2026-04-24 17:09:05,595 - INFO - Domain Default found not creating
2026-04-24 17:09:05,782 - INFO - Project ctest-TestRP-38428602 not found, creating it
2026-04-24 17:09:06,326 - INFO - Created Project:ctest-TestRP-38428602, ID : 5e4daa7a-2ada-4e24-901f-13bb8fefcb00
2026-04-24 17:09:08,066 - DEBUG - Services list from nova: [, , ]
2026-04-24 17:09:08,067 - DEBUG - Hosts: {'nova': ['cn-jenkins-deploy-platform-ansible-os-5683-1']}
2026-04-24 17:09:08,069 - INFO - ================================================================================
2026-04-24 17:09:08,069 - INFO - STARTING TEST : test_rp_interface
2026-04-24 17:09:08,069 - 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.
2026-04-24 17:09:08,341 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.17': '0'}} with
2026-04-24 17:09:08,341 - INFO - Initial checks done. Running the testcase now
2026-04-24 17:09:08,341 - INFO -
2026-04-24 17:09:08,933 - DEBUG - Response for create_network : {'network': {'id': 'ec8a2505-17ab-4ae2-91b7-857ceb096082', 'name': 'ctest-bgpaas_vn-52166452', 'tenant_id': '5e4daa7a2ada4e24901f13bb8fefcb00', 'project_id': '5e4daa7a2ada4e24901f13bb8fefcb00', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-38428602', 'ctest-bgpaas_vn-52166452'], 'port_security_enabled': True, 'description': ''}}
2026-04-24 17:09:09,119 - DEBUG - Response for create_subnet : {'subnet': {'id': '642e711e-aa5c-485d-97a2-ef7018da7421', 'name': '', 'tenant_id': '5e4daa7a2ada4e24901f13bb8fefcb00', 'network_id': 'ec8a2505-17ab-4ae2-91b7-857ceb096082', 'ip_version': 4, 'cidr': '45.211.173.64/26', 'allocation_pools': [{'start': '45.211.173.66', 'end': '45.211.173.126'}], 'gateway_ip': '45.211.173.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '45.211.173.66', 'tags': [], 'project_id': '5e4daa7a2ada4e24901f13bb8fefcb00'}}
2026-04-24 17:09:09,137 - INFO - Created VN ctest-bgpaas_vn-52166452
2026-04-24 17:09:09,188 - DEBUG - VN ctest-bgpaas_vn-52166452 UUID is ec8a2505-17ab-4ae2-91b7-857ceb096082
2026-04-24 17:09:09,664 - DEBUG - Response for create_network : {'network': {'id': '5007084e-63be-48d7-a091-6ac8ef7c8735', 'name': 'ctest-bgpaas_vn-43653115', 'tenant_id': '5e4daa7a2ada4e24901f13bb8fefcb00', 'project_id': '5e4daa7a2ada4e24901f13bb8fefcb00', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-38428602', 'ctest-bgpaas_vn-43653115'], 'port_security_enabled': True, 'description': ''}}
2026-04-24 17:09:09,844 - DEBUG - Response for create_subnet : {'subnet': {'id': '68cc4129-67f0-4f64-8cda-377e015e34ac', 'name': '', 'tenant_id': '5e4daa7a2ada4e24901f13bb8fefcb00', 'network_id': '5007084e-63be-48d7-a091-6ac8ef7c8735', 'ip_version': 4, 'cidr': '22.75.120.64/26', 'allocation_pools': [{'start': '22.75.120.66', 'end': '22.75.120.126'}], 'gateway_ip': '22.75.120.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '22.75.120.66', 'tags': [], 'project_id': '5e4daa7a2ada4e24901f13bb8fefcb00'}}
2026-04-24 17:09:09,863 - INFO - Created VN ctest-bgpaas_vn-43653115
2026-04-24 17:09:09,916 - DEBUG - VN ctest-bgpaas_vn-43653115 UUID is 5007084e-63be-48d7-a091-6ac8ef7c8735
2026-04-24 17:09:11,348 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5683-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5683-1)
2026-04-24 17:09:12,567 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5683-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5683-1)
2026-04-24 17:09:12,567 - INFO - Waiting for VM test_vm to be up..
2026-04-24 17:09:12,671 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-04-24 17:09:17,755 - DEBUG - VM is in ACTIVE state now
2026-04-24 17:09:17,755 - INFO - VM name : test_vm
2026-04-24 17:09:17,835 - DEBUG - VM test_vm ID is 46c339c3-b573-4c80-94c3-9a62a773fc38
2026-04-24 17:09:17,858 - DEBUG - VM test_vm launched on Node cn-jenkins-deploy-platform-ansible-os-5683-1
2026-04-24 17:09:17,943 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/46c339c3-b573-4c80-94c3-9a62a773fc38
2026-04-24 17:09:18,253 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/46c339c3-b573-4c80-94c3-9a62a773fc38
2026-04-24 17:09:18,295 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/3a99546e-2dae-4689-bea5-5e95c687b6cb
2026-04-24 17:09:21,563 - 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')
2026-04-24 17:09:21,563 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed!
2026-04-24 17:09:21,620 - DEBUG - Gateway for vn default-domain:ctest-TestRP-38428602:ctest-bgpaas_vn-52166452 is 45.211.173.65 and allocation pool is NOT set
2026-04-24 17:09:23,689 - 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.61 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.32 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 1.318/2.963/4.608/1.645 ms')
2026-04-24 17:09:23,689 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed
2026-04-24 17:09:23,844 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-24 17:09:23,844 - DEBUG - Waiting to SSH to VM test_vm, IP 45.211.173.67, Port 22
2026-04-24 17:09:24,008 - DEBUG - VM test_vm is ready for SSH connections
2026-04-24 17:09:24,008 - INFO - Waiting for VM test2_vm to be up..
2026-04-24 17:09:24,090 - DEBUG - VM is in ACTIVE state now
2026-04-24 17:09:24,091 - INFO - VM name : test2_vm
2026-04-24 17:09:24,169 - DEBUG - VM test2_vm ID is 8123b136-ff08-447b-bde0-6490b696a6a8
2026-04-24 17:09:24,169 - DEBUG - VM test2_vm launched on Node cn-jenkins-deploy-platform-ansible-os-5683-1
2026-04-24 17:09:24,254 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/8123b136-ff08-447b-bde0-6490b696a6a8
2026-04-24 17:09:24,264 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/fcf52b3f-f7a2-46e9-b0d7-2828fcd627f8
2026-04-24 17:09:25,516 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n64 bytes from 169.254.0.4: icmp_seq=1 ttl=63 time=4.51 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=1.41 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 1.413/2.962/4.511/1.549 ms')
2026-04-24 17:09:25,517 - INFO - Ping to Metadata IP 169.254.0.4 of VM test2_vm passed
2026-04-24 17:09:25,668 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-24 17:09:25,668 - DEBUG - Waiting to SSH to VM test2_vm, IP 22.75.120.67, Port 22
2026-04-24 17:09:25,834 - DEBUG - VM test2_vm is ready for SSH connections
2026-04-24 17:09:25,996 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-24 17:09:26,002 - DEBUG - Requesting: http://10.20.0.17:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-38428602:ctest-bgpaas_vn-52166452:ctest-bgpaas_vn-52166452.inet.0
2026-04-24 17:09:26,012 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-04-24 17:09:26,012 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 22.75.120.67, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.38, gateway password: c0ntrail123
2026-04-24 17:09:26,012 - DEBUG - ping -s 56 -c 3 -W 1 22.75.120.67
2026-04-24 17:09:29,690 - DEBUG - PING 22.75.120.67 (22.75.120.67): 56 data bytes
64 bytes from 22.75.120.67: seq=0 ttl=63 time=4.286 ms
64 bytes from 22.75.120.67: seq=1 ttl=63 time=0.997 ms
64 bytes from 22.75.120.67: seq=2 ttl=63 time=0.962 ms
--- 22.75.120.67 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.962/2.081/4.286 ms
2026-04-24 17:09:29,690 - INFO - Ping to IP 22.75.120.67 from VM test_vm passed
2026-04-24 17:09:29,761 - INFO - Deleting VM test2_vm
2026-04-24 17:09:29,838 - INFO - Deleting VM test_vm
2026-04-24 17:09:30,011 - INFO - Deleting VN ctest-bgpaas_vn-43653115
2026-04-24 17:09:30,052 - DEBUG - VN 5007084e-63be-48d7-a091-6ac8ef7c8735 still in use: Unable to complete operation on network 5007084e-63be-48d7-a091-6ac8ef7c8735. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-88dd9f3a-359e-4556-ac76-4db37fa84355']
2026-04-24 17:09:30,052 - WARNING - Deleting VN ctest-bgpaas_vn-43653115 failed..Will retry
2026-04-24 17:09:32,157 - DEBUG - Response for deleting network ()
2026-04-24 17:09:32,158 - INFO - Deleting VN ctest-bgpaas_vn-52166452
2026-04-24 17:09:32,270 - DEBUG - Response for deleting network ()
2026-04-24 17:09:32,525 - DEBUG - No XMPP flaps were noticed during the test
2026-04-24 17:09:32,525 - INFO - END TEST : test_rp_interface : PASSED[0:00:24]
2026-04-24 17:09:32,525 - INFO - --------------------------------------------------------------------------------
2026-04-24 17:09:33,228 - INFO - Deleted project: ctest-TestRP-38428602, ID : 5e4daa7a-2ada-4e24-901f-13bb8fefcb00