2025-10-06 02:30:34,461 - INFO - Domain Default found not creating 2025-10-06 02:30:34,600 - INFO - Project ctest-TestRP-37593964 not found, creating it 2025-10-06 02:30:35,143 - INFO - Created Project:ctest-TestRP-37593964, ID : d33076a9-f2b8-4a9a-9a76-ef196b32e181 2025-10-06 02:30:36,832 - DEBUG - Services list from nova: [, , , ] 2025-10-06 02:30:36,832 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-4219-1', 'an-jenkins-deploy-platform-ansible-os-4219-2']} 2025-10-06 02:30:36,834 - INFO - ================================================================================ 2025-10-06 02:30:36,834 - INFO - STARTING TEST : test_rp_interface 2025-10-06 02:30:36,834 - 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-06 02:30:38,103 - DEBUG - Nothing to compare xmpp stats {'10.0.0.49': {'10.20.0.193': '0', '10.20.0.25': '0'}, '10.0.0.19': {'10.20.0.25': '0', '10.20.0.17': '0'}} with 2025-10-06 02:30:38,104 - INFO - Initial checks done. Running the testcase now 2025-10-06 02:30:38,104 - INFO - 2025-10-06 02:30:38,749 - DEBUG - Response for create_network : {'network': {'id': '41539fdd-e543-4911-8366-aaa5526efaea', 'name': 'ctest-bgpaas_vn-85708098', 'tenant_id': 'd33076a9f2b84a9a9a76ef196b32e181', 'project_id': 'd33076a9f2b84a9a9a76ef196b32e181', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-37593964', 'ctest-bgpaas_vn-85708098'], 'port_security_enabled': True, 'description': ''}} 2025-10-06 02:30:38,988 - DEBUG - Response for create_subnet : {'subnet': {'id': '61f26e8a-6e57-47a6-b4c9-3f581d2d350d', 'name': '', 'tenant_id': 'd33076a9f2b84a9a9a76ef196b32e181', 'network_id': '41539fdd-e543-4911-8366-aaa5526efaea', 'ip_version': 4, 'cidr': '208.219.231.128/26', 'allocation_pools': [{'start': '208.219.231.130', 'end': '208.219.231.190'}], 'gateway_ip': '208.219.231.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '208.219.231.130', 'tags': [], 'project_id': 'd33076a9f2b84a9a9a76ef196b32e181'}} 2025-10-06 02:30:39,018 - INFO - Created VN ctest-bgpaas_vn-85708098 2025-10-06 02:30:39,032 - DEBUG - VN ctest-bgpaas_vn-85708098 UUID is 41539fdd-e543-4911-8366-aaa5526efaea 2025-10-06 02:30:39,520 - DEBUG - Response for create_network : {'network': {'id': 'fa2cfe31-a85a-41e7-9192-5dffd9150c87', 'name': 'ctest-bgpaas_vn-68066793', 'tenant_id': 'd33076a9f2b84a9a9a76ef196b32e181', 'project_id': 'd33076a9f2b84a9a9a76ef196b32e181', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-37593964', 'ctest-bgpaas_vn-68066793'], 'port_security_enabled': True, 'description': ''}} 2025-10-06 02:30:39,795 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd53ac504-b828-4a8c-a1bf-0e2ac514809b', 'name': '', 'tenant_id': 'd33076a9f2b84a9a9a76ef196b32e181', 'network_id': 'fa2cfe31-a85a-41e7-9192-5dffd9150c87', 'ip_version': 4, 'cidr': '221.196.31.0/26', 'allocation_pools': [{'start': '221.196.31.2', 'end': '221.196.31.62'}], 'gateway_ip': '221.196.31.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '221.196.31.2', 'tags': [], 'project_id': 'd33076a9f2b84a9a9a76ef196b32e181'}} 2025-10-06 02:30:39,816 - INFO - Created VN ctest-bgpaas_vn-68066793 2025-10-06 02:30:39,825 - DEBUG - VN ctest-bgpaas_vn-68066793 UUID is fa2cfe31-a85a-41e7-9192-5dffd9150c87 2025-10-06 02:30:41,405 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4219-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4219-1) 2025-10-06 02:30:43,165 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4219-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4219-2) 2025-10-06 02:30:43,165 - INFO - Waiting for VM test_vm to be up.. 2025-10-06 02:30:43,265 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-10-06 02:30:48,350 - DEBUG - VM is in ACTIVE state now 2025-10-06 02:30:48,350 - INFO - VM name : test_vm 2025-10-06 02:30:48,433 - DEBUG - VM test_vm ID is 1f26c307-9b7d-4a8a-b7e0-da8143f53f5c 2025-10-06 02:30:48,460 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-4219-1 2025-10-06 02:30:48,539 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/1f26c307-9b7d-4a8a-b7e0-da8143f53f5c 2025-10-06 02:30:48,834 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/1f26c307-9b7d-4a8a-b7e0-da8143f53f5c 2025-10-06 02:30:48,866 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/bdc6ca0f-6aa7-43bf-b51e-887c58c1a2de 2025-10-06 02:30:52,042 - 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 1020ms') 2025-10-06 02:30:52,042 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2025-10-06 02:30:52,058 - DEBUG - Gateway for vn default-domain:ctest-TestRP-37593964:ctest-bgpaas_vn-85708098 is 208.219.231.129 and allocation pool is NOT set 2025-10-06 02:30:54,116 - 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.21 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.344 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.344/1.778/3.213/1.434 ms') 2025-10-06 02:30:54,116 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2025-10-06 02:30:54,187 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-06 02:30:54,187 - DEBUG - Waiting to SSH to VM test_vm, IP 208.219.231.131, Port 22 2025-10-06 02:30:54,345 - DEBUG - VM test_vm is ready for SSH connections 2025-10-06 02:30:54,346 - INFO - Waiting for VM test2_vm to be up.. 2025-10-06 02:30:54,423 - DEBUG - VM is in ACTIVE state now 2025-10-06 02:30:54,423 - INFO - VM name : test2_vm 2025-10-06 02:30:54,510 - DEBUG - VM test2_vm ID is e737a9b4-bdf4-4d75-bab0-12724b076201 2025-10-06 02:30:54,510 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-4219-2 2025-10-06 02:30:54,581 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/e737a9b4-bdf4-4d75-bab0-12724b076201 2025-10-06 02:30:54,591 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/853b421e-9a09-4ae6-815b-f22c9d609848 2025-10-06 02:30:55,739 - 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.27 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.455 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.455/1.860/3.265/1.405 ms') 2025-10-06 02:30:55,739 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2025-10-06 02:30:55,806 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-06 02:30:55,806 - DEBUG - Waiting to SSH to VM test2_vm, IP 221.196.31.3, Port 22 2025-10-06 02:30:55,977 - DEBUG - VM test2_vm is ready for SSH connections 2025-10-06 02:30:56,157 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-06 02:30:56,167 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-37593964:ctest-bgpaas_vn-85708098:ctest-bgpaas_vn-85708098.inet.0 2025-10-06 02:30:56,181 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-37593964:ctest-bgpaas_vn-85708098:ctest-bgpaas_vn-85708098.inet.0 2025-10-06 02:30:56,190 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-06 02:30:56,190 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 221.196.31.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.49, gateway password: c0ntrail123 2025-10-06 02:30:56,190 - DEBUG - ping -s 56 -c 3 -W 1 221.196.31.3 2025-10-06 02:31:00,078 - DEBUG - PING 221.196.31.3 (221.196.31.3): 56 data bytes 64 bytes from 221.196.31.3: seq=0 ttl=63 time=5.366 ms 64 bytes from 221.196.31.3: seq=1 ttl=63 time=1.008 ms 64 bytes from 221.196.31.3: seq=2 ttl=63 time=0.909 ms --- 221.196.31.3 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 0.909/2.427/5.366 ms 2025-10-06 02:31:00,078 - INFO - Ping to IP 221.196.31.3 from VM test_vm passed 2025-10-06 02:31:00,192 - INFO - Deleting VM test2_vm 2025-10-06 02:31:00,264 - INFO - Deleting VM test_vm 2025-10-06 02:31:00,328 - INFO - Deleting VN ctest-bgpaas_vn-68066793 2025-10-06 02:31:00,365 - DEBUG - VN fa2cfe31-a85a-41e7-9192-5dffd9150c87 still in use: Unable to complete operation on network fa2cfe31-a85a-41e7-9192-5dffd9150c87. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-78f2e7b5-6430-4efe-ae9b-05412a629290'] 2025-10-06 02:31:00,365 - WARNING - Deleting VN ctest-bgpaas_vn-68066793 failed..Will retry 2025-10-06 02:31:02,520 - DEBUG - Response for deleting network () 2025-10-06 02:31:02,521 - INFO - Deleting VN ctest-bgpaas_vn-85708098 2025-10-06 02:31:02,702 - DEBUG - Response for deleting network () 2025-10-06 02:31:03,978 - DEBUG - No XMPP flaps were noticed during the test
2025-10-06 02:31:03,978 - INFO - END TEST : test_rp_interface : PASSED[0:00:27]
2025-10-06 02:31:03,978 - INFO - -------------------------------------------------------------------------------- 2025-10-06 02:31:03,980 - INFO - ================================================================================ 2025-10-06 02:31:03,980 - INFO - STARTING TEST : test_rp_interface_ext_community 2025-10-06 02:31:03,980 - 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-06 02:31:05,254 - DEBUG - Nothing to compare xmpp stats {'10.0.0.49': {'10.20.0.193': '0', '10.20.0.25': '0'}, '10.0.0.19': {'10.20.0.25': '0', '10.20.0.17': '0'}} with 2025-10-06 02:31:05,254 - INFO - Initial checks done. Running the testcase now 2025-10-06 02:31:05,254 - INFO - 2025-10-06 02:31:05,530 - DEBUG - Response for create_network : {'network': {'id': '63b78462-f875-4c49-93c2-78fc6cf6392c', 'name': 'ctest-bgpaas_vn-39424495', 'tenant_id': 'd33076a9f2b84a9a9a76ef196b32e181', 'project_id': 'd33076a9f2b84a9a9a76ef196b32e181', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-37593964', 'ctest-bgpaas_vn-39424495'], 'port_security_enabled': True, 'description': ''}} 2025-10-06 02:31:05,755 - DEBUG - Response for create_subnet : {'subnet': {'id': '3a54b47a-164f-4443-a34e-f419b86ab02b', 'name': '', 'tenant_id': 'd33076a9f2b84a9a9a76ef196b32e181', 'network_id': '63b78462-f875-4c49-93c2-78fc6cf6392c', 'ip_version': 4, 'cidr': '174.119.208.64/26', 'allocation_pools': [{'start': '174.119.208.66', 'end': '174.119.208.126'}], 'gateway_ip': '174.119.208.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '174.119.208.66', 'tags': [], 'project_id': 'd33076a9f2b84a9a9a76ef196b32e181'}} 2025-10-06 02:31:05,779 - INFO - Created VN ctest-bgpaas_vn-39424495 2025-10-06 02:31:05,790 - DEBUG - VN ctest-bgpaas_vn-39424495 UUID is 63b78462-f875-4c49-93c2-78fc6cf6392c 2025-10-06 02:31:06,286 - DEBUG - Response for create_network : {'network': {'id': '2aa032fc-2e5a-44c8-9379-bf5c77f9ded3', 'name': 'ctest-bgpaas_vn-32334265', 'tenant_id': 'd33076a9f2b84a9a9a76ef196b32e181', 'project_id': 'd33076a9f2b84a9a9a76ef196b32e181', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-37593964', 'ctest-bgpaas_vn-32334265'], 'port_security_enabled': True, 'description': ''}} 2025-10-06 02:31:06,542 - DEBUG - Response for create_subnet : {'subnet': {'id': '0d09254f-6bc8-40d8-b39e-e17fa491ff23', 'name': '', 'tenant_id': 'd33076a9f2b84a9a9a76ef196b32e181', 'network_id': '2aa032fc-2e5a-44c8-9379-bf5c77f9ded3', 'ip_version': 4, 'cidr': '39.190.8.128/26', 'allocation_pools': [{'start': '39.190.8.130', 'end': '39.190.8.190'}], 'gateway_ip': '39.190.8.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '39.190.8.130', 'tags': [], 'project_id': 'd33076a9f2b84a9a9a76ef196b32e181'}} 2025-10-06 02:31:06,564 - INFO - Created VN ctest-bgpaas_vn-32334265 2025-10-06 02:31:06,578 - DEBUG - VN ctest-bgpaas_vn-32334265 UUID is 2aa032fc-2e5a-44c8-9379-bf5c77f9ded3 2025-10-06 02:31:07,812 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4219-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4219-1) 2025-10-06 02:31:09,068 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4219-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4219-2) 2025-10-06 02:31:09,068 - INFO - Waiting for VM test_vm to be up.. 2025-10-06 02:31:09,169 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-10-06 02:31:14,247 - DEBUG - VM is in ACTIVE state now 2025-10-06 02:31:14,247 - INFO - VM name : test_vm 2025-10-06 02:31:14,327 - DEBUG - VM test_vm ID is afd1915e-c3bf-4d6f-baea-76ffa17a14e7 2025-10-06 02:31:14,327 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-4219-1 2025-10-06 02:31:14,405 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/afd1915e-c3bf-4d6f-baea-76ffa17a14e7 2025-10-06 02:31:14,416 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/79b9e56e-68f2-4c12-90e4-50798645610d 2025-10-06 02:31:17,578 - 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 1010ms') 2025-10-06 02:31:17,578 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2025-10-06 02:31:17,592 - DEBUG - Gateway for vn default-domain:ctest-TestRP-37593964:ctest-bgpaas_vn-39424495 is 174.119.208.65 and allocation pool is NOT set 2025-10-06 02:31:19,659 - 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.28 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.386 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.386/1.834/3.283/1.448 ms') 2025-10-06 02:31:19,660 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2025-10-06 02:31:19,736 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-06 02:31:19,737 - DEBUG - Waiting to SSH to VM test_vm, IP 174.119.208.67, Port 22 2025-10-06 02:31:19,897 - DEBUG - VM test_vm is ready for SSH connections 2025-10-06 02:31:19,897 - INFO - Waiting for VM test2_vm to be up.. 2025-10-06 02:31:19,987 - DEBUG - VM is in ACTIVE state now 2025-10-06 02:31:19,987 - INFO - VM name : test2_vm 2025-10-06 02:31:20,077 - DEBUG - VM test2_vm ID is b97f5cf8-cd57-4d21-b3e2-3a24eb10fc96 2025-10-06 02:31:20,077 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-4219-2 2025-10-06 02:31:20,154 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/b97f5cf8-cd57-4d21-b3e2-3a24eb10fc96 2025-10-06 02:31:20,165 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/52441174-e3ec-4ebc-b3e4-aa18a45dc3f4 2025-10-06 02:31:21,326 - 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.19 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.497 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1000ms\r\nrtt min/avg/max/mdev = 0.497/1.843/3.189/1.346 ms') 2025-10-06 02:31:21,326 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2025-10-06 02:31:21,403 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-06 02:31:21,403 - DEBUG - Waiting to SSH to VM test2_vm, IP 39.190.8.131, Port 22 2025-10-06 02:31:21,558 - DEBUG - VM test2_vm is ready for SSH connections 2025-10-06 02:31:21,725 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-06 02:31:21,736 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-37593964:ctest-bgpaas_vn-39424495:ctest-bgpaas_vn-39424495.inet.0 2025-10-06 02:31:21,750 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-37593964:ctest-bgpaas_vn-39424495:ctest-bgpaas_vn-39424495.inet.0 2025-10-06 02:31:21,760 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-06 02:31:21,760 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 39.190.8.131, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.49, gateway password: c0ntrail123 2025-10-06 02:31:21,760 - DEBUG - ping -s 56 -c 3 -W 1 39.190.8.131 2025-10-06 02:31:25,423 - DEBUG - PING 39.190.8.131 (39.190.8.131): 56 data bytes 64 bytes from 39.190.8.131: seq=0 ttl=63 time=5.594 ms 64 bytes from 39.190.8.131: seq=1 ttl=63 time=1.065 ms 64 bytes from 39.190.8.131: seq=2 ttl=63 time=0.812 ms --- 39.190.8.131 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 0.812/2.490/5.594 ms 2025-10-06 02:31:25,423 - INFO - Ping to IP 39.190.8.131 from VM test_vm passed 2025-10-06 02:31:25,569 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-06 02:31:25,581 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-37593964:ctest-bgpaas_vn-39424495:ctest-bgpaas_vn-39424495.inet.0 2025-10-06 02:31:25,596 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-37593964:ctest-bgpaas_vn-39424495:ctest-bgpaas_vn-39424495.inet.0 2025-10-06 02:31:25,852 - INFO - Deleting VM test2_vm 2025-10-06 02:31:25,929 - INFO - Deleting VM test_vm 2025-10-06 02:31:26,001 - INFO - Deleting VN ctest-bgpaas_vn-32334265 2025-10-06 02:31:26,040 - DEBUG - VN 2aa032fc-2e5a-44c8-9379-bf5c77f9ded3 still in use: Unable to complete operation on network 2aa032fc-2e5a-44c8-9379-bf5c77f9ded3. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-dfb2903f-1e8d-4312-aa6c-be2c8c92a566'] 2025-10-06 02:31:26,041 - WARNING - Deleting VN ctest-bgpaas_vn-32334265 failed..Will retry 2025-10-06 02:31:28,188 - DEBUG - Response for deleting network () 2025-10-06 02:31:28,188 - INFO - Deleting VN ctest-bgpaas_vn-39424495 2025-10-06 02:31:28,340 - DEBUG - Response for deleting network () 2025-10-06 02:31:29,606 - DEBUG - No XMPP flaps were noticed during the test
2025-10-06 02:31:29,606 - INFO - END TEST : test_rp_interface_ext_community : PASSED[0:00:26]
2025-10-06 02:31:29,606 - INFO - -------------------------------------------------------------------------------- 2025-10-06 02:31:29,608 - INFO - ================================================================================ 2025-10-06 02:31:29,608 - INFO - STARTING TEST : test_rp_interface_static 2025-10-06 02:31:29,608 - 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-06 02:31:30,882 - DEBUG - Nothing to compare xmpp stats {'10.0.0.49': {'10.20.0.193': '0', '10.20.0.25': '0'}, '10.0.0.19': {'10.20.0.25': '0', '10.20.0.17': '0'}} with 2025-10-06 02:31:30,882 - INFO - Initial checks done. Running the testcase now 2025-10-06 02:31:30,882 - INFO - 2025-10-06 02:31:31,151 - DEBUG - Response for create_network : {'network': {'id': '9ff4cbd1-d80d-45f7-ad8a-14b0859afd03', 'name': 'ctest-bgpaas_vn-32285464', 'tenant_id': 'd33076a9f2b84a9a9a76ef196b32e181', 'project_id': 'd33076a9f2b84a9a9a76ef196b32e181', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-37593964', 'ctest-bgpaas_vn-32285464'], 'port_security_enabled': True, 'description': ''}} 2025-10-06 02:31:31,383 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c993320e-148e-4a08-9780-21cc720f7e22', 'name': '', 'tenant_id': 'd33076a9f2b84a9a9a76ef196b32e181', 'network_id': '9ff4cbd1-d80d-45f7-ad8a-14b0859afd03', 'ip_version': 4, 'cidr': '145.222.99.0/26', 'allocation_pools': [{'start': '145.222.99.2', 'end': '145.222.99.62'}], 'gateway_ip': '145.222.99.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '145.222.99.2', 'tags': [], 'project_id': 'd33076a9f2b84a9a9a76ef196b32e181'}} 2025-10-06 02:31:31,404 - INFO - Created VN ctest-bgpaas_vn-32285464 2025-10-06 02:31:31,418 - DEBUG - VN ctest-bgpaas_vn-32285464 UUID is 9ff4cbd1-d80d-45f7-ad8a-14b0859afd03 2025-10-06 02:31:31,913 - DEBUG - Response for create_network : {'network': {'id': '60061a70-d6be-4dcd-a88e-4c5ba147cfd2', 'name': 'ctest-bgpaas_vn-69503859', 'tenant_id': 'd33076a9f2b84a9a9a76ef196b32e181', 'project_id': 'd33076a9f2b84a9a9a76ef196b32e181', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-37593964', 'ctest-bgpaas_vn-69503859'], 'port_security_enabled': True, 'description': ''}} 2025-10-06 02:31:32,134 - DEBUG - Response for create_subnet : {'subnet': {'id': 'df1bfcd4-c6d2-4e8c-b729-44cfc1ad9d27', 'name': '', 'tenant_id': 'd33076a9f2b84a9a9a76ef196b32e181', 'network_id': '60061a70-d6be-4dcd-a88e-4c5ba147cfd2', 'ip_version': 4, 'cidr': '64.255.20.0/26', 'allocation_pools': [{'start': '64.255.20.2', 'end': '64.255.20.62'}], 'gateway_ip': '64.255.20.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '64.255.20.2', 'tags': [], 'project_id': 'd33076a9f2b84a9a9a76ef196b32e181'}} 2025-10-06 02:31:32,154 - INFO - Created VN ctest-bgpaas_vn-69503859 2025-10-06 02:31:32,163 - DEBUG - VN ctest-bgpaas_vn-69503859 UUID is 60061a70-d6be-4dcd-a88e-4c5ba147cfd2 2025-10-06 02:31:33,352 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4219-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4219-1) 2025-10-06 02:31:34,661 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4219-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4219-2) 2025-10-06 02:31:34,661 - INFO - Waiting for VM test_vm to be up.. 2025-10-06 02:31:34,748 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-10-06 02:31:39,826 - DEBUG - VM is in ACTIVE state now 2025-10-06 02:31:39,826 - INFO - VM name : test_vm 2025-10-06 02:31:39,905 - DEBUG - VM test_vm ID is ca81dd00-b9ae-4eb0-a696-195f6cf0a353 2025-10-06 02:31:39,905 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-4219-1 2025-10-06 02:31:39,989 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/ca81dd00-b9ae-4eb0-a696-195f6cf0a353 2025-10-06 02:31:40,000 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/80dad9da-7551-4081-bf7d-cdf70fcf18d5 2025-10-06 02:31:43,177 - 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 1019ms') 2025-10-06 02:31:43,177 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2025-10-06 02:31:43,190 - DEBUG - Gateway for vn default-domain:ctest-TestRP-37593964:ctest-bgpaas_vn-32285464 is 145.222.99.1 and allocation pool is NOT set 2025-10-06 02:31:45,251 - 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.70 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.447 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.447/2.072/3.697/1.625 ms') 2025-10-06 02:31:45,251 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2025-10-06 02:31:45,317 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-06 02:31:45,317 - DEBUG - Waiting to SSH to VM test_vm, IP 145.222.99.3, Port 22 2025-10-06 02:31:45,474 - DEBUG - VM test_vm is ready for SSH connections 2025-10-06 02:31:45,474 - INFO - Waiting for VM test2_vm to be up.. 2025-10-06 02:31:45,558 - DEBUG - VM is in ACTIVE state now 2025-10-06 02:31:45,558 - INFO - VM name : test2_vm 2025-10-06 02:31:45,634 - DEBUG - VM test2_vm ID is 409ca60e-1004-4ce8-9ff4-e29ca91853bc 2025-10-06 02:31:45,634 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-4219-2 2025-10-06 02:31:45,712 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/409ca60e-1004-4ce8-9ff4-e29ca91853bc 2025-10-06 02:31:45,723 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/dc8394a4-d6bb-440b-b640-247af089c305 2025-10-06 02:31:46,876 - 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.67 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.431 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.431/2.549/4.667/2.118 ms') 2025-10-06 02:31:46,876 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2025-10-06 02:31:46,945 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-06 02:31:46,945 - DEBUG - Waiting to SSH to VM test2_vm, IP 64.255.20.3, Port 22 2025-10-06 02:31:47,112 - DEBUG - VM test2_vm is ready for SSH connections 2025-10-06 02:31:47,197 - INFO - Created InterfaceRouteTable ['default-domain', 'ctest-TestRP-37593964', 'ctest-int_table_right-30355857'](UUID 99d659af-8407-4348-b626-fe464b09cfd8), prefixes : ['147.241.67.192/26'] 2025-10-06 02:31:47,265 - INFO - Added intf route table 99d659af-8407-4348-b626-fe464b09cfd8 to port 80dad9da-7551-4081-bf7d-cdf70fcf18d5 2025-10-06 02:31:47,449 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-37593964:ctest-bgpaas_vn-32285464:ctest-bgpaas_vn-32285464.inet.0 2025-10-06 02:31:47,463 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-37593964:ctest-bgpaas_vn-32285464:ctest-bgpaas_vn-32285464.inet.0 2025-10-06 02:31:47,475 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-06 02:31:47,476 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 64.255.20.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.49, gateway password: c0ntrail123 2025-10-06 02:31:47,476 - DEBUG - ping -s 56 -c 3 -W 1 64.255.20.3 2025-10-06 02:31:51,132 - DEBUG - PING 64.255.20.3 (64.255.20.3): 56 data bytes 64 bytes from 64.255.20.3: seq=0 ttl=63 time=4.545 ms 64 bytes from 64.255.20.3: seq=1 ttl=63 time=1.089 ms 64 bytes from 64.255.20.3: seq=2 ttl=63 time=1.028 ms --- 64.255.20.3 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.028/2.220/4.545 ms 2025-10-06 02:31:51,132 - INFO - Ping to IP 64.255.20.3 from VM test_vm passed 2025-10-06 02:31:51,257 - INFO - Deleting VM test2_vm 2025-10-06 02:31:51,324 - INFO - Deleting VM test_vm 2025-10-06 02:31:51,389 - INFO - Deleting VN ctest-bgpaas_vn-69503859 2025-10-06 02:31:51,435 - DEBUG - VN 60061a70-d6be-4dcd-a88e-4c5ba147cfd2 still in use: Unable to complete operation on network 60061a70-d6be-4dcd-a88e-4c5ba147cfd2. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-3f497e08-3c7a-4ea3-8f57-64019d34164c'] 2025-10-06 02:31:51,436 - WARNING - Deleting VN ctest-bgpaas_vn-69503859 failed..Will retry 2025-10-06 02:31:53,614 - DEBUG - Response for deleting network () 2025-10-06 02:31:53,614 - INFO - Deleting VN ctest-bgpaas_vn-32285464 2025-10-06 02:31:53,779 - DEBUG - Response for deleting network () 2025-10-06 02:31:55,053 - DEBUG - No XMPP flaps were noticed during the test
2025-10-06 02:31:55,054 - INFO - END TEST : test_rp_interface_static : PASSED[0:00:26]
2025-10-06 02:31:55,054 - INFO - -------------------------------------------------------------------------------- 2025-10-06 02:31:55,745 - INFO - Deleted project: ctest-TestRP-37593964, ID : d33076a9-f2b8-4a9a-9a76-ef196b32e181