2025-04-09 16:59:15,427 - INFO - Domain Default found not creating
2025-04-09 16:59:15,866 - INFO - Project ctest-TestBasicVMVN-98259338 not found, creating it
2025-04-09 16:59:16,534 - INFO - Created Project:ctest-TestBasicVMVN-98259338, ID : 3a68c962-12d2-4606-b077-7ac5e0823c52
2025-04-09 16:59:18,839 - INFO - ================================================================================
2025-04-09 16:59:18,840 - INFO - STARTING TEST : test_generic_link_local_service
2025-04-09 16:59:18,840 - 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-09 16:59:19,185 - DEBUG - Nothing to compare xmpp stats {'10.0.0.254': {'10.20.0.17': '0'}} with
2025-04-09 16:59:19,185 - INFO - Initial checks done. Running the testcase now
2025-04-09 16:59:19,186 - INFO -
2025-04-09 16:59:20,093 - DEBUG - Response for create_network : {'network': {'id': 'db682e26-4f34-4b64-8249-9743e9f2d5a8', 'name': 'ctest-vn2_metadata-23630417', 'tenant_id': '3a68c96212d24606b0777ac5e0823c52', 'project_id': '3a68c96212d24606b0777ac5e0823c52', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-98259338', 'ctest-vn2_metadata-23630417'], 'port_security_enabled': True, 'description': ''}}
2025-04-09 16:59:20,305 - DEBUG - Response for create_subnet : {'subnet': {'id': '19f7f394-21f1-4966-abb2-14667b1cf1cb', 'name': '', 'tenant_id': '3a68c96212d24606b0777ac5e0823c52', 'network_id': 'db682e26-4f34-4b64-8249-9743e9f2d5a8', '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': '3a68c96212d24606b0777ac5e0823c52'}}
2025-04-09 16:59:20,332 - INFO - Created VN ctest-vn2_metadata-23630417
2025-04-09 16:59:20,388 - DEBUG - VN ctest-vn2_metadata-23630417 UUID is db682e26-4f34-4b64-8249-9743e9f2d5a8
2025-04-09 16:59:20,777 - DEBUG - Services list from nova: [, , ]
2025-04-09 16:59:22,380 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3072-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3072-1)
2025-04-09 16:59:22,536 - DEBUG - Link local service introspect added
2025-04-09 16:59:22,629 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-04-09 16:59:27,848 - DEBUG - VM is in ACTIVE state now
2025-04-09 16:59:28,086 - INFO - Waiting for VM ctest-TestBasicVMVN-98259338-82126630 to be up..
2025-04-09 16:59:28,086 - INFO - VM name : ctest-TestBasicVMVN-98259338-82126630
2025-04-09 16:59:28,247 - DEBUG - VM ctest-TestBasicVMVN-98259338-82126630 ID is ab8e87cd-11ab-43b2-aa72-0a3093adade8
2025-04-09 16:59:28,247 - DEBUG - VM ctest-TestBasicVMVN-98259338-82126630 launched on Node cn-jenkins-deploy-platform-ansible-os-3072-1
2025-04-09 16:59:28,371 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine/ab8e87cd-11ab-43b2-aa72-0a3093adade8
2025-04-09 16:59:28,678 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine/ab8e87cd-11ab-43b2-aa72-0a3093adade8
2025-04-09 16:59:28,721 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine-interface/56cc6ace-511a-490c-8d47-6605d0d1b15b
2025-04-09 16:59:32,107 - 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-04-09 16:59:32,107 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-98259338-82126630 failed!
2025-04-09 16:59:32,193 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-98259338:ctest-vn2_metadata-23630417 is 11.1.1.1 and allocation pool is NOT set
2025-04-09 16:59:36,302 - 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=11.3 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1018ms\r\nrtt min/avg/max/mdev = 11.336/11.336/11.336/0.000 ms')
2025-04-09 16:59:36,302 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-98259338-82126630 passed
2025-04-09 16:59:36,469 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 16:59:36,469 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-98259338-82126630, IP 11.1.1.3, Port 22
2025-04-09 16:59:36,662 - DEBUG - VM ctest-TestBasicVMVN-98259338-82126630 is ready for SSH connections
2025-04-09 16:59:36,662 - INFO - Retry 0
2025-04-09 16:59:36,662 - 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.254, gateway password: c0ntrail123
2025-04-09 16:59:36,662 - DEBUG - wget http://169.254.1.2:8083 --spider && echo "Successful"
2025-04-09 16:59:38,653 - DEBUG - Connecting to 169.254.1.2:8083 (169.254.1.2:8083)
Successful
2025-04-09 16:59:38,654 - INFO - Generic metadata worked
2025-04-09 16:59:38,976 - DEBUG - Link local service introspect removed
2025-04-09 16:59:38,976 - INFO - Deleting VM ctest-TestBasicVMVN-98259338-82126630
2025-04-09 16:59:39,150 - INFO - Deleting VN ctest-vn2_metadata-23630417
2025-04-09 16:59:39,238 - DEBUG - VN db682e26-4f34-4b64-8249-9743e9f2d5a8 still in use: Unable to complete operation on network db682e26-4f34-4b64-8249-9743e9f2d5a8. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-0c129acb-0cd7-416c-9446-d79f36384b22']
2025-04-09 16:59:39,238 - WARNING - Deleting VN ctest-vn2_metadata-23630417 failed..Will retry
2025-04-09 16:59:41,495 - DEBUG - Response for deleting network ()
2025-04-09 16:59:41,798 - DEBUG - No XMPP flaps were noticed during the test
2025-04-09 16:59:41,799 - INFO - END TEST : test_generic_link_local_service : PASSED[0:00:23]
2025-04-09 16:59:41,799 - INFO - --------------------------------------------------------------------------------
2025-04-09 16:59:41,808 - INFO - ================================================================================
2025-04-09 16:59:41,808 - INFO - STARTING TEST : test_metadata_service
2025-04-09 16:59:41,809 - 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-09 16:59:42,131 - DEBUG - Nothing to compare xmpp stats {'10.0.0.254': {'10.20.0.17': '0'}} with
2025-04-09 16:59:42,131 - INFO - Initial checks done. Running the testcase now
2025-04-09 16:59:42,131 - INFO -
2025-04-09 16:59:42,131 - DEBUG - Requesting: http://10.0.0.254:8082/global-vrouter-configs
2025-04-09 16:59:42,144 - DEBUG - Requesting: http://10.0.0.254:8082/global-vrouter-config/dc5c3fdf-adfe-4655-bfac-3f59f2c2c91f
2025-04-09 16:59:42,507 - DEBUG - Response for create_network : {'network': {'id': '65f99c99-287e-4cf4-ab6c-430768a5500c', 'name': 'ctest-vn-59106585', 'tenant_id': '3a68c96212d24606b0777ac5e0823c52', 'project_id': '3a68c96212d24606b0777ac5e0823c52', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-98259338', 'ctest-vn-59106585'], 'port_security_enabled': True, 'description': ''}}
2025-04-09 16:59:42,756 - DEBUG - Response for create_subnet : {'subnet': {'id': '8f8c768f-c1be-4f8e-93a5-6faa6649f7f5', 'name': '', 'tenant_id': '3a68c96212d24606b0777ac5e0823c52', 'network_id': '65f99c99-287e-4cf4-ab6c-430768a5500c', 'ip_version': 4, 'cidr': '27.64.252.0/26', 'allocation_pools': [{'start': '27.64.252.2', 'end': '27.64.252.62'}], 'gateway_ip': '27.64.252.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '27.64.252.2', 'tags': [], 'project_id': '3a68c96212d24606b0777ac5e0823c52'}}
2025-04-09 16:59:42,781 - INFO - Created VN ctest-vn-59106585
2025-04-09 16:59:42,840 - DEBUG - VN ctest-vn-59106585 UUID is 65f99c99-287e-4cf4-ab6c-430768a5500c
2025-04-09 16:59:44,590 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3072-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3072-1)
2025-04-09 16:59:44,590 - INFO - Waiting for VM ctest-TestBasicVMVN-98259338-31748423 to be up..
2025-04-09 16:59:44,686 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-04-09 16:59:49,830 - DEBUG - VM is in ACTIVE state now
2025-04-09 16:59:49,830 - INFO - VM name : ctest-TestBasicVMVN-98259338-31748423
2025-04-09 16:59:49,959 - DEBUG - VM ctest-TestBasicVMVN-98259338-31748423 ID is c2976001-7a40-4636-9d43-802ac260aa43
2025-04-09 16:59:49,960 - DEBUG - VM ctest-TestBasicVMVN-98259338-31748423 launched on Node cn-jenkins-deploy-platform-ansible-os-3072-1
2025-04-09 16:59:50,059 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine/c2976001-7a40-4636-9d43-802ac260aa43
2025-04-09 16:59:50,071 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine-interface/b28a99a0-44fe-4cfc-9bb3-83e0056e7597
2025-04-09 16:59:53,356 - 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 1013ms')
2025-04-09 16:59:53,356 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-98259338-31748423 failed!
2025-04-09 16:59:53,445 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-98259338:ctest-vn-59106585 is 27.64.252.1 and allocation pool is NOT set
2025-04-09 16:59:57,551 - 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 1029ms')
2025-04-09 16:59:57,551 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-98259338-31748423 failed!
2025-04-09 16:59:57,637 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-98259338:ctest-vn-59106585 is 27.64.252.1 and allocation pool is NOT set
2025-04-09 16:59:59,727 - 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=11.1 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.36 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.363/6.739/11.116/4.376 ms')
2025-04-09 16:59:59,727 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-98259338-31748423 passed
2025-04-09 16:59:59,921 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 16:59:59,921 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-98259338-31748423, IP 27.64.252.3, Port 22
2025-04-09 17:00:00,133 - DEBUG - VM ctest-TestBasicVMVN-98259338-31748423 is ready for SSH connections
2025-04-09 17:00:00,134 - DEBUG - Running remote_cmd, Cmd : cat /tmp/output.txt, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123
2025-04-09 17:00:00,134 - DEBUG - cat /tmp/output.txt
2025-04-09 17:00:01,990 - DEBUG - Hello World. The time is now Wed, 09 Apr 2025 10:59:58 -0600!
2025-04-09 17:00:01,991 - DEBUG - ret : {'cat /tmp/output.txt': 'Hello World. The time is now Wed, 09 Apr 2025 10:59:58 -0600!'}
2025-04-09 17:00:01,991 - INFO - metadata_script.txt got executed in the vm
2025-04-09 17:00:01,991 - INFO - Deleting VM ctest-TestBasicVMVN-98259338-31748423
2025-04-09 17:00:02,143 - INFO - Deleting VN ctest-vn-59106585
2025-04-09 17:00:02,219 - DEBUG - VN 65f99c99-287e-4cf4-ab6c-430768a5500c still in use: Unable to complete operation on network 65f99c99-287e-4cf4-ab6c-430768a5500c. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-d8d45b62-643e-4870-9d9d-b86c2274183c']
2025-04-09 17:00:02,219 - WARNING - Deleting VN ctest-vn-59106585 failed..Will retry
2025-04-09 17:00:04,458 - DEBUG - Response for deleting network ()
2025-04-09 17:00:04,773 - DEBUG - No XMPP flaps were noticed during the test
2025-04-09 17:00:04,773 - INFO - END TEST : test_metadata_service : PASSED[0:00:23]
2025-04-09 17:00:04,774 - INFO - --------------------------------------------------------------------------------
2025-04-09 17:00:04,782 - INFO - ================================================================================
2025-04-09 17:00:04,783 - INFO - STARTING TEST : test_ping_within_vn_two_vms_two_different_subnets
2025-04-09 17:00:04,783 - 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-09 17:00:05,134 - DEBUG - Nothing to compare xmpp stats {'10.0.0.254': {'10.20.0.17': '0'}} with
2025-04-09 17:00:05,135 - INFO - Initial checks done. Running the testcase now
2025-04-09 17:00:05,135 - INFO -
2025-04-09 17:00:05,821 - DEBUG - Response for create_network : {'network': {'id': '1d16b449-3735-4fb8-bed6-84104dab64ec', 'name': 'ctest-vn-47241184', 'tenant_id': '3a68c96212d24606b0777ac5e0823c52', 'project_id': '3a68c96212d24606b0777ac5e0823c52', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-98259338', 'ctest-vn-47241184'], 'port_security_enabled': True, 'description': ''}}
2025-04-09 17:00:06,036 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ae2f9f9e-8750-44f7-86db-b7ec80f17979', 'name': '', 'tenant_id': '3a68c96212d24606b0777ac5e0823c52', 'network_id': '1d16b449-3735-4fb8-bed6-84104dab64ec', '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': '3a68c96212d24606b0777ac5e0823c52'}}
2025-04-09 17:00:06,252 - DEBUG - Response for create_subnet : {'subnet': {'id': '6f01d9c9-cfb6-410e-8115-d379ced589aa', 'name': '', 'tenant_id': '3a68c96212d24606b0777ac5e0823c52', 'network_id': '1d16b449-3735-4fb8-bed6-84104dab64ec', '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': '3a68c96212d24606b0777ac5e0823c52'}}
2025-04-09 17:00:06,281 - INFO - Created VN ctest-vn-47241184
2025-04-09 17:00:06,336 - DEBUG - VN ctest-vn-47241184 UUID is 1d16b449-3735-4fb8-bed6-84104dab64ec
2025-04-09 17:00:06,992 - DEBUG - Response for create_port : {'port': {'name': '8c54ecee-1d17-41d5-b2fb-b90faf25845c', 'id': '8c54ecee-1d17-41d5-b2fb-b90faf25845c', 'tenant_id': '3a68c96212d24606b0777ac5e0823c52', 'network_id': '1d16b449-3735-4fb8-bed6-84104dab64ec', 'mac_address': '02:8c:54:ec:ee:1d', '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': 'ae2f9f9e-8750-44f7-86db-b7ec80f17979'}], 'security_groups': ['0c642e25-3ec0-4507-9689-e88d3225630a'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '3a68c96212d24606b0777ac5e0823c52'}}
2025-04-09 17:00:07,224 - DEBUG - Response for create_port : {'port': {'name': 'a37dd777-5dd7-4725-976a-377556565b2d', 'id': 'a37dd777-5dd7-4725-976a-377556565b2d', 'tenant_id': '3a68c96212d24606b0777ac5e0823c52', 'network_id': '1d16b449-3735-4fb8-bed6-84104dab64ec', 'mac_address': '02:a3:7d:d7:77:5d', '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': '6f01d9c9-cfb6-410e-8115-d379ced589aa'}], 'security_groups': ['0c642e25-3ec0-4507-9689-e88d3225630a'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '3a68c96212d24606b0777ac5e0823c52'}}
2025-04-09 17:00:07,768 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3072-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3072-1)
2025-04-09 17:00:08,496 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3072-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3072-1)
2025-04-09 17:00:09,881 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3072-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3072-1)
2025-04-09 17:00:09,881 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-04-09 17:00:09,888 - DEBUG - Requesting: http://10.0.0.254:8082/domain/95f60655-3a70-4c88-b7be-750614e898bf
2025-04-09 17:00:09,904 - DEBUG - Requesting: http://10.0.0.254:8082/project/3a68c962-12d2-4606-b077-7ac5e0823c52
2025-04-09 17:00:09,986 - DEBUG - Requesting: http://10.0.0.254:8082/network-ipam/6bb8e095-2925-4ce1-913a-5aacdc00d312
2025-04-09 17:00:09,996 - INFO - Verifications in API Server for IPAM: ctest-ipam-35036311 passed
2025-04-09 17:00:10,005 - DEBUG - Control-node 10.0.0.254 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestBasicVMVN-98259338:ctest-ipam-35036311', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN-98259338', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7762200889018109153', 'uuid-lslong': '10464776382620685074'}, 'enable': 'true', 'created': '2025-04-09T17:00:05', 'last-modified': '2025-04-09T17:00:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:04.540137'}
2025-04-09 17:00:10,005 - INFO - Verifications in Control node for IPAM: ctest-ipam-35036311 passed
2025-04-09 17:00:10,006 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-04-09 17:00:10,017 - DEBUG - Requesting: http://10.0.0.254:8082/domain/95f60655-3a70-4c88-b7be-750614e898bf
2025-04-09 17:00:10,034 - DEBUG - Requesting: http://10.0.0.254:8082/project/3a68c962-12d2-4606-b077-7ac5e0823c52
2025-04-09 17:00:10,131 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/1d16b449-3735-4fb8-bed6-84104dab64ec
2025-04-09 17:00:10,153 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/1d16b449-3735-4fb8-bed6-84104dab64ec
2025-04-09 17:00:10,168 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/cf5a4795-2c95-4b2b-aa15-f0f91a7a7bb7
2025-04-09 17:00:10,184 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/cf5a4795-2c95-4b2b-aa15-f0f91a7a7bb7
2025-04-09 17:00:10,197 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/3bb91ed9-b266-4a76-9a94-7758929d0b13
2025-04-09 17:00:10,209 - DEBUG - Route Targets: ['target:64512:8000005']
2025-04-09 17:00:10,210 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/1d16b449-3735-4fb8-bed6-84104dab64ec
2025-04-09 17:00:10,222 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/cf5a4795-2c95-4b2b-aa15-f0f91a7a7bb7
2025-04-09 17:00:10,243 - INFO - Verified VN network id 8 for VN 1d16b449-3735-4fb8-bed6-84104dab64ec
2025-04-09 17:00:10,243 - INFO - Verifications in API Server for VN ctest-vn-47241184 passed
2025-04-09 17:00:10,243 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/1d16b449-3735-4fb8-bed6-84104dab64ec
2025-04-09 17:00:10,261 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/cf5a4795-2c95-4b2b-aa15-f0f91a7a7bb7
2025-04-09 17:00:10,273 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/cf5a4795-2c95-4b2b-aa15-f0f91a7a7bb7
2025-04-09 17:00:10,285 - DEBUG - Requesting: http://10.0.0.254:8082/route-target/3bb91ed9-b266-4a76-9a94-7758929d0b13
2025-04-09 17:00:10,304 - DEBUG - Control-node 10.0.0.254 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicVMVN-98259338:ctest-vn-47241184', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN-98259338', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2096060903139397560', 'uuid-lslong': '13751323717779809516'}, 'enable': 'true', 'created': '2025-04-09T17:00:05', 'last-modified': '2025-04-09T17:00:06', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:04.095237'}
2025-04-09 17:00:10,312 - DEBUG - Route Targets: ['target:64512:8000005']
2025-04-09 17:00:10,313 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn-47241184 passed
2025-04-09 17:00:10,313 - DEBUG - ====Verifying policy data for ctest-vn-47241184 in API_Server ======
2025-04-09 17:00:10,313 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-04-09 17:00:10,320 - DEBUG - Requesting: http://10.0.0.254:8082/domain/95f60655-3a70-4c88-b7be-750614e898bf
2025-04-09 17:00:10,340 - DEBUG - Requesting: http://10.0.0.254:8082/project/3a68c962-12d2-4606-b077-7ac5e0823c52
2025-04-09 17:00:10,421 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-network/1d16b449-3735-4fb8-bed6-84104dab64ec
2025-04-09 17:00:10,451 - DEBUG - =>VN ctest-vn-47241184 has no policy to be verified
2025-04-09 17:00:10,451 - DEBUG - Verifying the vn in opserver
2025-04-09 17:00:10,451 - DEBUG - Verifying the default-domain:ctest-TestBasicVMVN-98259338:ctest-vn-47241184 virtual network link through opserver 10.0.0.254
2025-04-09 17:00:10,451 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-04-09 17:00:10,923 - DEBUG - Requesting: http://10.0.0.254:8081/analytics/uves/virtual-networks
2025-04-09 17:00:11,066 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicVMVN-98259338:ctest-vn-47241184', 'href': 'http://10.0.0.254:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicVMVN-98259338:ctest-vn-47241184?flat'}
2025-04-09 17:00:11,066 - INFO - Validated that VN default-domain:ctest-TestBasicVMVN-98259338:ctest-vn-47241184 is found in opserver
2025-04-09 17:00:11,074 - DEBUG - VRF ids for VN ctest-vn-47241184: {'10.0.0.254': '2'}
2025-04-09 17:00:11,074 - INFO - Waiting for VM ctest-TestBasicVMVN-98259338-62176590 to be up..
2025-04-09 17:00:11,217 - DEBUG - VM is in ACTIVE state now
2025-04-09 17:00:11,217 - INFO - VM name : ctest-TestBasicVMVN-98259338-62176590
2025-04-09 17:00:11,333 - DEBUG - VM ctest-TestBasicVMVN-98259338-62176590 ID is 6b698bf9-6029-438b-93b2-bc4a82154479
2025-04-09 17:00:11,333 - DEBUG - VM ctest-TestBasicVMVN-98259338-62176590 launched on Node cn-jenkins-deploy-platform-ansible-os-3072-1
2025-04-09 17:00:11,433 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine/6b698bf9-6029-438b-93b2-bc4a82154479
2025-04-09 17:00:11,448 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine-interface/8c54ecee-1d17-41d5-b2fb-b90faf25845c
2025-04-09 17:00:14,729 - 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 1006ms')
2025-04-09 17:00:14,729 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-98259338-62176590 failed!
2025-04-09 17:00:14,810 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-98259338:ctest-vn-47241184 is 31.1.1.1 and allocation pool is NOT set
2025-04-09 17:00:14,810 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-98259338:ctest-vn-47241184 is 31.1.2.1 and allocation pool is NOT set
2025-04-09 17:00:18,893 - 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 1006ms')
2025-04-09 17:00:18,894 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-98259338-62176590 failed!
2025-04-09 17:00:18,957 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-98259338:ctest-vn-47241184 is 31.1.1.1 and allocation pool is NOT set
2025-04-09 17:00:18,958 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-98259338:ctest-vn-47241184 is 31.1.2.1 and allocation pool is NOT set
2025-04-09 17:00:21,033 - 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=14.6 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=3.00 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.996/8.778/14.561/5.782 ms')
2025-04-09 17:00:21,034 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-98259338-62176590 passed
2025-04-09 17:00:21,208 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 17:00:21,208 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-98259338-62176590, IP 31.1.1.4, Port 22
2025-04-09 17:00:21,277 - 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-04-09 17:00:21,428 - DEBUG - VM ctest-TestBasicVMVN-98259338-62176590 is NOT ready for SSH connections, VM status: ACTIVE
2025-04-09 17:00:26,429 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 17:00:26,429 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-98259338-62176590, IP 31.1.1.4, Port 22
2025-04-09 17:00:26,621 - DEBUG - VM ctest-TestBasicVMVN-98259338-62176590 is ready for SSH connections
2025-04-09 17:00:26,621 - INFO - Waiting for VM ctest-TestBasicVMVN-98259338-60038443 to be up..
2025-04-09 17:00:26,785 - DEBUG - VM is in ACTIVE state now
2025-04-09 17:00:26,785 - INFO - VM name : ctest-TestBasicVMVN-98259338-60038443
2025-04-09 17:00:26,955 - DEBUG - VM ctest-TestBasicVMVN-98259338-60038443 ID is 59cef0c5-60fa-4ab6-83bf-dd99a62b7f6d
2025-04-09 17:00:26,956 - DEBUG - VM ctest-TestBasicVMVN-98259338-60038443 launched on Node cn-jenkins-deploy-platform-ansible-os-3072-1
2025-04-09 17:00:27,083 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine/59cef0c5-60fa-4ab6-83bf-dd99a62b7f6d
2025-04-09 17:00:27,102 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine-interface/a37dd777-5dd7-4725-976a-377556565b2d
2025-04-09 17:00:28,390 - 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=8.59 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.661 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.661/4.626/8.591/3.965 ms')
2025-04-09 17:00:28,391 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBasicVMVN-98259338-60038443 passed
2025-04-09 17:00:28,578 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 17:00:28,578 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-98259338-60038443, IP 31.1.2.4, Port 22
2025-04-09 17:00:28,791 - DEBUG - VM ctest-TestBasicVMVN-98259338-60038443 is ready for SSH connections
2025-04-09 17:00:28,791 - INFO - Waiting for VM ctest-TestBasicVMVN-98259338-21802760 to be up..
2025-04-09 17:00:29,011 - DEBUG - VM is in ACTIVE state now
2025-04-09 17:00:29,011 - INFO - VM name : ctest-TestBasicVMVN-98259338-21802760
2025-04-09 17:00:29,178 - DEBUG - VM ctest-TestBasicVMVN-98259338-21802760 ID is bd3be6b1-2a18-4d9f-932d-d32af5f40750
2025-04-09 17:00:29,179 - DEBUG - VM ctest-TestBasicVMVN-98259338-21802760 launched on Node cn-jenkins-deploy-platform-ansible-os-3072-1
2025-04-09 17:00:29,371 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine/bd3be6b1-2a18-4d9f-932d-d32af5f40750
2025-04-09 17:00:29,389 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine-interface/f75e14fd-6dce-42c5-b176-f15a67cfaee9
2025-04-09 17:00:30,700 - 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=6.44 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.940 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.940/3.688/6.437/2.748 ms')
2025-04-09 17:00:30,700 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-98259338-21802760 passed
2025-04-09 17:00:30,877 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 17:00:30,877 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-98259338-21802760, IP 31.1.1.3, Port 22
2025-04-09 17:00:31,071 - DEBUG - VM ctest-TestBasicVMVN-98259338-21802760 is ready for SSH connections
2025-04-09 17:00:31,071 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 17:00:31,072 - 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.254, gateway password: c0ntrail123
2025-04-09 17:00:31,072 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4
2025-04-09 17:00:35,564 - 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=5.468 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.031 ms
64 bytes from 31.1.2.4: seq=2 ttl=63 time=1.207 ms
--- 31.1.2.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.207/2.902/5.468 ms
2025-04-09 17:00:35,565 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-98259338-62176590 passed
2025-04-09 17:00:35,565 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 17:00:35,565 - 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.254, gateway password: c0ntrail123
2025-04-09 17:00:35,565 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4
2025-04-09 17:00:39,606 - 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=4.270 ms
64 bytes from 31.1.1.4: seq=1 ttl=63 time=2.210 ms
64 bytes from 31.1.1.4: seq=2 ttl=63 time=1.993 ms
--- 31.1.1.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.993/2.824/4.270 ms
2025-04-09 17:00:39,606 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-98259338-60038443 passed
2025-04-09 17:00:39,606 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 17:00:39,607 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 17:00:39,607 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 17:00:39,607 - 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.254, gateway password: c0ntrail123
2025-04-09 17:00:39,607 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-09 17:00:39,932 - DEBUG - None
2025-04-09 17:00:39,933 - 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.254, gateway password: c0ntrail123
2025-04-09 17:00:39,933 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-09 17:00:40,187 - DEBUG - None
2025-04-09 17:00:40,187 - 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.254, gateway password: c0ntrail123
2025-04-09 17:00:40,188 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-09 17:00:41,108 - DEBUG - None
2025-04-09 17:00:41,108 - 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.254, gateway password: c0ntrail123
2025-04-09 17:00:41,109 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7
2025-04-09 17:00:43,399 - 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.771 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=6.836 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=1.274 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=3.503 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=1.122 ms
--- 31.1.1.7 ping statistics ---
3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss
round-trip min/avg/max = 1.122/2.901/6.836 ms
2025-04-09 17:00:43,400 - 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.254, gateway password: c0ntrail123
2025-04-09 17:00:43,400 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1
2025-04-09 17:00:45,729 - 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=1.154 ms
64 bytes from 31.1.2.4: seq=0 ttl=63 time=4.980 ms (DUP!)
64 bytes from 31.1.1.3: seq=0 ttl=64 time=10.844 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.601 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.818 ms (DUP!)
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.142 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=1.584 ms
--- 224.0.0.1 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.601/3.303/10.844 ms
2025-04-09 17:00:45,729 - 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.254, gateway password: c0ntrail123
2025-04-09 17:00:45,729 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255
2025-04-09 17:00:48,040 - 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.679 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.507 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=5.953 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.606 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.627 ms (DUP!)
64 bytes from 31.1.2.4: seq=1 ttl=63 time=3.886 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.584 ms
--- 255.255.255.255 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.584/2.406/5.953 ms
2025-04-09 17:00:48,040 - INFO - Deleting VM ctest-TestBasicVMVN-98259338-21802760
2025-04-09 17:00:48,132 - INFO - Detaching port a37dd777-5dd7-4725-976a-377556565b2d from VM ctest-TestBasicVMVN-98259338-60038443
2025-04-09 17:00:48,196 - INFO - Deleting VM ctest-TestBasicVMVN-98259338-60038443
2025-04-09 17:00:48,278 - INFO - Detaching port 8c54ecee-1d17-41d5-b2fb-b90faf25845c from VM ctest-TestBasicVMVN-98259338-62176590
2025-04-09 17:00:48,327 - INFO - Deleting VM ctest-TestBasicVMVN-98259338-62176590
2025-04-09 17:00:48,411 - INFO - Deleting VN ctest-vn-47241184
2025-04-09 17:00:48,646 - DEBUG - Response for delete_port : ()
2025-04-09 17:00:48,899 - DEBUG - Response for delete_port : ()
2025-04-09 17:00:48,945 - DEBUG - VN 1d16b449-3735-4fb8-bed6-84104dab64ec still in use: Unable to complete operation on network 1d16b449-3735-4fb8-bed6-84104dab64ec. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-eb40be7a-1486-4f12-85d7-542f26cfe06f']
2025-04-09 17:00:48,945 - WARNING - Deleting VN ctest-vn-47241184 failed..Will retry
2025-04-09 17:00:51,109 - DEBUG - Response for deleting network ()
2025-04-09 17:00:51,109 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/cf5a4795-2c95-4b2b-aa15-f0f91a7a7bb7
2025-04-09 17:00:51,117 - DEBUG - Response Code: 404
2025-04-09 17:00:51,117 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-04-09 17:00:51,124 - DEBUG - Requesting: http://10.0.0.254:8082/domain/95f60655-3a70-4c88-b7be-750614e898bf
2025-04-09 17:00:51,183 - DEBUG - Requesting: http://10.0.0.254:8082/project/3a68c962-12d2-4606-b077-7ac5e0823c52
2025-04-09 17:00:51,278 - INFO - Validated that VN ctest-vn-47241184 is not found in API Server
2025-04-09 17:00:51,293 - DEBUG - VN ctest-vn-47241184 is not present in Agent 10.0.0.254
2025-04-09 17:00:51,293 - INFO - Validated that VN ctest-vn-47241184 is not in any agent
2025-04-09 17:00:51,300 - DEBUG - VRF 2 is not seen in agent 10.0.0.254
2025-04-09 17:00:51,308 - DEBUG - Vrouter 10.0.0.254 does not have vrf 2 for VN ctest-vn-47241184
2025-04-09 17:00:51,309 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-98259338:ctest-vn-47241184
2025-04-09 17:00:51,325 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-47241184 info
2025-04-09 17:00:51,412 - INFO - IPAM: ctest-ipam-35036311 is not found in API Server
2025-04-09 17:00:51,426 - INFO - IPAM:ctest-ipam-35036311 is not found in control node
2025-04-09 17:00:51,689 - DEBUG - No XMPP flaps were noticed during the test
2025-04-09 17:00:51,689 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:47]
2025-04-09 17:00:51,689 - INFO - --------------------------------------------------------------------------------
2025-04-09 17:00:52,414 - INFO - Deleted project: ctest-TestBasicVMVN-98259338, ID : 3a68c962-12d2-4606-b077-7ac5e0823c52