2026-10-29 18:51:39,484 - INFO - Domain Default found not creating
2026-10-29 18:51:39,633 - INFO - Project ctest-TestRP-40710231 not found, creating it
2026-10-29 18:51:40,106 - INFO - Created Project:ctest-TestRP-40710231, ID : 0dd2115d-2cbe-4c48-8671-b177745f1a8c
2026-10-29 18:51:41,866 - DEBUG - Services list from nova: [, , ]
2026-10-29 18:51:41,866 - DEBUG - Hosts: {'nova': ['cn-jenkins-deploy-platform-ansible-os-6440-1']}
2026-10-29 18:51:41,870 - INFO - ================================================================================
2026-10-29 18:51:41,870 - INFO - STARTING TEST : test_rp_interface
2026-10-29 18:51:41,870 - 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-10-29 18:51:42,129 - DEBUG - Nothing to compare xmpp stats {'10.0.0.248': {'10.20.0.25': '0'}} with
2026-10-29 18:51:42,129 - INFO - Initial checks done. Running the testcase now
2026-10-29 18:51:42,130 - INFO -
2026-10-29 18:51:42,728 - DEBUG - Response for create_network : {'network': {'id': '7cb128ac-8256-42b0-bdbc-28b0bbfce3b2', 'name': 'ctest-bgpaas_vn-77852489', 'tenant_id': '0dd2115d2cbe4c488671b177745f1a8c', 'project_id': '0dd2115d2cbe4c488671b177745f1a8c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-40710231', 'ctest-bgpaas_vn-77852489'], 'port_security_enabled': True, 'description': ''}}
2026-10-29 18:51:42,901 - DEBUG - Response for create_subnet : {'subnet': {'id': '8160c79d-5790-40e2-b2f3-b088795ebac3', 'name': '', 'tenant_id': '0dd2115d2cbe4c488671b177745f1a8c', 'network_id': '7cb128ac-8256-42b0-bdbc-28b0bbfce3b2', 'ip_version': 4, 'cidr': '17.56.235.128/26', 'allocation_pools': [{'start': '17.56.235.130', 'end': '17.56.235.190'}], 'gateway_ip': '17.56.235.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '17.56.235.130', 'tags': [], 'project_id': '0dd2115d2cbe4c488671b177745f1a8c'}}
2026-10-29 18:51:42,918 - INFO - Created VN ctest-bgpaas_vn-77852489
2026-10-29 18:51:42,971 - DEBUG - VN ctest-bgpaas_vn-77852489 UUID is 7cb128ac-8256-42b0-bdbc-28b0bbfce3b2
2026-10-29 18:51:43,437 - DEBUG - Response for create_network : {'network': {'id': 'c2e69b71-d144-446c-b135-0e5e2219eb1d', 'name': 'ctest-bgpaas_vn-64514247', 'tenant_id': '0dd2115d2cbe4c488671b177745f1a8c', 'project_id': '0dd2115d2cbe4c488671b177745f1a8c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-40710231', 'ctest-bgpaas_vn-64514247'], 'port_security_enabled': True, 'description': ''}}
2026-10-29 18:51:43,680 - DEBUG - Response for create_subnet : {'subnet': {'id': 'bee722bc-04d3-4942-a1bb-fa2bfdb7e037', 'name': '', 'tenant_id': '0dd2115d2cbe4c488671b177745f1a8c', 'network_id': 'c2e69b71-d144-446c-b135-0e5e2219eb1d', 'ip_version': 4, 'cidr': '21.173.212.192/26', 'allocation_pools': [{'start': '21.173.212.194', 'end': '21.173.212.254'}], 'gateway_ip': '21.173.212.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '21.173.212.194', 'tags': [], 'project_id': '0dd2115d2cbe4c488671b177745f1a8c'}}
2026-10-29 18:51:43,699 - INFO - Created VN ctest-bgpaas_vn-64514247
2026-10-29 18:51:43,751 - DEBUG - VN ctest-bgpaas_vn-64514247 UUID is c2e69b71-d144-446c-b135-0e5e2219eb1d
2026-10-29 18:51:44,456 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6440-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6440-1)
2026-10-29 18:51:44,789 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6440-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6440-1)
2026-10-29 18:51:44,789 - INFO - Waiting for VM test_vm to be up..
2026-10-29 18:51:44,827 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-29 18:51:49,898 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-29 18:51:54,959 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-29 18:52:00,060 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-29 18:52:05,125 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-29 18:52:10,187 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-29 18:52:15,250 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-29 18:52:20,319 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-29 18:52:25,387 - DEBUG - VM is in ACTIVE state now
2026-10-29 18:52:25,387 - INFO - VM name : test_vm
2026-10-29 18:52:25,449 - DEBUG - VM test_vm ID is 497871a6-fecc-4c72-94b0-912a3465d0b9
2026-10-29 18:52:25,465 - DEBUG - VM test_vm launched on Node cn-jenkins-deploy-platform-ansible-os-6440-1
2026-10-29 18:52:25,528 - DEBUG - Requesting: http://10.0.0.248:8082/virtual-machine/497871a6-fecc-4c72-94b0-912a3465d0b9
2026-10-29 18:52:25,890 - DEBUG - Requesting: http://10.0.0.248:8082/virtual-machine/497871a6-fecc-4c72-94b0-912a3465d0b9
2026-10-29 18:52:25,916 - DEBUG - Requesting: http://10.0.0.248:8082/virtual-machine-interface/8db8e72f-b829-464d-9af5-582d78b066cb
2026-10-29 18:52:29,161 - 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=2 ttl=63 time=2.67 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1006ms\r\nrtt min/avg/max/mdev = 2.671/2.671/2.671/0.000 ms')
2026-10-29 18:52:29,161 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed
2026-10-29 18:52:29,315 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-10-29 18:52:29,315 - DEBUG - Waiting to SSH to VM test_vm, IP 17.56.235.131, Port 22
2026-10-29 18:52:29,471 - DEBUG - VM test_vm is ready for SSH connections
2026-10-29 18:52:29,471 - INFO - Waiting for VM test2_vm to be up..
2026-10-29 18:52:29,536 - DEBUG - VM is in ACTIVE state now
2026-10-29 18:52:29,537 - INFO - VM name : test2_vm
2026-10-29 18:52:29,605 - DEBUG - VM test2_vm ID is cc78fee4-d082-41e7-8f9b-a0a84fbb1324
2026-10-29 18:52:29,605 - DEBUG - VM test2_vm launched on Node cn-jenkins-deploy-platform-ansible-os-6440-1
2026-10-29 18:52:29,669 - DEBUG - Requesting: http://10.0.0.248:8082/virtual-machine/cc78fee4-d082-41e7-8f9b-a0a84fbb1324
2026-10-29 18:52:29,678 - DEBUG - Requesting: http://10.0.0.248:8082/virtual-machine-interface/5546f3d5-13b2-45bc-95d3-138755e2adf2
2026-10-29 18:52:30,907 - 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=8.30 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.278 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.278/4.288/8.298/4.010 ms')
2026-10-29 18:52:30,907 - INFO - Ping to Metadata IP 169.254.0.4 of VM test2_vm passed
2026-10-29 18:52:31,054 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-10-29 18:52:31,055 - DEBUG - Waiting to SSH to VM test2_vm, IP 21.173.212.195, Port 22
2026-10-29 18:52:31,210 - DEBUG - VM test2_vm is ready for SSH connections
2026-10-29 18:52:31,346 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-10-29 18:52:31,351 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-40710231:ctest-bgpaas_vn-77852489:ctest-bgpaas_vn-77852489.inet.0
2026-10-29 18:52:32,361 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-10-29 18:52:32,366 - DEBUG - Requesting: http://10.20.0.25:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-40710231:ctest-bgpaas_vn-77852489:ctest-bgpaas_vn-77852489.inet.0
2026-10-29 18:52:32,374 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-10-29 18:52:32,374 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 21.173.212.195, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.248, gateway password: c0ntrail123
2026-10-29 18:52:32,374 - DEBUG - ping -s 56 -c 3 -W 1 21.173.212.195
2026-10-29 18:52:36,284 - DEBUG - PING 21.173.212.195 (21.173.212.195): 56 data bytes
64 bytes from 21.173.212.195: seq=0 ttl=63 time=4.228 ms
64 bytes from 21.173.212.195: seq=1 ttl=63 time=0.754 ms
64 bytes from 21.173.212.195: seq=2 ttl=63 time=0.874 ms
--- 21.173.212.195 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.754/1.952/4.228 ms
2026-10-29 18:52:36,285 - INFO - Ping to IP 21.173.212.195 from VM test_vm passed
2026-10-29 18:52:36,340 - INFO - Deleting VM test2_vm
2026-10-29 18:52:36,404 - INFO - Deleting VM test_vm
2026-10-29 18:52:36,464 - INFO - Deleting VN ctest-bgpaas_vn-64514247
2026-10-29 18:52:36,492 - DEBUG - VN c2e69b71-d144-446c-b135-0e5e2219eb1d still in use: Unable to complete operation on network c2e69b71-d144-446c-b135-0e5e2219eb1d. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-5330a735-f64d-4ddd-a905-8cb8589060f8']
2026-10-29 18:52:36,492 - WARNING - Deleting VN ctest-bgpaas_vn-64514247 failed..Will retry
2026-10-29 18:52:38,521 - DEBUG - VN c2e69b71-d144-446c-b135-0e5e2219eb1d still in use: Unable to complete operation on network c2e69b71-d144-446c-b135-0e5e2219eb1d. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-ae875492-af97-4d6a-8d32-cec9ecfae64e']
2026-10-29 18:52:38,521 - WARNING - Deleting VN ctest-bgpaas_vn-64514247 failed..Will retry
2026-10-29 18:52:40,609 - DEBUG - Response for deleting network ()
2026-10-29 18:52:40,609 - INFO - Deleting VN ctest-bgpaas_vn-77852489
2026-10-29 18:52:40,703 - DEBUG - Response for deleting network ()
2026-10-29 18:52:40,959 - DEBUG - No XMPP flaps were noticed during the test
2026-10-29 18:52:40,959 - INFO - END TEST : test_rp_interface : PASSED[0:00:59]
2026-10-29 18:52:40,959 - INFO - --------------------------------------------------------------------------------
2026-10-29 18:52:41,695 - INFO - Deleted project: ctest-TestRP-40710231, ID : 0dd2115d-2cbe-4c48-8671-b177745f1a8c