2026-09-17 09:10:46,035 - INFO - Domain Default found not creating 2026-09-17 09:10:46,265 - INFO - Project ctest-TestBasicVMVN-97022278 not found, creating it 2026-09-17 09:10:46,852 - INFO - Created Project:ctest-TestBasicVMVN-97022278, ID : 0af0b71f-8474-474c-8df6-cfa1c6e3d23a 2026-09-17 09:10:48,793 - INFO - ================================================================================ 2026-09-17 09:10:48,793 - INFO - STARTING TEST : test_generic_link_local_service 2026-09-17 09:10:48,793 - 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-09-17 09:10:49,068 - DEBUG - Nothing to compare xmpp stats {'10.0.0.190': {'10.20.0.25': '0'}} with 2026-09-17 09:10:49,069 - INFO - Initial checks done. Running the testcase now 2026-09-17 09:10:49,069 - INFO - 2026-09-17 09:10:49,712 - DEBUG - Response for create_network : {'network': {'id': '3713e928-3007-4daf-b083-4ab224e33556', 'name': 'ctest-vn2_metadata-17631465', 'tenant_id': '0af0b71f8474474c8df6cfa1c6e3d23a', 'project_id': '0af0b71f8474474c8df6cfa1c6e3d23a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-97022278', 'ctest-vn2_metadata-17631465'], 'port_security_enabled': True, 'description': ''}} 2026-09-17 09:10:49,910 - DEBUG - Response for create_subnet : {'subnet': {'id': '0dcf723a-0c05-4307-8d55-ce74689eac15', 'name': '', 'tenant_id': '0af0b71f8474474c8df6cfa1c6e3d23a', 'network_id': '3713e928-3007-4daf-b083-4ab224e33556', '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': '0af0b71f8474474c8df6cfa1c6e3d23a'}} 2026-09-17 09:10:49,934 - INFO - Created VN ctest-vn2_metadata-17631465 2026-09-17 09:10:49,990 - DEBUG - VN ctest-vn2_metadata-17631465 UUID is 3713e928-3007-4daf-b083-4ab224e33556 2026-09-17 09:10:50,194 - DEBUG - Services list from nova: [, , ] 2026-09-17 09:10:50,592 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6297-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6297-1) 2026-09-17 09:10:50,710 - DEBUG - Link local service introspect added 2026-09-17 09:10:50,763 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:10:55,862 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:11:00,973 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:11:06,053 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:11:11,179 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:11:16,302 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:11:21,404 - DEBUG - VM is in ACTIVE state now 2026-09-17 09:11:21,555 - INFO - Waiting for VM ctest-TestBasicVMVN-97022278-96965861 to be up.. 2026-09-17 09:11:21,556 - INFO - VM name : ctest-TestBasicVMVN-97022278-96965861 2026-09-17 09:11:21,641 - DEBUG - VM ctest-TestBasicVMVN-97022278-96965861 ID is 04301d1c-6ef7-4dcc-be09-8762d9181cf3 2026-09-17 09:11:21,641 - DEBUG - VM ctest-TestBasicVMVN-97022278-96965861 launched on Node cn-jenkins-deploy-platform-ansible-os-6297-1 2026-09-17 09:11:21,730 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine/04301d1c-6ef7-4dcc-be09-8762d9181cf3 2026-09-17 09:11:22,058 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine/04301d1c-6ef7-4dcc-be09-8762d9181cf3 2026-09-17 09:11:22,098 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine-interface/f0537721-ee22-4a06-8667-e62a9687f133 2026-09-17 09:11:23,364 - 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=3.91 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.760 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.760/2.333/3.906/1.573 ms') 2026-09-17 09:11:23,364 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-97022278-96965861 passed 2026-09-17 09:11:23,522 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-09-17 09:11:23,523 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-97022278-96965861, IP 11.1.1.3, Port 22 2026-09-17 09:11:23,597 - 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-09-17 09:11:23,695 - DEBUG - VM ctest-TestBasicVMVN-97022278-96965861 is NOT ready for SSH connections, VM status: ACTIVE 2026-09-17 09:11:28,696 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-09-17 09:11:28,696 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-97022278-96965861, IP 11.1.1.3, Port 22 2026-09-17 09:11:28,870 - DEBUG - VM ctest-TestBasicVMVN-97022278-96965861 is ready for SSH connections 2026-09-17 09:11:28,870 - INFO - Retry 0 2026-09-17 09:11:28,870 - 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-09-17 09:11:28,870 - DEBUG - wget http://169.254.1.2:8083 --spider && echo "Successful" 2026-09-17 09:11:30,482 - DEBUG - Connecting to 169.254.1.2:8083 (169.254.1.2:8083) Successful 2026-09-17 09:11:30,482 - INFO - Generic metadata worked 2026-09-17 09:11:30,750 - DEBUG - Link local service introspect removed 2026-09-17 09:11:30,750 - INFO - Deleting VM ctest-TestBasicVMVN-97022278-96965861 2026-09-17 09:11:30,848 - INFO - Deleting VN ctest-vn2_metadata-17631465 2026-09-17 09:11:30,890 - DEBUG - VN 3713e928-3007-4daf-b083-4ab224e33556 still in use: Unable to complete operation on network 3713e928-3007-4daf-b083-4ab224e33556. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-5a59d128-0a2e-49cb-9076-d7a799fa9740'] 2026-09-17 09:11:30,891 - WARNING - Deleting VN ctest-vn2_metadata-17631465 failed..Will retry 2026-09-17 09:11:32,933 - DEBUG - VN 3713e928-3007-4daf-b083-4ab224e33556 still in use: Unable to complete operation on network 3713e928-3007-4daf-b083-4ab224e33556. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-ef2f30b7-23c1-4403-a908-2127d0a31d66'] 2026-09-17 09:11:32,934 - WARNING - Deleting VN ctest-vn2_metadata-17631465 failed..Will retry 2026-09-17 09:11:35,072 - DEBUG - Response for deleting network () 2026-09-17 09:11:35,348 - DEBUG - No XMPP flaps were noticed during the test 2026-09-17 09:11:35,348 - INFO - -------------------------------------------------------------------------------- 2026-09-17 09:11:35,351 - INFO - ================================================================================ 2026-09-17 09:11:35,352 - INFO - STARTING TEST : test_metadata_service 2026-09-17 09:11:35,352 - 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-09-17 09:11:35,649 - DEBUG - Nothing to compare xmpp stats {'10.0.0.190': {'10.20.0.25': '0'}} with 2026-09-17 09:11:35,649 - INFO - Initial checks done. Running the testcase now 2026-09-17 09:11:35,649 - INFO - 2026-09-17 09:11:35,650 - DEBUG - Requesting: http://10.0.0.190:8082/global-vrouter-configs 2026-09-17 09:11:35,658 - DEBUG - Requesting: http://10.0.0.190:8082/global-vrouter-config/81c9a6a0-3f3d-451d-bca3-57fbfdd7d967 2026-09-17 09:11:36,038 - DEBUG - Response for create_network : {'network': {'id': '6412e8dd-cffc-454c-b0b6-a4c5e35f4919', 'name': 'ctest-vn-12939803', 'tenant_id': '0af0b71f8474474c8df6cfa1c6e3d23a', 'project_id': '0af0b71f8474474c8df6cfa1c6e3d23a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-97022278', 'ctest-vn-12939803'], 'port_security_enabled': True, 'description': ''}} 2026-09-17 09:11:36,227 - DEBUG - Response for create_subnet : {'subnet': {'id': '8f440508-96ec-48ee-b22e-681f6b70e9ba', 'name': '', 'tenant_id': '0af0b71f8474474c8df6cfa1c6e3d23a', 'network_id': '6412e8dd-cffc-454c-b0b6-a4c5e35f4919', 'ip_version': 4, 'cidr': '188.196.213.192/26', 'allocation_pools': [{'start': '188.196.213.194', 'end': '188.196.213.254'}], 'gateway_ip': '188.196.213.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '188.196.213.194', 'tags': [], 'project_id': '0af0b71f8474474c8df6cfa1c6e3d23a'}} 2026-09-17 09:11:36,249 - INFO - Created VN ctest-vn-12939803 2026-09-17 09:11:36,302 - DEBUG - VN ctest-vn-12939803 UUID is 6412e8dd-cffc-454c-b0b6-a4c5e35f4919 2026-09-17 09:11:36,856 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6297-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6297-1) 2026-09-17 09:11:36,856 - INFO - Waiting for VM ctest-TestBasicVMVN-97022278-09574478 to be up.. 2026-09-17 09:11:36,906 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:11:42,024 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:11:47,158 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:11:52,270 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:11:57,374 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:12:02,481 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:12:07,616 - DEBUG - VM is in ACTIVE state now 2026-09-17 09:12:07,617 - INFO - VM name : ctest-TestBasicVMVN-97022278-09574478 2026-09-17 09:12:07,735 - DEBUG - VM ctest-TestBasicVMVN-97022278-09574478 ID is 3e1d8291-5931-4a66-abf0-08317be401cf 2026-09-17 09:12:07,736 - DEBUG - VM ctest-TestBasicVMVN-97022278-09574478 launched on Node cn-jenkins-deploy-platform-ansible-os-6297-1 2026-09-17 09:12:07,837 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine/3e1d8291-5931-4a66-abf0-08317be401cf 2026-09-17 09:12:07,848 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine-interface/a4b505c0-c61b-4b59-88f3-27d62c68598c 2026-09-17 09:12:11,130 - 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 1024ms') 2026-09-17 09:12:11,130 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-97022278-09574478 failed! 2026-09-17 09:12:11,190 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-97022278:ctest-vn-12939803 is 188.196.213.193 and allocation pool is NOT set 2026-09-17 09:12:13,263 - 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=4.53 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.51 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.512/3.023/4.534/1.511 ms') 2026-09-17 09:12:13,263 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-97022278-09574478 passed 2026-09-17 09:12:13,422 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-09-17 09:12:13,422 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-97022278-09574478, IP 188.196.213.195, Port 22 2026-09-17 09:12:13,594 - DEBUG - VM ctest-TestBasicVMVN-97022278-09574478 is ready for SSH connections 2026-09-17 09:12:13,594 - 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-09-17 09:12:13,594 - DEBUG - cat /tmp/output.txt 2026-09-17 09:12:15,829 - DEBUG - Hello World. The time is now Thu, 17 Sep 2026 03:12:12 -0600! 2026-09-17 09:12:15,829 - DEBUG - ret : {'cat /tmp/output.txt': 'Hello World. The time is now Thu, 17 Sep 2026 03:12:12 -0600!'} 2026-09-17 09:12:15,830 - INFO - metadata_script.txt got executed in the vm 2026-09-17 09:12:15,830 - INFO - Deleting VM ctest-TestBasicVMVN-97022278-09574478 2026-09-17 09:12:15,951 - INFO - Deleting VN ctest-vn-12939803 2026-09-17 09:12:16,019 - DEBUG - VN 6412e8dd-cffc-454c-b0b6-a4c5e35f4919 still in use: Unable to complete operation on network 6412e8dd-cffc-454c-b0b6-a4c5e35f4919. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-f264bab1-5428-4908-87ae-8dfe47675363'] 2026-09-17 09:12:16,019 - WARNING - Deleting VN ctest-vn-12939803 failed..Will retry 2026-09-17 09:12:18,070 - DEBUG - VN 6412e8dd-cffc-454c-b0b6-a4c5e35f4919 still in use: Unable to complete operation on network 6412e8dd-cffc-454c-b0b6-a4c5e35f4919. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-7e4030dc-39f7-44e9-b2f2-10f5a967b0fd'] 2026-09-17 09:12:18,070 - WARNING - Deleting VN ctest-vn-12939803 failed..Will retry 2026-09-17 09:12:20,235 - DEBUG - Response for deleting network () 2026-09-17 09:12:20,522 - DEBUG - No XMPP flaps were noticed during the test
2026-09-17 09:12:20,522 - INFO - END TEST : test_metadata_service : PASSED[0:00:45]
2026-09-17 09:12:20,523 - INFO - -------------------------------------------------------------------------------- 2026-09-17 09:12:20,526 - INFO - ================================================================================ 2026-09-17 09:12:20,526 - INFO - STARTING TEST : test_ping_within_vn_two_vms_two_different_subnets 2026-09-17 09:12:20,526 - 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-09-17 09:12:20,832 - DEBUG - Nothing to compare xmpp stats {'10.0.0.190': {'10.20.0.25': '0'}} with 2026-09-17 09:12:20,832 - INFO - Initial checks done. Running the testcase now 2026-09-17 09:12:20,832 - INFO - 2026-09-17 09:12:21,426 - DEBUG - Response for create_network : {'network': {'id': '0479196e-886e-44cb-866a-fc17f57ba740', 'name': 'ctest-vn-72596514', 'tenant_id': '0af0b71f8474474c8df6cfa1c6e3d23a', 'project_id': '0af0b71f8474474c8df6cfa1c6e3d23a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVN-97022278', 'ctest-vn-72596514'], 'port_security_enabled': True, 'description': ''}} 2026-09-17 09:12:21,676 - DEBUG - Response for create_subnet : {'subnet': {'id': 'cd230db4-5409-4745-92ca-e69fe6bafb96', 'name': '', 'tenant_id': '0af0b71f8474474c8df6cfa1c6e3d23a', 'network_id': '0479196e-886e-44cb-866a-fc17f57ba740', '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': '0af0b71f8474474c8df6cfa1c6e3d23a'}} 2026-09-17 09:12:21,918 - DEBUG - Response for create_subnet : {'subnet': {'id': '0236836c-4b58-45c8-bca6-4a9497e88dcf', 'name': '', 'tenant_id': '0af0b71f8474474c8df6cfa1c6e3d23a', 'network_id': '0479196e-886e-44cb-866a-fc17f57ba740', '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': '0af0b71f8474474c8df6cfa1c6e3d23a'}} 2026-09-17 09:12:21,944 - INFO - Created VN ctest-vn-72596514 2026-09-17 09:12:22,002 - DEBUG - VN ctest-vn-72596514 UUID is 0479196e-886e-44cb-866a-fc17f57ba740 2026-09-17 09:12:22,524 - DEBUG - Response for create_port : {'port': {'name': '07afb2d9-e21c-4c77-9a51-63b974204cef', 'id': '07afb2d9-e21c-4c77-9a51-63b974204cef', 'tenant_id': '0af0b71f8474474c8df6cfa1c6e3d23a', 'network_id': '0479196e-886e-44cb-866a-fc17f57ba740', 'mac_address': '02:07:af:b2:d9:e2', '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': 'cd230db4-5409-4745-92ca-e69fe6bafb96'}], 'security_groups': ['543fe314-c0bc-4cea-8f26-c99b10afdcdf'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'tags': [], 'port_security_enabled': True, 'description': '', 'project_id': '0af0b71f8474474c8df6cfa1c6e3d23a'}} 2026-09-17 09:12:22,799 - DEBUG - Response for create_port : {'port': {'name': 'cd5f0d07-3d25-4755-aba3-8366bc0293b9', 'id': 'cd5f0d07-3d25-4755-aba3-8366bc0293b9', 'tenant_id': '0af0b71f8474474c8df6cfa1c6e3d23a', 'network_id': '0479196e-886e-44cb-866a-fc17f57ba740', 'mac_address': '02:cd:5f:0d:07: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': '0236836c-4b58-45c8-bca6-4a9497e88dcf'}], 'security_groups': ['543fe314-c0bc-4cea-8f26-c99b10afdcdf'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'tags': [], 'port_security_enabled': True, 'description': '', 'project_id': '0af0b71f8474474c8df6cfa1c6e3d23a'}} 2026-09-17 09:12:23,434 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6297-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6297-1) 2026-09-17 09:12:24,031 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6297-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6297-1) 2026-09-17 09:12:24,704 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6297-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6297-1) 2026-09-17 09:12:24,704 - DEBUG - Requesting: http://10.0.0.190:8082/domains 2026-09-17 09:12:24,710 - DEBUG - Requesting: http://10.0.0.190:8082/domain/c0139787-77d8-43e2-a7cd-3416226bccb5 2026-09-17 09:12:24,727 - DEBUG - Requesting: http://10.0.0.190:8082/project/0af0b71f-8474-474c-8df6-cfa1c6e3d23a 2026-09-17 09:12:24,815 - DEBUG - Requesting: http://10.0.0.190:8082/network-ipam/594d556b-5ecd-431d-8479-46528897f1f8 2026-09-17 09:12:24,832 - INFO - Verifications in API Server for IPAM: ctest-ipam-90212745 passed 2026-09-17 09:12:24,839 - DEBUG - Control-node 10.0.0.190 : IPAM object is : {'node_name': 'network-ipam:default-domain:ctest-TestBasicVMVN-97022278:ctest-ipam-90212745', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN-97022278', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '6434893362222678813', 'uuid-lslong': '9545738205481398776'}, 'enable': 'true', 'created': '2026-09-17T09:12:20', 'last-modified': '2026-09-17T09:12:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.737894'} 2026-09-17 09:12:24,839 - INFO - Verifications in Control node for IPAM: ctest-ipam-90212745 passed 2026-09-17 09:12:24,839 - DEBUG - Requesting: http://10.0.0.190:8082/domains 2026-09-17 09:12:24,848 - DEBUG - Requesting: http://10.0.0.190:8082/domain/c0139787-77d8-43e2-a7cd-3416226bccb5 2026-09-17 09:12:24,867 - DEBUG - Requesting: http://10.0.0.190:8082/project/0af0b71f-8474-474c-8df6-cfa1c6e3d23a 2026-09-17 09:12:24,953 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-network/0479196e-886e-44cb-866a-fc17f57ba740 2026-09-17 09:12:24,971 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-network/0479196e-886e-44cb-866a-fc17f57ba740 2026-09-17 09:12:24,984 - DEBUG - Requesting: http://10.0.0.190:8082/routing-instance/5928de75-10da-496b-851b-bb91165fc1df 2026-09-17 09:12:24,996 - DEBUG - Requesting: http://10.0.0.190:8082/routing-instance/5928de75-10da-496b-851b-bb91165fc1df 2026-09-17 09:12:25,006 - DEBUG - Requesting: http://10.0.0.190:8082/route-target/8ba3c0fc-4bd9-4c95-bdfe-1dee492b1207 2026-09-17 09:12:25,016 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-09-17 09:12:25,017 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-network/0479196e-886e-44cb-866a-fc17f57ba740 2026-09-17 09:12:25,030 - DEBUG - Requesting: http://10.0.0.190:8082/routing-instance/5928de75-10da-496b-851b-bb91165fc1df 2026-09-17 09:12:25,051 - INFO - Verified VN network id 12 for VN 0479196e-886e-44cb-866a-fc17f57ba740 2026-09-17 09:12:25,051 - INFO - Verifications in API Server for VN ctest-vn-72596514 passed 2026-09-17 09:12:25,051 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-network/0479196e-886e-44cb-866a-fc17f57ba740 2026-09-17 09:12:25,067 - DEBUG - Requesting: http://10.0.0.190:8082/routing-instance/5928de75-10da-496b-851b-bb91165fc1df 2026-09-17 09:12:25,077 - DEBUG - Requesting: http://10.0.0.190:8082/routing-instance/5928de75-10da-496b-851b-bb91165fc1df 2026-09-17 09:12:25,086 - DEBUG - Requesting: http://10.0.0.190:8082/route-target/8ba3c0fc-4bd9-4c95-bdfe-1dee492b1207 2026-09-17 09:12:25,101 - DEBUG - Control-node 10.0.0.190 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-TestBasicVMVN-97022278:ctest-vn-72596514', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-TestBasicVMVN-97022278', 'owner-access': '7', 'group': 'admin', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '322316810859726027', 'uuid-lslong': '9685831128446641984'}, 'enable': 'true', 'created': '2026-09-17T09:12:21', 'last-modified': '2026-09-17T09:12:21', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.230079'} 2026-09-17 09:12:25,113 - DEBUG - Route Targets: ['target:64512:8000005'] 2026-09-17 09:12:25,113 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn-72596514 passed 2026-09-17 09:12:25,113 - DEBUG - ====Verifying policy data for ctest-vn-72596514 in API_Server ====== 2026-09-17 09:12:25,113 - DEBUG - Requesting: http://10.0.0.190:8082/domains 2026-09-17 09:12:25,121 - DEBUG - Requesting: http://10.0.0.190:8082/domain/c0139787-77d8-43e2-a7cd-3416226bccb5 2026-09-17 09:12:25,138 - DEBUG - Requesting: http://10.0.0.190:8082/project/0af0b71f-8474-474c-8df6-cfa1c6e3d23a 2026-09-17 09:12:25,240 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-network/0479196e-886e-44cb-866a-fc17f57ba740 2026-09-17 09:12:25,259 - DEBUG - =>VN ctest-vn-72596514 has no policy to be verified 2026-09-17 09:12:25,259 - DEBUG - Verifying the vn in opserver 2026-09-17 09:12:25,259 - DEBUG - Verifying the default-domain:ctest-TestBasicVMVN-97022278:ctest-vn-72596514 virtual network link through opserver 10.0.0.190 2026-09-17 09:12:25,260 - DEBUG - Requesting: http://10.0.0.190:8081/analytics/uves/virtual-networks 2026-09-17 09:12:25,612 - DEBUG - Requesting: http://10.0.0.190:8081/analytics/uves/virtual-networks 2026-09-17 09:12:25,679 - DEBUG - vn link and name as {'name': 'default-domain:ctest-TestBasicVMVN-97022278:ctest-vn-72596514', 'href': 'http://10.0.0.190:8081/analytics/uves/virtual-network/default-domain:ctest-TestBasicVMVN-97022278:ctest-vn-72596514?flat'} 2026-09-17 09:12:25,679 - INFO - Validated that VN default-domain:ctest-TestBasicVMVN-97022278:ctest-vn-72596514 is found in opserver 2026-09-17 09:12:25,692 - DEBUG - Do not have enough data to verify VN in agent 2026-09-17 09:12:25,703 - DEBUG - VRF ids for VN ctest-vn-72596514: {} 2026-09-17 09:12:25,703 - INFO - Waiting for VM ctest-TestBasicVMVN-97022278-57157356 to be up.. 2026-09-17 09:12:25,768 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:12:30,854 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:12:35,949 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:12:41,053 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:12:46,138 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:12:51,209 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:12:56,287 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:13:01,372 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:13:06,466 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:13:11,535 - DEBUG - VM is in ACTIVE state now 2026-09-17 09:13:11,536 - INFO - VM name : ctest-TestBasicVMVN-97022278-57157356 2026-09-17 09:13:11,626 - DEBUG - VM ctest-TestBasicVMVN-97022278-57157356 ID is e42539b6-89f4-4a5a-8076-7d3b1a325a69 2026-09-17 09:13:11,626 - DEBUG - VM ctest-TestBasicVMVN-97022278-57157356 launched on Node cn-jenkins-deploy-platform-ansible-os-6297-1 2026-09-17 09:13:11,708 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine/e42539b6-89f4-4a5a-8076-7d3b1a325a69 2026-09-17 09:13:11,720 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine-interface/07afb2d9-e21c-4c77-9a51-63b974204cef 2026-09-17 09:13:15,007 - 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-09-17 09:13:15,007 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-97022278-57157356 failed! 2026-09-17 09:13:15,062 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-97022278:ctest-vn-72596514 is 31.1.1.1 and allocation pool is NOT set 2026-09-17 09:13:15,062 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVN-97022278:ctest-vn-72596514 is 31.1.2.1 and allocation pool is NOT set 2026-09-17 09:13:17,127 - 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.30 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.33 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 = 1.329/3.313/5.298/1.984 ms') 2026-09-17 09:13:17,127 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVN-97022278-57157356 passed 2026-09-17 09:13:17,286 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-09-17 09:13:17,286 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-97022278-57157356, IP 31.1.1.4, Port 22 2026-09-17 09:13:17,461 - DEBUG - VM ctest-TestBasicVMVN-97022278-57157356 is ready for SSH connections 2026-09-17 09:13:17,462 - INFO - Waiting for VM ctest-TestBasicVMVN-97022278-00699623 to be up.. 2026-09-17 09:13:17,552 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-17 09:13:22,649 - DEBUG - VM is in ACTIVE state now 2026-09-17 09:13:22,650 - INFO - VM name : ctest-TestBasicVMVN-97022278-00699623 2026-09-17 09:13:22,757 - DEBUG - VM ctest-TestBasicVMVN-97022278-00699623 ID is 1a87279b-c90e-41ea-8563-c0888d5318fe 2026-09-17 09:13:22,758 - DEBUG - VM ctest-TestBasicVMVN-97022278-00699623 launched on Node cn-jenkins-deploy-platform-ansible-os-6297-1 2026-09-17 09:13:22,844 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine/1a87279b-c90e-41ea-8563-c0888d5318fe 2026-09-17 09:13:22,852 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine-interface/cd5f0d07-3d25-4755-aba3-8366bc0293b9 2026-09-17 09:13:26,104 - 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=2 ttl=63 time=13.5 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1010ms\r\nrtt min/avg/max/mdev = 13.501/13.501/13.501/0.000 ms') 2026-09-17 09:13:26,105 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBasicVMVN-97022278-00699623 passed 2026-09-17 09:13:26,258 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-09-17 09:13:26,259 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-97022278-00699623, IP 31.1.2.4, Port 22 2026-09-17 09:13:26,424 - DEBUG - VM ctest-TestBasicVMVN-97022278-00699623 is ready for SSH connections 2026-09-17 09:13:26,425 - INFO - Waiting for VM ctest-TestBasicVMVN-97022278-04817024 to be up.. 2026-09-17 09:13:26,518 - DEBUG - VM is in ACTIVE state now 2026-09-17 09:13:26,518 - INFO - VM name : ctest-TestBasicVMVN-97022278-04817024 2026-09-17 09:13:26,587 - DEBUG - VM ctest-TestBasicVMVN-97022278-04817024 ID is 8ce935fc-af50-451e-9b11-363cbbd18016 2026-09-17 09:13:26,587 - DEBUG - VM ctest-TestBasicVMVN-97022278-04817024 launched on Node cn-jenkins-deploy-platform-ansible-os-6297-1 2026-09-17 09:13:26,662 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine/8ce935fc-af50-451e-9b11-363cbbd18016 2026-09-17 09:13:26,670 - DEBUG - Requesting: http://10.0.0.190:8082/virtual-machine-interface/636e9b0b-5111-4bbb-8718-5901648a31d6 2026-09-17 09:13:27,920 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n64 bytes from 169.254.0.5: icmp_seq=1 ttl=63 time=3.33 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.523 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.523/1.924/3.325/1.401 ms') 2026-09-17 09:13:27,920 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-97022278-04817024 passed 2026-09-17 09:13:28,074 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-09-17 09:13:28,074 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-97022278-04817024, IP 31.1.1.3, Port 22 2026-09-17 09:13:28,230 - DEBUG - VM ctest-TestBasicVMVN-97022278-04817024 is ready for SSH connections 2026-09-17 09:13:28,230 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-09-17 09:13:28,230 - 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-09-17 09:13:28,230 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4 2026-09-17 09:13:32,394 - DEBUG - PING 31.1.2.4 (31.1.2.4): 56 data bytes 64 bytes from 31.1.2.4: seq=0 ttl=63 time=5.153 ms 64 bytes from 31.1.2.4: seq=1 ttl=63 time=0.863 ms 64 bytes from 31.1.2.4: seq=2 ttl=63 time=1.206 ms --- 31.1.2.4 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 0.863/2.407/5.153 ms 2026-09-17 09:13:32,394 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-97022278-57157356 passed 2026-09-17 09:13:32,394 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-09-17 09:13:32,394 - 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-09-17 09:13:32,394 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4 2026-09-17 09:13:36,014 - 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.274 ms 64 bytes from 31.1.1.4: seq=1 ttl=63 time=1.081 ms 64 bytes from 31.1.1.4: seq=2 ttl=63 time=1.049 ms --- 31.1.1.4 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.049/1.801/3.274 ms 2026-09-17 09:13:36,014 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-97022278-00699623 passed 2026-09-17 09:13:36,014 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-09-17 09:13:36,014 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-09-17 09:13:36,014 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-09-17 09:13:36,014 - 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-09-17 09:13:36,014 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts 2026-09-17 09:13:36,132 - DEBUG - None 2026-09-17 09:13:36,132 - 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-09-17 09:13:36,132 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts 2026-09-17 09:13:36,269 - DEBUG - None 2026-09-17 09:13:36,270 - 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-09-17 09:13:36,270 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts 2026-09-17 09:13:37,919 - DEBUG - None 2026-09-17 09:13:37,919 - 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-09-17 09:13:37,919 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7 2026-09-17 09:13:40,076 - 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.848 ms 64 bytes from 31.1.1.3: seq=0 ttl=64 time=5.930 ms (DUP!) 64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.907 ms 64 bytes from 31.1.1.3: seq=1 ttl=64 time=3.648 ms (DUP!) 64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.605 ms --- 31.1.1.7 ping statistics --- 3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss round-trip min/avg/max = 0.605/2.787/5.930 ms 2026-09-17 09:13:40,076 - 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-09-17 09:13:40,077 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1 2026-09-17 09:13:42,267 - 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.116 ms 64 bytes from 31.1.1.3: seq=0 ttl=64 time=3.931 ms (DUP!) 64 bytes from 31.1.2.4: seq=0 ttl=63 time=5.481 ms (DUP!) 64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.587 ms 64 bytes from 31.1.2.4: seq=1 ttl=63 time=3.082 ms (DUP!) 64 bytes from 31.1.1.3: seq=1 ttl=64 time=4.278 ms (DUP!) 64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.506 ms --- 224.0.0.1 ping statistics --- 3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss round-trip min/avg/max = 0.506/2.711/5.481 ms 2026-09-17 09:13:42,267 - 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-09-17 09:13:42,267 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255 2026-09-17 09:13:44,458 - 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.717 ms 64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.703 ms (DUP!) 64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.794 ms (DUP!) 64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.516 ms 64 bytes from 31.1.1.3: seq=1 ttl=64 time=3.387 ms (DUP!) 64 bytes from 31.1.2.4: seq=1 ttl=63 time=4.910 ms (DUP!) 64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.666 ms --- 255.255.255.255 ping statistics --- 3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss round-trip min/avg/max = 0.516/2.384/4.910 ms 2026-09-17 09:13:44,459 - INFO - Deleting VM ctest-TestBasicVMVN-97022278-04817024 2026-09-17 09:13:44,548 - INFO - Detaching port cd5f0d07-3d25-4755-aba3-8366bc0293b9 from VM ctest-TestBasicVMVN-97022278-00699623 2026-09-17 09:13:44,582 - INFO - Deleting VM ctest-TestBasicVMVN-97022278-00699623 2026-09-17 09:13:44,645 - INFO - Detaching port 07afb2d9-e21c-4c77-9a51-63b974204cef from VM ctest-TestBasicVMVN-97022278-57157356 2026-09-17 09:13:44,682 - INFO - Deleting VM ctest-TestBasicVMVN-97022278-57157356 2026-09-17 09:13:44,748 - INFO - Deleting VN ctest-vn-72596514 2026-09-17 09:13:44,972 - DEBUG - Response for delete_port : () 2026-09-17 09:13:45,409 - DEBUG - Response for delete_port : () 2026-09-17 09:13:45,479 - DEBUG - VN 0479196e-886e-44cb-866a-fc17f57ba740 still in use: Unable to complete operation on network 0479196e-886e-44cb-866a-fc17f57ba740. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-ee8e3eb4-c4ca-4ed3-8892-07f25fafcc82'] 2026-09-17 09:13:45,479 - WARNING - Deleting VN ctest-vn-72596514 failed..Will retry 2026-09-17 09:13:47,542 - DEBUG - VN 0479196e-886e-44cb-866a-fc17f57ba740 still in use: Unable to complete operation on network 0479196e-886e-44cb-866a-fc17f57ba740. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-396b5475-dc1c-4cb9-84fb-510498eb34d3'] 2026-09-17 09:13:47,542 - WARNING - Deleting VN ctest-vn-72596514 failed..Will retry 2026-09-17 09:13:49,601 - DEBUG - VN 0479196e-886e-44cb-866a-fc17f57ba740 still in use: Unable to complete operation on network 0479196e-886e-44cb-866a-fc17f57ba740. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-d84b89af-d06e-427b-9828-5a679bcf41bb'] 2026-09-17 09:13:49,601 - WARNING - Deleting VN ctest-vn-72596514 failed..Will retry 2026-09-17 09:13:51,838 - DEBUG - Response for deleting network () 2026-09-17 09:13:51,839 - DEBUG - Requesting: http://10.0.0.190:8082/routing-instance/5928de75-10da-496b-851b-bb91165fc1df 2026-09-17 09:13:51,846 - DEBUG - Response Code: 404 2026-09-17 09:13:51,846 - DEBUG - Requesting: http://10.0.0.190:8082/domains 2026-09-17 09:13:51,855 - DEBUG - Requesting: http://10.0.0.190:8082/domain/c0139787-77d8-43e2-a7cd-3416226bccb5 2026-09-17 09:13:51,923 - DEBUG - Requesting: http://10.0.0.190:8082/project/0af0b71f-8474-474c-8df6-cfa1c6e3d23a 2026-09-17 09:13:52,015 - INFO - Validated that VN ctest-vn-72596514 is not found in API Server 2026-09-17 09:13:52,030 - DEBUG - VN ctest-vn-72596514 is not present in Agent 10.0.0.190 2026-09-17 09:13:52,031 - INFO - Validated that VN ctest-vn-72596514 is not in any agent 2026-09-17 09:13:52,049 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-72596514 info 2026-09-17 09:13:52,158 - INFO - IPAM: ctest-ipam-90212745 is not found in API Server 2026-09-17 09:13:52,174 - INFO - IPAM:ctest-ipam-90212745 is not found in control node 2026-09-17 09:13:52,448 - DEBUG - No XMPP flaps were noticed during the test
2026-09-17 09:13:52,449 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:01:32]
2026-09-17 09:13:52,449 - INFO - -------------------------------------------------------------------------------- 2026-09-17 09:13:53,571 - INFO - Deleted project: ctest-TestBasicVMVN-97022278, ID : 0af0b71f-8474-474c-8df6-cfa1c6e3d23a