2025-08-15 09:40:59,037 - INFO - Domain Default found not creating
2025-08-15 09:40:59,177 - INFO - Project ctest-TestBasicVMVN-97239836 not found, creating it
2025-08-15 09:40:59,644 - INFO - Created Project:ctest-TestBasicVMVN-97239836, ID : 879c75e7-881c-4598-a587-17b97815fc5e
2025-08-15 09:41:01,123 - INFO - ================================================================================
2025-08-15 09:41:01,123 - INFO - STARTING TEST : test_generic_link_local_service
2025-08-15 09:41:01,123 - 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-08-15 09:41:01,383 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.129': '0'}} with
2025-08-15 09:41:01,383 - INFO - Initial checks done. Running the testcase now
2025-08-15 09:41:01,383 - INFO -
2025-08-15 09:41:01,912 - DEBUG - Response for create_network : {'network': {'id': '67d0e796-28aa-4706-ac73-18a908e6d7d0', 'name': 'ctest-vn2_metadata-84706054', 'tenant_id': '879c75e7881c4598a58717b97815fc5e', 'project_id': '879c75e7881c4598a58717b97815fc5e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-97239836', 'ctest-vn2_metadata-84706054'], 'port_security_enabled': True, 'description': ''}}
2025-08-15 09:41:02,129 - DEBUG - Response for create_subnet : {'subnet': {'id': '32949ad7-fc8e-4c33-aa13-a100b1208fcd', 'name': '', 'tenant_id': '879c75e7881c4598a58717b97815fc5e', 'network_id': '67d0e796-28aa-4706-ac73-18a908e6d7d0', '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': '879c75e7881c4598a58717b97815fc5e'}}
2025-08-15 09:41:02,146 - INFO - Created VN ctest-vn2_metadata-84706054
2025-08-15 09:41:02,198 - DEBUG - VN ctest-vn2_metadata-84706054 UUID is 67d0e796-28aa-4706-ac73-18a908e6d7d0
2025-08-15 09:41:02,363 - DEBUG - Services list from nova: [, , ]
2025-08-15 09:41:03,324 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3863-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3863-1)
2025-08-15 09:41:03,430 - DEBUG - Link local service introspect added
2025-08-15 09:41:03,469 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-08-15 09:41:08,542 - DEBUG - VM is in ACTIVE state now
2025-08-15 09:41:08,666 - INFO - Waiting for VM ctest-TestBasicVMVN-97239836-54030885 to be up..
2025-08-15 09:41:08,666 - INFO - VM name : ctest-TestBasicVMVN-97239836-54030885
2025-08-15 09:41:08,737 - DEBUG - VM ctest-TestBasicVMVN-97239836-54030885 ID is 4f4c5ad4-8ec0-48f8-bfe4-c602d95f6bff
2025-08-15 09:41:08,737 - DEBUG - VM ctest-TestBasicVMVN-97239836-54030885 launched on Node cn-jenkins-deploy-platform-ansible-os-3863-1
2025-08-15 09:41:08,803 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine/4f4c5ad4-8ec0-48f8-bfe4-c602d95f6bff
2025-08-15 09:41:09,095 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine/4f4c5ad4-8ec0-48f8-bfe4-c602d95f6bff
2025-08-15 09:41:09,123 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine-interface/9010a1bf-688c-4530-868c-a3d29609e9c1
2025-08-15 09:41:12,358 - 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 1004ms')
2025-08-15 09:41:12,358 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-97239836-54030885 failed!
2025-08-15 09:41:12,410 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-97239836:ctest-vn2_metadata-84706054 is 11.1.1.1 and allocation pool is NOT set
2025-08-15 09:41:14,473 - 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.94 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.58 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 = 2.581/2.759/2.938/0.178 ms')
2025-08-15 09:41:14,473 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-97239836-54030885 passed
2025-08-15 09:41:14,622 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-15 09:41:14,622 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-97239836-54030885, IP 11.1.1.3, Port 22
2025-08-15 09:41:14,682 - 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-08-15 09:41:14,762 - DEBUG - VM ctest-TestBasicVMVN-97239836-54030885 is NOT ready for SSH connections, VM status: ACTIVE
2025-08-15 09:41:19,763 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-15 09:41:19,763 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-97239836-54030885, IP 11.1.1.3, Port 22
2025-08-15 09:41:19,917 - DEBUG - VM ctest-TestBasicVMVN-97239836-54030885 is ready for SSH connections
2025-08-15 09:41:19,918 - INFO - Retry 0
2025-08-15 09:41:19,918 - 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.41, gateway password: c0ntrail123
2025-08-15 09:41:19,918 - DEBUG - wget http://169.254.1.2:8083 --spider && echo "Successful"
2025-08-15 09:41:21,508 - DEBUG - Connecting to 169.254.1.2:8083 (169.254.1.2:8083)
Successful
2025-08-15 09:41:21,508 - INFO - Generic metadata worked
2025-08-15 09:41:21,746 - DEBUG - Link local service introspect removed
2025-08-15 09:41:21,746 - INFO - Deleting VM ctest-TestBasicVMVN-97239836-54030885
2025-08-15 09:41:21,806 - INFO - Deleting VN ctest-vn2_metadata-84706054
2025-08-15 09:41:21,839 - DEBUG - VN 67d0e796-28aa-4706-ac73-18a908e6d7d0 still in use: Unable to complete operation on network 67d0e796-28aa-4706-ac73-18a908e6d7d0. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-9489aeae-ec3e-4407-87c4-6af714dfdcd9']
2025-08-15 09:41:21,839 - WARNING - Deleting VN ctest-vn2_metadata-84706054 failed..Will retry
2025-08-15 09:41:23,936 - DEBUG - Response for deleting network ()
2025-08-15 09:41:24,190 - DEBUG - No XMPP flaps were noticed during the test
2025-08-15 09:41:24,190 - INFO - END TEST : test_generic_link_local_service : PASSED[0:00:23]
2025-08-15 09:41:24,191 - INFO - --------------------------------------------------------------------------------
2025-08-15 09:41:24,194 - INFO - ================================================================================
2025-08-15 09:41:24,194 - INFO - STARTING TEST : test_metadata_service
2025-08-15 09:41:24,194 - 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-08-15 09:41:24,478 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.129': '0'}} with
2025-08-15 09:41:24,478 - INFO - Initial checks done. Running the testcase now
2025-08-15 09:41:24,478 - INFO -
2025-08-15 09:41:24,478 - DEBUG - Requesting: http://10.0.0.41:8082/global-vrouter-configs
2025-08-15 09:41:24,484 - DEBUG - Requesting: http://10.0.0.41:8082/global-vrouter-config/dc9d0051-4050-403d-a742-32f128049e79
2025-08-15 09:41:24,655 - DEBUG - Response for create_network : {'network': {'id': 'dde32f35-0117-4c7b-846c-d3c53c733a3b', 'name': 'ctest-vn-18449622', 'tenant_id': '879c75e7881c4598a58717b97815fc5e', 'project_id': '879c75e7881c4598a58717b97815fc5e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-97239836', 'ctest-vn-18449622'], 'port_security_enabled': True, 'description': ''}}
2025-08-15 09:41:24,800 - DEBUG - Response for create_subnet : {'subnet': {'id': '4dd009d7-3eb2-42cc-b4a3-d2d973cd79b4', 'name': '', 'tenant_id': '879c75e7881c4598a58717b97815fc5e', 'network_id': 'dde32f35-0117-4c7b-846c-d3c53c733a3b', 'ip_version': 4, 'cidr': '14.212.198.0/26', 'allocation_pools': [{'start': '14.212.198.2', 'end': '14.212.198.62'}], 'gateway_ip': '14.212.198.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '14.212.198.2', 'tags': [], 'project_id': '879c75e7881c4598a58717b97815fc5e'}}
2025-08-15 09:41:24,817 - INFO - Created VN ctest-vn-18449622
2025-08-15 09:41:24,870 - DEBUG - VN ctest-vn-18449622 UUID is dde32f35-0117-4c7b-846c-d3c53c733a3b
2025-08-15 09:41:25,999 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3863-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3863-1)
2025-08-15 09:41:25,999 - INFO - Waiting for VM ctest-TestBasicVMVN-97239836-66214128 to be up..
2025-08-15 09:41:26,038 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-08-15 09:41:31,107 - DEBUG - VM is in ACTIVE state now
2025-08-15 09:41:31,107 - INFO - VM name : ctest-TestBasicVMVN-97239836-66214128
2025-08-15 09:41:31,171 - DEBUG - VM ctest-TestBasicVMVN-97239836-66214128 ID is d9130165-9704-4d3b-b083-60580de9f939
2025-08-15 09:41:31,171 - DEBUG - VM ctest-TestBasicVMVN-97239836-66214128 launched on Node cn-jenkins-deploy-platform-ansible-os-3863-1
2025-08-15 09:41:31,235 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine/d9130165-9704-4d3b-b083-60580de9f939
2025-08-15 09:41:31,243 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine-interface/f465470b-a54c-4fcf-a357-b8b83395c839
2025-08-15 09:41:34,500 - 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-15 09:41:34,500 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-97239836-66214128 failed!
2025-08-15 09:41:34,554 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-97239836:ctest-vn-18449622 is 14.212.198.1 and allocation pool is NOT set
2025-08-15 09:41:36,618 - 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=4.17 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.02 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 = 1.022/2.596/4.170/1.574 ms')
2025-08-15 09:41:36,618 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-97239836-66214128 passed
2025-08-15 09:41:36,770 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-15 09:41:36,770 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-97239836-66214128, IP 14.212.198.3, Port 22
2025-08-15 09:41:36,921 - DEBUG - VM ctest-TestBasicVMVN-97239836-66214128 is ready for SSH connections
2025-08-15 09:41:36,921 - DEBUG - Running remote_cmd, Cmd : cat /tmp/output.txt, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.41, gateway password: c0ntrail123
2025-08-15 09:41:36,922 - DEBUG - cat /tmp/output.txt
2025-08-15 09:41:38,575 - DEBUG - Hello World. The time is now Fri, 15 Aug 2025 03:41:34 -0600!
2025-08-15 09:41:38,575 - DEBUG - ret : {'cat /tmp/output.txt': 'Hello World. The time is now Fri, 15 Aug 2025 03:41:34 -0600!'}
2025-08-15 09:41:38,575 - INFO - metadata_script.txt got executed in the vm
2025-08-15 09:41:38,575 - INFO - Deleting VM ctest-TestBasicVMVN-97239836-66214128
2025-08-15 09:41:38,637 - INFO - Deleting VN ctest-vn-18449622
2025-08-15 09:41:38,673 - DEBUG - VN dde32f35-0117-4c7b-846c-d3c53c733a3b still in use: Unable to complete operation on network dde32f35-0117-4c7b-846c-d3c53c733a3b. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-1124e509-2a26-4a0e-9ed4-c854fb1e6a41']
2025-08-15 09:41:38,673 - WARNING - Deleting VN ctest-vn-18449622 failed..Will retry
2025-08-15 09:41:40,761 - DEBUG - Response for deleting network ()
2025-08-15 09:41:41,022 - DEBUG - No XMPP flaps were noticed during the test
2025-08-15 09:41:41,022 - INFO - END TEST : test_metadata_service : PASSED[0:00:17]
2025-08-15 09:41:41,022 - INFO - --------------------------------------------------------------------------------
2025-08-15 09:41:41,024 - INFO - ================================================================================
2025-08-15 09:41:41,024 - INFO - STARTING TEST : test_ping_within_vn_two_vms_two_different_subnets
2025-08-15 09:41:41,025 - 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-08-15 09:41:41,310 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.129': '0'}} with
2025-08-15 09:41:41,310 - INFO - Initial checks done. Running the testcase now
2025-08-15 09:41:41,310 - INFO -
2025-08-15 09:41:41,800 - DEBUG - Response for create_network : {'network': {'id': '58d2ce70-2811-45b6-b1d3-a8efbf473831', 'name': 'ctest-vn-44820592', 'tenant_id': '879c75e7881c4598a58717b97815fc5e', 'project_id': '879c75e7881c4598a58717b97815fc5e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-97239836', 'ctest-vn-44820592'], 'port_security_enabled': True, 'description': ''}}
2025-08-15 09:41:41,997 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c09979cc-4b31-45b7-b8e5-ac0f08fff715', 'name': '', 'tenant_id': '879c75e7881c4598a58717b97815fc5e', 'network_id': '58d2ce70-2811-45b6-b1d3-a8efbf473831', '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': '879c75e7881c4598a58717b97815fc5e'}}
2025-08-15 09:41:42,180 - DEBUG - Response for create_subnet : {'subnet': {'id': '1778a9bd-3bf9-4680-b976-036c6fbfee23', 'name': '', 'tenant_id': '879c75e7881c4598a58717b97815fc5e', 'network_id': '58d2ce70-2811-45b6-b1d3-a8efbf473831', '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': '879c75e7881c4598a58717b97815fc5e'}}
2025-08-15 09:41:42,198 - INFO - Created VN ctest-vn-44820592
2025-08-15 09:41:42,250 - DEBUG - VN ctest-vn-44820592 UUID is 58d2ce70-2811-45b6-b1d3-a8efbf473831
2025-08-15 09:41:42,574 - DEBUG - Response for create_port : {'port': {'name': '72284eaf-a9c3-463d-8c9e-01a13309cc19', 'id': '72284eaf-a9c3-463d-8c9e-01a13309cc19', 'tenant_id': '879c75e7881c4598a58717b97815fc5e', 'network_id': '58d2ce70-2811-45b6-b1d3-a8efbf473831', 'mac_address': '02:72:28:4e:af:a9', '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': 'c09979cc-4b31-45b7-b8e5-ac0f08fff715'}], 'security_groups': ['38b7985a-e147-43fe-b388-e0039984f6c6'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '879c75e7881c4598a58717b97815fc5e'}}
2025-08-15 09:41:42,729 - DEBUG - Response for create_port : {'port': {'name': '8fb139f2-59cb-4587-9806-b9622f9f7f12', 'id': '8fb139f2-59cb-4587-9806-b9622f9f7f12', 'tenant_id': '879c75e7881c4598a58717b97815fc5e', 'network_id': '58d2ce70-2811-45b6-b1d3-a8efbf473831', 'mac_address': '02:8f:b1:39:f2:59', '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': '1778a9bd-3bf9-4680-b976-036c6fbfee23'}], 'security_groups': ['38b7985a-e147-43fe-b388-e0039984f6c6'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '879c75e7881c4598a58717b97815fc5e'}}
2025-08-15 09:41:43,043 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3863-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3863-1)
2025-08-15 09:41:43,404 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3863-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3863-1)
2025-08-15 09:41:44,574 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3863-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3863-1)
2025-08-15 09:41:44,574 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-08-15 09:41:44,580 - DEBUG - Requesting: http://10.0.0.41:8082/domain/49aa4ce0-7fff-469c-a8e7-8aa08626eb89
2025-08-15 09:41:44,595 - DEBUG - Requesting: http://10.0.0.41:8082/project/879c75e7-881c-4598-a587-17b97815fc5e
2025-08-15 09:41:44,677 - DEBUG - Requesting: http://10.0.0.41:8082/network-ipam/e0c66c4b-33fc-46f5-a64c-1e5cf58863bc
2025-08-15 09:41:44,689 - INFO - Verifications in API Server for IPAM: ctest-ipam-73589581 passed
2025-08-15 09:41:44,694 - DEBUG - Control-node 10.0.0.41 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestBasicVMVN-97239836:ctest-ipam-73589581', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN-97239836', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16196752180135085813', 'uuid-lslong': '11982986093131228092'}, 'enable': 'true', 'created': '2025-08-15T09:41:41', 'last-modified': '2025-08-15T09:41:41', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.151194'}
2025-08-15 09:41:44,695 - INFO - Verifications in Control node for IPAM: ctest-ipam-73589581 passed
2025-08-15 09:41:44,695 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-08-15 09:41:44,707 - DEBUG - Requesting: http://10.0.0.41:8082/domain/49aa4ce0-7fff-469c-a8e7-8aa08626eb89
2025-08-15 09:41:44,730 - DEBUG - Requesting: http://10.0.0.41:8082/project/879c75e7-881c-4598-a587-17b97815fc5e
2025-08-15 09:41:44,814 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/58d2ce70-2811-45b6-b1d3-a8efbf473831
2025-08-15 09:41:44,831 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/58d2ce70-2811-45b6-b1d3-a8efbf473831
2025-08-15 09:41:44,842 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/847332ed-0475-4886-9435-c4ff9055bf47
2025-08-15 09:41:44,864 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/847332ed-0475-4886-9435-c4ff9055bf47
2025-08-15 09:41:44,872 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/0e20b19a-414d-468c-9d47-64ed63bf2db6
2025-08-15 09:41:44,880 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-15 09:41:44,880 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/58d2ce70-2811-45b6-b1d3-a8efbf473831
2025-08-15 09:41:44,894 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/847332ed-0475-4886-9435-c4ff9055bf47
2025-08-15 09:41:44,913 - INFO - Verified VN network id 12 for VN 58d2ce70-2811-45b6-b1d3-a8efbf473831
2025-08-15 09:41:44,913 - INFO - Verifications in API Server for VN ctest-vn-44820592 passed
2025-08-15 09:41:44,914 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/58d2ce70-2811-45b6-b1d3-a8efbf473831
2025-08-15 09:41:44,928 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/847332ed-0475-4886-9435-c4ff9055bf47
2025-08-15 09:41:44,938 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/847332ed-0475-4886-9435-c4ff9055bf47
2025-08-15 09:41:44,946 - DEBUG - Requesting: http://10.0.0.41:8082/route-target/0e20b19a-414d-468c-9d47-64ed63bf2db6
2025-08-15 09:41:44,965 - DEBUG - Control-node 10.0.0.41 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicVMVN-97239836:ctest-vn-44820592', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN-97239836', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6400405001550775734', 'uuid-lslong': '12813771112458958897'}, 'enable': 'true', 'created': '2025-08-15T09:41:41', 'last-modified': '2025-08-15T09:41:42', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.808477'}
2025-08-15 09:41:44,977 - DEBUG - Route Targets: ['target:64512:8000005']
2025-08-15 09:41:44,977 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn-44820592 passed
2025-08-15 09:41:44,978 - DEBUG - ====Verifying policy data for ctest-vn-44820592 in API_Server ======
2025-08-15 09:41:44,978 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-08-15 09:41:44,989 - DEBUG - Requesting: http://10.0.0.41:8082/domain/49aa4ce0-7fff-469c-a8e7-8aa08626eb89
2025-08-15 09:41:45,052 - DEBUG - Requesting: http://10.0.0.41:8082/project/879c75e7-881c-4598-a587-17b97815fc5e
2025-08-15 09:41:45,187 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-network/58d2ce70-2811-45b6-b1d3-a8efbf473831
2025-08-15 09:41:45,221 - DEBUG - =>VN ctest-vn-44820592 has no policy to be verified
2025-08-15 09:41:45,221 - DEBUG - Verifying the vn in opserver
2025-08-15 09:41:45,222 - DEBUG - Verifying the default-domain:ctest-TestBasicVMVN-97239836:ctest-vn-44820592 virtual network link through opserver 10.0.0.41
2025-08-15 09:41:45,222 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-08-15 09:41:45,593 - DEBUG - Requesting: http://10.0.0.41:8081/analytics/uves/virtual-networks
2025-08-15 09:41:45,646 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicVMVN-97239836:ctest-vn-44820592', 'href': 'http://10.0.0.41:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicVMVN-97239836:ctest-vn-44820592?flat'}
2025-08-15 09:41:45,646 - INFO - Validated that VN default-domain:ctest-TestBasicVMVN-97239836:ctest-vn-44820592 is found in opserver
2025-08-15 09:41:45,651 - DEBUG - VRF ids for VN ctest-vn-44820592: {'10.0.0.41': '2'}
2025-08-15 09:41:45,651 - INFO - Waiting for VM ctest-TestBasicVMVN-97239836-85486657 to be up..
2025-08-15 09:41:45,721 - DEBUG - VM is in ACTIVE state now
2025-08-15 09:41:45,721 - INFO - VM name : ctest-TestBasicVMVN-97239836-85486657
2025-08-15 09:41:45,804 - DEBUG - VM ctest-TestBasicVMVN-97239836-85486657 ID is 9eeb7cee-851d-49b0-a98d-2cf05cfe05bf
2025-08-15 09:41:45,804 - DEBUG - VM ctest-TestBasicVMVN-97239836-85486657 launched on Node cn-jenkins-deploy-platform-ansible-os-3863-1
2025-08-15 09:41:45,883 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine/9eeb7cee-851d-49b0-a98d-2cf05cfe05bf
2025-08-15 09:41:45,891 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine-interface/72284eaf-a9c3-463d-8c9e-01a13309cc19
2025-08-15 09:41:49,157 - 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 1032ms')
2025-08-15 09:41:49,157 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-97239836-85486657 failed!
2025-08-15 09:41:49,210 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-97239836:ctest-vn-44820592 is 31.1.1.1 and allocation pool is NOT set
2025-08-15 09:41:49,210 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-97239836:ctest-vn-44820592 is 31.1.2.1 and allocation pool is NOT set
2025-08-15 09:41:53,281 - 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 1015ms')
2025-08-15 09:41:53,281 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-97239836-85486657 failed!
2025-08-15 09:41:53,334 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-97239836:ctest-vn-44820592 is 31.1.1.1 and allocation pool is NOT set
2025-08-15 09:41:53,334 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-97239836:ctest-vn-44820592 is 31.1.2.1 and allocation pool is NOT set
2025-08-15 09:41:55,393 - 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=5.63 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.383 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.383/3.004/5.626/2.621 ms')
2025-08-15 09:41:55,393 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-97239836-85486657 passed
2025-08-15 09:41:55,546 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-15 09:41:55,546 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-97239836-85486657, IP 31.1.1.4, Port 22
2025-08-15 09:41:55,701 - DEBUG - VM ctest-TestBasicVMVN-97239836-85486657 is ready for SSH connections
2025-08-15 09:41:55,701 - INFO - Waiting for VM ctest-TestBasicVMVN-97239836-37741135 to be up..
2025-08-15 09:41:55,770 - DEBUG - VM is in ACTIVE state now
2025-08-15 09:41:55,770 - INFO - VM name : ctest-TestBasicVMVN-97239836-37741135
2025-08-15 09:41:55,835 - DEBUG - VM ctest-TestBasicVMVN-97239836-37741135 ID is db3522d7-6971-424c-b14e-60c3050d92ee
2025-08-15 09:41:55,835 - DEBUG - VM ctest-TestBasicVMVN-97239836-37741135 launched on Node cn-jenkins-deploy-platform-ansible-os-3863-1
2025-08-15 09:41:55,901 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine/db3522d7-6971-424c-b14e-60c3050d92ee
2025-08-15 09:41:55,909 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine-interface/8fb139f2-59cb-4587-9806-b9622f9f7f12
2025-08-15 09:41:57,143 - 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.54 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.337 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.337/1.940/3.543/1.603 ms')
2025-08-15 09:41:57,144 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBasicVMVN-97239836-37741135 passed
2025-08-15 09:41:57,302 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-15 09:41:57,302 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-97239836-37741135, IP 31.1.2.4, Port 22
2025-08-15 09:41:57,457 - DEBUG - VM ctest-TestBasicVMVN-97239836-37741135 is ready for SSH connections
2025-08-15 09:41:57,457 - INFO - Waiting for VM ctest-TestBasicVMVN-97239836-70710092 to be up..
2025-08-15 09:41:57,526 - DEBUG - VM is in ACTIVE state now
2025-08-15 09:41:57,526 - INFO - VM name : ctest-TestBasicVMVN-97239836-70710092
2025-08-15 09:41:57,592 - DEBUG - VM ctest-TestBasicVMVN-97239836-70710092 ID is 309c92dd-2755-4688-930d-d335be801325
2025-08-15 09:41:57,592 - DEBUG - VM ctest-TestBasicVMVN-97239836-70710092 launched on Node cn-jenkins-deploy-platform-ansible-os-3863-1
2025-08-15 09:41:57,659 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine/309c92dd-2755-4688-930d-d335be801325
2025-08-15 09:41:57,667 - DEBUG - Requesting: http://10.0.0.41:8082/virtual-machine-interface/a1fde196-b69f-4ef8-ae39-f692ae46a70e
2025-08-15 09:41:58,899 - 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.63 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.354 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.354/1.492/2.631/1.138 ms')
2025-08-15 09:41:58,900 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-97239836-70710092 passed
2025-08-15 09:41:59,050 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-15 09:41:59,050 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-97239836-70710092, IP 31.1.1.3, Port 22
2025-08-15 09:41:59,201 - DEBUG - VM ctest-TestBasicVMVN-97239836-70710092 is ready for SSH connections
2025-08-15 09:41:59,202 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-15 09:41:59,202 - 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.41, gateway password: c0ntrail123
2025-08-15 09:41:59,202 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4
2025-08-15 09:42:03,207 - 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=3.415 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=0.718 ms
64 bytes from 31.1.2.4: seq=2 ttl=63 time=0.852 ms
--- 31.1.2.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.718/1.661/3.415 ms
2025-08-15 09:42:03,207 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-97239836-85486657 passed
2025-08-15 09:42:03,207 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-15 09:42:03,207 - 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.41, gateway password: c0ntrail123
2025-08-15 09:42:03,207 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4
2025-08-15 09:42:06,855 - 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.817 ms
64 bytes from 31.1.1.4: seq=1 ttl=63 time=0.943 ms
64 bytes from 31.1.1.4: seq=2 ttl=63 time=0.822 ms
--- 31.1.1.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.822/1.527/2.817 ms
2025-08-15 09:42:06,855 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-97239836-37741135 passed
2025-08-15 09:42:06,855 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-15 09:42:06,855 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-15 09:42:06,855 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-15 09:42:06,855 - 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.41, gateway password: c0ntrail123
2025-08-15 09:42:06,855 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-08-15 09:42:07,029 - DEBUG - None
2025-08-15 09:42:07,029 - 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.41, gateway password: c0ntrail123
2025-08-15 09:42:07,029 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-08-15 09:42:07,211 - DEBUG - None
2025-08-15 09:42:07,211 - 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.41, gateway password: c0ntrail123
2025-08-15 09:42:07,211 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-08-15 09:42:08,033 - DEBUG - None
2025-08-15 09:42:08,033 - 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.41, gateway password: c0ntrail123
2025-08-15 09:42:08,033 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7
2025-08-15 09:42:10,229 - 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.881 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=6.487 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.409 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.607 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.432 ms
--- 31.1.1.7 ping statistics ---
3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss
round-trip min/avg/max = 0.409/2.163/6.487 ms
2025-08-15 09:42:10,229 - 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.41, gateway password: c0ntrail123
2025-08-15 09:42:10,229 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1
2025-08-15 09:42:12,464 - 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.917 ms
64 bytes from 31.1.2.4: seq=0 ttl=63 time=2.764 ms (DUP!)
64 bytes from 31.1.1.3: seq=0 ttl=64 time=3.712 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.386 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=1.656 ms (DUP!)
64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.509 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.346 ms
--- 224.0.0.1 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.346/1.755/3.712 ms
2025-08-15 09:42:12,464 - 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.41, gateway password: c0ntrail123
2025-08-15 09:42:12,464 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255
2025-08-15 09:42:14,702 - 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.626 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.251 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=2.986 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.428 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=1.607 ms (DUP!)
64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.570 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.328 ms
--- 255.255.255.255 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.328/1.542/2.986 ms
2025-08-15 09:42:14,702 - INFO - Deleting VM ctest-TestBasicVMVN-97239836-70710092
2025-08-15 09:42:14,762 - INFO - Detaching port 8fb139f2-59cb-4587-9806-b9622f9f7f12 from VM ctest-TestBasicVMVN-97239836-37741135
2025-08-15 09:42:14,790 - INFO - Deleting VM ctest-TestBasicVMVN-97239836-37741135
2025-08-15 09:42:14,856 - INFO - Detaching port 72284eaf-a9c3-463d-8c9e-01a13309cc19 from VM ctest-TestBasicVMVN-97239836-85486657
2025-08-15 09:42:14,893 - INFO - Deleting VM ctest-TestBasicVMVN-97239836-85486657
2025-08-15 09:42:14,955 - INFO - Deleting VN ctest-vn-44820592
2025-08-15 09:42:15,112 - DEBUG - Response for delete_port : ()
2025-08-15 09:42:15,335 - DEBUG - Response for delete_port : ()
2025-08-15 09:42:15,381 - DEBUG - VN 58d2ce70-2811-45b6-b1d3-a8efbf473831 still in use: Unable to complete operation on network 58d2ce70-2811-45b6-b1d3-a8efbf473831. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-f7835dee-bcf1-436b-b9f3-d65277259cba']
2025-08-15 09:42:15,381 - WARNING - Deleting VN ctest-vn-44820592 failed..Will retry
2025-08-15 09:42:17,513 - DEBUG - Response for deleting network ()
2025-08-15 09:42:17,513 - DEBUG - Requesting: http://10.0.0.41:8082/routing-instance/847332ed-0475-4886-9435-c4ff9055bf47
2025-08-15 09:42:17,519 - DEBUG - Response Code: 404
2025-08-15 09:42:17,520 - DEBUG - Requesting: http://10.0.0.41:8082/domains
2025-08-15 09:42:17,524 - DEBUG - Requesting: http://10.0.0.41:8082/domain/49aa4ce0-7fff-469c-a8e7-8aa08626eb89
2025-08-15 09:42:17,584 - DEBUG - Requesting: http://10.0.0.41:8082/project/879c75e7-881c-4598-a587-17b97815fc5e
2025-08-15 09:42:17,663 - INFO - Validated that VN ctest-vn-44820592 is not found in API Server
2025-08-15 09:42:17,674 - DEBUG - VN ctest-vn-44820592 is not present in Agent 10.0.0.41
2025-08-15 09:42:17,674 - INFO - Validated that VN ctest-vn-44820592 is not in any agent
2025-08-15 09:42:17,680 - DEBUG - VRF 2 is not seen in agent 10.0.0.41
2025-08-15 09:42:17,693 - DEBUG - Vrouter 10.0.0.41 does not have vrf 2 for VN ctest-vn-44820592
2025-08-15 09:42:17,693 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-97239836:ctest-vn-44820592
2025-08-15 09:42:17,706 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-44820592 info
2025-08-15 09:42:17,781 - INFO - IPAM: ctest-ipam-73589581 is not found in API Server
2025-08-15 09:42:17,791 - INFO - IPAM:ctest-ipam-73589581 is not found in control node
2025-08-15 09:42:18,043 - DEBUG - No XMPP flaps were noticed during the test
2025-08-15 09:42:18,043 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:37]
2025-08-15 09:42:18,043 - INFO - --------------------------------------------------------------------------------
2025-08-15 09:42:18,691 - INFO - Deleted project: ctest-TestBasicVMVN-97239836, ID : 879c75e7-881c-4598-a587-17b97815fc5e