2026-02-04 10:06:46,473 - INFO - Domain Default found not creating
2026-02-04 10:06:46,621 - INFO - Project ctest-TestRP-45218498 not found, creating it
2026-02-04 10:06:47,064 - INFO - Created Project:ctest-TestRP-45218498, ID : 4d5c1ea7-4741-4e8c-8521-99a17767dc25
2026-02-04 10:06:48,570 - DEBUG - Services list from nova: [, , ]
2026-02-04 10:06:48,570 - DEBUG - Hosts: {'nova': ['cn-jenkins-deploy-platform-ansible-os-5200-1']}
2026-02-04 10:06:48,572 - INFO - ================================================================================
2026-02-04 10:06:48,572 - INFO - STARTING TEST : test_rp_interface
2026-02-04 10:06:48,572 - 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-02-04 10:06:48,827 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.17': '0'}} with
2026-02-04 10:06:48,827 - INFO - Initial checks done. Running the testcase now
2026-02-04 10:06:48,827 - INFO -
2026-02-04 10:06:49,359 - DEBUG - Response for create_network : {'network': {'id': '0704eda1-b5a6-429a-83f1-2771f08eb7a6', 'name': 'ctest-bgpaas_vn-43034411', 'tenant_id': '4d5c1ea747414e8c852199a17767dc25', 'project_id': '4d5c1ea747414e8c852199a17767dc25', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-45218498', 'ctest-bgpaas_vn-43034411'], 'port_security_enabled': True, 'description': ''}}
2026-02-04 10:06:49,564 - DEBUG - Response for create_subnet : {'subnet': {'id': '5c171acd-0f24-4368-b691-eda15f98fcc4', 'name': '', 'tenant_id': '4d5c1ea747414e8c852199a17767dc25', 'network_id': '0704eda1-b5a6-429a-83f1-2771f08eb7a6', 'ip_version': 4, 'cidr': '86.68.118.64/26', 'allocation_pools': [{'start': '86.68.118.66', 'end': '86.68.118.126'}], 'gateway_ip': '86.68.118.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '86.68.118.66', 'tags': [], 'project_id': '4d5c1ea747414e8c852199a17767dc25'}}
2026-02-04 10:06:49,581 - INFO - Created VN ctest-bgpaas_vn-43034411
2026-02-04 10:06:49,634 - DEBUG - VN ctest-bgpaas_vn-43034411 UUID is 0704eda1-b5a6-429a-83f1-2771f08eb7a6
2026-02-04 10:06:50,105 - DEBUG - Response for create_network : {'network': {'id': '90e39039-c6a2-4159-acd9-3c82c080d85a', 'name': 'ctest-bgpaas_vn-31930989', 'tenant_id': '4d5c1ea747414e8c852199a17767dc25', 'project_id': '4d5c1ea747414e8c852199a17767dc25', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-45218498', 'ctest-bgpaas_vn-31930989'], 'port_security_enabled': True, 'description': ''}}
2026-02-04 10:06:50,285 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd440b7d7-0f20-469a-92bf-d50a5fc65984', 'name': '', 'tenant_id': '4d5c1ea747414e8c852199a17767dc25', 'network_id': '90e39039-c6a2-4159-acd9-3c82c080d85a', 'ip_version': 4, 'cidr': '79.29.215.64/26', 'allocation_pools': [{'start': '79.29.215.66', 'end': '79.29.215.126'}], 'gateway_ip': '79.29.215.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '79.29.215.66', 'tags': [], 'project_id': '4d5c1ea747414e8c852199a17767dc25'}}
2026-02-04 10:06:50,301 - INFO - Created VN ctest-bgpaas_vn-31930989
2026-02-04 10:06:50,354 - DEBUG - VN ctest-bgpaas_vn-31930989 UUID is 90e39039-c6a2-4159-acd9-3c82c080d85a
2026-02-04 10:06:51,715 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5200-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5200-1)
2026-02-04 10:06:52,854 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5200-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5200-1)
2026-02-04 10:06:52,854 - INFO - Waiting for VM test_vm to be up..
2026-02-04 10:06:52,924 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-02-04 10:06:58,007 - DEBUG - VM is in ACTIVE state now
2026-02-04 10:06:58,007 - INFO - VM name : test_vm
2026-02-04 10:06:58,086 - DEBUG - VM test_vm ID is fb0c7445-7ace-4070-a551-beb4a8ba0f7f
2026-02-04 10:06:58,107 - DEBUG - VM test_vm launched on Node cn-jenkins-deploy-platform-ansible-os-5200-1
2026-02-04 10:06:58,180 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/fb0c7445-7ace-4070-a551-beb4a8ba0f7f
2026-02-04 10:06:58,473 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/fb0c7445-7ace-4070-a551-beb4a8ba0f7f
2026-02-04 10:06:58,506 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/dfe51241-c84d-4306-b237-20b153802e0f
2026-02-04 10:07:01,763 - 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 1022ms')
2026-02-04 10:07:01,763 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed!
2026-02-04 10:07:01,817 - DEBUG - Gateway for vn default-domain:ctest-TestRP-45218498:ctest-bgpaas_vn-43034411 is 86.68.118.65 and allocation pool is NOT set
2026-02-04 10:07:03,879 - 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.41 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.39 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.387/2.899/4.411/1.512 ms')
2026-02-04 10:07:03,879 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed
2026-02-04 10:07:04,025 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-04 10:07:04,026 - DEBUG - Waiting to SSH to VM test_vm, IP 86.68.118.67, Port 22
2026-02-04 10:07:04,181 - DEBUG - VM test_vm is ready for SSH connections
2026-02-04 10:07:04,181 - INFO - Waiting for VM test2_vm to be up..
2026-02-04 10:07:04,253 - DEBUG - VM is in ACTIVE state now
2026-02-04 10:07:04,253 - INFO - VM name : test2_vm
2026-02-04 10:07:04,328 - DEBUG - VM test2_vm ID is f1f1ad55-8d2b-4984-8678-775320462a0b
2026-02-04 10:07:04,328 - DEBUG - VM test2_vm launched on Node cn-jenkins-deploy-platform-ansible-os-5200-1
2026-02-04 10:07:04,404 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/f1f1ad55-8d2b-4984-8678-775320462a0b
2026-02-04 10:07:04,412 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/890ad181-3f01-424d-86b1-fefc799f6f29
2026-02-04 10:07:05,648 - 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.96 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.436 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.436/1.695/2.955/1.259 ms')
2026-02-04 10:07:05,648 - INFO - Ping to Metadata IP 169.254.0.4 of VM test2_vm passed
2026-02-04 10:07:05,797 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-04 10:07:05,798 - DEBUG - Waiting to SSH to VM test2_vm, IP 79.29.215.67, Port 22
2026-02-04 10:07:05,961 - DEBUG - VM test2_vm is ready for SSH connections
2026-02-04 10:07:06,117 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-04 10:07:06,122 - DEBUG - Requesting: http://10.20.0.17:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-45218498:ctest-bgpaas_vn-43034411:ctest-bgpaas_vn-43034411.inet.0
2026-02-04 10:07:06,131 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-04 10:07:06,131 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 79.29.215.67, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.38, gateway password: c0ntrail123
2026-02-04 10:07:06,132 - DEBUG - ping -s 56 -c 3 -W 1 79.29.215.67
2026-02-04 10:07:09,804 - DEBUG - PING 79.29.215.67 (79.29.215.67): 56 data bytes
64 bytes from 79.29.215.67: seq=0 ttl=63 time=4.275 ms
64 bytes from 79.29.215.67: seq=1 ttl=63 time=0.925 ms
64 bytes from 79.29.215.67: seq=2 ttl=63 time=0.789 ms
--- 79.29.215.67 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.789/1.996/4.275 ms
2026-02-04 10:07:09,805 - INFO - Ping to IP 79.29.215.67 from VM test_vm passed
2026-02-04 10:07:09,861 - INFO - Deleting VM test2_vm
2026-02-04 10:07:09,939 - INFO - Deleting VM test_vm
2026-02-04 10:07:10,006 - INFO - Deleting VN ctest-bgpaas_vn-31930989
2026-02-04 10:07:10,041 - DEBUG - VN 90e39039-c6a2-4159-acd9-3c82c080d85a still in use: Unable to complete operation on network 90e39039-c6a2-4159-acd9-3c82c080d85a. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-4bb9ea89-82da-4b19-a357-e77b1c41bb6f']
2026-02-04 10:07:10,041 - WARNING - Deleting VN ctest-bgpaas_vn-31930989 failed..Will retry
2026-02-04 10:07:12,139 - DEBUG - Response for deleting network ()
2026-02-04 10:07:12,139 - INFO - Deleting VN ctest-bgpaas_vn-43034411
2026-02-04 10:07:12,229 - DEBUG - Response for deleting network ()
2026-02-04 10:07:12,492 - DEBUG - No XMPP flaps were noticed during the test
2026-02-04 10:07:12,492 - INFO - END TEST : test_rp_interface : PASSED[0:00:24]
2026-02-04 10:07:12,492 - INFO - --------------------------------------------------------------------------------
2026-02-04 10:07:13,167 - INFO - Deleted project: ctest-TestRP-45218498, ID : 4d5c1ea7-4741-4e8c-8521-99a17767dc25