2025-09-23 12:19:50,913 - INFO - Domain Default found not creating 2025-09-23 12:19:51,113 - INFO - Project ctest-TestBasicVMVN-52327935 not found, creating it 2025-09-23 12:19:51,650 - INFO - Created Project:ctest-TestBasicVMVN-52327935, ID : 1c473f26-df20-42da-96cb-c10af8e90955 2025-09-23 12:19:53,440 - INFO - ================================================================================ 2025-09-23 12:19:53,441 - INFO - STARTING TEST : test_generic_link_local_service 2025-09-23 12:19:53,441 - INFO - TEST DESCRIPTION : Description: Test to validate generic linklocal service - running nova list from vm. 1.Create generic link local service to be able to wget to jenkins 2.Create a vm 3.Try wget to jenkins - passes if successful else fails Maintainer: sandipd@juniper.net 2025-09-23 12:19:53,709 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.17': '0'}} with 2025-09-23 12:19:53,709 - INFO - Initial checks done. Running the testcase now 2025-09-23 12:19:53,709 - INFO - 2025-09-23 12:19:54,408 - DEBUG - Response for create_network : {'network': {'id': 'ccd7ed36-b2e5-441a-8d04-80dee59cd47c', 'name': 'ctest-vn2_metadata-57371610', 'tenant_id': '1c473f26df2042da96cbc10af8e90955', 'project_id': '1c473f26df2042da96cbc10af8e90955', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-52327935', 'ctest-vn2_metadata-57371610'], 'port_security_enabled': True, 'description': ''}} 2025-09-23 12:19:54,695 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a09fee86-fcb8-4b70-be48-b46ef0246e3e', 'name': '', 'tenant_id': '1c473f26df2042da96cbc10af8e90955', 'network_id': 'ccd7ed36-b2e5-441a-8d04-80dee59cd47c', 'ip_version': 4, 'cidr': '11.1.1.0/24', 'allocation_pools': [{'start': '11.1.1.2', 'end': '11.1.1.254'}], 'gateway_ip': '11.1.1.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '11.1.1.2', 'tags': [], 'project_id': '1c473f26df2042da96cbc10af8e90955'}} 2025-09-23 12:19:54,720 - INFO - Created VN ctest-vn2_metadata-57371610 2025-09-23 12:19:54,776 - DEBUG - VN ctest-vn2_metadata-57371610 UUID is ccd7ed36-b2e5-441a-8d04-80dee59cd47c 2025-09-23 12:19:54,988 - DEBUG - Services list from nova: [, , ] 2025-09-23 12:19:56,096 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4174-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4174-1) 2025-09-23 12:19:56,208 - DEBUG - Link local service introspect added 2025-09-23 12:19:56,258 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-09-23 12:20:01,369 - DEBUG - VM is in ACTIVE state now 2025-09-23 12:20:01,520 - INFO - Waiting for VM ctest-TestBasicVMVN-52327935-14925197 to be up.. 2025-09-23 12:20:01,520 - INFO - VM name : ctest-TestBasicVMVN-52327935-14925197 2025-09-23 12:20:01,622 - DEBUG - VM ctest-TestBasicVMVN-52327935-14925197 ID is 3785baac-d4c8-47ee-9900-63573f86101c 2025-09-23 12:20:01,623 - DEBUG - VM ctest-TestBasicVMVN-52327935-14925197 launched on Node cn-jenkins-deploy-platform-ansible-os-4174-1 2025-09-23 12:20:01,707 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/3785baac-d4c8-47ee-9900-63573f86101c 2025-09-23 12:20:02,012 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/3785baac-d4c8-47ee-9900-63573f86101c 2025-09-23 12:20:02,050 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/e8781f63-5801-4bc6-8733-b544540f1e83 2025-09-23 12:20:05,321 - 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 1003ms') 2025-09-23 12:20:05,322 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-52327935-14925197 failed! 2025-09-23 12:20:05,380 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-52327935:ctest-vn2_metadata-57371610 is 11.1.1.1 and allocation pool is NOT set 2025-09-23 12:20:07,453 - 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=12.3 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.93 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 = 2.934/7.601/12.268/4.667 ms') 2025-09-23 12:20:07,454 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-52327935-14925197 passed 2025-09-23 12:20:07,604 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-23 12:20:07,605 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-52327935-14925197, IP 11.1.1.3, Port 22 2025-09-23 12:20:07,671 - DEBUG - Error on ssh to cirros@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2025-09-23 12:20:07,781 - DEBUG - VM ctest-TestBasicVMVN-52327935-14925197 is NOT ready for SSH connections, VM status: ACTIVE 2025-09-23 12:20:12,782 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-23 12:20:12,782 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-52327935-14925197, IP 11.1.1.3, Port 22 2025-09-23 12:20:12,959 - DEBUG - VM ctest-TestBasicVMVN-52327935-14925197 is ready for SSH connections 2025-09-23 12:20:12,959 - INFO - Retry 0 2025-09-23 12:20:12,959 - DEBUG - Running remote_cmd, Cmd : wget http://169.254.1.2:8083 --spider && echo "Successful", host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123 2025-09-23 12:20:12,960 - DEBUG - wget http://169.254.1.2:8083 --spider && echo "Successful" 2025-09-23 12:20:14,642 - DEBUG - Connecting to 169.254.1.2:8083 (169.254.1.2:8083) Successful 2025-09-23 12:20:14,642 - INFO - Generic metadata worked 2025-09-23 12:20:14,916 - DEBUG - Link local service introspect removed 2025-09-23 12:20:14,916 - INFO - Deleting VM ctest-TestBasicVMVN-52327935-14925197 2025-09-23 12:20:15,006 - INFO - Deleting VN ctest-vn2_metadata-57371610 2025-09-23 12:20:15,060 - DEBUG - VN ccd7ed36-b2e5-441a-8d04-80dee59cd47c still in use: Unable to complete operation on network ccd7ed36-b2e5-441a-8d04-80dee59cd47c. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-e54ffa8b-cd3b-4213-bb90-4656af58bba1'] 2025-09-23 12:20:15,061 - WARNING - Deleting VN ctest-vn2_metadata-57371610 failed..Will retry 2025-09-23 12:20:17,189 - DEBUG - Response for deleting network () 2025-09-23 12:20:17,450 - DEBUG - No XMPP flaps were noticed during the test 2025-09-23 12:20:17,450 - INFO - -------------------------------------------------------------------------------- 2025-09-23 12:20:17,453 - INFO - ================================================================================ 2025-09-23 12:20:17,454 - INFO - STARTING TEST : test_metadata_service 2025-09-23 12:20:17,454 - INFO - TEST DESCRIPTION : Description: Test to validate metadata service on VM creation. 1.Verify from global-vrouter-config if metadata configures or not - fails otherwise 2.Create a shell script which writes 'hello world ' in a file in /tmp and save the script on the nova api node 3.Create a vm with userdata pointing to that script - script should get executed during vm boot up 4.Go to the vm and verify if the file with 'hello world ' written saved in /tmp of the vm - fails otherwise Maintainer: sandipd@juniper.net 2025-09-23 12:20:17,762 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.17': '0'}} with 2025-09-23 12:20:17,762 - INFO - Initial checks done. Running the testcase now 2025-09-23 12:20:17,763 - INFO - 2025-09-23 12:20:17,763 - DEBUG - Requesting: http://10.0.0.50:8082/global-vrouter-configs 2025-09-23 12:20:17,770 - DEBUG - Requesting: http://10.0.0.50:8082/global-vrouter-config/91a9cfe9-a2b9-4491-a6b0-403b76c69d32 2025-09-23 12:20:17,987 - DEBUG - Response for create_network : {'network': {'id': 'c59b5106-d28a-41ed-8e2b-9265e30a5566', 'name': 'ctest-vn-64302703', 'tenant_id': '1c473f26df2042da96cbc10af8e90955', 'project_id': '1c473f26df2042da96cbc10af8e90955', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-52327935', 'ctest-vn-64302703'], 'port_security_enabled': True, 'description': ''}} 2025-09-23 12:20:18,179 - DEBUG - Response for create_subnet : {'subnet': {'id': '1451b2b1-da70-4517-b7be-be648d1dbff6', 'name': '', 'tenant_id': '1c473f26df2042da96cbc10af8e90955', 'network_id': 'c59b5106-d28a-41ed-8e2b-9265e30a5566', 'ip_version': 4, 'cidr': '87.136.214.128/26', 'allocation_pools': [{'start': '87.136.214.130', 'end': '87.136.214.190'}], 'gateway_ip': '87.136.214.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '87.136.214.130', 'tags': [], 'project_id': '1c473f26df2042da96cbc10af8e90955'}} 2025-09-23 12:20:18,198 - INFO - Created VN ctest-vn-64302703 2025-09-23 12:20:18,252 - DEBUG - VN ctest-vn-64302703 UUID is c59b5106-d28a-41ed-8e2b-9265e30a5566 2025-09-23 12:20:19,478 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4174-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4174-1) 2025-09-23 12:20:19,479 - INFO - Waiting for VM ctest-TestBasicVMVN-52327935-27484630 to be up.. 2025-09-23 12:20:19,531 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-09-23 12:20:24,615 - DEBUG - VM is in ACTIVE state now 2025-09-23 12:20:24,615 - INFO - VM name : ctest-TestBasicVMVN-52327935-27484630 2025-09-23 12:20:24,696 - DEBUG - VM ctest-TestBasicVMVN-52327935-27484630 ID is 280ee7f2-2ee3-4b68-b326-820ebed6f824 2025-09-23 12:20:24,697 - DEBUG - VM ctest-TestBasicVMVN-52327935-27484630 launched on Node cn-jenkins-deploy-platform-ansible-os-4174-1 2025-09-23 12:20:24,784 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/280ee7f2-2ee3-4b68-b326-820ebed6f824 2025-09-23 12:20:24,794 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/44ee4096-7352-4a49-afab-3ebf8fa449db 2025-09-23 12:20:28,075 - 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 1021ms') 2025-09-23 12:20:28,075 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-52327935-27484630 failed! 2025-09-23 12:20:28,132 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-52327935:ctest-vn-64302703 is 87.136.214.129 and allocation pool is NOT set 2025-09-23 12:20:32,194 - 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=6.44 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 6.442/6.442/6.442/0.000 ms') 2025-09-23 12:20:32,194 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-52327935-27484630 passed 2025-09-23 12:20:32,348 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-23 12:20:32,348 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-52327935-27484630, IP 87.136.214.131, Port 22 2025-09-23 12:20:32,515 - DEBUG - VM ctest-TestBasicVMVN-52327935-27484630 is ready for SSH connections 2025-09-23 12:20:32,515 - DEBUG - Running remote_cmd, Cmd : cat /tmp/output.txt, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123 2025-09-23 12:20:32,515 - DEBUG - cat /tmp/output.txt 2025-09-23 12:20:34,193 - DEBUG - Hello World. The time is now Tue, 23 Sep 2025 06:20:30 -0600! 2025-09-23 12:20:34,194 - DEBUG - ret : {'cat /tmp/output.txt': 'Hello World. The time is now Tue, 23 Sep 2025 06:20:30 -0600!'} 2025-09-23 12:20:34,194 - INFO - metadata_script.txt got executed in the vm 2025-09-23 12:20:34,194 - INFO - Deleting VM ctest-TestBasicVMVN-52327935-27484630 2025-09-23 12:20:34,311 - INFO - Deleting VN ctest-vn-64302703 2025-09-23 12:20:34,357 - DEBUG - VN c59b5106-d28a-41ed-8e2b-9265e30a5566 still in use: Unable to complete operation on network c59b5106-d28a-41ed-8e2b-9265e30a5566. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-3c29953b-dcc4-4ef0-af32-1f5ab04cf9bc'] 2025-09-23 12:20:34,357 - WARNING - Deleting VN ctest-vn-64302703 failed..Will retry 2025-09-23 12:20:36,507 - DEBUG - Response for deleting network () 2025-09-23 12:20:36,769 - DEBUG - No XMPP flaps were noticed during the test
2025-09-23 12:20:36,769 - INFO - END TEST : test_metadata_service : PASSED[0:00:19]
2025-09-23 12:20:36,769 - INFO - -------------------------------------------------------------------------------- 2025-09-23 12:20:36,773 - INFO - ================================================================================ 2025-09-23 12:20:36,774 - INFO - STARTING TEST : test_ping_within_vn_two_vms_two_different_subnets 2025-09-23 12:20:36,774 - INFO - TEST DESCRIPTION : Description: Validate Ping between 2 VMs in the same VN, 2 VMs in different VN subnets. Test steps: 1. Create 1 IPAM's. 2. Create 1 VN with 2 subnets and launch 2 VMs in them. 3. Ping between the VMs in the same VN should go thru fine. 4. Ping to the subnet broadcast and all-broadcast address. Pass criteria: VM in the same subnet will respond to both the pings, while the VM in a different VN should respond only to the all-broadcast address. Maintainer : ganeshahv@juniper.net 2025-09-23 12:20:37,084 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.17': '0'}} with 2025-09-23 12:20:37,084 - INFO - Initial checks done. Running the testcase now 2025-09-23 12:20:37,085 - INFO - 2025-09-23 12:20:37,632 - DEBUG - Response for create_network : {'network': {'id': 'd30dfba0-9f41-482d-ad8e-40853b8230f4', 'name': 'ctest-vn-42998028', 'tenant_id': '1c473f26df2042da96cbc10af8e90955', 'project_id': '1c473f26df2042da96cbc10af8e90955', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-52327935', 'ctest-vn-42998028'], 'port_security_enabled': True, 'description': ''}} 2025-09-23 12:20:37,886 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e68aa07f-afe5-41b5-9bed-19c00b1c8e2d', 'name': '', 'tenant_id': '1c473f26df2042da96cbc10af8e90955', 'network_id': 'd30dfba0-9f41-482d-ad8e-40853b8230f4', 'ip_version': 4, 'cidr': '31.1.1.0/29', 'allocation_pools': [{'start': '31.1.1.2', 'end': '31.1.1.6'}], 'gateway_ip': '31.1.1.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '31.1.1.2', 'tags': [], 'project_id': '1c473f26df2042da96cbc10af8e90955'}} 2025-09-23 12:20:38,130 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c90810d8-2e44-43a2-bd88-0ca75959c429', 'name': '', 'tenant_id': '1c473f26df2042da96cbc10af8e90955', 'network_id': 'd30dfba0-9f41-482d-ad8e-40853b8230f4', 'ip_version': 4, 'cidr': '31.1.2.0/29', 'allocation_pools': [{'start': '31.1.2.2', 'end': '31.1.2.6'}], 'gateway_ip': '31.1.2.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '31.1.2.2', 'tags': [], 'project_id': '1c473f26df2042da96cbc10af8e90955'}} 2025-09-23 12:20:38,157 - INFO - Created VN ctest-vn-42998028 2025-09-23 12:20:38,212 - DEBUG - VN ctest-vn-42998028 UUID is d30dfba0-9f41-482d-ad8e-40853b8230f4 2025-09-23 12:20:38,673 - DEBUG - Response for create_port : {'port': {'name': 'd82e974d-a72c-4cf8-8137-d74cbe473ee4', 'id': 'd82e974d-a72c-4cf8-8137-d74cbe473ee4', 'tenant_id': '1c473f26df2042da96cbc10af8e90955', 'network_id': 'd30dfba0-9f41-482d-ad8e-40853b8230f4', 'mac_address': '02:d8:2e:97:4d:a7', 'binding:vnic_type': 'normal', 'binding:vif_details': {'port_filter': True}, 'binding:vif_type': 'unbound', 'binding:host_id': None, 'allowed_address_pairs': [], 'fixed_ips': [{'ip_address': '31.1.1.4', 'subnet_id': 'e68aa07f-afe5-41b5-9bed-19c00b1c8e2d'}], 'security_groups': ['c7947104-4240-402d-a7c0-13df39f1f9f3'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '1c473f26df2042da96cbc10af8e90955'}} 2025-09-23 12:20:38,894 - DEBUG - Response for create_port : {'port': {'name': '49f96852-2e0b-4040-8531-72a05f1d5016', 'id': '49f96852-2e0b-4040-8531-72a05f1d5016', 'tenant_id': '1c473f26df2042da96cbc10af8e90955', 'network_id': 'd30dfba0-9f41-482d-ad8e-40853b8230f4', 'mac_address': '02:49:f9:68:52:2e', 'binding:vnic_type': 'normal', 'binding:vif_details': {'port_filter': True}, 'binding:vif_type': 'unbound', 'binding:host_id': None, 'allowed_address_pairs': [], 'fixed_ips': [{'ip_address': '31.1.2.4', 'subnet_id': 'c90810d8-2e44-43a2-bd88-0ca75959c429'}], 'security_groups': ['c7947104-4240-402d-a7c0-13df39f1f9f3'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '1c473f26df2042da96cbc10af8e90955'}} 2025-09-23 12:20:39,419 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4174-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4174-1) 2025-09-23 12:20:40,000 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4174-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4174-1) 2025-09-23 12:20:41,587 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4174-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4174-1) 2025-09-23 12:20:41,587 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2025-09-23 12:20:41,595 - DEBUG - Requesting: http://10.0.0.50:8082/domain/8bc7aaff-2766-45ed-ac21-d4ece8f95b67 2025-09-23 12:20:41,614 - DEBUG - Requesting: http://10.0.0.50:8082/project/1c473f26-df20-42da-96cb-c10af8e90955 2025-09-23 12:20:41,713 - DEBUG - Requesting: http://10.0.0.50:8082/network-ipam/90ae16a3-3543-4fae-9635-a487304af5af 2025-09-23 12:20:41,730 - INFO - Verifications in API Server for IPAM: ctest-ipam-19842778 passed 2025-09-23 12:20:41,739 - DEBUG - Control-node 10.0.0.50 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestBasicVMVN-52327935:ctest-ipam-19842778', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN-52327935', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10425295077638361006', 'uuid-lslong': '10823738179992614319'}, 'enable': 'true', 'created': '2025-09-23T12:20:37', 'last-modified': '2025-09-23T12:20:37', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:04.409168'} 2025-09-23 12:20:41,739 - INFO - Verifications in Control node for IPAM: ctest-ipam-19842778 passed 2025-09-23 12:20:41,740 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2025-09-23 12:20:41,756 - DEBUG - Requesting: http://10.0.0.50:8082/domain/8bc7aaff-2766-45ed-ac21-d4ece8f95b67 2025-09-23 12:20:41,777 - DEBUG - Requesting: http://10.0.0.50:8082/project/1c473f26-df20-42da-96cb-c10af8e90955 2025-09-23 12:20:41,879 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/d30dfba0-9f41-482d-ad8e-40853b8230f4 2025-09-23 12:20:41,903 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/d30dfba0-9f41-482d-ad8e-40853b8230f4 2025-09-23 12:20:41,922 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/793f81e1-ea09-4c1b-b8b1-a60cf692ae59 2025-09-23 12:20:41,936 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/793f81e1-ea09-4c1b-b8b1-a60cf692ae59 2025-09-23 12:20:41,955 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/d398d82c-b2cd-4c75-90bc-dbf570db8be5 2025-09-23 12:20:41,965 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-09-23 12:20:41,966 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/d30dfba0-9f41-482d-ad8e-40853b8230f4 2025-09-23 12:20:41,982 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/793f81e1-ea09-4c1b-b8b1-a60cf692ae59 2025-09-23 12:20:42,004 - INFO - Verified VN network id 12 for VN d30dfba0-9f41-482d-ad8e-40853b8230f4 2025-09-23 12:20:42,004 - INFO - Verifications in API Server for VN ctest-vn-42998028 passed 2025-09-23 12:20:42,004 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/d30dfba0-9f41-482d-ad8e-40853b8230f4 2025-09-23 12:20:42,019 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/793f81e1-ea09-4c1b-b8b1-a60cf692ae59 2025-09-23 12:20:42,030 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/793f81e1-ea09-4c1b-b8b1-a60cf692ae59 2025-09-23 12:20:42,042 - DEBUG - Requesting: http://10.0.0.50:8082/route-target/d398d82c-b2cd-4c75-90bc-dbf570db8be5 2025-09-23 12:20:42,061 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicVMVN-52327935:ctest-vn-42998028', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN-52327935', 'owner-access': '7', 'group': 'reader', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '15208088183985227821', 'uuid-lslong': '12506004156227662068'}, 'enable': 'true', 'created': '2025-09-23T12:20:37', 'last-modified': '2025-09-23T12:20:38', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.976221'} 2025-09-23 12:20:42,070 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-09-23 12:20:42,071 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn-42998028 passed 2025-09-23 12:20:42,071 - DEBUG - ====Verifying policy data for ctest-vn-42998028 in API_Server ====== 2025-09-23 12:20:42,071 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2025-09-23 12:20:42,079 - DEBUG - Requesting: http://10.0.0.50:8082/domain/8bc7aaff-2766-45ed-ac21-d4ece8f95b67 2025-09-23 12:20:42,098 - DEBUG - Requesting: http://10.0.0.50:8082/project/1c473f26-df20-42da-96cb-c10af8e90955 2025-09-23 12:20:42,194 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-network/d30dfba0-9f41-482d-ad8e-40853b8230f4 2025-09-23 12:20:42,223 - DEBUG - =>VN ctest-vn-42998028 has no policy to be verified 2025-09-23 12:20:42,223 - DEBUG - Verifying the vn in opserver 2025-09-23 12:20:42,223 - DEBUG - Verifying the default-domain:ctest-TestBasicVMVN-52327935:ctest-vn-42998028 virtual network link through opserver 10.0.0.50 2025-09-23 12:20:42,224 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2025-09-23 12:20:42,537 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2025-09-23 12:20:42,716 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicVMVN-52327935:ctest-vn-42998028', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicVMVN-52327935:ctest-vn-42998028?flat'} 2025-09-23 12:20:42,716 - INFO - Validated that VN default-domain:ctest-TestBasicVMVN-52327935:ctest-vn-42998028 is found in opserver 2025-09-23 12:20:42,725 - DEBUG - VRF ids for VN ctest-vn-42998028: {'10.0.0.50': '2'} 2025-09-23 12:20:42,725 - INFO - Waiting for VM ctest-TestBasicVMVN-52327935-35554233 to be up.. 2025-09-23 12:20:42,967 - DEBUG - VM is in ACTIVE state now 2025-09-23 12:20:42,967 - INFO - VM name : ctest-TestBasicVMVN-52327935-35554233 2025-09-23 12:20:43,203 - DEBUG - VM ctest-TestBasicVMVN-52327935-35554233 ID is b563efb3-e844-432a-8afd-364bfbf29d20 2025-09-23 12:20:43,203 - DEBUG - VM ctest-TestBasicVMVN-52327935-35554233 launched on Node cn-jenkins-deploy-platform-ansible-os-4174-1 2025-09-23 12:20:43,474 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/b563efb3-e844-432a-8afd-364bfbf29d20 2025-09-23 12:20:43,490 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/d82e974d-a72c-4cf8-8137-d74cbe473ee4 2025-09-23 12:20:46,821 - 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 1005ms') 2025-09-23 12:20:46,822 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-52327935-35554233 failed! 2025-09-23 12:20:46,884 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-52327935:ctest-vn-42998028 is 31.1.1.1 and allocation pool is NOT set 2025-09-23 12:20:46,885 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-52327935:ctest-vn-42998028 is 31.1.2.1 and allocation pool is NOT set 2025-09-23 12:20:50,955 - 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 1007ms') 2025-09-23 12:20:50,955 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-52327935-35554233 failed! 2025-09-23 12:20:51,012 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-52327935:ctest-vn-42998028 is 31.1.1.1 and allocation pool is NOT set 2025-09-23 12:20:51,013 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-52327935:ctest-vn-42998028 is 31.1.2.1 and allocation pool is NOT set 2025-09-23 12:20:53,085 - 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=18.6 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=3.53 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 = 3.531/11.087/18.644/7.556 ms') 2025-09-23 12:20:53,085 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-52327935-35554233 passed 2025-09-23 12:20:53,244 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-23 12:20:53,244 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-52327935-35554233, IP 31.1.1.4, Port 22 2025-09-23 12:20:53,313 - DEBUG - Error on ssh to cirros@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2025-09-23 12:20:53,414 - DEBUG - VM ctest-TestBasicVMVN-52327935-35554233 is NOT ready for SSH connections, VM status: ACTIVE 2025-09-23 12:20:58,415 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-23 12:20:58,415 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-52327935-35554233, IP 31.1.1.4, Port 22 2025-09-23 12:20:58,594 - DEBUG - VM ctest-TestBasicVMVN-52327935-35554233 is ready for SSH connections 2025-09-23 12:20:58,594 - INFO - Waiting for VM ctest-TestBasicVMVN-52327935-00701968 to be up.. 2025-09-23 12:20:58,682 - DEBUG - VM is in ACTIVE state now 2025-09-23 12:20:58,682 - INFO - VM name : ctest-TestBasicVMVN-52327935-00701968 2025-09-23 12:20:58,768 - DEBUG - VM ctest-TestBasicVMVN-52327935-00701968 ID is ea9db283-5f01-43c2-94c0-141318553710 2025-09-23 12:20:58,768 - DEBUG - VM ctest-TestBasicVMVN-52327935-00701968 launched on Node cn-jenkins-deploy-platform-ansible-os-4174-1 2025-09-23 12:20:58,855 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/ea9db283-5f01-43c2-94c0-141318553710 2025-09-23 12:20:58,864 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/49f96852-2e0b-4040-8531-72a05f1d5016 2025-09-23 12:21:00,106 - 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.425 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1000ms\r\nrtt min/avg/max/mdev = 0.425/1.792/3.160/1.367 ms') 2025-09-23 12:21:00,106 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBasicVMVN-52327935-00701968 passed 2025-09-23 12:21:00,260 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-23 12:21:00,260 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-52327935-00701968, IP 31.1.2.4, Port 22 2025-09-23 12:21:00,427 - DEBUG - VM ctest-TestBasicVMVN-52327935-00701968 is ready for SSH connections 2025-09-23 12:21:00,428 - INFO - Waiting for VM ctest-TestBasicVMVN-52327935-48583735 to be up.. 2025-09-23 12:21:00,527 - DEBUG - VM is in ACTIVE state now 2025-09-23 12:21:00,527 - INFO - VM name : ctest-TestBasicVMVN-52327935-48583735 2025-09-23 12:21:00,617 - DEBUG - VM ctest-TestBasicVMVN-52327935-48583735 ID is 32152538-710b-4d37-ac12-1607eda75230 2025-09-23 12:21:00,618 - DEBUG - VM ctest-TestBasicVMVN-52327935-48583735 launched on Node cn-jenkins-deploy-platform-ansible-os-4174-1 2025-09-23 12:21:00,702 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/32152538-710b-4d37-ac12-1607eda75230 2025-09-23 12:21:00,712 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/06fa8152-2d62-4a62-a8fd-8eac553302ba 2025-09-23 12:21:01,962 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n64 bytes from 169.254.0.5: icmp_seq=1 ttl=63 time=5.02 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.431 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.431/2.726/5.022/2.295 ms') 2025-09-23 12:21:01,962 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-52327935-48583735 passed 2025-09-23 12:21:02,116 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-23 12:21:02,116 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-52327935-48583735, IP 31.1.1.3, Port 22 2025-09-23 12:21:02,291 - DEBUG - VM ctest-TestBasicVMVN-52327935-48583735 is ready for SSH connections 2025-09-23 12:21:02,292 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-23 12:21:02,292 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 31.1.2.4, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123 2025-09-23 12:21:02,292 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4 2025-09-23 12:21:06,422 - DEBUG - PING 31.1.2.4 (31.1.2.4): 56 data bytes 64 bytes from 31.1.2.4: seq=0 ttl=63 time=4.203 ms 64 bytes from 31.1.2.4: seq=1 ttl=63 time=1.547 ms 64 bytes from 31.1.2.4: seq=2 ttl=63 time=1.059 ms --- 31.1.2.4 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.059/2.269/4.203 ms 2025-09-23 12:21:06,422 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-52327935-35554233 passed 2025-09-23 12:21:06,422 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-23 12:21:06,423 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 31.1.1.4, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123 2025-09-23 12:21:06,423 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4 2025-09-23 12:21:10,181 - DEBUG - PING 31.1.1.4 (31.1.1.4): 56 data bytes 64 bytes from 31.1.1.4: seq=0 ttl=63 time=2.916 ms 64 bytes from 31.1.1.4: seq=1 ttl=63 time=1.060 ms 64 bytes from 31.1.1.4: seq=2 ttl=63 time=0.997 ms --- 31.1.1.4 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 0.997/1.657/2.916 ms 2025-09-23 12:21:10,181 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-52327935-00701968 passed 2025-09-23 12:21:10,181 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-23 12:21:10,181 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-23 12:21:10,181 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-23 12:21:10,181 - DEBUG - Running remote_cmd, Cmd : echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123 2025-09-23 12:21:10,181 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts 2025-09-23 12:21:10,368 - DEBUG - None 2025-09-23 12:21:10,369 - DEBUG - Running remote_cmd, Cmd : echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123 2025-09-23 12:21:10,369 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts 2025-09-23 12:21:10,561 - DEBUG - None 2025-09-23 12:21:10,561 - DEBUG - Running remote_cmd, Cmd : echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts, host_string: cirros@169.254.0.5, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123 2025-09-23 12:21:10,561 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts 2025-09-23 12:21:11,232 - DEBUG - None 2025-09-23 12:21:11,232 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 31.1.1.7, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123 2025-09-23 12:21:11,232 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7 2025-09-23 12:21:13,464 - DEBUG - PING 31.1.1.7 (31.1.1.7): 56 data bytes 64 bytes from 31.1.1.4: seq=0 ttl=64 time=2.874 ms 64 bytes from 31.1.1.3: seq=0 ttl=64 time=7.363 ms (DUP!) 64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.641 ms 64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.040 ms (DUP!) 64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.690 ms --- 31.1.1.7 ping statistics --- 3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss round-trip min/avg/max = 0.641/2.721/7.363 ms 2025-09-23 12:21:13,465 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 224.0.0.1, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123 2025-09-23 12:21:13,465 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1 2025-09-23 12:21:15,762 - DEBUG - PING 224.0.0.1 (224.0.0.1): 56 data bytes 64 bytes from 31.1.1.4: seq=0 ttl=64 time=4.249 ms 64 bytes from 31.1.1.3: seq=0 ttl=64 time=6.767 ms (DUP!) 64 bytes from 31.1.2.4: seq=0 ttl=63 time=8.232 ms (DUP!) 64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.920 ms 64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.993 ms (DUP!) 64 bytes from 31.1.1.3: seq=1 ttl=64 time=4.530 ms (DUP!) 64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.688 ms --- 224.0.0.1 ping statistics --- 3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss round-trip min/avg/max = 0.688/4.054/8.232 ms 2025-09-23 12:21:15,763 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 255.255.255.255, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123 2025-09-23 12:21:15,763 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255 2025-09-23 12:21:18,103 - DEBUG - PING 255.255.255.255 (255.255.255.255): 56 data bytes 64 bytes from 31.1.1.4: seq=0 ttl=64 time=2.616 ms 64 bytes from 31.1.1.3: seq=0 ttl=64 time=6.032 ms (DUP!) 64 bytes from 31.1.2.4: seq=0 ttl=63 time=7.651 ms (DUP!) 64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.790 ms 64 bytes from 31.1.1.3: seq=1 ttl=64 time=3.822 ms (DUP!) 64 bytes from 31.1.2.4: seq=1 ttl=63 time=6.611 ms (DUP!) 64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.646 ms --- 255.255.255.255 ping statistics --- 3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss round-trip min/avg/max = 0.646/4.024/7.651 ms 2025-09-23 12:21:18,103 - INFO - Deleting VM ctest-TestBasicVMVN-52327935-48583735 2025-09-23 12:21:18,179 - INFO - Detaching port 49f96852-2e0b-4040-8531-72a05f1d5016 from VM ctest-TestBasicVMVN-52327935-00701968 2025-09-23 12:21:18,230 - INFO - Deleting VM ctest-TestBasicVMVN-52327935-00701968 2025-09-23 12:21:18,321 - INFO - Detaching port d82e974d-a72c-4cf8-8137-d74cbe473ee4 from VM ctest-TestBasicVMVN-52327935-35554233 2025-09-23 12:21:18,359 - INFO - Deleting VM ctest-TestBasicVMVN-52327935-35554233 2025-09-23 12:21:18,455 - INFO - Deleting VN ctest-vn-42998028 2025-09-23 12:21:18,660 - DEBUG - Response for delete_port : () 2025-09-23 12:21:18,919 - DEBUG - Response for delete_port : () 2025-09-23 12:21:18,973 - DEBUG - VN d30dfba0-9f41-482d-ad8e-40853b8230f4 still in use: Unable to complete operation on network d30dfba0-9f41-482d-ad8e-40853b8230f4. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-c7fbc778-4925-4e0c-ae7b-b6a815fdfe05'] 2025-09-23 12:21:18,973 - WARNING - Deleting VN ctest-vn-42998028 failed..Will retry 2025-09-23 12:21:21,163 - DEBUG - Response for deleting network () 2025-09-23 12:21:21,163 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/793f81e1-ea09-4c1b-b8b1-a60cf692ae59 2025-09-23 12:21:21,169 - DEBUG - Response Code: 404 2025-09-23 12:21:21,169 - DEBUG - Requesting: http://10.0.0.50:8082/domains 2025-09-23 12:21:21,177 - DEBUG - Requesting: http://10.0.0.50:8082/domain/8bc7aaff-2766-45ed-ac21-d4ece8f95b67 2025-09-23 12:21:21,234 - DEBUG - Requesting: http://10.0.0.50:8082/project/1c473f26-df20-42da-96cb-c10af8e90955 2025-09-23 12:21:21,340 - INFO - Validated that VN ctest-vn-42998028 is not found in API Server 2025-09-23 12:21:21,354 - DEBUG - VN ctest-vn-42998028 is not present in Agent 10.0.0.50 2025-09-23 12:21:21,354 - INFO - Validated that VN ctest-vn-42998028 is not in any agent 2025-09-23 12:21:21,360 - DEBUG - VRF 2 is not seen in agent 10.0.0.50 2025-09-23 12:21:21,368 - DEBUG - Vrouter 10.0.0.50 does not have vrf 2 for VN ctest-vn-42998028 2025-09-23 12:21:21,368 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-52327935:ctest-vn-42998028 2025-09-23 12:21:21,386 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-42998028 info 2025-09-23 12:21:21,492 - INFO - IPAM: ctest-ipam-19842778 is not found in API Server 2025-09-23 12:21:21,510 - INFO - IPAM:ctest-ipam-19842778 is not found in control node 2025-09-23 12:21:21,787 - DEBUG - No XMPP flaps were noticed during the test
2025-09-23 12:21:21,788 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:45]
2025-09-23 12:21:21,788 - INFO - -------------------------------------------------------------------------------- 2025-09-23 12:21:22,622 - INFO - Deleted project: ctest-TestBasicVMVN-52327935, ID : 1c473f26-df20-42da-96cb-c10af8e90955