2026-10-02 04:59:08,277 - INFO - Domain Default found not creating 2026-10-02 04:59:08,471 - INFO - Project ctest-TestBasicVMVN-37638013 not found, creating it 2026-10-02 04:59:09,007 - INFO - Created Project:ctest-TestBasicVMVN-37638013, ID : 852cfe2a-95fb-42c5-ab4f-b402502dc0fb 2026-10-02 04:59:10,837 - INFO - ================================================================================ 2026-10-02 04:59:10,837 - INFO - STARTING TEST : test_generic_link_local_service 2026-10-02 04:59:10,837 - 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 2026-10-02 04:59:11,116 - DEBUG - Nothing to compare xmpp stats {'10.0.0.190': {'10.20.0.17': '0'}} with 2026-10-02 04:59:11,116 - INFO - Initial checks done. Running the testcase now 2026-10-02 04:59:11,116 - INFO - 2026-10-02 04:59:11,826 - DEBUG - Response for create_network : {'network': {'id': '378bd2e0-96e7-461f-b9b6-06ae0776fcdf', 'name': 'ctest-vn2_metadata-28476458', 'tenant_id': '852cfe2a95fb42c5ab4fb402502dc0fb', 'project_id': '852cfe2a95fb42c5ab4fb402502dc0fb', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-37638013', 'ctest-vn2_metadata-28476458'], 'port_security_enabled': True, 'description': ''}} 2026-10-02 04:59:12,020 - DEBUG - Response for create_subnet : {'subnet': {'id': 'fee50065-d650-4e1e-a223-7056ebeedab5', 'name': '', 'tenant_id': '852cfe2a95fb42c5ab4fb402502dc0fb', 'network_id': '378bd2e0-96e7-461f-b9b6-06ae0776fcdf', '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': '852cfe2a95fb42c5ab4fb402502dc0fb'}} 2026-10-02 04:59:12,041 - INFO - Created VN ctest-vn2_metadata-28476458 2026-10-02 04:59:12,096 - DEBUG - VN ctest-vn2_metadata-28476458 UUID is 378bd2e0-96e7-461f-b9b6-06ae0776fcdf 2026-10-02 04:59:12,303 - DEBUG - Services list from nova: [, , ] 2026-10-02 04:59:12,727 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6338-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6338-1) 2026-10-02 04:59:12,840 - DEBUG - Link local service introspect added 2026-10-02 04:59:12,893 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 04:59:17,970 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 04:59:23,063 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 04:59:28,161 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 04:59:33,266 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 04:59:38,350 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 04:59:43,446 - DEBUG - VM is in ACTIVE state now 2026-10-02 04:59:43,606 - INFO - Waiting for VM ctest-TestBasicVMVN-37638013-78854339 to be up.. 2026-10-02 04:59:43,606 - INFO - VM name : ctest-TestBasicVMVN-37638013-78854339 2026-10-02 04:59:43,702 - DEBUG - VM ctest-TestBasicVMVN-37638013-78854339 ID is c7b47cf9-7bd2-4348-92e0-52250be49fc2 2026-10-02 04:59:43,703 - DEBUG - VM ctest-TestBasicVMVN-37638013-78854339 launched on Node cn-jenkins-deploy-platform-ansible-os-6338-1 2026-10-02 04:59:43,806 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine/c7b47cf9-7bd2-4348-92e0-52250be49fc2 2026-10-02 04:59:44,197 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine/c7b47cf9-7bd2-4348-92e0-52250be49fc2 2026-10-02 04:59:44,235 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine-interface/6056d220-14aa-44c2-b4b1-45ee1bde679c 2026-10-02 04:59:47,512 - 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 1023ms') 2026-10-02 04:59:47,513 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-37638013-78854339 failed! 2026-10-02 04:59:47,572 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-37638013:ctest-vn2_metadata-28476458 is 11.1.1.1 and allocation pool is NOT set 2026-10-02 04:59:49,637 - 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=6.94 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.11 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1000ms\r\nrtt min/avg/max/mdev = 2.106/4.521/6.937/2.415 ms') 2026-10-02 04:59:49,637 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-37638013-78854339 passed 2026-10-02 04:59:49,792 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-10-02 04:59:49,792 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-37638013-78854339, IP 11.1.1.3, Port 22 2026-10-02 04:59:49,862 - 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': ''} 2026-10-02 04:59:49,962 - DEBUG - VM ctest-TestBasicVMVN-37638013-78854339 is NOT ready for SSH connections, VM status: ACTIVE 2026-10-02 04:59:54,963 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-10-02 04:59:54,963 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-37638013-78854339, IP 11.1.1.3, Port 22 2026-10-02 04:59:55,134 - DEBUG - VM ctest-TestBasicVMVN-37638013-78854339 is ready for SSH connections 2026-10-02 04:59:55,134 - INFO - Retry 0 2026-10-02 04:59:55,134 - 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.190, gateway password: c0ntrail123 2026-10-02 04:59:55,135 - DEBUG - wget http://169.254.1.2:8083 --spider && echo "Successful" 2026-10-02 04:59:56,741 - DEBUG - Connecting to 169.254.1.2:8083 (169.254.1.2:8083) Successful 2026-10-02 04:59:56,742 - INFO - Generic metadata worked 2026-10-02 04:59:57,020 - DEBUG - Link local service introspect removed 2026-10-02 04:59:57,020 - INFO - Deleting VM ctest-TestBasicVMVN-37638013-78854339 2026-10-02 04:59:57,110 - INFO - Deleting VN ctest-vn2_metadata-28476458 2026-10-02 04:59:57,155 - DEBUG - VN 378bd2e0-96e7-461f-b9b6-06ae0776fcdf still in use: Unable to complete operation on network 378bd2e0-96e7-461f-b9b6-06ae0776fcdf. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-f48bbcaa-8cf8-42b0-8cce-e73b5d7f136c'] 2026-10-02 04:59:57,155 - WARNING - Deleting VN ctest-vn2_metadata-28476458 failed..Will retry 2026-10-02 04:59:59,204 - DEBUG - VN 378bd2e0-96e7-461f-b9b6-06ae0776fcdf still in use: Unable to complete operation on network 378bd2e0-96e7-461f-b9b6-06ae0776fcdf. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-9f8d91e7-5b56-4126-b6dc-3025b8ec032b'] 2026-10-02 04:59:59,204 - WARNING - Deleting VN ctest-vn2_metadata-28476458 failed..Will retry 2026-10-02 05:00:01,420 - DEBUG - Response for deleting network () 2026-10-02 05:00:01,699 - DEBUG - No XMPP flaps were noticed during the test 2026-10-02 05:00:01,700 - INFO - -------------------------------------------------------------------------------- 2026-10-02 05:00:01,703 - INFO - ================================================================================ 2026-10-02 05:00:01,703 - INFO - STARTING TEST : test_metadata_service 2026-10-02 05:00:01,703 - 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 2026-10-02 05:00:01,998 - DEBUG - Nothing to compare xmpp stats {'10.0.0.190': {'10.20.0.17': '0'}} with 2026-10-02 05:00:01,998 - INFO - Initial checks done. Running the testcase now 2026-10-02 05:00:01,998 - INFO - 2026-10-02 05:00:01,998 - DEBUG - Requesting: http://10.0.0.190:8082/global-vrouter-configs 2026-10-02 05:00:02,007 - DEBUG - Requesting: http://10.0.0.190:8082/global-vrouter-config/73755bfe-8d19-459c-bb89-8a017c9ec213 2026-10-02 05:00:02,298 - DEBUG - Response for create_network : {'network': {'id': '5cc3a2bd-ab53-4cd9-9d28-69e329519216', 'name': 'ctest-vn-06599295', 'tenant_id': '852cfe2a95fb42c5ab4fb402502dc0fb', 'project_id': '852cfe2a95fb42c5ab4fb402502dc0fb', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-37638013', 'ctest-vn-06599295'], 'port_security_enabled': True, 'description': ''}} 2026-10-02 05:00:02,513 - DEBUG - Response for create_subnet : {'subnet': {'id': '73dbf17b-880a-4bae-afb8-80fece5c0a9f', 'name': '', 'tenant_id': '852cfe2a95fb42c5ab4fb402502dc0fb', 'network_id': '5cc3a2bd-ab53-4cd9-9d28-69e329519216', 'ip_version': 4, 'cidr': '97.233.36.0/26', 'allocation_pools': [{'start': '97.233.36.2', 'end': '97.233.36.62'}], 'gateway_ip': '97.233.36.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '97.233.36.2', 'tags': [], 'project_id': '852cfe2a95fb42c5ab4fb402502dc0fb'}} 2026-10-02 05:00:02,539 - INFO - Created VN ctest-vn-06599295 2026-10-02 05:00:02,600 - DEBUG - VN ctest-vn-06599295 UUID is 5cc3a2bd-ab53-4cd9-9d28-69e329519216 2026-10-02 05:00:03,202 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6338-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6338-1) 2026-10-02 05:00:03,202 - INFO - Waiting for VM ctest-TestBasicVMVN-37638013-67483267 to be up.. 2026-10-02 05:00:03,252 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 05:00:08,355 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 05:00:13,456 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 05:00:18,555 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 05:00:23,671 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 05:00:28,876 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 05:00:33,971 - DEBUG - VM is in ACTIVE state now 2026-10-02 05:00:33,971 - INFO - VM name : ctest-TestBasicVMVN-37638013-67483267 2026-10-02 05:00:34,070 - DEBUG - VM ctest-TestBasicVMVN-37638013-67483267 ID is 3f347288-56a2-4dd0-813e-359faacd1a90 2026-10-02 05:00:34,070 - DEBUG - VM ctest-TestBasicVMVN-37638013-67483267 launched on Node cn-jenkins-deploy-platform-ansible-os-6338-1 2026-10-02 05:00:34,160 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine/3f347288-56a2-4dd0-813e-359faacd1a90 2026-10-02 05:00:34,172 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine-interface/4672045d-56ee-4a48-a6ec-a191526ad7f9 2026-10-02 05:00:37,467 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1028ms') 2026-10-02 05:00:37,467 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-37638013-67483267 failed! 2026-10-02 05:00:37,524 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-37638013:ctest-vn-06599295 is 97.233.36.1 and allocation pool is NOT set 2026-10-02 05:00:39,596 - 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.05 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.573 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.573/4.811/9.050/4.238 ms') 2026-10-02 05:00:39,597 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-37638013-67483267 passed 2026-10-02 05:00:39,762 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-10-02 05:00:39,763 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-37638013-67483267, IP 97.233.36.3, Port 22 2026-10-02 05:00:39,955 - DEBUG - VM ctest-TestBasicVMVN-37638013-67483267 is ready for SSH connections 2026-10-02 05:00:39,955 - DEBUG - Running remote_cmd, Cmd : cat /tmp/output.txt, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.190, gateway password: c0ntrail123 2026-10-02 05:00:39,955 - DEBUG - cat /tmp/output.txt 2026-10-02 05:00:42,038 - DEBUG - Hello World. The time is now Thu, 01 Oct 2026 23:00:37 -0600! 2026-10-02 05:00:42,038 - DEBUG - ret : {'cat /tmp/output.txt': 'Hello World. The time is now Thu, 01 Oct 2026 23:00:37 -0600!'} 2026-10-02 05:00:42,038 - INFO - metadata_script.txt got executed in the vm 2026-10-02 05:00:42,038 - INFO - Deleting VM ctest-TestBasicVMVN-37638013-67483267 2026-10-02 05:00:42,127 - INFO - Deleting VN ctest-vn-06599295 2026-10-02 05:00:42,167 - DEBUG - VN 5cc3a2bd-ab53-4cd9-9d28-69e329519216 still in use: Unable to complete operation on network 5cc3a2bd-ab53-4cd9-9d28-69e329519216. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-40dbef2a-d3d3-4cd6-acc3-88e3d6848f7f'] 2026-10-02 05:00:42,168 - WARNING - Deleting VN ctest-vn-06599295 failed..Will retry 2026-10-02 05:00:44,225 - DEBUG - VN 5cc3a2bd-ab53-4cd9-9d28-69e329519216 still in use: Unable to complete operation on network 5cc3a2bd-ab53-4cd9-9d28-69e329519216. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-407bf014-b20a-4ab9-93b0-fbe66d0e2d6a'] 2026-10-02 05:00:44,225 - WARNING - Deleting VN ctest-vn-06599295 failed..Will retry 2026-10-02 05:00:46,414 - DEBUG - Response for deleting network () 2026-10-02 05:00:46,689 - DEBUG - No XMPP flaps were noticed during the test
2026-10-02 05:00:46,690 - INFO - END TEST : test_metadata_service : PASSED[0:00:45]
2026-10-02 05:00:46,690 - INFO - -------------------------------------------------------------------------------- 2026-10-02 05:00:46,693 - INFO - ================================================================================ 2026-10-02 05:00:46,693 - INFO - STARTING TEST : test_ping_within_vn_two_vms_two_different_subnets 2026-10-02 05:00:46,693 - 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 2026-10-02 05:00:46,989 - DEBUG - Nothing to compare xmpp stats {'10.0.0.190': {'10.20.0.17': '0'}} with 2026-10-02 05:00:46,989 - INFO - Initial checks done. Running the testcase now 2026-10-02 05:00:46,989 - INFO - 2026-10-02 05:00:47,552 - DEBUG - Response for create_network : {'network': {'id': '5981833d-0d84-4356-b35c-e72f46c414c6', 'name': 'ctest-vn-75365147', 'tenant_id': '852cfe2a95fb42c5ab4fb402502dc0fb', 'project_id': '852cfe2a95fb42c5ab4fb402502dc0fb', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-37638013', 'ctest-vn-75365147'], 'port_security_enabled': True, 'description': ''}} 2026-10-02 05:00:47,742 - DEBUG - Response for create_subnet : {'subnet': {'id': '03623c5f-b479-4e80-9e96-a67e14c2f127', 'name': '', 'tenant_id': '852cfe2a95fb42c5ab4fb402502dc0fb', 'network_id': '5981833d-0d84-4356-b35c-e72f46c414c6', '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': '852cfe2a95fb42c5ab4fb402502dc0fb'}} 2026-10-02 05:00:47,935 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e239620e-d75e-4ba7-b8e2-b74080116af0', 'name': '', 'tenant_id': '852cfe2a95fb42c5ab4fb402502dc0fb', 'network_id': '5981833d-0d84-4356-b35c-e72f46c414c6', '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': '852cfe2a95fb42c5ab4fb402502dc0fb'}} 2026-10-02 05:00:47,963 - INFO - Created VN ctest-vn-75365147 2026-10-02 05:00:48,020 - DEBUG - VN ctest-vn-75365147 UUID is 5981833d-0d84-4356-b35c-e72f46c414c6 2026-10-02 05:00:48,480 - DEBUG - Response for create_port : {'port': {'name': '62bf75d6-1219-45b3-9d6f-9751a394920d', 'id': '62bf75d6-1219-45b3-9d6f-9751a394920d', 'tenant_id': '852cfe2a95fb42c5ab4fb402502dc0fb', 'network_id': '5981833d-0d84-4356-b35c-e72f46c414c6', 'mac_address': '02:62:bf:75:d6:12', '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': '03623c5f-b479-4e80-9e96-a67e14c2f127'}], 'security_groups': ['8d11c5b8-a65b-459b-b3e0-081af78ba7ed'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'tags': [], 'port_security_enabled': True, 'description': '', 'project_id': '852cfe2a95fb42c5ab4fb402502dc0fb'}} 2026-10-02 05:00:48,728 - DEBUG - Response for create_port : {'port': {'name': '03fb1887-c0c3-4866-81f2-e685bb9cde75', 'id': '03fb1887-c0c3-4866-81f2-e685bb9cde75', 'tenant_id': '852cfe2a95fb42c5ab4fb402502dc0fb', 'network_id': '5981833d-0d84-4356-b35c-e72f46c414c6', 'mac_address': '02:03:fb:18:87:c0', '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': 'e239620e-d75e-4ba7-b8e2-b74080116af0'}], 'security_groups': ['8d11c5b8-a65b-459b-b3e0-081af78ba7ed'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'tags': [], 'port_security_enabled': True, 'description': '', 'project_id': '852cfe2a95fb42c5ab4fb402502dc0fb'}} 2026-10-02 05:00:49,199 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6338-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6338-1) 2026-10-02 05:00:49,701 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6338-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6338-1) 2026-10-02 05:00:50,231 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6338-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6338-1) 2026-10-02 05:00:50,232 - DEBUG - Requesting: http://10.0.0.190:8082/domains 2026-10-02 05:00:50,240 - DEBUG - Requesting: http://10.0.0.190:8082/domain/6894662b-5702-4df9-a206-4bbbf4ca6688 2026-10-02 05:00:50,257 - DEBUG - Requesting: http://10.0.0.190:8082/project/852cfe2a-95fb-42c5-ab4f-b402502dc0fb 2026-10-02 05:00:50,344 - DEBUG - Requesting: http://10.0.0.190:8082/network-ipam/937bc9ae-bbd5-490a-bc7a-6def4a939e99 2026-10-02 05:00:50,359 - INFO - Verifications in API Server for IPAM: ctest-ipam-35460477 passed 2026-10-02 05:00:50,367 - DEBUG - Control-node 10.0.0.190 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestBasicVMVN-37638013:ctest-ipam-35460477', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN-37638013', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '10627309498023627018', 'uuid-lslong': '13581288500804951705'}, 'enable': 'true', 'created': '2026-10-02T05:00:47', 'last-modified': '2026-10-02T05:00:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.126088'} 2026-10-02 05:00:50,367 - INFO - Verifications in Control node for IPAM: ctest-ipam-35460477 passed 2026-10-02 05:00:50,367 - DEBUG - Requesting: http://10.0.0.190:8082/domains 2026-10-02 05:00:50,375 - DEBUG - Requesting: http://10.0.0.190:8082/domain/6894662b-5702-4df9-a206-4bbbf4ca6688 2026-10-02 05:00:50,392 - DEBUG - Requesting: http://10.0.0.190:8082/project/852cfe2a-95fb-42c5-ab4f-b402502dc0fb 2026-10-02 05:00:50,478 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-network/5981833d-0d84-4356-b35c-e72f46c414c6 2026-10-02 05:00:50,497 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-network/5981833d-0d84-4356-b35c-e72f46c414c6 2026-10-02 05:00:50,514 - DEBUG - Requesting: http://10.0.0.190:8082/routing-instance/2b8c41fb-faa8-404a-9763-de163767bb3f 2026-10-02 05:00:50,525 - DEBUG - Requesting: http://10.0.0.190:8082/routing-instance/2b8c41fb-faa8-404a-9763-de163767bb3f 2026-10-02 05:00:50,535 - DEBUG - Requesting: http://10.0.0.190:8082/route-target/41b8236a-626b-47a6-ba38-3b4aae64e716 2026-10-02 05:00:50,544 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-10-02 05:00:50,544 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-network/5981833d-0d84-4356-b35c-e72f46c414c6 2026-10-02 05:00:50,556 - DEBUG - Requesting: http://10.0.0.190:8082/routing-instance/2b8c41fb-faa8-404a-9763-de163767bb3f 2026-10-02 05:00:50,576 - INFO - Verified VN network id 12 for VN 5981833d-0d84-4356-b35c-e72f46c414c6 2026-10-02 05:00:50,577 - INFO - Verifications in API Server for VN ctest-vn-75365147 passed 2026-10-02 05:00:50,577 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-network/5981833d-0d84-4356-b35c-e72f46c414c6 2026-10-02 05:00:50,590 - DEBUG - Requesting: http://10.0.0.190:8082/routing-instance/2b8c41fb-faa8-404a-9763-de163767bb3f 2026-10-02 05:00:50,602 - DEBUG - Requesting: http://10.0.0.190:8082/routing-instance/2b8c41fb-faa8-404a-9763-de163767bb3f 2026-10-02 05:00:50,613 - DEBUG - Requesting: http://10.0.0.190:8082/route-target/41b8236a-626b-47a6-ba38-3b4aae64e716 2026-10-02 05:00:50,631 - DEBUG - Control-node 10.0.0.190 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicVMVN-37638013:ctest-vn-75365147', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN-37638013', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6449580439614276438', 'uuid-lslong': '12924459220883215558'}, 'enable': 'true', 'created': '2026-10-02T05:00:47', 'last-modified': '2026-10-02T05:00:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.741193'} 2026-10-02 05:00:50,641 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-10-02 05:00:50,641 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn-75365147 passed 2026-10-02 05:00:50,641 - DEBUG - ====Verifying policy data for ctest-vn-75365147 in API_Server ====== 2026-10-02 05:00:50,641 - DEBUG - Requesting: http://10.0.0.190:8082/domains 2026-10-02 05:00:50,649 - DEBUG - Requesting: http://10.0.0.190:8082/domain/6894662b-5702-4df9-a206-4bbbf4ca6688 2026-10-02 05:00:50,663 - DEBUG - Requesting: http://10.0.0.190:8082/project/852cfe2a-95fb-42c5-ab4f-b402502dc0fb 2026-10-02 05:00:50,753 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-network/5981833d-0d84-4356-b35c-e72f46c414c6 2026-10-02 05:00:50,769 - DEBUG - =>VN ctest-vn-75365147 has no policy to be verified 2026-10-02 05:00:50,769 - DEBUG - Verifying the vn in opserver 2026-10-02 05:00:50,769 - DEBUG - Verifying the default-domain:ctest-TestBasicVMVN-37638013:ctest-vn-75365147 virtual network link through opserver 10.0.0.190 2026-10-02 05:00:50,769 - DEBUG - Requesting: http://10.0.0.190:8081/analytics/uves/virtual-networks 2026-10-02 05:00:51,155 - DEBUG - Requesting: http://10.0.0.190:8081/analytics/uves/virtual-networks 2026-10-02 05:00:51,220 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicVMVN-37638013:ctest-vn-75365147', 'href': 'http://10.0.0.190:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicVMVN-37638013:ctest-vn-75365147?flat'} 2026-10-02 05:00:51,220 - INFO - Validated that VN default-domain:ctest-TestBasicVMVN-37638013:ctest-vn-75365147 is found in opserver 2026-10-02 05:00:51,236 - DEBUG - Do not have enough data to verify VN in agent 2026-10-02 05:00:51,243 - DEBUG - VRF ids for VN ctest-vn-75365147: {} 2026-10-02 05:00:51,243 - INFO - Waiting for VM ctest-TestBasicVMVN-37638013-48468581 to be up.. 2026-10-02 05:00:51,308 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 05:00:56,406 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 05:01:01,500 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 05:01:06,605 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 05:01:11,713 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 05:01:16,808 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 05:01:21,901 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 05:01:27,002 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 05:01:32,101 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 05:01:37,204 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-10-02 05:01:42,315 - DEBUG - VM is in ACTIVE state now 2026-10-02 05:01:42,315 - INFO - VM name : ctest-TestBasicVMVN-37638013-48468581 2026-10-02 05:01:42,414 - DEBUG - VM ctest-TestBasicVMVN-37638013-48468581 ID is 2007ca95-5920-43d0-9d2c-dbd3b7de76fc 2026-10-02 05:01:42,415 - DEBUG - VM ctest-TestBasicVMVN-37638013-48468581 launched on Node cn-jenkins-deploy-platform-ansible-os-6338-1 2026-10-02 05:01:42,517 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine/2007ca95-5920-43d0-9d2c-dbd3b7de76fc 2026-10-02 05:01:42,527 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine-interface/62bf75d6-1219-45b3-9d6f-9751a394920d 2026-10-02 05:01:45,812 - 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 1031ms') 2026-10-02 05:01:45,812 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-37638013-48468581 failed! 2026-10-02 05:01:45,876 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-37638013:ctest-vn-75365147 is 31.1.1.1 and allocation pool is NOT set 2026-10-02 05:01:45,876 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-37638013:ctest-vn-75365147 is 31.1.2.1 and allocation pool is NOT set 2026-10-02 05:01:49,979 - 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=10.7 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1028ms\r\nrtt min/avg/max/mdev = 10.692/10.692/10.692/0.000 ms') 2026-10-02 05:01:49,979 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-37638013-48468581 passed 2026-10-02 05:01:50,136 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-10-02 05:01:50,136 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-37638013-48468581, IP 31.1.1.4, Port 22 2026-10-02 05:01:50,306 - DEBUG - VM ctest-TestBasicVMVN-37638013-48468581 is ready for SSH connections 2026-10-02 05:01:50,306 - INFO - Waiting for VM ctest-TestBasicVMVN-37638013-94451436 to be up.. 2026-10-02 05:01:50,404 - DEBUG - VM is in ACTIVE state now 2026-10-02 05:01:50,404 - INFO - VM name : ctest-TestBasicVMVN-37638013-94451436 2026-10-02 05:01:50,503 - DEBUG - VM ctest-TestBasicVMVN-37638013-94451436 ID is f73867ab-e8cc-412f-8791-2b8656024174 2026-10-02 05:01:50,503 - DEBUG - VM ctest-TestBasicVMVN-37638013-94451436 launched on Node cn-jenkins-deploy-platform-ansible-os-6338-1 2026-10-02 05:01:50,601 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine/f73867ab-e8cc-412f-8791-2b8656024174 2026-10-02 05:01:50,615 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine-interface/03fb1887-c0c3-4866-81f2-e685bb9cde75 2026-10-02 05:01:53,911 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1032ms') 2026-10-02 05:01:53,911 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBasicVMVN-37638013-94451436 failed! 2026-10-02 05:01:53,972 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-37638013:ctest-vn-75365147 is 31.1.1.1 and allocation pool is NOT set 2026-10-02 05:01:53,972 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-37638013:ctest-vn-75365147 is 31.1.2.1 and allocation pool is NOT set 2026-10-02 05:01:56,048 - 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=6.37 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.864 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.864/3.617/6.371/2.753 ms') 2026-10-02 05:01:56,048 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBasicVMVN-37638013-94451436 passed 2026-10-02 05:01:56,204 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-10-02 05:01:56,204 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-37638013-94451436, IP 31.1.2.4, Port 22 2026-10-02 05:01:56,270 - DEBUG - Error on ssh to cirros@169.254.0.4:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.4/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.4/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.4/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-10-02 05:01:56,361 - DEBUG - VM ctest-TestBasicVMVN-37638013-94451436 is NOT ready for SSH connections, VM status: ACTIVE 2026-10-02 05:02:01,362 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-10-02 05:02:01,362 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-37638013-94451436, IP 31.1.2.4, Port 22 2026-10-02 05:02:01,538 - DEBUG - VM ctest-TestBasicVMVN-37638013-94451436 is ready for SSH connections 2026-10-02 05:02:01,538 - INFO - Waiting for VM ctest-TestBasicVMVN-37638013-22919464 to be up.. 2026-10-02 05:02:01,646 - DEBUG - VM is in ACTIVE state now 2026-10-02 05:02:01,646 - INFO - VM name : ctest-TestBasicVMVN-37638013-22919464 2026-10-02 05:02:01,757 - DEBUG - VM ctest-TestBasicVMVN-37638013-22919464 ID is 83c2c298-7625-4a35-a11b-58974be1ff75 2026-10-02 05:02:01,757 - DEBUG - VM ctest-TestBasicVMVN-37638013-22919464 launched on Node cn-jenkins-deploy-platform-ansible-os-6338-1 2026-10-02 05:02:01,859 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine/83c2c298-7625-4a35-a11b-58974be1ff75 2026-10-02 05:02:01,873 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine-interface/2b34d3fa-904f-41dc-a788-ca3537eaa037 2026-10-02 05:02:03,129 - 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.45 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.573 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.573/2.510/4.447/1.937 ms') 2026-10-02 05:02:03,129 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-37638013-22919464 passed 2026-10-02 05:02:03,284 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-10-02 05:02:03,285 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-37638013-22919464, IP 31.1.1.3, Port 22 2026-10-02 05:02:03,459 - DEBUG - VM ctest-TestBasicVMVN-37638013-22919464 is ready for SSH connections 2026-10-02 05:02:03,459 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-10-02 05:02:03,459 - 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.190, gateway password: c0ntrail123 2026-10-02 05:02:03,459 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4 2026-10-02 05:02:07,725 - 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.782 ms 64 bytes from 31.1.2.4: seq=1 ttl=63 time=1.192 ms 64 bytes from 31.1.2.4: seq=2 ttl=63 time=1.237 ms --- 31.1.2.4 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.192/2.403/4.782 ms 2026-10-02 05:02:07,725 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-37638013-48468581 passed 2026-10-02 05:02:07,725 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-10-02 05:02:07,725 - 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.190, gateway password: c0ntrail123 2026-10-02 05:02:07,725 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4 2026-10-02 05:02:11,429 - 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.691 ms 64 bytes from 31.1.1.4: seq=1 ttl=63 time=1.133 ms 64 bytes from 31.1.1.4: seq=2 ttl=63 time=1.356 ms --- 31.1.1.4 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.133/2.393/4.691 ms 2026-10-02 05:02:11,429 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-37638013-94451436 passed 2026-10-02 05:02:11,429 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-10-02 05:02:11,429 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-10-02 05:02:11,429 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-10-02 05:02:11,429 - 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.190, gateway password: c0ntrail123 2026-10-02 05:02:11,430 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts 2026-10-02 05:02:11,548 - DEBUG - None 2026-10-02 05:02:11,548 - 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.190, gateway password: c0ntrail123 2026-10-02 05:02:11,548 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts 2026-10-02 05:02:11,673 - DEBUG - None 2026-10-02 05:02:11,673 - 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.190, gateway password: c0ntrail123 2026-10-02 05:02:11,674 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts 2026-10-02 05:02:13,325 - DEBUG - None 2026-10-02 05:02:13,325 - 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.190, gateway password: c0ntrail123 2026-10-02 05:02:13,325 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7 2026-10-02 05:02:15,464 - 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.383 ms 64 bytes from 31.1.1.3: seq=0 ttl=64 time=5.589 ms (DUP!) 64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.539 ms 64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.277 ms (DUP!) 64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.655 ms --- 31.1.1.7 ping statistics --- 3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss round-trip min/avg/max = 0.539/2.288/5.589 ms 2026-10-02 05:02:15,464 - 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.190, gateway password: c0ntrail123 2026-10-02 05:02:15,464 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1 2026-10-02 05:02:17,647 - 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.203 ms 64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.132 ms (DUP!) 64 bytes from 31.1.1.3: seq=0 ttl=64 time=4.674 ms (DUP!) 64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.395 ms 64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.476 ms (DUP!) 64 bytes from 31.1.2.4: seq=1 ttl=63 time=3.946 ms (DUP!) 64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.462 ms --- 224.0.0.1 ping statistics --- 3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss round-trip min/avg/max = 0.395/2.326/4.674 ms 2026-10-02 05:02:17,648 - 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.190, gateway password: c0ntrail123 2026-10-02 05:02:17,648 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255 2026-10-02 05:02:19,832 - 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=2.069 ms 64 bytes from 31.1.1.3: seq=0 ttl=64 time=3.726 ms (DUP!) 64 bytes from 31.1.2.4: seq=0 ttl=63 time=5.015 ms (DUP!) 64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.922 ms 64 bytes from 31.1.2.4: seq=1 ttl=63 time=3.269 ms (DUP!) 64 bytes from 31.1.1.3: seq=1 ttl=64 time=4.414 ms (DUP!) 64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.447 ms --- 255.255.255.255 ping statistics --- 3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss round-trip min/avg/max = 0.447/2.837/5.015 ms 2026-10-02 05:02:19,832 - INFO - Deleting VM ctest-TestBasicVMVN-37638013-22919464 2026-10-02 05:02:19,934 - INFO - Detaching port 03fb1887-c0c3-4866-81f2-e685bb9cde75 from VM ctest-TestBasicVMVN-37638013-94451436 2026-10-02 05:02:19,984 - INFO - Deleting VM ctest-TestBasicVMVN-37638013-94451436 2026-10-02 05:02:20,077 - INFO - Detaching port 62bf75d6-1219-45b3-9d6f-9751a394920d from VM ctest-TestBasicVMVN-37638013-48468581 2026-10-02 05:02:20,120 - INFO - Deleting VM ctest-TestBasicVMVN-37638013-48468581 2026-10-02 05:02:20,221 - INFO - Deleting VN ctest-vn-75365147 2026-10-02 05:02:20,440 - DEBUG - Response for delete_port : () 2026-10-02 05:02:20,726 - DEBUG - Response for delete_port : () 2026-10-02 05:02:20,782 - DEBUG - VN 5981833d-0d84-4356-b35c-e72f46c414c6 still in use: Unable to complete operation on network 5981833d-0d84-4356-b35c-e72f46c414c6. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-2116f1fd-daf9-4bb0-9ab5-71caebc2a69d'] 2026-10-02 05:02:20,782 - WARNING - Deleting VN ctest-vn-75365147 failed..Will retry 2026-10-02 05:02:22,941 - DEBUG - Response for deleting network () 2026-10-02 05:02:22,942 - DEBUG - Requesting: http://10.0.0.190:8082/routing-instance/2b8c41fb-faa8-404a-9763-de163767bb3f 2026-10-02 05:02:22,953 - DEBUG - Response Code: 404 2026-10-02 05:02:22,953 - DEBUG - Requesting: http://10.0.0.190:8082/domains 2026-10-02 05:02:22,963 - DEBUG - Requesting: http://10.0.0.190:8082/domain/6894662b-5702-4df9-a206-4bbbf4ca6688 2026-10-02 05:02:23,023 - DEBUG - Requesting: http://10.0.0.190:8082/project/852cfe2a-95fb-42c5-ab4f-b402502dc0fb 2026-10-02 05:02:23,105 - INFO - Validated that VN ctest-vn-75365147 is not found in API Server 2026-10-02 05:02:23,121 - DEBUG - VN ctest-vn-75365147 is not present in Agent 10.0.0.190 2026-10-02 05:02:23,122 - INFO - Validated that VN ctest-vn-75365147 is not in any agent 2026-10-02 05:02:23,141 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-75365147 info 2026-10-02 05:02:23,224 - INFO - IPAM: ctest-ipam-35460477 is not found in API Server 2026-10-02 05:02:23,238 - INFO - IPAM:ctest-ipam-35460477 is not found in control node 2026-10-02 05:02:23,514 - DEBUG - No XMPP flaps were noticed during the test
2026-10-02 05:02:23,514 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:01:37]
2026-10-02 05:02:23,514 - INFO - -------------------------------------------------------------------------------- 2026-10-02 05:02:24,407 - INFO - Deleted project: ctest-TestBasicVMVN-37638013, ID : 852cfe2a-95fb-42c5-ab4f-b402502dc0fb