2025-11-18 03:37:30,939 - INFO - Domain Default found not creating
2025-11-18 03:37:31,147 - INFO - Project ctest-TestRP-08857356 not found, creating it
2025-11-18 03:37:31,611 - INFO - Created Project:ctest-TestRP-08857356, ID : 98487cd1-90d8-4ab8-8cd6-ce10a980c9bc
2025-11-18 03:37:33,094 - DEBUG - Services list from nova: [, , ]
2025-11-18 03:37:33,094 - DEBUG - Hosts: {'nova': ['cn-jenkins-deploy-platform-ansible-os-4752-1']}
2025-11-18 03:37:33,096 - INFO - ================================================================================
2025-11-18 03:37:33,097 - INFO - STARTING TEST : test_rp_interface
2025-11-18 03:37:33,097 - 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-11-18 03:37:33,349 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.17': '0'}} with
2025-11-18 03:37:33,349 - INFO - Initial checks done. Running the testcase now
2025-11-18 03:37:33,349 - INFO -
2025-11-18 03:37:33,897 - DEBUG - Response for create_network : {'network': {'id': '5863c6b0-ff1e-49a2-817a-1d5302d39323', 'name': 'ctest-bgpaas_vn-93610913', 'tenant_id': '98487cd190d84ab88cd6ce10a980c9bc', 'project_id': '98487cd190d84ab88cd6ce10a980c9bc', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-08857356', 'ctest-bgpaas_vn-93610913'], 'port_security_enabled': True, 'description': ''}}
2025-11-18 03:37:34,094 - DEBUG - Response for create_subnet : {'subnet': {'id': '6b9cc6bc-35a4-401e-b0af-de5082e93b04', 'name': '', 'tenant_id': '98487cd190d84ab88cd6ce10a980c9bc', 'network_id': '5863c6b0-ff1e-49a2-817a-1d5302d39323', 'ip_version': 4, 'cidr': '125.45.12.0/26', 'allocation_pools': [{'start': '125.45.12.2', 'end': '125.45.12.62'}], 'gateway_ip': '125.45.12.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '125.45.12.2', 'tags': [], 'project_id': '98487cd190d84ab88cd6ce10a980c9bc'}}
2025-11-18 03:37:34,113 - INFO - Created VN ctest-bgpaas_vn-93610913
2025-11-18 03:37:34,168 - DEBUG - VN ctest-bgpaas_vn-93610913 UUID is 5863c6b0-ff1e-49a2-817a-1d5302d39323
2025-11-18 03:37:34,629 - DEBUG - Response for create_network : {'network': {'id': '880149db-4302-49c2-a992-84bee82b48a9', 'name': 'ctest-bgpaas_vn-27119603', 'tenant_id': '98487cd190d84ab88cd6ce10a980c9bc', 'project_id': '98487cd190d84ab88cd6ce10a980c9bc', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-08857356', 'ctest-bgpaas_vn-27119603'], 'port_security_enabled': True, 'description': ''}}
2025-11-18 03:37:34,808 - DEBUG - Response for create_subnet : {'subnet': {'id': 'bbb32c5a-73ff-43b2-8cae-7e0a8ada997f', 'name': '', 'tenant_id': '98487cd190d84ab88cd6ce10a980c9bc', 'network_id': '880149db-4302-49c2-a992-84bee82b48a9', 'ip_version': 4, 'cidr': '167.88.143.128/26', 'allocation_pools': [{'start': '167.88.143.130', 'end': '167.88.143.190'}], 'gateway_ip': '167.88.143.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '167.88.143.130', 'tags': [], 'project_id': '98487cd190d84ab88cd6ce10a980c9bc'}}
2025-11-18 03:37:34,824 - INFO - Created VN ctest-bgpaas_vn-27119603
2025-11-18 03:37:34,876 - DEBUG - VN ctest-bgpaas_vn-27119603 UUID is 880149db-4302-49c2-a992-84bee82b48a9
2025-11-18 03:37:36,195 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4752-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4752-1)
2025-11-18 03:37:37,372 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4752-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4752-1)
2025-11-18 03:37:37,372 - INFO - Waiting for VM test_vm to be up..
2025-11-18 03:37:37,484 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-11-18 03:37:42,568 - DEBUG - VM is in ACTIVE state now
2025-11-18 03:37:42,569 - INFO - VM name : test_vm
2025-11-18 03:37:42,646 - DEBUG - VM test_vm ID is e872a524-e945-4222-be52-3acc460a9931
2025-11-18 03:37:42,677 - DEBUG - VM test_vm launched on Node cn-jenkins-deploy-platform-ansible-os-4752-1
2025-11-18 03:37:42,764 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/e872a524-e945-4222-be52-3acc460a9931
2025-11-18 03:37:43,077 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/e872a524-e945-4222-be52-3acc460a9931
2025-11-18 03:37:43,398 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/bdfa6d3d-71f9-4aa9-83b3-cb33314095dc
2025-11-18 03:37:46,643 - 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-11-18 03:37:46,643 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed!
2025-11-18 03:37:46,700 - DEBUG - Gateway for vn default-domain:ctest-TestRP-08857356:ctest-bgpaas_vn-93610913 is 125.45.12.1 and allocation pool is NOT set
2025-11-18 03:37:48,761 - 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.94 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.550 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.550/1.747/2.944/1.197 ms')
2025-11-18 03:37:48,761 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed
2025-11-18 03:37:48,916 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-18 03:37:48,916 - DEBUG - Waiting to SSH to VM test_vm, IP 125.45.12.3, Port 22
2025-11-18 03:37:49,071 - DEBUG - VM test_vm is ready for SSH connections
2025-11-18 03:37:49,071 - INFO - Waiting for VM test2_vm to be up..
2025-11-18 03:37:49,162 - DEBUG - VM is in ACTIVE state now
2025-11-18 03:37:49,162 - INFO - VM name : test2_vm
2025-11-18 03:37:49,238 - DEBUG - VM test2_vm ID is b65bc25b-b84d-409c-90af-f13490ddf2bc
2025-11-18 03:37:49,238 - DEBUG - VM test2_vm launched on Node cn-jenkins-deploy-platform-ansible-os-4752-1
2025-11-18 03:37:49,322 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/b65bc25b-b84d-409c-90af-f13490ddf2bc
2025-11-18 03:37:49,330 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/6bc93d00-8b91-4312-8403-1d8442c3c0d6
2025-11-18 03:37:50,569 - 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=2.66 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.438 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 = 0.438/1.546/2.655/1.108 ms')
2025-11-18 03:37:50,569 - INFO - Ping to Metadata IP 169.254.0.4 of VM test2_vm passed
2025-11-18 03:37:50,724 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-18 03:37:50,724 - DEBUG - Waiting to SSH to VM test2_vm, IP 167.88.143.131, Port 22
2025-11-18 03:37:50,883 - DEBUG - VM test2_vm is ready for SSH connections
2025-11-18 03:37:51,039 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-18 03:37:51,045 - DEBUG - Requesting: http://10.20.0.17:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-08857356:ctest-bgpaas_vn-93610913:ctest-bgpaas_vn-93610913.inet.0
2025-11-18 03:37:51,054 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-18 03:37:51,055 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 167.88.143.131, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2025-11-18 03:37:51,055 - DEBUG - ping -s 56 -c 3 -W 1 167.88.143.131
2025-11-18 03:37:54,692 - DEBUG - PING 167.88.143.131 (167.88.143.131): 56 data bytes
64 bytes from 167.88.143.131: seq=0 ttl=63 time=3.532 ms
64 bytes from 167.88.143.131: seq=1 ttl=63 time=1.049 ms
64 bytes from 167.88.143.131: seq=2 ttl=63 time=0.878 ms
--- 167.88.143.131 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.878/1.819/3.532 ms
2025-11-18 03:37:54,692 - INFO - Ping to IP 167.88.143.131 from VM test_vm passed
2025-11-18 03:37:54,755 - INFO - Deleting VM test2_vm
2025-11-18 03:37:54,823 - INFO - Deleting VM test_vm
2025-11-18 03:37:54,895 - INFO - Deleting VN ctest-bgpaas_vn-27119603
2025-11-18 03:37:54,936 - DEBUG - VN 880149db-4302-49c2-a992-84bee82b48a9 still in use: Unable to complete operation on network 880149db-4302-49c2-a992-84bee82b48a9. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-f72bde1c-7d03-4b44-848d-8df8b821ca19']
2025-11-18 03:37:54,936 - WARNING - Deleting VN ctest-bgpaas_vn-27119603 failed..Will retry
2025-11-18 03:37:57,053 - DEBUG - Response for deleting network ()
2025-11-18 03:37:57,053 - INFO - Deleting VN ctest-bgpaas_vn-93610913
2025-11-18 03:37:57,159 - DEBUG - Response for deleting network ()
2025-11-18 03:37:57,424 - DEBUG - No XMPP flaps were noticed during the test
2025-11-18 03:37:57,424 - INFO - END TEST : test_rp_interface : PASSED[0:00:24]
2025-11-18 03:37:57,424 - INFO - --------------------------------------------------------------------------------
2025-11-18 03:37:58,123 - INFO - Deleted project: ctest-TestRP-08857356, ID : 98487cd1-90d8-4ab8-8cd6-ce10a980c9bc