2025-02-06 13:00:39,549 - INFO - Domain Default found not creating 2025-02-06 13:00:39,698 - INFO - Project ctest-TestBasicVMVN-31101588 not found, creating it 2025-02-06 13:00:40,160 - INFO - Created Project:ctest-TestBasicVMVN-31101588, ID : 7d56d9eb-cbf3-43fe-95f1-da5218206eb8 2025-02-06 13:00:41,704 - INFO - ================================================================================ 2025-02-06 13:00:41,704 - INFO - STARTING TEST : test_generic_link_local_service 2025-02-06 13:00:41,704 - 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-02-06 13:00:41,960 - DEBUG - Nothing to compare xmpp stats {'10.0.0.24': {'10.20.0.17': '0'}} with 2025-02-06 13:00:41,960 - INFO - Initial checks done. Running the testcase now 2025-02-06 13:00:41,960 - INFO - 2025-02-06 13:00:42,542 - DEBUG - Response for create_network : {'network': {'id': 'd6a9bd69-828d-49f1-b6d0-60741f0f8f43', 'name': 'ctest-vn2_metadata-33613714', 'tenant_id': '7d56d9ebcbf343fe95f1da5218206eb8', 'project_id': '7d56d9ebcbf343fe95f1da5218206eb8', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-31101588', 'ctest-vn2_metadata-33613714'], 'port_security_enabled': True, 'description': ''}} 2025-02-06 13:00:42,747 - DEBUG - Response for create_subnet : {'subnet': {'id': '7899744f-66b9-4fbd-80b2-ac1bfaeb9811', 'name': '', 'tenant_id': '7d56d9ebcbf343fe95f1da5218206eb8', 'network_id': 'd6a9bd69-828d-49f1-b6d0-60741f0f8f43', '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': '7d56d9ebcbf343fe95f1da5218206eb8'}} 2025-02-06 13:00:42,766 - INFO - Created VN ctest-vn2_metadata-33613714 2025-02-06 13:00:42,822 - DEBUG - VN ctest-vn2_metadata-33613714 UUID is d6a9bd69-828d-49f1-b6d0-60741f0f8f43 2025-02-06 13:00:43,011 - DEBUG - Services list from nova: [, , ] 2025-02-06 13:00:44,097 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-2701-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-2701-1) 2025-02-06 13:00:44,205 - DEBUG - Link local service introspect added 2025-02-06 13:00:44,245 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-02-06 13:00:49,325 - DEBUG - VM is in ACTIVE state now 2025-02-06 13:00:49,452 - INFO - Waiting for VM ctest-TestBasicVMVN-31101588-24508615 to be up.. 2025-02-06 13:00:49,453 - INFO - VM name : ctest-TestBasicVMVN-31101588-24508615 2025-02-06 13:00:49,529 - DEBUG - VM ctest-TestBasicVMVN-31101588-24508615 ID is f5fb60b0-0ccd-4518-8b1f-484d5ac6cb2e 2025-02-06 13:00:49,529 - DEBUG - VM ctest-TestBasicVMVN-31101588-24508615 launched on Node cn-jenkins-deploy-platform-ansible-os-2701-1 2025-02-06 13:00:49,605 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-machine/f5fb60b0-0ccd-4518-8b1f-484d5ac6cb2e 2025-02-06 13:00:49,940 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-machine/f5fb60b0-0ccd-4518-8b1f-484d5ac6cb2e 2025-02-06 13:00:49,971 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-machine-interface/337ffc54-7589-4fb7-b91b-070ecf38cf9b 2025-02-06 13:00:53,217 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1007ms') 2025-02-06 13:00:53,217 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-31101588-24508615 failed! 2025-02-06 13:00:53,274 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-31101588:ctest-vn2_metadata-33613714 is 11.1.1.1 and allocation pool is NOT set 2025-02-06 13:00:55,336 - 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=9.75 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.47 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 = 1.470/5.612/9.754/4.142 ms') 2025-02-06 13:00:55,336 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-31101588-24508615 passed 2025-02-06 13:00:55,486 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-02-06 13:00:55,486 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-31101588-24508615, IP 11.1.1.3, Port 22 2025-02-06 13:00:55,652 - DEBUG - VM ctest-TestBasicVMVN-31101588-24508615 is ready for SSH connections 2025-02-06 13:00:55,652 - INFO - Retry 0 2025-02-06 13:00:55,652 - 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.24, gateway password: c0ntrail123 2025-02-06 13:00:55,652 - DEBUG - wget http://169.254.1.2:8083 --spider && echo "Successful" 2025-02-06 13:00:57,303 - DEBUG - Connecting to 169.254.1.2:8083 (169.254.1.2:8083) Successful 2025-02-06 13:00:57,304 - INFO - Generic metadata worked 2025-02-06 13:00:57,553 - DEBUG - Link local service introspect removed 2025-02-06 13:00:57,554 - INFO - Deleting VM ctest-TestBasicVMVN-31101588-24508615 2025-02-06 13:00:57,620 - INFO - Deleting VN ctest-vn2_metadata-33613714 2025-02-06 13:00:57,662 - DEBUG - VN d6a9bd69-828d-49f1-b6d0-60741f0f8f43 still in use: Unable to complete operation on network d6a9bd69-828d-49f1-b6d0-60741f0f8f43. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-2f30b771-ba95-41a7-8577-0641a6d4684d'] 2025-02-06 13:00:57,663 - WARNING - Deleting VN ctest-vn2_metadata-33613714 failed..Will retry 2025-02-06 13:00:59,818 - DEBUG - Response for deleting network () 2025-02-06 13:01:00,075 - DEBUG - No XMPP flaps were noticed during the test 2025-02-06 13:01:00,075 - INFO - -------------------------------------------------------------------------------- 2025-02-06 13:01:00,078 - INFO - ================================================================================ 2025-02-06 13:01:00,078 - INFO - STARTING TEST : test_metadata_service 2025-02-06 13:01:00,078 - 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-02-06 13:01:00,364 - DEBUG - Nothing to compare xmpp stats {'10.0.0.24': {'10.20.0.17': '0'}} with 2025-02-06 13:01:00,364 - INFO - Initial checks done. Running the testcase now 2025-02-06 13:01:00,364 - INFO - 2025-02-06 13:01:00,364 - DEBUG - Requesting: http://10.0.0.24:8082/global-vrouter-configs 2025-02-06 13:01:00,370 - DEBUG - Requesting: http://10.0.0.24:8082/global-vrouter-config/954a19e5-98e2-429c-85fa-fad188f0c188 2025-02-06 13:01:00,567 - DEBUG - Response for create_network : {'network': {'id': '0e643632-5fc0-4ec4-a8d0-fcf401fd48bf', 'name': 'ctest-vn-28057825', 'tenant_id': '7d56d9ebcbf343fe95f1da5218206eb8', 'project_id': '7d56d9ebcbf343fe95f1da5218206eb8', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-31101588', 'ctest-vn-28057825'], 'port_security_enabled': True, 'description': ''}} 2025-02-06 13:01:00,796 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f72ebf2b-6598-4a92-9cd5-07d93447bb93', 'name': '', 'tenant_id': '7d56d9ebcbf343fe95f1da5218206eb8', 'network_id': '0e643632-5fc0-4ec4-a8d0-fcf401fd48bf', 'ip_version': 4, 'cidr': '106.236.170.192/26', 'allocation_pools': [{'start': '106.236.170.194', 'end': '106.236.170.254'}], 'gateway_ip': '106.236.170.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '106.236.170.194', 'tags': [], 'project_id': '7d56d9ebcbf343fe95f1da5218206eb8'}} 2025-02-06 13:01:00,815 - INFO - Created VN ctest-vn-28057825 2025-02-06 13:01:00,870 - DEBUG - VN ctest-vn-28057825 UUID is 0e643632-5fc0-4ec4-a8d0-fcf401fd48bf 2025-02-06 13:01:02,194 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-2701-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-2701-1) 2025-02-06 13:01:02,194 - INFO - Waiting for VM ctest-TestBasicVMVN-31101588-32897597 to be up.. 2025-02-06 13:01:02,238 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-02-06 13:01:07,323 - DEBUG - VM is in ACTIVE state now 2025-02-06 13:01:07,323 - INFO - VM name : ctest-TestBasicVMVN-31101588-32897597 2025-02-06 13:01:07,406 - DEBUG - VM ctest-TestBasicVMVN-31101588-32897597 ID is 88b14556-59ef-45e5-bdf1-52dcc3afb6f6 2025-02-06 13:01:07,406 - DEBUG - VM ctest-TestBasicVMVN-31101588-32897597 launched on Node cn-jenkins-deploy-platform-ansible-os-2701-1 2025-02-06 13:01:07,483 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-machine/88b14556-59ef-45e5-bdf1-52dcc3afb6f6 2025-02-06 13:01:07,494 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-machine-interface/34add221-6cb4-415b-9e1f-25e8384e1b04 2025-02-06 13:01:10,749 - 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 1011ms') 2025-02-06 13:01:10,749 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-31101588-32897597 failed! 2025-02-06 13:01:10,806 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-31101588:ctest-vn-28057825 is 106.236.170.193 and allocation pool is NOT set 2025-02-06 13:01:14,873 - 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=9.08 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1010ms\r\nrtt min/avg/max/mdev = 9.077/9.077/9.077/0.000 ms') 2025-02-06 13:01:14,873 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-31101588-32897597 passed 2025-02-06 13:01:15,026 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-02-06 13:01:15,026 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-31101588-32897597, IP 106.236.170.195, Port 22 2025-02-06 13:01:15,091 - 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-02-06 13:01:15,173 - DEBUG - VM ctest-TestBasicVMVN-31101588-32897597 is NOT ready for SSH connections, VM status: ACTIVE 2025-02-06 13:01:20,174 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-02-06 13:01:20,174 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-31101588-32897597, IP 106.236.170.195, Port 22 2025-02-06 13:01:20,330 - DEBUG - VM ctest-TestBasicVMVN-31101588-32897597 is ready for SSH connections 2025-02-06 13:01:20,330 - DEBUG - Running remote_cmd, Cmd : cat /tmp/output.txt, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.24, gateway password: c0ntrail123 2025-02-06 13:01:20,330 - DEBUG - cat /tmp/output.txt 2025-02-06 13:01:22,007 - DEBUG - Hello World. The time is now Thu, 06 Feb 2025 06:01:15 -0700! 2025-02-06 13:01:22,007 - DEBUG - ret : {'cat /tmp/output.txt': 'Hello World. The time is now Thu, 06 Feb 2025 06:01:15 -0700!'} 2025-02-06 13:01:22,007 - INFO - metadata_script.txt got executed in the vm 2025-02-06 13:01:22,007 - INFO - Deleting VM ctest-TestBasicVMVN-31101588-32897597 2025-02-06 13:01:22,080 - INFO - Deleting VN ctest-vn-28057825 2025-02-06 13:01:22,124 - DEBUG - VN 0e643632-5fc0-4ec4-a8d0-fcf401fd48bf still in use: Unable to complete operation on network 0e643632-5fc0-4ec4-a8d0-fcf401fd48bf. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-bb51c7c4-754d-457f-b793-98df99183129'] 2025-02-06 13:01:22,124 - WARNING - Deleting VN ctest-vn-28057825 failed..Will retry 2025-02-06 13:01:24,236 - DEBUG - Response for deleting network () 2025-02-06 13:01:24,493 - DEBUG - No XMPP flaps were noticed during the test
2025-02-06 13:01:24,493 - INFO - END TEST : test_metadata_service : PASSED[0:00:24]
2025-02-06 13:01:24,493 - INFO - -------------------------------------------------------------------------------- 2025-02-06 13:01:24,498 - INFO - ================================================================================ 2025-02-06 13:01:24,498 - INFO - STARTING TEST : test_ping_within_vn_two_vms_two_different_subnets 2025-02-06 13:01:24,498 - 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-02-06 13:01:24,782 - DEBUG - Nothing to compare xmpp stats {'10.0.0.24': {'10.20.0.17': '0'}} with 2025-02-06 13:01:24,782 - INFO - Initial checks done. Running the testcase now 2025-02-06 13:01:24,782 - INFO - 2025-02-06 13:01:25,293 - DEBUG - Response for create_network : {'network': {'id': '5118136b-1ecb-4e7a-b52c-a04895d93edd', 'name': 'ctest-vn-02541385', 'tenant_id': '7d56d9ebcbf343fe95f1da5218206eb8', 'project_id': '7d56d9ebcbf343fe95f1da5218206eb8', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-31101588', 'ctest-vn-02541385'], 'port_security_enabled': True, 'description': ''}} 2025-02-06 13:01:25,505 - DEBUG - Response for create_subnet : {'subnet': {'id': '5e5fee58-f1ae-4ab0-90ef-66594950a1ef', 'name': '', 'tenant_id': '7d56d9ebcbf343fe95f1da5218206eb8', 'network_id': '5118136b-1ecb-4e7a-b52c-a04895d93edd', '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': '7d56d9ebcbf343fe95f1da5218206eb8'}} 2025-02-06 13:01:25,654 - DEBUG - Response for create_subnet : {'subnet': {'id': '73abbdd0-2bd7-4821-a728-0ef974763dd2', 'name': '', 'tenant_id': '7d56d9ebcbf343fe95f1da5218206eb8', 'network_id': '5118136b-1ecb-4e7a-b52c-a04895d93edd', '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': '7d56d9ebcbf343fe95f1da5218206eb8'}} 2025-02-06 13:01:25,676 - INFO - Created VN ctest-vn-02541385 2025-02-06 13:01:25,730 - DEBUG - VN ctest-vn-02541385 UUID is 5118136b-1ecb-4e7a-b52c-a04895d93edd 2025-02-06 13:01:26,091 - DEBUG - Response for create_port : {'port': {'name': '64ad8a36-44a9-464d-a7b7-f3c587e8b536', 'id': '64ad8a36-44a9-464d-a7b7-f3c587e8b536', 'tenant_id': '7d56d9ebcbf343fe95f1da5218206eb8', 'network_id': '5118136b-1ecb-4e7a-b52c-a04895d93edd', 'mac_address': '02:64:ad:8a:36:44', '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': '5e5fee58-f1ae-4ab0-90ef-66594950a1ef'}], 'security_groups': ['d30561af-97a6-49c1-9319-27dc2bfa0f50'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '7d56d9ebcbf343fe95f1da5218206eb8'}} 2025-02-06 13:01:26,270 - DEBUG - Response for create_port : {'port': {'name': '43323672-938d-4cb8-8764-64c1e1155deb', 'id': '43323672-938d-4cb8-8764-64c1e1155deb', 'tenant_id': '7d56d9ebcbf343fe95f1da5218206eb8', 'network_id': '5118136b-1ecb-4e7a-b52c-a04895d93edd', 'mac_address': '02:43:32:36:72:93', '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': '73abbdd0-2bd7-4821-a728-0ef974763dd2'}], 'security_groups': ['d30561af-97a6-49c1-9319-27dc2bfa0f50'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '7d56d9ebcbf343fe95f1da5218206eb8'}} 2025-02-06 13:01:26,630 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-2701-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-2701-1) 2025-02-06 13:01:27,052 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-2701-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-2701-1) 2025-02-06 13:01:28,294 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-2701-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-2701-1) 2025-02-06 13:01:28,294 - DEBUG - Requesting: http://10.0.0.24:8082/domains 2025-02-06 13:01:28,302 - DEBUG - Requesting: http://10.0.0.24:8082/domain/f6d1ccab-fbc6-46b5-9c91-98ccf0568927 2025-02-06 13:01:28,322 - DEBUG - Requesting: http://10.0.0.24:8082/project/7d56d9eb-cbf3-43fe-95f1-da5218206eb8 2025-02-06 13:01:28,411 - DEBUG - Requesting: http://10.0.0.24:8082/network-ipam/4fda4bbf-b22f-4dbb-8ce7-7f78128216df 2025-02-06 13:01:28,422 - INFO - Verifications in API Server for IPAM: ctest-ipam-20670060 passed 2025-02-06 13:01:28,430 - DEBUG - Control-node 10.0.0.24 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestBasicVMVN-31101588:ctest-ipam-20670060', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN-31101588', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5753994760619511227', 'uuid-lslong': '10153224038613391071'}, 'enable': 'true', 'created': '2025-02-06T13:01:24', 'last-modified': '2025-02-06T13:01:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.410753'} 2025-02-06 13:01:28,430 - INFO - Verifications in Control node for IPAM: ctest-ipam-20670060 passed 2025-02-06 13:01:28,431 - DEBUG - Requesting: http://10.0.0.24:8082/domains 2025-02-06 13:01:28,437 - DEBUG - Requesting: http://10.0.0.24:8082/domain/f6d1ccab-fbc6-46b5-9c91-98ccf0568927 2025-02-06 13:01:28,453 - DEBUG - Requesting: http://10.0.0.24:8082/project/7d56d9eb-cbf3-43fe-95f1-da5218206eb8 2025-02-06 13:01:28,541 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-network/5118136b-1ecb-4e7a-b52c-a04895d93edd 2025-02-06 13:01:28,565 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-network/5118136b-1ecb-4e7a-b52c-a04895d93edd 2025-02-06 13:01:28,578 - DEBUG - Requesting: http://10.0.0.24:8082/routing-instance/e3bbc79d-a7cc-4f50-869a-5c0e5248c283 2025-02-06 13:01:28,588 - DEBUG - Requesting: http://10.0.0.24:8082/routing-instance/e3bbc79d-a7cc-4f50-869a-5c0e5248c283 2025-02-06 13:01:28,597 - DEBUG - Requesting: http://10.0.0.24:8082/route-target/65d9fa08-6fa1-4193-af8c-9477fb335fb7 2025-02-06 13:01:28,605 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-02-06 13:01:28,605 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-network/5118136b-1ecb-4e7a-b52c-a04895d93edd 2025-02-06 13:01:28,618 - DEBUG - Requesting: http://10.0.0.24:8082/routing-instance/e3bbc79d-a7cc-4f50-869a-5c0e5248c283 2025-02-06 13:01:28,639 - INFO - Verified VN network id 8 for VN 5118136b-1ecb-4e7a-b52c-a04895d93edd 2025-02-06 13:01:28,639 - INFO - Verifications in API Server for VN ctest-vn-02541385 passed 2025-02-06 13:01:28,639 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-network/5118136b-1ecb-4e7a-b52c-a04895d93edd 2025-02-06 13:01:28,654 - DEBUG - Requesting: http://10.0.0.24:8082/routing-instance/e3bbc79d-a7cc-4f50-869a-5c0e5248c283 2025-02-06 13:01:28,663 - DEBUG - Requesting: http://10.0.0.24:8082/routing-instance/e3bbc79d-a7cc-4f50-869a-5c0e5248c283 2025-02-06 13:01:28,672 - DEBUG - Requesting: http://10.0.0.24:8082/route-target/65d9fa08-6fa1-4193-af8c-9477fb335fb7 2025-02-06 13:01:28,691 - DEBUG - Control-node 10.0.0.24 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicVMVN-31101588:ctest-vn-02541385', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN-31101588', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5843441867312287354', 'uuid-lslong': '13054985653452357341'}, 'enable': 'true', 'created': '2025-02-06T13:01:25', 'last-modified': '2025-02-06T13:01:25', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.062295'} 2025-02-06 13:01:28,708 - DEBUG - Route Targets: ['target:64512:8000004'] 2025-02-06 13:01:28,708 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn-02541385 passed 2025-02-06 13:01:28,708 - DEBUG - ====Verifying policy data for ctest-vn-02541385 in API_Server ====== 2025-02-06 13:01:28,708 - DEBUG - Requesting: http://10.0.0.24:8082/domains 2025-02-06 13:01:28,723 - DEBUG - Requesting: http://10.0.0.24:8082/domain/f6d1ccab-fbc6-46b5-9c91-98ccf0568927 2025-02-06 13:01:28,742 - DEBUG - Requesting: http://10.0.0.24:8082/project/7d56d9eb-cbf3-43fe-95f1-da5218206eb8 2025-02-06 13:01:28,868 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-network/5118136b-1ecb-4e7a-b52c-a04895d93edd 2025-02-06 13:01:28,907 - DEBUG - =>VN ctest-vn-02541385 has no policy to be verified 2025-02-06 13:01:28,907 - DEBUG - Verifying the vn in opserver 2025-02-06 13:01:28,907 - DEBUG - Verifying the default-domain:ctest-TestBasicVMVN-31101588:ctest-vn-02541385 virtual network link through opserver 10.0.0.24 2025-02-06 13:01:28,907 - DEBUG - Requesting: http://10.0.0.24:8081/analytics/uves/virtual-networks 2025-02-06 13:01:29,261 - DEBUG - Requesting: http://10.0.0.24:8081/analytics/uves/virtual-networks 2025-02-06 13:01:29,320 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicVMVN-31101588:ctest-vn-02541385', 'href': 'http://10.0.0.24:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicVMVN-31101588:ctest-vn-02541385?flat'} 2025-02-06 13:01:29,320 - INFO - Validated that VN default-domain:ctest-TestBasicVMVN-31101588:ctest-vn-02541385 is found in opserver 2025-02-06 13:01:29,327 - DEBUG - VRF ids for VN ctest-vn-02541385: {'10.0.0.24': '2'} 2025-02-06 13:01:29,327 - INFO - Waiting for VM ctest-TestBasicVMVN-31101588-44226242 to be up.. 2025-02-06 13:01:29,424 - DEBUG - VM is in ACTIVE state now 2025-02-06 13:01:29,424 - INFO - VM name : ctest-TestBasicVMVN-31101588-44226242 2025-02-06 13:01:29,508 - DEBUG - VM ctest-TestBasicVMVN-31101588-44226242 ID is 3bc31731-f825-4a38-8a2c-e74a65f552dd 2025-02-06 13:01:29,508 - DEBUG - VM ctest-TestBasicVMVN-31101588-44226242 launched on Node cn-jenkins-deploy-platform-ansible-os-2701-1 2025-02-06 13:01:29,598 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-machine/3bc31731-f825-4a38-8a2c-e74a65f552dd 2025-02-06 13:01:29,609 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-machine-interface/64ad8a36-44a9-464d-a7b7-f3c587e8b536 2025-02-06 13:01:32,895 - 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-02-06 13:01:32,895 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-31101588-44226242 failed! 2025-02-06 13:01:32,954 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-31101588:ctest-vn-02541385 is 31.1.1.1 and allocation pool is NOT set 2025-02-06 13:01:32,954 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-31101588:ctest-vn-02541385 is 31.1.2.1 and allocation pool is NOT set 2025-02-06 13:01:37,019 - 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 1010ms') 2025-02-06 13:01:37,019 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-31101588-44226242 failed! 2025-02-06 13:01:37,074 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-31101588:ctest-vn-02541385 is 31.1.1.1 and allocation pool is NOT set 2025-02-06 13:01:37,074 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-31101588:ctest-vn-02541385 is 31.1.2.1 and allocation pool is NOT set 2025-02-06 13:01:39,132 - 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=7.39 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.720 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.720/4.056/7.392/3.336 ms') 2025-02-06 13:01:39,132 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-31101588-44226242 passed 2025-02-06 13:01:39,282 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-02-06 13:01:39,282 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-31101588-44226242, IP 31.1.1.4, Port 22 2025-02-06 13:01:39,348 - 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-02-06 13:01:39,436 - DEBUG - VM ctest-TestBasicVMVN-31101588-44226242 is NOT ready for SSH connections, VM status: ACTIVE 2025-02-06 13:01:44,436 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-02-06 13:01:44,436 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-31101588-44226242, IP 31.1.1.4, Port 22 2025-02-06 13:01:44,597 - DEBUG - VM ctest-TestBasicVMVN-31101588-44226242 is ready for SSH connections 2025-02-06 13:01:44,597 - INFO - Waiting for VM ctest-TestBasicVMVN-31101588-16105964 to be up.. 2025-02-06 13:01:44,675 - DEBUG - VM is in ACTIVE state now 2025-02-06 13:01:44,675 - INFO - VM name : ctest-TestBasicVMVN-31101588-16105964 2025-02-06 13:01:44,755 - DEBUG - VM ctest-TestBasicVMVN-31101588-16105964 ID is 91ff85eb-c2df-481d-af78-0bac84e49182 2025-02-06 13:01:44,756 - DEBUG - VM ctest-TestBasicVMVN-31101588-16105964 launched on Node cn-jenkins-deploy-platform-ansible-os-2701-1 2025-02-06 13:01:44,835 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-machine/91ff85eb-c2df-481d-af78-0bac84e49182 2025-02-06 13:01:44,844 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-machine-interface/43323672-938d-4cb8-8764-64c1e1155deb 2025-02-06 13:01:46,088 - 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.02 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.332 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.332/1.678/3.024/1.346 ms') 2025-02-06 13:01:46,088 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBasicVMVN-31101588-16105964 passed 2025-02-06 13:01:46,246 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-02-06 13:01:46,246 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-31101588-16105964, IP 31.1.2.4, Port 22 2025-02-06 13:01:46,401 - DEBUG - VM ctest-TestBasicVMVN-31101588-16105964 is ready for SSH connections 2025-02-06 13:01:46,401 - INFO - Waiting for VM ctest-TestBasicVMVN-31101588-66414570 to be up.. 2025-02-06 13:01:46,478 - DEBUG - VM is in ACTIVE state now 2025-02-06 13:01:46,478 - INFO - VM name : ctest-TestBasicVMVN-31101588-66414570 2025-02-06 13:01:46,558 - DEBUG - VM ctest-TestBasicVMVN-31101588-66414570 ID is ea7b4e33-95aa-4b38-a569-d200cae99d01 2025-02-06 13:01:46,558 - DEBUG - VM ctest-TestBasicVMVN-31101588-66414570 launched on Node cn-jenkins-deploy-platform-ansible-os-2701-1 2025-02-06 13:01:46,636 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-machine/ea7b4e33-95aa-4b38-a569-d200cae99d01 2025-02-06 13:01:46,645 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-machine-interface/bab4b06d-6a9d-4029-a939-d791030aea26 2025-02-06 13:01:47,890 - 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=3.01 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.412 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.412/1.712/3.013/1.300 ms') 2025-02-06 13:01:47,890 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-31101588-66414570 passed 2025-02-06 13:01:48,046 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-02-06 13:01:48,046 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-31101588-66414570, IP 31.1.1.3, Port 22 2025-02-06 13:01:48,201 - DEBUG - VM ctest-TestBasicVMVN-31101588-66414570 is ready for SSH connections 2025-02-06 13:01:48,201 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-02-06 13:01:48,201 - 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.24, gateway password: c0ntrail123 2025-02-06 13:01:48,201 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4 2025-02-06 13:01:52,321 - DEBUG - PING 31.1.2.4 (31.1.2.4): 56 data bytes 64 bytes from 31.1.2.4: seq=0 ttl=63 time=4.086 ms 64 bytes from 31.1.2.4: seq=1 ttl=63 time=0.802 ms 64 bytes from 31.1.2.4: seq=2 ttl=63 time=0.806 ms --- 31.1.2.4 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 0.802/1.898/4.086 ms 2025-02-06 13:01:52,321 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-31101588-44226242 passed 2025-02-06 13:01:52,321 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-02-06 13:01:52,321 - 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.24, gateway password: c0ntrail123 2025-02-06 13:01:52,321 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4 2025-02-06 13:01:56,016 - 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=3.219 ms 64 bytes from 31.1.1.4: seq=1 ttl=63 time=0.829 ms 64 bytes from 31.1.1.4: seq=2 ttl=63 time=0.883 ms --- 31.1.1.4 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 0.829/1.643/3.219 ms 2025-02-06 13:01:56,016 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-31101588-16105964 passed 2025-02-06 13:01:56,016 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-02-06 13:01:56,016 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-02-06 13:01:56,016 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-02-06 13:01:56,016 - 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.24, gateway password: c0ntrail123 2025-02-06 13:01:56,017 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts 2025-02-06 13:01:56,213 - DEBUG - None 2025-02-06 13:01:56,213 - 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.24, gateway password: c0ntrail123 2025-02-06 13:01:56,213 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts 2025-02-06 13:01:56,419 - DEBUG - None 2025-02-06 13:01:56,419 - 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.24, gateway password: c0ntrail123 2025-02-06 13:01:56,419 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts 2025-02-06 13:01:57,097 - DEBUG - None 2025-02-06 13:01:57,098 - 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.24, gateway password: c0ntrail123 2025-02-06 13:01:57,098 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7 2025-02-06 13:01:59,324 - 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.932 ms 64 bytes from 31.1.1.3: seq=0 ttl=64 time=6.472 ms (DUP!) 64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.515 ms 64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.754 ms (DUP!) 64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.399 ms --- 31.1.1.7 ping statistics --- 3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss round-trip min/avg/max = 0.399/2.214/6.472 ms 2025-02-06 13:01:59,324 - 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.24, gateway password: c0ntrail123 2025-02-06 13:01:59,325 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1 2025-02-06 13:02:01,582 - 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.064 ms 64 bytes from 31.1.1.3: seq=0 ttl=64 time=3.163 ms (DUP!) 64 bytes from 31.1.2.4: seq=0 ttl=63 time=4.277 ms (DUP!) 64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.392 ms 64 bytes from 31.1.2.4: seq=1 ttl=63 time=1.756 ms (DUP!) 64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.612 ms (DUP!) 64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.445 ms --- 224.0.0.1 ping statistics --- 3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss round-trip min/avg/max = 0.392/1.958/4.277 ms 2025-02-06 13:02:01,583 - 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.24, gateway password: c0ntrail123 2025-02-06 13:02:01,583 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255 2025-02-06 13:02:03,830 - 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.700 ms 64 bytes from 31.1.1.3: seq=0 ttl=64 time=3.305 ms (DUP!) 64 bytes from 31.1.2.4: seq=0 ttl=63 time=4.240 ms (DUP!) 64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.407 ms 64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.096 ms (DUP!) 64 bytes from 31.1.1.3: seq=1 ttl=64 time=3.194 ms (DUP!) 64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.379 ms --- 255.255.255.255 ping statistics --- 3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss round-trip min/avg/max = 0.379/2.045/4.240 ms 2025-02-06 13:02:03,830 - INFO - Deleting VM ctest-TestBasicVMVN-31101588-66414570 2025-02-06 13:02:03,905 - INFO - Detaching port 43323672-938d-4cb8-8764-64c1e1155deb from VM ctest-TestBasicVMVN-31101588-16105964 2025-02-06 13:02:03,963 - INFO - Deleting VM ctest-TestBasicVMVN-31101588-16105964 2025-02-06 13:02:04,033 - INFO - Detaching port 64ad8a36-44a9-464d-a7b7-f3c587e8b536 from VM ctest-TestBasicVMVN-31101588-44226242 2025-02-06 13:02:04,069 - INFO - Deleting VM ctest-TestBasicVMVN-31101588-44226242 2025-02-06 13:02:04,144 - INFO - Deleting VN ctest-vn-02541385 2025-02-06 13:02:04,328 - DEBUG - Response for delete_port : () 2025-02-06 13:02:04,529 - DEBUG - Response for delete_port : () 2025-02-06 13:02:04,574 - DEBUG - VN 5118136b-1ecb-4e7a-b52c-a04895d93edd still in use: Unable to complete operation on network 5118136b-1ecb-4e7a-b52c-a04895d93edd. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-985e18aa-df95-4711-b6dd-9077306331ce'] 2025-02-06 13:02:04,574 - WARNING - Deleting VN ctest-vn-02541385 failed..Will retry 2025-02-06 13:02:06,723 - DEBUG - Response for deleting network () 2025-02-06 13:02:06,723 - DEBUG - Requesting: http://10.0.0.24:8082/routing-instance/e3bbc79d-a7cc-4f50-869a-5c0e5248c283 2025-02-06 13:02:06,729 - DEBUG - Response Code: 404 2025-02-06 13:02:06,729 - DEBUG - Requesting: http://10.0.0.24:8082/domains 2025-02-06 13:02:06,734 - DEBUG - Requesting: http://10.0.0.24:8082/domain/f6d1ccab-fbc6-46b5-9c91-98ccf0568927 2025-02-06 13:02:06,787 - DEBUG - Requesting: http://10.0.0.24:8082/project/7d56d9eb-cbf3-43fe-95f1-da5218206eb8 2025-02-06 13:02:06,865 - INFO - Validated that VN ctest-vn-02541385 is not found in API Server 2025-02-06 13:02:06,877 - DEBUG - VN ctest-vn-02541385 is not present in Agent 10.0.0.24 2025-02-06 13:02:06,877 - INFO - Validated that VN ctest-vn-02541385 is not in any agent 2025-02-06 13:02:06,884 - DEBUG - VRF 2 is not seen in agent 10.0.0.24 2025-02-06 13:02:06,889 - DEBUG - Vrouter 10.0.0.24 does not have vrf 2 for VN ctest-vn-02541385 2025-02-06 13:02:06,889 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-31101588:ctest-vn-02541385 2025-02-06 13:02:06,902 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-02541385 info 2025-02-06 13:02:06,989 - INFO - IPAM: ctest-ipam-20670060 is not found in API Server 2025-02-06 13:02:07,003 - INFO - IPAM:ctest-ipam-20670060 is not found in control node 2025-02-06 13:02:07,273 - DEBUG - No XMPP flaps were noticed during the test
2025-02-06 13:02:07,273 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:43]
2025-02-06 13:02:07,274 - INFO - -------------------------------------------------------------------------------- 2025-02-06 13:02:08,042 - INFO - Deleted project: ctest-TestBasicVMVN-31101588, ID : 7d56d9eb-cbf3-43fe-95f1-da5218206eb8