2026-05-14 03:20:30,239 - INFO - Domain Default found not creating 2026-05-14 03:20:30,436 - INFO - Project ctest-TestRP-25263317 not found, creating it 2026-05-14 03:20:31,033 - INFO - Created Project:ctest-TestRP-25263317, ID : 44cccf37-dbf8-4103-9c38-1f01c02e9507 2026-05-14 03:20:32,815 - DEBUG - Services list from nova: [, , , ] 2026-05-14 03:20:32,815 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5780-1', 'an-jenkins-deploy-platform-ansible-os-5780-2']} 2026-05-14 03:20:32,818 - INFO - ================================================================================ 2026-05-14 03:20:32,818 - INFO - STARTING TEST : test_rp_interface 2026-05-14 03:20:32,819 - 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-14 03:20:34,129 - DEBUG - Nothing to compare xmpp stats {'10.0.0.240': {'10.20.0.18': '0', '10.20.0.129': '0'}, '10.0.0.65': {'10.20.0.18': '0', '10.20.0.129': '0'}} with 2026-05-14 03:20:34,129 - INFO - Initial checks done. Running the testcase now 2026-05-14 03:20:34,130 - INFO - 2026-05-14 03:20:34,959 - DEBUG - Response for create_network : {'network': {'id': '07f0dce1-e646-416a-bc2c-882f030e8c34', 'name': 'ctest-bgpaas_vn-13549772', 'tenant_id': '44cccf37dbf841039c381f01c02e9507', 'project_id': '44cccf37dbf841039c381f01c02e9507', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-25263317', 'ctest-bgpaas_vn-13549772'], 'port_security_enabled': True, 'description': ''}} 2026-05-14 03:20:35,303 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c6243118-3b5f-42ad-ab29-ed3bee06c6f4', 'name': '', 'tenant_id': '44cccf37dbf841039c381f01c02e9507', 'network_id': '07f0dce1-e646-416a-bc2c-882f030e8c34', 'ip_version': 4, 'cidr': '30.184.204.64/26', 'allocation_pools': [{'start': '30.184.204.66', 'end': '30.184.204.126'}], 'gateway_ip': '30.184.204.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '30.184.204.66', 'tags': [], 'project_id': '44cccf37dbf841039c381f01c02e9507'}} 2026-05-14 03:20:35,330 - INFO - Created VN ctest-bgpaas_vn-13549772 2026-05-14 03:20:35,347 - DEBUG - VN ctest-bgpaas_vn-13549772 UUID is 07f0dce1-e646-416a-bc2c-882f030e8c34 2026-05-14 03:20:35,978 - DEBUG - Response for create_network : {'network': {'id': '2b0095a5-7b7b-4785-a583-d4e318ef4499', 'name': 'ctest-bgpaas_vn-40653533', 'tenant_id': '44cccf37dbf841039c381f01c02e9507', 'project_id': '44cccf37dbf841039c381f01c02e9507', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-25263317', 'ctest-bgpaas_vn-40653533'], 'port_security_enabled': True, 'description': ''}} 2026-05-14 03:20:36,263 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd7576d22-5cc7-4d78-ac5b-7e22c29c959f', 'name': '', 'tenant_id': '44cccf37dbf841039c381f01c02e9507', 'network_id': '2b0095a5-7b7b-4785-a583-d4e318ef4499', 'ip_version': 4, 'cidr': '216.96.19.64/26', 'allocation_pools': [{'start': '216.96.19.66', 'end': '216.96.19.126'}], 'gateway_ip': '216.96.19.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '216.96.19.66', 'tags': [], 'project_id': '44cccf37dbf841039c381f01c02e9507'}} 2026-05-14 03:20:36,296 - INFO - Created VN ctest-bgpaas_vn-40653533 2026-05-14 03:20:36,312 - DEBUG - VN ctest-bgpaas_vn-40653533 UUID is 2b0095a5-7b7b-4785-a583-d4e318ef4499 2026-05-14 03:20:38,162 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5780-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5780-1) 2026-05-14 03:20:39,934 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5780-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5780-2) 2026-05-14 03:20:39,934 - INFO - Waiting for VM test_vm to be up.. 2026-05-14 03:20:40,034 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-05-14 03:20:45,138 - DEBUG - VM is in ACTIVE state now 2026-05-14 03:20:45,138 - INFO - VM name : test_vm 2026-05-14 03:20:45,242 - DEBUG - VM test_vm ID is 119903c1-9232-41a2-b1ec-2c5548900f56 2026-05-14 03:20:45,273 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5780-1 2026-05-14 03:20:45,375 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/119903c1-9232-41a2-b1ec-2c5548900f56 2026-05-14 03:20:45,735 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/119903c1-9232-41a2-b1ec-2c5548900f56 2026-05-14 03:20:45,784 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/e6c4057f-dc26-4733-a3b3-0fff16da50f3 2026-05-14 03:20:48,980 - 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 1027ms') 2026-05-14 03:20:48,980 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2026-05-14 03:20:49,006 - DEBUG - Gateway for vn default-domain:ctest-TestRP-25263317:ctest-bgpaas_vn-13549772 is 30.184.204.65 and allocation pool is NOT set 2026-05-14 03:20:51,075 - 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.06 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.531 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.531/2.793/5.055/2.262 ms') 2026-05-14 03:20:51,075 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2026-05-14 03:20:51,149 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-14 03:20:51,149 - DEBUG - Waiting to SSH to VM test_vm, IP 30.184.204.67, Port 22 2026-05-14 03:20:51,315 - DEBUG - VM test_vm is ready for SSH connections 2026-05-14 03:20:51,316 - INFO - Waiting for VM test2_vm to be up.. 2026-05-14 03:20:51,424 - DEBUG - VM is in ACTIVE state now 2026-05-14 03:20:51,424 - INFO - VM name : test2_vm 2026-05-14 03:20:51,515 - DEBUG - VM test2_vm ID is 9e1a1b02-1a36-4839-aef4-5bd16251d384 2026-05-14 03:20:51,515 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5780-2 2026-05-14 03:20:51,608 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/9e1a1b02-1a36-4839-aef4-5bd16251d384 2026-05-14 03:20:51,620 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/a729124e-45b5-4c92-871c-a906ac54884f 2026-05-14 03:20:52,799 - 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.40 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.25 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.248/2.823/3.398/0.575 ms') 2026-05-14 03:20:52,799 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2026-05-14 03:20:52,877 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-14 03:20:52,877 - DEBUG - Waiting to SSH to VM test2_vm, IP 216.96.19.67, Port 22 2026-05-14 03:20:52,946 - 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-14 03:20:53,050 - DEBUG - VM test2_vm is NOT ready for SSH connections, VM status: ACTIVE 2026-05-14 03:20:58,052 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-14 03:20:58,052 - DEBUG - Waiting to SSH to VM test2_vm, IP 216.96.19.67, Port 22 2026-05-14 03:20:58,229 - DEBUG - VM test2_vm is ready for SSH connections 2026-05-14 03:20:58,447 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-14 03:20:58,466 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-25263317:ctest-bgpaas_vn-13549772:ctest-bgpaas_vn-13549772.inet.0 2026-05-14 03:20:58,490 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-25263317:ctest-bgpaas_vn-13549772:ctest-bgpaas_vn-13549772.inet.0 2026-05-14 03:20:58,505 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-14 03:20:58,505 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 216.96.19.67, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.240, gateway password: c0ntrail123 2026-05-14 03:20:58,506 - DEBUG - ping -s 56 -c 3 -W 1 216.96.19.67 2026-05-14 03:21:02,536 - DEBUG - PING 216.96.19.67 (216.96.19.67): 56 data bytes 64 bytes from 216.96.19.67: seq=0 ttl=63 time=6.443 ms 64 bytes from 216.96.19.67: seq=1 ttl=63 time=1.501 ms 64 bytes from 216.96.19.67: seq=2 ttl=63 time=1.774 ms --- 216.96.19.67 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.501/3.239/6.443 ms 2026-05-14 03:21:02,537 - INFO - Ping to IP 216.96.19.67 from VM test_vm passed 2026-05-14 03:21:02,669 - INFO - Deleting VM test2_vm 2026-05-14 03:21:02,763 - INFO - Deleting VM test_vm 2026-05-14 03:21:02,842 - INFO - Deleting VN ctest-bgpaas_vn-40653533 2026-05-14 03:21:02,892 - DEBUG - VN 2b0095a5-7b7b-4785-a583-d4e318ef4499 still in use: Unable to complete operation on network 2b0095a5-7b7b-4785-a583-d4e318ef4499. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-f45a1923-ea96-4868-ba35-51014f1a18dd'] 2026-05-14 03:21:02,892 - WARNING - Deleting VN ctest-bgpaas_vn-40653533 failed..Will retry 2026-05-14 03:21:05,060 - DEBUG - Response for deleting network () 2026-05-14 03:21:05,060 - INFO - Deleting VN ctest-bgpaas_vn-13549772 2026-05-14 03:21:05,273 - DEBUG - Response for deleting network () 2026-05-14 03:21:06,594 - DEBUG - No XMPP flaps were noticed during the test
2026-05-14 03:21:06,594 - INFO - END TEST : test_rp_interface : PASSED[0:00:34]
2026-05-14 03:21:06,594 - INFO - -------------------------------------------------------------------------------- 2026-05-14 03:21:06,597 - INFO - ================================================================================ 2026-05-14 03:21:06,597 - INFO - STARTING TEST : test_rp_interface_ext_community 2026-05-14 03:21:06,598 - 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-14 03:21:07,878 - DEBUG - Nothing to compare xmpp stats {'10.0.0.240': {'10.20.0.18': '0', '10.20.0.129': '0'}, '10.0.0.65': {'10.20.0.18': '0', '10.20.0.129': '0'}} with 2026-05-14 03:21:07,878 - INFO - Initial checks done. Running the testcase now 2026-05-14 03:21:07,878 - INFO - 2026-05-14 03:21:08,181 - DEBUG - Response for create_network : {'network': {'id': '658b9ca8-782c-49e5-9183-c18338810d71', 'name': 'ctest-bgpaas_vn-18945304', 'tenant_id': '44cccf37dbf841039c381f01c02e9507', 'project_id': '44cccf37dbf841039c381f01c02e9507', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-25263317', 'ctest-bgpaas_vn-18945304'], 'port_security_enabled': True, 'description': ''}} 2026-05-14 03:21:08,467 - DEBUG - Response for create_subnet : {'subnet': {'id': '075b7043-967e-4f7a-9fb0-113de1bb9d28', 'name': '', 'tenant_id': '44cccf37dbf841039c381f01c02e9507', 'network_id': '658b9ca8-782c-49e5-9183-c18338810d71', 'ip_version': 4, 'cidr': '38.199.221.0/26', 'allocation_pools': [{'start': '38.199.221.2', 'end': '38.199.221.62'}], 'gateway_ip': '38.199.221.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '38.199.221.2', 'tags': [], 'project_id': '44cccf37dbf841039c381f01c02e9507'}} 2026-05-14 03:21:08,492 - INFO - Created VN ctest-bgpaas_vn-18945304 2026-05-14 03:21:08,508 - DEBUG - VN ctest-bgpaas_vn-18945304 UUID is 658b9ca8-782c-49e5-9183-c18338810d71 2026-05-14 03:21:09,067 - DEBUG - Response for create_network : {'network': {'id': 'd9fb6732-fef6-43d4-ad6a-85752b6463dd', 'name': 'ctest-bgpaas_vn-11764123', 'tenant_id': '44cccf37dbf841039c381f01c02e9507', 'project_id': '44cccf37dbf841039c381f01c02e9507', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-25263317', 'ctest-bgpaas_vn-11764123'], 'port_security_enabled': True, 'description': ''}} 2026-05-14 03:21:09,301 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f25373a6-a499-4a92-8334-6d7199d85748', 'name': '', 'tenant_id': '44cccf37dbf841039c381f01c02e9507', 'network_id': 'd9fb6732-fef6-43d4-ad6a-85752b6463dd', 'ip_version': 4, 'cidr': '11.253.167.192/26', 'allocation_pools': [{'start': '11.253.167.194', 'end': '11.253.167.254'}], 'gateway_ip': '11.253.167.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '11.253.167.194', 'tags': [], 'project_id': '44cccf37dbf841039c381f01c02e9507'}} 2026-05-14 03:21:09,332 - INFO - Created VN ctest-bgpaas_vn-11764123 2026-05-14 03:21:09,350 - DEBUG - VN ctest-bgpaas_vn-11764123 UUID is d9fb6732-fef6-43d4-ad6a-85752b6463dd 2026-05-14 03:21:10,875 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5780-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5780-1) 2026-05-14 03:21:12,348 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5780-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5780-2) 2026-05-14 03:21:12,348 - INFO - Waiting for VM test_vm to be up.. 2026-05-14 03:21:12,446 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-05-14 03:21:17,572 - DEBUG - VM is in ACTIVE state now 2026-05-14 03:21:17,572 - INFO - VM name : test_vm 2026-05-14 03:21:17,683 - DEBUG - VM test_vm ID is 047fd8ba-0fcc-438b-84e9-86b3852a7745 2026-05-14 03:21:17,683 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5780-1 2026-05-14 03:21:17,778 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/047fd8ba-0fcc-438b-84e9-86b3852a7745 2026-05-14 03:21:17,790 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/66aff052-c363-4835-81cd-95fd4dd529a1 2026-05-14 03:21:20,973 - 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 1018ms') 2026-05-14 03:21:20,973 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2026-05-14 03:21:20,991 - DEBUG - Gateway for vn default-domain:ctest-TestRP-25263317:ctest-bgpaas_vn-18945304 is 38.199.221.1 and allocation pool is NOT set 2026-05-14 03:21:23,062 - 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.39 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.433 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.433/2.913/5.393/2.480 ms') 2026-05-14 03:21:23,062 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2026-05-14 03:21:23,141 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-14 03:21:23,141 - DEBUG - Waiting to SSH to VM test_vm, IP 38.199.221.3, Port 22 2026-05-14 03:21:23,312 - DEBUG - VM test_vm is ready for SSH connections 2026-05-14 03:21:23,312 - INFO - Waiting for VM test2_vm to be up.. 2026-05-14 03:21:23,412 - DEBUG - VM is in ACTIVE state now 2026-05-14 03:21:23,412 - INFO - VM name : test2_vm 2026-05-14 03:21:23,518 - DEBUG - VM test2_vm ID is 07c3678b-9326-4baa-a26c-c8a09094bd8e 2026-05-14 03:21:23,519 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5780-2 2026-05-14 03:21:23,623 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/07c3678b-9326-4baa-a26c-c8a09094bd8e 2026-05-14 03:21:23,638 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/549619c9-e843-4d83-b6cd-32be6ed15366 2026-05-14 03:21:24,833 - 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.83 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.47 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.471/3.148/4.825/1.677 ms') 2026-05-14 03:21:24,833 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2026-05-14 03:21:24,910 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-14 03:21:24,910 - DEBUG - Waiting to SSH to VM test2_vm, IP 11.253.167.195, Port 22 2026-05-14 03:21:24,977 - 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-14 03:21:25,077 - DEBUG - VM test2_vm is NOT ready for SSH connections, VM status: ACTIVE 2026-05-14 03:21:30,078 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-14 03:21:30,079 - DEBUG - Waiting to SSH to VM test2_vm, IP 11.253.167.195, Port 22 2026-05-14 03:21:30,250 - DEBUG - VM test2_vm is ready for SSH connections 2026-05-14 03:21:30,431 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-14 03:21:30,448 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-25263317:ctest-bgpaas_vn-18945304:ctest-bgpaas_vn-18945304.inet.0 2026-05-14 03:21:31,468 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-14 03:21:31,482 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-25263317:ctest-bgpaas_vn-18945304:ctest-bgpaas_vn-18945304.inet.0 2026-05-14 03:21:31,500 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-25263317:ctest-bgpaas_vn-18945304:ctest-bgpaas_vn-18945304.inet.0 2026-05-14 03:21:31,516 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-14 03:21:31,516 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 11.253.167.195, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.240, gateway password: c0ntrail123 2026-05-14 03:21:31,516 - DEBUG - ping -s 56 -c 3 -W 1 11.253.167.195 2026-05-14 03:21:35,202 - DEBUG - PING 11.253.167.195 (11.253.167.195): 56 data bytes 64 bytes from 11.253.167.195: seq=0 ttl=63 time=7.802 ms 64 bytes from 11.253.167.195: seq=1 ttl=63 time=2.650 ms 64 bytes from 11.253.167.195: seq=2 ttl=63 time=1.428 ms --- 11.253.167.195 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.428/3.960/7.802 ms 2026-05-14 03:21:35,202 - INFO - Ping to IP 11.253.167.195 from VM test_vm passed 2026-05-14 03:21:35,407 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-14 03:21:35,421 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-25263317:ctest-bgpaas_vn-18945304:ctest-bgpaas_vn-18945304.inet.0 2026-05-14 03:21:35,437 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-25263317:ctest-bgpaas_vn-18945304:ctest-bgpaas_vn-18945304.inet.0 2026-05-14 03:21:35,746 - INFO - Deleting VM test2_vm 2026-05-14 03:21:35,893 - INFO - Deleting VM test_vm 2026-05-14 03:21:35,981 - INFO - Deleting VN ctest-bgpaas_vn-11764123 2026-05-14 03:21:36,032 - DEBUG - VN d9fb6732-fef6-43d4-ad6a-85752b6463dd still in use: Unable to complete operation on network d9fb6732-fef6-43d4-ad6a-85752b6463dd. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-21575ae9-9d5c-46d2-bfd3-a8a7a4ebd092'] 2026-05-14 03:21:36,032 - WARNING - Deleting VN ctest-bgpaas_vn-11764123 failed..Will retry 2026-05-14 03:21:38,243 - DEBUG - Response for deleting network () 2026-05-14 03:21:38,244 - INFO - Deleting VN ctest-bgpaas_vn-18945304 2026-05-14 03:21:38,438 - DEBUG - Response for deleting network () 2026-05-14 03:21:39,723 - DEBUG - No XMPP flaps were noticed during the test
2026-05-14 03:21:39,723 - INFO - END TEST : test_rp_interface_ext_community : PASSED[0:00:33]
2026-05-14 03:21:39,723 - INFO - -------------------------------------------------------------------------------- 2026-05-14 03:21:39,728 - INFO - ================================================================================ 2026-05-14 03:21:39,728 - INFO - STARTING TEST : test_rp_interface_static 2026-05-14 03:21:39,728 - 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-14 03:21:41,013 - DEBUG - Nothing to compare xmpp stats {'10.0.0.240': {'10.20.0.18': '0', '10.20.0.129': '0'}, '10.0.0.65': {'10.20.0.18': '0', '10.20.0.129': '0'}} with 2026-05-14 03:21:41,013 - INFO - Initial checks done. Running the testcase now 2026-05-14 03:21:41,013 - INFO - 2026-05-14 03:21:41,307 - DEBUG - Response for create_network : {'network': {'id': '8464ac88-0447-423a-9513-a9700f1dd58d', 'name': 'ctest-bgpaas_vn-47991128', 'tenant_id': '44cccf37dbf841039c381f01c02e9507', 'project_id': '44cccf37dbf841039c381f01c02e9507', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-25263317', 'ctest-bgpaas_vn-47991128'], 'port_security_enabled': True, 'description': ''}} 2026-05-14 03:21:41,577 - DEBUG - Response for create_subnet : {'subnet': {'id': '56ae7daf-e191-4576-87dc-62132269e2a5', 'name': '', 'tenant_id': '44cccf37dbf841039c381f01c02e9507', 'network_id': '8464ac88-0447-423a-9513-a9700f1dd58d', 'ip_version': 4, 'cidr': '32.57.0.192/26', 'allocation_pools': [{'start': '32.57.0.194', 'end': '32.57.0.254'}], 'gateway_ip': '32.57.0.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '32.57.0.194', 'tags': [], 'project_id': '44cccf37dbf841039c381f01c02e9507'}} 2026-05-14 03:21:41,605 - INFO - Created VN ctest-bgpaas_vn-47991128 2026-05-14 03:21:41,623 - DEBUG - VN ctest-bgpaas_vn-47991128 UUID is 8464ac88-0447-423a-9513-a9700f1dd58d 2026-05-14 03:21:42,236 - DEBUG - Response for create_network : {'network': {'id': 'b4abaa06-5169-4d63-87f5-ad0ed4233372', 'name': 'ctest-bgpaas_vn-60882704', 'tenant_id': '44cccf37dbf841039c381f01c02e9507', 'project_id': '44cccf37dbf841039c381f01c02e9507', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-25263317', 'ctest-bgpaas_vn-60882704'], 'port_security_enabled': True, 'description': ''}} 2026-05-14 03:21:42,544 - DEBUG - Response for create_subnet : {'subnet': {'id': '62df766e-e694-40dc-ad6f-56a712b3519c', 'name': '', 'tenant_id': '44cccf37dbf841039c381f01c02e9507', 'network_id': 'b4abaa06-5169-4d63-87f5-ad0ed4233372', 'ip_version': 4, 'cidr': '95.14.125.0/26', 'allocation_pools': [{'start': '95.14.125.2', 'end': '95.14.125.62'}], 'gateway_ip': '95.14.125.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '95.14.125.2', 'tags': [], 'project_id': '44cccf37dbf841039c381f01c02e9507'}} 2026-05-14 03:21:42,568 - INFO - Created VN ctest-bgpaas_vn-60882704 2026-05-14 03:21:42,587 - DEBUG - VN ctest-bgpaas_vn-60882704 UUID is b4abaa06-5169-4d63-87f5-ad0ed4233372 2026-05-14 03:21:44,155 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5780-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5780-1) 2026-05-14 03:21:45,798 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5780-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5780-2) 2026-05-14 03:21:45,798 - INFO - Waiting for VM test_vm to be up.. 2026-05-14 03:21:45,913 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-05-14 03:21:51,010 - DEBUG - VM is in ACTIVE state now 2026-05-14 03:21:51,011 - INFO - VM name : test_vm 2026-05-14 03:21:51,115 - DEBUG - VM test_vm ID is 73ed7260-65d0-41a9-a2d8-66fb50587fb0 2026-05-14 03:21:51,115 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5780-1 2026-05-14 03:21:51,229 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/73ed7260-65d0-41a9-a2d8-66fb50587fb0 2026-05-14 03:21:51,242 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/aacb1500-1c28-4303-a968-8dec1ba44941 2026-05-14 03:21:54,450 - 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-14 03:21:54,451 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2026-05-14 03:21:54,468 - DEBUG - Gateway for vn default-domain:ctest-TestRP-25263317:ctest-bgpaas_vn-47991128 is 32.57.0.193 and allocation pool is NOT set 2026-05-14 03:21:56,529 - 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=8.73 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.31 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.309/5.017/8.725/3.708 ms') 2026-05-14 03:21:56,529 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2026-05-14 03:21:56,604 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-14 03:21:56,604 - DEBUG - Waiting to SSH to VM test_vm, IP 32.57.0.195, Port 22 2026-05-14 03:21:56,676 - 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-14 03:21:56,790 - DEBUG - VM test_vm is NOT ready for SSH connections, VM status: ACTIVE 2026-05-14 03:22:01,791 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-14 03:22:01,791 - DEBUG - Waiting to SSH to VM test_vm, IP 32.57.0.195, Port 22 2026-05-14 03:22:01,959 - DEBUG - VM test_vm is ready for SSH connections 2026-05-14 03:22:01,959 - INFO - Waiting for VM test2_vm to be up.. 2026-05-14 03:22:02,063 - DEBUG - VM is in ACTIVE state now 2026-05-14 03:22:02,063 - INFO - VM name : test2_vm 2026-05-14 03:22:02,192 - DEBUG - VM test2_vm ID is 353b0bf7-5473-432a-92c2-135eb296a97e 2026-05-14 03:22:02,193 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5780-2 2026-05-14 03:22:02,317 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/353b0bf7-5473-432a-92c2-135eb296a97e 2026-05-14 03:22:02,331 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/b610e157-0f4f-441e-a2f7-074e4ace91f6 2026-05-14 03:22:03,503 - 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.27 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.428 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.428/1.849/3.271/1.421 ms') 2026-05-14 03:22:03,504 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2026-05-14 03:22:03,582 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-14 03:22:03,583 - DEBUG - Waiting to SSH to VM test2_vm, IP 95.14.125.3, Port 22 2026-05-14 03:22:03,743 - DEBUG - VM test2_vm is ready for SSH connections 2026-05-14 03:22:03,843 - INFO - Created InterfaceRouteTable ['default-domain', 'ctest-TestRP-25263317', 'ctest-int_table_right-71110483'](UUID 8e5b4f35-cc4d-445d-b37d-d9eba4275a5c), prefixes : ['171.0.63.64/26'] 2026-05-14 03:22:03,915 - INFO - Added intf route table 8e5b4f35-cc4d-445d-b37d-d9eba4275a5c to port aacb1500-1c28-4303-a968-8dec1ba44941 2026-05-14 03:22:04,134 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-25263317:ctest-bgpaas_vn-47991128:ctest-bgpaas_vn-47991128.inet.0 2026-05-14 03:22:04,153 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-25263317:ctest-bgpaas_vn-47991128:ctest-bgpaas_vn-47991128.inet.0 2026-05-14 03:22:04,170 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-14 03:22:04,170 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 95.14.125.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.240, gateway password: c0ntrail123 2026-05-14 03:22:04,170 - DEBUG - ping -s 56 -c 3 -W 1 95.14.125.3 2026-05-14 03:22:08,372 - DEBUG - PING 95.14.125.3 (95.14.125.3): 56 data bytes 64 bytes from 95.14.125.3: seq=0 ttl=63 time=7.513 ms 64 bytes from 95.14.125.3: seq=1 ttl=63 time=1.547 ms 64 bytes from 95.14.125.3: seq=2 ttl=63 time=1.781 ms --- 95.14.125.3 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.547/3.613/7.513 ms 2026-05-14 03:22:08,372 - INFO - Ping to IP 95.14.125.3 from VM test_vm passed 2026-05-14 03:22:08,506 - INFO - Deleting VM test2_vm 2026-05-14 03:22:08,689 - INFO - Deleting VM test_vm 2026-05-14 03:22:08,776 - INFO - Deleting VN ctest-bgpaas_vn-60882704 2026-05-14 03:22:08,820 - DEBUG - VN b4abaa06-5169-4d63-87f5-ad0ed4233372 still in use: Unable to complete operation on network b4abaa06-5169-4d63-87f5-ad0ed4233372. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-38418321-5ac1-4926-8a26-c68f93d54555'] 2026-05-14 03:22:08,820 - WARNING - Deleting VN ctest-bgpaas_vn-60882704 failed..Will retry 2026-05-14 03:22:11,012 - DEBUG - Response for deleting network () 2026-05-14 03:22:11,012 - INFO - Deleting VN ctest-bgpaas_vn-47991128 2026-05-14 03:22:11,211 - DEBUG - Response for deleting network () 2026-05-14 03:22:12,521 - DEBUG - No XMPP flaps were noticed during the test
2026-05-14 03:22:12,521 - INFO - END TEST : test_rp_interface_static : PASSED[0:00:33]
2026-05-14 03:22:12,521 - INFO - -------------------------------------------------------------------------------- 2026-05-14 03:22:13,339 - INFO - Deleted project: ctest-TestRP-25263317, ID : 44cccf37-dbf8-4103-9c38-1f01c02e9507