2026-05-28 16:22:44,826 - INFO - Domain Default found not creating 2026-05-28 16:22:44,993 - INFO - Project ctest-TestRP-27696022 not found, creating it 2026-05-28 16:22:45,542 - INFO - Created Project:ctest-TestRP-27696022, ID : 281531aa-e70a-4d77-9739-25d5011aedb3 2026-05-28 16:22:47,140 - DEBUG - Services list from nova: [, , , ] 2026-05-28 16:22:47,140 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5845-1', 'an-jenkins-deploy-platform-ansible-os-5845-2']} 2026-05-28 16:22:47,142 - INFO - ================================================================================ 2026-05-28 16:22:47,142 - INFO - STARTING TEST : test_rp_interface 2026-05-28 16:22:47,142 - 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-28 16:22:48,455 - DEBUG - Nothing to compare xmpp stats {'10.0.0.130': {'10.20.0.25': '0', '10.20.0.254': '0'}, '10.0.0.73': {'10.20.0.25': '0', '10.20.0.254': '0'}} with 2026-05-28 16:22:48,455 - INFO - Initial checks done. Running the testcase now 2026-05-28 16:22:48,455 - INFO - 2026-05-28 16:22:49,257 - DEBUG - Response for create_network : {'network': {'id': '1f6dd2a9-78fc-4bc0-a53e-cb5b3756e588', 'name': 'ctest-bgpaas_vn-15877057', 'tenant_id': '281531aae70a4d77973925d5011aedb3', 'project_id': '281531aae70a4d77973925d5011aedb3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-27696022', 'ctest-bgpaas_vn-15877057'], 'port_security_enabled': True, 'description': ''}} 2026-05-28 16:22:49,574 - DEBUG - Response for create_subnet : {'subnet': {'id': '7b73a38f-7000-40d8-aefb-29267f9f3322', 'name': '', 'tenant_id': '281531aae70a4d77973925d5011aedb3', 'network_id': '1f6dd2a9-78fc-4bc0-a53e-cb5b3756e588', 'ip_version': 4, 'cidr': '68.164.74.128/26', 'allocation_pools': [{'start': '68.164.74.130', 'end': '68.164.74.190'}], 'gateway_ip': '68.164.74.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '68.164.74.130', 'tags': [], 'project_id': '281531aae70a4d77973925d5011aedb3'}} 2026-05-28 16:22:49,598 - INFO - Created VN ctest-bgpaas_vn-15877057 2026-05-28 16:22:49,613 - DEBUG - VN ctest-bgpaas_vn-15877057 UUID is 1f6dd2a9-78fc-4bc0-a53e-cb5b3756e588 2026-05-28 16:22:50,220 - DEBUG - Response for create_network : {'network': {'id': '51864f2c-1884-4737-b14a-ac7758891dd0', 'name': 'ctest-bgpaas_vn-20438828', 'tenant_id': '281531aae70a4d77973925d5011aedb3', 'project_id': '281531aae70a4d77973925d5011aedb3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-27696022', 'ctest-bgpaas_vn-20438828'], 'port_security_enabled': True, 'description': ''}} 2026-05-28 16:22:50,505 - DEBUG - Response for create_subnet : {'subnet': {'id': '189269e9-6f03-479b-8249-125352e4f445', 'name': '', 'tenant_id': '281531aae70a4d77973925d5011aedb3', 'network_id': '51864f2c-1884-4737-b14a-ac7758891dd0', 'ip_version': 4, 'cidr': '120.2.237.128/26', 'allocation_pools': [{'start': '120.2.237.130', 'end': '120.2.237.190'}], 'gateway_ip': '120.2.237.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '120.2.237.130', 'tags': [], 'project_id': '281531aae70a4d77973925d5011aedb3'}} 2026-05-28 16:22:50,527 - INFO - Created VN ctest-bgpaas_vn-20438828 2026-05-28 16:22:50,546 - DEBUG - VN ctest-bgpaas_vn-20438828 UUID is 51864f2c-1884-4737-b14a-ac7758891dd0 2026-05-28 16:22:51,974 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5845-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5845-1) 2026-05-28 16:22:53,393 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5845-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5845-2) 2026-05-28 16:22:53,393 - INFO - Waiting for VM test_vm to be up.. 2026-05-28 16:22:53,497 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-05-28 16:22:58,591 - DEBUG - VM is in ACTIVE state now 2026-05-28 16:22:58,592 - INFO - VM name : test_vm 2026-05-28 16:22:58,679 - DEBUG - VM test_vm ID is b6a71487-9f18-49f5-8574-bda3be35d96b 2026-05-28 16:22:58,705 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5845-1 2026-05-28 16:22:58,813 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/b6a71487-9f18-49f5-8574-bda3be35d96b 2026-05-28 16:22:59,112 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/b6a71487-9f18-49f5-8574-bda3be35d96b 2026-05-28 16:22:59,150 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/549d80d1-5e08-4c78-a389-445f98e8b726 2026-05-28 16:23:02,330 - 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 1014ms') 2026-05-28 16:23:02,330 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2026-05-28 16:23:02,349 - DEBUG - Gateway for vn default-domain:ctest-TestRP-27696022:ctest-bgpaas_vn-15877057 is 68.164.74.129 and allocation pool is NOT set 2026-05-28 16:23:04,410 - 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.76 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.833 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.833/2.797/4.761/1.964 ms') 2026-05-28 16:23:04,411 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2026-05-28 16:23:04,483 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-28 16:23:04,483 - DEBUG - Waiting to SSH to VM test_vm, IP 68.164.74.131, Port 22 2026-05-28 16:23:04,654 - DEBUG - VM test_vm is ready for SSH connections 2026-05-28 16:23:04,655 - INFO - Waiting for VM test2_vm to be up.. 2026-05-28 16:23:04,760 - DEBUG - VM is in ACTIVE state now 2026-05-28 16:23:04,760 - INFO - VM name : test2_vm 2026-05-28 16:23:04,868 - DEBUG - VM test2_vm ID is 8db270bd-37aa-4cfe-9b5c-12bf466de072 2026-05-28 16:23:04,868 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5845-2 2026-05-28 16:23:04,976 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/8db270bd-37aa-4cfe-9b5c-12bf466de072 2026-05-28 16:23:04,989 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/bae7d41d-09b7-455f-ae4f-198e4aadb41d 2026-05-28 16:23:06,166 - 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.14 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.61 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.606/4.373/6.141/1.767 ms') 2026-05-28 16:23:06,166 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2026-05-28 16:23:06,243 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-28 16:23:06,243 - DEBUG - Waiting to SSH to VM test2_vm, IP 120.2.237.131, Port 22 2026-05-28 16:23:06,417 - DEBUG - VM test2_vm is ready for SSH connections 2026-05-28 16:23:06,623 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-28 16:23:06,638 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-27696022:ctest-bgpaas_vn-15877057:ctest-bgpaas_vn-15877057.inet.0 2026-05-28 16:23:06,653 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-27696022:ctest-bgpaas_vn-15877057:ctest-bgpaas_vn-15877057.inet.0 2026-05-28 16:23:06,664 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-28 16:23:06,665 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 120.2.237.131, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.130, gateway password: c0ntrail123 2026-05-28 16:23:06,665 - DEBUG - ping -s 56 -c 3 -W 1 120.2.237.131 2026-05-28 16:23:10,659 - DEBUG - PING 120.2.237.131 (120.2.237.131): 56 data bytes 64 bytes from 120.2.237.131: seq=0 ttl=63 time=9.146 ms 64 bytes from 120.2.237.131: seq=1 ttl=63 time=1.248 ms 64 bytes from 120.2.237.131: seq=2 ttl=63 time=1.299 ms --- 120.2.237.131 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.248/3.897/9.146 ms 2026-05-28 16:23:10,659 - INFO - Ping to IP 120.2.237.131 from VM test_vm passed 2026-05-28 16:23:10,795 - INFO - Deleting VM test2_vm 2026-05-28 16:23:10,910 - INFO - Deleting VM test_vm 2026-05-28 16:23:10,998 - INFO - Deleting VN ctest-bgpaas_vn-20438828 2026-05-28 16:23:11,044 - DEBUG - VN 51864f2c-1884-4737-b14a-ac7758891dd0 still in use: Unable to complete operation on network 51864f2c-1884-4737-b14a-ac7758891dd0. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-e931130c-7ef7-4d1e-9496-da496b6ec2f8'] 2026-05-28 16:23:11,044 - WARNING - Deleting VN ctest-bgpaas_vn-20438828 failed..Will retry 2026-05-28 16:23:13,248 - DEBUG - Response for deleting network () 2026-05-28 16:23:13,249 - INFO - Deleting VN ctest-bgpaas_vn-15877057 2026-05-28 16:23:13,447 - DEBUG - Response for deleting network () 2026-05-28 16:23:14,764 - DEBUG - No XMPP flaps were noticed during the test
2026-05-28 16:23:14,765 - INFO - END TEST : test_rp_interface : PASSED[0:00:27]
2026-05-28 16:23:14,765 - INFO - -------------------------------------------------------------------------------- 2026-05-28 16:23:14,768 - INFO - ================================================================================ 2026-05-28 16:23:14,768 - INFO - STARTING TEST : test_rp_interface_ext_community 2026-05-28 16:23:14,768 - 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-28 16:23:16,070 - DEBUG - Nothing to compare xmpp stats {'10.0.0.130': {'10.20.0.25': '0', '10.20.0.254': '0'}, '10.0.0.73': {'10.20.0.25': '0', '10.20.0.254': '0'}} with 2026-05-28 16:23:16,070 - INFO - Initial checks done. Running the testcase now 2026-05-28 16:23:16,070 - INFO - 2026-05-28 16:23:16,378 - DEBUG - Response for create_network : {'network': {'id': '80c07be0-874a-43b5-b2be-42b927c164d6', 'name': 'ctest-bgpaas_vn-87255558', 'tenant_id': '281531aae70a4d77973925d5011aedb3', 'project_id': '281531aae70a4d77973925d5011aedb3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-27696022', 'ctest-bgpaas_vn-87255558'], 'port_security_enabled': True, 'description': ''}} 2026-05-28 16:23:16,663 - DEBUG - Response for create_subnet : {'subnet': {'id': '49856bde-5d0e-4b3d-8e44-8d2343e6cb02', 'name': '', 'tenant_id': '281531aae70a4d77973925d5011aedb3', 'network_id': '80c07be0-874a-43b5-b2be-42b927c164d6', 'ip_version': 4, 'cidr': '184.199.180.64/26', 'allocation_pools': [{'start': '184.199.180.66', 'end': '184.199.180.126'}], 'gateway_ip': '184.199.180.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '184.199.180.66', 'tags': [], 'project_id': '281531aae70a4d77973925d5011aedb3'}} 2026-05-28 16:23:16,691 - INFO - Created VN ctest-bgpaas_vn-87255558 2026-05-28 16:23:16,704 - DEBUG - VN ctest-bgpaas_vn-87255558 UUID is 80c07be0-874a-43b5-b2be-42b927c164d6 2026-05-28 16:23:17,306 - DEBUG - Response for create_network : {'network': {'id': 'e5a4d623-ea14-40ef-980c-fdf8c76cc7b4', 'name': 'ctest-bgpaas_vn-01444473', 'tenant_id': '281531aae70a4d77973925d5011aedb3', 'project_id': '281531aae70a4d77973925d5011aedb3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-27696022', 'ctest-bgpaas_vn-01444473'], 'port_security_enabled': True, 'description': ''}} 2026-05-28 16:23:17,531 - DEBUG - Response for create_subnet : {'subnet': {'id': '6ce3f219-430a-41b7-a1bd-33c13c2f51e2', 'name': '', 'tenant_id': '281531aae70a4d77973925d5011aedb3', 'network_id': 'e5a4d623-ea14-40ef-980c-fdf8c76cc7b4', 'ip_version': 4, 'cidr': '147.183.16.0/26', 'allocation_pools': [{'start': '147.183.16.2', 'end': '147.183.16.62'}], 'gateway_ip': '147.183.16.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '147.183.16.2', 'tags': [], 'project_id': '281531aae70a4d77973925d5011aedb3'}} 2026-05-28 16:23:17,557 - INFO - Created VN ctest-bgpaas_vn-01444473 2026-05-28 16:23:17,569 - DEBUG - VN ctest-bgpaas_vn-01444473 UUID is e5a4d623-ea14-40ef-980c-fdf8c76cc7b4 2026-05-28 16:23:18,982 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5845-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5845-1) 2026-05-28 16:23:20,587 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5845-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5845-2) 2026-05-28 16:23:20,587 - INFO - Waiting for VM test_vm to be up.. 2026-05-28 16:23:20,714 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-05-28 16:23:25,817 - DEBUG - VM is in ACTIVE state now 2026-05-28 16:23:25,817 - INFO - VM name : test_vm 2026-05-28 16:23:25,914 - DEBUG - VM test_vm ID is a36e516e-a9a1-409f-89b3-563be0a2fc8f 2026-05-28 16:23:25,914 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5845-1 2026-05-28 16:23:26,024 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/a36e516e-a9a1-409f-89b3-563be0a2fc8f 2026-05-28 16:23:26,036 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/82d91985-eb2c-4ebb-baff-be8e9b5e33f9 2026-05-28 16:23:29,212 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1002ms') 2026-05-28 16:23:29,212 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2026-05-28 16:23:29,231 - DEBUG - Gateway for vn default-domain:ctest-TestRP-27696022:ctest-bgpaas_vn-87255558 is 184.199.180.65 and allocation pool is NOT set 2026-05-28 16:23:31,299 - 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=7.77 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.624 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.624/4.196/7.768/3.572 ms') 2026-05-28 16:23:31,299 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2026-05-28 16:23:31,377 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-28 16:23:31,377 - DEBUG - Waiting to SSH to VM test_vm, IP 184.199.180.67, Port 22 2026-05-28 16:23:31,448 - 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-28 16:23:31,550 - DEBUG - VM test_vm is NOT ready for SSH connections, VM status: ACTIVE 2026-05-28 16:23:36,551 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-28 16:23:36,551 - DEBUG - Waiting to SSH to VM test_vm, IP 184.199.180.67, Port 22 2026-05-28 16:23:36,717 - DEBUG - VM test_vm is ready for SSH connections 2026-05-28 16:23:36,717 - INFO - Waiting for VM test2_vm to be up.. 2026-05-28 16:23:36,825 - DEBUG - VM is in ACTIVE state now 2026-05-28 16:23:36,825 - INFO - VM name : test2_vm 2026-05-28 16:23:36,933 - DEBUG - VM test2_vm ID is 42c50f63-3b8e-4487-89a1-d25040b8fd44 2026-05-28 16:23:36,933 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5845-2 2026-05-28 16:23:37,038 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/42c50f63-3b8e-4487-89a1-d25040b8fd44 2026-05-28 16:23:37,049 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/1cb2a4fa-052b-4fc7-a362-5a07d3028123 2026-05-28 16:23:38,209 - 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.16 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.528 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.528/2.342/4.157/1.814 ms') 2026-05-28 16:23:38,209 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2026-05-28 16:23:38,281 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-28 16:23:38,281 - DEBUG - Waiting to SSH to VM test2_vm, IP 147.183.16.3, Port 22 2026-05-28 16:23:38,452 - DEBUG - VM test2_vm is ready for SSH connections 2026-05-28 16:23:38,631 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-28 16:23:38,646 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-27696022:ctest-bgpaas_vn-87255558:ctest-bgpaas_vn-87255558.inet.0 2026-05-28 16:23:38,664 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-27696022:ctest-bgpaas_vn-87255558:ctest-bgpaas_vn-87255558.inet.0 2026-05-28 16:23:38,676 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-28 16:23:38,676 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 147.183.16.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.130, gateway password: c0ntrail123 2026-05-28 16:23:38,676 - DEBUG - ping -s 56 -c 3 -W 1 147.183.16.3 2026-05-28 16:23:42,432 - DEBUG - PING 147.183.16.3 (147.183.16.3): 56 data bytes 64 bytes from 147.183.16.3: seq=0 ttl=63 time=8.996 ms 64 bytes from 147.183.16.3: seq=1 ttl=63 time=1.363 ms 64 bytes from 147.183.16.3: seq=2 ttl=63 time=1.573 ms --- 147.183.16.3 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.363/3.977/8.996 ms 2026-05-28 16:23:42,432 - INFO - Ping to IP 147.183.16.3 from VM test_vm passed 2026-05-28 16:23:42,591 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-28 16:23:42,604 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-27696022:ctest-bgpaas_vn-87255558:ctest-bgpaas_vn-87255558.inet.0 2026-05-28 16:23:43,619 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-28 16:23:43,635 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-27696022:ctest-bgpaas_vn-87255558:ctest-bgpaas_vn-87255558.inet.0 2026-05-28 16:23:43,652 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-27696022:ctest-bgpaas_vn-87255558:ctest-bgpaas_vn-87255558.inet.0 2026-05-28 16:23:43,974 - INFO - Deleting VM test2_vm 2026-05-28 16:23:44,075 - INFO - Deleting VM test_vm 2026-05-28 16:23:44,155 - INFO - Deleting VN ctest-bgpaas_vn-01444473 2026-05-28 16:23:44,208 - DEBUG - VN e5a4d623-ea14-40ef-980c-fdf8c76cc7b4 still in use: Unable to complete operation on network e5a4d623-ea14-40ef-980c-fdf8c76cc7b4. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-b5aa9702-8748-415f-8d0e-aeab9056bf4f'] 2026-05-28 16:23:44,208 - WARNING - Deleting VN ctest-bgpaas_vn-01444473 failed..Will retry 2026-05-28 16:23:46,427 - DEBUG - Response for deleting network () 2026-05-28 16:23:46,427 - INFO - Deleting VN ctest-bgpaas_vn-87255558 2026-05-28 16:23:46,617 - DEBUG - Response for deleting network () 2026-05-28 16:23:47,918 - DEBUG - No XMPP flaps were noticed during the test
2026-05-28 16:23:47,918 - INFO - END TEST : test_rp_interface_ext_community : PASSED[0:00:33]
2026-05-28 16:23:47,918 - INFO - -------------------------------------------------------------------------------- 2026-05-28 16:23:47,920 - INFO - ================================================================================ 2026-05-28 16:23:47,921 - INFO - STARTING TEST : test_rp_interface_static 2026-05-28 16:23:47,921 - 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-28 16:23:49,214 - DEBUG - Nothing to compare xmpp stats {'10.0.0.130': {'10.20.0.25': '0', '10.20.0.254': '0'}, '10.0.0.73': {'10.20.0.25': '0', '10.20.0.254': '0'}} with 2026-05-28 16:23:49,214 - INFO - Initial checks done. Running the testcase now 2026-05-28 16:23:49,214 - INFO - 2026-05-28 16:23:49,523 - DEBUG - Response for create_network : {'network': {'id': '90d4bb6f-d26a-40eb-bc91-32944125b296', 'name': 'ctest-bgpaas_vn-09926820', 'tenant_id': '281531aae70a4d77973925d5011aedb3', 'project_id': '281531aae70a4d77973925d5011aedb3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-27696022', 'ctest-bgpaas_vn-09926820'], 'port_security_enabled': True, 'description': ''}} 2026-05-28 16:23:49,740 - DEBUG - Response for create_subnet : {'subnet': {'id': 'cd899d3d-4bf5-45ea-887b-6e038a4a7daf', 'name': '', 'tenant_id': '281531aae70a4d77973925d5011aedb3', 'network_id': '90d4bb6f-d26a-40eb-bc91-32944125b296', 'ip_version': 4, 'cidr': '97.31.105.0/26', 'allocation_pools': [{'start': '97.31.105.2', 'end': '97.31.105.62'}], 'gateway_ip': '97.31.105.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '97.31.105.2', 'tags': [], 'project_id': '281531aae70a4d77973925d5011aedb3'}} 2026-05-28 16:23:49,761 - INFO - Created VN ctest-bgpaas_vn-09926820 2026-05-28 16:23:49,774 - DEBUG - VN ctest-bgpaas_vn-09926820 UUID is 90d4bb6f-d26a-40eb-bc91-32944125b296 2026-05-28 16:23:50,327 - DEBUG - Response for create_network : {'network': {'id': 'd64d2e7e-6545-40d5-b5ce-49833b84a029', 'name': 'ctest-bgpaas_vn-79883829', 'tenant_id': '281531aae70a4d77973925d5011aedb3', 'project_id': '281531aae70a4d77973925d5011aedb3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-27696022', 'ctest-bgpaas_vn-79883829'], 'port_security_enabled': True, 'description': ''}} 2026-05-28 16:23:50,573 - DEBUG - Response for create_subnet : {'subnet': {'id': '2e563de6-5d3f-4f59-af81-a36dd95d171f', 'name': '', 'tenant_id': '281531aae70a4d77973925d5011aedb3', 'network_id': 'd64d2e7e-6545-40d5-b5ce-49833b84a029', 'ip_version': 4, 'cidr': '187.118.187.64/26', 'allocation_pools': [{'start': '187.118.187.66', 'end': '187.118.187.126'}], 'gateway_ip': '187.118.187.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '187.118.187.66', 'tags': [], 'project_id': '281531aae70a4d77973925d5011aedb3'}} 2026-05-28 16:23:50,596 - INFO - Created VN ctest-bgpaas_vn-79883829 2026-05-28 16:23:50,611 - DEBUG - VN ctest-bgpaas_vn-79883829 UUID is d64d2e7e-6545-40d5-b5ce-49833b84a029 2026-05-28 16:23:51,978 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5845-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5845-1) 2026-05-28 16:23:53,343 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5845-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5845-2) 2026-05-28 16:23:53,343 - INFO - Waiting for VM test_vm to be up.. 2026-05-28 16:23:53,443 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-05-28 16:23:58,532 - DEBUG - VM is in ACTIVE state now 2026-05-28 16:23:58,532 - INFO - VM name : test_vm 2026-05-28 16:23:58,622 - DEBUG - VM test_vm ID is 9ff8e671-65a9-40a1-9475-a7089b7ee100 2026-05-28 16:23:58,622 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5845-1 2026-05-28 16:23:58,711 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/9ff8e671-65a9-40a1-9475-a7089b7ee100 2026-05-28 16:23:58,721 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/ddcf84c1-a039-464f-bf0e-cec2d74b7ca4 2026-05-28 16:24:01,914 - 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 1026ms') 2026-05-28 16:24:01,914 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2026-05-28 16:24:01,934 - DEBUG - Gateway for vn default-domain:ctest-TestRP-27696022:ctest-bgpaas_vn-09926820 is 97.31.105.1 and allocation pool is NOT set 2026-05-28 16:24:03,999 - 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.8 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.410 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.410/5.629/10.849/5.219 ms') 2026-05-28 16:24:03,999 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2026-05-28 16:24:04,073 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-28 16:24:04,073 - DEBUG - Waiting to SSH to VM test_vm, IP 97.31.105.3, Port 22 2026-05-28 16:24:04,143 - 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-28 16:24:04,233 - DEBUG - VM test_vm is NOT ready for SSH connections, VM status: ACTIVE 2026-05-28 16:24:09,234 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-28 16:24:09,234 - DEBUG - Waiting to SSH to VM test_vm, IP 97.31.105.3, Port 22 2026-05-28 16:24:09,414 - DEBUG - VM test_vm is ready for SSH connections 2026-05-28 16:24:09,414 - INFO - Waiting for VM test2_vm to be up.. 2026-05-28 16:24:09,513 - DEBUG - VM is in ACTIVE state now 2026-05-28 16:24:09,513 - INFO - VM name : test2_vm 2026-05-28 16:24:09,615 - DEBUG - VM test2_vm ID is d16a62f7-04f3-43fc-8338-714c23c4e942 2026-05-28 16:24:09,615 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5845-2 2026-05-28 16:24:09,699 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/d16a62f7-04f3-43fc-8338-714c23c4e942 2026-05-28 16:24:09,711 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/93911576-ec48-4c55-a62b-ba15798881ec 2026-05-28 16:24:10,881 - 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.54 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.463 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.463/1.999/3.535/1.536 ms') 2026-05-28 16:24:10,881 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2026-05-28 16:24:10,954 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-28 16:24:10,954 - DEBUG - Waiting to SSH to VM test2_vm, IP 187.118.187.67, Port 22 2026-05-28 16:24:11,120 - DEBUG - VM test2_vm is ready for SSH connections 2026-05-28 16:24:11,216 - INFO - Created InterfaceRouteTable ['default-domain', 'ctest-TestRP-27696022', 'ctest-int_table_right-78789211'](UUID f4aa8891-0a19-404f-a3ac-b88fde2a810f), prefixes : ['208.171.34.128/26'] 2026-05-28 16:24:11,291 - INFO - Added intf route table f4aa8891-0a19-404f-a3ac-b88fde2a810f to port ddcf84c1-a039-464f-bf0e-cec2d74b7ca4 2026-05-28 16:24:11,508 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-27696022:ctest-bgpaas_vn-09926820:ctest-bgpaas_vn-09926820.inet.0 2026-05-28 16:24:11,524 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-27696022:ctest-bgpaas_vn-09926820:ctest-bgpaas_vn-09926820.inet.0 2026-05-28 16:24:11,536 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-28 16:24:11,536 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 187.118.187.67, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.130, gateway password: c0ntrail123 2026-05-28 16:24:11,536 - DEBUG - ping -s 56 -c 3 -W 1 187.118.187.67 2026-05-28 16:24:15,556 - DEBUG - PING 187.118.187.67 (187.118.187.67): 56 data bytes 64 bytes from 187.118.187.67: seq=0 ttl=63 time=6.552 ms 64 bytes from 187.118.187.67: seq=1 ttl=63 time=1.456 ms 64 bytes from 187.118.187.67: seq=2 ttl=63 time=1.354 ms --- 187.118.187.67 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.354/3.120/6.552 ms 2026-05-28 16:24:15,556 - INFO - Ping to IP 187.118.187.67 from VM test_vm passed 2026-05-28 16:24:15,727 - INFO - Deleting VM test2_vm 2026-05-28 16:24:15,823 - INFO - Deleting VM test_vm 2026-05-28 16:24:15,915 - INFO - Deleting VN ctest-bgpaas_vn-79883829 2026-05-28 16:24:15,972 - DEBUG - VN d64d2e7e-6545-40d5-b5ce-49833b84a029 still in use: Unable to complete operation on network d64d2e7e-6545-40d5-b5ce-49833b84a029. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-395fa2f6-8878-4c86-be9b-24c974b28e3f'] 2026-05-28 16:24:15,973 - WARNING - Deleting VN ctest-bgpaas_vn-79883829 failed..Will retry 2026-05-28 16:24:18,174 - DEBUG - Response for deleting network () 2026-05-28 16:24:18,174 - INFO - Deleting VN ctest-bgpaas_vn-09926820 2026-05-28 16:24:18,403 - DEBUG - Response for deleting network () 2026-05-28 16:24:19,716 - DEBUG - No XMPP flaps were noticed during the test
2026-05-28 16:24:19,716 - INFO - END TEST : test_rp_interface_static : PASSED[0:00:32]
2026-05-28 16:24:19,717 - INFO - -------------------------------------------------------------------------------- 2026-05-28 16:24:20,540 - INFO - Deleted project: ctest-TestRP-27696022, ID : 281531aa-e70a-4d77-9739-25d5011aedb3