2025-09-16 12:04:50,739 - INFO - Domain Default found not creating
2025-09-16 12:04:50,881 - INFO - Project ctest-TestRP-33264146 not found, creating it
2025-09-16 12:04:51,335 - INFO - Created Project:ctest-TestRP-33264146, ID : 8227a817-7ec0-4fdc-b2aa-22a698070504
2025-09-16 12:04:52,721 - DEBUG - Services list from nova: [, , ]
2025-09-16 12:04:52,721 - DEBUG - Hosts: {'nova': ['cn-jenkins-deploy-platform-ansible-os-4122-1']}
2025-09-16 12:04:52,724 - INFO - ================================================================================
2025-09-16 12:04:52,724 - INFO - STARTING TEST : test_rp_interface
2025-09-16 12:04:52,724 - 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-16 12:04:52,986 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.254': '0'}} with
2025-09-16 12:04:52,986 - INFO - Initial checks done. Running the testcase now
2025-09-16 12:04:52,986 - INFO -
2025-09-16 12:04:53,510 - DEBUG - Response for create_network : {'network': {'id': '103f945d-d002-4e2b-b842-e16080672499', 'name': 'ctest-bgpaas_vn-63387199', 'tenant_id': '8227a8177ec04fdcb2aa22a698070504', 'project_id': '8227a8177ec04fdcb2aa22a698070504', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-33264146', 'ctest-bgpaas_vn-63387199'], 'port_security_enabled': True, 'description': ''}}
2025-09-16 12:04:53,671 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e5aadfab-df19-4ead-ba42-565ddf862643', 'name': '', 'tenant_id': '8227a8177ec04fdcb2aa22a698070504', 'network_id': '103f945d-d002-4e2b-b842-e16080672499', 'ip_version': 4, 'cidr': '211.195.82.128/26', 'allocation_pools': [{'start': '211.195.82.130', 'end': '211.195.82.190'}], 'gateway_ip': '211.195.82.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '211.195.82.130', 'tags': [], 'project_id': '8227a8177ec04fdcb2aa22a698070504'}}
2025-09-16 12:04:53,686 - INFO - Created VN ctest-bgpaas_vn-63387199
2025-09-16 12:04:53,737 - DEBUG - VN ctest-bgpaas_vn-63387199 UUID is 103f945d-d002-4e2b-b842-e16080672499
2025-09-16 12:04:54,236 - DEBUG - Response for create_network : {'network': {'id': '2d59410b-4d8d-430e-89af-3fdc9898df3f', 'name': 'ctest-bgpaas_vn-19905843', 'tenant_id': '8227a8177ec04fdcb2aa22a698070504', 'project_id': '8227a8177ec04fdcb2aa22a698070504', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-33264146', 'ctest-bgpaas_vn-19905843'], 'port_security_enabled': True, 'description': ''}}
2025-09-16 12:04:54,437 - DEBUG - Response for create_subnet : {'subnet': {'id': '48e2d699-4b30-48d1-ad42-2a4028989256', 'name': '', 'tenant_id': '8227a8177ec04fdcb2aa22a698070504', 'network_id': '2d59410b-4d8d-430e-89af-3fdc9898df3f', 'ip_version': 4, 'cidr': '104.66.19.64/26', 'allocation_pools': [{'start': '104.66.19.66', 'end': '104.66.19.126'}], 'gateway_ip': '104.66.19.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '104.66.19.66', 'tags': [], 'project_id': '8227a8177ec04fdcb2aa22a698070504'}}
2025-09-16 12:04:54,452 - INFO - Created VN ctest-bgpaas_vn-19905843
2025-09-16 12:04:54,505 - DEBUG - VN ctest-bgpaas_vn-19905843 UUID is 2d59410b-4d8d-430e-89af-3fdc9898df3f
2025-09-16 12:04:55,827 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4122-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4122-1)
2025-09-16 12:04:56,903 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4122-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4122-1)
2025-09-16 12:04:56,904 - INFO - Waiting for VM test_vm to be up..
2025-09-16 12:04:56,979 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-09-16 12:05:02,078 - DEBUG - VM is in ACTIVE state now
2025-09-16 12:05:02,078 - INFO - VM name : test_vm
2025-09-16 12:05:02,242 - DEBUG - VM test_vm ID is ca51a18b-c203-41a2-bebc-2b492889f0c8
2025-09-16 12:05:02,259 - DEBUG - VM test_vm launched on Node cn-jenkins-deploy-platform-ansible-os-4122-1
2025-09-16 12:05:02,323 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/ca51a18b-c203-41a2-bebc-2b492889f0c8
2025-09-16 12:05:02,618 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/ca51a18b-c203-41a2-bebc-2b492889f0c8
2025-09-16 12:05:02,646 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/093df537-c966-40bf-a603-0e534e7df8cb
2025-09-16 12:05:05,900 - 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')
2025-09-16 12:05:05,900 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed!
2025-09-16 12:05:05,953 - DEBUG - Gateway for vn default-domain:ctest-TestRP-33264146:ctest-bgpaas_vn-63387199 is 211.195.82.129 and allocation pool is NOT set
2025-09-16 12:05:08,012 - 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.82 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.606 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.606/1.710/2.815/1.104 ms')
2025-09-16 12:05:08,012 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed
2025-09-16 12:05:08,165 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-09-16 12:05:08,165 - DEBUG - Waiting to SSH to VM test_vm, IP 211.195.82.131, Port 22
2025-09-16 12:05:08,320 - DEBUG - VM test_vm is ready for SSH connections
2025-09-16 12:05:08,320 - INFO - Waiting for VM test2_vm to be up..
2025-09-16 12:05:08,391 - DEBUG - VM is in ACTIVE state now
2025-09-16 12:05:08,391 - INFO - VM name : test2_vm
2025-09-16 12:05:08,459 - DEBUG - VM test2_vm ID is edd18c8e-3cb3-4254-8afd-c26e2356de9b
2025-09-16 12:05:08,459 - DEBUG - VM test2_vm launched on Node cn-jenkins-deploy-platform-ansible-os-4122-1
2025-09-16 12:05:08,529 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/edd18c8e-3cb3-4254-8afd-c26e2356de9b
2025-09-16 12:05:08,537 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/97d1daec-eaf6-44b1-bacd-b4193255c148
2025-09-16 12:05:09,764 - 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.79 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.408 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.408/1.600/2.792/1.192 ms')
2025-09-16 12:05:09,764 - INFO - Ping to Metadata IP 169.254.0.4 of VM test2_vm passed
2025-09-16 12:05:09,913 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-09-16 12:05:09,913 - DEBUG - Waiting to SSH to VM test2_vm, IP 104.66.19.67, Port 22
2025-09-16 12:05:10,073 - DEBUG - VM test2_vm is ready for SSH connections
2025-09-16 12:05:10,209 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-09-16 12:05:10,215 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-33264146:ctest-bgpaas_vn-63387199:ctest-bgpaas_vn-63387199.inet.0
2025-09-16 12:05:10,224 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-09-16 12:05:10,224 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 104.66.19.67, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2025-09-16 12:05:10,224 - DEBUG - ping -s 56 -c 3 -W 1 104.66.19.67
2025-09-16 12:05:14,229 - DEBUG - PING 104.66.19.67 (104.66.19.67): 56 data bytes
64 bytes from 104.66.19.67: seq=0 ttl=63 time=3.680 ms
64 bytes from 104.66.19.67: seq=1 ttl=63 time=0.884 ms
64 bytes from 104.66.19.67: seq=2 ttl=63 time=0.822 ms
--- 104.66.19.67 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.822/1.795/3.680 ms
2025-09-16 12:05:14,229 - INFO - Ping to IP 104.66.19.67 from VM test_vm passed
2025-09-16 12:05:14,288 - INFO - Deleting VM test2_vm
2025-09-16 12:05:14,348 - INFO - Deleting VM test_vm
2025-09-16 12:05:14,419 - INFO - Deleting VN ctest-bgpaas_vn-19905843
2025-09-16 12:05:14,451 - DEBUG - VN 2d59410b-4d8d-430e-89af-3fdc9898df3f still in use: Unable to complete operation on network 2d59410b-4d8d-430e-89af-3fdc9898df3f. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-1205bef4-80b5-486b-b5bf-fd8770fad00e']
2025-09-16 12:05:14,452 - WARNING - Deleting VN ctest-bgpaas_vn-19905843 failed..Will retry
2025-09-16 12:05:16,536 - DEBUG - Response for deleting network ()
2025-09-16 12:05:16,537 - INFO - Deleting VN ctest-bgpaas_vn-63387199
2025-09-16 12:05:16,624 - DEBUG - Response for deleting network ()
2025-09-16 12:05:16,878 - DEBUG - No XMPP flaps were noticed during the test
2025-09-16 12:05:16,878 - INFO - END TEST : test_rp_interface : PASSED[0:00:24]
2025-09-16 12:05:16,878 - INFO - --------------------------------------------------------------------------------
2025-09-16 12:05:17,509 - INFO - Deleted project: ctest-TestRP-33264146, ID : 8227a817-7ec0-4fdc-b2aa-22a698070504