2026-04-27 03:24:24,400 - INFO - Domain Default found not creating 2026-04-27 03:24:24,647 - INFO - Project ctest-TestRP-49369857 not found, creating it 2026-04-27 03:24:25,370 - INFO - Created Project:ctest-TestRP-49369857, ID : db69137a-730f-4b0e-b5ad-65190ce102dc 2026-04-27 03:24:27,190 - DEBUG - Services list from nova: [, , , ] 2026-04-27 03:24:27,190 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5690-1', 'an-jenkins-deploy-platform-ansible-os-5690-2']} 2026-04-27 03:24:27,193 - INFO - ================================================================================ 2026-04-27 03:24:27,193 - INFO - STARTING TEST : test_rp_interface 2026-04-27 03:24:27,193 - INFO - TEST DESCRIPTION : 1. Create a routing policy with interface match. 2. Launch VMs. 3. Attach policy to VN and confirm if policy takes hold. 2026-04-27 03:24:28,521 - DEBUG - Nothing to compare xmpp stats {'10.0.0.33': {'10.20.0.193': '0', '10.20.0.18': '0'}, '10.0.0.65': {'10.20.0.25': '0', '10.20.0.18': '0'}} with 2026-04-27 03:24:28,521 - INFO - Initial checks done. Running the testcase now 2026-04-27 03:24:28,522 - INFO - 2026-04-27 03:24:29,298 - DEBUG - Response for create_network : {'network': {'id': 'c8e24e35-f330-44a7-96e9-4778208de274', 'name': 'ctest-bgpaas_vn-52943371', 'tenant_id': 'db69137a730f4b0eb5ad65190ce102dc', 'project_id': 'db69137a730f4b0eb5ad65190ce102dc', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-49369857', 'ctest-bgpaas_vn-52943371'], 'port_security_enabled': True, 'description': ''}} 2026-04-27 03:24:29,693 - DEBUG - Response for create_subnet : {'subnet': {'id': '30961fbc-0a80-45c2-b1e7-8b2dddc6040a', 'name': '', 'tenant_id': 'db69137a730f4b0eb5ad65190ce102dc', 'network_id': 'c8e24e35-f330-44a7-96e9-4778208de274', 'ip_version': 4, 'cidr': '52.3.255.192/26', 'allocation_pools': [{'start': '52.3.255.194', 'end': '52.3.255.254'}], 'gateway_ip': '52.3.255.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '52.3.255.194', 'tags': [], 'project_id': 'db69137a730f4b0eb5ad65190ce102dc'}} 2026-04-27 03:24:29,730 - INFO - Created VN ctest-bgpaas_vn-52943371 2026-04-27 03:24:29,749 - DEBUG - VN ctest-bgpaas_vn-52943371 UUID is c8e24e35-f330-44a7-96e9-4778208de274 2026-04-27 03:24:30,416 - DEBUG - Response for create_network : {'network': {'id': '45c862c9-dec8-4c6c-91a2-f89fa593240d', 'name': 'ctest-bgpaas_vn-77153577', 'tenant_id': 'db69137a730f4b0eb5ad65190ce102dc', 'project_id': 'db69137a730f4b0eb5ad65190ce102dc', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-49369857', 'ctest-bgpaas_vn-77153577'], 'port_security_enabled': True, 'description': ''}} 2026-04-27 03:24:30,707 - DEBUG - Response for create_subnet : {'subnet': {'id': '7ffa09b6-60a7-4935-9086-b21d0c4cadf7', 'name': '', 'tenant_id': 'db69137a730f4b0eb5ad65190ce102dc', 'network_id': '45c862c9-dec8-4c6c-91a2-f89fa593240d', 'ip_version': 4, 'cidr': '38.13.192.128/26', 'allocation_pools': [{'start': '38.13.192.130', 'end': '38.13.192.190'}], 'gateway_ip': '38.13.192.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '38.13.192.130', 'tags': [], 'project_id': 'db69137a730f4b0eb5ad65190ce102dc'}} 2026-04-27 03:24:30,735 - INFO - Created VN ctest-bgpaas_vn-77153577 2026-04-27 03:24:30,752 - DEBUG - VN ctest-bgpaas_vn-77153577 UUID is 45c862c9-dec8-4c6c-91a2-f89fa593240d 2026-04-27 03:24:32,472 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5690-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5690-1) 2026-04-27 03:24:34,159 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5690-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5690-2) 2026-04-27 03:24:34,159 - INFO - Waiting for VM test_vm to be up.. 2026-04-27 03:24:34,286 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-04-27 03:24:39,408 - DEBUG - VM is in ACTIVE state now 2026-04-27 03:24:39,408 - INFO - VM name : test_vm 2026-04-27 03:24:39,537 - DEBUG - VM test_vm ID is d5d56e26-5e2e-4cd5-8674-5898e2efc163 2026-04-27 03:24:39,575 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5690-1 2026-04-27 03:24:39,697 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/d5d56e26-5e2e-4cd5-8674-5898e2efc163 2026-04-27 03:24:40,029 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/d5d56e26-5e2e-4cd5-8674-5898e2efc163 2026-04-27 03:24:40,078 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/cf44358d-5dbf-4778-aa5c-c93374a2cbd5 2026-04-27 03:24:43,264 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1002ms') 2026-04-27 03:24:43,264 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2026-04-27 03:24:43,284 - DEBUG - Gateway for vn default-domain:ctest-TestRP-49369857:ctest-bgpaas_vn-52943371 is 52.3.255.193 and allocation pool is NOT set 2026-04-27 03:24:45,341 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=3.52 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.496 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.496/2.006/3.516/1.510 ms') 2026-04-27 03:24:45,341 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2026-04-27 03:24:45,431 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-27 03:24:45,431 - DEBUG - Waiting to SSH to VM test_vm, IP 52.3.255.195, Port 22 2026-04-27 03:24:45,613 - DEBUG - VM test_vm is ready for SSH connections 2026-04-27 03:24:45,613 - INFO - Waiting for VM test2_vm to be up.. 2026-04-27 03:24:45,848 - DEBUG - VM is in ACTIVE state now 2026-04-27 03:24:45,848 - INFO - VM name : test2_vm 2026-04-27 03:24:45,978 - DEBUG - VM test2_vm ID is cc6f8788-43fa-41c8-8f5a-71811dcbeaa1 2026-04-27 03:24:45,979 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5690-2 2026-04-27 03:24:46,104 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/cc6f8788-43fa-41c8-8f5a-71811dcbeaa1 2026-04-27 03:24:46,116 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/72e5119d-6285-4354-b6be-65a6ab586ee2 2026-04-27 03:24:47,306 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=4.96 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.895 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.895/2.925/4.955/2.030 ms') 2026-04-27 03:24:47,306 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2026-04-27 03:24:47,381 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-27 03:24:47,381 - DEBUG - Waiting to SSH to VM test2_vm, IP 38.13.192.131, Port 22 2026-04-27 03:24:47,449 - DEBUG - Error on ssh to cirros@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-04-27 03:24:47,556 - DEBUG - VM test2_vm is NOT ready for SSH connections, VM status: ACTIVE 2026-04-27 03:24:52,557 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-27 03:24:52,557 - DEBUG - Waiting to SSH to VM test2_vm, IP 38.13.192.131, Port 22 2026-04-27 03:24:52,727 - DEBUG - VM test2_vm is ready for SSH connections 2026-04-27 03:24:52,915 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-27 03:24:52,931 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-49369857:ctest-bgpaas_vn-52943371:ctest-bgpaas_vn-52943371.inet.0 2026-04-27 03:24:52,952 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-49369857:ctest-bgpaas_vn-52943371:ctest-bgpaas_vn-52943371.inet.0 2026-04-27 03:24:52,975 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-27 03:24:52,975 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 38.13.192.131, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.33, gateway password: c0ntrail123 2026-04-27 03:24:52,975 - DEBUG - ping -s 56 -c 3 -W 1 38.13.192.131 2026-04-27 03:24:56,917 - DEBUG - PING 38.13.192.131 (38.13.192.131): 56 data bytes 64 bytes from 38.13.192.131: seq=0 ttl=63 time=11.054 ms 64 bytes from 38.13.192.131: seq=1 ttl=63 time=1.526 ms 64 bytes from 38.13.192.131: seq=2 ttl=63 time=1.514 ms --- 38.13.192.131 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.514/4.698/11.054 ms 2026-04-27 03:24:56,917 - INFO - Ping to IP 38.13.192.131 from VM test_vm passed 2026-04-27 03:24:57,123 - INFO - Deleting VM test2_vm 2026-04-27 03:24:57,223 - INFO - Deleting VM test_vm 2026-04-27 03:24:57,317 - INFO - Deleting VN ctest-bgpaas_vn-77153577 2026-04-27 03:24:57,375 - DEBUG - VN 45c862c9-dec8-4c6c-91a2-f89fa593240d still in use: Unable to complete operation on network 45c862c9-dec8-4c6c-91a2-f89fa593240d. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-7df55483-125a-4982-9976-9efb1315e967'] 2026-04-27 03:24:57,375 - WARNING - Deleting VN ctest-bgpaas_vn-77153577 failed..Will retry 2026-04-27 03:24:59,606 - DEBUG - Response for deleting network () 2026-04-27 03:24:59,606 - INFO - Deleting VN ctest-bgpaas_vn-52943371 2026-04-27 03:24:59,888 - DEBUG - Response for deleting network () 2026-04-27 03:25:01,225 - DEBUG - No XMPP flaps were noticed during the test
2026-04-27 03:25:01,225 - INFO - END TEST : test_rp_interface : PASSED[0:00:34]
2026-04-27 03:25:01,225 - INFO - -------------------------------------------------------------------------------- 2026-04-27 03:25:01,229 - INFO - ================================================================================ 2026-04-27 03:25:01,229 - INFO - STARTING TEST : test_rp_interface_ext_community 2026-04-27 03:25:01,229 - INFO - TEST DESCRIPTION : 1. Create a routing policy with interface match. 2. Launch VMs. 3. Attach policy to VN and confirm if policy takes hold. 2026-04-27 03:25:02,581 - DEBUG - Nothing to compare xmpp stats {'10.0.0.33': {'10.20.0.193': '0', '10.20.0.18': '0'}, '10.0.0.65': {'10.20.0.25': '0', '10.20.0.18': '0'}} with 2026-04-27 03:25:02,581 - INFO - Initial checks done. Running the testcase now 2026-04-27 03:25:02,581 - INFO - 2026-04-27 03:25:02,914 - DEBUG - Response for create_network : {'network': {'id': '89ae18c8-5ad8-459e-9108-d85833eef96e', 'name': 'ctest-bgpaas_vn-69549971', 'tenant_id': 'db69137a730f4b0eb5ad65190ce102dc', 'project_id': 'db69137a730f4b0eb5ad65190ce102dc', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-49369857', 'ctest-bgpaas_vn-69549971'], 'port_security_enabled': True, 'description': ''}} 2026-04-27 03:25:03,239 - DEBUG - Response for create_subnet : {'subnet': {'id': '337a4a4d-0b27-4261-84a7-e7b9e02382ae', 'name': '', 'tenant_id': 'db69137a730f4b0eb5ad65190ce102dc', 'network_id': '89ae18c8-5ad8-459e-9108-d85833eef96e', 'ip_version': 4, 'cidr': '59.132.150.64/26', 'allocation_pools': [{'start': '59.132.150.66', 'end': '59.132.150.126'}], 'gateway_ip': '59.132.150.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '59.132.150.66', 'tags': [], 'project_id': 'db69137a730f4b0eb5ad65190ce102dc'}} 2026-04-27 03:25:03,269 - INFO - Created VN ctest-bgpaas_vn-69549971 2026-04-27 03:25:03,283 - DEBUG - VN ctest-bgpaas_vn-69549971 UUID is 89ae18c8-5ad8-459e-9108-d85833eef96e 2026-04-27 03:25:03,994 - DEBUG - Response for create_network : {'network': {'id': 'a632bd3b-7286-47c3-8e6a-74d7dd43a806', 'name': 'ctest-bgpaas_vn-84487327', 'tenant_id': 'db69137a730f4b0eb5ad65190ce102dc', 'project_id': 'db69137a730f4b0eb5ad65190ce102dc', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-49369857', 'ctest-bgpaas_vn-84487327'], 'port_security_enabled': True, 'description': ''}} 2026-04-27 03:25:04,287 - DEBUG - Response for create_subnet : {'subnet': {'id': '36d0e3a0-b500-41dc-a5ce-914760e70e30', 'name': '', 'tenant_id': 'db69137a730f4b0eb5ad65190ce102dc', 'network_id': 'a632bd3b-7286-47c3-8e6a-74d7dd43a806', 'ip_version': 4, 'cidr': '118.199.73.0/26', 'allocation_pools': [{'start': '118.199.73.2', 'end': '118.199.73.62'}], 'gateway_ip': '118.199.73.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '118.199.73.2', 'tags': [], 'project_id': 'db69137a730f4b0eb5ad65190ce102dc'}} 2026-04-27 03:25:04,320 - INFO - Created VN ctest-bgpaas_vn-84487327 2026-04-27 03:25:04,339 - DEBUG - VN ctest-bgpaas_vn-84487327 UUID is a632bd3b-7286-47c3-8e6a-74d7dd43a806 2026-04-27 03:25:05,911 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5690-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5690-1) 2026-04-27 03:25:07,718 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5690-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5690-2) 2026-04-27 03:25:07,719 - INFO - Waiting for VM test_vm to be up.. 2026-04-27 03:25:07,858 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-04-27 03:25:13,096 - DEBUG - VM is in ACTIVE state now 2026-04-27 03:25:13,096 - INFO - VM name : test_vm 2026-04-27 03:25:13,194 - DEBUG - VM test_vm ID is 466c6ef8-2951-4173-a1c3-ee6f3ee7f9b5 2026-04-27 03:25:13,194 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5690-1 2026-04-27 03:25:13,307 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/466c6ef8-2951-4173-a1c3-ee6f3ee7f9b5 2026-04-27 03:25:13,324 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/00dde553-7ed7-4fc8-bb56-f81c566139de 2026-04-27 03:25:16,504 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1007ms') 2026-04-27 03:25:16,504 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2026-04-27 03:25:16,523 - DEBUG - Gateway for vn default-domain:ctest-TestRP-49369857:ctest-bgpaas_vn-69549971 is 59.132.150.65 and allocation pool is NOT set 2026-04-27 03:25:18,588 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=4.95 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.400 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.400/2.676/4.952/2.276 ms') 2026-04-27 03:25:18,588 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2026-04-27 03:25:18,668 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-27 03:25:18,668 - DEBUG - Waiting to SSH to VM test_vm, IP 59.132.150.67, Port 22 2026-04-27 03:25:18,840 - DEBUG - VM test_vm is ready for SSH connections 2026-04-27 03:25:18,840 - INFO - Waiting for VM test2_vm to be up.. 2026-04-27 03:25:18,951 - DEBUG - VM is in ACTIVE state now 2026-04-27 03:25:18,951 - INFO - VM name : test2_vm 2026-04-27 03:25:19,061 - DEBUG - VM test2_vm ID is 68f2e174-c1e3-47d2-a010-6c6ec20e0ab9 2026-04-27 03:25:19,061 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5690-2 2026-04-27 03:25:19,172 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/68f2e174-c1e3-47d2-a010-6c6ec20e0ab9 2026-04-27 03:25:19,191 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/d426dea0-c574-4c5b-b9d6-bf6bf15d810a 2026-04-27 03:25:20,372 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=9.35 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.63 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 2.629/5.988/9.347/3.359 ms') 2026-04-27 03:25:20,372 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2026-04-27 03:25:20,450 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-27 03:25:20,450 - DEBUG - Waiting to SSH to VM test2_vm, IP 118.199.73.3, Port 22 2026-04-27 03:25:20,518 - DEBUG - Error on ssh to cirros@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-04-27 03:25:20,626 - DEBUG - VM test2_vm is NOT ready for SSH connections, VM status: ACTIVE 2026-04-27 03:25:25,626 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-27 03:25:25,627 - DEBUG - Waiting to SSH to VM test2_vm, IP 118.199.73.3, Port 22 2026-04-27 03:25:25,801 - DEBUG - VM test2_vm is ready for SSH connections 2026-04-27 03:25:26,011 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-27 03:25:26,028 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-49369857:ctest-bgpaas_vn-69549971:ctest-bgpaas_vn-69549971.inet.0 2026-04-27 03:25:27,047 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-27 03:25:27,061 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-49369857:ctest-bgpaas_vn-69549971:ctest-bgpaas_vn-69549971.inet.0 2026-04-27 03:25:27,081 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-49369857:ctest-bgpaas_vn-69549971:ctest-bgpaas_vn-69549971.inet.0 2026-04-27 03:25:27,095 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-27 03:25:27,096 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 118.199.73.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.33, gateway password: c0ntrail123 2026-04-27 03:25:27,096 - DEBUG - ping -s 56 -c 3 -W 1 118.199.73.3 2026-04-27 03:25:30,774 - DEBUG - PING 118.199.73.3 (118.199.73.3): 56 data bytes 64 bytes from 118.199.73.3: seq=0 ttl=63 time=6.001 ms 64 bytes from 118.199.73.3: seq=1 ttl=63 time=1.291 ms 64 bytes from 118.199.73.3: seq=2 ttl=63 time=1.404 ms --- 118.199.73.3 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.291/2.898/6.001 ms 2026-04-27 03:25:30,774 - INFO - Ping to IP 118.199.73.3 from VM test_vm passed 2026-04-27 03:25:30,971 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-27 03:25:30,986 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-49369857:ctest-bgpaas_vn-69549971:ctest-bgpaas_vn-69549971.inet.0 2026-04-27 03:25:31,007 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-49369857:ctest-bgpaas_vn-69549971:ctest-bgpaas_vn-69549971.inet.0 2026-04-27 03:25:31,378 - INFO - Deleting VM test2_vm 2026-04-27 03:25:31,490 - INFO - Deleting VM test_vm 2026-04-27 03:25:31,594 - INFO - Deleting VN ctest-bgpaas_vn-84487327 2026-04-27 03:25:31,656 - DEBUG - VN a632bd3b-7286-47c3-8e6a-74d7dd43a806 still in use: Unable to complete operation on network a632bd3b-7286-47c3-8e6a-74d7dd43a806. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-4050a5d4-7df4-41bf-be5f-34905c2ae69d'] 2026-04-27 03:25:31,656 - WARNING - Deleting VN ctest-bgpaas_vn-84487327 failed..Will retry 2026-04-27 03:25:33,884 - DEBUG - Response for deleting network () 2026-04-27 03:25:33,884 - INFO - Deleting VN ctest-bgpaas_vn-69549971 2026-04-27 03:25:34,122 - DEBUG - Response for deleting network () 2026-04-27 03:25:35,452 - DEBUG - No XMPP flaps were noticed during the test
2026-04-27 03:25:35,452 - INFO - END TEST : test_rp_interface_ext_community : PASSED[0:00:34]
2026-04-27 03:25:35,452 - INFO - -------------------------------------------------------------------------------- 2026-04-27 03:25:35,455 - INFO - ================================================================================ 2026-04-27 03:25:35,455 - INFO - STARTING TEST : test_rp_interface_static 2026-04-27 03:25:35,455 - INFO - TEST DESCRIPTION : 1. Create a routing policy with interface-static match. 2. Launch VMs. 3. Attach policy to VN and confirm if policy takes hold. 2026-04-27 03:25:36,785 - DEBUG - Nothing to compare xmpp stats {'10.0.0.33': {'10.20.0.193': '0', '10.20.0.18': '0'}, '10.0.0.65': {'10.20.0.25': '0', '10.20.0.18': '0'}} with 2026-04-27 03:25:36,785 - INFO - Initial checks done. Running the testcase now 2026-04-27 03:25:36,785 - INFO - 2026-04-27 03:25:37,160 - DEBUG - Response for create_network : {'network': {'id': '72b872ca-aac0-452d-a3ce-517eee6946cb', 'name': 'ctest-bgpaas_vn-19533447', 'tenant_id': 'db69137a730f4b0eb5ad65190ce102dc', 'project_id': 'db69137a730f4b0eb5ad65190ce102dc', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-49369857', 'ctest-bgpaas_vn-19533447'], 'port_security_enabled': True, 'description': ''}} 2026-04-27 03:25:37,435 - DEBUG - Response for create_subnet : {'subnet': {'id': 'aace315c-a41b-46f0-a03c-da0efe6be731', 'name': '', 'tenant_id': 'db69137a730f4b0eb5ad65190ce102dc', 'network_id': '72b872ca-aac0-452d-a3ce-517eee6946cb', 'ip_version': 4, 'cidr': '157.69.212.0/26', 'allocation_pools': [{'start': '157.69.212.2', 'end': '157.69.212.62'}], 'gateway_ip': '157.69.212.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '157.69.212.2', 'tags': [], 'project_id': 'db69137a730f4b0eb5ad65190ce102dc'}} 2026-04-27 03:25:37,467 - INFO - Created VN ctest-bgpaas_vn-19533447 2026-04-27 03:25:37,483 - DEBUG - VN ctest-bgpaas_vn-19533447 UUID is 72b872ca-aac0-452d-a3ce-517eee6946cb 2026-04-27 03:25:38,146 - DEBUG - Response for create_network : {'network': {'id': '940e525e-29bd-400a-82aa-0b8ef26a166d', 'name': 'ctest-bgpaas_vn-35095103', 'tenant_id': 'db69137a730f4b0eb5ad65190ce102dc', 'project_id': 'db69137a730f4b0eb5ad65190ce102dc', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-49369857', 'ctest-bgpaas_vn-35095103'], 'port_security_enabled': True, 'description': ''}} 2026-04-27 03:25:38,394 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ec4acd6d-daac-4c71-9926-ad7d2b0602b7', 'name': '', 'tenant_id': 'db69137a730f4b0eb5ad65190ce102dc', 'network_id': '940e525e-29bd-400a-82aa-0b8ef26a166d', 'ip_version': 4, 'cidr': '98.9.220.192/26', 'allocation_pools': [{'start': '98.9.220.194', 'end': '98.9.220.254'}], 'gateway_ip': '98.9.220.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '98.9.220.194', 'tags': [], 'project_id': 'db69137a730f4b0eb5ad65190ce102dc'}} 2026-04-27 03:25:38,429 - INFO - Created VN ctest-bgpaas_vn-35095103 2026-04-27 03:25:38,449 - DEBUG - VN ctest-bgpaas_vn-35095103 UUID is 940e525e-29bd-400a-82aa-0b8ef26a166d 2026-04-27 03:25:40,045 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5690-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5690-1) 2026-04-27 03:25:41,650 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5690-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5690-2) 2026-04-27 03:25:41,650 - INFO - Waiting for VM test_vm to be up.. 2026-04-27 03:25:41,790 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-04-27 03:25:46,896 - DEBUG - VM is in ACTIVE state now 2026-04-27 03:25:46,896 - INFO - VM name : test_vm 2026-04-27 03:25:47,005 - DEBUG - VM test_vm ID is c377008d-5535-4342-8897-8d05cf4a9153 2026-04-27 03:25:47,005 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5690-1 2026-04-27 03:25:47,132 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/c377008d-5535-4342-8897-8d05cf4a9153 2026-04-27 03:25:47,150 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/10968972-337c-4a2f-a844-f085c072a97d 2026-04-27 03:25:50,368 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1031ms') 2026-04-27 03:25:50,368 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2026-04-27 03:25:50,386 - DEBUG - Gateway for vn default-domain:ctest-TestRP-49369857:ctest-bgpaas_vn-19533447 is 157.69.212.1 and allocation pool is NOT set 2026-04-27 03:25:52,448 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=9.33 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.462 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.462/4.895/9.329/4.433 ms') 2026-04-27 03:25:52,448 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2026-04-27 03:25:52,530 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-27 03:25:52,531 - DEBUG - Waiting to SSH to VM test_vm, IP 157.69.212.3, Port 22 2026-04-27 03:25:52,693 - DEBUG - VM test_vm is ready for SSH connections 2026-04-27 03:25:52,693 - INFO - Waiting for VM test2_vm to be up.. 2026-04-27 03:25:52,831 - DEBUG - VM is in ACTIVE state now 2026-04-27 03:25:52,831 - INFO - VM name : test2_vm 2026-04-27 03:25:52,949 - DEBUG - VM test2_vm ID is 8befe26e-84f9-4606-a87f-3be683686e78 2026-04-27 03:25:52,949 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5690-2 2026-04-27 03:25:53,072 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/8befe26e-84f9-4606-a87f-3be683686e78 2026-04-27 03:25:53,087 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/64318dfb-7ce2-4690-8b06-c3e6024514d3 2026-04-27 03:25:54,289 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=4.49 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=3.66 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 3.657/4.071/4.485/0.414 ms') 2026-04-27 03:25:54,289 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2026-04-27 03:25:54,370 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-27 03:25:54,370 - DEBUG - Waiting to SSH to VM test2_vm, IP 98.9.220.195, Port 22 2026-04-27 03:25:54,437 - DEBUG - Error on ssh to cirros@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-04-27 03:25:54,561 - DEBUG - VM test2_vm is NOT ready for SSH connections, VM status: ACTIVE 2026-04-27 03:25:59,563 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-27 03:25:59,563 - DEBUG - Waiting to SSH to VM test2_vm, IP 98.9.220.195, Port 22 2026-04-27 03:25:59,719 - DEBUG - VM test2_vm is ready for SSH connections 2026-04-27 03:25:59,831 - INFO - Created InterfaceRouteTable ['default-domain', 'ctest-TestRP-49369857', 'ctest-int_table_right-65837605'](UUID e75a21c8-b637-465e-b288-a6d35e4f977c), prefixes : ['51.49.33.128/26'] 2026-04-27 03:25:59,915 - INFO - Added intf route table e75a21c8-b637-465e-b288-a6d35e4f977c to port 10968972-337c-4a2f-a844-f085c072a97d 2026-04-27 03:26:00,198 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-49369857:ctest-bgpaas_vn-19533447:ctest-bgpaas_vn-19533447.inet.0 2026-04-27 03:26:00,229 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-49369857:ctest-bgpaas_vn-19533447:ctest-bgpaas_vn-19533447.inet.0 2026-04-27 03:26:00,251 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-04-27 03:26:00,251 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 98.9.220.195, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.33, gateway password: c0ntrail123 2026-04-27 03:26:00,252 - DEBUG - ping -s 56 -c 3 -W 1 98.9.220.195 2026-04-27 03:26:04,227 - DEBUG - PING 98.9.220.195 (98.9.220.195): 56 data bytes 64 bytes from 98.9.220.195: seq=0 ttl=63 time=7.678 ms 64 bytes from 98.9.220.195: seq=1 ttl=63 time=1.525 ms 64 bytes from 98.9.220.195: seq=2 ttl=63 time=1.357 ms --- 98.9.220.195 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.357/3.520/7.678 ms 2026-04-27 03:26:04,227 - INFO - Ping to IP 98.9.220.195 from VM test_vm passed 2026-04-27 03:26:04,366 - INFO - Deleting VM test2_vm 2026-04-27 03:26:04,457 - INFO - Deleting VM test_vm 2026-04-27 03:26:04,554 - INFO - Deleting VN ctest-bgpaas_vn-35095103 2026-04-27 03:26:04,620 - DEBUG - VN 940e525e-29bd-400a-82aa-0b8ef26a166d still in use: Unable to complete operation on network 940e525e-29bd-400a-82aa-0b8ef26a166d. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-68edff1c-5a9d-447a-a024-a7748b4cf53a'] 2026-04-27 03:26:04,620 - WARNING - Deleting VN ctest-bgpaas_vn-35095103 failed..Will retry 2026-04-27 03:26:06,858 - DEBUG - Response for deleting network () 2026-04-27 03:26:06,858 - INFO - Deleting VN ctest-bgpaas_vn-19533447 2026-04-27 03:26:07,119 - DEBUG - Response for deleting network () 2026-04-27 03:26:08,442 - DEBUG - No XMPP flaps were noticed during the test
2026-04-27 03:26:08,442 - INFO - END TEST : test_rp_interface_static : PASSED[0:00:33]
2026-04-27 03:26:08,442 - INFO - -------------------------------------------------------------------------------- 2026-04-27 03:26:09,293 - INFO - Deleted project: ctest-TestRP-49369857, ID : db69137a-730f-4b0e-b5ad-65190ce102dc