2025-11-27 02:50:58,728 - INFO - Domain Default found not creating 2025-11-27 02:50:58,904 - INFO - Project ctest-TestRP-49012485 not found, creating it 2025-11-27 02:50:59,424 - INFO - Created Project:ctest-TestRP-49012485, ID : 7ddfac08-21f0-4cec-b831-c0a9d2afd6bf 2025-11-27 02:51:01,006 - DEBUG - Services list from nova: [, , , ] 2025-11-27 02:51:01,006 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-4820-2', 'an-jenkins-deploy-platform-ansible-os-4820-1']} 2025-11-27 02:51:01,011 - INFO - ================================================================================ 2025-11-27 02:51:01,011 - INFO - STARTING TEST : test_rp_interface 2025-11-27 02:51:01,011 - 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. 2025-11-27 02:51:02,285 - DEBUG - Nothing to compare xmpp stats {'10.0.0.19': {'10.20.0.193': '0', '10.20.0.192': '0'}, '10.0.0.130': {'10.20.0.192': '0', '10.20.0.129': '0'}} with 2025-11-27 02:51:02,285 - INFO - Initial checks done. Running the testcase now 2025-11-27 02:51:02,285 - INFO - 2025-11-27 02:51:02,975 - DEBUG - Response for create_network : {'network': {'id': 'eadedd24-980a-4b8f-924e-36be568a933a', 'name': 'ctest-bgpaas_vn-89136351', 'tenant_id': '7ddfac0821f04cecb831c0a9d2afd6bf', 'project_id': '7ddfac0821f04cecb831c0a9d2afd6bf', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-49012485', 'ctest-bgpaas_vn-89136351'], 'port_security_enabled': True, 'description': ''}} 2025-11-27 02:51:03,261 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c32e1b13-f6c5-4a5f-91f7-dd84cfc91111', 'name': '', 'tenant_id': '7ddfac0821f04cecb831c0a9d2afd6bf', 'network_id': 'eadedd24-980a-4b8f-924e-36be568a933a', 'ip_version': 4, 'cidr': '91.91.236.128/26', 'allocation_pools': [{'start': '91.91.236.130', 'end': '91.91.236.190'}], 'gateway_ip': '91.91.236.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '91.91.236.130', 'tags': [], 'project_id': '7ddfac0821f04cecb831c0a9d2afd6bf'}} 2025-11-27 02:51:03,299 - INFO - Created VN ctest-bgpaas_vn-89136351 2025-11-27 02:51:03,309 - DEBUG - VN ctest-bgpaas_vn-89136351 UUID is eadedd24-980a-4b8f-924e-36be568a933a 2025-11-27 02:51:03,829 - DEBUG - Response for create_network : {'network': {'id': 'ad88aae3-accd-42fc-ba88-4a015ef512c5', 'name': 'ctest-bgpaas_vn-25407393', 'tenant_id': '7ddfac0821f04cecb831c0a9d2afd6bf', 'project_id': '7ddfac0821f04cecb831c0a9d2afd6bf', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-49012485', 'ctest-bgpaas_vn-25407393'], 'port_security_enabled': True, 'description': ''}} 2025-11-27 02:51:04,087 - DEBUG - Response for create_subnet : {'subnet': {'id': '96816b1c-5857-416b-9248-71156b5810e7', 'name': '', 'tenant_id': '7ddfac0821f04cecb831c0a9d2afd6bf', 'network_id': 'ad88aae3-accd-42fc-ba88-4a015ef512c5', 'ip_version': 4, 'cidr': '108.161.212.128/26', 'allocation_pools': [{'start': '108.161.212.130', 'end': '108.161.212.190'}], 'gateway_ip': '108.161.212.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '108.161.212.130', 'tags': [], 'project_id': '7ddfac0821f04cecb831c0a9d2afd6bf'}} 2025-11-27 02:51:04,110 - INFO - Created VN ctest-bgpaas_vn-25407393 2025-11-27 02:51:04,120 - DEBUG - VN ctest-bgpaas_vn-25407393 UUID is ad88aae3-accd-42fc-ba88-4a015ef512c5 2025-11-27 02:51:05,471 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4820-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4820-2) 2025-11-27 02:51:06,828 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4820-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4820-1) 2025-11-27 02:51:06,828 - INFO - Waiting for VM test_vm to be up.. 2025-11-27 02:51:06,933 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-11-27 02:51:12,007 - DEBUG - VM is in ACTIVE state now 2025-11-27 02:51:12,007 - INFO - VM name : test_vm 2025-11-27 02:51:12,087 - DEBUG - VM test_vm ID is 8cada1a6-894f-48b8-a1e3-49593946702e 2025-11-27 02:51:12,118 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-4820-2 2025-11-27 02:51:12,201 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/8cada1a6-894f-48b8-a1e3-49593946702e 2025-11-27 02:51:12,500 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/8cada1a6-894f-48b8-a1e3-49593946702e 2025-11-27 02:51:12,536 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/823d13d9-6586-4a1c-a14c-8b540d5d1b39 2025-11-27 02:51:15,725 - 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 1029ms') 2025-11-27 02:51:15,725 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2025-11-27 02:51:15,741 - DEBUG - Gateway for vn default-domain:ctest-TestRP-49012485:ctest-bgpaas_vn-89136351 is 91.91.236.129 and allocation pool is NOT set 2025-11-27 02:51:17,805 - 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.70 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.471 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.471/1.584/2.697/1.113 ms') 2025-11-27 02:51:17,805 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2025-11-27 02:51:17,873 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-11-27 02:51:17,874 - DEBUG - Waiting to SSH to VM test_vm, IP 91.91.236.131, Port 22 2025-11-27 02:51:18,032 - DEBUG - VM test_vm is ready for SSH connections 2025-11-27 02:51:18,032 - INFO - Waiting for VM test2_vm to be up.. 2025-11-27 02:51:18,126 - DEBUG - VM is in ACTIVE state now 2025-11-27 02:51:18,126 - INFO - VM name : test2_vm 2025-11-27 02:51:18,213 - DEBUG - VM test2_vm ID is 0f1025b8-21f9-4b2c-8680-605459ea0dcb 2025-11-27 02:51:18,213 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-4820-1 2025-11-27 02:51:18,288 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/0f1025b8-21f9-4b2c-8680-605459ea0dcb 2025-11-27 02:51:18,298 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/a8418cfb-c4a8-4da8-92d0-bbc72a94c751 2025-11-27 02:51:19,457 - 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.38 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.416 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.416/1.896/3.376/1.480 ms') 2025-11-27 02:51:19,457 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2025-11-27 02:51:19,524 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-11-27 02:51:19,524 - DEBUG - Waiting to SSH to VM test2_vm, IP 108.161.212.131, Port 22 2025-11-27 02:51:19,682 - DEBUG - VM test2_vm is ready for SSH connections 2025-11-27 02:51:19,840 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-11-27 02:51:19,852 - DEBUG - Requesting: http://10.20.0.192:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-49012485:ctest-bgpaas_vn-89136351:ctest-bgpaas_vn-89136351.inet.0 2025-11-27 02:51:19,869 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-49012485:ctest-bgpaas_vn-89136351:ctest-bgpaas_vn-89136351.inet.0 2025-11-27 02:51:19,882 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-11-27 02:51:19,882 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 108.161.212.131, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.130, gateway password: c0ntrail123 2025-11-27 02:51:19,882 - DEBUG - ping -s 56 -c 3 -W 1 108.161.212.131 2025-11-27 02:51:23,783 - DEBUG - PING 108.161.212.131 (108.161.212.131): 56 data bytes 64 bytes from 108.161.212.131: seq=0 ttl=63 time=5.380 ms 64 bytes from 108.161.212.131: seq=1 ttl=63 time=1.153 ms 64 bytes from 108.161.212.131: seq=2 ttl=63 time=0.936 ms --- 108.161.212.131 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 0.936/2.489/5.380 ms 2025-11-27 02:51:23,783 - INFO - Ping to IP 108.161.212.131 from VM test_vm passed 2025-11-27 02:51:23,892 - INFO - Deleting VM test2_vm 2025-11-27 02:51:23,985 - INFO - Deleting VM test_vm 2025-11-27 02:51:24,055 - INFO - Deleting VN ctest-bgpaas_vn-25407393 2025-11-27 02:51:24,098 - DEBUG - VN ad88aae3-accd-42fc-ba88-4a015ef512c5 still in use: Unable to complete operation on network ad88aae3-accd-42fc-ba88-4a015ef512c5. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-f658489a-3782-41fd-a6b0-a359a2077867'] 2025-11-27 02:51:24,098 - WARNING - Deleting VN ctest-bgpaas_vn-25407393 failed..Will retry 2025-11-27 02:51:26,249 - DEBUG - Response for deleting network () 2025-11-27 02:51:26,249 - INFO - Deleting VN ctest-bgpaas_vn-89136351 2025-11-27 02:51:26,439 - DEBUG - Response for deleting network () 2025-11-27 02:51:27,700 - DEBUG - No XMPP flaps were noticed during the test
2025-11-27 02:51:27,700 - INFO - END TEST : test_rp_interface : PASSED[0:00:26]
2025-11-27 02:51:27,700 - INFO - -------------------------------------------------------------------------------- 2025-11-27 02:51:27,706 - INFO - ================================================================================ 2025-11-27 02:51:27,706 - INFO - STARTING TEST : test_rp_interface_ext_community 2025-11-27 02:51:27,706 - 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. 2025-11-27 02:51:29,031 - DEBUG - Nothing to compare xmpp stats {'10.0.0.19': {'10.20.0.193': '0', '10.20.0.192': '0'}, '10.0.0.130': {'10.20.0.192': '0', '10.20.0.129': '0'}} with 2025-11-27 02:51:29,031 - INFO - Initial checks done. Running the testcase now 2025-11-27 02:51:29,031 - INFO - 2025-11-27 02:51:29,268 - DEBUG - Response for create_network : {'network': {'id': 'e9f0a26f-3c07-43f7-b6c8-c781494c46c7', 'name': 'ctest-bgpaas_vn-42370061', 'tenant_id': '7ddfac0821f04cecb831c0a9d2afd6bf', 'project_id': '7ddfac0821f04cecb831c0a9d2afd6bf', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-49012485', 'ctest-bgpaas_vn-42370061'], 'port_security_enabled': True, 'description': ''}} 2025-11-27 02:51:29,494 - DEBUG - Response for create_subnet : {'subnet': {'id': '5e63da20-e13b-4f06-946d-7b0dcb296933', 'name': '', 'tenant_id': '7ddfac0821f04cecb831c0a9d2afd6bf', 'network_id': 'e9f0a26f-3c07-43f7-b6c8-c781494c46c7', 'ip_version': 4, 'cidr': '6.185.175.128/26', 'allocation_pools': [{'start': '6.185.175.130', 'end': '6.185.175.190'}], 'gateway_ip': '6.185.175.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '6.185.175.130', 'tags': [], 'project_id': '7ddfac0821f04cecb831c0a9d2afd6bf'}} 2025-11-27 02:51:29,516 - INFO - Created VN ctest-bgpaas_vn-42370061 2025-11-27 02:51:29,528 - DEBUG - VN ctest-bgpaas_vn-42370061 UUID is e9f0a26f-3c07-43f7-b6c8-c781494c46c7 2025-11-27 02:51:30,008 - DEBUG - Response for create_network : {'network': {'id': '246c5a2a-599a-4361-9fb0-eb7c6c11db6b', 'name': 'ctest-bgpaas_vn-85026752', 'tenant_id': '7ddfac0821f04cecb831c0a9d2afd6bf', 'project_id': '7ddfac0821f04cecb831c0a9d2afd6bf', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-49012485', 'ctest-bgpaas_vn-85026752'], 'port_security_enabled': True, 'description': ''}} 2025-11-27 02:51:30,279 - DEBUG - Response for create_subnet : {'subnet': {'id': '74be3a1e-6f45-41fa-8e1a-0599f710a6f7', 'name': '', 'tenant_id': '7ddfac0821f04cecb831c0a9d2afd6bf', 'network_id': '246c5a2a-599a-4361-9fb0-eb7c6c11db6b', 'ip_version': 4, 'cidr': '123.242.167.192/26', 'allocation_pools': [{'start': '123.242.167.194', 'end': '123.242.167.254'}], 'gateway_ip': '123.242.167.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '123.242.167.194', 'tags': [], 'project_id': '7ddfac0821f04cecb831c0a9d2afd6bf'}} 2025-11-27 02:51:30,308 - INFO - Created VN ctest-bgpaas_vn-85026752 2025-11-27 02:51:30,318 - DEBUG - VN ctest-bgpaas_vn-85026752 UUID is 246c5a2a-599a-4361-9fb0-eb7c6c11db6b 2025-11-27 02:51:31,621 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4820-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4820-2) 2025-11-27 02:51:32,987 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4820-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4820-1) 2025-11-27 02:51:32,987 - INFO - Waiting for VM test_vm to be up.. 2025-11-27 02:51:33,077 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-11-27 02:51:38,156 - DEBUG - VM is in ACTIVE state now 2025-11-27 02:51:38,156 - INFO - VM name : test_vm 2025-11-27 02:51:38,232 - DEBUG - VM test_vm ID is 8a837856-51f4-47a3-8de4-a5340d50c9cb 2025-11-27 02:51:38,232 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-4820-2 2025-11-27 02:51:38,312 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/8a837856-51f4-47a3-8de4-a5340d50c9cb 2025-11-27 02:51:38,323 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/e4a57c30-046d-4e37-a228-7a0f4e5cb7bb 2025-11-27 02:51:41,482 - 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') 2025-11-27 02:51:41,483 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2025-11-27 02:51:41,495 - DEBUG - Gateway for vn default-domain:ctest-TestRP-49012485:ctest-bgpaas_vn-42370061 is 6.185.175.129 and allocation pool is NOT set 2025-11-27 02:51:43,562 - 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.09 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.421 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.421/1.755/3.089/1.334 ms') 2025-11-27 02:51:43,562 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2025-11-27 02:51:43,628 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-11-27 02:51:43,628 - DEBUG - Waiting to SSH to VM test_vm, IP 6.185.175.131, Port 22 2025-11-27 02:51:43,794 - DEBUG - VM test_vm is ready for SSH connections 2025-11-27 02:51:43,794 - INFO - Waiting for VM test2_vm to be up.. 2025-11-27 02:51:43,876 - DEBUG - VM is in ACTIVE state now 2025-11-27 02:51:43,876 - INFO - VM name : test2_vm 2025-11-27 02:51:43,953 - DEBUG - VM test2_vm ID is 1aa566fa-a119-4550-a3d1-ee6ca7595024 2025-11-27 02:51:43,953 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-4820-1 2025-11-27 02:51:44,035 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/1aa566fa-a119-4550-a3d1-ee6ca7595024 2025-11-27 02:51:44,045 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/b3a58174-3c5a-4928-8217-0c1f25fa82c5 2025-11-27 02:51:45,208 - 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=0.562 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.562/5.370/10.178/4.808 ms') 2025-11-27 02:51:45,209 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2025-11-27 02:51:45,276 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-11-27 02:51:45,276 - DEBUG - Waiting to SSH to VM test2_vm, IP 123.242.167.195, Port 22 2025-11-27 02:51:45,438 - DEBUG - VM test2_vm is ready for SSH connections 2025-11-27 02:51:45,580 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-11-27 02:51:45,593 - DEBUG - Requesting: http://10.20.0.192:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-49012485:ctest-bgpaas_vn-42370061:ctest-bgpaas_vn-42370061.inet.0 2025-11-27 02:51:45,608 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-49012485:ctest-bgpaas_vn-42370061:ctest-bgpaas_vn-42370061.inet.0 2025-11-27 02:51:45,621 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-11-27 02:51:45,622 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 123.242.167.195, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.130, gateway password: c0ntrail123 2025-11-27 02:51:45,622 - DEBUG - ping -s 56 -c 3 -W 1 123.242.167.195 2025-11-27 02:51:49,278 - DEBUG - PING 123.242.167.195 (123.242.167.195): 56 data bytes 64 bytes from 123.242.167.195: seq=0 ttl=63 time=5.455 ms 64 bytes from 123.242.167.195: seq=1 ttl=63 time=1.187 ms 64 bytes from 123.242.167.195: seq=2 ttl=63 time=1.304 ms --- 123.242.167.195 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.187/2.648/5.455 ms 2025-11-27 02:51:49,278 - INFO - Ping to IP 123.242.167.195 from VM test_vm passed 2025-11-27 02:51:49,412 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-11-27 02:51:49,426 - DEBUG - Requesting: http://10.20.0.192:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-49012485:ctest-bgpaas_vn-42370061:ctest-bgpaas_vn-42370061.inet.0 2025-11-27 02:51:49,442 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-49012485:ctest-bgpaas_vn-42370061:ctest-bgpaas_vn-42370061.inet.0 2025-11-27 02:51:49,687 - INFO - Deleting VM test2_vm 2025-11-27 02:51:49,757 - INFO - Deleting VM test_vm 2025-11-27 02:51:49,845 - INFO - Deleting VN ctest-bgpaas_vn-85026752 2025-11-27 02:51:49,887 - DEBUG - VN 246c5a2a-599a-4361-9fb0-eb7c6c11db6b still in use: Unable to complete operation on network 246c5a2a-599a-4361-9fb0-eb7c6c11db6b. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-23655976-2396-4d9e-a332-e892361be94b'] 2025-11-27 02:51:49,888 - WARNING - Deleting VN ctest-bgpaas_vn-85026752 failed..Will retry 2025-11-27 02:51:52,023 - DEBUG - Response for deleting network () 2025-11-27 02:51:52,023 - INFO - Deleting VN ctest-bgpaas_vn-42370061 2025-11-27 02:51:52,196 - DEBUG - Response for deleting network () 2025-11-27 02:51:53,480 - DEBUG - No XMPP flaps were noticed during the test
2025-11-27 02:51:53,480 - INFO - END TEST : test_rp_interface_ext_community : PASSED[0:00:26]
2025-11-27 02:51:53,480 - INFO - -------------------------------------------------------------------------------- 2025-11-27 02:51:53,484 - INFO - ================================================================================ 2025-11-27 02:51:53,484 - INFO - STARTING TEST : test_rp_interface_static 2025-11-27 02:51:53,484 - 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. 2025-11-27 02:51:54,766 - DEBUG - Nothing to compare xmpp stats {'10.0.0.19': {'10.20.0.193': '0', '10.20.0.192': '0'}, '10.0.0.130': {'10.20.0.192': '0', '10.20.0.129': '0'}} with 2025-11-27 02:51:54,766 - INFO - Initial checks done. Running the testcase now 2025-11-27 02:51:54,767 - INFO - 2025-11-27 02:51:55,017 - DEBUG - Response for create_network : {'network': {'id': '53234549-0048-4fc3-bbc4-a8fa61837a38', 'name': 'ctest-bgpaas_vn-65128156', 'tenant_id': '7ddfac0821f04cecb831c0a9d2afd6bf', 'project_id': '7ddfac0821f04cecb831c0a9d2afd6bf', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-49012485', 'ctest-bgpaas_vn-65128156'], 'port_security_enabled': True, 'description': ''}} 2025-11-27 02:51:55,290 - DEBUG - Response for create_subnet : {'subnet': {'id': '0d700c9f-e969-4269-b2bc-9c33c7b17101', 'name': '', 'tenant_id': '7ddfac0821f04cecb831c0a9d2afd6bf', 'network_id': '53234549-0048-4fc3-bbc4-a8fa61837a38', 'ip_version': 4, 'cidr': '139.83.126.64/26', 'allocation_pools': [{'start': '139.83.126.66', 'end': '139.83.126.126'}], 'gateway_ip': '139.83.126.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '139.83.126.66', 'tags': [], 'project_id': '7ddfac0821f04cecb831c0a9d2afd6bf'}} 2025-11-27 02:51:55,315 - INFO - Created VN ctest-bgpaas_vn-65128156 2025-11-27 02:51:55,326 - DEBUG - VN ctest-bgpaas_vn-65128156 UUID is 53234549-0048-4fc3-bbc4-a8fa61837a38 2025-11-27 02:51:55,816 - DEBUG - Response for create_network : {'network': {'id': '51f479e2-95e2-43ec-836d-d7297d39c81a', 'name': 'ctest-bgpaas_vn-09278997', 'tenant_id': '7ddfac0821f04cecb831c0a9d2afd6bf', 'project_id': '7ddfac0821f04cecb831c0a9d2afd6bf', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-49012485', 'ctest-bgpaas_vn-09278997'], 'port_security_enabled': True, 'description': ''}} 2025-11-27 02:51:56,067 - DEBUG - Response for create_subnet : {'subnet': {'id': 'cf6e813b-53d6-4bcc-a929-2d5fa37e6b08', 'name': '', 'tenant_id': '7ddfac0821f04cecb831c0a9d2afd6bf', 'network_id': '51f479e2-95e2-43ec-836d-d7297d39c81a', 'ip_version': 4, 'cidr': '141.135.208.64/26', 'allocation_pools': [{'start': '141.135.208.66', 'end': '141.135.208.126'}], 'gateway_ip': '141.135.208.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '141.135.208.66', 'tags': [], 'project_id': '7ddfac0821f04cecb831c0a9d2afd6bf'}} 2025-11-27 02:51:56,095 - INFO - Created VN ctest-bgpaas_vn-09278997 2025-11-27 02:51:56,106 - DEBUG - VN ctest-bgpaas_vn-09278997 UUID is 51f479e2-95e2-43ec-836d-d7297d39c81a 2025-11-27 02:51:57,425 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4820-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4820-2) 2025-11-27 02:51:58,860 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4820-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4820-1) 2025-11-27 02:51:58,860 - INFO - Waiting for VM test_vm to be up.. 2025-11-27 02:51:58,942 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-11-27 02:52:04,017 - DEBUG - VM is in ACTIVE state now 2025-11-27 02:52:04,017 - INFO - VM name : test_vm 2025-11-27 02:52:04,104 - DEBUG - VM test_vm ID is c842e224-66ef-48e0-864a-41e98921a9fb 2025-11-27 02:52:04,104 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-4820-2 2025-11-27 02:52:04,192 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/c842e224-66ef-48e0-864a-41e98921a9fb 2025-11-27 02:52:04,201 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/a310959a-3fcb-428d-bc0b-834907e2aaeb 2025-11-27 02:52:07,373 - 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 1015ms') 2025-11-27 02:52:07,374 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2025-11-27 02:52:07,387 - DEBUG - Gateway for vn default-domain:ctest-TestRP-49012485:ctest-bgpaas_vn-65128156 is 139.83.126.65 and allocation pool is NOT set 2025-11-27 02:52:09,451 - 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.83 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.70 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.695/3.763/5.832/2.068 ms') 2025-11-27 02:52:09,451 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2025-11-27 02:52:09,515 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-11-27 02:52:09,516 - DEBUG - Waiting to SSH to VM test_vm, IP 139.83.126.67, Port 22 2025-11-27 02:52:09,676 - DEBUG - VM test_vm is ready for SSH connections 2025-11-27 02:52:09,676 - INFO - Waiting for VM test2_vm to be up.. 2025-11-27 02:52:09,753 - DEBUG - VM is in ACTIVE state now 2025-11-27 02:52:09,753 - INFO - VM name : test2_vm 2025-11-27 02:52:09,834 - DEBUG - VM test2_vm ID is f3396852-17db-4bb0-81d4-d74f33f5cc89 2025-11-27 02:52:09,834 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-4820-1 2025-11-27 02:52:09,911 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/f3396852-17db-4bb0-81d4-d74f33f5cc89 2025-11-27 02:52:09,921 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/df18b06c-b025-4722-b937-2f1122559ea8 2025-11-27 02:52:11,089 - 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.65 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.588 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.588/3.120/5.653/2.532 ms') 2025-11-27 02:52:11,089 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2025-11-27 02:52:11,156 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-11-27 02:52:11,156 - DEBUG - Waiting to SSH to VM test2_vm, IP 141.135.208.67, Port 22 2025-11-27 02:52:11,314 - DEBUG - VM test2_vm is ready for SSH connections 2025-11-27 02:52:11,404 - INFO - Created InterfaceRouteTable ['default-domain', 'ctest-TestRP-49012485', 'ctest-int_table_right-70914583'](UUID 7e5a2fc5-2b2a-4516-8ccb-797d46849e60), prefixes : ['223.105.110.0/26'] 2025-11-27 02:52:11,472 - INFO - Added intf route table 7e5a2fc5-2b2a-4516-8ccb-797d46849e60 to port a310959a-3fcb-428d-bc0b-834907e2aaeb 2025-11-27 02:52:11,658 - DEBUG - Requesting: http://10.20.0.192:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-49012485:ctest-bgpaas_vn-65128156:ctest-bgpaas_vn-65128156.inet.0 2025-11-27 02:52:11,676 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-49012485:ctest-bgpaas_vn-65128156:ctest-bgpaas_vn-65128156.inet.0 2025-11-27 02:52:11,690 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-11-27 02:52:11,691 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 141.135.208.67, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.130, gateway password: c0ntrail123 2025-11-27 02:52:11,691 - DEBUG - ping -s 56 -c 3 -W 1 141.135.208.67 2025-11-27 02:52:15,351 - DEBUG - PING 141.135.208.67 (141.135.208.67): 56 data bytes 64 bytes from 141.135.208.67: seq=0 ttl=63 time=5.193 ms 64 bytes from 141.135.208.67: seq=1 ttl=63 time=1.100 ms 64 bytes from 141.135.208.67: seq=2 ttl=63 time=1.219 ms --- 141.135.208.67 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.100/2.504/5.193 ms 2025-11-27 02:52:15,351 - INFO - Ping to IP 141.135.208.67 from VM test_vm passed 2025-11-27 02:52:15,459 - INFO - Deleting VM test2_vm 2025-11-27 02:52:15,552 - INFO - Deleting VM test_vm 2025-11-27 02:52:15,621 - INFO - Deleting VN ctest-bgpaas_vn-09278997 2025-11-27 02:52:15,660 - DEBUG - VN 51f479e2-95e2-43ec-836d-d7297d39c81a still in use: Unable to complete operation on network 51f479e2-95e2-43ec-836d-d7297d39c81a. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-fa445e1a-9227-479d-ba50-1cef2b1953c0'] 2025-11-27 02:52:15,660 - WARNING - Deleting VN ctest-bgpaas_vn-09278997 failed..Will retry 2025-11-27 02:52:17,850 - DEBUG - Response for deleting network () 2025-11-27 02:52:17,850 - INFO - Deleting VN ctest-bgpaas_vn-65128156 2025-11-27 02:52:18,033 - DEBUG - Response for deleting network () 2025-11-27 02:52:19,330 - DEBUG - No XMPP flaps were noticed during the test
2025-11-27 02:52:19,330 - INFO - END TEST : test_rp_interface_static : PASSED[0:00:26]
2025-11-27 02:52:19,331 - INFO - -------------------------------------------------------------------------------- 2025-11-27 02:52:20,024 - INFO - Deleted project: ctest-TestRP-49012485, ID : 7ddfac08-21f0-4cec-b831-c0a9d2afd6bf