2026-05-18 03:04:59,266 - INFO - Domain Default found not creating 2026-05-18 03:04:59,453 - INFO - Project ctest-TestRP-59205369 not found, creating it 2026-05-18 03:05:00,074 - INFO - Created Project:ctest-TestRP-59205369, ID : 9e520b2f-c0e3-4178-b9ae-d584b6f29cfb 2026-05-18 03:05:01,827 - DEBUG - Services list from nova: [, , , ] 2026-05-18 03:05:01,827 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5792-2', 'an-jenkins-deploy-platform-ansible-os-5792-1']} 2026-05-18 03:05:01,830 - INFO - ================================================================================ 2026-05-18 03:05:01,830 - INFO - STARTING TEST : test_rp_interface 2026-05-18 03:05:01,830 - 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-05-18 03:05:03,130 - DEBUG - Nothing to compare xmpp stats {'10.0.0.65': {'10.20.0.129': '0', '10.20.0.25': '2'}, '10.0.0.130': {'10.20.0.25': '0', '10.20.0.129': '3'}} with 2026-05-18 03:05:03,130 - INFO - Initial checks done. Running the testcase now 2026-05-18 03:05:03,130 - INFO - 2026-05-18 03:05:03,873 - DEBUG - Response for create_network : {'network': {'id': 'd884dbe2-f0e3-4a8d-aa30-4e3c8e2fd990', 'name': 'ctest-bgpaas_vn-34786067', 'tenant_id': '9e520b2fc0e34178b9aed584b6f29cfb', 'project_id': '9e520b2fc0e34178b9aed584b6f29cfb', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-59205369', 'ctest-bgpaas_vn-34786067'], 'port_security_enabled': True, 'description': ''}} 2026-05-18 03:05:04,149 - DEBUG - Response for create_subnet : {'subnet': {'id': 'fcb049a9-eeb6-4a52-9188-75ce72826983', 'name': '', 'tenant_id': '9e520b2fc0e34178b9aed584b6f29cfb', 'network_id': 'd884dbe2-f0e3-4a8d-aa30-4e3c8e2fd990', 'ip_version': 4, 'cidr': '134.177.92.192/26', 'allocation_pools': [{'start': '134.177.92.194', 'end': '134.177.92.254'}], 'gateway_ip': '134.177.92.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '134.177.92.194', 'tags': [], 'project_id': '9e520b2fc0e34178b9aed584b6f29cfb'}} 2026-05-18 03:05:04,173 - INFO - Created VN ctest-bgpaas_vn-34786067 2026-05-18 03:05:04,186 - DEBUG - VN ctest-bgpaas_vn-34786067 UUID is d884dbe2-f0e3-4a8d-aa30-4e3c8e2fd990 2026-05-18 03:05:04,751 - DEBUG - Response for create_network : {'network': {'id': '3a7aea0e-097a-4358-aa3a-dc67c2735a7e', 'name': 'ctest-bgpaas_vn-82648802', 'tenant_id': '9e520b2fc0e34178b9aed584b6f29cfb', 'project_id': '9e520b2fc0e34178b9aed584b6f29cfb', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-59205369', 'ctest-bgpaas_vn-82648802'], 'port_security_enabled': True, 'description': ''}} 2026-05-18 03:05:05,001 - DEBUG - Response for create_subnet : {'subnet': {'id': '9c1541ed-c2d1-4f3d-8c32-fe796b1859e9', 'name': '', 'tenant_id': '9e520b2fc0e34178b9aed584b6f29cfb', 'network_id': '3a7aea0e-097a-4358-aa3a-dc67c2735a7e', 'ip_version': 4, 'cidr': '204.191.90.64/26', 'allocation_pools': [{'start': '204.191.90.66', 'end': '204.191.90.126'}], 'gateway_ip': '204.191.90.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '204.191.90.66', 'tags': [], 'project_id': '9e520b2fc0e34178b9aed584b6f29cfb'}} 2026-05-18 03:05:05,029 - INFO - Created VN ctest-bgpaas_vn-82648802 2026-05-18 03:05:05,044 - DEBUG - VN ctest-bgpaas_vn-82648802 UUID is 3a7aea0e-097a-4358-aa3a-dc67c2735a7e 2026-05-18 03:05:06,481 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5792-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5792-2) 2026-05-18 03:05:08,088 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5792-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5792-1) 2026-05-18 03:05:08,088 - INFO - Waiting for VM test_vm to be up.. 2026-05-18 03:05:08,197 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-05-18 03:05:13,280 - DEBUG - VM is in ACTIVE state now 2026-05-18 03:05:13,280 - INFO - VM name : test_vm 2026-05-18 03:05:13,374 - DEBUG - VM test_vm ID is 45fecd50-681b-4dbe-9250-d476e64022bc 2026-05-18 03:05:13,398 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5792-2 2026-05-18 03:05:13,487 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine/45fecd50-681b-4dbe-9250-d476e64022bc 2026-05-18 03:05:13,797 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine/45fecd50-681b-4dbe-9250-d476e64022bc 2026-05-18 03:05:13,838 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine-interface/7bd43711-11f8-4416-aa76-2c2e308bd6de 2026-05-18 03:05:17,021 - 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 1019ms') 2026-05-18 03:05:17,021 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2026-05-18 03:05:17,047 - DEBUG - Gateway for vn default-domain:ctest-TestRP-59205369:ctest-bgpaas_vn-34786067 is 134.177.92.193 and allocation pool is NOT set 2026-05-18 03:05:19,107 - 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=11.0 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.473 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1000ms\r\nrtt min/avg/max/mdev = 0.473/5.712/10.951/5.239 ms') 2026-05-18 03:05:19,108 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2026-05-18 03:05:19,180 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-18 03:05:19,180 - DEBUG - Waiting to SSH to VM test_vm, IP 134.177.92.195, Port 22 2026-05-18 03:05:19,347 - DEBUG - VM test_vm is ready for SSH connections 2026-05-18 03:05:19,348 - INFO - Waiting for VM test2_vm to be up.. 2026-05-18 03:05:19,454 - DEBUG - VM is in ACTIVE state now 2026-05-18 03:05:19,455 - INFO - VM name : test2_vm 2026-05-18 03:05:19,572 - DEBUG - VM test2_vm ID is a3e55104-87aa-4df2-aca8-3e2345b803bd 2026-05-18 03:05:19,572 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5792-1 2026-05-18 03:05:19,659 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine/a3e55104-87aa-4df2-aca8-3e2345b803bd 2026-05-18 03:05:19,671 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine-interface/f7efbefe-a9ed-45dc-83a1-457b7796a299 2026-05-18 03:05:20,848 - 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=5.64 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.68 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 = 1.681/3.662/5.643/1.981 ms') 2026-05-18 03:05:20,848 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2026-05-18 03:05:20,921 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-18 03:05:20,921 - DEBUG - Waiting to SSH to VM test2_vm, IP 204.191.90.67, Port 22 2026-05-18 03:05:21,094 - DEBUG - VM test2_vm is ready for SSH connections 2026-05-18 03:05:21,288 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-18 03:05:21,319 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-59205369:ctest-bgpaas_vn-34786067:ctest-bgpaas_vn-34786067.inet.0 2026-05-18 03:05:21,333 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-59205369:ctest-bgpaas_vn-34786067:ctest-bgpaas_vn-34786067.inet.0 2026-05-18 03:05:21,351 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-18 03:05:21,351 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 204.191.90.67, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.130, gateway password: c0ntrail123 2026-05-18 03:05:21,351 - DEBUG - ping -s 56 -c 3 -W 1 204.191.90.67 2026-05-18 03:05:25,312 - DEBUG - PING 204.191.90.67 (204.191.90.67): 56 data bytes 64 bytes from 204.191.90.67: seq=0 ttl=63 time=7.606 ms 64 bytes from 204.191.90.67: seq=1 ttl=63 time=1.615 ms 64 bytes from 204.191.90.67: seq=2 ttl=63 time=1.365 ms --- 204.191.90.67 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.365/3.528/7.606 ms 2026-05-18 03:05:25,312 - INFO - Ping to IP 204.191.90.67 from VM test_vm passed 2026-05-18 03:05:25,451 - INFO - Deleting VM test2_vm 2026-05-18 03:05:25,537 - INFO - Deleting VM test_vm 2026-05-18 03:05:25,609 - INFO - Deleting VN ctest-bgpaas_vn-82648802 2026-05-18 03:05:25,652 - DEBUG - VN 3a7aea0e-097a-4358-aa3a-dc67c2735a7e still in use: Unable to complete operation on network 3a7aea0e-097a-4358-aa3a-dc67c2735a7e. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-bf56d9d2-9d18-4eb6-8918-1505069401da'] 2026-05-18 03:05:25,652 - WARNING - Deleting VN ctest-bgpaas_vn-82648802 failed..Will retry 2026-05-18 03:05:27,824 - DEBUG - Response for deleting network () 2026-05-18 03:05:27,824 - INFO - Deleting VN ctest-bgpaas_vn-34786067 2026-05-18 03:05:28,067 - DEBUG - Response for deleting network () 2026-05-18 03:05:29,367 - DEBUG - No XMPP flaps were noticed during the test
2026-05-18 03:05:29,367 - INFO - END TEST : test_rp_interface : PASSED[0:00:28]
2026-05-18 03:05:29,367 - INFO - -------------------------------------------------------------------------------- 2026-05-18 03:05:29,371 - INFO - ================================================================================ 2026-05-18 03:05:29,371 - INFO - STARTING TEST : test_rp_interface_ext_community 2026-05-18 03:05:29,371 - 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-05-18 03:05:30,669 - DEBUG - Nothing to compare xmpp stats {'10.0.0.65': {'10.20.0.129': '0', '10.20.0.25': '2'}, '10.0.0.130': {'10.20.0.25': '0', '10.20.0.129': '3'}} with 2026-05-18 03:05:30,669 - INFO - Initial checks done. Running the testcase now 2026-05-18 03:05:30,669 - INFO - 2026-05-18 03:05:31,006 - DEBUG - Response for create_network : {'network': {'id': 'a5edf5b8-72fa-473f-b71f-3e5665ec3e18', 'name': 'ctest-bgpaas_vn-25363764', 'tenant_id': '9e520b2fc0e34178b9aed584b6f29cfb', 'project_id': '9e520b2fc0e34178b9aed584b6f29cfb', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-59205369', 'ctest-bgpaas_vn-25363764'], 'port_security_enabled': True, 'description': ''}} 2026-05-18 03:05:31,288 - DEBUG - Response for create_subnet : {'subnet': {'id': '3d4f53d7-900d-4dd2-a0ab-f2c606364bfc', 'name': '', 'tenant_id': '9e520b2fc0e34178b9aed584b6f29cfb', 'network_id': 'a5edf5b8-72fa-473f-b71f-3e5665ec3e18', 'ip_version': 4, 'cidr': '52.76.53.0/26', 'allocation_pools': [{'start': '52.76.53.2', 'end': '52.76.53.62'}], 'gateway_ip': '52.76.53.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '52.76.53.2', 'tags': [], 'project_id': '9e520b2fc0e34178b9aed584b6f29cfb'}} 2026-05-18 03:05:31,314 - INFO - Created VN ctest-bgpaas_vn-25363764 2026-05-18 03:05:31,328 - DEBUG - VN ctest-bgpaas_vn-25363764 UUID is a5edf5b8-72fa-473f-b71f-3e5665ec3e18 2026-05-18 03:05:31,867 - DEBUG - Response for create_network : {'network': {'id': 'fc0bc977-06cf-47f8-b697-62ab4d5bbbea', 'name': 'ctest-bgpaas_vn-91273677', 'tenant_id': '9e520b2fc0e34178b9aed584b6f29cfb', 'project_id': '9e520b2fc0e34178b9aed584b6f29cfb', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-59205369', 'ctest-bgpaas_vn-91273677'], 'port_security_enabled': True, 'description': ''}} 2026-05-18 03:05:32,141 - DEBUG - Response for create_subnet : {'subnet': {'id': '1cd129a3-85a4-423f-b150-a792a2dedce7', 'name': '', 'tenant_id': '9e520b2fc0e34178b9aed584b6f29cfb', 'network_id': 'fc0bc977-06cf-47f8-b697-62ab4d5bbbea', 'ip_version': 4, 'cidr': '185.79.227.192/26', 'allocation_pools': [{'start': '185.79.227.194', 'end': '185.79.227.254'}], 'gateway_ip': '185.79.227.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '185.79.227.194', 'tags': [], 'project_id': '9e520b2fc0e34178b9aed584b6f29cfb'}} 2026-05-18 03:05:32,165 - INFO - Created VN ctest-bgpaas_vn-91273677 2026-05-18 03:05:32,182 - DEBUG - VN ctest-bgpaas_vn-91273677 UUID is fc0bc977-06cf-47f8-b697-62ab4d5bbbea 2026-05-18 03:05:33,632 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5792-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5792-2) 2026-05-18 03:05:35,093 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5792-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5792-1) 2026-05-18 03:05:35,093 - INFO - Waiting for VM test_vm to be up.. 2026-05-18 03:05:35,207 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-05-18 03:05:40,298 - DEBUG - VM is in ACTIVE state now 2026-05-18 03:05:40,299 - INFO - VM name : test_vm 2026-05-18 03:05:40,391 - DEBUG - VM test_vm ID is 3f0bba42-de07-4826-990a-627e2447510f 2026-05-18 03:05:40,391 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5792-2 2026-05-18 03:05:40,485 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine/3f0bba42-de07-4826-990a-627e2447510f 2026-05-18 03:05:40,497 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine-interface/aaf991b2-73d6-44ee-883a-b6f47fd51ec8 2026-05-18 03:05:43,677 - 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 1010ms') 2026-05-18 03:05:43,677 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2026-05-18 03:05:43,691 - DEBUG - Gateway for vn default-domain:ctest-TestRP-59205369:ctest-bgpaas_vn-25363764 is 52.76.53.1 and allocation pool is NOT set 2026-05-18 03:05:45,757 - 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=5.19 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.875 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.875/3.033/5.191/2.158 ms') 2026-05-18 03:05:45,757 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2026-05-18 03:05:45,829 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-18 03:05:45,829 - DEBUG - Waiting to SSH to VM test_vm, IP 52.76.53.3, Port 22 2026-05-18 03:05:45,989 - DEBUG - VM test_vm is ready for SSH connections 2026-05-18 03:05:45,989 - INFO - Waiting for VM test2_vm to be up.. 2026-05-18 03:05:46,078 - DEBUG - VM is in ACTIVE state now 2026-05-18 03:05:46,078 - INFO - VM name : test2_vm 2026-05-18 03:05:46,171 - DEBUG - VM test2_vm ID is 158b163e-2ae7-4210-8a8d-1ab999992dd7 2026-05-18 03:05:46,171 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5792-1 2026-05-18 03:05:46,254 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine/158b163e-2ae7-4210-8a8d-1ab999992dd7 2026-05-18 03:05:46,265 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine-interface/cc31fd9a-8374-4df1-8534-0427dff15751 2026-05-18 03:05:47,430 - 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.54 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.20 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.200/5.869/9.539/3.669 ms') 2026-05-18 03:05:47,431 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2026-05-18 03:05:47,502 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-18 03:05:47,502 - DEBUG - Waiting to SSH to VM test2_vm, IP 185.79.227.195, Port 22 2026-05-18 03:05:47,571 - 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-05-18 03:05:47,679 - DEBUG - VM test2_vm is NOT ready for SSH connections, VM status: ACTIVE 2026-05-18 03:05:52,680 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-18 03:05:52,681 - DEBUG - Waiting to SSH to VM test2_vm, IP 185.79.227.195, Port 22 2026-05-18 03:05:52,851 - DEBUG - VM test2_vm is ready for SSH connections 2026-05-18 03:05:53,024 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-18 03:05:53,038 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-59205369:ctest-bgpaas_vn-25363764:ctest-bgpaas_vn-25363764.inet.0 2026-05-18 03:05:53,049 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-59205369:ctest-bgpaas_vn-25363764:ctest-bgpaas_vn-25363764.inet.0 2026-05-18 03:05:53,067 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-18 03:05:53,067 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 185.79.227.195, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.130, gateway password: c0ntrail123 2026-05-18 03:05:53,067 - DEBUG - ping -s 56 -c 3 -W 1 185.79.227.195 2026-05-18 03:05:56,727 - DEBUG - PING 185.79.227.195 (185.79.227.195): 56 data bytes 64 bytes from 185.79.227.195: seq=0 ttl=63 time=6.943 ms 64 bytes from 185.79.227.195: seq=1 ttl=63 time=1.422 ms 64 bytes from 185.79.227.195: seq=2 ttl=63 time=1.669 ms --- 185.79.227.195 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.422/3.344/6.943 ms 2026-05-18 03:05:56,728 - INFO - Ping to IP 185.79.227.195 from VM test_vm passed 2026-05-18 03:05:56,894 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-18 03:05:56,912 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-59205369:ctest-bgpaas_vn-25363764:ctest-bgpaas_vn-25363764.inet.0 2026-05-18 03:05:56,926 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-59205369:ctest-bgpaas_vn-25363764:ctest-bgpaas_vn-25363764.inet.0 2026-05-18 03:05:57,203 - INFO - Deleting VM test2_vm 2026-05-18 03:05:57,277 - INFO - Deleting VM test_vm 2026-05-18 03:05:57,349 - INFO - Deleting VN ctest-bgpaas_vn-91273677 2026-05-18 03:05:57,401 - DEBUG - VN fc0bc977-06cf-47f8-b697-62ab4d5bbbea still in use: Unable to complete operation on network fc0bc977-06cf-47f8-b697-62ab4d5bbbea. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-ae69f720-7ad9-42d0-a0a2-ee1decc70a10'] 2026-05-18 03:05:57,401 - WARNING - Deleting VN ctest-bgpaas_vn-91273677 failed..Will retry 2026-05-18 03:05:59,591 - DEBUG - Response for deleting network () 2026-05-18 03:05:59,591 - INFO - Deleting VN ctest-bgpaas_vn-25363764 2026-05-18 03:05:59,786 - DEBUG - Response for deleting network () 2026-05-18 03:06:01,080 - DEBUG - No XMPP flaps were noticed during the test
2026-05-18 03:06:01,081 - INFO - END TEST : test_rp_interface_ext_community : PASSED[0:00:32]
2026-05-18 03:06:01,081 - INFO - -------------------------------------------------------------------------------- 2026-05-18 03:06:01,084 - INFO - ================================================================================ 2026-05-18 03:06:01,084 - INFO - STARTING TEST : test_rp_interface_static 2026-05-18 03:06:01,085 - 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-05-18 03:06:02,364 - DEBUG - Nothing to compare xmpp stats {'10.0.0.65': {'10.20.0.129': '0', '10.20.0.25': '2'}, '10.0.0.130': {'10.20.0.25': '0', '10.20.0.129': '3'}} with 2026-05-18 03:06:02,364 - INFO - Initial checks done. Running the testcase now 2026-05-18 03:06:02,365 - INFO - 2026-05-18 03:06:02,687 - DEBUG - Response for create_network : {'network': {'id': '88a01c8a-39e0-4604-a119-64b743ccad17', 'name': 'ctest-bgpaas_vn-03730777', 'tenant_id': '9e520b2fc0e34178b9aed584b6f29cfb', 'project_id': '9e520b2fc0e34178b9aed584b6f29cfb', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-59205369', 'ctest-bgpaas_vn-03730777'], 'port_security_enabled': True, 'description': ''}} 2026-05-18 03:06:02,948 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f95e98f6-0886-44fd-b281-b98ba0478177', 'name': '', 'tenant_id': '9e520b2fc0e34178b9aed584b6f29cfb', 'network_id': '88a01c8a-39e0-4604-a119-64b743ccad17', 'ip_version': 4, 'cidr': '4.55.228.128/26', 'allocation_pools': [{'start': '4.55.228.130', 'end': '4.55.228.190'}], 'gateway_ip': '4.55.228.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '4.55.228.130', 'tags': [], 'project_id': '9e520b2fc0e34178b9aed584b6f29cfb'}} 2026-05-18 03:06:02,973 - INFO - Created VN ctest-bgpaas_vn-03730777 2026-05-18 03:06:02,989 - DEBUG - VN ctest-bgpaas_vn-03730777 UUID is 88a01c8a-39e0-4604-a119-64b743ccad17 2026-05-18 03:06:03,593 - DEBUG - Response for create_network : {'network': {'id': '57ddf9fa-0609-485b-9a44-50afad049ecd', 'name': 'ctest-bgpaas_vn-67349324', 'tenant_id': '9e520b2fc0e34178b9aed584b6f29cfb', 'project_id': '9e520b2fc0e34178b9aed584b6f29cfb', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-59205369', 'ctest-bgpaas_vn-67349324'], 'port_security_enabled': True, 'description': ''}} 2026-05-18 03:06:03,816 - DEBUG - Response for create_subnet : {'subnet': {'id': '2b491613-28ad-4cd8-b6dc-8a91330c01c6', 'name': '', 'tenant_id': '9e520b2fc0e34178b9aed584b6f29cfb', 'network_id': '57ddf9fa-0609-485b-9a44-50afad049ecd', 'ip_version': 4, 'cidr': '38.85.145.64/26', 'allocation_pools': [{'start': '38.85.145.66', 'end': '38.85.145.126'}], 'gateway_ip': '38.85.145.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '38.85.145.66', 'tags': [], 'project_id': '9e520b2fc0e34178b9aed584b6f29cfb'}} 2026-05-18 03:06:03,847 - INFO - Created VN ctest-bgpaas_vn-67349324 2026-05-18 03:06:03,864 - DEBUG - VN ctest-bgpaas_vn-67349324 UUID is 57ddf9fa-0609-485b-9a44-50afad049ecd 2026-05-18 03:06:05,285 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5792-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5792-2) 2026-05-18 03:06:06,682 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5792-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5792-1) 2026-05-18 03:06:06,682 - INFO - Waiting for VM test_vm to be up.. 2026-05-18 03:06:06,782 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-05-18 03:06:11,874 - DEBUG - VM is in ACTIVE state now 2026-05-18 03:06:11,874 - INFO - VM name : test_vm 2026-05-18 03:06:11,964 - DEBUG - VM test_vm ID is 4c3e149e-2175-439a-9dd3-4b75fbccaa22 2026-05-18 03:06:11,964 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5792-2 2026-05-18 03:06:12,057 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine/4c3e149e-2175-439a-9dd3-4b75fbccaa22 2026-05-18 03:06:12,068 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine-interface/9d5efd03-a34d-4f44-8b60-8de02e0c5caa 2026-05-18 03:06:15,263 - 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 1034ms') 2026-05-18 03:06:15,263 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2026-05-18 03:06:15,281 - DEBUG - Gateway for vn default-domain:ctest-TestRP-59205369:ctest-bgpaas_vn-03730777 is 4.55.228.129 and allocation pool is NOT set 2026-05-18 03:06:17,346 - 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=11.3 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.607 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.607/5.977/11.347/5.370 ms') 2026-05-18 03:06:17,346 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2026-05-18 03:06:17,417 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-18 03:06:17,417 - DEBUG - Waiting to SSH to VM test_vm, IP 4.55.228.131, Port 22 2026-05-18 03:06:17,574 - DEBUG - VM test_vm is ready for SSH connections 2026-05-18 03:06:17,574 - INFO - Waiting for VM test2_vm to be up.. 2026-05-18 03:06:17,681 - DEBUG - VM is in ACTIVE state now 2026-05-18 03:06:17,682 - INFO - VM name : test2_vm 2026-05-18 03:06:17,788 - DEBUG - VM test2_vm ID is 62ee172f-9705-4898-b3d6-c10f7279c3f2 2026-05-18 03:06:17,788 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5792-1 2026-05-18 03:06:17,904 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine/62ee172f-9705-4898-b3d6-c10f7279c3f2 2026-05-18 03:06:17,915 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine-interface/fbad4208-53b0-413f-90b3-034d7ec5bacc 2026-05-18 03:06:19,093 - 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.42 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.80 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 = 1.801/5.610/9.420/3.809 ms') 2026-05-18 03:06:19,093 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2026-05-18 03:06:19,166 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-18 03:06:19,166 - DEBUG - Waiting to SSH to VM test2_vm, IP 38.85.145.67, Port 22 2026-05-18 03:06:19,235 - 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-05-18 03:06:19,322 - DEBUG - VM test2_vm is NOT ready for SSH connections, VM status: ACTIVE 2026-05-18 03:06:24,322 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-18 03:06:24,323 - DEBUG - Waiting to SSH to VM test2_vm, IP 38.85.145.67, Port 22 2026-05-18 03:06:24,499 - DEBUG - VM test2_vm is ready for SSH connections 2026-05-18 03:06:24,608 - INFO - Created InterfaceRouteTable ['default-domain', 'ctest-TestRP-59205369', 'ctest-int_table_right-60883450'](UUID a497fbf8-e4c9-470a-992d-150a0af70afc), prefixes : ['67.3.94.64/26'] 2026-05-18 03:06:24,692 - INFO - Added intf route table a497fbf8-e4c9-470a-992d-150a0af70afc to port 9d5efd03-a34d-4f44-8b60-8de02e0c5caa 2026-05-18 03:06:24,926 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-59205369:ctest-bgpaas_vn-03730777:ctest-bgpaas_vn-03730777.inet.0 2026-05-18 03:06:24,949 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-59205369:ctest-bgpaas_vn-03730777:ctest-bgpaas_vn-03730777.inet.0 2026-05-18 03:06:24,971 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-18 03:06:24,971 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 38.85.145.67, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.130, gateway password: c0ntrail123 2026-05-18 03:06:24,971 - DEBUG - ping -s 56 -c 3 -W 1 38.85.145.67 2026-05-18 03:06:28,902 - DEBUG - PING 38.85.145.67 (38.85.145.67): 56 data bytes 64 bytes from 38.85.145.67: seq=0 ttl=63 time=6.330 ms 64 bytes from 38.85.145.67: seq=1 ttl=63 time=1.669 ms 64 bytes from 38.85.145.67: seq=2 ttl=63 time=1.504 ms --- 38.85.145.67 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.504/3.167/6.330 ms 2026-05-18 03:06:28,902 - INFO - Ping to IP 38.85.145.67 from VM test_vm passed 2026-05-18 03:06:29,062 - INFO - Deleting VM test2_vm 2026-05-18 03:06:29,150 - INFO - Deleting VM test_vm 2026-05-18 03:06:29,235 - INFO - Deleting VN ctest-bgpaas_vn-67349324 2026-05-18 03:06:29,281 - DEBUG - VN 57ddf9fa-0609-485b-9a44-50afad049ecd still in use: Unable to complete operation on network 57ddf9fa-0609-485b-9a44-50afad049ecd. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-a763ac09-a727-4587-bbc8-c4a7bd7d9873'] 2026-05-18 03:06:29,281 - WARNING - Deleting VN ctest-bgpaas_vn-67349324 failed..Will retry 2026-05-18 03:06:31,432 - DEBUG - Response for deleting network () 2026-05-18 03:06:31,432 - INFO - Deleting VN ctest-bgpaas_vn-03730777 2026-05-18 03:06:31,617 - DEBUG - Response for deleting network () 2026-05-18 03:06:32,895 - DEBUG - No XMPP flaps were noticed during the test
2026-05-18 03:06:32,895 - INFO - END TEST : test_rp_interface_static : PASSED[0:00:31]
2026-05-18 03:06:32,895 - INFO - -------------------------------------------------------------------------------- 2026-05-18 03:06:33,687 - INFO - Deleted project: ctest-TestRP-59205369, ID : 9e520b2f-c0e3-4178-b9ae-d584b6f29cfb