2026-03-09 02:45:39,506 - INFO - Domain Default found not creating 2026-03-09 02:45:39,664 - INFO - Project ctest-TestRP-24811812 not found, creating it 2026-03-09 02:45:40,205 - INFO - Created Project:ctest-TestRP-24811812, ID : d73b7771-a2a5-4f15-9961-e70f695554e5 2026-03-09 02:45:41,654 - DEBUG - Services list from nova: [, , , ] 2026-03-09 02:45:41,655 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5454-1', 'an-jenkins-deploy-platform-ansible-os-5454-2']} 2026-03-09 02:45:41,657 - INFO - ================================================================================ 2026-03-09 02:45:41,657 - INFO - STARTING TEST : test_rp_interface 2026-03-09 02:45:41,658 - 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-03-09 02:45:42,929 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.25': '0', '10.20.0.254': '0'}, '10.0.0.27': {'10.20.0.25': '0', '10.20.0.17': '0'}} with 2026-03-09 02:45:42,929 - INFO - Initial checks done. Running the testcase now 2026-03-09 02:45:42,929 - INFO - 2026-03-09 02:45:43,578 - DEBUG - Response for create_network : {'network': {'id': '0eeb43e8-c53a-4eb5-8baa-55ba37a16571', 'name': 'ctest-bgpaas_vn-93576778', 'tenant_id': 'd73b7771a2a54f159961e70f695554e5', 'project_id': 'd73b7771a2a54f159961e70f695554e5', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-24811812', 'ctest-bgpaas_vn-93576778'], 'port_security_enabled': True, 'description': ''}} 2026-03-09 02:45:43,890 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a82a710c-4d3f-4be8-9b9a-cf01a9f180e7', 'name': '', 'tenant_id': 'd73b7771a2a54f159961e70f695554e5', 'network_id': '0eeb43e8-c53a-4eb5-8baa-55ba37a16571', 'ip_version': 4, 'cidr': '190.1.223.128/26', 'allocation_pools': [{'start': '190.1.223.130', 'end': '190.1.223.190'}], 'gateway_ip': '190.1.223.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '190.1.223.130', 'tags': [], 'project_id': 'd73b7771a2a54f159961e70f695554e5'}} 2026-03-09 02:45:43,910 - INFO - Created VN ctest-bgpaas_vn-93576778 2026-03-09 02:45:43,923 - DEBUG - VN ctest-bgpaas_vn-93576778 UUID is 0eeb43e8-c53a-4eb5-8baa-55ba37a16571 2026-03-09 02:45:44,415 - DEBUG - Response for create_network : {'network': {'id': '9a10b42f-244d-4094-b726-8a55bf5696a3', 'name': 'ctest-bgpaas_vn-04575752', 'tenant_id': 'd73b7771a2a54f159961e70f695554e5', 'project_id': 'd73b7771a2a54f159961e70f695554e5', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-24811812', 'ctest-bgpaas_vn-04575752'], 'port_security_enabled': True, 'description': ''}} 2026-03-09 02:45:44,670 - DEBUG - Response for create_subnet : {'subnet': {'id': '00848b33-1355-4b02-ae10-cb69103d5abf', 'name': '', 'tenant_id': 'd73b7771a2a54f159961e70f695554e5', 'network_id': '9a10b42f-244d-4094-b726-8a55bf5696a3', 'ip_version': 4, 'cidr': '152.253.153.128/26', 'allocation_pools': [{'start': '152.253.153.130', 'end': '152.253.153.190'}], 'gateway_ip': '152.253.153.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '152.253.153.130', 'tags': [], 'project_id': 'd73b7771a2a54f159961e70f695554e5'}} 2026-03-09 02:45:44,691 - INFO - Created VN ctest-bgpaas_vn-04575752 2026-03-09 02:45:44,701 - DEBUG - VN ctest-bgpaas_vn-04575752 UUID is 9a10b42f-244d-4094-b726-8a55bf5696a3 2026-03-09 02:45:45,998 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5454-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5454-1) 2026-03-09 02:45:47,267 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5454-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5454-2) 2026-03-09 02:45:47,267 - INFO - Waiting for VM test_vm to be up.. 2026-03-09 02:45:47,347 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-03-09 02:45:52,431 - DEBUG - VM is in ACTIVE state now 2026-03-09 02:45:52,432 - INFO - VM name : test_vm 2026-03-09 02:45:52,507 - DEBUG - VM test_vm ID is e2438bde-92ae-4869-a8cb-c93debc13006 2026-03-09 02:45:52,531 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5454-1 2026-03-09 02:45:52,606 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/e2438bde-92ae-4869-a8cb-c93debc13006 2026-03-09 02:45:52,939 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/e2438bde-92ae-4869-a8cb-c93debc13006 2026-03-09 02:45:52,979 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/27ca3f35-b343-4805-8211-01e52e0b3a66 2026-03-09 02:45:56,146 - 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 1011ms') 2026-03-09 02:45:56,146 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2026-03-09 02:45:56,159 - DEBUG - Gateway for vn default-domain:ctest-TestRP-24811812:ctest-bgpaas_vn-93576778 is 190.1.223.129 and allocation pool is NOT set 2026-03-09 02:45:58,219 - 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=2.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 = 2.310/3.749/5.189/1.439 ms') 2026-03-09 02:45:58,219 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2026-03-09 02:45:58,283 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-09 02:45:58,283 - DEBUG - Waiting to SSH to VM test_vm, IP 190.1.223.131, Port 22 2026-03-09 02:45:58,339 - 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-03-09 02:45:58,432 - DEBUG - VM test_vm is NOT ready for SSH connections, VM status: ACTIVE 2026-03-09 02:46:03,433 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-09 02:46:03,433 - DEBUG - Waiting to SSH to VM test_vm, IP 190.1.223.131, Port 22 2026-03-09 02:46:03,597 - DEBUG - VM test_vm is ready for SSH connections 2026-03-09 02:46:03,597 - INFO - Waiting for VM test2_vm to be up.. 2026-03-09 02:46:03,680 - DEBUG - VM is in ACTIVE state now 2026-03-09 02:46:03,680 - INFO - VM name : test2_vm 2026-03-09 02:46:03,765 - DEBUG - VM test2_vm ID is 7b49fa31-086c-4281-ac45-2554973f082d 2026-03-09 02:46:03,765 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5454-2 2026-03-09 02:46:03,844 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/7b49fa31-086c-4281-ac45-2554973f082d 2026-03-09 02:46:03,853 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/e71babac-700c-4efc-a8f5-278762a1a9fd 2026-03-09 02:46:05,008 - 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.04 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.403 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.403/2.222/4.041/1.819 ms') 2026-03-09 02:46:05,008 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2026-03-09 02:46:05,076 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-09 02:46:05,076 - DEBUG - Waiting to SSH to VM test2_vm, IP 152.253.153.131, Port 22 2026-03-09 02:46:05,230 - DEBUG - VM test2_vm is ready for SSH connections 2026-03-09 02:46:05,404 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-09 02:46:05,418 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-24811812:ctest-bgpaas_vn-93576778:ctest-bgpaas_vn-93576778.inet.0 2026-03-09 02:46:05,433 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-24811812:ctest-bgpaas_vn-93576778:ctest-bgpaas_vn-93576778.inet.0 2026-03-09 02:46:05,446 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-09 02:46:05,446 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 152.253.153.131, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.41, gateway password: c0ntrail123 2026-03-09 02:46:05,446 - DEBUG - ping -s 56 -c 3 -W 1 152.253.153.131 2026-03-09 02:46:09,144 - DEBUG - PING 152.253.153.131 (152.253.153.131): 56 data bytes 64 bytes from 152.253.153.131: seq=0 ttl=63 time=7.291 ms 64 bytes from 152.253.153.131: seq=1 ttl=63 time=1.525 ms 64 bytes from 152.253.153.131: seq=2 ttl=63 time=1.111 ms --- 152.253.153.131 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.111/3.309/7.291 ms 2026-03-09 02:46:09,144 - INFO - Ping to IP 152.253.153.131 from VM test_vm passed 2026-03-09 02:46:09,243 - INFO - Deleting VM test2_vm 2026-03-09 02:46:09,329 - INFO - Deleting VM test_vm 2026-03-09 02:46:09,393 - INFO - Deleting VN ctest-bgpaas_vn-04575752 2026-03-09 02:46:09,433 - DEBUG - VN 9a10b42f-244d-4094-b726-8a55bf5696a3 still in use: Unable to complete operation on network 9a10b42f-244d-4094-b726-8a55bf5696a3. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-57444816-5458-45f1-830b-7c88587ee666'] 2026-03-09 02:46:09,433 - WARNING - Deleting VN ctest-bgpaas_vn-04575752 failed..Will retry 2026-03-09 02:46:11,583 - DEBUG - Response for deleting network () 2026-03-09 02:46:11,583 - INFO - Deleting VN ctest-bgpaas_vn-93576778 2026-03-09 02:46:11,738 - DEBUG - Response for deleting network () 2026-03-09 02:46:12,993 - DEBUG - No XMPP flaps were noticed during the test
2026-03-09 02:46:12,993 - INFO - END TEST : test_rp_interface : PASSED[0:00:31]
2026-03-09 02:46:12,993 - INFO - -------------------------------------------------------------------------------- 2026-03-09 02:46:12,996 - INFO - ================================================================================ 2026-03-09 02:46:12,996 - INFO - STARTING TEST : test_rp_interface_ext_community 2026-03-09 02:46:12,996 - 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-03-09 02:46:14,271 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.25': '0', '10.20.0.254': '0'}, '10.0.0.27': {'10.20.0.25': '0', '10.20.0.17': '0'}} with 2026-03-09 02:46:14,271 - INFO - Initial checks done. Running the testcase now 2026-03-09 02:46:14,271 - INFO - 2026-03-09 02:46:14,494 - DEBUG - Response for create_network : {'network': {'id': 'ebf4fcb0-6039-47d8-bcea-198f46cc3ce2', 'name': 'ctest-bgpaas_vn-22611203', 'tenant_id': 'd73b7771a2a54f159961e70f695554e5', 'project_id': 'd73b7771a2a54f159961e70f695554e5', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-24811812', 'ctest-bgpaas_vn-22611203'], 'port_security_enabled': True, 'description': ''}} 2026-03-09 02:46:14,704 - DEBUG - Response for create_subnet : {'subnet': {'id': '9550e1d7-8332-46f9-9caf-55cefb1882e1', 'name': '', 'tenant_id': 'd73b7771a2a54f159961e70f695554e5', 'network_id': 'ebf4fcb0-6039-47d8-bcea-198f46cc3ce2', 'ip_version': 4, 'cidr': '17.78.123.64/26', 'allocation_pools': [{'start': '17.78.123.66', 'end': '17.78.123.126'}], 'gateway_ip': '17.78.123.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '17.78.123.66', 'tags': [], 'project_id': 'd73b7771a2a54f159961e70f695554e5'}} 2026-03-09 02:46:14,726 - INFO - Created VN ctest-bgpaas_vn-22611203 2026-03-09 02:46:14,739 - DEBUG - VN ctest-bgpaas_vn-22611203 UUID is ebf4fcb0-6039-47d8-bcea-198f46cc3ce2 2026-03-09 02:46:15,262 - DEBUG - Response for create_network : {'network': {'id': '39fb5fc8-5711-4ec4-86ec-998ab2f0c6c4', 'name': 'ctest-bgpaas_vn-15588826', 'tenant_id': 'd73b7771a2a54f159961e70f695554e5', 'project_id': 'd73b7771a2a54f159961e70f695554e5', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-24811812', 'ctest-bgpaas_vn-15588826'], 'port_security_enabled': True, 'description': ''}} 2026-03-09 02:46:15,491 - DEBUG - Response for create_subnet : {'subnet': {'id': '48c21125-4755-4957-96b0-8d599ed9d785', 'name': '', 'tenant_id': 'd73b7771a2a54f159961e70f695554e5', 'network_id': '39fb5fc8-5711-4ec4-86ec-998ab2f0c6c4', 'ip_version': 4, 'cidr': '146.99.98.128/26', 'allocation_pools': [{'start': '146.99.98.130', 'end': '146.99.98.190'}], 'gateway_ip': '146.99.98.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '146.99.98.130', 'tags': [], 'project_id': 'd73b7771a2a54f159961e70f695554e5'}} 2026-03-09 02:46:15,514 - INFO - Created VN ctest-bgpaas_vn-15588826 2026-03-09 02:46:15,527 - DEBUG - VN ctest-bgpaas_vn-15588826 UUID is 39fb5fc8-5711-4ec4-86ec-998ab2f0c6c4 2026-03-09 02:46:16,840 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5454-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5454-1) 2026-03-09 02:46:18,084 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5454-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5454-2) 2026-03-09 02:46:18,084 - INFO - Waiting for VM test_vm to be up.. 2026-03-09 02:46:18,170 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-03-09 02:46:23,261 - DEBUG - VM is in ACTIVE state now 2026-03-09 02:46:23,261 - INFO - VM name : test_vm 2026-03-09 02:46:23,350 - DEBUG - VM test_vm ID is 8e0529de-3e7c-48d3-9bb2-0eea27a7ff5a 2026-03-09 02:46:23,350 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5454-1 2026-03-09 02:46:23,462 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/8e0529de-3e7c-48d3-9bb2-0eea27a7ff5a 2026-03-09 02:46:23,472 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/3616935c-35ff-4d52-89e8-38b953dc3fc9 2026-03-09 02:46:26,646 - 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-03-09 02:46:26,646 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2026-03-09 02:46:26,659 - DEBUG - Gateway for vn default-domain:ctest-TestRP-24811812:ctest-bgpaas_vn-22611203 is 17.78.123.65 and allocation pool is NOT set 2026-03-09 02:46:28,726 - 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=6.67 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.41 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.408/4.538/6.668/2.130 ms') 2026-03-09 02:46:28,726 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2026-03-09 02:46:28,793 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-09 02:46:28,793 - DEBUG - Waiting to SSH to VM test_vm, IP 17.78.123.67, Port 22 2026-03-09 02:46:28,962 - DEBUG - VM test_vm is ready for SSH connections 2026-03-09 02:46:28,962 - INFO - Waiting for VM test2_vm to be up.. 2026-03-09 02:46:29,038 - DEBUG - VM is in ACTIVE state now 2026-03-09 02:46:29,038 - INFO - VM name : test2_vm 2026-03-09 02:46:29,111 - DEBUG - VM test2_vm ID is d483eca3-03ff-439d-82ad-e84f10615d1e 2026-03-09 02:46:29,111 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5454-2 2026-03-09 02:46:29,189 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/d483eca3-03ff-439d-82ad-e84f10615d1e 2026-03-09 02:46:29,198 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/7598bd1a-488b-47b6-b9e8-6401cc39e9a0 2026-03-09 02:46:30,352 - 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.79 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.435 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.435/2.111/3.787/1.676 ms') 2026-03-09 02:46:30,353 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2026-03-09 02:46:30,421 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-09 02:46:30,421 - DEBUG - Waiting to SSH to VM test2_vm, IP 146.99.98.131, Port 22 2026-03-09 02:46:30,592 - DEBUG - VM test2_vm is ready for SSH connections 2026-03-09 02:46:30,728 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-09 02:46:30,739 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-24811812:ctest-bgpaas_vn-22611203:ctest-bgpaas_vn-22611203.inet.0 2026-03-09 02:46:30,750 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-24811812:ctest-bgpaas_vn-22611203:ctest-bgpaas_vn-22611203.inet.0 2026-03-09 02:46:30,761 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-09 02:46:30,761 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 146.99.98.131, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.41, gateway password: c0ntrail123 2026-03-09 02:46:30,761 - DEBUG - ping -s 56 -c 3 -W 1 146.99.98.131 2026-03-09 02:46:34,681 - DEBUG - PING 146.99.98.131 (146.99.98.131): 56 data bytes 64 bytes from 146.99.98.131: seq=0 ttl=63 time=6.758 ms 64 bytes from 146.99.98.131: seq=1 ttl=63 time=1.124 ms 64 bytes from 146.99.98.131: seq=2 ttl=63 time=1.115 ms --- 146.99.98.131 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.115/2.999/6.758 ms 2026-03-09 02:46:34,681 - INFO - Ping to IP 146.99.98.131 from VM test_vm passed 2026-03-09 02:46:34,841 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-09 02:46:34,854 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-24811812:ctest-bgpaas_vn-22611203:ctest-bgpaas_vn-22611203.inet.0 2026-03-09 02:46:34,864 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-24811812:ctest-bgpaas_vn-22611203:ctest-bgpaas_vn-22611203.inet.0 2026-03-09 02:46:35,114 - INFO - Deleting VM test2_vm 2026-03-09 02:46:35,186 - INFO - Deleting VM test_vm 2026-03-09 02:46:35,250 - INFO - Deleting VN ctest-bgpaas_vn-15588826 2026-03-09 02:46:35,286 - DEBUG - VN 39fb5fc8-5711-4ec4-86ec-998ab2f0c6c4 still in use: Unable to complete operation on network 39fb5fc8-5711-4ec4-86ec-998ab2f0c6c4. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-9f45d4c2-babc-451e-86fc-3c94116b60d6'] 2026-03-09 02:46:35,286 - WARNING - Deleting VN ctest-bgpaas_vn-15588826 failed..Will retry 2026-03-09 02:46:37,426 - DEBUG - Response for deleting network () 2026-03-09 02:46:37,426 - INFO - Deleting VN ctest-bgpaas_vn-22611203 2026-03-09 02:46:37,597 - DEBUG - Response for deleting network () 2026-03-09 02:46:38,877 - DEBUG - No XMPP flaps were noticed during the test
2026-03-09 02:46:38,877 - INFO - END TEST : test_rp_interface_ext_community : PASSED[0:00:26]
2026-03-09 02:46:38,877 - INFO - -------------------------------------------------------------------------------- 2026-03-09 02:46:38,881 - INFO - ================================================================================ 2026-03-09 02:46:38,881 - INFO - STARTING TEST : test_rp_interface_static 2026-03-09 02:46:38,881 - 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-03-09 02:46:40,153 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.25': '0', '10.20.0.254': '0'}, '10.0.0.27': {'10.20.0.25': '0', '10.20.0.17': '0'}} with 2026-03-09 02:46:40,154 - INFO - Initial checks done. Running the testcase now 2026-03-09 02:46:40,154 - INFO - 2026-03-09 02:46:40,414 - DEBUG - Response for create_network : {'network': {'id': '3d04bf86-5c56-4dff-ab9b-589442445690', 'name': 'ctest-bgpaas_vn-54265898', 'tenant_id': 'd73b7771a2a54f159961e70f695554e5', 'project_id': 'd73b7771a2a54f159961e70f695554e5', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-24811812', 'ctest-bgpaas_vn-54265898'], 'port_security_enabled': True, 'description': ''}} 2026-03-09 02:46:40,630 - DEBUG - Response for create_subnet : {'subnet': {'id': '6623cce6-df9b-4161-a47d-b35add43b4d7', 'name': '', 'tenant_id': 'd73b7771a2a54f159961e70f695554e5', 'network_id': '3d04bf86-5c56-4dff-ab9b-589442445690', 'ip_version': 4, 'cidr': '76.99.191.64/26', 'allocation_pools': [{'start': '76.99.191.66', 'end': '76.99.191.126'}], 'gateway_ip': '76.99.191.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '76.99.191.66', 'tags': [], 'project_id': 'd73b7771a2a54f159961e70f695554e5'}} 2026-03-09 02:46:40,651 - INFO - Created VN ctest-bgpaas_vn-54265898 2026-03-09 02:46:40,661 - DEBUG - VN ctest-bgpaas_vn-54265898 UUID is 3d04bf86-5c56-4dff-ab9b-589442445690 2026-03-09 02:46:41,163 - DEBUG - Response for create_network : {'network': {'id': '49cf375e-038e-4440-a279-ce9a3cd371e0', 'name': 'ctest-bgpaas_vn-84002004', 'tenant_id': 'd73b7771a2a54f159961e70f695554e5', 'project_id': 'd73b7771a2a54f159961e70f695554e5', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-24811812', 'ctest-bgpaas_vn-84002004'], 'port_security_enabled': True, 'description': ''}} 2026-03-09 02:46:41,370 - DEBUG - Response for create_subnet : {'subnet': {'id': '00371248-7b81-4997-a903-c9c824d560aa', 'name': '', 'tenant_id': 'd73b7771a2a54f159961e70f695554e5', 'network_id': '49cf375e-038e-4440-a279-ce9a3cd371e0', 'ip_version': 4, 'cidr': '91.6.6.128/26', 'allocation_pools': [{'start': '91.6.6.130', 'end': '91.6.6.190'}], 'gateway_ip': '91.6.6.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '91.6.6.130', 'tags': [], 'project_id': 'd73b7771a2a54f159961e70f695554e5'}} 2026-03-09 02:46:41,392 - INFO - Created VN ctest-bgpaas_vn-84002004 2026-03-09 02:46:41,402 - DEBUG - VN ctest-bgpaas_vn-84002004 UUID is 49cf375e-038e-4440-a279-ce9a3cd371e0 2026-03-09 02:46:42,694 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5454-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5454-1) 2026-03-09 02:46:43,958 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5454-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5454-2) 2026-03-09 02:46:43,959 - INFO - Waiting for VM test_vm to be up.. 2026-03-09 02:46:44,054 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-03-09 02:46:49,135 - DEBUG - VM is in ACTIVE state now 2026-03-09 02:46:49,135 - INFO - VM name : test_vm 2026-03-09 02:46:49,227 - DEBUG - VM test_vm ID is 5b5f8d53-2b0f-444c-8926-36465184ac54 2026-03-09 02:46:49,227 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5454-1 2026-03-09 02:46:49,305 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/5b5f8d53-2b0f-444c-8926-36465184ac54 2026-03-09 02:46:49,316 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/5d05ff8b-1740-4404-b0b6-86e797102a44 2026-03-09 02:46:52,505 - 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-03-09 02:46:52,506 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2026-03-09 02:46:52,522 - DEBUG - Gateway for vn default-domain:ctest-TestRP-24811812:ctest-bgpaas_vn-54265898 is 76.99.191.65 and allocation pool is NOT set 2026-03-09 02:46:54,587 - 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=6.22 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.45 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 = 2.446/4.334/6.222/1.888 ms') 2026-03-09 02:46:54,587 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2026-03-09 02:46:54,656 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-09 02:46:54,656 - DEBUG - Waiting to SSH to VM test_vm, IP 76.99.191.67, Port 22 2026-03-09 02:46:54,725 - 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-03-09 02:46:54,813 - DEBUG - VM test_vm is NOT ready for SSH connections, VM status: ACTIVE 2026-03-09 02:46:59,814 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-09 02:46:59,814 - DEBUG - Waiting to SSH to VM test_vm, IP 76.99.191.67, Port 22 2026-03-09 02:46:59,981 - DEBUG - VM test_vm is ready for SSH connections 2026-03-09 02:46:59,981 - INFO - Waiting for VM test2_vm to be up.. 2026-03-09 02:47:00,071 - DEBUG - VM is in ACTIVE state now 2026-03-09 02:47:00,071 - INFO - VM name : test2_vm 2026-03-09 02:47:00,159 - DEBUG - VM test2_vm ID is 1054d2ea-8dd8-4faf-8d1c-59d54f6da1e2 2026-03-09 02:47:00,159 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5454-2 2026-03-09 02:47:00,244 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/1054d2ea-8dd8-4faf-8d1c-59d54f6da1e2 2026-03-09 02:47:00,255 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/6242e620-4695-4edd-a1f6-8fb5f0ee35ed 2026-03-09 02:47:01,414 - 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=2.79 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.354 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.354/1.572/2.791/1.218 ms') 2026-03-09 02:47:01,414 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2026-03-09 02:47:01,485 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-09 02:47:01,485 - DEBUG - Waiting to SSH to VM test2_vm, IP 91.6.6.131, Port 22 2026-03-09 02:47:01,641 - DEBUG - VM test2_vm is ready for SSH connections 2026-03-09 02:47:01,732 - INFO - Created InterfaceRouteTable ['default-domain', 'ctest-TestRP-24811812', 'ctest-int_table_right-10672531'](UUID 53bff86e-10e2-4006-9be9-ef916b6a27f1), prefixes : ['2.236.206.0/26'] 2026-03-09 02:47:01,804 - INFO - Added intf route table 53bff86e-10e2-4006-9be9-ef916b6a27f1 to port 5d05ff8b-1740-4404-b0b6-86e797102a44 2026-03-09 02:47:02,024 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-24811812:ctest-bgpaas_vn-54265898:ctest-bgpaas_vn-54265898.inet.0 2026-03-09 02:47:02,035 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-24811812:ctest-bgpaas_vn-54265898:ctest-bgpaas_vn-54265898.inet.0 2026-03-09 02:47:02,049 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-03-09 02:47:02,049 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 91.6.6.131, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.41, gateway password: c0ntrail123 2026-03-09 02:47:02,049 - DEBUG - ping -s 56 -c 3 -W 1 91.6.6.131 2026-03-09 02:47:05,727 - DEBUG - PING 91.6.6.131 (91.6.6.131): 56 data bytes 64 bytes from 91.6.6.131: seq=0 ttl=63 time=6.592 ms 64 bytes from 91.6.6.131: seq=1 ttl=63 time=1.098 ms 64 bytes from 91.6.6.131: seq=2 ttl=63 time=1.164 ms --- 91.6.6.131 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.098/2.951/6.592 ms 2026-03-09 02:47:05,727 - INFO - Ping to IP 91.6.6.131 from VM test_vm passed 2026-03-09 02:47:05,864 - INFO - Deleting VM test2_vm 2026-03-09 02:47:05,938 - INFO - Deleting VM test_vm 2026-03-09 02:47:06,013 - INFO - Deleting VN ctest-bgpaas_vn-84002004 2026-03-09 02:47:06,067 - DEBUG - VN 49cf375e-038e-4440-a279-ce9a3cd371e0 still in use: Unable to complete operation on network 49cf375e-038e-4440-a279-ce9a3cd371e0. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-0bec49fe-f491-4bc8-994d-64beab4b34d7'] 2026-03-09 02:47:06,067 - WARNING - Deleting VN ctest-bgpaas_vn-84002004 failed..Will retry 2026-03-09 02:47:08,230 - DEBUG - Response for deleting network () 2026-03-09 02:47:08,230 - INFO - Deleting VN ctest-bgpaas_vn-54265898 2026-03-09 02:47:08,396 - DEBUG - Response for deleting network () 2026-03-09 02:47:09,670 - DEBUG - No XMPP flaps were noticed during the test
2026-03-09 02:47:09,671 - INFO - END TEST : test_rp_interface_static : PASSED[0:00:31]
2026-03-09 02:47:09,671 - INFO - -------------------------------------------------------------------------------- 2026-03-09 02:47:10,381 - INFO - Deleted project: ctest-TestRP-24811812, ID : d73b7771-a2a5-4f15-9961-e70f695554e5