2026-01-26 16:56:27,356 - INFO - Domain Default found not creating
2026-01-26 16:56:27,532 - INFO - Project ctest-TestRP-71796241 not found, creating it
2026-01-26 16:56:28,018 - INFO - Created Project:ctest-TestRP-71796241, ID : 9f6bb4fe-625a-482c-8419-799c5deee693
2026-01-26 16:56:29,680 - DEBUG - Services list from nova: [, , ]
2026-01-26 16:56:29,680 - DEBUG - Hosts: {'nova': ['cn-jenkins-deploy-platform-ansible-os-5083-1']}
2026-01-26 16:56:29,683 - INFO - ================================================================================
2026-01-26 16:56:29,683 - INFO - STARTING TEST : test_rp_interface
2026-01-26 16:56:29,683 - 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-01-26 16:56:29,940 - DEBUG - Nothing to compare xmpp stats {'10.0.0.242': {'10.20.0.17': '0'}} with
2026-01-26 16:56:29,940 - INFO - Initial checks done. Running the testcase now
2026-01-26 16:56:29,940 - INFO -
2026-01-26 16:56:30,540 - DEBUG - Response for create_network : {'network': {'id': '40a3c187-4888-48dd-84ea-c9aaa85f1d56', 'name': 'ctest-bgpaas_vn-87957421', 'tenant_id': '9f6bb4fe625a482c8419799c5deee693', 'project_id': '9f6bb4fe625a482c8419799c5deee693', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-71796241', 'ctest-bgpaas_vn-87957421'], 'port_security_enabled': True, 'description': ''}}
2026-01-26 16:56:30,772 - DEBUG - Response for create_subnet : {'subnet': {'id': '883015fe-428a-4d60-8fed-a9a80b3798b3', 'name': '', 'tenant_id': '9f6bb4fe625a482c8419799c5deee693', 'network_id': '40a3c187-4888-48dd-84ea-c9aaa85f1d56', 'ip_version': 4, 'cidr': '207.133.205.128/26', 'allocation_pools': [{'start': '207.133.205.130', 'end': '207.133.205.190'}], 'gateway_ip': '207.133.205.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '207.133.205.130', 'tags': [], 'project_id': '9f6bb4fe625a482c8419799c5deee693'}}
2026-01-26 16:56:30,791 - INFO - Created VN ctest-bgpaas_vn-87957421
2026-01-26 16:56:30,845 - DEBUG - VN ctest-bgpaas_vn-87957421 UUID is 40a3c187-4888-48dd-84ea-c9aaa85f1d56
2026-01-26 16:56:31,327 - DEBUG - Response for create_network : {'network': {'id': 'ac126599-3a38-4203-977e-e51b4e262986', 'name': 'ctest-bgpaas_vn-05646461', 'tenant_id': '9f6bb4fe625a482c8419799c5deee693', 'project_id': '9f6bb4fe625a482c8419799c5deee693', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-71796241', 'ctest-bgpaas_vn-05646461'], 'port_security_enabled': True, 'description': ''}}
2026-01-26 16:56:31,564 - DEBUG - Response for create_subnet : {'subnet': {'id': '85bec1eb-bdd5-4bc4-8061-3967e1954553', 'name': '', 'tenant_id': '9f6bb4fe625a482c8419799c5deee693', 'network_id': 'ac126599-3a38-4203-977e-e51b4e262986', 'ip_version': 4, 'cidr': '85.95.144.192/26', 'allocation_pools': [{'start': '85.95.144.194', 'end': '85.95.144.254'}], 'gateway_ip': '85.95.144.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '85.95.144.194', 'tags': [], 'project_id': '9f6bb4fe625a482c8419799c5deee693'}}
2026-01-26 16:56:31,586 - INFO - Created VN ctest-bgpaas_vn-05646461
2026-01-26 16:56:31,637 - DEBUG - VN ctest-bgpaas_vn-05646461 UUID is ac126599-3a38-4203-977e-e51b4e262986
2026-01-26 16:56:33,135 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5083-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5083-1)
2026-01-26 16:56:34,400 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5083-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5083-1)
2026-01-26 16:56:34,400 - INFO - Waiting for VM test_vm to be up..
2026-01-26 16:56:34,493 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-01-26 16:56:39,572 - DEBUG - VM is in ACTIVE state now
2026-01-26 16:56:39,572 - INFO - VM name : test_vm
2026-01-26 16:56:39,649 - DEBUG - VM test_vm ID is 70704d25-5bf6-4f9c-b696-79213ea13fe9
2026-01-26 16:56:39,782 - DEBUG - VM test_vm launched on Node cn-jenkins-deploy-platform-ansible-os-5083-1
2026-01-26 16:56:39,872 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine/70704d25-5bf6-4f9c-b696-79213ea13fe9
2026-01-26 16:56:40,208 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine/70704d25-5bf6-4f9c-b696-79213ea13fe9
2026-01-26 16:56:40,242 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine-interface/d6b19036-9014-4e12-9c0b-6b2328526373
2026-01-26 16:56:43,508 - 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 1025ms')
2026-01-26 16:56:43,508 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed!
2026-01-26 16:56:43,565 - DEBUG - Gateway for vn default-domain:ctest-TestRP-71796241:ctest-bgpaas_vn-87957421 is 207.133.205.129 and allocation pool is NOT set
2026-01-26 16:56:45,630 - 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.03 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.958 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.958/2.496/4.034/1.538 ms')
2026-01-26 16:56:45,630 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed
2026-01-26 16:56:45,785 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-26 16:56:45,785 - DEBUG - Waiting to SSH to VM test_vm, IP 207.133.205.131, Port 22
2026-01-26 16:56:45,952 - DEBUG - VM test_vm is ready for SSH connections
2026-01-26 16:56:45,952 - INFO - Waiting for VM test2_vm to be up..
2026-01-26 16:56:46,050 - DEBUG - VM is in ACTIVE state now
2026-01-26 16:56:46,051 - INFO - VM name : test2_vm
2026-01-26 16:56:46,134 - DEBUG - VM test2_vm ID is 8175dfdb-99a9-4651-8224-41f49d93bc41
2026-01-26 16:56:46,134 - DEBUG - VM test2_vm launched on Node cn-jenkins-deploy-platform-ansible-os-5083-1
2026-01-26 16:56:46,216 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine/8175dfdb-99a9-4651-8224-41f49d93bc41
2026-01-26 16:56:46,225 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine-interface/7217b2f7-d963-4416-bc1f-8900c054d1f6
2026-01-26 16:56:47,460 - 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.16 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.729 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.729/1.943/3.158/1.214 ms')
2026-01-26 16:56:47,460 - INFO - Ping to Metadata IP 169.254.0.4 of VM test2_vm passed
2026-01-26 16:56:47,613 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-26 16:56:47,613 - DEBUG - Waiting to SSH to VM test2_vm, IP 85.95.144.195, Port 22
2026-01-26 16:56:47,770 - DEBUG - VM test2_vm is ready for SSH connections
2026-01-26 16:56:47,929 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-26 16:56:47,935 - DEBUG - Requesting: http://10.20.0.17:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-71796241:ctest-bgpaas_vn-87957421:ctest-bgpaas_vn-87957421.inet.0
2026-01-26 16:56:47,944 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-26 16:56:47,944 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 85.95.144.195, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.242, gateway password: c0ntrail123
2026-01-26 16:56:47,944 - DEBUG - ping -s 56 -c 3 -W 1 85.95.144.195
2026-01-26 16:56:51,650 - DEBUG - PING 85.95.144.195 (85.95.144.195): 56 data bytes
64 bytes from 85.95.144.195: seq=0 ttl=63 time=3.435 ms
64 bytes from 85.95.144.195: seq=1 ttl=63 time=0.830 ms
64 bytes from 85.95.144.195: seq=2 ttl=63 time=0.957 ms
--- 85.95.144.195 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.830/1.740/3.435 ms
2026-01-26 16:56:51,650 - INFO - Ping to IP 85.95.144.195 from VM test_vm passed
2026-01-26 16:56:51,723 - INFO - Deleting VM test2_vm
2026-01-26 16:56:51,800 - INFO - Deleting VM test_vm
2026-01-26 16:56:51,875 - INFO - Deleting VN ctest-bgpaas_vn-05646461
2026-01-26 16:56:51,916 - DEBUG - VN ac126599-3a38-4203-977e-e51b4e262986 still in use: Unable to complete operation on network ac126599-3a38-4203-977e-e51b4e262986. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-cb215c3b-2d7d-4b4e-9085-e6ed6632a4c8']
2026-01-26 16:56:51,916 - WARNING - Deleting VN ctest-bgpaas_vn-05646461 failed..Will retry
2026-01-26 16:56:54,027 - DEBUG - Response for deleting network ()
2026-01-26 16:56:54,028 - INFO - Deleting VN ctest-bgpaas_vn-87957421
2026-01-26 16:56:54,138 - DEBUG - Response for deleting network ()
2026-01-26 16:56:54,403 - DEBUG - No XMPP flaps were noticed during the test
2026-01-26 16:56:54,403 - INFO - END TEST : test_rp_interface : PASSED[0:00:25]
2026-01-26 16:56:54,403 - INFO - --------------------------------------------------------------------------------
2026-01-26 16:56:55,152 - INFO - Deleted project: ctest-TestRP-71796241, ID : 9f6bb4fe-625a-482c-8419-799c5deee693