2025-10-08 14:05:31,981 - INFO - Domain Default found not creating 2025-10-08 14:05:32,114 - INFO - Project ctest-TestRP-22417355 not found, creating it 2025-10-08 14:05:32,658 - INFO - Created Project:ctest-TestRP-22417355, ID : 99cf55b3-13e1-4c44-9e2e-f0008cf69508 2025-10-08 14:05:34,087 - DEBUG - Services list from nova: [, , , ] 2025-10-08 14:05:34,087 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-4234-2', 'an-jenkins-deploy-platform-ansible-os-4234-1']} 2025-10-08 14:05:34,090 - INFO - ================================================================================ 2025-10-08 14:05:34,090 - INFO - STARTING TEST : test_rp_interface 2025-10-08 14:05:34,090 - 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-10-08 14:05:35,386 - DEBUG - Nothing to compare xmpp stats {'10.0.0.130': {'10.20.0.25': '0', '10.20.0.14': '0'}, '10.0.0.131': {'10.20.0.14': '0', '10.20.0.25': '0'}} with 2025-10-08 14:05:35,386 - INFO - Initial checks done. Running the testcase now 2025-10-08 14:05:35,387 - INFO - 2025-10-08 14:05:36,216 - DEBUG - Response for create_network : {'network': {'id': '6207d076-603f-4be6-9bd9-cef9378e4b75', 'name': 'ctest-bgpaas_vn-88126179', 'tenant_id': '99cf55b313e14c449e2ef0008cf69508', 'project_id': '99cf55b313e14c449e2ef0008cf69508', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-22417355', 'ctest-bgpaas_vn-88126179'], 'port_security_enabled': True, 'description': ''}} 2025-10-08 14:05:36,523 - DEBUG - Response for create_subnet : {'subnet': {'id': '5c02c4d4-7ead-4785-a75f-33de6edd63f0', 'name': '', 'tenant_id': '99cf55b313e14c449e2ef0008cf69508', 'network_id': '6207d076-603f-4be6-9bd9-cef9378e4b75', 'ip_version': 4, 'cidr': '81.214.119.64/26', 'allocation_pools': [{'start': '81.214.119.66', 'end': '81.214.119.126'}], 'gateway_ip': '81.214.119.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '81.214.119.66', 'tags': [], 'project_id': '99cf55b313e14c449e2ef0008cf69508'}} 2025-10-08 14:05:36,544 - INFO - Created VN ctest-bgpaas_vn-88126179 2025-10-08 14:05:36,555 - DEBUG - VN ctest-bgpaas_vn-88126179 UUID is 6207d076-603f-4be6-9bd9-cef9378e4b75 2025-10-08 14:05:37,088 - DEBUG - Response for create_network : {'network': {'id': '8fefa858-11c4-487b-b77d-44f183614b90', 'name': 'ctest-bgpaas_vn-30983425', 'tenant_id': '99cf55b313e14c449e2ef0008cf69508', 'project_id': '99cf55b313e14c449e2ef0008cf69508', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-22417355', 'ctest-bgpaas_vn-30983425'], 'port_security_enabled': True, 'description': ''}} 2025-10-08 14:05:37,361 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ab671b69-9398-42d4-aa64-2019647c80c8', 'name': '', 'tenant_id': '99cf55b313e14c449e2ef0008cf69508', 'network_id': '8fefa858-11c4-487b-b77d-44f183614b90', 'ip_version': 4, 'cidr': '212.133.134.192/26', 'allocation_pools': [{'start': '212.133.134.194', 'end': '212.133.134.254'}], 'gateway_ip': '212.133.134.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '212.133.134.194', 'tags': [], 'project_id': '99cf55b313e14c449e2ef0008cf69508'}} 2025-10-08 14:05:37,381 - INFO - Created VN ctest-bgpaas_vn-30983425 2025-10-08 14:05:37,394 - DEBUG - VN ctest-bgpaas_vn-30983425 UUID is 8fefa858-11c4-487b-b77d-44f183614b90 2025-10-08 14:05:38,759 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4234-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4234-2) 2025-10-08 14:05:40,158 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4234-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4234-1) 2025-10-08 14:05:40,158 - INFO - Waiting for VM test_vm to be up.. 2025-10-08 14:05:40,275 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-10-08 14:05:45,370 - DEBUG - VM is in ACTIVE state now 2025-10-08 14:05:45,370 - INFO - VM name : test_vm 2025-10-08 14:05:45,460 - DEBUG - VM test_vm ID is 9bf384f9-0d36-4cc0-b947-69321ad42bb4 2025-10-08 14:05:45,485 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-4234-2 2025-10-08 14:05:45,568 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/9bf384f9-0d36-4cc0-b947-69321ad42bb4 2025-10-08 14:05:45,861 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/9bf384f9-0d36-4cc0-b947-69321ad42bb4 2025-10-08 14:05:45,893 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine-interface/084022d2-ee98-4a78-8514-a57e199fe28a 2025-10-08 14:05:49,086 - 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') 2025-10-08 14:05:49,086 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2025-10-08 14:05:49,099 - DEBUG - Gateway for vn default-domain:ctest-TestRP-22417355:ctest-bgpaas_vn-88126179 is 81.214.119.65 and allocation pool is NOT set 2025-10-08 14:05:51,173 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=8.67 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.484 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.484/4.579/8.674/4.095 ms') 2025-10-08 14:05:51,173 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2025-10-08 14:05:51,241 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-08 14:05:51,241 - DEBUG - Waiting to SSH to VM test_vm, IP 81.214.119.67, Port 22 2025-10-08 14:05:51,411 - DEBUG - VM test_vm is ready for SSH connections 2025-10-08 14:05:51,412 - INFO - Waiting for VM test2_vm to be up.. 2025-10-08 14:05:51,487 - DEBUG - VM is in ACTIVE state now 2025-10-08 14:05:51,487 - INFO - VM name : test2_vm 2025-10-08 14:05:51,558 - DEBUG - VM test2_vm ID is 191b03d0-7bd1-4134-9186-a6e71870d64b 2025-10-08 14:05:51,559 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-4234-1 2025-10-08 14:05:51,630 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/191b03d0-7bd1-4134-9186-a6e71870d64b 2025-10-08 14:05:51,640 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine-interface/804304a7-9dc1-4577-b082-cdc68d7a9e3b 2025-10-08 14:05:52,806 - 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.00 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.916 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.916/2.459/4.003/1.543 ms') 2025-10-08 14:05:52,807 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2025-10-08 14:05:52,871 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-08 14:05:52,871 - DEBUG - Waiting to SSH to VM test2_vm, IP 212.133.134.195, Port 22 2025-10-08 14:05:53,040 - DEBUG - VM test2_vm is ready for SSH connections 2025-10-08 14:05:53,171 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-08 14:05:53,183 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-22417355:ctest-bgpaas_vn-88126179:ctest-bgpaas_vn-88126179.inet.0 2025-10-08 14:05:53,195 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-22417355:ctest-bgpaas_vn-88126179:ctest-bgpaas_vn-88126179.inet.0 2025-10-08 14:05:53,210 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-08 14:05:53,210 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 212.133.134.195, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.131, gateway password: c0ntrail123 2025-10-08 14:05:53,210 - DEBUG - ping -s 56 -c 3 -W 1 212.133.134.195 2025-10-08 14:05:57,245 - DEBUG - PING 212.133.134.195 (212.133.134.195): 56 data bytes 64 bytes from 212.133.134.195: seq=0 ttl=63 time=8.305 ms 64 bytes from 212.133.134.195: seq=1 ttl=63 time=1.297 ms 64 bytes from 212.133.134.195: seq=2 ttl=63 time=1.778 ms --- 212.133.134.195 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.297/3.793/8.305 ms 2025-10-08 14:05:57,245 - INFO - Ping to IP 212.133.134.195 from VM test_vm passed 2025-10-08 14:05:57,352 - INFO - Deleting VM test2_vm 2025-10-08 14:05:57,416 - INFO - Deleting VM test_vm 2025-10-08 14:05:57,484 - INFO - Deleting VN ctest-bgpaas_vn-30983425 2025-10-08 14:05:57,524 - DEBUG - VN 8fefa858-11c4-487b-b77d-44f183614b90 still in use: Unable to complete operation on network 8fefa858-11c4-487b-b77d-44f183614b90. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-a4af1550-6ed4-49a9-b9d2-6c8a4b5f325d'] 2025-10-08 14:05:57,524 - WARNING - Deleting VN ctest-bgpaas_vn-30983425 failed..Will retry 2025-10-08 14:05:59,684 - DEBUG - Response for deleting network () 2025-10-08 14:05:59,684 - INFO - Deleting VN ctest-bgpaas_vn-88126179 2025-10-08 14:05:59,882 - DEBUG - Response for deleting network () 2025-10-08 14:06:01,179 - DEBUG - No XMPP flaps were noticed during the test
2025-10-08 14:06:01,179 - INFO - END TEST : test_rp_interface : PASSED[0:00:27]
2025-10-08 14:06:01,179 - INFO - -------------------------------------------------------------------------------- 2025-10-08 14:06:01,183 - INFO - ================================================================================ 2025-10-08 14:06:01,183 - INFO - STARTING TEST : test_rp_interface_ext_community 2025-10-08 14:06:01,183 - 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-10-08 14:06:02,492 - DEBUG - Nothing to compare xmpp stats {'10.0.0.130': {'10.20.0.25': '0', '10.20.0.14': '0'}, '10.0.0.131': {'10.20.0.14': '0', '10.20.0.25': '0'}} with 2025-10-08 14:06:02,493 - INFO - Initial checks done. Running the testcase now 2025-10-08 14:06:02,493 - INFO - 2025-10-08 14:06:02,777 - DEBUG - Response for create_network : {'network': {'id': '987c9d3e-3a02-4886-bb73-c5d697fd7728', 'name': 'ctest-bgpaas_vn-92166768', 'tenant_id': '99cf55b313e14c449e2ef0008cf69508', 'project_id': '99cf55b313e14c449e2ef0008cf69508', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-22417355', 'ctest-bgpaas_vn-92166768'], 'port_security_enabled': True, 'description': ''}} 2025-10-08 14:06:03,055 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ce089632-2586-4994-9b02-4e74813f9627', 'name': '', 'tenant_id': '99cf55b313e14c449e2ef0008cf69508', 'network_id': '987c9d3e-3a02-4886-bb73-c5d697fd7728', 'ip_version': 4, 'cidr': '116.174.255.64/26', 'allocation_pools': [{'start': '116.174.255.66', 'end': '116.174.255.126'}], 'gateway_ip': '116.174.255.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '116.174.255.66', 'tags': [], 'project_id': '99cf55b313e14c449e2ef0008cf69508'}} 2025-10-08 14:06:03,076 - INFO - Created VN ctest-bgpaas_vn-92166768 2025-10-08 14:06:03,088 - DEBUG - VN ctest-bgpaas_vn-92166768 UUID is 987c9d3e-3a02-4886-bb73-c5d697fd7728 2025-10-08 14:06:03,653 - DEBUG - Response for create_network : {'network': {'id': '11d492d7-ff57-4f4d-8568-f1ab1f8d6dec', 'name': 'ctest-bgpaas_vn-27692608', 'tenant_id': '99cf55b313e14c449e2ef0008cf69508', 'project_id': '99cf55b313e14c449e2ef0008cf69508', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-22417355', 'ctest-bgpaas_vn-27692608'], 'port_security_enabled': True, 'description': ''}} 2025-10-08 14:06:03,919 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a652dc36-1ec9-4ef7-85ef-16c4094a70d8', 'name': '', 'tenant_id': '99cf55b313e14c449e2ef0008cf69508', 'network_id': '11d492d7-ff57-4f4d-8568-f1ab1f8d6dec', 'ip_version': 4, 'cidr': '20.88.77.64/26', 'allocation_pools': [{'start': '20.88.77.66', 'end': '20.88.77.126'}], 'gateway_ip': '20.88.77.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '20.88.77.66', 'tags': [], 'project_id': '99cf55b313e14c449e2ef0008cf69508'}} 2025-10-08 14:06:03,942 - INFO - Created VN ctest-bgpaas_vn-27692608 2025-10-08 14:06:03,953 - DEBUG - VN ctest-bgpaas_vn-27692608 UUID is 11d492d7-ff57-4f4d-8568-f1ab1f8d6dec 2025-10-08 14:06:05,412 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4234-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4234-2) 2025-10-08 14:06:06,671 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4234-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4234-1) 2025-10-08 14:06:06,671 - INFO - Waiting for VM test_vm to be up.. 2025-10-08 14:06:06,754 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-10-08 14:06:11,828 - DEBUG - VM is in ACTIVE state now 2025-10-08 14:06:11,828 - INFO - VM name : test_vm 2025-10-08 14:06:11,897 - DEBUG - VM test_vm ID is 0ac64dfa-7af3-4540-90ca-3b4895cdc2e7 2025-10-08 14:06:11,898 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-4234-2 2025-10-08 14:06:11,973 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/0ac64dfa-7af3-4540-90ca-3b4895cdc2e7 2025-10-08 14:06:11,982 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine-interface/53294bee-5ad2-4d22-9b8d-4f338fde2e7d 2025-10-08 14:06:15,135 - 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 1007ms') 2025-10-08 14:06:15,135 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2025-10-08 14:06:15,148 - DEBUG - Gateway for vn default-domain:ctest-TestRP-22417355:ctest-bgpaas_vn-92166768 is 116.174.255.65 and allocation pool is NOT set 2025-10-08 14:06:17,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.05 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=3.79 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 3.789/4.421/5.053/0.632 ms') 2025-10-08 14:06:17,219 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2025-10-08 14:06:17,283 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-08 14:06:17,283 - DEBUG - Waiting to SSH to VM test_vm, IP 116.174.255.67, Port 22 2025-10-08 14:06:17,452 - DEBUG - VM test_vm is ready for SSH connections 2025-10-08 14:06:17,452 - INFO - Waiting for VM test2_vm to be up.. 2025-10-08 14:06:17,548 - DEBUG - VM is in ACTIVE state now 2025-10-08 14:06:17,549 - INFO - VM name : test2_vm 2025-10-08 14:06:17,629 - DEBUG - VM test2_vm ID is be631ebc-9ef0-4dcc-b4e0-ca68d559bbd9 2025-10-08 14:06:17,629 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-4234-1 2025-10-08 14:06:17,701 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/be631ebc-9ef0-4dcc-b4e0-ca68d559bbd9 2025-10-08 14:06:17,710 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine-interface/4dfb6609-5c81-4f17-b690-77e46a85721e 2025-10-08 14:06:18,885 - 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.72 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=3.24 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 = 3.239/3.977/4.715/0.738 ms') 2025-10-08 14:06:18,885 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2025-10-08 14:06:18,951 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-08 14:06:18,951 - DEBUG - Waiting to SSH to VM test2_vm, IP 20.88.77.67, Port 22 2025-10-08 14:06:19,139 - DEBUG - VM test2_vm is ready for SSH connections 2025-10-08 14:06:19,283 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-08 14:06:19,308 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-22417355:ctest-bgpaas_vn-92166768:ctest-bgpaas_vn-92166768.inet.0 2025-10-08 14:06:19,320 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-22417355:ctest-bgpaas_vn-92166768:ctest-bgpaas_vn-92166768.inet.0 2025-10-08 14:06:19,333 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-08 14:06:19,334 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 20.88.77.67, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.131, gateway password: c0ntrail123 2025-10-08 14:06:19,334 - DEBUG - ping -s 56 -c 3 -W 1 20.88.77.67 2025-10-08 14:06:23,067 - DEBUG - PING 20.88.77.67 (20.88.77.67): 56 data bytes 64 bytes from 20.88.77.67: seq=0 ttl=63 time=6.286 ms 64 bytes from 20.88.77.67: seq=1 ttl=63 time=1.473 ms 64 bytes from 20.88.77.67: seq=2 ttl=63 time=1.196 ms --- 20.88.77.67 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.196/2.985/6.286 ms 2025-10-08 14:06:23,067 - INFO - Ping to IP 20.88.77.67 from VM test_vm passed 2025-10-08 14:06:23,216 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-08 14:06:23,231 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-22417355:ctest-bgpaas_vn-92166768:ctest-bgpaas_vn-92166768.inet.0 2025-10-08 14:06:23,242 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-22417355:ctest-bgpaas_vn-92166768:ctest-bgpaas_vn-92166768.inet.0 2025-10-08 14:06:23,483 - INFO - Deleting VM test2_vm 2025-10-08 14:06:23,588 - INFO - Deleting VM test_vm 2025-10-08 14:06:23,668 - INFO - Deleting VN ctest-bgpaas_vn-27692608 2025-10-08 14:06:23,722 - DEBUG - VN 11d492d7-ff57-4f4d-8568-f1ab1f8d6dec still in use: Unable to complete operation on network 11d492d7-ff57-4f4d-8568-f1ab1f8d6dec. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-181fe6e2-2b95-4c13-b7dc-4cba366f1ef8'] 2025-10-08 14:06:23,722 - WARNING - Deleting VN ctest-bgpaas_vn-27692608 failed..Will retry 2025-10-08 14:06:25,890 - DEBUG - Response for deleting network () 2025-10-08 14:06:25,890 - INFO - Deleting VN ctest-bgpaas_vn-92166768 2025-10-08 14:06:26,077 - DEBUG - Response for deleting network () 2025-10-08 14:06:27,342 - DEBUG - No XMPP flaps were noticed during the test
2025-10-08 14:06:27,343 - INFO - END TEST : test_rp_interface_ext_community : PASSED[0:00:26]
2025-10-08 14:06:27,343 - INFO - -------------------------------------------------------------------------------- 2025-10-08 14:06:27,346 - INFO - ================================================================================ 2025-10-08 14:06:27,346 - INFO - STARTING TEST : test_rp_interface_static 2025-10-08 14:06:27,346 - 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-10-08 14:06:28,638 - DEBUG - Nothing to compare xmpp stats {'10.0.0.130': {'10.20.0.25': '0', '10.20.0.14': '0'}, '10.0.0.131': {'10.20.0.14': '0', '10.20.0.25': '0'}} with 2025-10-08 14:06:28,638 - INFO - Initial checks done. Running the testcase now 2025-10-08 14:06:28,638 - INFO - 2025-10-08 14:06:28,910 - DEBUG - Response for create_network : {'network': {'id': '23f5e5c4-c8a0-44b5-9462-4f6583081cb8', 'name': 'ctest-bgpaas_vn-41670241', 'tenant_id': '99cf55b313e14c449e2ef0008cf69508', 'project_id': '99cf55b313e14c449e2ef0008cf69508', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-22417355', 'ctest-bgpaas_vn-41670241'], 'port_security_enabled': True, 'description': ''}} 2025-10-08 14:06:29,138 - DEBUG - Response for create_subnet : {'subnet': {'id': '0af5d968-bc39-4c8d-b83b-6fe5e331d8b5', 'name': '', 'tenant_id': '99cf55b313e14c449e2ef0008cf69508', 'network_id': '23f5e5c4-c8a0-44b5-9462-4f6583081cb8', 'ip_version': 4, 'cidr': '165.177.150.192/26', 'allocation_pools': [{'start': '165.177.150.194', 'end': '165.177.150.254'}], 'gateway_ip': '165.177.150.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '165.177.150.194', 'tags': [], 'project_id': '99cf55b313e14c449e2ef0008cf69508'}} 2025-10-08 14:06:29,160 - INFO - Created VN ctest-bgpaas_vn-41670241 2025-10-08 14:06:29,171 - DEBUG - VN ctest-bgpaas_vn-41670241 UUID is 23f5e5c4-c8a0-44b5-9462-4f6583081cb8 2025-10-08 14:06:29,668 - DEBUG - Response for create_network : {'network': {'id': '88c90cd9-6dca-4067-a1ba-110e62752a28', 'name': 'ctest-bgpaas_vn-84262285', 'tenant_id': '99cf55b313e14c449e2ef0008cf69508', 'project_id': '99cf55b313e14c449e2ef0008cf69508', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-22417355', 'ctest-bgpaas_vn-84262285'], 'port_security_enabled': True, 'description': ''}} 2025-10-08 14:06:29,870 - DEBUG - Response for create_subnet : {'subnet': {'id': '8b604fee-1b45-4089-9cad-d3a114ae1a54', 'name': '', 'tenant_id': '99cf55b313e14c449e2ef0008cf69508', 'network_id': '88c90cd9-6dca-4067-a1ba-110e62752a28', 'ip_version': 4, 'cidr': '1.70.252.64/26', 'allocation_pools': [{'start': '1.70.252.66', 'end': '1.70.252.126'}], 'gateway_ip': '1.70.252.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '1.70.252.66', 'tags': [], 'project_id': '99cf55b313e14c449e2ef0008cf69508'}} 2025-10-08 14:06:29,892 - INFO - Created VN ctest-bgpaas_vn-84262285 2025-10-08 14:06:29,903 - DEBUG - VN ctest-bgpaas_vn-84262285 UUID is 88c90cd9-6dca-4067-a1ba-110e62752a28 2025-10-08 14:06:31,173 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4234-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4234-2) 2025-10-08 14:06:32,470 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4234-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4234-1) 2025-10-08 14:06:32,470 - INFO - Waiting for VM test_vm to be up.. 2025-10-08 14:06:32,565 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-10-08 14:06:37,665 - DEBUG - VM is in ACTIVE state now 2025-10-08 14:06:37,665 - INFO - VM name : test_vm 2025-10-08 14:06:37,774 - DEBUG - VM test_vm ID is c0cf9406-5e95-485b-9560-1c4e9bf3779b 2025-10-08 14:06:37,774 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-4234-2 2025-10-08 14:06:37,854 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/c0cf9406-5e95-485b-9560-1c4e9bf3779b 2025-10-08 14:06:37,865 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine-interface/f3c09a27-5c0e-4836-adee-6ff555ad4a76 2025-10-08 14:06:41,053 - 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 1030ms') 2025-10-08 14:06:41,053 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2025-10-08 14:06:41,066 - DEBUG - Gateway for vn default-domain:ctest-TestRP-22417355:ctest-bgpaas_vn-41670241 is 165.177.150.193 and allocation pool is NOT set 2025-10-08 14:06:43,127 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=8.78 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.290 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.290/4.534/8.778/4.244 ms') 2025-10-08 14:06:43,127 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2025-10-08 14:06:43,196 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-08 14:06:43,196 - DEBUG - Waiting to SSH to VM test_vm, IP 165.177.150.195, Port 22 2025-10-08 14:06:43,363 - DEBUG - VM test_vm is ready for SSH connections 2025-10-08 14:06:43,363 - INFO - Waiting for VM test2_vm to be up.. 2025-10-08 14:06:43,473 - DEBUG - VM is in ACTIVE state now 2025-10-08 14:06:43,473 - INFO - VM name : test2_vm 2025-10-08 14:06:43,549 - DEBUG - VM test2_vm ID is 91cf10d8-134c-45e0-8a2a-1461d2c6ca6c 2025-10-08 14:06:43,549 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-4234-1 2025-10-08 14:06:43,623 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/91cf10d8-134c-45e0-8a2a-1461d2c6ca6c 2025-10-08 14:06:43,632 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine-interface/ad75ba36-ab97-4b2f-96fb-fb5bc81adf1e 2025-10-08 14:06:44,807 - 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.81 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.525 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.525/2.165/3.806/1.640 ms') 2025-10-08 14:06:44,807 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2025-10-08 14:06:44,876 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-08 14:06:44,876 - DEBUG - Waiting to SSH to VM test2_vm, IP 1.70.252.67, Port 22 2025-10-08 14:06:45,049 - DEBUG - VM test2_vm is ready for SSH connections 2025-10-08 14:06:45,139 - INFO - Created InterfaceRouteTable ['default-domain', 'ctest-TestRP-22417355', 'ctest-int_table_right-13308791'](UUID 37eb8e90-f788-4571-b536-fff51529cebe), prefixes : ['96.148.71.192/26'] 2025-10-08 14:06:45,207 - INFO - Added intf route table 37eb8e90-f788-4571-b536-fff51529cebe to port f3c09a27-5c0e-4836-adee-6ff555ad4a76 2025-10-08 14:06:45,409 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-22417355:ctest-bgpaas_vn-41670241:ctest-bgpaas_vn-41670241.inet.0 2025-10-08 14:06:45,422 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-22417355:ctest-bgpaas_vn-41670241:ctest-bgpaas_vn-41670241.inet.0 2025-10-08 14:06:45,435 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-08 14:06:45,435 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 1.70.252.67, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.131, gateway password: c0ntrail123 2025-10-08 14:06:45,435 - DEBUG - ping -s 56 -c 3 -W 1 1.70.252.67 2025-10-08 14:06:49,168 - DEBUG - PING 1.70.252.67 (1.70.252.67): 56 data bytes 64 bytes from 1.70.252.67: seq=0 ttl=63 time=8.662 ms 64 bytes from 1.70.252.67: seq=1 ttl=63 time=1.407 ms 64 bytes from 1.70.252.67: seq=2 ttl=63 time=1.785 ms --- 1.70.252.67 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.407/3.951/8.662 ms 2025-10-08 14:06:49,168 - INFO - Ping to IP 1.70.252.67 from VM test_vm passed 2025-10-08 14:06:49,296 - INFO - Deleting VM test2_vm 2025-10-08 14:06:49,363 - INFO - Deleting VM test_vm 2025-10-08 14:06:49,421 - INFO - Deleting VN ctest-bgpaas_vn-84262285 2025-10-08 14:06:49,456 - DEBUG - VN 88c90cd9-6dca-4067-a1ba-110e62752a28 still in use: Unable to complete operation on network 88c90cd9-6dca-4067-a1ba-110e62752a28. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-f2411172-2c38-47dd-b3e6-61c93b2afa42'] 2025-10-08 14:06:49,456 - WARNING - Deleting VN ctest-bgpaas_vn-84262285 failed..Will retry 2025-10-08 14:06:51,613 - DEBUG - Response for deleting network () 2025-10-08 14:06:51,613 - INFO - Deleting VN ctest-bgpaas_vn-41670241 2025-10-08 14:06:51,793 - DEBUG - Response for deleting network () 2025-10-08 14:06:53,080 - DEBUG - No XMPP flaps were noticed during the test
2025-10-08 14:06:53,080 - INFO - END TEST : test_rp_interface_static : PASSED[0:00:26]
2025-10-08 14:06:53,080 - INFO - -------------------------------------------------------------------------------- 2025-10-08 14:06:53,766 - INFO - Deleted project: ctest-TestRP-22417355, ID : 99cf55b3-13e1-4c44-9e2e-f0008cf69508