2025-08-10 21:22:24,238 - INFO - Domain Default found not creating 2025-08-10 21:22:24,392 - INFO - Project ctest-TestRP-70277359 not found, creating it 2025-08-10 21:22:24,831 - INFO - Created Project:ctest-TestRP-70277359, ID : 44569e26-1893-4632-8f47-9f2fd0d34de9 2025-08-10 21:22:26,209 - DEBUG - Services list from nova: [, , , ] 2025-08-10 21:22:26,209 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-3790-1', 'an-jenkins-deploy-platform-ansible-os-3790-2']} 2025-08-10 21:22:26,212 - INFO - ================================================================================ 2025-08-10 21:22:26,212 - INFO - STARTING TEST : test_rp_interface 2025-08-10 21:22:26,212 - 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-08-10 21:22:27,483 - DEBUG - Nothing to compare xmpp stats {'10.0.0.254': {'10.20.0.25': '0', '10.20.0.17': '0'}, '10.0.0.50': {'10.20.0.25': '0', '10.20.0.17': '0'}} with 2025-08-10 21:22:27,484 - INFO - Initial checks done. Running the testcase now 2025-08-10 21:22:27,484 - INFO - 2025-08-10 21:22:28,098 - DEBUG - Response for create_network : {'network': {'id': '02331781-3afe-4959-86b6-7870837dc489', 'name': 'ctest-bgpaas_vn-20626043', 'tenant_id': '44569e26189346328f479f2fd0d34de9', 'project_id': '44569e26189346328f479f2fd0d34de9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-70277359', 'ctest-bgpaas_vn-20626043'], 'port_security_enabled': True, 'description': ''}} 2025-08-10 21:22:28,394 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e38df0da-8977-4699-888f-47a114b97704', 'name': '', 'tenant_id': '44569e26189346328f479f2fd0d34de9', 'network_id': '02331781-3afe-4959-86b6-7870837dc489', 'ip_version': 4, 'cidr': '135.101.64.0/26', 'allocation_pools': [{'start': '135.101.64.2', 'end': '135.101.64.62'}], 'gateway_ip': '135.101.64.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '135.101.64.2', 'tags': [], 'project_id': '44569e26189346328f479f2fd0d34de9'}} 2025-08-10 21:22:28,416 - INFO - Created VN ctest-bgpaas_vn-20626043 2025-08-10 21:22:28,428 - DEBUG - VN ctest-bgpaas_vn-20626043 UUID is 02331781-3afe-4959-86b6-7870837dc489 2025-08-10 21:22:28,944 - DEBUG - Response for create_network : {'network': {'id': 'efcc883d-9d9c-478a-81c4-10a77a446460', 'name': 'ctest-bgpaas_vn-32254763', 'tenant_id': '44569e26189346328f479f2fd0d34de9', 'project_id': '44569e26189346328f479f2fd0d34de9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-70277359', 'ctest-bgpaas_vn-32254763'], 'port_security_enabled': True, 'description': ''}} 2025-08-10 21:22:29,142 - DEBUG - Response for create_subnet : {'subnet': {'id': '9c650a14-9064-4812-b60d-1aef32175370', 'name': '', 'tenant_id': '44569e26189346328f479f2fd0d34de9', 'network_id': 'efcc883d-9d9c-478a-81c4-10a77a446460', 'ip_version': 4, 'cidr': '73.59.112.64/26', 'allocation_pools': [{'start': '73.59.112.66', 'end': '73.59.112.126'}], 'gateway_ip': '73.59.112.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '73.59.112.66', 'tags': [], 'project_id': '44569e26189346328f479f2fd0d34de9'}} 2025-08-10 21:22:29,167 - INFO - Created VN ctest-bgpaas_vn-32254763 2025-08-10 21:22:29,179 - DEBUG - VN ctest-bgpaas_vn-32254763 UUID is efcc883d-9d9c-478a-81c4-10a77a446460 2025-08-10 21:22:30,497 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3790-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3790-1) 2025-08-10 21:22:32,058 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3790-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3790-2) 2025-08-10 21:22:32,058 - INFO - Waiting for VM test_vm to be up.. 2025-08-10 21:22:32,140 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-08-10 21:22:37,212 - DEBUG - VM is in ACTIVE state now 2025-08-10 21:22:37,212 - INFO - VM name : test_vm 2025-08-10 21:22:37,283 - DEBUG - VM test_vm ID is 1ded901c-c918-4b10-91fa-8226eff3ce5c 2025-08-10 21:22:37,304 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-3790-1 2025-08-10 21:22:37,374 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-machine/1ded901c-c918-4b10-91fa-8226eff3ce5c 2025-08-10 21:22:37,675 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-machine/1ded901c-c918-4b10-91fa-8226eff3ce5c 2025-08-10 21:22:37,708 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-machine-interface/7d5979a8-3895-4eca-980b-9524964698fa 2025-08-10 21:22:40,940 - 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 1024ms') 2025-08-10 21:22:40,940 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2025-08-10 21:22:40,953 - DEBUG - Gateway for vn default-domain:ctest-TestRP-70277359:ctest-bgpaas_vn-20626043 is 135.101.64.1 and allocation pool is NOT set 2025-08-10 21:22:43,017 - 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.28 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.605 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.605/2.444/4.284/1.839 ms') 2025-08-10 21:22:43,017 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2025-08-10 21:22:43,129 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-10 21:22:43,129 - DEBUG - Waiting to SSH to VM test_vm, IP 135.101.64.3, Port 22 2025-08-10 21:22:43,288 - DEBUG - VM test_vm is ready for SSH connections 2025-08-10 21:22:43,288 - INFO - Waiting for VM test2_vm to be up.. 2025-08-10 21:22:43,366 - DEBUG - VM is in ACTIVE state now 2025-08-10 21:22:43,367 - INFO - VM name : test2_vm 2025-08-10 21:22:43,437 - DEBUG - VM test2_vm ID is ab94640d-0d10-44bf-84b0-6911639b031f 2025-08-10 21:22:43,437 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-3790-2 2025-08-10 21:22:43,505 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-machine/ab94640d-0d10-44bf-84b0-6911639b031f 2025-08-10 21:22:43,515 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-machine-interface/6e18320f-0385-4fcf-b3d8-0961cc035631 2025-08-10 21:22:44,705 - 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.72 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.337 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.337/1.530/2.724/1.193 ms') 2025-08-10 21:22:44,705 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2025-08-10 21:22:44,815 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-10 21:22:44,815 - DEBUG - Waiting to SSH to VM test2_vm, IP 73.59.112.67, Port 22 2025-08-10 21:22:44,985 - DEBUG - VM test2_vm is ready for SSH connections 2025-08-10 21:22:45,152 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-10 21:22:45,165 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-70277359:ctest-bgpaas_vn-20626043:ctest-bgpaas_vn-20626043.inet.0 2025-08-10 21:22:45,180 - DEBUG - Requesting: http://10.20.0.17:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-70277359:ctest-bgpaas_vn-20626043:ctest-bgpaas_vn-20626043.inet.0 2025-08-10 21:22:45,191 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-10 21:22:45,191 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 73.59.112.67, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123 2025-08-10 21:22:45,192 - DEBUG - ping -s 56 -c 3 -W 1 73.59.112.67 2025-08-10 21:22:48,828 - DEBUG - PING 73.59.112.67 (73.59.112.67): 56 data bytes 64 bytes from 73.59.112.67: seq=0 ttl=63 time=3.984 ms 64 bytes from 73.59.112.67: seq=1 ttl=63 time=0.703 ms 64 bytes from 73.59.112.67: seq=2 ttl=63 time=0.790 ms --- 73.59.112.67 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 0.703/1.825/3.984 ms 2025-08-10 21:22:48,828 - INFO - Ping to IP 73.59.112.67 from VM test_vm passed 2025-08-10 21:22:48,914 - INFO - Deleting VM test2_vm 2025-08-10 21:22:48,990 - INFO - Deleting VM test_vm 2025-08-10 21:22:49,049 - INFO - Deleting VN ctest-bgpaas_vn-32254763 2025-08-10 21:22:49,089 - DEBUG - VN efcc883d-9d9c-478a-81c4-10a77a446460 still in use: Unable to complete operation on network efcc883d-9d9c-478a-81c4-10a77a446460. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-4ab62145-72f8-45da-957b-e713f196f999'] 2025-08-10 21:22:49,089 - WARNING - Deleting VN ctest-bgpaas_vn-32254763 failed..Will retry 2025-08-10 21:22:51,224 - DEBUG - Response for deleting network () 2025-08-10 21:22:51,224 - INFO - Deleting VN ctest-bgpaas_vn-20626043 2025-08-10 21:22:51,383 - DEBUG - Response for deleting network () 2025-08-10 21:22:52,645 - DEBUG - No XMPP flaps were noticed during the test
2025-08-10 21:22:52,645 - INFO - END TEST : test_rp_interface : PASSED[0:00:26]
2025-08-10 21:22:52,645 - INFO - -------------------------------------------------------------------------------- 2025-08-10 21:22:52,649 - INFO - ================================================================================ 2025-08-10 21:22:52,650 - INFO - STARTING TEST : test_rp_interface_ext_community 2025-08-10 21:22:52,650 - 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-08-10 21:22:53,903 - DEBUG - Nothing to compare xmpp stats {'10.0.0.254': {'10.20.0.25': '0', '10.20.0.17': '0'}, '10.0.0.50': {'10.20.0.25': '0', '10.20.0.17': '0'}} with 2025-08-10 21:22:53,903 - INFO - Initial checks done. Running the testcase now 2025-08-10 21:22:53,903 - INFO - 2025-08-10 21:22:54,172 - DEBUG - Response for create_network : {'network': {'id': '70555f29-bcd7-4584-bcb7-ab13537d6894', 'name': 'ctest-bgpaas_vn-78726785', 'tenant_id': '44569e26189346328f479f2fd0d34de9', 'project_id': '44569e26189346328f479f2fd0d34de9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-70277359', 'ctest-bgpaas_vn-78726785'], 'port_security_enabled': True, 'description': ''}} 2025-08-10 21:22:54,412 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd609420b-539e-4ef9-b81f-6df15788794d', 'name': '', 'tenant_id': '44569e26189346328f479f2fd0d34de9', 'network_id': '70555f29-bcd7-4584-bcb7-ab13537d6894', 'ip_version': 4, 'cidr': '49.61.181.128/26', 'allocation_pools': [{'start': '49.61.181.130', 'end': '49.61.181.190'}], 'gateway_ip': '49.61.181.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '49.61.181.130', 'tags': [], 'project_id': '44569e26189346328f479f2fd0d34de9'}} 2025-08-10 21:22:54,437 - INFO - Created VN ctest-bgpaas_vn-78726785 2025-08-10 21:22:54,448 - DEBUG - VN ctest-bgpaas_vn-78726785 UUID is 70555f29-bcd7-4584-bcb7-ab13537d6894 2025-08-10 21:22:54,943 - DEBUG - Response for create_network : {'network': {'id': '7a4504dc-04e3-404f-8961-524f229037db', 'name': 'ctest-bgpaas_vn-76472034', 'tenant_id': '44569e26189346328f479f2fd0d34de9', 'project_id': '44569e26189346328f479f2fd0d34de9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-70277359', 'ctest-bgpaas_vn-76472034'], 'port_security_enabled': True, 'description': ''}} 2025-08-10 21:22:55,186 - DEBUG - Response for create_subnet : {'subnet': {'id': '3f4d98c5-2cd2-404e-b7cd-c62457d0d1a3', 'name': '', 'tenant_id': '44569e26189346328f479f2fd0d34de9', 'network_id': '7a4504dc-04e3-404f-8961-524f229037db', 'ip_version': 4, 'cidr': '11.246.255.64/26', 'allocation_pools': [{'start': '11.246.255.66', 'end': '11.246.255.126'}], 'gateway_ip': '11.246.255.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '11.246.255.66', 'tags': [], 'project_id': '44569e26189346328f479f2fd0d34de9'}} 2025-08-10 21:22:55,209 - INFO - Created VN ctest-bgpaas_vn-76472034 2025-08-10 21:22:55,219 - DEBUG - VN ctest-bgpaas_vn-76472034 UUID is 7a4504dc-04e3-404f-8961-524f229037db 2025-08-10 21:22:56,464 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3790-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3790-1) 2025-08-10 21:22:57,702 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3790-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3790-2) 2025-08-10 21:22:57,703 - INFO - Waiting for VM test_vm to be up.. 2025-08-10 21:22:57,786 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-08-10 21:23:02,863 - DEBUG - VM is in ACTIVE state now 2025-08-10 21:23:02,864 - INFO - VM name : test_vm 2025-08-10 21:23:02,933 - DEBUG - VM test_vm ID is 30163a97-0d2d-461d-9523-72d53983cc21 2025-08-10 21:23:02,933 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-3790-1 2025-08-10 21:23:02,997 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-machine/30163a97-0d2d-461d-9523-72d53983cc21 2025-08-10 21:23:03,009 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-machine-interface/9c74ce2d-629b-4f07-91a8-a1fd27f078f6 2025-08-10 21:23:06,220 - 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 1016ms') 2025-08-10 21:23:06,220 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2025-08-10 21:23:06,233 - DEBUG - Gateway for vn default-domain:ctest-TestRP-70277359:ctest-bgpaas_vn-78726785 is 49.61.181.129 and allocation pool is NOT set 2025-08-10 21:23:08,289 - 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.89 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.397 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.397/1.645/2.893/1.248 ms') 2025-08-10 21:23:08,290 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2025-08-10 21:23:08,399 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-10 21:23:08,399 - DEBUG - Waiting to SSH to VM test_vm, IP 49.61.181.131, Port 22 2025-08-10 21:23:08,552 - DEBUG - VM test_vm is ready for SSH connections 2025-08-10 21:23:08,553 - INFO - Waiting for VM test2_vm to be up.. 2025-08-10 21:23:08,621 - DEBUG - VM is in ACTIVE state now 2025-08-10 21:23:08,621 - INFO - VM name : test2_vm 2025-08-10 21:23:08,680 - DEBUG - VM test2_vm ID is 056b3016-20d1-4207-8392-048dd12e7603 2025-08-10 21:23:08,680 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-3790-2 2025-08-10 21:23:08,736 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-machine/056b3016-20d1-4207-8392-048dd12e7603 2025-08-10 21:23:08,744 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-machine-interface/efcd939e-469a-471b-be1f-b7a4fd75d7bd 2025-08-10 21:23:09,933 - 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.33 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.264 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.264/1.296/2.329/1.032 ms') 2025-08-10 21:23:09,933 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2025-08-10 21:23:10,043 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-10 21:23:10,044 - DEBUG - Waiting to SSH to VM test2_vm, IP 11.246.255.67, Port 22 2025-08-10 21:23:10,198 - DEBUG - VM test2_vm is ready for SSH connections 2025-08-10 21:23:10,348 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-10 21:23:10,361 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-70277359:ctest-bgpaas_vn-78726785:ctest-bgpaas_vn-78726785.inet.0 2025-08-10 21:23:10,376 - DEBUG - Requesting: http://10.20.0.17:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-70277359:ctest-bgpaas_vn-78726785:ctest-bgpaas_vn-78726785.inet.0 2025-08-10 21:23:10,386 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-10 21:23:10,387 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 11.246.255.67, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123 2025-08-10 21:23:10,387 - DEBUG - ping -s 56 -c 3 -W 1 11.246.255.67 2025-08-10 21:23:14,222 - DEBUG - PING 11.246.255.67 (11.246.255.67): 56 data bytes 64 bytes from 11.246.255.67: seq=0 ttl=63 time=4.462 ms 64 bytes from 11.246.255.67: seq=1 ttl=63 time=0.816 ms 64 bytes from 11.246.255.67: seq=2 ttl=63 time=0.773 ms --- 11.246.255.67 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 0.773/2.017/4.462 ms 2025-08-10 21:23:14,223 - INFO - Ping to IP 11.246.255.67 from VM test_vm passed 2025-08-10 21:23:14,368 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-10 21:23:14,380 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-70277359:ctest-bgpaas_vn-78726785:ctest-bgpaas_vn-78726785.inet.0 2025-08-10 21:23:14,393 - DEBUG - Requesting: http://10.20.0.17:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-70277359:ctest-bgpaas_vn-78726785:ctest-bgpaas_vn-78726785.inet.0 2025-08-10 21:23:14,625 - INFO - Deleting VM test2_vm 2025-08-10 21:23:14,682 - INFO - Deleting VM test_vm 2025-08-10 21:23:14,735 - INFO - Deleting VN ctest-bgpaas_vn-76472034 2025-08-10 21:23:14,770 - DEBUG - VN 7a4504dc-04e3-404f-8961-524f229037db still in use: Unable to complete operation on network 7a4504dc-04e3-404f-8961-524f229037db. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-d2497ffc-a6cd-4ec2-9722-53402f690bb6'] 2025-08-10 21:23:14,770 - WARNING - Deleting VN ctest-bgpaas_vn-76472034 failed..Will retry 2025-08-10 21:23:16,903 - DEBUG - Response for deleting network () 2025-08-10 21:23:16,903 - INFO - Deleting VN ctest-bgpaas_vn-78726785 2025-08-10 21:23:17,061 - DEBUG - Response for deleting network () 2025-08-10 21:23:18,306 - DEBUG - No XMPP flaps were noticed during the test
2025-08-10 21:23:18,306 - INFO - END TEST : test_rp_interface_ext_community : PASSED[0:00:26]
2025-08-10 21:23:18,306 - INFO - -------------------------------------------------------------------------------- 2025-08-10 21:23:18,309 - INFO - ================================================================================ 2025-08-10 21:23:18,309 - INFO - STARTING TEST : test_rp_interface_static 2025-08-10 21:23:18,310 - 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-08-10 21:23:19,554 - DEBUG - Nothing to compare xmpp stats {'10.0.0.254': {'10.20.0.25': '0', '10.20.0.17': '0'}, '10.0.0.50': {'10.20.0.25': '0', '10.20.0.17': '0'}} with 2025-08-10 21:23:19,555 - INFO - Initial checks done. Running the testcase now 2025-08-10 21:23:19,555 - INFO - 2025-08-10 21:23:19,770 - DEBUG - Response for create_network : {'network': {'id': '0c3ab7d5-9a37-470c-aab1-f2bcb8b227df', 'name': 'ctest-bgpaas_vn-81661063', 'tenant_id': '44569e26189346328f479f2fd0d34de9', 'project_id': '44569e26189346328f479f2fd0d34de9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-70277359', 'ctest-bgpaas_vn-81661063'], 'port_security_enabled': True, 'description': ''}} 2025-08-10 21:23:19,951 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e47fc5aa-0dbb-43f3-97b1-6586fbb4e45e', 'name': '', 'tenant_id': '44569e26189346328f479f2fd0d34de9', 'network_id': '0c3ab7d5-9a37-470c-aab1-f2bcb8b227df', 'ip_version': 4, 'cidr': '145.112.192.128/26', 'allocation_pools': [{'start': '145.112.192.130', 'end': '145.112.192.190'}], 'gateway_ip': '145.112.192.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '145.112.192.130', 'tags': [], 'project_id': '44569e26189346328f479f2fd0d34de9'}} 2025-08-10 21:23:19,987 - INFO - Created VN ctest-bgpaas_vn-81661063 2025-08-10 21:23:19,998 - DEBUG - VN ctest-bgpaas_vn-81661063 UUID is 0c3ab7d5-9a37-470c-aab1-f2bcb8b227df 2025-08-10 21:23:20,526 - DEBUG - Response for create_network : {'network': {'id': '3187a116-4e80-4347-86ba-e6c0a6f753b1', 'name': 'ctest-bgpaas_vn-45588876', 'tenant_id': '44569e26189346328f479f2fd0d34de9', 'project_id': '44569e26189346328f479f2fd0d34de9', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-70277359', 'ctest-bgpaas_vn-45588876'], 'port_security_enabled': True, 'description': ''}} 2025-08-10 21:23:20,761 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a3fbd680-f44b-498d-8fdb-dfd2020f1492', 'name': '', 'tenant_id': '44569e26189346328f479f2fd0d34de9', 'network_id': '3187a116-4e80-4347-86ba-e6c0a6f753b1', 'ip_version': 4, 'cidr': '69.145.200.64/26', 'allocation_pools': [{'start': '69.145.200.66', 'end': '69.145.200.126'}], 'gateway_ip': '69.145.200.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '69.145.200.66', 'tags': [], 'project_id': '44569e26189346328f479f2fd0d34de9'}} 2025-08-10 21:23:20,782 - INFO - Created VN ctest-bgpaas_vn-45588876 2025-08-10 21:23:20,792 - DEBUG - VN ctest-bgpaas_vn-45588876 UUID is 3187a116-4e80-4347-86ba-e6c0a6f753b1 2025-08-10 21:23:22,030 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3790-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3790-1) 2025-08-10 21:23:23,289 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-3790-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-3790-2) 2025-08-10 21:23:23,289 - INFO - Waiting for VM test_vm to be up.. 2025-08-10 21:23:23,366 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-08-10 21:23:28,434 - DEBUG - VM is in ACTIVE state now 2025-08-10 21:23:28,434 - INFO - VM name : test_vm 2025-08-10 21:23:28,493 - DEBUG - VM test_vm ID is 487c15e7-da6a-497a-8ff2-225cfb858e56 2025-08-10 21:23:28,493 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-3790-1 2025-08-10 21:23:28,569 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-machine/487c15e7-da6a-497a-8ff2-225cfb858e56 2025-08-10 21:23:28,577 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-machine-interface/5beee8e6-c27d-4275-8ad2-fca175ef1b6c 2025-08-10 21:23:31,785 - 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-08-10 21:23:31,785 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2025-08-10 21:23:31,797 - DEBUG - Gateway for vn default-domain:ctest-TestRP-70277359:ctest-bgpaas_vn-81661063 is 145.112.192.129 and allocation pool is NOT set 2025-08-10 21:23:33,858 - 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.47 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.389 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.389/1.928/3.468/1.539 ms') 2025-08-10 21:23:33,858 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2025-08-10 21:23:33,966 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-10 21:23:33,967 - DEBUG - Waiting to SSH to VM test_vm, IP 145.112.192.131, Port 22 2025-08-10 21:23:34,116 - DEBUG - VM test_vm is ready for SSH connections 2025-08-10 21:23:34,117 - INFO - Waiting for VM test2_vm to be up.. 2025-08-10 21:23:34,185 - DEBUG - VM is in ACTIVE state now 2025-08-10 21:23:34,185 - INFO - VM name : test2_vm 2025-08-10 21:23:34,246 - DEBUG - VM test2_vm ID is 0719ea56-4910-4da5-ba4b-f915d01cd080 2025-08-10 21:23:34,246 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-3790-2 2025-08-10 21:23:34,309 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-machine/0719ea56-4910-4da5-ba4b-f915d01cd080 2025-08-10 21:23:34,316 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-machine-interface/f2550e37-a87b-4eab-adcc-00c11b44773d 2025-08-10 21:23:35,515 - 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.39 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.637 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.637/2.011/3.386/1.374 ms') 2025-08-10 21:23:35,515 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2025-08-10 21:23:35,623 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-10 21:23:35,623 - DEBUG - Waiting to SSH to VM test2_vm, IP 69.145.200.67, Port 22 2025-08-10 21:23:35,774 - DEBUG - VM test2_vm is ready for SSH connections 2025-08-10 21:23:35,856 - INFO - Created InterfaceRouteTable ['default-domain', 'ctest-TestRP-70277359', 'ctest-int_table_right-66263436'](UUID cd7274f8-d04b-4efa-9099-6f3c4bc9f003), prefixes : ['74.158.41.128/26'] 2025-08-10 21:23:35,920 - INFO - Added intf route table cd7274f8-d04b-4efa-9099-6f3c4bc9f003 to port 5beee8e6-c27d-4275-8ad2-fca175ef1b6c 2025-08-10 21:23:36,096 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-70277359:ctest-bgpaas_vn-81661063:ctest-bgpaas_vn-81661063.inet.0 2025-08-10 21:23:36,112 - DEBUG - Requesting: http://10.20.0.17:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-70277359:ctest-bgpaas_vn-81661063:ctest-bgpaas_vn-81661063.inet.0 2025-08-10 21:23:36,126 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-10 21:23:36,126 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 69.145.200.67, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123 2025-08-10 21:23:36,126 - DEBUG - ping -s 56 -c 3 -W 1 69.145.200.67 2025-08-10 21:23:39,740 - DEBUG - PING 69.145.200.67 (69.145.200.67): 56 data bytes 64 bytes from 69.145.200.67: seq=0 ttl=63 time=5.226 ms 64 bytes from 69.145.200.67: seq=1 ttl=63 time=0.845 ms 64 bytes from 69.145.200.67: seq=2 ttl=63 time=0.800 ms --- 69.145.200.67 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 0.800/2.290/5.226 ms 2025-08-10 21:23:39,740 - INFO - Ping to IP 69.145.200.67 from VM test_vm passed 2025-08-10 21:23:39,845 - INFO - Deleting VM test2_vm 2025-08-10 21:23:39,906 - INFO - Deleting VM test_vm 2025-08-10 21:23:39,963 - INFO - Deleting VN ctest-bgpaas_vn-45588876 2025-08-10 21:23:40,003 - DEBUG - VN 3187a116-4e80-4347-86ba-e6c0a6f753b1 still in use: Unable to complete operation on network 3187a116-4e80-4347-86ba-e6c0a6f753b1. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-719ee951-02f9-4eeb-b5a9-044d3d23ac73'] 2025-08-10 21:23:40,004 - WARNING - Deleting VN ctest-bgpaas_vn-45588876 failed..Will retry 2025-08-10 21:23:42,142 - DEBUG - Response for deleting network () 2025-08-10 21:23:42,142 - INFO - Deleting VN ctest-bgpaas_vn-81661063 2025-08-10 21:23:42,274 - DEBUG - Response for deleting network () 2025-08-10 21:23:43,526 - DEBUG - No XMPP flaps were noticed during the test
2025-08-10 21:23:43,526 - INFO - END TEST : test_rp_interface_static : PASSED[0:00:25]
2025-08-10 21:23:43,526 - INFO - -------------------------------------------------------------------------------- 2025-08-10 21:23:44,196 - INFO - Deleted project: ctest-TestRP-70277359, ID : 44569e26-1893-4632-8f47-9f2fd0d34de9