2025-08-21 02:10:15,143 - INFO - Domain Default found not creating
2025-08-21 02:10:15,267 - INFO - Project ctest-TestRP-08264689 not found, creating it
2025-08-21 02:10:15,698 - INFO - Created Project:ctest-TestRP-08264689, ID : 2aceb6c5-1047-4f76-8670-22ccbd5f2c16
2025-08-21 02:10:17,077 - DEBUG - Services list from nova: [, , ]
2025-08-21 02:10:17,078 - DEBUG - Hosts: {'nova': ['cn-jenkins-deploy-platform-ansible-os-3905-1']}
2025-08-21 02:10:17,080 - INFO - ================================================================================
2025-08-21 02:10:17,080 - INFO - STARTING TEST : test_rp_interface
2025-08-21 02:10:17,080 - 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-08-21 02:10:17,333 - DEBUG - Nothing to compare xmpp stats {'10.0.0.23': {'10.20.0.192': '0'}} with
2025-08-21 02:10:17,333 - INFO - Initial checks done. Running the testcase now
2025-08-21 02:10:17,333 - INFO -
2025-08-21 02:10:17,865 - DEBUG - Response for create_network : {'network': {'id': '93fb7edc-445c-4f2c-8b51-1d6749d2bb16', 'name': 'ctest-bgpaas_vn-75098510', 'tenant_id': '2aceb6c510474f76867022ccbd5f2c16', 'project_id': '2aceb6c510474f76867022ccbd5f2c16', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-08264689', 'ctest-bgpaas_vn-75098510'], 'port_security_enabled': True, 'description': ''}}
2025-08-21 02:10:18,088 - DEBUG - Response for create_subnet : {'subnet': {'id': '0aba36ca-d67f-4f90-8735-34722a122e71', 'name': '', 'tenant_id': '2aceb6c510474f76867022ccbd5f2c16', 'network_id': '93fb7edc-445c-4f2c-8b51-1d6749d2bb16', 'ip_version': 4, 'cidr': '160.28.200.192/26', 'allocation_pools': [{'start': '160.28.200.194', 'end': '160.28.200.254'}], 'gateway_ip': '160.28.200.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '160.28.200.194', 'tags': [], 'project_id': '2aceb6c510474f76867022ccbd5f2c16'}}
2025-08-21 02:10:18,107 - INFO - Created VN ctest-bgpaas_vn-75098510
2025-08-21 02:10:18,160 - DEBUG - VN ctest-bgpaas_vn-75098510 UUID is 93fb7edc-445c-4f2c-8b51-1d6749d2bb16
2025-08-21 02:10:18,636 - DEBUG - Response for create_network : {'network': {'id': 'bc946385-3486-4eb5-9120-29b5db3beee4', 'name': 'ctest-bgpaas_vn-64161571', 'tenant_id': '2aceb6c510474f76867022ccbd5f2c16', 'project_id': '2aceb6c510474f76867022ccbd5f2c16', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-08264689', 'ctest-bgpaas_vn-64161571'], 'port_security_enabled': True, 'description': ''}}
2025-08-21 02:10:18,860 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f7fca108-4bdc-44d8-9870-1300b7bd6222', 'name': '', 'tenant_id': '2aceb6c510474f76867022ccbd5f2c16', 'network_id': 'bc946385-3486-4eb5-9120-29b5db3beee4', 'ip_version': 4, 'cidr': '114.231.12.192/26', 'allocation_pools': [{'start': '114.231.12.194', 'end': '114.231.12.254'}], 'gateway_ip': '114.231.12.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '114.231.12.194', 'tags': [], 'project_id': '2aceb6c510474f76867022ccbd5f2c16'}}
2025-08-21 02:10:18,878 - INFO - Created VN ctest-bgpaas_vn-64161571
2025-08-21 02:10:18,932 - DEBUG - VN ctest-bgpaas_vn-64161571 UUID is bc946385-3486-4eb5-9120-29b5db3beee4
2025-08-21 02:10:20,234 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3905-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3905-1)
2025-08-21 02:10:21,389 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3905-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3905-1)
2025-08-21 02:10:21,390 - INFO - Waiting for VM test_vm to be up..
2025-08-21 02:10:21,467 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-08-21 02:10:26,539 - DEBUG - VM is in ACTIVE state now
2025-08-21 02:10:26,539 - INFO - VM name : test_vm
2025-08-21 02:10:26,610 - DEBUG - VM test_vm ID is 8522594a-d17e-49ce-a7e7-4e417ff133d2
2025-08-21 02:10:26,630 - DEBUG - VM test_vm launched on Node cn-jenkins-deploy-platform-ansible-os-3905-1
2025-08-21 02:10:26,702 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/8522594a-d17e-49ce-a7e7-4e417ff133d2
2025-08-21 02:10:27,000 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/8522594a-d17e-49ce-a7e7-4e417ff133d2
2025-08-21 02:10:27,031 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/2b3f2b70-0120-482c-8c18-0bd2ea88b3da
2025-08-21 02:10:30,303 - 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 1028ms')
2025-08-21 02:10:30,303 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed!
2025-08-21 02:10:30,360 - DEBUG - Gateway for vn default-domain:ctest-TestRP-08264689:ctest-bgpaas_vn-75098510 is 160.28.200.193 and allocation pool is NOT set
2025-08-21 02:10:32,426 - 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.52 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.396 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.396/1.457/2.518/1.061 ms')
2025-08-21 02:10:32,426 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed
2025-08-21 02:10:32,580 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-21 02:10:32,580 - DEBUG - Waiting to SSH to VM test_vm, IP 160.28.200.195, Port 22
2025-08-21 02:10:32,734 - DEBUG - VM test_vm is ready for SSH connections
2025-08-21 02:10:32,735 - INFO - Waiting for VM test2_vm to be up..
2025-08-21 02:10:32,802 - DEBUG - VM is in ACTIVE state now
2025-08-21 02:10:32,802 - INFO - VM name : test2_vm
2025-08-21 02:10:32,868 - DEBUG - VM test2_vm ID is 351d607c-d45c-47a6-9e42-53f1d0c9783e
2025-08-21 02:10:32,869 - DEBUG - VM test2_vm launched on Node cn-jenkins-deploy-platform-ansible-os-3905-1
2025-08-21 02:10:32,931 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/351d607c-d45c-47a6-9e42-53f1d0c9783e
2025-08-21 02:10:32,939 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/d03b960e-b360-41a4-b3c6-679f5a4422a3
2025-08-21 02:10:34,169 - 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.03 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.452 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.452/1.740/3.028/1.288 ms')
2025-08-21 02:10:34,170 - INFO - Ping to Metadata IP 169.254.0.4 of VM test2_vm passed
2025-08-21 02:10:34,316 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-21 02:10:34,316 - DEBUG - Waiting to SSH to VM test2_vm, IP 114.231.12.195, Port 22
2025-08-21 02:10:34,478 - DEBUG - VM test2_vm is ready for SSH connections
2025-08-21 02:10:34,651 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-21 02:10:34,657 - DEBUG - Requesting: http://10.20.0.192:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-08264689:ctest-bgpaas_vn-75098510:ctest-bgpaas_vn-75098510.inet.0
2025-08-21 02:10:34,666 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-21 02:10:34,666 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 114.231.12.195, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.23, gateway password: c0ntrail123
2025-08-21 02:10:34,666 - DEBUG - ping -s 56 -c 3 -W 1 114.231.12.195
2025-08-21 02:10:38,614 - DEBUG - PING 114.231.12.195 (114.231.12.195): 56 data bytes
64 bytes from 114.231.12.195: seq=0 ttl=63 time=3.257 ms
64 bytes from 114.231.12.195: seq=1 ttl=63 time=0.715 ms
64 bytes from 114.231.12.195: seq=2 ttl=63 time=0.664 ms
--- 114.231.12.195 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.664/1.545/3.257 ms
2025-08-21 02:10:38,614 - INFO - Ping to IP 114.231.12.195 from VM test_vm passed
2025-08-21 02:10:38,688 - INFO - Deleting VM test2_vm
2025-08-21 02:10:38,752 - INFO - Deleting VM test_vm
2025-08-21 02:10:38,814 - INFO - Deleting VN ctest-bgpaas_vn-64161571
2025-08-21 02:10:38,852 - DEBUG - VN bc946385-3486-4eb5-9120-29b5db3beee4 still in use: Unable to complete operation on network bc946385-3486-4eb5-9120-29b5db3beee4. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-39225dd3-e0f6-4757-a52f-5438a52ad8ec']
2025-08-21 02:10:38,852 - WARNING - Deleting VN ctest-bgpaas_vn-64161571 failed..Will retry
2025-08-21 02:10:40,951 - DEBUG - Response for deleting network ()
2025-08-21 02:10:40,951 - INFO - Deleting VN ctest-bgpaas_vn-75098510
2025-08-21 02:10:41,075 - DEBUG - Response for deleting network ()
2025-08-21 02:10:41,328 - DEBUG - No XMPP flaps were noticed during the test
2025-08-21 02:10:41,328 - INFO - END TEST : test_rp_interface : PASSED[0:00:24]
2025-08-21 02:10:41,328 - INFO - --------------------------------------------------------------------------------
2025-08-21 02:10:41,985 - INFO - Deleted project: ctest-TestRP-08264689, ID : 2aceb6c5-1047-4f76-8670-22ccbd5f2c16