2025-09-24 21:55:35,370 - INFO - Domain Default found not creating
2025-09-24 21:55:35,530 - INFO - Project ctest-TestRP-91815663 not found, creating it
2025-09-24 21:55:36,015 - INFO - Created Project:ctest-TestRP-91815663, ID : 62d5578d-d972-4ac3-8717-b2d8305c39a4
2025-09-24 21:55:37,574 - DEBUG - Services list from nova: [, , ]
2025-09-24 21:55:37,574 - DEBUG - Hosts: {'nova': ['cn-jenkins-deploy-platform-ansible-os-4184-1']}
2025-09-24 21:55:37,577 - INFO - ================================================================================
2025-09-24 21:55:37,577 - INFO - STARTING TEST : test_rp_interface
2025-09-24 21:55:37,577 - 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-24 21:55:37,844 - DEBUG - Nothing to compare xmpp stats {'10.0.0.57': {'10.20.0.17': '0'}} with
2025-09-24 21:55:37,844 - INFO - Initial checks done. Running the testcase now
2025-09-24 21:55:37,844 - INFO -
2025-09-24 21:55:38,457 - DEBUG - Response for create_network : {'network': {'id': '627ccf47-86dc-458b-8ae9-1bf3d6447e0e', 'name': 'ctest-bgpaas_vn-80360738', 'tenant_id': '62d5578dd9724ac38717b2d8305c39a4', 'project_id': '62d5578dd9724ac38717b2d8305c39a4', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-91815663', 'ctest-bgpaas_vn-80360738'], 'port_security_enabled': True, 'description': ''}}
2025-09-24 21:55:38,634 - DEBUG - Response for create_subnet : {'subnet': {'id': '584f4b19-6be8-40c3-90da-418024bc7570', 'name': '', 'tenant_id': '62d5578dd9724ac38717b2d8305c39a4', 'network_id': '627ccf47-86dc-458b-8ae9-1bf3d6447e0e', 'ip_version': 4, 'cidr': '72.184.8.128/26', 'allocation_pools': [{'start': '72.184.8.130', 'end': '72.184.8.190'}], 'gateway_ip': '72.184.8.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '72.184.8.130', 'tags': [], 'project_id': '62d5578dd9724ac38717b2d8305c39a4'}}
2025-09-24 21:55:38,659 - INFO - Created VN ctest-bgpaas_vn-80360738
2025-09-24 21:55:38,714 - DEBUG - VN ctest-bgpaas_vn-80360738 UUID is 627ccf47-86dc-458b-8ae9-1bf3d6447e0e
2025-09-24 21:55:39,203 - DEBUG - Response for create_network : {'network': {'id': '6dabde44-92da-46eb-a192-9b60c921a00a', 'name': 'ctest-bgpaas_vn-80533987', 'tenant_id': '62d5578dd9724ac38717b2d8305c39a4', 'project_id': '62d5578dd9724ac38717b2d8305c39a4', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-91815663', 'ctest-bgpaas_vn-80533987'], 'port_security_enabled': True, 'description': ''}}
2025-09-24 21:55:39,453 - DEBUG - Response for create_subnet : {'subnet': {'id': '7c9ba109-66b6-40af-b03f-c9d90e33b159', 'name': '', 'tenant_id': '62d5578dd9724ac38717b2d8305c39a4', 'network_id': '6dabde44-92da-46eb-a192-9b60c921a00a', 'ip_version': 4, 'cidr': '47.144.156.128/26', 'allocation_pools': [{'start': '47.144.156.130', 'end': '47.144.156.190'}], 'gateway_ip': '47.144.156.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '47.144.156.130', 'tags': [], 'project_id': '62d5578dd9724ac38717b2d8305c39a4'}}
2025-09-24 21:55:39,472 - INFO - Created VN ctest-bgpaas_vn-80533987
2025-09-24 21:55:39,525 - DEBUG - VN ctest-bgpaas_vn-80533987 UUID is 6dabde44-92da-46eb-a192-9b60c921a00a
2025-09-24 21:55:40,944 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4184-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4184-1)
2025-09-24 21:55:42,113 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4184-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4184-1)
2025-09-24 21:55:42,113 - INFO - Waiting for VM test_vm to be up..
2025-09-24 21:55:42,331 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-09-24 21:55:47,423 - DEBUG - VM is in ACTIVE state now
2025-09-24 21:55:47,423 - INFO - VM name : test_vm
2025-09-24 21:55:47,504 - DEBUG - VM test_vm ID is 9583888e-a161-452a-8046-5ae21445ee84
2025-09-24 21:55:47,525 - DEBUG - VM test_vm launched on Node cn-jenkins-deploy-platform-ansible-os-4184-1
2025-09-24 21:55:47,609 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-machine/9583888e-a161-452a-8046-5ae21445ee84
2025-09-24 21:55:47,914 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-machine/9583888e-a161-452a-8046-5ae21445ee84
2025-09-24 21:55:47,948 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-machine-interface/450ac739-7c43-4a6b-9243-3ac9791a8133
2025-09-24 21:55:51,200 - 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 1006ms')
2025-09-24 21:55:51,200 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed!
2025-09-24 21:55:51,254 - DEBUG - Gateway for vn default-domain:ctest-TestRP-91815663:ctest-bgpaas_vn-80360738 is 72.184.8.129 and allocation pool is NOT set
2025-09-24 21:55:53,319 - 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.86 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.524 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.524/1.693/2.863/1.169 ms')
2025-09-24 21:55:53,320 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed
2025-09-24 21:55:53,474 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-09-24 21:55:53,474 - DEBUG - Waiting to SSH to VM test_vm, IP 72.184.8.131, Port 22
2025-09-24 21:55:53,634 - DEBUG - VM test_vm is ready for SSH connections
2025-09-24 21:55:53,634 - INFO - Waiting for VM test2_vm to be up..
2025-09-24 21:55:53,712 - DEBUG - VM is in ACTIVE state now
2025-09-24 21:55:53,713 - INFO - VM name : test2_vm
2025-09-24 21:55:53,794 - DEBUG - VM test2_vm ID is 66687a0e-57ac-4e74-abbe-58c9da1274e7
2025-09-24 21:55:53,794 - DEBUG - VM test2_vm launched on Node cn-jenkins-deploy-platform-ansible-os-4184-1
2025-09-24 21:55:53,891 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-machine/66687a0e-57ac-4e74-abbe-58c9da1274e7
2025-09-24 21:55:53,900 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-machine-interface/c259f88a-05e3-4aa6-95be-d14fecfc279a
2025-09-24 21:55:55,152 - 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=3.39 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.835 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.835/2.111/3.387/1.276 ms')
2025-09-24 21:55:55,152 - INFO - Ping to Metadata IP 169.254.0.4 of VM test2_vm passed
2025-09-24 21:55:55,302 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-09-24 21:55:55,302 - DEBUG - Waiting to SSH to VM test2_vm, IP 47.144.156.131, Port 22
2025-09-24 21:55:55,472 - DEBUG - VM test2_vm is ready for SSH connections
2025-09-24 21:55:55,621 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-09-24 21:55:55,628 - DEBUG - Requesting: http://10.20.0.17:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-91815663:ctest-bgpaas_vn-80360738:ctest-bgpaas_vn-80360738.inet.0
2025-09-24 21:55:55,638 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-09-24 21:55:55,639 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 47.144.156.131, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.57, gateway password: c0ntrail123
2025-09-24 21:55:55,639 - DEBUG - ping -s 56 -c 3 -W 1 47.144.156.131
2025-09-24 21:55:59,715 - DEBUG - PING 47.144.156.131 (47.144.156.131): 56 data bytes
64 bytes from 47.144.156.131: seq=0 ttl=63 time=3.835 ms
64 bytes from 47.144.156.131: seq=1 ttl=63 time=0.967 ms
64 bytes from 47.144.156.131: seq=2 ttl=63 time=0.870 ms
--- 47.144.156.131 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.870/1.890/3.835 ms
2025-09-24 21:55:59,715 - INFO - Ping to IP 47.144.156.131 from VM test_vm passed
2025-09-24 21:55:59,799 - INFO - Deleting VM test2_vm
2025-09-24 21:55:59,882 - INFO - Deleting VM test_vm
2025-09-24 21:55:59,987 - INFO - Deleting VN ctest-bgpaas_vn-80533987
2025-09-24 21:56:00,031 - DEBUG - VN 6dabde44-92da-46eb-a192-9b60c921a00a still in use: Unable to complete operation on network 6dabde44-92da-46eb-a192-9b60c921a00a. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-1da55e35-16d5-42d8-a3d3-9ee185461314']
2025-09-24 21:56:00,032 - WARNING - Deleting VN ctest-bgpaas_vn-80533987 failed..Will retry
2025-09-24 21:56:02,162 - DEBUG - Response for deleting network ()
2025-09-24 21:56:02,162 - INFO - Deleting VN ctest-bgpaas_vn-80360738
2025-09-24 21:56:02,315 - DEBUG - Response for deleting network ()
2025-09-24 21:56:02,586 - DEBUG - No XMPP flaps were noticed during the test
2025-09-24 21:56:02,586 - INFO - END TEST : test_rp_interface : PASSED[0:00:25]
2025-09-24 21:56:02,586 - INFO - --------------------------------------------------------------------------------
2025-09-24 21:56:03,302 - INFO - Deleted project: ctest-TestRP-91815663, ID : 62d5578d-d972-4ac3-8717-b2d8305c39a4