2026-01-15 03:00:56,302 - INFO - Domain Default found not creating 2026-01-15 03:00:56,526 - INFO - Project ctest-TestRP-14741411 not found, creating it 2026-01-15 03:00:57,137 - INFO - Created Project:ctest-TestRP-14741411, ID : 6966520c-938e-4a5e-9011-e97601958f74 2026-01-15 03:00:58,916 - DEBUG - Services list from nova: [, , , ] 2026-01-15 03:00:58,917 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5009-2', 'an-jenkins-deploy-platform-ansible-os-5009-1']} 2026-01-15 03:00:58,919 - INFO - ================================================================================ 2026-01-15 03:00:58,919 - INFO - STARTING TEST : test_rp_interface 2026-01-15 03:00:58,919 - 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-01-15 03:01:00,216 - DEBUG - Nothing to compare xmpp stats {'10.0.0.141': {'10.20.0.249': '0', '10.20.0.201': '0'}, '10.0.0.133': {'10.20.0.249': '0', '10.20.0.201': '0'}} with 2026-01-15 03:01:00,216 - INFO - Initial checks done. Running the testcase now 2026-01-15 03:01:00,216 - INFO - 2026-01-15 03:01:01,093 - DEBUG - Response for create_network : {'network': {'id': '2667ec66-ba7d-4855-9649-53a61ee55cb7', 'name': 'ctest-bgpaas_vn-95953690', 'tenant_id': '6966520c938e4a5e9011e97601958f74', 'project_id': '6966520c938e4a5e9011e97601958f74', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-14741411', 'ctest-bgpaas_vn-95953690'], 'port_security_enabled': True, 'description': ''}} 2026-01-15 03:01:01,366 - DEBUG - Response for create_subnet : {'subnet': {'id': '2d3fde7d-5bf7-44ec-ace7-d001a53b9283', 'name': '', 'tenant_id': '6966520c938e4a5e9011e97601958f74', 'network_id': '2667ec66-ba7d-4855-9649-53a61ee55cb7', 'ip_version': 4, 'cidr': '99.16.94.0/26', 'allocation_pools': [{'start': '99.16.94.2', 'end': '99.16.94.62'}], 'gateway_ip': '99.16.94.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '99.16.94.2', 'tags': [], 'project_id': '6966520c938e4a5e9011e97601958f74'}} 2026-01-15 03:01:01,399 - INFO - Created VN ctest-bgpaas_vn-95953690 2026-01-15 03:01:01,411 - DEBUG - VN ctest-bgpaas_vn-95953690 UUID is 2667ec66-ba7d-4855-9649-53a61ee55cb7 2026-01-15 03:01:01,948 - DEBUG - Response for create_network : {'network': {'id': 'acff9c63-300d-4af6-b0b6-b39369c89423', 'name': 'ctest-bgpaas_vn-16051953', 'tenant_id': '6966520c938e4a5e9011e97601958f74', 'project_id': '6966520c938e4a5e9011e97601958f74', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-14741411', 'ctest-bgpaas_vn-16051953'], 'port_security_enabled': True, 'description': ''}} 2026-01-15 03:01:02,207 - DEBUG - Response for create_subnet : {'subnet': {'id': '7a787233-92e9-4074-9422-0a313a4f4a21', 'name': '', 'tenant_id': '6966520c938e4a5e9011e97601958f74', 'network_id': 'acff9c63-300d-4af6-b0b6-b39369c89423', 'ip_version': 4, 'cidr': '91.6.233.128/26', 'allocation_pools': [{'start': '91.6.233.130', 'end': '91.6.233.190'}], 'gateway_ip': '91.6.233.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '91.6.233.130', 'tags': [], 'project_id': '6966520c938e4a5e9011e97601958f74'}} 2026-01-15 03:01:02,233 - INFO - Created VN ctest-bgpaas_vn-16051953 2026-01-15 03:01:02,246 - DEBUG - VN ctest-bgpaas_vn-16051953 UUID is acff9c63-300d-4af6-b0b6-b39369c89423 2026-01-15 03:01:03,845 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5009-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5009-2) 2026-01-15 03:01:05,509 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5009-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5009-1) 2026-01-15 03:01:05,509 - INFO - Waiting for VM test_vm to be up.. 2026-01-15 03:01:05,645 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-01-15 03:01:10,752 - DEBUG - VM is in ACTIVE state now 2026-01-15 03:01:10,752 - INFO - VM name : test_vm 2026-01-15 03:01:10,865 - DEBUG - VM test_vm ID is dbd9c303-aaca-4643-94a6-3184eadf6544 2026-01-15 03:01:10,907 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5009-2 2026-01-15 03:01:11,028 - DEBUG - Requesting: http://10.0.0.73:8082/virtual-machine/dbd9c303-aaca-4643-94a6-3184eadf6544 2026-01-15 03:01:11,408 - DEBUG - Requesting: http://10.0.0.73:8082/virtual-machine/dbd9c303-aaca-4643-94a6-3184eadf6544 2026-01-15 03:01:11,455 - DEBUG - Requesting: http://10.0.0.73:8082/virtual-machine-interface/f04d108f-b9c9-4ca4-9b49-7ed982a8ba9a 2026-01-15 03:01:14,634 - 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 1006ms') 2026-01-15 03:01:14,635 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2026-01-15 03:01:14,651 - DEBUG - Gateway for vn default-domain:ctest-TestRP-14741411:ctest-bgpaas_vn-95953690 is 99.16.94.1 and allocation pool is NOT set 2026-01-15 03:01:16,722 - 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.13 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.586 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.586/4.358/8.130/3.772 ms') 2026-01-15 03:01:16,722 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2026-01-15 03:01:16,794 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-15 03:01:16,794 - DEBUG - Waiting to SSH to VM test_vm, IP 99.16.94.3, Port 22 2026-01-15 03:01:16,954 - DEBUG - VM test_vm is ready for SSH connections 2026-01-15 03:01:16,954 - INFO - Waiting for VM test2_vm to be up.. 2026-01-15 03:01:17,048 - DEBUG - VM is in ACTIVE state now 2026-01-15 03:01:17,048 - INFO - VM name : test2_vm 2026-01-15 03:01:17,158 - DEBUG - VM test2_vm ID is 47fdec99-26d7-4cc4-a331-e3ad25b35f04 2026-01-15 03:01:17,158 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5009-1 2026-01-15 03:01:17,255 - DEBUG - Requesting: http://10.0.0.73:8082/virtual-machine/47fdec99-26d7-4cc4-a331-e3ad25b35f04 2026-01-15 03:01:17,266 - DEBUG - Requesting: http://10.0.0.73:8082/virtual-machine-interface/e11d6fc5-9f3d-4bb1-8459-49135568e5ad 2026-01-15 03:01:18,431 - 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.10 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.514 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.514/2.308/4.102/1.794 ms') 2026-01-15 03:01:18,431 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2026-01-15 03:01:18,502 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-15 03:01:18,502 - DEBUG - Waiting to SSH to VM test2_vm, IP 91.6.233.131, Port 22 2026-01-15 03:01:18,669 - DEBUG - VM test2_vm is ready for SSH connections 2026-01-15 03:01:18,825 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-15 03:01:18,845 - DEBUG - Requesting: http://10.20.0.249:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-14741411:ctest-bgpaas_vn-95953690:ctest-bgpaas_vn-95953690.inet.0 2026-01-15 03:01:18,859 - DEBUG - Requesting: http://10.20.0.201:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-14741411:ctest-bgpaas_vn-95953690:ctest-bgpaas_vn-95953690.inet.0 2026-01-15 03:01:18,875 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-15 03:01:18,875 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 91.6.233.131, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.133, gateway password: c0ntrail123 2026-01-15 03:01:18,875 - DEBUG - ping -s 56 -c 3 -W 1 91.6.233.131 2026-01-15 03:01:22,572 - DEBUG - PING 91.6.233.131 (91.6.233.131): 56 data bytes 64 bytes from 91.6.233.131: seq=0 ttl=63 time=6.935 ms 64 bytes from 91.6.233.131: seq=1 ttl=63 time=1.470 ms 64 bytes from 91.6.233.131: seq=2 ttl=63 time=1.633 ms --- 91.6.233.131 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.470/3.346/6.935 ms 2026-01-15 03:01:22,572 - INFO - Ping to IP 91.6.233.131 from VM test_vm passed 2026-01-15 03:01:22,690 - INFO - Deleting VM test2_vm 2026-01-15 03:01:22,777 - INFO - Deleting VM test_vm 2026-01-15 03:01:22,858 - INFO - Deleting VN ctest-bgpaas_vn-16051953 2026-01-15 03:01:22,904 - DEBUG - VN acff9c63-300d-4af6-b0b6-b39369c89423 still in use: Unable to complete operation on network acff9c63-300d-4af6-b0b6-b39369c89423. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-1b4c01cd-3029-4367-82e0-450eef6af634'] 2026-01-15 03:01:22,904 - WARNING - Deleting VN ctest-bgpaas_vn-16051953 failed..Will retry 2026-01-15 03:01:25,079 - DEBUG - Response for deleting network () 2026-01-15 03:01:25,079 - INFO - Deleting VN ctest-bgpaas_vn-95953690 2026-01-15 03:01:25,261 - DEBUG - Response for deleting network () 2026-01-15 03:01:26,539 - DEBUG - No XMPP flaps were noticed during the test
2026-01-15 03:01:26,539 - INFO - END TEST : test_rp_interface : PASSED[0:00:28]
2026-01-15 03:01:26,539 - INFO - -------------------------------------------------------------------------------- 2026-01-15 03:01:26,542 - INFO - ================================================================================ 2026-01-15 03:01:26,542 - INFO - STARTING TEST : test_rp_interface_ext_community 2026-01-15 03:01:26,542 - 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-01-15 03:01:27,803 - DEBUG - Nothing to compare xmpp stats {'10.0.0.141': {'10.20.0.249': '0', '10.20.0.201': '0'}, '10.0.0.133': {'10.20.0.249': '0', '10.20.0.201': '0'}} with 2026-01-15 03:01:27,803 - INFO - Initial checks done. Running the testcase now 2026-01-15 03:01:27,803 - INFO - 2026-01-15 03:01:28,085 - DEBUG - Response for create_network : {'network': {'id': '721df0c2-4f0c-4cdf-bd88-7c7879245f68', 'name': 'ctest-bgpaas_vn-52801781', 'tenant_id': '6966520c938e4a5e9011e97601958f74', 'project_id': '6966520c938e4a5e9011e97601958f74', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-14741411', 'ctest-bgpaas_vn-52801781'], 'port_security_enabled': True, 'description': ''}} 2026-01-15 03:01:28,305 - DEBUG - Response for create_subnet : {'subnet': {'id': 'b19a4376-5703-4568-8223-5a548e6cefd7', 'name': '', 'tenant_id': '6966520c938e4a5e9011e97601958f74', 'network_id': '721df0c2-4f0c-4cdf-bd88-7c7879245f68', 'ip_version': 4, 'cidr': '37.132.57.64/26', 'allocation_pools': [{'start': '37.132.57.66', 'end': '37.132.57.126'}], 'gateway_ip': '37.132.57.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '37.132.57.66', 'tags': [], 'project_id': '6966520c938e4a5e9011e97601958f74'}} 2026-01-15 03:01:28,336 - INFO - Created VN ctest-bgpaas_vn-52801781 2026-01-15 03:01:28,349 - DEBUG - VN ctest-bgpaas_vn-52801781 UUID is 721df0c2-4f0c-4cdf-bd88-7c7879245f68 2026-01-15 03:01:28,877 - DEBUG - Response for create_network : {'network': {'id': 'e7dd4918-39f9-4a32-95ff-14351b1b9f11', 'name': 'ctest-bgpaas_vn-44670206', 'tenant_id': '6966520c938e4a5e9011e97601958f74', 'project_id': '6966520c938e4a5e9011e97601958f74', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-14741411', 'ctest-bgpaas_vn-44670206'], 'port_security_enabled': True, 'description': ''}} 2026-01-15 03:01:29,163 - DEBUG - Response for create_subnet : {'subnet': {'id': '4a9fb32b-fb06-4c0d-838a-0504e50e69f8', 'name': '', 'tenant_id': '6966520c938e4a5e9011e97601958f74', 'network_id': 'e7dd4918-39f9-4a32-95ff-14351b1b9f11', 'ip_version': 4, 'cidr': '93.8.140.128/26', 'allocation_pools': [{'start': '93.8.140.130', 'end': '93.8.140.190'}], 'gateway_ip': '93.8.140.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '93.8.140.130', 'tags': [], 'project_id': '6966520c938e4a5e9011e97601958f74'}} 2026-01-15 03:01:29,189 - INFO - Created VN ctest-bgpaas_vn-44670206 2026-01-15 03:01:29,207 - DEBUG - VN ctest-bgpaas_vn-44670206 UUID is e7dd4918-39f9-4a32-95ff-14351b1b9f11 2026-01-15 03:01:30,677 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5009-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5009-2) 2026-01-15 03:01:32,332 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5009-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5009-1) 2026-01-15 03:01:32,333 - INFO - Waiting for VM test_vm to be up.. 2026-01-15 03:01:32,451 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-01-15 03:01:37,576 - DEBUG - VM is in ACTIVE state now 2026-01-15 03:01:37,576 - INFO - VM name : test_vm 2026-01-15 03:01:37,693 - DEBUG - VM test_vm ID is acd5c74d-fc7d-464e-87b9-5b56fee5f460 2026-01-15 03:01:37,693 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5009-2 2026-01-15 03:01:37,824 - DEBUG - Requesting: http://10.0.0.73:8082/virtual-machine/acd5c74d-fc7d-464e-87b9-5b56fee5f460 2026-01-15 03:01:37,834 - DEBUG - Requesting: http://10.0.0.73:8082/virtual-machine-interface/0b4841a9-df68-4aa5-97e6-00a7dd937b2f 2026-01-15 03:01:40,999 - 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 1003ms') 2026-01-15 03:01:40,999 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2026-01-15 03:01:41,016 - DEBUG - Gateway for vn default-domain:ctest-TestRP-14741411:ctest-bgpaas_vn-52801781 is 37.132.57.65 and allocation pool is NOT set 2026-01-15 03:01:43,079 - 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=12.2 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.04 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.035/7.112/12.189/5.077 ms') 2026-01-15 03:01:43,079 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2026-01-15 03:01:43,150 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-15 03:01:43,150 - DEBUG - Waiting to SSH to VM test_vm, IP 37.132.57.67, Port 22 2026-01-15 03:01:43,216 - 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-01-15 03:01:43,322 - DEBUG - VM test_vm is NOT ready for SSH connections, VM status: ACTIVE 2026-01-15 03:01:48,323 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-15 03:01:48,323 - DEBUG - Waiting to SSH to VM test_vm, IP 37.132.57.67, Port 22 2026-01-15 03:01:48,492 - DEBUG - VM test_vm is ready for SSH connections 2026-01-15 03:01:48,492 - INFO - Waiting for VM test2_vm to be up.. 2026-01-15 03:01:48,594 - DEBUG - VM is in ACTIVE state now 2026-01-15 03:01:48,594 - INFO - VM name : test2_vm 2026-01-15 03:01:48,698 - DEBUG - VM test2_vm ID is 7c9d6578-f0b6-49dc-84c2-6bb977fe600f 2026-01-15 03:01:48,698 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5009-1 2026-01-15 03:01:48,794 - DEBUG - Requesting: http://10.0.0.73:8082/virtual-machine/7c9d6578-f0b6-49dc-84c2-6bb977fe600f 2026-01-15 03:01:48,804 - DEBUG - Requesting: http://10.0.0.73:8082/virtual-machine-interface/1f7aa337-ae68-42ed-82cd-37ee316d9679 2026-01-15 03:01:49,966 - 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.31 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.699 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.699/2.002/3.305/1.303 ms') 2026-01-15 03:01:49,966 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2026-01-15 03:01:50,033 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-15 03:01:50,033 - DEBUG - Waiting to SSH to VM test2_vm, IP 93.8.140.131, Port 22 2026-01-15 03:01:50,205 - DEBUG - VM test2_vm is ready for SSH connections 2026-01-15 03:01:50,356 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-15 03:01:50,370 - DEBUG - Requesting: http://10.20.0.249:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-14741411:ctest-bgpaas_vn-52801781:ctest-bgpaas_vn-52801781.inet.0 2026-01-15 03:01:50,384 - DEBUG - Requesting: http://10.20.0.201:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-14741411:ctest-bgpaas_vn-52801781:ctest-bgpaas_vn-52801781.inet.0 2026-01-15 03:01:50,414 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-15 03:01:50,414 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 93.8.140.131, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.133, gateway password: c0ntrail123 2026-01-15 03:01:50,415 - DEBUG - ping -s 56 -c 3 -W 1 93.8.140.131 2026-01-15 03:01:54,404 - DEBUG - PING 93.8.140.131 (93.8.140.131): 56 data bytes 64 bytes from 93.8.140.131: seq=0 ttl=63 time=6.605 ms 64 bytes from 93.8.140.131: seq=1 ttl=63 time=1.574 ms 64 bytes from 93.8.140.131: seq=2 ttl=63 time=1.258 ms --- 93.8.140.131 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.258/3.145/6.605 ms 2026-01-15 03:01:54,404 - INFO - Ping to IP 93.8.140.131 from VM test_vm passed 2026-01-15 03:01:54,564 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-15 03:01:54,580 - DEBUG - Requesting: http://10.20.0.249:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-14741411:ctest-bgpaas_vn-52801781:ctest-bgpaas_vn-52801781.inet.0 2026-01-15 03:01:55,593 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-15 03:01:55,609 - DEBUG - Requesting: http://10.20.0.249:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-14741411:ctest-bgpaas_vn-52801781:ctest-bgpaas_vn-52801781.inet.0 2026-01-15 03:01:55,621 - DEBUG - Requesting: http://10.20.0.201:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-14741411:ctest-bgpaas_vn-52801781:ctest-bgpaas_vn-52801781.inet.0 2026-01-15 03:01:55,876 - INFO - Deleting VM test2_vm 2026-01-15 03:01:55,967 - INFO - Deleting VM test_vm 2026-01-15 03:01:56,058 - INFO - Deleting VN ctest-bgpaas_vn-44670206 2026-01-15 03:01:56,101 - DEBUG - VN e7dd4918-39f9-4a32-95ff-14351b1b9f11 still in use: Unable to complete operation on network e7dd4918-39f9-4a32-95ff-14351b1b9f11. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-5d7bd798-2e4c-4d5c-b101-d179a1bd3a1b'] 2026-01-15 03:01:56,101 - WARNING - Deleting VN ctest-bgpaas_vn-44670206 failed..Will retry 2026-01-15 03:01:58,248 - DEBUG - Response for deleting network () 2026-01-15 03:01:58,248 - INFO - Deleting VN ctest-bgpaas_vn-52801781 2026-01-15 03:01:58,442 - DEBUG - Response for deleting network () 2026-01-15 03:01:59,735 - DEBUG - No XMPP flaps were noticed during the test
2026-01-15 03:01:59,735 - INFO - END TEST : test_rp_interface_ext_community : PASSED[0:00:33]
2026-01-15 03:01:59,735 - INFO - -------------------------------------------------------------------------------- 2026-01-15 03:01:59,738 - INFO - ================================================================================ 2026-01-15 03:01:59,738 - INFO - STARTING TEST : test_rp_interface_static 2026-01-15 03:01:59,738 - 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-01-15 03:02:01,033 - DEBUG - Nothing to compare xmpp stats {'10.0.0.141': {'10.20.0.249': '0', '10.20.0.201': '0'}, '10.0.0.133': {'10.20.0.249': '0', '10.20.0.201': '0'}} with 2026-01-15 03:02:01,033 - INFO - Initial checks done. Running the testcase now 2026-01-15 03:02:01,033 - INFO - 2026-01-15 03:02:01,327 - DEBUG - Response for create_network : {'network': {'id': '6d2928c6-a5e9-4fa3-bd72-39a3adb60283', 'name': 'ctest-bgpaas_vn-90196136', 'tenant_id': '6966520c938e4a5e9011e97601958f74', 'project_id': '6966520c938e4a5e9011e97601958f74', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-14741411', 'ctest-bgpaas_vn-90196136'], 'port_security_enabled': True, 'description': ''}} 2026-01-15 03:02:01,618 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f72d9b41-4978-4e81-82c8-1c273c50ffcc', 'name': '', 'tenant_id': '6966520c938e4a5e9011e97601958f74', 'network_id': '6d2928c6-a5e9-4fa3-bd72-39a3adb60283', 'ip_version': 4, 'cidr': '50.217.2.192/26', 'allocation_pools': [{'start': '50.217.2.194', 'end': '50.217.2.254'}], 'gateway_ip': '50.217.2.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '50.217.2.194', 'tags': [], 'project_id': '6966520c938e4a5e9011e97601958f74'}} 2026-01-15 03:02:01,646 - INFO - Created VN ctest-bgpaas_vn-90196136 2026-01-15 03:02:01,661 - DEBUG - VN ctest-bgpaas_vn-90196136 UUID is 6d2928c6-a5e9-4fa3-bd72-39a3adb60283 2026-01-15 03:02:02,216 - DEBUG - Response for create_network : {'network': {'id': 'd3af7204-2027-420b-aca5-7e3317e6821c', 'name': 'ctest-bgpaas_vn-63432148', 'tenant_id': '6966520c938e4a5e9011e97601958f74', 'project_id': '6966520c938e4a5e9011e97601958f74', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-14741411', 'ctest-bgpaas_vn-63432148'], 'port_security_enabled': True, 'description': ''}} 2026-01-15 03:02:02,418 - DEBUG - Response for create_subnet : {'subnet': {'id': 'b6231e1e-9415-40c2-b87e-5454c06f0f48', 'name': '', 'tenant_id': '6966520c938e4a5e9011e97601958f74', 'network_id': 'd3af7204-2027-420b-aca5-7e3317e6821c', 'ip_version': 4, 'cidr': '223.184.213.0/26', 'allocation_pools': [{'start': '223.184.213.2', 'end': '223.184.213.62'}], 'gateway_ip': '223.184.213.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '223.184.213.2', 'tags': [], 'project_id': '6966520c938e4a5e9011e97601958f74'}} 2026-01-15 03:02:02,449 - INFO - Created VN ctest-bgpaas_vn-63432148 2026-01-15 03:02:02,461 - DEBUG - VN ctest-bgpaas_vn-63432148 UUID is d3af7204-2027-420b-aca5-7e3317e6821c 2026-01-15 03:02:03,981 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5009-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5009-2) 2026-01-15 03:02:05,607 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5009-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5009-1) 2026-01-15 03:02:05,607 - INFO - Waiting for VM test_vm to be up.. 2026-01-15 03:02:05,728 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-01-15 03:02:10,841 - DEBUG - VM is in ACTIVE state now 2026-01-15 03:02:10,842 - INFO - VM name : test_vm 2026-01-15 03:02:10,976 - DEBUG - VM test_vm ID is e0e8f407-cdde-44f5-b866-3e808f92225b 2026-01-15 03:02:10,976 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5009-2 2026-01-15 03:02:11,095 - DEBUG - Requesting: http://10.0.0.73:8082/virtual-machine/e0e8f407-cdde-44f5-b866-3e808f92225b 2026-01-15 03:02:11,113 - DEBUG - Requesting: http://10.0.0.73:8082/virtual-machine-interface/cef613aa-0cc0-4f99-871f-b1ec1f9db2a7 2026-01-15 03:02:14,282 - 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 1006ms') 2026-01-15 03:02:14,282 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2026-01-15 03:02:14,297 - DEBUG - Gateway for vn default-domain:ctest-TestRP-14741411:ctest-bgpaas_vn-90196136 is 50.217.2.193 and allocation pool is NOT set 2026-01-15 03:02:16,370 - 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.05 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.443 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.443/2.246/4.049/1.803 ms') 2026-01-15 03:02:16,370 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2026-01-15 03:02:16,443 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-15 03:02:16,443 - DEBUG - Waiting to SSH to VM test_vm, IP 50.217.2.195, Port 22 2026-01-15 03:02:16,616 - DEBUG - VM test_vm is ready for SSH connections 2026-01-15 03:02:16,616 - INFO - Waiting for VM test2_vm to be up.. 2026-01-15 03:02:16,714 - DEBUG - VM is in ACTIVE state now 2026-01-15 03:02:16,714 - INFO - VM name : test2_vm 2026-01-15 03:02:16,807 - DEBUG - VM test2_vm ID is cb1c02b5-65cc-4bf6-aed6-73db85cf1311 2026-01-15 03:02:16,808 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5009-1 2026-01-15 03:02:16,902 - DEBUG - Requesting: http://10.0.0.73:8082/virtual-machine/cb1c02b5-65cc-4bf6-aed6-73db85cf1311 2026-01-15 03:02:16,912 - DEBUG - Requesting: http://10.0.0.73:8082/virtual-machine-interface/f7f7f52c-98e0-47b4-90fa-cd5cc7d614b2 2026-01-15 03:02:18,084 - 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=10.2 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=3.16 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 = 3.162/6.698/10.234/3.536 ms') 2026-01-15 03:02:18,084 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2026-01-15 03:02:18,153 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-15 03:02:18,153 - DEBUG - Waiting to SSH to VM test2_vm, IP 223.184.213.3, Port 22 2026-01-15 03:02:18,221 - 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-01-15 03:02:18,316 - DEBUG - VM test2_vm is NOT ready for SSH connections, VM status: ACTIVE 2026-01-15 03:02:23,317 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-15 03:02:23,317 - DEBUG - Waiting to SSH to VM test2_vm, IP 223.184.213.3, Port 22 2026-01-15 03:02:23,488 - DEBUG - VM test2_vm is ready for SSH connections 2026-01-15 03:02:23,585 - INFO - Created InterfaceRouteTable ['default-domain', 'ctest-TestRP-14741411', 'ctest-int_table_right-74384287'](UUID 130b9b49-f269-42f0-a880-99baa7441300), prefixes : ['25.60.5.192/26'] 2026-01-15 03:02:23,653 - INFO - Added intf route table 130b9b49-f269-42f0-a880-99baa7441300 to port cef613aa-0cc0-4f99-871f-b1ec1f9db2a7 2026-01-15 03:02:23,882 - DEBUG - Requesting: http://10.20.0.249:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-14741411:ctest-bgpaas_vn-90196136:ctest-bgpaas_vn-90196136.inet.0 2026-01-15 03:02:23,902 - DEBUG - Requesting: http://10.20.0.201:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-14741411:ctest-bgpaas_vn-90196136:ctest-bgpaas_vn-90196136.inet.0 2026-01-15 03:02:23,920 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-15 03:02:23,921 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 223.184.213.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.133, gateway password: c0ntrail123 2026-01-15 03:02:23,921 - DEBUG - ping -s 56 -c 3 -W 1 223.184.213.3 2026-01-15 03:02:27,618 - DEBUG - PING 223.184.213.3 (223.184.213.3): 56 data bytes 64 bytes from 223.184.213.3: seq=0 ttl=63 time=6.971 ms 64 bytes from 223.184.213.3: seq=1 ttl=63 time=1.543 ms 64 bytes from 223.184.213.3: seq=2 ttl=63 time=1.651 ms --- 223.184.213.3 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.543/3.388/6.971 ms 2026-01-15 03:02:27,618 - INFO - Ping to IP 223.184.213.3 from VM test_vm passed 2026-01-15 03:02:27,737 - INFO - Deleting VM test2_vm 2026-01-15 03:02:27,860 - INFO - Deleting VM test_vm 2026-01-15 03:02:27,946 - INFO - Deleting VN ctest-bgpaas_vn-63432148 2026-01-15 03:02:27,999 - DEBUG - VN d3af7204-2027-420b-aca5-7e3317e6821c still in use: Unable to complete operation on network d3af7204-2027-420b-aca5-7e3317e6821c. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-53def887-8606-4eb0-8a8e-f8306ba0ba3c'] 2026-01-15 03:02:27,999 - WARNING - Deleting VN ctest-bgpaas_vn-63432148 failed..Will retry 2026-01-15 03:02:30,190 - DEBUG - Response for deleting network () 2026-01-15 03:02:30,190 - INFO - Deleting VN ctest-bgpaas_vn-90196136 2026-01-15 03:02:30,399 - DEBUG - Response for deleting network () 2026-01-15 03:02:31,708 - DEBUG - No XMPP flaps were noticed during the test
2026-01-15 03:02:31,708 - INFO - END TEST : test_rp_interface_static : PASSED[0:00:32]
2026-01-15 03:02:31,708 - INFO - -------------------------------------------------------------------------------- 2026-01-15 03:02:32,550 - INFO - Deleted project: ctest-TestRP-14741411, ID : 6966520c-938e-4a5e-9011-e97601958f74