2026-10-23 14:30:01,512 - INFO - Domain Default found not creating
2026-10-23 14:30:01,842 - INFO - Project ctest-TestBasicVMVN-70578934 not found, creating it
2026-10-23 14:30:02,474 - INFO - Created Project:ctest-TestBasicVMVN-70578934, ID : f90c5d3e-7ef4-490d-82fa-8e4024f9435f
2026-10-23 14:30:04,578 - INFO - ================================================================================
2026-10-23 14:30:04,578 - INFO - STARTING TEST : test_generic_link_local_service
2026-10-23 14:30:04,578 - 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-23 14:30:04,855 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.25': '0'}} with
2026-10-23 14:30:04,855 - INFO - Initial checks done. Running the testcase now
2026-10-23 14:30:04,856 - INFO -
2026-10-23 14:30:05,605 - DEBUG - Response for create_network : {'network': {'id': '8da55ef9-dbba-429a-9c96-c3bc5f6ccbc0', 'name': 'ctest-vn2_metadata-88586000', 'tenant_id': 'f90c5d3e7ef4490d82fa8e4024f9435f', 'project_id': 'f90c5d3e7ef4490d82fa8e4024f9435f', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-70578934', 'ctest-vn2_metadata-88586000'], 'port_security_enabled': True, 'description': ''}}
2026-10-23 14:30:05,907 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd7a57590-ec5e-45bd-a6af-c35d1e16c203', 'name': '', 'tenant_id': 'f90c5d3e7ef4490d82fa8e4024f9435f', 'network_id': '8da55ef9-dbba-429a-9c96-c3bc5f6ccbc0', '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': 'f90c5d3e7ef4490d82fa8e4024f9435f'}}
2026-10-23 14:30:05,931 - INFO - Created VN ctest-vn2_metadata-88586000
2026-10-23 14:30:05,986 - DEBUG - VN ctest-vn2_metadata-88586000 UUID is 8da55ef9-dbba-429a-9c96-c3bc5f6ccbc0
2026-10-23 14:30:06,219 - DEBUG - Services list from nova: [, , ]
2026-10-23 14:30:06,726 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6396-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6396-1)
2026-10-23 14:30:06,841 - DEBUG - Link local service introspect added
2026-10-23 14:30:06,893 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:30:12,007 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:30:17,150 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:30:22,286 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:30:27,387 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:30:32,483 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:30:37,608 - DEBUG - VM is in ACTIVE state now
2026-10-23 14:30:37,798 - INFO - Waiting for VM ctest-TestBasicVMVN-70578934-00987865 to be up..
2026-10-23 14:30:37,798 - INFO - VM name : ctest-TestBasicVMVN-70578934-00987865
2026-10-23 14:30:37,914 - DEBUG - VM ctest-TestBasicVMVN-70578934-00987865 ID is 2e065331-1967-4120-81df-66da43aef61e
2026-10-23 14:30:37,914 - DEBUG - VM ctest-TestBasicVMVN-70578934-00987865 launched on Node cn-jenkins-deploy-platform-ansible-os-6396-1
2026-10-23 14:30:38,018 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/2e065331-1967-4120-81df-66da43aef61e
2026-10-23 14:30:38,404 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/2e065331-1967-4120-81df-66da43aef61e
2026-10-23 14:30:38,453 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/6e59ad11-0f96-4a11-93da-5d2237adbcb1
2026-10-23 14:30:41,724 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1004ms')
2026-10-23 14:30:41,724 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-70578934-00987865 failed!
2026-10-23 14:30:41,786 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-70578934:ctest-vn2_metadata-88586000 is 11.1.1.1 and allocation pool is NOT set
2026-10-23 14:30:45,886 - 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-23 14:30:45,886 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-70578934-00987865 failed!
2026-10-23 14:30:45,954 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-70578934:ctest-vn2_metadata-88586000 is 11.1.1.1 and allocation pool is NOT set
2026-10-23 14:30:48,021 - 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.28 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.45 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.448/4.363/7.278/2.915 ms')
2026-10-23 14:30:48,021 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-70578934-00987865 passed
2026-10-23 14:30:48,182 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-10-23 14:30:48,182 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-70578934-00987865, IP 11.1.1.3, Port 22
2026-10-23 14:30:48,356 - DEBUG - VM ctest-TestBasicVMVN-70578934-00987865 is ready for SSH connections
2026-10-23 14:30:48,356 - INFO - Retry 0
2026-10-23 14:30:48,356 - 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
2026-10-23 14:30:48,356 - DEBUG - wget http://169.254.1.2:8083 --spider && echo "Successful"
2026-10-23 14:30:50,182 - DEBUG - Connecting to 169.254.1.2:8083 (169.254.1.2:8083)
Successful
2026-10-23 14:30:50,182 - INFO - Generic metadata worked
2026-10-23 14:30:50,481 - DEBUG - Link local service introspect removed
2026-10-23 14:30:50,481 - INFO - Deleting VM ctest-TestBasicVMVN-70578934-00987865
2026-10-23 14:30:50,620 - INFO - Deleting VN ctest-vn2_metadata-88586000
2026-10-23 14:30:50,671 - DEBUG - VN 8da55ef9-dbba-429a-9c96-c3bc5f6ccbc0 still in use: Unable to complete operation on network 8da55ef9-dbba-429a-9c96-c3bc5f6ccbc0. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-b1b0309a-d3c4-4635-b10a-2989354b9c9a']
2026-10-23 14:30:50,671 - WARNING - Deleting VN ctest-vn2_metadata-88586000 failed..Will retry
2026-10-23 14:30:52,760 - DEBUG - VN 8da55ef9-dbba-429a-9c96-c3bc5f6ccbc0 still in use: Unable to complete operation on network 8da55ef9-dbba-429a-9c96-c3bc5f6ccbc0. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-0a0ee907-2e58-4891-af10-e340da62febf']
2026-10-23 14:30:52,760 - WARNING - Deleting VN ctest-vn2_metadata-88586000 failed..Will retry
2026-10-23 14:30:54,920 - DEBUG - Response for deleting network ()
2026-10-23 14:30:55,210 - DEBUG - No XMPP flaps were noticed during the test
2026-10-23 14:30:55,210 - INFO - END TEST : test_generic_link_local_service : PASSED[0:00:51]
2026-10-23 14:30:55,211 - INFO - --------------------------------------------------------------------------------
2026-10-23 14:30:55,215 - INFO - ================================================================================
2026-10-23 14:30:55,215 - INFO - STARTING TEST : test_metadata_service
2026-10-23 14:30:55,215 - 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-23 14:30:55,530 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.25': '0'}} with
2026-10-23 14:30:55,531 - INFO - Initial checks done. Running the testcase now
2026-10-23 14:30:55,531 - INFO -
2026-10-23 14:30:55,531 - DEBUG - Requesting: http://10.0.0.38:8082/global-vrouter-configs
2026-10-23 14:30:55,540 - DEBUG - Requesting: http://10.0.0.38:8082/global-vrouter-config/c5e8b0bb-2c82-4295-af1f-fcce94d73c20
2026-10-23 14:30:55,833 - DEBUG - Response for create_network : {'network': {'id': 'a2b2fdd4-0d90-4b09-bde8-3da8fa7ec4b9', 'name': 'ctest-vn-00799518', 'tenant_id': 'f90c5d3e7ef4490d82fa8e4024f9435f', 'project_id': 'f90c5d3e7ef4490d82fa8e4024f9435f', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-70578934', 'ctest-vn-00799518'], 'port_security_enabled': True, 'description': ''}}
2026-10-23 14:30:56,060 - DEBUG - Response for create_subnet : {'subnet': {'id': '971698ed-c64b-4531-b446-747b0adeda5d', 'name': '', 'tenant_id': 'f90c5d3e7ef4490d82fa8e4024f9435f', 'network_id': 'a2b2fdd4-0d90-4b09-bde8-3da8fa7ec4b9', 'ip_version': 4, 'cidr': '195.242.221.192/26', 'allocation_pools': [{'start': '195.242.221.194', 'end': '195.242.221.254'}], 'gateway_ip': '195.242.221.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '195.242.221.194', 'tags': [], 'project_id': 'f90c5d3e7ef4490d82fa8e4024f9435f'}}
2026-10-23 14:30:56,089 - INFO - Created VN ctest-vn-00799518
2026-10-23 14:30:56,147 - DEBUG - VN ctest-vn-00799518 UUID is a2b2fdd4-0d90-4b09-bde8-3da8fa7ec4b9
2026-10-23 14:30:57,027 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6396-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6396-1)
2026-10-23 14:30:57,028 - INFO - Waiting for VM ctest-TestBasicVMVN-70578934-98236677 to be up..
2026-10-23 14:30:57,082 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:31:02,181 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:31:07,285 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:31:12,404 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:31:17,518 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:31:22,642 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:31:27,756 - DEBUG - VM is in ACTIVE state now
2026-10-23 14:31:27,756 - INFO - VM name : ctest-TestBasicVMVN-70578934-98236677
2026-10-23 14:31:27,868 - DEBUG - VM ctest-TestBasicVMVN-70578934-98236677 ID is 35809d5d-5ccd-48ca-8d77-3d59a4d4d815
2026-10-23 14:31:27,869 - DEBUG - VM ctest-TestBasicVMVN-70578934-98236677 launched on Node cn-jenkins-deploy-platform-ansible-os-6396-1
2026-10-23 14:31:27,966 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/35809d5d-5ccd-48ca-8d77-3d59a4d4d815
2026-10-23 14:31:27,978 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/6b0a235d-bfc6-41df-b765-f4dc5e8f162e
2026-10-23 14:31:31,266 - 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 1017ms')
2026-10-23 14:31:31,266 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-70578934-98236677 failed!
2026-10-23 14:31:31,326 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-70578934:ctest-vn-00799518 is 195.242.221.193 and allocation pool is NOT set
2026-10-23 14:31:35,422 - 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 1025ms')
2026-10-23 14:31:35,422 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-70578934-98236677 failed!
2026-10-23 14:31:35,486 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-70578934:ctest-vn-00799518 is 195.242.221.193 and allocation pool is NOT set
2026-10-23 14:31:37,557 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=5.09 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.716 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.716/2.901/5.086/2.185 ms')
2026-10-23 14:31:37,557 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-70578934-98236677 passed
2026-10-23 14:31:37,722 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-10-23 14:31:37,722 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-70578934-98236677, IP 195.242.221.195, Port 22
2026-10-23 14:31:37,896 - DEBUG - VM ctest-TestBasicVMVN-70578934-98236677 is ready for SSH connections
2026-10-23 14:31:37,897 - 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
2026-10-23 14:31:37,897 - DEBUG - cat /tmp/output.txt
2026-10-23 14:31:40,376 - DEBUG - Hello World. The time is now Fri, 23 Oct 2026 08:31:35 -0600!
2026-10-23 14:31:40,376 - DEBUG - ret : {'cat /tmp/output.txt': 'Hello World. The time is now Fri, 23 Oct 2026 08:31:35 -0600!'}
2026-10-23 14:31:40,376 - INFO - metadata_script.txt got executed in the vm
2026-10-23 14:31:40,376 - INFO - Deleting VM ctest-TestBasicVMVN-70578934-98236677
2026-10-23 14:31:40,503 - INFO - Deleting VN ctest-vn-00799518
2026-10-23 14:31:40,551 - DEBUG - VN a2b2fdd4-0d90-4b09-bde8-3da8fa7ec4b9 still in use: Unable to complete operation on network a2b2fdd4-0d90-4b09-bde8-3da8fa7ec4b9. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-c31c4e71-1d30-4a5c-bf35-b51d7a7fae4e']
2026-10-23 14:31:40,551 - WARNING - Deleting VN ctest-vn-00799518 failed..Will retry
2026-10-23 14:31:42,600 - DEBUG - VN a2b2fdd4-0d90-4b09-bde8-3da8fa7ec4b9 still in use: Unable to complete operation on network a2b2fdd4-0d90-4b09-bde8-3da8fa7ec4b9. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-742baa6a-b331-4b66-9b18-71479142a902']
2026-10-23 14:31:42,600 - WARNING - Deleting VN ctest-vn-00799518 failed..Will retry
2026-10-23 14:31:44,743 - DEBUG - Response for deleting network ()
2026-10-23 14:31:45,027 - DEBUG - No XMPP flaps were noticed during the test
2026-10-23 14:31:45,027 - INFO - END TEST : test_metadata_service : PASSED[0:00:50]
2026-10-23 14:31:45,027 - INFO - --------------------------------------------------------------------------------
2026-10-23 14:31:45,029 - INFO - ================================================================================
2026-10-23 14:31:45,029 - INFO - STARTING TEST : test_ping_within_vn_two_vms_two_different_subnets
2026-10-23 14:31:45,030 - 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-23 14:31:45,323 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.25': '0'}} with
2026-10-23 14:31:45,323 - INFO - Initial checks done. Running the testcase now
2026-10-23 14:31:45,323 - INFO -
2026-10-23 14:31:45,900 - DEBUG - Response for create_network : {'network': {'id': '1cb20c83-1815-4c78-a7b0-a715b0e9bd3b', 'name': 'ctest-vn-79634325', 'tenant_id': 'f90c5d3e7ef4490d82fa8e4024f9435f', 'project_id': 'f90c5d3e7ef4490d82fa8e4024f9435f', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-70578934', 'ctest-vn-79634325'], 'port_security_enabled': True, 'description': ''}}
2026-10-23 14:31:46,112 - DEBUG - Response for create_subnet : {'subnet': {'id': '388e73a1-f550-4b43-b5c3-28392f753944', 'name': '', 'tenant_id': 'f90c5d3e7ef4490d82fa8e4024f9435f', 'network_id': '1cb20c83-1815-4c78-a7b0-a715b0e9bd3b', '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': 'f90c5d3e7ef4490d82fa8e4024f9435f'}}
2026-10-23 14:31:46,323 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c2432e3a-5e7c-4a65-98af-0bc78a0937af', 'name': '', 'tenant_id': 'f90c5d3e7ef4490d82fa8e4024f9435f', 'network_id': '1cb20c83-1815-4c78-a7b0-a715b0e9bd3b', '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': 'f90c5d3e7ef4490d82fa8e4024f9435f'}}
2026-10-23 14:31:46,356 - INFO - Created VN ctest-vn-79634325
2026-10-23 14:31:46,413 - DEBUG - VN ctest-vn-79634325 UUID is 1cb20c83-1815-4c78-a7b0-a715b0e9bd3b
2026-10-23 14:31:46,958 - DEBUG - Response for create_port : {'port': {'name': '9b47d1ee-b65c-4659-8411-06e0dc51e8b1', 'id': '9b47d1ee-b65c-4659-8411-06e0dc51e8b1', 'tenant_id': 'f90c5d3e7ef4490d82fa8e4024f9435f', 'network_id': '1cb20c83-1815-4c78-a7b0-a715b0e9bd3b', 'mac_address': '02:9b:47:d1:ee:b6', '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': '388e73a1-f550-4b43-b5c3-28392f753944'}], 'security_groups': ['7bc31abe-e353-407f-a1cc-0319e265aab9'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'tags': [], 'port_security_enabled': True, 'description': '', 'project_id': 'f90c5d3e7ef4490d82fa8e4024f9435f'}}
2026-10-23 14:31:47,260 - DEBUG - Response for create_port : {'port': {'name': '8a38781d-ea90-4e0a-ba5e-0a68fa4cbfc2', 'id': '8a38781d-ea90-4e0a-ba5e-0a68fa4cbfc2', 'tenant_id': 'f90c5d3e7ef4490d82fa8e4024f9435f', 'network_id': '1cb20c83-1815-4c78-a7b0-a715b0e9bd3b', 'mac_address': '02:8a:38:78:1d:ea', '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': 'c2432e3a-5e7c-4a65-98af-0bc78a0937af'}], 'security_groups': ['7bc31abe-e353-407f-a1cc-0319e265aab9'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'tags': [], 'port_security_enabled': True, 'description': '', 'project_id': 'f90c5d3e7ef4490d82fa8e4024f9435f'}}
2026-10-23 14:31:47,818 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6396-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6396-1)
2026-10-23 14:31:48,511 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6396-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6396-1)
2026-10-23 14:31:49,278 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6396-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6396-1)
2026-10-23 14:31:49,278 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-10-23 14:31:49,287 - DEBUG - Requesting: http://10.0.0.38:8082/domain/4189e7ba-60c7-4312-b19e-84ffbbe2755a
2026-10-23 14:31:49,311 - DEBUG - Requesting: http://10.0.0.38:8082/project/f90c5d3e-7ef4-490d-82fa-8e4024f9435f
2026-10-23 14:31:49,408 - DEBUG - Requesting: http://10.0.0.38:8082/network-ipam/2050db40-6e3c-4692-ae14-baf172a38d1c
2026-10-23 14:31:49,426 - INFO - Verifications in API Server for IPAM: ctest-ipam-11060195 passed
2026-10-23 14:31:49,442 - DEBUG - Control-node 10.0.0.38 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestBasicVMVN-70578934:ctest-ipam-11060195', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN-70578934', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2328602077124380306', 'uuid-lslong': '12543856408306879772'}, 'enable': 'true', 'created': '2026-10-23T14:31:45', 'last-modified': '2026-10-23T14:31:45', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.856353'}
2026-10-23 14:31:49,442 - INFO - Verifications in Control node for IPAM: ctest-ipam-11060195 passed
2026-10-23 14:31:49,442 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-10-23 14:31:49,454 - DEBUG - Requesting: http://10.0.0.38:8082/domain/4189e7ba-60c7-4312-b19e-84ffbbe2755a
2026-10-23 14:31:49,471 - DEBUG - Requesting: http://10.0.0.38:8082/project/f90c5d3e-7ef4-490d-82fa-8e4024f9435f
2026-10-23 14:31:49,559 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/1cb20c83-1815-4c78-a7b0-a715b0e9bd3b
2026-10-23 14:31:49,583 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/1cb20c83-1815-4c78-a7b0-a715b0e9bd3b
2026-10-23 14:31:49,600 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/3aa14dc6-1cef-4962-9154-f034fa3bafe6
2026-10-23 14:31:49,613 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/3aa14dc6-1cef-4962-9154-f034fa3bafe6
2026-10-23 14:31:49,626 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/3c26e4f9-4053-480a-bc6a-1fc2758e756e
2026-10-23 14:31:49,638 - DEBUG - Route Targets: ['target:64512:8000005']
2026-10-23 14:31:49,638 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/1cb20c83-1815-4c78-a7b0-a715b0e9bd3b
2026-10-23 14:31:49,655 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/3aa14dc6-1cef-4962-9154-f034fa3bafe6
2026-10-23 14:31:49,686 - INFO - Verified VN network id 11 for VN 1cb20c83-1815-4c78-a7b0-a715b0e9bd3b
2026-10-23 14:31:49,686 - INFO - Verifications in API Server for VN ctest-vn-79634325 passed
2026-10-23 14:31:49,686 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/1cb20c83-1815-4c78-a7b0-a715b0e9bd3b
2026-10-23 14:31:49,712 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/3aa14dc6-1cef-4962-9154-f034fa3bafe6
2026-10-23 14:31:49,734 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/3aa14dc6-1cef-4962-9154-f034fa3bafe6
2026-10-23 14:31:49,750 - DEBUG - Requesting: http://10.0.0.38:8082/route-target/3c26e4f9-4053-480a-bc6a-1fc2758e756e
2026-10-23 14:31:49,778 - DEBUG - Control-node 10.0.0.38 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicVMVN-70578934:ctest-vn-79634325', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN-70578934', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '2067728936100777080', 'uuid-lslong': '12083341511839300923'}, 'enable': 'true', 'created': '2026-10-23T14:31:45', 'last-modified': '2026-10-23T14:31:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.496861'}
2026-10-23 14:31:49,791 - DEBUG - Route Targets: ['target:64512:8000005']
2026-10-23 14:31:49,791 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn-79634325 passed
2026-10-23 14:31:49,791 - DEBUG - ====Verifying policy data for ctest-vn-79634325 in API_Server ======
2026-10-23 14:31:49,791 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-10-23 14:31:49,815 - DEBUG - Requesting: http://10.0.0.38:8082/domain/4189e7ba-60c7-4312-b19e-84ffbbe2755a
2026-10-23 14:31:49,833 - DEBUG - Requesting: http://10.0.0.38:8082/project/f90c5d3e-7ef4-490d-82fa-8e4024f9435f
2026-10-23 14:31:49,922 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-network/1cb20c83-1815-4c78-a7b0-a715b0e9bd3b
2026-10-23 14:31:49,935 - DEBUG - =>VN ctest-vn-79634325 has no policy to be verified
2026-10-23 14:31:49,935 - DEBUG - Verifying the vn in opserver
2026-10-23 14:31:49,935 - DEBUG - Verifying the default-domain:ctest-TestBasicVMVN-70578934:ctest-vn-79634325 virtual network link through opserver 10.0.0.38
2026-10-23 14:31:49,935 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-10-23 14:31:50,338 - DEBUG - Requesting: http://10.0.0.38:8081/analytics/uves/virtual-networks
2026-10-23 14:31:50,424 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicVMVN-70578934:ctest-vn-79634325', 'href': 'http://10.0.0.38:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicVMVN-70578934:ctest-vn-79634325?flat'}
2026-10-23 14:31:50,424 - INFO - Validated that VN default-domain:ctest-TestBasicVMVN-70578934:ctest-vn-79634325 is found in opserver
2026-10-23 14:31:50,441 - DEBUG - Do not have enough data to verify VN in agent
2026-10-23 14:31:50,450 - DEBUG - VRF ids for VN ctest-vn-79634325: {}
2026-10-23 14:31:50,450 - INFO - Waiting for VM ctest-TestBasicVMVN-70578934-48336205 to be up..
2026-10-23 14:31:50,535 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:31:55,658 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:32:00,784 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:32:05,888 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:32:11,011 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:32:16,127 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:32:21,230 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:32:26,342 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:32:31,440 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:32:36,534 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:32:41,653 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:32:46,789 - DEBUG - VM is in ACTIVE state now
2026-10-23 14:32:46,790 - INFO - VM name : ctest-TestBasicVMVN-70578934-48336205
2026-10-23 14:32:46,910 - DEBUG - VM ctest-TestBasicVMVN-70578934-48336205 ID is 81f9459c-49ca-445a-9c1e-90967c8d9153
2026-10-23 14:32:46,910 - DEBUG - VM ctest-TestBasicVMVN-70578934-48336205 launched on Node cn-jenkins-deploy-platform-ansible-os-6396-1
2026-10-23 14:32:47,022 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/81f9459c-49ca-445a-9c1e-90967c8d9153
2026-10-23 14:32:47,032 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/9b47d1ee-b65c-4659-8411-06e0dc51e8b1
2026-10-23 14:32:50,304 - 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 1002ms')
2026-10-23 14:32:50,305 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-70578934-48336205 failed!
2026-10-23 14:32:50,374 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-70578934:ctest-vn-79634325 is 31.1.1.1 and allocation pool is NOT set
2026-10-23 14:32:50,374 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-70578934:ctest-vn-79634325 is 31.1.2.1 and allocation pool is NOT set
2026-10-23 14:32:52,447 - 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.75 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.811 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.811/3.779/6.747/2.968 ms')
2026-10-23 14:32:52,447 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-70578934-48336205 passed
2026-10-23 14:32:52,610 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-10-23 14:32:52,610 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-70578934-48336205, IP 31.1.1.4, Port 22
2026-10-23 14:32:52,797 - DEBUG - VM ctest-TestBasicVMVN-70578934-48336205 is ready for SSH connections
2026-10-23 14:32:52,798 - INFO - Waiting for VM ctest-TestBasicVMVN-70578934-71081552 to be up..
2026-10-23 14:32:52,924 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-10-23 14:32:58,023 - DEBUG - VM is in ACTIVE state now
2026-10-23 14:32:58,023 - INFO - VM name : ctest-TestBasicVMVN-70578934-71081552
2026-10-23 14:32:58,115 - DEBUG - VM ctest-TestBasicVMVN-70578934-71081552 ID is 6c2c9797-1d67-4441-9fb2-74ecf120f86e
2026-10-23 14:32:58,115 - DEBUG - VM ctest-TestBasicVMVN-70578934-71081552 launched on Node cn-jenkins-deploy-platform-ansible-os-6396-1
2026-10-23 14:32:58,207 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/6c2c9797-1d67-4441-9fb2-74ecf120f86e
2026-10-23 14:32:58,219 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/8a38781d-ea90-4e0a-ba5e-0a68fa4cbfc2
2026-10-23 14:33:01,505 - 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 1020ms')
2026-10-23 14:33:01,506 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBasicVMVN-70578934-71081552 failed!
2026-10-23 14:33:01,566 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-70578934:ctest-vn-79634325 is 31.1.1.1 and allocation pool is NOT set
2026-10-23 14:33:01,566 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-70578934:ctest-vn-79634325 is 31.1.2.1 and allocation pool is NOT set
2026-10-23 14:33:05,662 - 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 1026ms')
2026-10-23 14:33:05,662 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBasicVMVN-70578934-71081552 failed!
2026-10-23 14:33:05,721 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-70578934:ctest-vn-79634325 is 31.1.1.1 and allocation pool is NOT set
2026-10-23 14:33:05,722 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-70578934:ctest-vn-79634325 is 31.1.2.1 and allocation pool is NOT set
2026-10-23 14:33:07,791 - 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=5.95 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.621 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.621/3.287/5.953/2.666 ms')
2026-10-23 14:33:07,791 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBasicVMVN-70578934-71081552 passed
2026-10-23 14:33:07,950 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-10-23 14:33:07,950 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-70578934-71081552, IP 31.1.2.4, Port 22
2026-10-23 14:33:08,120 - DEBUG - VM ctest-TestBasicVMVN-70578934-71081552 is ready for SSH connections
2026-10-23 14:33:08,120 - INFO - Waiting for VM ctest-TestBasicVMVN-70578934-45460546 to be up..
2026-10-23 14:33:08,227 - DEBUG - VM is in ACTIVE state now
2026-10-23 14:33:08,227 - INFO - VM name : ctest-TestBasicVMVN-70578934-45460546
2026-10-23 14:33:08,320 - DEBUG - VM ctest-TestBasicVMVN-70578934-45460546 ID is 3754d43a-1d1b-4713-a25b-5dce652221a3
2026-10-23 14:33:08,321 - DEBUG - VM ctest-TestBasicVMVN-70578934-45460546 launched on Node cn-jenkins-deploy-platform-ansible-os-6396-1
2026-10-23 14:33:08,417 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/3754d43a-1d1b-4713-a25b-5dce652221a3
2026-10-23 14:33:08,430 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/2d709a50-cdd3-4905-8d9e-ec8ccde752c8
2026-10-23 14:33:09,706 - 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=5.31 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.540 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.540/2.927/5.314/2.387 ms')
2026-10-23 14:33:09,707 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-70578934-45460546 passed
2026-10-23 14:33:09,866 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-10-23 14:33:09,866 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-70578934-45460546, IP 31.1.1.3, Port 22
2026-10-23 14:33:10,036 - DEBUG - VM ctest-TestBasicVMVN-70578934-45460546 is ready for SSH connections
2026-10-23 14:33:10,036 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-10-23 14:33:10,036 - 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
2026-10-23 14:33:10,036 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4
2026-10-23 14:33:14,708 - 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=6.855 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=1.376 ms
64 bytes from 31.1.2.4: seq=2 ttl=63 time=1.253 ms
--- 31.1.2.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.253/3.161/6.855 ms
2026-10-23 14:33:14,709 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-70578934-48336205 passed
2026-10-23 14:33:14,709 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-10-23 14:33:14,709 - 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
2026-10-23 14:33:14,709 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4
2026-10-23 14:33:18,609 - 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=5.211 ms
64 bytes from 31.1.1.4: seq=1 ttl=63 time=1.188 ms
64 bytes from 31.1.1.4: seq=2 ttl=63 time=1.638 ms
--- 31.1.1.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.188/2.679/5.211 ms
2026-10-23 14:33:18,610 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-70578934-71081552 passed
2026-10-23 14:33:18,610 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-10-23 14:33:18,610 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-10-23 14:33:18,610 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-10-23 14:33:18,610 - 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
2026-10-23 14:33:18,610 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2026-10-23 14:33:18,766 - DEBUG - None
2026-10-23 14:33:18,766 - 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
2026-10-23 14:33:18,766 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2026-10-23 14:33:18,897 - DEBUG - None
2026-10-23 14:33:18,897 - 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
2026-10-23 14:33:18,897 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2026-10-23 14:33:20,758 - DEBUG - None
2026-10-23 14:33:20,758 - 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
2026-10-23 14:33:20,758 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7
2026-10-23 14:33:22,958 - 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=3.359 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=8.429 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.716 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=3.053 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.710 ms
--- 31.1.1.7 ping statistics ---
3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss
round-trip min/avg/max = 0.710/3.253/8.429 ms
2026-10-23 14:33:22,959 - 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
2026-10-23 14:33:22,959 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1
2026-10-23 14:33:25,177 - 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=2.057 ms
64 bytes from 31.1.2.4: seq=0 ttl=63 time=5.522 ms (DUP!)
64 bytes from 31.1.1.3: seq=0 ttl=64 time=7.560 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.619 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=4.062 ms (DUP!)
64 bytes from 31.1.1.3: seq=1 ttl=64 time=4.392 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.807 ms
--- 224.0.0.1 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.619/3.574/7.560 ms
2026-10-23 14:33:25,178 - 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
2026-10-23 14:33:25,178 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255
2026-10-23 14:33:27,392 - 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.974 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=4.203 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=6.151 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.771 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=3.459 ms (DUP!)
64 bytes from 31.1.1.3: seq=1 ttl=64 time=6.288 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=1.063 ms
--- 255.255.255.255 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.771/3.272/6.288 ms
2026-10-23 14:33:27,393 - INFO - Deleting VM ctest-TestBasicVMVN-70578934-45460546
2026-10-23 14:33:27,510 - INFO - Detaching port 8a38781d-ea90-4e0a-ba5e-0a68fa4cbfc2 from VM ctest-TestBasicVMVN-70578934-71081552
2026-10-23 14:33:27,562 - INFO - Deleting VM ctest-TestBasicVMVN-70578934-71081552
2026-10-23 14:33:27,662 - INFO - Detaching port 9b47d1ee-b65c-4659-8411-06e0dc51e8b1 from VM ctest-TestBasicVMVN-70578934-48336205
2026-10-23 14:33:27,705 - INFO - Deleting VM ctest-TestBasicVMVN-70578934-48336205
2026-10-23 14:33:27,797 - INFO - Deleting VN ctest-vn-79634325
2026-10-23 14:33:28,050 - DEBUG - Response for delete_port : ()
2026-10-23 14:33:28,334 - DEBUG - Response for delete_port : ()
2026-10-23 14:33:28,396 - DEBUG - VN 1cb20c83-1815-4c78-a7b0-a715b0e9bd3b still in use: Unable to complete operation on network 1cb20c83-1815-4c78-a7b0-a715b0e9bd3b. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-7ce4653a-cc21-48db-b80b-091c29310a8e']
2026-10-23 14:33:28,396 - WARNING - Deleting VN ctest-vn-79634325 failed..Will retry
2026-10-23 14:33:30,580 - DEBUG - Response for deleting network ()
2026-10-23 14:33:30,580 - DEBUG - Requesting: http://10.0.0.38:8082/routing-instance/3aa14dc6-1cef-4962-9154-f034fa3bafe6
2026-10-23 14:33:30,588 - DEBUG - Response Code: 404
2026-10-23 14:33:30,588 - DEBUG - Requesting: http://10.0.0.38:8082/domains
2026-10-23 14:33:30,599 - DEBUG - Requesting: http://10.0.0.38:8082/domain/4189e7ba-60c7-4312-b19e-84ffbbe2755a
2026-10-23 14:33:30,656 - DEBUG - Requesting: http://10.0.0.38:8082/project/f90c5d3e-7ef4-490d-82fa-8e4024f9435f
2026-10-23 14:33:30,739 - INFO - Validated that VN ctest-vn-79634325 is not found in API Server
2026-10-23 14:33:30,760 - DEBUG - VN ctest-vn-79634325 is not present in Agent 10.0.0.38
2026-10-23 14:33:30,760 - INFO - Validated that VN ctest-vn-79634325 is not in any agent
2026-10-23 14:33:30,789 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-79634325 info
2026-10-23 14:33:30,873 - INFO - IPAM: ctest-ipam-11060195 is not found in API Server
2026-10-23 14:33:30,888 - INFO - IPAM:ctest-ipam-11060195 is not found in control node
2026-10-23 14:33:31,185 - DEBUG - No XMPP flaps were noticed during the test
2026-10-23 14:33:31,185 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:01:46]
2026-10-23 14:33:31,185 - INFO - --------------------------------------------------------------------------------
2026-10-23 14:33:32,296 - INFO - Deleted project: ctest-TestBasicVMVN-70578934, ID : f90c5d3e-7ef4-490d-82fa-8e4024f9435f