2025-06-19 14:36:05,073 - INFO - Domain Default found not creating 2025-06-19 14:36:05,209 - INFO - Project ctest-TestBasicVMVN-85715522 not found, creating it 2025-06-19 14:36:05,668 - INFO - Created Project:ctest-TestBasicVMVN-85715522, ID : 6b89ade7-0e44-4062-838a-980271ec2bcc 2025-06-19 14:36:07,222 - INFO - ================================================================================ 2025-06-19 14:36:07,223 - INFO - STARTING TEST : test_generic_link_local_service 2025-06-19 14:36:07,223 - 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-06-19 14:36:07,476 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.254': '0'}} with 2025-06-19 14:36:07,476 - INFO - Initial checks done. Running the testcase now 2025-06-19 14:36:07,477 - INFO - 2025-06-19 14:36:08,073 - DEBUG - Response for create_network : {'network': {'id': '3f0a0cd3-b6dc-4d19-80f1-9171fccc82cc', 'name': 'ctest-vn2_metadata-45579014', 'tenant_id': '6b89ade70e444062838a980271ec2bcc', 'project_id': '6b89ade70e444062838a980271ec2bcc', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-85715522', 'ctest-vn2_metadata-45579014'], 'port_security_enabled': True, 'description': ''}} 2025-06-19 14:36:08,274 - DEBUG - Response for create_subnet : {'subnet': {'id': '9ff3ce67-8a1f-4625-8438-8c393fb38586', 'name': '', 'tenant_id': '6b89ade70e444062838a980271ec2bcc', 'network_id': '3f0a0cd3-b6dc-4d19-80f1-9171fccc82cc', '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': '6b89ade70e444062838a980271ec2bcc'}} 2025-06-19 14:36:08,292 - INFO - Created VN ctest-vn2_metadata-45579014 2025-06-19 14:36:08,347 - DEBUG - VN ctest-vn2_metadata-45579014 UUID is 3f0a0cd3-b6dc-4d19-80f1-9171fccc82cc 2025-06-19 14:36:08,526 - DEBUG - Services list from nova: [, , ] 2025-06-19 14:36:09,611 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3497-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3497-1) 2025-06-19 14:36:09,715 - DEBUG - Link local service introspect added 2025-06-19 14:36:09,756 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-06-19 14:36:14,866 - DEBUG - VM is in ACTIVE state now 2025-06-19 14:36:14,994 - INFO - Waiting for VM ctest-TestBasicVMVN-85715522-02633445 to be up.. 2025-06-19 14:36:14,994 - INFO - VM name : ctest-TestBasicVMVN-85715522-02633445 2025-06-19 14:36:15,075 - DEBUG - VM ctest-TestBasicVMVN-85715522-02633445 ID is b828cb88-35af-451b-885d-a2d2e02491dc 2025-06-19 14:36:15,075 - DEBUG - VM ctest-TestBasicVMVN-85715522-02633445 launched on Node cn-jenkins-deploy-platform-ansible-os-3497-1 2025-06-19 14:36:15,152 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/b828cb88-35af-451b-885d-a2d2e02491dc 2025-06-19 14:36:15,483 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/b828cb88-35af-451b-885d-a2d2e02491dc 2025-06-19 14:36:15,513 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/4c43d629-b78b-46b1-9115-f7403df6772c 2025-06-19 14:36:18,798 - 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-06-19 14:36:18,798 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-85715522-02633445 failed! 2025-06-19 14:36:18,855 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-85715522:ctest-vn2_metadata-45579014 is 11.1.1.1 and allocation pool is NOT set 2025-06-19 14:36:20,916 - 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.87 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.05 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.045/5.958/9.872/3.913 ms') 2025-06-19 14:36:20,916 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-85715522-02633445 passed 2025-06-19 14:36:21,071 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-06-19 14:36:21,071 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-85715522-02633445, IP 11.1.1.3, Port 22 2025-06-19 14:36:21,127 - 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-06-19 14:36:21,205 - DEBUG - VM ctest-TestBasicVMVN-85715522-02633445 is NOT ready for SSH connections, VM status: ACTIVE 2025-06-19 14:36:26,206 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-06-19 14:36:26,206 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-85715522-02633445, IP 11.1.1.3, Port 22 2025-06-19 14:36:26,367 - DEBUG - VM ctest-TestBasicVMVN-85715522-02633445 is ready for SSH connections 2025-06-19 14:36:26,367 - INFO - Retry 0 2025-06-19 14:36:26,367 - DEBUG - Running remote_cmd, Cmd : wget http://169.254.1.2:8083 --spider && echo "Successful", host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.38, gateway password: c0ntrail123 2025-06-19 14:36:26,367 - DEBUG - wget http://169.254.1.2:8083 --spider && echo "Successful" 2025-06-19 14:36:27,983 - DEBUG - Connecting to 169.254.1.2:8083 (169.254.1.2:8083) Successful 2025-06-19 14:36:27,983 - INFO - Generic metadata worked 2025-06-19 14:36:28,243 - DEBUG - Link local service introspect removed 2025-06-19 14:36:28,243 - INFO - Deleting VM ctest-TestBasicVMVN-85715522-02633445 2025-06-19 14:36:28,318 - INFO - Deleting VN ctest-vn2_metadata-45579014 2025-06-19 14:36:28,362 - DEBUG - VN 3f0a0cd3-b6dc-4d19-80f1-9171fccc82cc still in use: Unable to complete operation on network 3f0a0cd3-b6dc-4d19-80f1-9171fccc82cc. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-89ccd392-78a2-470d-abe4-59568eb3ddb3'] 2025-06-19 14:36:28,362 - WARNING - Deleting VN ctest-vn2_metadata-45579014 failed..Will retry 2025-06-19 14:36:30,486 - DEBUG - Response for deleting network () 2025-06-19 14:36:30,755 - DEBUG - No XMPP flaps were noticed during the test 2025-06-19 14:36:30,756 - INFO - -------------------------------------------------------------------------------- 2025-06-19 14:36:30,759 - INFO - ================================================================================ 2025-06-19 14:36:30,759 - INFO - STARTING TEST : test_metadata_service 2025-06-19 14:36:30,759 - 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-06-19 14:36:31,041 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.254': '0'}} with 2025-06-19 14:36:31,042 - INFO - Initial checks done. Running the testcase now 2025-06-19 14:36:31,042 - INFO - 2025-06-19 14:36:31,042 - DEBUG - Requesting: http://10.0.0.38:8082/global-vrouter-configs 2025-06-19 14:36:31,049 - DEBUG - Requesting: http://10.0.0.38:8082/global-vrouter-config/6f9b55cf-5ba7-47c3-bb4a-e82905cfe919 2025-06-19 14:36:31,259 - DEBUG - Response for create_network : {'network': {'id': '191a38bd-f680-4af7-9d8e-1d84f594fc03', 'name': 'ctest-vn-14733577', 'tenant_id': '6b89ade70e444062838a980271ec2bcc', 'project_id': '6b89ade70e444062838a980271ec2bcc', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-85715522', 'ctest-vn-14733577'], 'port_security_enabled': True, 'description': ''}} 2025-06-19 14:36:31,480 - DEBUG - Response for create_subnet : {'subnet': {'id': '69c9b666-588c-4eda-ab93-5256bb8e452d', 'name': '', 'tenant_id': '6b89ade70e444062838a980271ec2bcc', 'network_id': '191a38bd-f680-4af7-9d8e-1d84f594fc03', 'ip_version': 4, 'cidr': '76.146.101.128/26', 'allocation_pools': [{'start': '76.146.101.130', 'end': '76.146.101.190'}], 'gateway_ip': '76.146.101.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '76.146.101.130', 'tags': [], 'project_id': '6b89ade70e444062838a980271ec2bcc'}} 2025-06-19 14:36:31,498 - INFO - Created VN ctest-vn-14733577 2025-06-19 14:36:31,551 - DEBUG - VN ctest-vn-14733577 UUID is 191a38bd-f680-4af7-9d8e-1d84f594fc03 2025-06-19 14:36:32,851 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3497-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3497-1) 2025-06-19 14:36:32,851 - INFO - Waiting for VM ctest-TestBasicVMVN-85715522-93037871 to be up.. 2025-06-19 14:36:32,896 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-06-19 14:36:37,982 - DEBUG - VM is in ACTIVE state now 2025-06-19 14:36:37,982 - INFO - VM name : ctest-TestBasicVMVN-85715522-93037871 2025-06-19 14:36:38,058 - DEBUG - VM ctest-TestBasicVMVN-85715522-93037871 ID is 77e3536b-67b3-4018-89c5-c102fe3ba8a9 2025-06-19 14:36:38,058 - DEBUG - VM ctest-TestBasicVMVN-85715522-93037871 launched on Node cn-jenkins-deploy-platform-ansible-os-3497-1 2025-06-19 14:36:38,134 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/77e3536b-67b3-4018-89c5-c102fe3ba8a9 2025-06-19 14:36:38,143 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/1f174502-673b-4e32-8937-067740afc37a 2025-06-19 14:36:41,391 - 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-06-19 14:36:41,391 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-85715522-93037871 failed! 2025-06-19 14:36:41,447 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-85715522:ctest-vn-14733577 is 76.146.101.129 and allocation pool is NOT set 2025-06-19 14:36:43,511 - 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=10.4 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.40 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.404/6.400/10.396/3.996 ms') 2025-06-19 14:36:43,511 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-85715522-93037871 passed 2025-06-19 14:36:43,663 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-06-19 14:36:43,663 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-85715522-93037871, IP 76.146.101.131, Port 22 2025-06-19 14:36:43,728 - 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-06-19 14:36:43,811 - DEBUG - VM ctest-TestBasicVMVN-85715522-93037871 is NOT ready for SSH connections, VM status: ACTIVE 2025-06-19 14:36:48,812 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-06-19 14:36:48,812 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-85715522-93037871, IP 76.146.101.131, Port 22 2025-06-19 14:36:48,966 - DEBUG - VM ctest-TestBasicVMVN-85715522-93037871 is ready for SSH connections 2025-06-19 14:36:48,966 - DEBUG - Running remote_cmd, Cmd : cat /tmp/output.txt, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.38, gateway password: c0ntrail123 2025-06-19 14:36:48,966 - DEBUG - cat /tmp/output.txt 2025-06-19 14:36:50,601 - DEBUG - Hello World. The time is now Thu, 19 Jun 2025 08:36:44 -0600! 2025-06-19 14:36:50,601 - DEBUG - ret : {'cat /tmp/output.txt': 'Hello World. The time is now Thu, 19 Jun 2025 08:36:44 -0600!'} 2025-06-19 14:36:50,601 - INFO - metadata_script.txt got executed in the vm 2025-06-19 14:36:50,601 - INFO - Deleting VM ctest-TestBasicVMVN-85715522-93037871 2025-06-19 14:36:50,663 - INFO - Deleting VN ctest-vn-14733577 2025-06-19 14:36:50,700 - DEBUG - VN 191a38bd-f680-4af7-9d8e-1d84f594fc03 still in use: Unable to complete operation on network 191a38bd-f680-4af7-9d8e-1d84f594fc03. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-f41d4a95-8cb0-4fe4-a1d1-ce491575d540'] 2025-06-19 14:36:50,700 - WARNING - Deleting VN ctest-vn-14733577 failed..Will retry 2025-06-19 14:36:52,798 - DEBUG - Response for deleting network () 2025-06-19 14:36:53,053 - DEBUG - No XMPP flaps were noticed during the test
2025-06-19 14:36:53,053 - INFO - END TEST : test_metadata_service : PASSED[0:00:23]
2025-06-19 14:36:53,053 - INFO - -------------------------------------------------------------------------------- 2025-06-19 14:36:53,056 - INFO - ================================================================================ 2025-06-19 14:36:53,056 - INFO - STARTING TEST : test_ping_within_vn_two_vms_two_different_subnets 2025-06-19 14:36:53,056 - 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-06-19 14:36:53,340 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.254': '0'}} with 2025-06-19 14:36:53,340 - INFO - Initial checks done. Running the testcase now 2025-06-19 14:36:53,340 - INFO - 2025-06-19 14:36:53,826 - DEBUG - Response for create_network : {'network': {'id': 'f029c515-7290-431c-a30d-c25cb6f68613', 'name': 'ctest-vn-81336711', 'tenant_id': '6b89ade70e444062838a980271ec2bcc', 'project_id': '6b89ade70e444062838a980271ec2bcc', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-85715522', 'ctest-vn-81336711'], 'port_security_enabled': True, 'description': ''}} 2025-06-19 14:36:53,978 - DEBUG - Response for create_subnet : {'subnet': {'id': '6267847f-1524-4a2c-b9f3-0fdc784a09e7', 'name': '', 'tenant_id': '6b89ade70e444062838a980271ec2bcc', 'network_id': 'f029c515-7290-431c-a30d-c25cb6f68613', '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': '6b89ade70e444062838a980271ec2bcc'}} 2025-06-19 14:36:54,171 - DEBUG - Response for create_subnet : {'subnet': {'id': '293f33d1-d039-41b2-bce3-d6d72b0db03a', 'name': '', 'tenant_id': '6b89ade70e444062838a980271ec2bcc', 'network_id': 'f029c515-7290-431c-a30d-c25cb6f68613', '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': '6b89ade70e444062838a980271ec2bcc'}} 2025-06-19 14:36:54,190 - INFO - Created VN ctest-vn-81336711 2025-06-19 14:36:54,243 - DEBUG - VN ctest-vn-81336711 UUID is f029c515-7290-431c-a30d-c25cb6f68613 2025-06-19 14:36:54,589 - DEBUG - Response for create_port : {'port': {'name': '7faf22fc-d7e8-4e64-82e1-108d3855f9eb', 'id': '7faf22fc-d7e8-4e64-82e1-108d3855f9eb', 'tenant_id': '6b89ade70e444062838a980271ec2bcc', 'network_id': 'f029c515-7290-431c-a30d-c25cb6f68613', 'mac_address': '02:7f:af:22:fc:d7', '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': '6267847f-1524-4a2c-b9f3-0fdc784a09e7'}], 'security_groups': ['423f90a8-a3ad-4067-9008-6e5d493db1a2'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '6b89ade70e444062838a980271ec2bcc'}} 2025-06-19 14:36:54,758 - DEBUG - Response for create_port : {'port': {'name': '84688528-3d62-4644-a1eb-57e3728198e8', 'id': '84688528-3d62-4644-a1eb-57e3728198e8', 'tenant_id': '6b89ade70e444062838a980271ec2bcc', 'network_id': 'f029c515-7290-431c-a30d-c25cb6f68613', 'mac_address': '02:84:68:85:28:3d', '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': '293f33d1-d039-41b2-bce3-d6d72b0db03a'}], 'security_groups': ['423f90a8-a3ad-4067-9008-6e5d493db1a2'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '6b89ade70e444062838a980271ec2bcc'}} 2025-06-19 14:36:55,101 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3497-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3497-1) 2025-06-19 14:36:55,463 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3497-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3497-1) 2025-06-19 14:36:56,705 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3497-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3497-1) 2025-06-19 14:36:56,705 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-06-19 14:36:56,712 - DEBUG - Requesting: http://10.0.0.38:8082/domain/408fa638-d3b0-456a-b9d0-416ce21a7ae4 2025-06-19 14:36:56,728 - DEBUG - Requesting: http://10.0.0.38:8082/project/6b89ade7-0e44-4062-838a-980271ec2bcc 2025-06-19 14:36:56,810 - DEBUG - Requesting: http://10.0.0.38:8082/network-ipam/4f7c7147-b0df-4d48-822e-0aa1181becbc 2025-06-19 14:36:56,821 - INFO - Verifications in API Server for IPAM: ctest-ipam-65571101 passed 2025-06-19 14:36:56,831 - DEBUG - Control-node 10.0.0.38 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestBasicVMVN-85715522:ctest-ipam-65571101', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN-85715522', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '5727577378832469320', 'uuid-lslong': '9380446760869817532'}, 'enable': 'true', 'created': '2025-06-19T14:36:53', 'last-modified': '2025-06-19T14:36:53', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.260406'} 2025-06-19 14:36:56,831 - INFO - Verifications in Control node for IPAM: ctest-ipam-65571101 passed 2025-06-19 14:36:56,831 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-06-19 14:36:56,838 - DEBUG - Requesting: http://10.0.0.38:8082/domain/408fa638-d3b0-456a-b9d0-416ce21a7ae4 2025-06-19 14:36:56,858 - DEBUG - Requesting: http://10.0.0.38:8082/project/6b89ade7-0e44-4062-838a-980271ec2bcc 2025-06-19 14:36:56,939 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f029c515-7290-431c-a30d-c25cb6f68613 2025-06-19 14:36:56,963 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f029c515-7290-431c-a30d-c25cb6f68613 2025-06-19 14:36:56,979 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/8cfc1db8-cba5-4647-9342-ea3a0f910d8b 2025-06-19 14:36:56,990 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/8cfc1db8-cba5-4647-9342-ea3a0f910d8b 2025-06-19 14:36:57,001 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/dcd6fdb8-72ec-4de6-9bee-4c6e8d128e76 2025-06-19 14:36:57,012 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-06-19 14:36:57,012 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f029c515-7290-431c-a30d-c25cb6f68613 2025-06-19 14:36:57,029 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/8cfc1db8-cba5-4647-9342-ea3a0f910d8b 2025-06-19 14:36:57,053 - INFO - Verified VN network id 8 for VN f029c515-7290-431c-a30d-c25cb6f68613 2025-06-19 14:36:57,054 - INFO - Verifications in API Server for VN ctest-vn-81336711 passed 2025-06-19 14:36:57,054 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f029c515-7290-431c-a30d-c25cb6f68613 2025-06-19 14:36:57,078 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/8cfc1db8-cba5-4647-9342-ea3a0f910d8b 2025-06-19 14:36:57,088 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/8cfc1db8-cba5-4647-9342-ea3a0f910d8b 2025-06-19 14:36:57,104 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/dcd6fdb8-72ec-4de6-9bee-4c6e8d128e76 2025-06-19 14:36:57,133 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicVMVN-85715522:ctest-vn-81336711', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN-85715522', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '17305579739054883612', 'uuid-lslong': '11749260706341881363'}, 'enable': 'true', 'created': '2025-06-19T14:36:53', 'last-modified': '2025-06-19T14:36:54', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.979152'} 2025-06-19 14:36:57,156 - DEBUG - Route Targets: ['target:64512:8000005'] 2025-06-19 14:36:57,156 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn-81336711 passed 2025-06-19 14:36:57,156 - DEBUG - ====Verifying policy data for ctest-vn-81336711 in API_Server ====== 2025-06-19 14:36:57,156 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-06-19 14:36:57,167 - DEBUG - Requesting: http://10.0.0.38:8082/domain/408fa638-d3b0-456a-b9d0-416ce21a7ae4 2025-06-19 14:36:57,181 - DEBUG - Requesting: http://10.0.0.38:8082/project/6b89ade7-0e44-4062-838a-980271ec2bcc 2025-06-19 14:36:57,308 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/f029c515-7290-431c-a30d-c25cb6f68613 2025-06-19 14:36:57,327 - DEBUG - =>VN ctest-vn-81336711 has no policy to be verified 2025-06-19 14:36:57,327 - DEBUG - Verifying the vn in opserver 2025-06-19 14:36:57,327 - DEBUG - Verifying the default-domain:ctest-TestBasicVMVN-85715522:ctest-vn-81336711 virtual network link through opserver 10.0.0.38 2025-06-19 14:36:57,327 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-06-19 14:36:57,724 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks 2025-06-19 14:36:57,804 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicVMVN-85715522:ctest-vn-81336711', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicVMVN-85715522:ctest-vn-81336711?flat'} 2025-06-19 14:36:57,805 - INFO - Validated that VN default-domain:ctest-TestBasicVMVN-85715522:ctest-vn-81336711 is found in opserver 2025-06-19 14:36:57,811 - DEBUG - VRF ids for VN ctest-vn-81336711: {'10.0.0.38': '2'} 2025-06-19 14:36:57,811 - INFO - Waiting for VM ctest-TestBasicVMVN-85715522-43263449 to be up.. 2025-06-19 14:36:57,902 - DEBUG - VM is in ACTIVE state now 2025-06-19 14:36:57,902 - INFO - VM name : ctest-TestBasicVMVN-85715522-43263449 2025-06-19 14:36:57,997 - DEBUG - VM ctest-TestBasicVMVN-85715522-43263449 ID is 795b356f-928e-4d97-a6ff-378f3c3ce7c4 2025-06-19 14:36:57,998 - DEBUG - VM ctest-TestBasicVMVN-85715522-43263449 launched on Node cn-jenkins-deploy-platform-ansible-os-3497-1 2025-06-19 14:36:58,097 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/795b356f-928e-4d97-a6ff-378f3c3ce7c4 2025-06-19 14:36:58,111 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/7faf22fc-d7e8-4e64-82e1-108d3855f9eb 2025-06-19 14:37:01,389 - 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-06-19 14:37:01,389 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-85715522-43263449 failed! 2025-06-19 14:37:01,447 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-85715522:ctest-vn-81336711 is 31.1.1.1 and allocation pool is NOT set 2025-06-19 14:37:01,447 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-85715522:ctest-vn-81336711 is 31.1.2.1 and allocation pool is NOT set 2025-06-19 14:37:05,521 - 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-06-19 14:37:05,521 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-85715522-43263449 failed! 2025-06-19 14:37:05,575 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-85715522:ctest-vn-81336711 is 31.1.1.1 and allocation pool is NOT set 2025-06-19 14:37:05,575 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-85715522:ctest-vn-81336711 is 31.1.2.1 and allocation pool is NOT set 2025-06-19 14:37:07,635 - 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.79 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.339 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.339/5.062/9.785/4.723 ms') 2025-06-19 14:37:07,635 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-85715522-43263449 passed 2025-06-19 14:37:07,787 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-06-19 14:37:07,787 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-85715522-43263449, IP 31.1.1.4, Port 22 2025-06-19 14:37:07,942 - DEBUG - VM ctest-TestBasicVMVN-85715522-43263449 is ready for SSH connections 2025-06-19 14:37:07,942 - INFO - Waiting for VM ctest-TestBasicVMVN-85715522-63108076 to be up.. 2025-06-19 14:37:08,020 - DEBUG - VM is in ACTIVE state now 2025-06-19 14:37:08,021 - INFO - VM name : ctest-TestBasicVMVN-85715522-63108076 2025-06-19 14:37:08,098 - DEBUG - VM ctest-TestBasicVMVN-85715522-63108076 ID is d30157c9-a9aa-458f-aa73-b63bad45de90 2025-06-19 14:37:08,099 - DEBUG - VM ctest-TestBasicVMVN-85715522-63108076 launched on Node cn-jenkins-deploy-platform-ansible-os-3497-1 2025-06-19 14:37:08,180 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/d30157c9-a9aa-458f-aa73-b63bad45de90 2025-06-19 14:37:08,190 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/84688528-3d62-4644-a1eb-57e3728198e8 2025-06-19 14:37:09,437 - 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.433 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.433/1.726/3.020/1.293 ms') 2025-06-19 14:37:09,437 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBasicVMVN-85715522-63108076 passed 2025-06-19 14:37:09,587 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-06-19 14:37:09,587 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-85715522-63108076, IP 31.1.2.4, Port 22 2025-06-19 14:37:09,746 - DEBUG - VM ctest-TestBasicVMVN-85715522-63108076 is ready for SSH connections 2025-06-19 14:37:09,746 - INFO - Waiting for VM ctest-TestBasicVMVN-85715522-57777102 to be up.. 2025-06-19 14:37:09,821 - DEBUG - VM is in ACTIVE state now 2025-06-19 14:37:09,821 - INFO - VM name : ctest-TestBasicVMVN-85715522-57777102 2025-06-19 14:37:09,901 - DEBUG - VM ctest-TestBasicVMVN-85715522-57777102 ID is 05a006aa-fcd3-4329-aa49-71f0be061cf4 2025-06-19 14:37:09,901 - DEBUG - VM ctest-TestBasicVMVN-85715522-57777102 launched on Node cn-jenkins-deploy-platform-ansible-os-3497-1 2025-06-19 14:37:09,975 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/05a006aa-fcd3-4329-aa49-71f0be061cf4 2025-06-19 14:37:09,985 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/f0fba53e-cf43-406d-8ccb-b467d28be813 2025-06-19 14:37:11,225 - 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=4.25 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.314 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.314/2.283/4.252/1.969 ms') 2025-06-19 14:37:11,225 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-85715522-57777102 passed 2025-06-19 14:37:11,379 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-06-19 14:37:11,379 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-85715522-57777102, IP 31.1.1.3, Port 22 2025-06-19 14:37:11,542 - DEBUG - VM ctest-TestBasicVMVN-85715522-57777102 is ready for SSH connections 2025-06-19 14:37:11,542 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-06-19 14:37:11,542 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 31.1.2.4, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.38, gateway password: c0ntrail123 2025-06-19 14:37:11,542 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4 2025-06-19 14:37:15,569 - 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.482 ms 64 bytes from 31.1.2.4: seq=1 ttl=63 time=0.747 ms 64 bytes from 31.1.2.4: seq=2 ttl=63 time=0.811 ms --- 31.1.2.4 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 0.747/1.680/3.482 ms 2025-06-19 14:37:15,569 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-85715522-43263449 passed 2025-06-19 14:37:15,569 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-06-19 14:37:15,569 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 31.1.1.4, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.38, gateway password: c0ntrail123 2025-06-19 14:37:15,569 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4 2025-06-19 14:37:19,335 - 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.118 ms 64 bytes from 31.1.1.4: seq=1 ttl=63 time=1.046 ms 64 bytes from 31.1.1.4: seq=2 ttl=63 time=0.825 ms --- 31.1.1.4 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 0.825/1.663/3.118 ms 2025-06-19 14:37:19,335 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-85715522-63108076 passed 2025-06-19 14:37:19,335 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-06-19 14:37:19,335 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-06-19 14:37:19,335 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-06-19 14:37:19,336 - DEBUG - Running remote_cmd, Cmd : echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.38, gateway password: c0ntrail123 2025-06-19 14:37:19,336 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts 2025-06-19 14:37:19,531 - DEBUG - None 2025-06-19 14:37:19,532 - DEBUG - Running remote_cmd, Cmd : echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.38, gateway password: c0ntrail123 2025-06-19 14:37:19,532 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts 2025-06-19 14:37:19,727 - DEBUG - None 2025-06-19 14:37:19,727 - DEBUG - Running remote_cmd, Cmd : echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts, host_string: cirros@169.254.0.5, password: cubswin:)gateway: ubuntu@10.0.0.38, gateway password: c0ntrail123 2025-06-19 14:37:19,727 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts 2025-06-19 14:37:20,363 - DEBUG - None 2025-06-19 14:37:20,364 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 31.1.1.7, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.38, gateway password: c0ntrail123 2025-06-19 14:37:20,364 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7 2025-06-19 14:37:22,584 - DEBUG - PING 31.1.1.7 (31.1.1.7): 56 data bytes 64 bytes from 31.1.1.4: seq=0 ttl=64 time=2.215 ms 64 bytes from 31.1.1.3: seq=0 ttl=64 time=4.998 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.635 ms (DUP!) 64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.387 ms --- 31.1.1.7 ping statistics --- 3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss round-trip min/avg/max = 0.387/1.928/4.998 ms 2025-06-19 14:37:22,584 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 224.0.0.1, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.38, gateway password: c0ntrail123 2025-06-19 14:37:22,584 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1 2025-06-19 14:37:24,841 - 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.134 ms 64 bytes from 31.1.1.3: seq=0 ttl=64 time=3.289 ms (DUP!) 64 bytes from 31.1.2.4: seq=0 ttl=63 time=4.405 ms (DUP!) 64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.610 ms 64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.390 ms (DUP!) 64 bytes from 31.1.1.3: seq=1 ttl=64 time=3.786 ms (DUP!) 64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.358 ms --- 224.0.0.1 ping statistics --- 3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss round-trip min/avg/max = 0.358/2.281/4.405 ms 2025-06-19 14:37:24,842 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 255.255.255.255, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.38, gateway password: c0ntrail123 2025-06-19 14:37:24,842 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255 2025-06-19 14:37:27,094 - 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.725 ms 64 bytes from 31.1.1.3: seq=0 ttl=64 time=3.242 ms (DUP!) 64 bytes from 31.1.2.4: seq=0 ttl=63 time=4.532 ms (DUP!) 64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.474 ms 64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.030 ms (DUP!) 64 bytes from 31.1.1.3: seq=1 ttl=64 time=3.123 ms (DUP!) 64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.450 ms --- 255.255.255.255 ping statistics --- 3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss round-trip min/avg/max = 0.450/2.082/4.532 ms 2025-06-19 14:37:27,094 - INFO - Deleting VM ctest-TestBasicVMVN-85715522-57777102 2025-06-19 14:37:27,163 - INFO - Detaching port 84688528-3d62-4644-a1eb-57e3728198e8 from VM ctest-TestBasicVMVN-85715522-63108076 2025-06-19 14:37:27,214 - INFO - Deleting VM ctest-TestBasicVMVN-85715522-63108076 2025-06-19 14:37:27,279 - INFO - Detaching port 7faf22fc-d7e8-4e64-82e1-108d3855f9eb from VM ctest-TestBasicVMVN-85715522-43263449 2025-06-19 14:37:27,313 - INFO - Deleting VM ctest-TestBasicVMVN-85715522-43263449 2025-06-19 14:37:27,381 - INFO - Deleting VN ctest-vn-81336711 2025-06-19 14:37:27,568 - DEBUG - Response for delete_port : () 2025-06-19 14:37:27,741 - DEBUG - Response for delete_port : () 2025-06-19 14:37:27,790 - DEBUG - VN f029c515-7290-431c-a30d-c25cb6f68613 still in use: Unable to complete operation on network f029c515-7290-431c-a30d-c25cb6f68613. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-a2eee2f3-45c3-456d-8f0d-75f31fbf4cee'] 2025-06-19 14:37:27,790 - WARNING - Deleting VN ctest-vn-81336711 failed..Will retry 2025-06-19 14:37:29,940 - DEBUG - Response for deleting network () 2025-06-19 14:37:29,941 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/8cfc1db8-cba5-4647-9342-ea3a0f910d8b 2025-06-19 14:37:29,946 - DEBUG - Response Code: 404 2025-06-19 14:37:29,947 - DEBUG - Requesting: http://10.0.0.38:8082/domains 2025-06-19 14:37:29,954 - DEBUG - Requesting: http://10.0.0.38:8082/domain/408fa638-d3b0-456a-b9d0-416ce21a7ae4 2025-06-19 14:37:30,013 - DEBUG - Requesting: http://10.0.0.38:8082/project/6b89ade7-0e44-4062-838a-980271ec2bcc 2025-06-19 14:37:30,088 - INFO - Validated that VN ctest-vn-81336711 is not found in API Server 2025-06-19 14:37:30,101 - DEBUG - VN ctest-vn-81336711 is not present in Agent 10.0.0.38 2025-06-19 14:37:30,101 - INFO - Validated that VN ctest-vn-81336711 is not in any agent 2025-06-19 14:37:30,107 - DEBUG - VRF 2 is not seen in agent 10.0.0.38 2025-06-19 14:37:30,113 - DEBUG - Vrouter 10.0.0.38 does not have vrf 2 for VN ctest-vn-81336711 2025-06-19 14:37:30,113 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-85715522:ctest-vn-81336711 2025-06-19 14:37:30,124 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-81336711 info 2025-06-19 14:37:30,203 - INFO - IPAM: ctest-ipam-65571101 is not found in API Server 2025-06-19 14:37:30,214 - INFO - IPAM:ctest-ipam-65571101 is not found in control node 2025-06-19 14:37:30,468 - DEBUG - No XMPP flaps were noticed during the test
2025-06-19 14:37:30,468 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:37]
2025-06-19 14:37:30,468 - INFO - -------------------------------------------------------------------------------- 2025-06-19 14:37:31,228 - INFO - Deleted project: ctest-TestBasicVMVN-85715522, ID : 6b89ade7-0e44-4062-838a-980271ec2bcc