2025-04-27 16:54:40,606 - INFO - Domain Default found not creating 2025-04-27 16:54:40,710 - INFO - Project ctest-TestBasicVMVN-67815320 not found, creating it 2025-04-27 16:54:41,203 - INFO - Created Project:ctest-TestBasicVMVN-67815320, ID : c91ee3de-ca75-4587-ac58-4ab112a4d691 2025-04-27 16:54:42,391 - INFO - ================================================================================ 2025-04-27 16:54:42,391 - INFO - STARTING TEST : test_generic_link_local_service 2025-04-27 16:54:42,391 - 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-04-27 16:54:42,640 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.17': '0'}} with 2025-04-27 16:54:42,640 - INFO - Initial checks done. Running the testcase now 2025-04-27 16:54:42,640 - INFO - 2025-04-27 16:54:43,106 - DEBUG - Response for create_network : {'network': {'id': '463e849c-bcbb-4780-88ed-5737010d2e78', 'name': 'ctest-vn2_metadata-48611938', 'tenant_id': 'c91ee3deca754587ac584ab112a4d691', 'project_id': 'c91ee3deca754587ac584ab112a4d691', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-67815320', 'ctest-vn2_metadata-48611938'], 'port_security_enabled': True, 'description': ''}} 2025-04-27 16:54:43,266 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c7416964-6b6a-47cb-80ea-fdfaf2b76860', 'name': '', 'tenant_id': 'c91ee3deca754587ac584ab112a4d691', 'network_id': '463e849c-bcbb-4780-88ed-5737010d2e78', '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': 'c91ee3deca754587ac584ab112a4d691'}} 2025-04-27 16:54:43,280 - INFO - Created VN ctest-vn2_metadata-48611938 2025-04-27 16:54:43,331 - DEBUG - VN ctest-vn2_metadata-48611938 UUID is 463e849c-bcbb-4780-88ed-5737010d2e78 2025-04-27 16:54:43,474 - DEBUG - Services list from nova: [, , ] 2025-04-27 16:54:44,313 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3228-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3228-1) 2025-04-27 16:54:44,415 - DEBUG - Link local service introspect added 2025-04-27 16:54:44,454 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-04-27 16:54:49,516 - DEBUG - VM is in ACTIVE state now 2025-04-27 16:54:49,627 - INFO - Waiting for VM ctest-TestBasicVMVN-67815320-87234749 to be up.. 2025-04-27 16:54:49,627 - INFO - VM name : ctest-TestBasicVMVN-67815320-87234749 2025-04-27 16:54:49,686 - DEBUG - VM ctest-TestBasicVMVN-67815320-87234749 ID is c2280e7d-aada-4ccf-9258-4cad2256cbe4 2025-04-27 16:54:49,686 - DEBUG - VM ctest-TestBasicVMVN-67815320-87234749 launched on Node cn-jenkins-deploy-platform-ansible-os-3228-1 2025-04-27 16:54:49,740 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/c2280e7d-aada-4ccf-9258-4cad2256cbe4 2025-04-27 16:54:49,996 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/c2280e7d-aada-4ccf-9258-4cad2256cbe4 2025-04-27 16:54:50,024 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/a7ffdf53-e6c0-42fc-bfc2-87852d7d3371 2025-04-27 16:54:53,256 - 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-04-27 16:54:53,256 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-67815320-87234749 failed! 2025-04-27 16:54:53,312 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-67815320:ctest-vn2_metadata-48611938 is 11.1.1.1 and allocation pool is NOT set 2025-04-27 16:54:55,379 - 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.64 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.346 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.346/1.491/2.636/1.145 ms') 2025-04-27 16:54:55,379 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-67815320-87234749 passed 2025-04-27 16:54:55,527 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-04-27 16:54:55,528 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-67815320-87234749, IP 11.1.1.3, Port 22 2025-04-27 16:54:55,682 - DEBUG - VM ctest-TestBasicVMVN-67815320-87234749 is ready for SSH connections 2025-04-27 16:54:55,683 - INFO - Retry 0 2025-04-27 16:54:55,683 - 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.38, gateway password: c0ntrail123 2025-04-27 16:54:55,683 - DEBUG - wget http://169.254.1.2:8083 --spider && echo "Successful" 2025-04-27 16:54:57,219 - DEBUG - Connecting to 169.254.1.2:8083 (169.254.1.2:8083) Successful 2025-04-27 16:54:57,219 - INFO - Generic metadata worked 2025-04-27 16:54:57,459 - DEBUG - Link local service introspect removed 2025-04-27 16:54:57,459 - INFO - Deleting VM ctest-TestBasicVMVN-67815320-87234749 2025-04-27 16:54:57,511 - INFO - Deleting VN ctest-vn2_metadata-48611938 2025-04-27 16:54:57,543 - DEBUG - VN 463e849c-bcbb-4780-88ed-5737010d2e78 still in use: Unable to complete operation on network 463e849c-bcbb-4780-88ed-5737010d2e78. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-6506edce-33b3-43db-866c-dc1c530d26af'] 2025-04-27 16:54:57,543 - WARNING - Deleting VN ctest-vn2_metadata-48611938 failed..Will retry 2025-04-27 16:54:59,634 - DEBUG - Response for deleting network () 2025-04-27 16:54:59,887 - DEBUG - No XMPP flaps were noticed during the test 2025-04-27 16:54:59,888 - INFO - -------------------------------------------------------------------------------- 2025-04-27 16:54:59,890 - INFO - ================================================================================ 2025-04-27 16:54:59,890 - INFO - STARTING TEST : test_metadata_service 2025-04-27 16:54:59,890 - 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-04-27 16:55:00,172 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.17': '0'}} with 2025-04-27 16:55:00,172 - INFO - Initial checks done. Running the testcase now 2025-04-27 16:55:00,172 - INFO - 2025-04-27 16:55:00,172 - DEBUG - Requesting: http://10.0.0.38:8082/global-vrouter-configs 2025-04-27 16:55:00,177 - DEBUG - Requesting: http://10.0.0.38:8082/global-vrouter-config/cb23b4ae-4c51-4341-9094-d943a798b68b 2025-04-27 16:55:00,334 - DEBUG - Response for create_network : {'network': {'id': '18b25bf2-d348-4c4d-84f7-84562b13ed4e', 'name': 'ctest-vn-78485963', 'tenant_id': 'c91ee3deca754587ac584ab112a4d691', 'project_id': 'c91ee3deca754587ac584ab112a4d691', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-67815320', 'ctest-vn-78485963'], 'port_security_enabled': True, 'description': ''}} 2025-04-27 16:55:00,471 - DEBUG - Response for create_subnet : {'subnet': {'id': 'aa021b7d-fa3a-4ec7-9c31-8d825e53a6d2', 'name': '', 'tenant_id': 'c91ee3deca754587ac584ab112a4d691', 'network_id': '18b25bf2-d348-4c4d-84f7-84562b13ed4e', 'ip_version': 4, 'cidr': '214.217.160.64/26', 'allocation_pools': [{'start': '214.217.160.66', 'end': '214.217.160.126'}], 'gateway_ip': '214.217.160.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '214.217.160.66', 'tags': [], 'project_id': 'c91ee3deca754587ac584ab112a4d691'}} 2025-04-27 16:55:00,484 - INFO - Created VN ctest-vn-78485963 2025-04-27 16:55:00,535 - DEBUG - VN ctest-vn-78485963 UUID is 18b25bf2-d348-4c4d-84f7-84562b13ed4e 2025-04-27 16:55:01,512 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3228-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3228-1) 2025-04-27 16:55:01,512 - INFO - Waiting for VM ctest-TestBasicVMVN-67815320-38384702 to be up.. 2025-04-27 16:55:01,541 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-04-27 16:55:06,602 - DEBUG - VM is in ACTIVE state now 2025-04-27 16:55:06,602 - INFO - VM name : ctest-TestBasicVMVN-67815320-38384702 2025-04-27 16:55:06,662 - DEBUG - VM ctest-TestBasicVMVN-67815320-38384702 ID is f1087ce5-abea-4d74-9e21-e67043fd20ad 2025-04-27 16:55:06,662 - DEBUG - VM ctest-TestBasicVMVN-67815320-38384702 launched on Node cn-jenkins-deploy-platform-ansible-os-3228-1 2025-04-27 16:55:06,798 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/f1087ce5-abea-4d74-9e21-e67043fd20ad 2025-04-27 16:55:06,804 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/2f74d6c1-cc5c-4fcb-8271-875c58a24b0a 2025-04-27 16:55:10,055 - 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-04-27 16:55:10,056 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-67815320-38384702 failed! 2025-04-27 16:55:10,107 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-67815320:ctest-vn-78485963 is 214.217.160.65 and allocation pool is NOT set 2025-04-27 16:55:12,165 - 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.72 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.379 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.379/1.550/2.722/1.171 ms') 2025-04-27 16:55:12,165 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-67815320-38384702 passed 2025-04-27 16:55:12,315 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-04-27 16:55:12,316 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-67815320-38384702, IP 214.217.160.67, Port 22 2025-04-27 16:55:12,474 - DEBUG - VM ctest-TestBasicVMVN-67815320-38384702 is ready for SSH connections 2025-04-27 16:55:12,475 - DEBUG - Running remote_cmd, Cmd : cat /tmp/output.txt, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.38, gateway password: c0ntrail123 2025-04-27 16:55:12,475 - DEBUG - cat /tmp/output.txt 2025-04-27 16:55:14,029 - DEBUG - Hello World. The time is now Sun, 27 Apr 2025 10:55:10 -0600! 2025-04-27 16:55:14,029 - DEBUG - ret : {'cat /tmp/output.txt': 'Hello World. The time is now Sun, 27 Apr 2025 10:55:10 -0600!'} 2025-04-27 16:55:14,029 - INFO - metadata_script.txt got executed in the vm 2025-04-27 16:55:14,029 - INFO - Deleting VM ctest-TestBasicVMVN-67815320-38384702 2025-04-27 16:55:14,085 - INFO - Deleting VN ctest-vn-78485963 2025-04-27 16:55:14,120 - DEBUG - VN 18b25bf2-d348-4c4d-84f7-84562b13ed4e still in use: Unable to complete operation on network 18b25bf2-d348-4c4d-84f7-84562b13ed4e. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-72778d7f-e418-482a-9d00-9c5da05c5c99'] 2025-04-27 16:55:14,121 - WARNING - Deleting VN ctest-vn-78485963 failed..Will retry 2025-04-27 16:55:16,209 - DEBUG - Response for deleting network () 2025-04-27 16:55:16,464 - DEBUG - No XMPP flaps were noticed during the test
2025-04-27 16:55:16,464 - INFO - END TEST : test_metadata_service : PASSED[0:00:17]
2025-04-27 16:55:16,464 - INFO - -------------------------------------------------------------------------------- 2025-04-27 16:55:16,466 - INFO - ================================================================================ 2025-04-27 16:55:16,466 - INFO - STARTING TEST : test_ping_within_vn_two_vms_two_different_subnets 2025-04-27 16:55:16,466 - 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-04-27 16:55:16,756 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.17': '0'}} with 2025-04-27 16:55:16,756 - INFO - Initial checks done. Running the testcase now 2025-04-27 16:55:16,756 - INFO - 2025-04-27 16:55:17,204 - DEBUG - Response for create_network : {'network': {'id': '92b2502f-56bf-4932-91aa-b11828a2d645', 'name': 'ctest-vn-51165890', 'tenant_id': 'c91ee3deca754587ac584ab112a4d691', 'project_id': 'c91ee3deca754587ac584ab112a4d691', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-67815320', 'ctest-vn-51165890'], 'port_security_enabled': True, 'description': ''}} 2025-04-27 16:55:17,388 - DEBUG - Response for create_subnet : {'subnet': {'id': '7910eef5-9142-436b-9bef-5c8b10f2d4d0', 'name': '', 'tenant_id': 'c91ee3deca754587ac584ab112a4d691', 'network_id': '92b2502f-56bf-4932-91aa-b11828a2d645', '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': 'c91ee3deca754587ac584ab112a4d691'}} 2025-04-27 16:55:17,578 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ef325fec-9ef7-41ed-b8cf-d5d4df06f478', 'name': '', 'tenant_id': 'c91ee3deca754587ac584ab112a4d691', 'network_id': '92b2502f-56bf-4932-91aa-b11828a2d645', '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': 'c91ee3deca754587ac584ab112a4d691'}} 2025-04-27 16:55:17,595 - INFO - Created VN ctest-vn-51165890 2025-04-27 16:55:17,643 - DEBUG - VN ctest-vn-51165890 UUID is 92b2502f-56bf-4932-91aa-b11828a2d645 2025-04-27 16:55:17,982 - DEBUG - Response for create_port : {'port': {'name': 'c28ed74f-5f0e-433f-bff3-9c3c5d7cc11a', 'id': 'c28ed74f-5f0e-433f-bff3-9c3c5d7cc11a', 'tenant_id': 'c91ee3deca754587ac584ab112a4d691', 'network_id': '92b2502f-56bf-4932-91aa-b11828a2d645', 'mac_address': '02:c2:8e:d7:4f:5f', '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': '7910eef5-9142-436b-9bef-5c8b10f2d4d0'}], 'security_groups': ['2f08ce5e-c1fe-4b1a-b564-072f449adf0a'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': 'c91ee3deca754587ac584ab112a4d691'}} 2025-04-27 16:55:18,242 - DEBUG - Response for create_port : {'port': {'name': '9b5c34e1-958e-438f-ac88-6a5d917952c8', 'id': '9b5c34e1-958e-438f-ac88-6a5d917952c8', 'tenant_id': 'c91ee3deca754587ac584ab112a4d691', 'network_id': '92b2502f-56bf-4932-91aa-b11828a2d645', 'mac_address': '02:9b:5c:34:e1:95', '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': 'ef325fec-9ef7-41ed-b8cf-d5d4df06f478'}], 'security_groups': ['2f08ce5e-c1fe-4b1a-b564-072f449adf0a'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': 'c91ee3deca754587ac584ab112a4d691'}} 2025-04-27 16:55:18,545 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3228-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3228-1) 2025-04-27 16:55:18,860 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3228-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3228-1) 2025-04-27 16:55:19,888 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3228-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3228-1) 2025-04-27 16:55:19,888 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-04-27 16:55:19,897 - DEBUG - Requesting: http://10.0.0.38:8082/domain/90bd626b-cf9a-4b40-9c73-769a4185e78a 2025-04-27 16:55:19,908 - DEBUG - Requesting: http://10.0.0.38:8082/project/c91ee3de-ca75-4587-ac58-4ab112a4d691 2025-04-27 16:55:19,984 - DEBUG - Requesting: http://10.0.0.38:8082/network-ipam/f75221d4-872e-4a65-b876-bc951b3a93fc 2025-04-27 16:55:19,993 - INFO - Verifications in API Server for IPAM: ctest-ipam-40838328 passed 2025-04-27 16:55:20,000 - DEBUG - Control-node 10.0.0.38 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestBasicVMVN-67815320:ctest-ipam-40838328', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN-67815320', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17821343872143215205', 'uuid-lslong': '13292018698823570428'}, 'enable': 'true', 'created': '2025-04-27T16:55:16', 'last-modified': '2025-04-27T16:55:16', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.025025'} 2025-04-27 16:55:20,000 - INFO - Verifications in Control node for IPAM: ctest-ipam-40838328 passed 2025-04-27 16:55:20,001 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-04-27 16:55:20,006 - DEBUG - Requesting: http://10.0.0.38:8082/domain/90bd626b-cf9a-4b40-9c73-769a4185e78a 2025-04-27 16:55:20,019 - DEBUG - Requesting: http://10.0.0.38:8082/project/c91ee3de-ca75-4587-ac58-4ab112a4d691 2025-04-27 16:55:20,094 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/92b2502f-56bf-4932-91aa-b11828a2d645 2025-04-27 16:55:20,111 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/92b2502f-56bf-4932-91aa-b11828a2d645 2025-04-27 16:55:20,122 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b5e7cf50-c7a6-463d-82df-974631c1a293 2025-04-27 16:55:20,129 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b5e7cf50-c7a6-463d-82df-974631c1a293 2025-04-27 16:55:20,140 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/7c940902-0fac-44ba-9d3e-a25e88f45213 2025-04-27 16:55:20,145 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-04-27 16:55:20,145 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/92b2502f-56bf-4932-91aa-b11828a2d645 2025-04-27 16:55:20,156 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b5e7cf50-c7a6-463d-82df-974631c1a293 2025-04-27 16:55:20,173 - INFO - Verified VN network id 9 for VN 92b2502f-56bf-4932-91aa-b11828a2d645 2025-04-27 16:55:20,173 - INFO - Verifications in API Server for VN ctest-vn-51165890 passed 2025-04-27 16:55:20,173 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/92b2502f-56bf-4932-91aa-b11828a2d645 2025-04-27 16:55:20,190 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b5e7cf50-c7a6-463d-82df-974631c1a293 2025-04-27 16:55:20,210 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b5e7cf50-c7a6-463d-82df-974631c1a293 2025-04-27 16:55:20,217 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/7c940902-0fac-44ba-9d3e-a25e88f45213 2025-04-27 16:55:20,229 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicVMVN-67815320:ctest-vn-51165890', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN-67815320', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10570599439641037106', 'uuid-lslong': '10496396598859454021'}, 'enable': 'true', 'created': '2025-04-27T16:55:17', 'last-modified': '2025-04-27T16:55:17', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.687482'} 2025-04-27 16:55:20,236 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-04-27 16:55:20,236 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn-51165890 passed 2025-04-27 16:55:20,236 - DEBUG - ====Verifying policy data for ctest-vn-51165890 in API_Server ====== 2025-04-27 16:55:20,236 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-04-27 16:55:20,244 - DEBUG - Requesting: http://10.0.0.38:8082/domain/90bd626b-cf9a-4b40-9c73-769a4185e78a 2025-04-27 16:55:20,256 - DEBUG - Requesting: http://10.0.0.38:8082/project/c91ee3de-ca75-4587-ac58-4ab112a4d691 2025-04-27 16:55:20,290 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/92b2502f-56bf-4932-91aa-b11828a2d645 2025-04-27 16:55:20,302 - DEBUG - =>VN ctest-vn-51165890 has no policy to be verified 2025-04-27 16:55:20,302 - DEBUG - Verifying the vn in opserver 2025-04-27 16:55:20,302 - DEBUG - Verifying the default-domain:ctest-TestBasicVMVN-67815320:ctest-vn-51165890 virtual network link through opserver 10.0.0.38 2025-04-27 16:55:20,302 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-04-27 16:55:20,653 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-04-27 16:55:20,739 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicVMVN-67815320:ctest-vn-51165890', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicVMVN-67815320:ctest-vn-51165890?flat'} 2025-04-27 16:55:20,739 - INFO - Validated that VN default-domain:ctest-TestBasicVMVN-67815320:ctest-vn-51165890 is found in opserver 2025-04-27 16:55:20,745 - DEBUG - VRF ids for VN ctest-vn-51165890: {'10.0.0.38': '2'} 2025-04-27 16:55:20,745 - INFO - Waiting for VM ctest-TestBasicVMVN-67815320-23119918 to be up.. 2025-04-27 16:55:20,838 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-04-27 16:55:25,907 - DEBUG - VM is in ACTIVE state now 2025-04-27 16:55:25,907 - INFO - VM name : ctest-TestBasicVMVN-67815320-23119918 2025-04-27 16:55:25,971 - DEBUG - VM ctest-TestBasicVMVN-67815320-23119918 ID is 74acf79c-6483-4223-8f7c-aaecdcb1f71b 2025-04-27 16:55:25,971 - DEBUG - VM ctest-TestBasicVMVN-67815320-23119918 launched on Node cn-jenkins-deploy-platform-ansible-os-3228-1 2025-04-27 16:55:26,033 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/74acf79c-6483-4223-8f7c-aaecdcb1f71b 2025-04-27 16:55:26,041 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/c28ed74f-5f0e-433f-bff3-9c3c5d7cc11a 2025-04-27 16:55:29,287 - 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 1020ms') 2025-04-27 16:55:29,287 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-67815320-23119918 failed! 2025-04-27 16:55:29,343 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-67815320:ctest-vn-51165890 is 31.1.1.1 and allocation pool is NOT set 2025-04-27 16:55:29,344 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-67815320:ctest-vn-51165890 is 31.1.2.1 and allocation pool is NOT set 2025-04-27 16:55:31,399 - 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.34 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.294 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.294/1.317/2.340/1.023 ms') 2025-04-27 16:55:31,399 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-67815320-23119918 passed 2025-04-27 16:55:31,543 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-04-27 16:55:31,544 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-67815320-23119918, IP 31.1.1.4, Port 22 2025-04-27 16:55:31,694 - DEBUG - VM ctest-TestBasicVMVN-67815320-23119918 is ready for SSH connections 2025-04-27 16:55:31,694 - INFO - Waiting for VM ctest-TestBasicVMVN-67815320-71892019 to be up.. 2025-04-27 16:55:31,760 - DEBUG - VM is in ACTIVE state now 2025-04-27 16:55:31,760 - INFO - VM name : ctest-TestBasicVMVN-67815320-71892019 2025-04-27 16:55:31,814 - DEBUG - VM ctest-TestBasicVMVN-67815320-71892019 ID is 14b8c87b-077b-4350-9272-d5a1faaae017 2025-04-27 16:55:31,814 - DEBUG - VM ctest-TestBasicVMVN-67815320-71892019 launched on Node cn-jenkins-deploy-platform-ansible-os-3228-1 2025-04-27 16:55:31,869 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/14b8c87b-077b-4350-9272-d5a1faaae017 2025-04-27 16:55:31,875 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/9b5c34e1-958e-438f-ac88-6a5d917952c8 2025-04-27 16:55:33,103 - 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.40 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.355 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.355/1.379/2.404/1.024 ms') 2025-04-27 16:55:33,103 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBasicVMVN-67815320-71892019 passed 2025-04-27 16:55:33,251 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-04-27 16:55:33,252 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-67815320-71892019, IP 31.1.2.4, Port 22 2025-04-27 16:55:33,403 - DEBUG - VM ctest-TestBasicVMVN-67815320-71892019 is ready for SSH connections 2025-04-27 16:55:33,403 - INFO - Waiting for VM ctest-TestBasicVMVN-67815320-96220662 to be up.. 2025-04-27 16:55:33,487 - DEBUG - VM is in ACTIVE state now 2025-04-27 16:55:33,487 - INFO - VM name : ctest-TestBasicVMVN-67815320-96220662 2025-04-27 16:55:33,547 - DEBUG - VM ctest-TestBasicVMVN-67815320-96220662 ID is 25d03977-c22c-410d-b79c-ec6e7f45f1e2 2025-04-27 16:55:33,547 - DEBUG - VM ctest-TestBasicVMVN-67815320-96220662 launched on Node cn-jenkins-deploy-platform-ansible-os-3228-1 2025-04-27 16:55:33,599 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/25d03977-c22c-410d-b79c-ec6e7f45f1e2 2025-04-27 16:55:33,606 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/5da56638-4126-4d61-b96c-bd0d2ac1d957 2025-04-27 16:55:34,834 - 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=2.39 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.301 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.301/1.347/2.394/1.046 ms') 2025-04-27 16:55:34,834 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-67815320-96220662 passed 2025-04-27 16:55:34,975 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-04-27 16:55:34,975 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-67815320-96220662, IP 31.1.1.3, Port 22 2025-04-27 16:55:35,126 - DEBUG - VM ctest-TestBasicVMVN-67815320-96220662 is ready for SSH connections 2025-04-27 16:55:35,127 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-04-27 16:55:35,127 - 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.38, gateway password: c0ntrail123 2025-04-27 16:55:35,127 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4 2025-04-27 16:55:38,993 - 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=2.854 ms 64 bytes from 31.1.2.4: seq=1 ttl=63 time=0.792 ms 64 bytes from 31.1.2.4: seq=2 ttl=63 time=0.718 ms --- 31.1.2.4 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 0.718/1.454/2.854 ms 2025-04-27 16:55:38,993 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-67815320-23119918 passed 2025-04-27 16:55:38,993 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-04-27 16:55:38,993 - 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.38, gateway password: c0ntrail123 2025-04-27 16:55:38,993 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4 2025-04-27 16:55:42,558 - 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.277 ms 64 bytes from 31.1.1.4: seq=1 ttl=63 time=0.766 ms 64 bytes from 31.1.1.4: seq=2 ttl=63 time=0.605 ms --- 31.1.1.4 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 0.605/1.216/2.277 ms 2025-04-27 16:55:42,558 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-67815320-71892019 passed 2025-04-27 16:55:42,558 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-04-27 16:55:42,558 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-04-27 16:55:42,558 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-04-27 16:55:42,558 - 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.38, gateway password: c0ntrail123 2025-04-27 16:55:42,558 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts 2025-04-27 16:55:42,712 - DEBUG - None 2025-04-27 16:55:42,712 - 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.38, gateway password: c0ntrail123 2025-04-27 16:55:42,712 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts 2025-04-27 16:55:42,874 - DEBUG - None 2025-04-27 16:55:42,874 - 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.38, gateway password: c0ntrail123 2025-04-27 16:55:42,874 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts 2025-04-27 16:55:43,411 - DEBUG - None 2025-04-27 16:55:43,412 - 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.38, gateway password: c0ntrail123 2025-04-27 16:55:43,413 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7 2025-04-27 16:55:45,589 - 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=1.608 ms 64 bytes from 31.1.1.3: seq=0 ttl=64 time=3.869 ms (DUP!) 64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.377 ms 64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.498 ms (DUP!) 64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.380 ms --- 31.1.1.7 ping statistics --- 3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss round-trip min/avg/max = 0.377/1.546/3.869 ms 2025-04-27 16:55:45,589 - 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.38, gateway password: c0ntrail123 2025-04-27 16:55:45,589 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1 2025-04-27 16:55:47,796 - 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=0.836 ms 64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.285 ms (DUP!) 64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.154 ms (DUP!) 64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.386 ms 64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.471 ms (DUP!) 64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.138 ms (DUP!) 64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.343 ms --- 224.0.0.1 ping statistics --- 3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss round-trip min/avg/max = 0.343/1.516/3.154 ms 2025-04-27 16:55:47,797 - 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.38, gateway password: c0ntrail123 2025-04-27 16:55:47,797 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255 2025-04-27 16:55:50,016 - 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=0.780 ms 64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.228 ms (DUP!) 64 bytes from 31.1.2.4: seq=0 ttl=63 time=2.990 ms (DUP!) 64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.368 ms 64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.562 ms (DUP!) 64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.331 ms (DUP!) 64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.498 ms --- 255.255.255.255 ping statistics --- 3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss round-trip min/avg/max = 0.368/1.536/2.990 ms 2025-04-27 16:55:50,016 - INFO - Deleting VM ctest-TestBasicVMVN-67815320-96220662 2025-04-27 16:55:50,068 - INFO - Detaching port 9b5c34e1-958e-438f-ac88-6a5d917952c8 from VM ctest-TestBasicVMVN-67815320-71892019 2025-04-27 16:55:50,109 - INFO - Deleting VM ctest-TestBasicVMVN-67815320-71892019 2025-04-27 16:55:50,162 - INFO - Detaching port c28ed74f-5f0e-433f-bff3-9c3c5d7cc11a from VM ctest-TestBasicVMVN-67815320-23119918 2025-04-27 16:55:50,189 - INFO - Deleting VM ctest-TestBasicVMVN-67815320-23119918 2025-04-27 16:55:50,249 - INFO - Deleting VN ctest-vn-51165890 2025-04-27 16:55:50,414 - DEBUG - Response for delete_port : () 2025-04-27 16:55:50,548 - DEBUG - Response for delete_port : () 2025-04-27 16:55:50,584 - DEBUG - VN 92b2502f-56bf-4932-91aa-b11828a2d645 still in use: Unable to complete operation on network 92b2502f-56bf-4932-91aa-b11828a2d645. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-90f432ec-26ca-470c-b71c-584332b73316'] 2025-04-27 16:55:50,584 - WARNING - Deleting VN ctest-vn-51165890 failed..Will retry 2025-04-27 16:55:52,694 - DEBUG - Response for deleting network () 2025-04-27 16:55:52,694 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/b5e7cf50-c7a6-463d-82df-974631c1a293 2025-04-27 16:55:52,699 - DEBUG - Response Code: 404 2025-04-27 16:55:52,699 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-04-27 16:55:52,703 - DEBUG - Requesting: http://10.0.0.38:8082/domain/90bd626b-cf9a-4b40-9c73-769a4185e78a 2025-04-27 16:55:52,756 - DEBUG - Requesting: http://10.0.0.38:8082/project/c91ee3de-ca75-4587-ac58-4ab112a4d691 2025-04-27 16:55:52,828 - INFO - Validated that VN ctest-vn-51165890 is not found in API Server 2025-04-27 16:55:52,838 - DEBUG - VN ctest-vn-51165890 is not present in Agent 10.0.0.38 2025-04-27 16:55:52,838 - INFO - Validated that VN ctest-vn-51165890 is not in any agent 2025-04-27 16:55:52,843 - DEBUG - VRF 2 is not seen in agent 10.0.0.38 2025-04-27 16:55:52,848 - DEBUG - Vrouter 10.0.0.38 does not have vrf 2 for VN ctest-vn-51165890 2025-04-27 16:55:52,848 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-67815320:ctest-vn-51165890 2025-04-27 16:55:52,857 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-51165890 info 2025-04-27 16:55:52,927 - INFO - IPAM: ctest-ipam-40838328 is not found in API Server 2025-04-27 16:55:52,937 - INFO - IPAM:ctest-ipam-40838328 is not found in control node 2025-04-27 16:55:53,197 - DEBUG - No XMPP flaps were noticed during the test
2025-04-27 16:55:53,197 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:37]
2025-04-27 16:55:53,197 - INFO - -------------------------------------------------------------------------------- 2025-04-27 16:55:53,822 - INFO - Deleted project: ctest-TestBasicVMVN-67815320, ID : c91ee3de-ca75-4587-ac58-4ab112a4d691