2025-09-29 02:37:03,139 - INFO - Domain Default found not creating 2025-09-29 02:37:03,279 - INFO - Project ctest-TestRP-22239118 not found, creating it 2025-09-29 02:37:03,831 - INFO - Created Project:ctest-TestRP-22239118, ID : 045970e1-92fb-4adb-8fcc-504f3ea24eeb 2025-09-29 02:37:05,316 - DEBUG - Services list from nova: [, , , ] 2025-09-29 02:37:05,317 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-4203-2', 'an-jenkins-deploy-platform-ansible-os-4203-1']} 2025-09-29 02:37:05,319 - INFO - ================================================================================ 2025-09-29 02:37:05,319 - INFO - STARTING TEST : test_rp_interface 2025-09-29 02:37:05,319 - 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-09-29 02:37:06,662 - DEBUG - Nothing to compare xmpp stats {'10.0.0.27': {'10.20.0.129': '0', '10.20.0.17': '0'}, '10.0.0.131': {'10.20.0.129': '0', '10.20.0.17': '0'}} with 2025-09-29 02:37:06,662 - INFO - Initial checks done. Running the testcase now 2025-09-29 02:37:06,662 - INFO - 2025-09-29 02:37:07,341 - DEBUG - Response for create_network : {'network': {'id': '3f8936d7-82b1-4578-9d18-14fd8eb957cb', 'name': 'ctest-bgpaas_vn-75518310', 'tenant_id': '045970e192fb4adb8fcc504f3ea24eeb', 'project_id': '045970e192fb4adb8fcc504f3ea24eeb', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-22239118', 'ctest-bgpaas_vn-75518310'], 'port_security_enabled': True, 'description': ''}} 2025-09-29 02:37:07,589 - DEBUG - Response for create_subnet : {'subnet': {'id': '3b60f02d-31d2-4d00-9afb-b9f2766122ef', 'name': '', 'tenant_id': '045970e192fb4adb8fcc504f3ea24eeb', 'network_id': '3f8936d7-82b1-4578-9d18-14fd8eb957cb', 'ip_version': 4, 'cidr': '210.154.110.0/26', 'allocation_pools': [{'start': '210.154.110.2', 'end': '210.154.110.62'}], 'gateway_ip': '210.154.110.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '210.154.110.2', 'tags': [], 'project_id': '045970e192fb4adb8fcc504f3ea24eeb'}} 2025-09-29 02:37:07,611 - INFO - Created VN ctest-bgpaas_vn-75518310 2025-09-29 02:37:07,624 - DEBUG - VN ctest-bgpaas_vn-75518310 UUID is 3f8936d7-82b1-4578-9d18-14fd8eb957cb 2025-09-29 02:37:08,153 - DEBUG - Response for create_network : {'network': {'id': '005bbf4d-68db-42c6-9392-adc6265a18ed', 'name': 'ctest-bgpaas_vn-89482071', 'tenant_id': '045970e192fb4adb8fcc504f3ea24eeb', 'project_id': '045970e192fb4adb8fcc504f3ea24eeb', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-22239118', 'ctest-bgpaas_vn-89482071'], 'port_security_enabled': True, 'description': ''}} 2025-09-29 02:37:08,435 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c821a991-c8ef-465c-8288-f0cd545c74d7', 'name': '', 'tenant_id': '045970e192fb4adb8fcc504f3ea24eeb', 'network_id': '005bbf4d-68db-42c6-9392-adc6265a18ed', 'ip_version': 4, 'cidr': '34.140.206.192/26', 'allocation_pools': [{'start': '34.140.206.194', 'end': '34.140.206.254'}], 'gateway_ip': '34.140.206.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '34.140.206.194', 'tags': [], 'project_id': '045970e192fb4adb8fcc504f3ea24eeb'}} 2025-09-29 02:37:08,454 - INFO - Created VN ctest-bgpaas_vn-89482071 2025-09-29 02:37:08,464 - DEBUG - VN ctest-bgpaas_vn-89482071 UUID is 005bbf4d-68db-42c6-9392-adc6265a18ed 2025-09-29 02:37:09,872 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4203-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4203-2) 2025-09-29 02:37:11,223 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4203-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4203-1) 2025-09-29 02:37:11,223 - INFO - Waiting for VM test_vm to be up.. 2025-09-29 02:37:11,319 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-09-29 02:37:16,410 - DEBUG - VM is in ACTIVE state now 2025-09-29 02:37:16,410 - INFO - VM name : test_vm 2025-09-29 02:37:16,515 - DEBUG - VM test_vm ID is 5dc09a0b-f2a6-4e44-847c-345e4bff7123 2025-09-29 02:37:16,550 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-4203-2 2025-09-29 02:37:16,653 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/5dc09a0b-f2a6-4e44-847c-345e4bff7123 2025-09-29 02:37:16,945 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/5dc09a0b-f2a6-4e44-847c-345e4bff7123 2025-09-29 02:37:16,989 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/6883a31a-1261-4e61-9749-928eb354df45 2025-09-29 02:37:20,186 - 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 1011ms') 2025-09-29 02:37:20,186 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2025-09-29 02:37:20,219 - DEBUG - Gateway for vn default-domain:ctest-TestRP-22239118:ctest-bgpaas_vn-75518310 is 210.154.110.1 and allocation pool is NOT set 2025-09-29 02:37:22,288 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=6.59 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.64 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 2.642/4.615/6.589/1.973 ms') 2025-09-29 02:37:22,288 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2025-09-29 02:37:22,380 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-29 02:37:22,380 - DEBUG - Waiting to SSH to VM test_vm, IP 210.154.110.3, Port 22 2025-09-29 02:37:22,552 - DEBUG - VM test_vm is ready for SSH connections 2025-09-29 02:37:22,552 - INFO - Waiting for VM test2_vm to be up.. 2025-09-29 02:37:22,641 - DEBUG - VM is in ACTIVE state now 2025-09-29 02:37:22,641 - INFO - VM name : test2_vm 2025-09-29 02:37:22,712 - DEBUG - VM test2_vm ID is 33e20d59-3f2f-4c61-9fdb-33547220b3bd 2025-09-29 02:37:22,712 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-4203-1 2025-09-29 02:37:22,806 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/33e20d59-3f2f-4c61-9fdb-33547220b3bd 2025-09-29 02:37:22,823 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/b3293709-74fd-4a90-af22-a0e08732f63f 2025-09-29 02:37:24,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.05 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.538 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.538/2.295/4.052/1.757 ms') 2025-09-29 02:37:24,017 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2025-09-29 02:37:24,105 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-29 02:37:24,105 - DEBUG - Waiting to SSH to VM test2_vm, IP 34.140.206.195, Port 22 2025-09-29 02:37:24,271 - DEBUG - VM test2_vm is ready for SSH connections 2025-09-29 02:37:24,447 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-29 02:37:24,458 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-22239118:ctest-bgpaas_vn-75518310:ctest-bgpaas_vn-75518310.inet.0 2025-09-29 02:37:24,479 - DEBUG - Requesting: http://10.20.0.17:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-22239118:ctest-bgpaas_vn-75518310:ctest-bgpaas_vn-75518310.inet.0 2025-09-29 02:37:24,490 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-29 02:37:24,491 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 34.140.206.195, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.131, gateway password: c0ntrail123 2025-09-29 02:37:24,491 - DEBUG - ping -s 56 -c 3 -W 1 34.140.206.195 2025-09-29 02:37:28,453 - DEBUG - PING 34.140.206.195 (34.140.206.195): 56 data bytes 64 bytes from 34.140.206.195: seq=0 ttl=63 time=6.156 ms 64 bytes from 34.140.206.195: seq=1 ttl=63 time=1.579 ms 64 bytes from 34.140.206.195: seq=2 ttl=63 time=1.254 ms --- 34.140.206.195 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.254/2.996/6.156 ms 2025-09-29 02:37:28,454 - INFO - Ping to IP 34.140.206.195 from VM test_vm passed 2025-09-29 02:37:28,599 - INFO - Deleting VM test2_vm 2025-09-29 02:37:28,708 - INFO - Deleting VM test_vm 2025-09-29 02:37:28,792 - INFO - Deleting VN ctest-bgpaas_vn-89482071 2025-09-29 02:37:28,858 - DEBUG - VN 005bbf4d-68db-42c6-9392-adc6265a18ed still in use: Unable to complete operation on network 005bbf4d-68db-42c6-9392-adc6265a18ed. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-ac20ba7b-2a62-437e-875b-069f882e7f17'] 2025-09-29 02:37:28,858 - WARNING - Deleting VN ctest-bgpaas_vn-89482071 failed..Will retry 2025-09-29 02:37:31,010 - DEBUG - Response for deleting network () 2025-09-29 02:37:31,010 - INFO - Deleting VN ctest-bgpaas_vn-75518310 2025-09-29 02:37:31,240 - DEBUG - Response for deleting network () 2025-09-29 02:37:32,556 - DEBUG - No XMPP flaps were noticed during the test
2025-09-29 02:37:32,556 - INFO - END TEST : test_rp_interface : PASSED[0:00:27]
2025-09-29 02:37:32,556 - INFO - -------------------------------------------------------------------------------- 2025-09-29 02:37:32,560 - INFO - ================================================================================ 2025-09-29 02:37:32,560 - INFO - STARTING TEST : test_rp_interface_ext_community 2025-09-29 02:37:32,560 - 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-09-29 02:37:33,900 - DEBUG - Nothing to compare xmpp stats {'10.0.0.27': {'10.20.0.129': '0', '10.20.0.17': '0'}, '10.0.0.131': {'10.20.0.129': '0', '10.20.0.17': '0'}} with 2025-09-29 02:37:33,900 - INFO - Initial checks done. Running the testcase now 2025-09-29 02:37:33,900 - INFO - 2025-09-29 02:37:34,229 - DEBUG - Response for create_network : {'network': {'id': '08b0f125-8abe-4c90-9ff3-97ebc1a302a0', 'name': 'ctest-bgpaas_vn-49537010', 'tenant_id': '045970e192fb4adb8fcc504f3ea24eeb', 'project_id': '045970e192fb4adb8fcc504f3ea24eeb', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-22239118', 'ctest-bgpaas_vn-49537010'], 'port_security_enabled': True, 'description': ''}} 2025-09-29 02:37:34,478 - DEBUG - Response for create_subnet : {'subnet': {'id': '643db841-9f16-437d-9dfc-2f0360a251c5', 'name': '', 'tenant_id': '045970e192fb4adb8fcc504f3ea24eeb', 'network_id': '08b0f125-8abe-4c90-9ff3-97ebc1a302a0', 'ip_version': 4, 'cidr': '11.60.175.64/26', 'allocation_pools': [{'start': '11.60.175.66', 'end': '11.60.175.126'}], 'gateway_ip': '11.60.175.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '11.60.175.66', 'tags': [], 'project_id': '045970e192fb4adb8fcc504f3ea24eeb'}} 2025-09-29 02:37:34,503 - INFO - Created VN ctest-bgpaas_vn-49537010 2025-09-29 02:37:34,518 - DEBUG - VN ctest-bgpaas_vn-49537010 UUID is 08b0f125-8abe-4c90-9ff3-97ebc1a302a0 2025-09-29 02:37:35,096 - DEBUG - Response for create_network : {'network': {'id': '1424d544-3583-4f60-b88d-9d8477553148', 'name': 'ctest-bgpaas_vn-01886768', 'tenant_id': '045970e192fb4adb8fcc504f3ea24eeb', 'project_id': '045970e192fb4adb8fcc504f3ea24eeb', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-22239118', 'ctest-bgpaas_vn-01886768'], 'port_security_enabled': True, 'description': ''}} 2025-09-29 02:37:35,330 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a348f084-f814-4e0b-a68a-63dfae4e7b01', 'name': '', 'tenant_id': '045970e192fb4adb8fcc504f3ea24eeb', 'network_id': '1424d544-3583-4f60-b88d-9d8477553148', 'ip_version': 4, 'cidr': '8.195.121.0/26', 'allocation_pools': [{'start': '8.195.121.2', 'end': '8.195.121.62'}], 'gateway_ip': '8.195.121.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '8.195.121.2', 'tags': [], 'project_id': '045970e192fb4adb8fcc504f3ea24eeb'}} 2025-09-29 02:37:35,354 - INFO - Created VN ctest-bgpaas_vn-01886768 2025-09-29 02:37:35,366 - DEBUG - VN ctest-bgpaas_vn-01886768 UUID is 1424d544-3583-4f60-b88d-9d8477553148 2025-09-29 02:37:36,718 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4203-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4203-2) 2025-09-29 02:37:38,069 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4203-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4203-1) 2025-09-29 02:37:38,070 - INFO - Waiting for VM test_vm to be up.. 2025-09-29 02:37:38,173 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-09-29 02:37:43,267 - DEBUG - VM is in ACTIVE state now 2025-09-29 02:37:43,267 - INFO - VM name : test_vm 2025-09-29 02:37:43,346 - DEBUG - VM test_vm ID is 15cfc286-c2d0-427e-a381-ef1a046367f5 2025-09-29 02:37:43,346 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-4203-2 2025-09-29 02:37:43,425 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/15cfc286-c2d0-427e-a381-ef1a046367f5 2025-09-29 02:37:43,442 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/2259b9ac-fd65-42fc-8441-7b2639c5e810 2025-09-29 02:37:46,659 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1026ms') 2025-09-29 02:37:46,659 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2025-09-29 02:37:46,684 - DEBUG - Gateway for vn default-domain:ctest-TestRP-22239118:ctest-bgpaas_vn-49537010 is 11.60.175.65 and allocation pool is NOT set 2025-09-29 02:37:48,752 - 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.18 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 1001ms\r\nrtt min/avg/max/mdev = 0.431/4.307/8.184/3.876 ms') 2025-09-29 02:37:48,752 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2025-09-29 02:37:48,849 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-29 02:37:48,849 - DEBUG - Waiting to SSH to VM test_vm, IP 11.60.175.67, Port 22 2025-09-29 02:37:49,019 - DEBUG - VM test_vm is ready for SSH connections 2025-09-29 02:37:49,019 - INFO - Waiting for VM test2_vm to be up.. 2025-09-29 02:37:49,110 - DEBUG - VM is in ACTIVE state now 2025-09-29 02:37:49,111 - INFO - VM name : test2_vm 2025-09-29 02:37:49,194 - DEBUG - VM test2_vm ID is 305dd23a-4022-4ddc-8ddf-cd5b341f9147 2025-09-29 02:37:49,194 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-4203-1 2025-09-29 02:37:49,289 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/305dd23a-4022-4ddc-8ddf-cd5b341f9147 2025-09-29 02:37:49,302 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/dbab5817-673a-477d-9164-1eb301e27a34 2025-09-29 02:37:50,478 - 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.24 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.538 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.538/1.887/3.236/1.349 ms') 2025-09-29 02:37:50,479 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2025-09-29 02:37:50,565 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-29 02:37:50,565 - DEBUG - Waiting to SSH to VM test2_vm, IP 8.195.121.3, Port 22 2025-09-29 02:37:50,721 - DEBUG - VM test2_vm is ready for SSH connections 2025-09-29 02:37:50,907 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-29 02:37:50,920 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-22239118:ctest-bgpaas_vn-49537010:ctest-bgpaas_vn-49537010.inet.0 2025-09-29 02:37:50,940 - DEBUG - Requesting: http://10.20.0.17:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-22239118:ctest-bgpaas_vn-49537010:ctest-bgpaas_vn-49537010.inet.0 2025-09-29 02:37:50,950 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-29 02:37:50,950 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 8.195.121.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.131, gateway password: c0ntrail123 2025-09-29 02:37:50,950 - DEBUG - ping -s 56 -c 3 -W 1 8.195.121.3 2025-09-29 02:37:54,592 - DEBUG - PING 8.195.121.3 (8.195.121.3): 56 data bytes 64 bytes from 8.195.121.3: seq=0 ttl=63 time=7.144 ms 64 bytes from 8.195.121.3: seq=1 ttl=63 time=3.758 ms 64 bytes from 8.195.121.3: seq=2 ttl=63 time=1.388 ms --- 8.195.121.3 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.388/4.096/7.144 ms 2025-09-29 02:37:54,593 - INFO - Ping to IP 8.195.121.3 from VM test_vm passed 2025-09-29 02:37:54,811 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-29 02:37:54,828 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-22239118:ctest-bgpaas_vn-49537010:ctest-bgpaas_vn-49537010.inet.0 2025-09-29 02:37:54,840 - DEBUG - Requesting: http://10.20.0.17:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-22239118:ctest-bgpaas_vn-49537010:ctest-bgpaas_vn-49537010.inet.0 2025-09-29 02:37:55,121 - INFO - Deleting VM test2_vm 2025-09-29 02:37:55,185 - INFO - Deleting VM test_vm 2025-09-29 02:37:55,249 - INFO - Deleting VN ctest-bgpaas_vn-01886768 2025-09-29 02:37:55,291 - DEBUG - VN 1424d544-3583-4f60-b88d-9d8477553148 still in use: Unable to complete operation on network 1424d544-3583-4f60-b88d-9d8477553148. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-4dbd7b5a-bca4-4555-9fd6-9909cc182d26'] 2025-09-29 02:37:55,291 - WARNING - Deleting VN ctest-bgpaas_vn-01886768 failed..Will retry 2025-09-29 02:37:57,473 - DEBUG - Response for deleting network () 2025-09-29 02:37:57,474 - INFO - Deleting VN ctest-bgpaas_vn-49537010 2025-09-29 02:37:57,669 - DEBUG - Response for deleting network () 2025-09-29 02:37:58,992 - DEBUG - No XMPP flaps were noticed during the test
2025-09-29 02:37:58,992 - INFO - END TEST : test_rp_interface_ext_community : PASSED[0:00:26]
2025-09-29 02:37:58,992 - INFO - -------------------------------------------------------------------------------- 2025-09-29 02:37:58,995 - INFO - ================================================================================ 2025-09-29 02:37:58,995 - INFO - STARTING TEST : test_rp_interface_static 2025-09-29 02:37:58,995 - 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-09-29 02:38:00,319 - DEBUG - Nothing to compare xmpp stats {'10.0.0.27': {'10.20.0.129': '0', '10.20.0.17': '0'}, '10.0.0.131': {'10.20.0.129': '0', '10.20.0.17': '0'}} with 2025-09-29 02:38:00,319 - INFO - Initial checks done. Running the testcase now 2025-09-29 02:38:00,319 - INFO - 2025-09-29 02:38:00,648 - DEBUG - Response for create_network : {'network': {'id': '281d9ebd-5650-42db-b2b4-b11484507d91', 'name': 'ctest-bgpaas_vn-31424071', 'tenant_id': '045970e192fb4adb8fcc504f3ea24eeb', 'project_id': '045970e192fb4adb8fcc504f3ea24eeb', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-22239118', 'ctest-bgpaas_vn-31424071'], 'port_security_enabled': True, 'description': ''}} 2025-09-29 02:38:00,873 - DEBUG - Response for create_subnet : {'subnet': {'id': '6c205ac7-ac95-45cb-bbd7-502431cc4c5c', 'name': '', 'tenant_id': '045970e192fb4adb8fcc504f3ea24eeb', 'network_id': '281d9ebd-5650-42db-b2b4-b11484507d91', 'ip_version': 4, 'cidr': '33.155.193.0/26', 'allocation_pools': [{'start': '33.155.193.2', 'end': '33.155.193.62'}], 'gateway_ip': '33.155.193.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '33.155.193.2', 'tags': [], 'project_id': '045970e192fb4adb8fcc504f3ea24eeb'}} 2025-09-29 02:38:00,895 - INFO - Created VN ctest-bgpaas_vn-31424071 2025-09-29 02:38:00,914 - DEBUG - VN ctest-bgpaas_vn-31424071 UUID is 281d9ebd-5650-42db-b2b4-b11484507d91 2025-09-29 02:38:01,501 - DEBUG - Response for create_network : {'network': {'id': 'f072095d-4b38-4e97-87fb-11c7672a7814', 'name': 'ctest-bgpaas_vn-57401671', 'tenant_id': '045970e192fb4adb8fcc504f3ea24eeb', 'project_id': '045970e192fb4adb8fcc504f3ea24eeb', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-22239118', 'ctest-bgpaas_vn-57401671'], 'port_security_enabled': True, 'description': ''}} 2025-09-29 02:38:01,735 - DEBUG - Response for create_subnet : {'subnet': {'id': '132748f2-71df-4177-8cf8-a9d43823edff', 'name': '', 'tenant_id': '045970e192fb4adb8fcc504f3ea24eeb', 'network_id': 'f072095d-4b38-4e97-87fb-11c7672a7814', 'ip_version': 4, 'cidr': '184.146.105.0/26', 'allocation_pools': [{'start': '184.146.105.2', 'end': '184.146.105.62'}], 'gateway_ip': '184.146.105.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '184.146.105.2', 'tags': [], 'project_id': '045970e192fb4adb8fcc504f3ea24eeb'}} 2025-09-29 02:38:01,757 - INFO - Created VN ctest-bgpaas_vn-57401671 2025-09-29 02:38:01,767 - DEBUG - VN ctest-bgpaas_vn-57401671 UUID is f072095d-4b38-4e97-87fb-11c7672a7814 2025-09-29 02:38:03,195 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4203-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4203-2) 2025-09-29 02:38:04,860 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4203-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4203-1) 2025-09-29 02:38:04,861 - INFO - Waiting for VM test_vm to be up.. 2025-09-29 02:38:04,958 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-09-29 02:38:10,067 - DEBUG - VM is in ACTIVE state now 2025-09-29 02:38:10,067 - INFO - VM name : test_vm 2025-09-29 02:38:10,167 - DEBUG - VM test_vm ID is 31ac6d86-0b2f-4128-8724-b1666e9baf98 2025-09-29 02:38:10,167 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-4203-2 2025-09-29 02:38:10,258 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/31ac6d86-0b2f-4128-8724-b1666e9baf98 2025-09-29 02:38:10,277 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/01f07ca5-5a7f-4e1c-ab45-5615b2095bc3 2025-09-29 02:38:13,472 - 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-09-29 02:38:13,472 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2025-09-29 02:38:13,501 - DEBUG - Gateway for vn default-domain:ctest-TestRP-22239118:ctest-bgpaas_vn-31424071 is 33.155.193.1 and allocation pool is NOT set 2025-09-29 02:38:15,569 - 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=9.69 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.519 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.519/5.103/9.688/4.584 ms') 2025-09-29 02:38:15,569 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2025-09-29 02:38:15,670 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-29 02:38:15,670 - DEBUG - Waiting to SSH to VM test_vm, IP 33.155.193.3, Port 22 2025-09-29 02:38:15,839 - DEBUG - VM test_vm is ready for SSH connections 2025-09-29 02:38:15,839 - INFO - Waiting for VM test2_vm to be up.. 2025-09-29 02:38:15,919 - DEBUG - VM is in ACTIVE state now 2025-09-29 02:38:15,919 - INFO - VM name : test2_vm 2025-09-29 02:38:16,037 - DEBUG - VM test2_vm ID is 23dea65e-2461-4d47-893f-81d70b0bdfbc 2025-09-29 02:38:16,037 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-4203-1 2025-09-29 02:38:16,129 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/23dea65e-2461-4d47-893f-81d70b0bdfbc 2025-09-29 02:38:16,148 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/5250604a-53a9-4ec4-b448-e556d497605f 2025-09-29 02:38:17,349 - 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.78 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.531 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.531/1.656/2.782/1.125 ms') 2025-09-29 02:38:17,349 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2025-09-29 02:38:17,420 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-29 02:38:17,420 - DEBUG - Waiting to SSH to VM test2_vm, IP 184.146.105.3, Port 22 2025-09-29 02:38:17,577 - DEBUG - VM test2_vm is ready for SSH connections 2025-09-29 02:38:17,711 - INFO - Created InterfaceRouteTable ['default-domain', 'ctest-TestRP-22239118', 'ctest-int_table_right-25271609'](UUID 6adc2b18-62fb-400b-9072-6e6cffe37ec2), prefixes : ['140.7.102.192/26'] 2025-09-29 02:38:17,807 - INFO - Added intf route table 6adc2b18-62fb-400b-9072-6e6cffe37ec2 to port 01f07ca5-5a7f-4e1c-ab45-5615b2095bc3 2025-09-29 02:38:18,019 - DEBUG - Requesting: http://10.20.0.129:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-22239118:ctest-bgpaas_vn-31424071:ctest-bgpaas_vn-31424071.inet.0 2025-09-29 02:38:18,041 - DEBUG - Requesting: http://10.20.0.17:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-22239118:ctest-bgpaas_vn-31424071:ctest-bgpaas_vn-31424071.inet.0 2025-09-29 02:38:18,054 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-29 02:38:18,054 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 184.146.105.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.131, gateway password: c0ntrail123 2025-09-29 02:38:18,055 - DEBUG - ping -s 56 -c 3 -W 1 184.146.105.3 2025-09-29 02:38:21,736 - DEBUG - PING 184.146.105.3 (184.146.105.3): 56 data bytes 64 bytes from 184.146.105.3: seq=0 ttl=63 time=5.372 ms 64 bytes from 184.146.105.3: seq=1 ttl=63 time=1.429 ms 64 bytes from 184.146.105.3: seq=2 ttl=63 time=1.354 ms --- 184.146.105.3 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.354/2.718/5.372 ms 2025-09-29 02:38:21,737 - INFO - Ping to IP 184.146.105.3 from VM test_vm passed 2025-09-29 02:38:21,904 - INFO - Deleting VM test2_vm 2025-09-29 02:38:21,976 - INFO - Deleting VM test_vm 2025-09-29 02:38:22,043 - INFO - Deleting VN ctest-bgpaas_vn-57401671 2025-09-29 02:38:22,084 - DEBUG - VN f072095d-4b38-4e97-87fb-11c7672a7814 still in use: Unable to complete operation on network f072095d-4b38-4e97-87fb-11c7672a7814. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-82f3bdf2-0366-486f-ac88-6bf155929172'] 2025-09-29 02:38:22,084 - WARNING - Deleting VN ctest-bgpaas_vn-57401671 failed..Will retry 2025-09-29 02:38:24,271 - DEBUG - Response for deleting network () 2025-09-29 02:38:24,271 - INFO - Deleting VN ctest-bgpaas_vn-31424071 2025-09-29 02:38:24,446 - DEBUG - Response for deleting network () 2025-09-29 02:38:25,783 - DEBUG - No XMPP flaps were noticed during the test
2025-09-29 02:38:25,783 - INFO - END TEST : test_rp_interface_static : PASSED[0:00:27]
2025-09-29 02:38:25,784 - INFO - -------------------------------------------------------------------------------- 2025-09-29 02:38:26,638 - INFO - Deleted project: ctest-TestRP-22239118, ID : 045970e1-92fb-4adb-8fcc-504f3ea24eeb