2026-06-08 03:30:29,422 - INFO - Domain Default found not creating 2026-06-08 03:30:29,596 - INFO - Project ctest-TestvDNSBasic0-05268018 not found, creating it 2026-06-08 03:30:30,273 - INFO - Created Project:ctest-TestvDNSBasic0-05268018, ID : bcc15640-9836-4ed7-97e9-b719a33b2b37 2026-06-08 03:30:31,782 - INFO - ================================================================================ 2026-06-08 03:30:31,782 - INFO - STARTING TEST : test_vdns_ping_same_vn 2026-06-08 03:30:31,782 - INFO - TEST DESCRIPTION : Test:- Test vdns functionality. On VM launch agent should dynamically update dns records to dns agent 1. Create vDNS server 2. Create IPAM using above vDNS data 3. Create VN using above IPAM and launch 2 VM's within it 4. Ping between these 2 VM's using dns name 5. Try to delete vDNS server which has IPAM back-reference[Negative case] 6. Add CNAME VDNS record for vm1-test and verify we able to ping by alias name Pass criteria: Step 4,5 and 6 should pass Maintainer: cf-test@juniper.net 2026-06-08 03:30:33,087 - DEBUG - Nothing to compare xmpp stats {'10.0.0.23': {'10.20.0.193': '3', '10.20.0.25': '1'}, '10.0.0.240': {'10.20.0.129': '3', '10.20.0.25': '2'}} with 2026-06-08 03:30:33,087 - INFO - Initial checks done. Running the testcase now 2026-06-08 03:30:33,088 - INFO - 2026-06-08 03:30:33,841 - INFO - Using existing project ['default-domain', 'ctest-TestvDNSBasic0-05268018'](bcc15640-9836-4ed7-97e9-b719a33b2b37) 2026-06-08 03:30:33,899 - DEBUG - Creating VDNS : ctest-vdns1-35374017 2026-06-08 03:30:34,159 - DEBUG - VDNS: ['default-domain', 'ctest-vdns1-35374017'] created succesfully 2026-06-08 03:30:34,159 - DEBUG - Verify VDNS entry is shown in control node 2026-06-08 03:30:34,181 - DEBUG - Verify VDNS entry is shown in the API server 2026-06-08 03:30:34,181 - DEBUG - Requesting: http://10.0.0.33:8082/domains 2026-06-08 03:30:34,478 - DEBUG - Requesting: http://10.0.0.33:8082/domains 2026-06-08 03:30:34,512 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2441b78a-01cc-4005-9aa7-6b434eb6fb41 2026-06-08 03:30:34,530 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-DNS/7609c579-c864-4f33-b1a0-dece48410eb7 2026-06-08 03:30:35,535 - DEBUG - Response for create_network : {'network': {'id': '13f039d6-6403-4cff-bb13-9bf52dabf50a', 'name': 'ctest-vn1-vdns-46227128', 'tenant_id': 'bcc1564098364ed797e9b719a33b2b37', 'project_id': 'bcc1564098364ed797e9b719a33b2b37', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestvDNSBasic0-05268018', 'ctest-vn1-vdns-46227128'], 'port_security_enabled': True, 'description': ''}} 2026-06-08 03:30:35,932 - DEBUG - Response for create_subnet : {'subnet': {'id': 'fc082a8c-3b93-4595-a71e-57ed994e1bcb', 'name': '', 'tenant_id': 'bcc1564098364ed797e9b719a33b2b37', 'network_id': '13f039d6-6403-4cff-bb13-9bf52dabf50a', 'ip_version': 4, 'cidr': '10.10.10.0/24', 'allocation_pools': [{'start': '10.10.10.2', 'end': '10.10.10.254'}], 'gateway_ip': '10.10.10.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '10.10.10.2', 'tags': [], 'project_id': 'bcc1564098364ed797e9b719a33b2b37'}} 2026-06-08 03:30:35,954 - INFO - Created VN ctest-vn1-vdns-46227128 2026-06-08 03:30:35,973 - DEBUG - VN ctest-vn1-vdns-46227128 UUID is 13f039d6-6403-4cff-bb13-9bf52dabf50a 2026-06-08 03:30:36,258 - DEBUG - Services list from nova: [, , , ] 2026-06-08 03:30:37,561 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5901-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5901-2) 2026-06-08 03:30:37,561 - INFO - Waiting for VM ctest-vm1-test-41561165 to be up.. 2026-06-08 03:30:37,611 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-06-08 03:30:42,715 - DEBUG - VM is in ACTIVE state now 2026-06-08 03:30:42,715 - INFO - VM name : ctest-vm1-test-41561165 2026-06-08 03:30:42,815 - DEBUG - VM ctest-vm1-test-41561165 ID is 2474971d-13d3-4708-9d1e-498fbff0dcaa 2026-06-08 03:30:42,815 - DEBUG - VM ctest-vm1-test-41561165 launched on Node an-jenkins-deploy-platform-ansible-os-5901-2 2026-06-08 03:30:42,917 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/2474971d-13d3-4708-9d1e-498fbff0dcaa 2026-06-08 03:30:43,215 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/2474971d-13d3-4708-9d1e-498fbff0dcaa 2026-06-08 03:30:43,260 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/037aec79-b0b5-444d-916c-62792cfc236f 2026-06-08 03:30:46,482 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1023ms') 2026-06-08 03:30:46,482 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:30:46,507 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:30:50,579 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1005ms') 2026-06-08 03:30:50,579 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:30:50,597 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:30:54,673 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1008ms') 2026-06-08 03:30:54,673 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:30:54,694 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:30:58,769 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms') 2026-06-08 03:30:58,769 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:30:58,798 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:31:02,898 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1033ms') 2026-06-08 03:31:02,899 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:31:02,920 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:31:06,993 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1005ms') 2026-06-08 03:31:06,994 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:31:07,013 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:31:11,083 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1013ms') 2026-06-08 03:31:11,083 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:31:11,101 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:31:15,185 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-06-08 03:31:15,185 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:31:15,205 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:31:19,283 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms') 2026-06-08 03:31:19,283 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:31:19,300 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:31:23,370 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1011ms') 2026-06-08 03:31:23,370 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:31:23,386 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:31:27,472 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1020ms') 2026-06-08 03:31:27,472 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:31:27,491 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:31:31,566 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-06-08 03:31:31,566 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:31:31,585 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:31:35,662 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1013ms') 2026-06-08 03:31:35,662 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:31:35,680 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:31:39,763 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1013ms') 2026-06-08 03:31:39,763 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:31:39,781 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:31:43,860 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1011ms') 2026-06-08 03:31:43,860 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:31:43,879 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:31:47,957 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1015ms') 2026-06-08 03:31:47,957 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:31:47,978 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:31:52,051 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1007ms') 2026-06-08 03:31:52,051 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:31:52,070 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:31:56,139 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1009ms') 2026-06-08 03:31:56,139 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:31:56,160 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:32:00,240 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms') 2026-06-08 03:32:00,240 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:32:00,261 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:32:04,335 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1008ms') 2026-06-08 03:32:04,335 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:32:04,357 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:32:08,433 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1011ms') 2026-06-08 03:32:08,433 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:32:08,481 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:32:12,562 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1012ms') 2026-06-08 03:32:12,562 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:32:12,581 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:32:16,660 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1015ms') 2026-06-08 03:32:16,660 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:32:16,678 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:32:20,753 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1011ms') 2026-06-08 03:32:20,754 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:32:20,773 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:32:24,849 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1011ms') 2026-06-08 03:32:24,849 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:32:24,868 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:32:28,946 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1009ms') 2026-06-08 03:32:28,946 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:32:28,963 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:32:33,037 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-06-08 03:32:33,037 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:32:33,055 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:32:37,137 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms') 2026-06-08 03:32:37,137 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:32:37,159 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:32:41,234 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1001ms') 2026-06-08 03:32:41,234 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:32:41,253 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:32:45,328 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms') 2026-06-08 03:32:45,328 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:32:45,349 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:32:49,427 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1006ms') 2026-06-08 03:32:49,427 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:32:49,444 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:32:53,515 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1013ms') 2026-06-08 03:32:53,515 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:32:53,531 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:32:57,618 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1021ms') 2026-06-08 03:32:57,618 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:32:57,640 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:33:01,713 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1005ms') 2026-06-08 03:33:01,713 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:33:01,736 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:33:05,810 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1013ms') 2026-06-08 03:33:05,810 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:33:05,825 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:33:09,907 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1015ms') 2026-06-08 03:33:09,907 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:33:09,927 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:33:14,003 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1009ms') 2026-06-08 03:33:14,003 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:33:14,019 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:33:18,097 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-06-08 03:33:18,097 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:33:18,118 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:33:22,189 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1009ms') 2026-06-08 03:33:22,189 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:33:22,206 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:33:26,289 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1016ms') 2026-06-08 03:33:26,289 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:33:26,306 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:33:30,386 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1012ms') 2026-06-08 03:33:30,386 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:33:30,403 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:33:34,481 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1015ms') 2026-06-08 03:33:34,481 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:33:34,497 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:33:38,575 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-06-08 03:33:38,575 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:33:38,591 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:33:42,666 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1017ms') 2026-06-08 03:33:42,666 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:33:42,683 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:33:46,764 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1023ms') 2026-06-08 03:33:46,764 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:33:46,782 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:33:50,867 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1017ms') 2026-06-08 03:33:50,867 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:33:50,883 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:33:54,959 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms') 2026-06-08 03:33:54,959 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:33:54,974 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:33:59,058 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1018ms') 2026-06-08 03:33:59,058 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:33:59,075 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:34:03,158 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1018ms') 2026-06-08 03:34:03,158 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:34:03,177 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:34:07,249 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1003ms') 2026-06-08 03:34:07,250 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:34:07,266 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:34:11,346 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-06-08 03:34:11,346 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:34:11,363 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:34:14,576 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1025ms') 2026-06-08 03:34:14,577 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:34:14,594 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:34:18,671 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-06-08 03:34:18,671 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:34:18,690 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:34:22,772 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1013ms') 2026-06-08 03:34:22,772 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:34:22,788 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:34:26,867 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms') 2026-06-08 03:34:26,867 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:34:26,889 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:34:30,959 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1006ms') 2026-06-08 03:34:30,959 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:34:30,975 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:34:35,060 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms') 2026-06-08 03:34:35,060 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:34:35,077 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:34:39,150 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1009ms') 2026-06-08 03:34:39,150 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:34:39,166 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:34:43,249 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1016ms') 2026-06-08 03:34:43,249 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:34:43,264 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:34:47,346 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-06-08 03:34:47,346 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:34:47,363 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:34:51,438 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1012ms') 2026-06-08 03:34:51,438 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:34:51,456 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:34:55,533 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1015ms') 2026-06-08 03:34:55,533 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:34:55,550 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:34:59,629 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1017ms') 2026-06-08 03:34:59,629 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:34:59,644 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:35:03,727 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1022ms') 2026-06-08 03:35:03,727 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:35:03,747 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:35:07,826 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-06-08 03:35:07,826 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:35:07,848 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:35:11,922 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms') 2026-06-08 03:35:11,922 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:35:11,936 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:35:16,012 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1017ms') 2026-06-08 03:35:16,012 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:35:16,030 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:35:20,114 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms') 2026-06-08 03:35:20,114 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:35:20,130 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:35:24,205 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1015ms') 2026-06-08 03:35:24,205 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:35:24,221 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:35:28,306 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1017ms') 2026-06-08 03:35:28,307 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:35:28,323 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:35:32,399 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1013ms') 2026-06-08 03:35:32,399 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:35:32,416 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:35:36,496 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-06-08 03:35:36,496 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:35:36,541 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:35:40,623 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms') 2026-06-08 03:35:40,623 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:35:40,642 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:35:44,720 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms') 2026-06-08 03:35:44,720 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:35:44,736 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:35:48,819 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-06-08 03:35:48,820 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:35:48,838 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:35:52,913 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1009ms') 2026-06-08 03:35:52,913 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:35:52,930 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:35:57,007 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-06-08 03:35:57,007 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:35:57,024 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:36:01,106 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1012ms') 2026-06-08 03:36:01,106 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:36:01,125 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:36:05,202 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1009ms') 2026-06-08 03:36:05,202 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:36:05,219 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:36:09,292 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-06-08 03:36:09,292 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:36:09,318 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:36:13,392 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1011ms') 2026-06-08 03:36:13,392 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:36:13,409 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:36:17,486 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-06-08 03:36:17,486 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:36:17,501 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:36:21,582 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1017ms') 2026-06-08 03:36:21,582 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:36:21,600 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:36:25,680 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-06-08 03:36:25,680 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:36:25,700 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:36:29,775 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1008ms') 2026-06-08 03:36:29,775 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:36:29,795 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:36:33,868 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1015ms') 2026-06-08 03:36:33,869 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:36:33,884 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:36:37,966 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1016ms') 2026-06-08 03:36:37,966 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:36:37,983 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:36:42,061 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1018ms') 2026-06-08 03:36:42,061 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:36:42,081 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:36:46,156 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1012ms') 2026-06-08 03:36:46,156 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:36:46,175 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:36:50,255 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1016ms') 2026-06-08 03:36:50,255 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:36:50,274 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:36:54,355 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-06-08 03:36:54,355 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:36:54,371 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:36:58,455 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1018ms') 2026-06-08 03:36:58,455 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:36:58,471 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:37:02,545 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1007ms') 2026-06-08 03:37:02,545 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:37:02,562 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:37:06,640 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-06-08 03:37:06,641 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:37:06,660 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:37:10,732 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms') 2026-06-08 03:37:10,732 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:37:10,747 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:37:14,836 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms') 2026-06-08 03:37:14,836 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:37:14,851 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:37:18,930 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-06-08 03:37:18,930 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:37:18,946 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:37:23,022 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1015ms') 2026-06-08 03:37:23,022 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:37:23,041 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:37:27,123 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1015ms') 2026-06-08 03:37:27,123 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:37:27,144 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:37:31,217 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms') 2026-06-08 03:37:31,217 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:37:31,238 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:37:35,307 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms') 2026-06-08 03:37:35,307 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:37:35,324 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:37:39,411 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1020ms') 2026-06-08 03:37:39,411 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vm1-test-41561165 failed! 2026-06-08 03:37:39,431 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-05268018:ctest-vn1-vdns-46227128 is 10.10.10.1 and allocation pool is NOT set 2026-06-08 03:37:39,432 - WARNING - VM metadata IP is not 169.254.x.x 2026-06-08 03:37:39,555 - DEBUG - VM ctest-vm1-test-41561165 does not seem to be fully up 2026-06-08 03:37:40,105 - DEBUG - Console output: [ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Linux version 3.2.0-35-virtual (buildd@allspice) (gcc version 4.6.3 (Ubuntu/Linaro 4.6.3-1ubuntu5) ) #55-Ubuntu SMP Wed Dec 5 18:02:05 UTC 2012 (Ubuntu 3.2.0-35.55-virtual 3.2.34) [ 0.000000] Command line: BOOT_IMAGE=/boot/vmlinuz-3.2.0-35-virtual root=UUID=02147f18-c4e2-47d4-ba41-a162651517cb ro console=ttyS0 console=tty0 rootdelay=1800 [ 0.000000] KERNEL supported cpus: [ 0.000000] Intel GenuineIntel [ 0.000000] AMD AuthenticAMD [ 0.000000] Centaur CentaurHauls [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: 0000000000000000 - 000000000009fc00 (usable) [ 0.000000] BIOS-e820: 000000000009fc00 - 00000000000a0000 (reserved) [ 0.000000] BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved) [ 0.000000] BIOS-e820: 0000000000100000 - 000000003ffdb000 (usable) [ 0.000000] BIOS-e820: 000000003ffdb000 - 0000000040000000 (reserved) [ 0.000000] BIOS-e820: 00000000fffc0000 - 0000000100000000 (reserved) [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] DMI 2.8 present. [ 0.000000] No AGP bridge found [ 0.000000] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000 [ 0.000000] x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106 [ 0.000000] found SMP MP-table at [ffff8800000f5b30] f5b30 [ 0.000000] Using GB pages for direct mapping [ 0.000000] init_memory_mapping: 0000000000000000-000000003ffdb000 [ 0.000000] RAMDISK: 3776e000 - 37baf000 [ 0.000000] ACPI: RSDP 00000000000f5900 00014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 000000003ffe17da 00030 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 000000003ffe16c6 00074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 000000003ffe0040 01686 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 000000003ffe0000 00040 [ 0.000000] ACPI: APIC 000000003ffe173a 00078 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 000000003ffe17b2 00028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at 0000000000000000-000000003ffdb000 [ 0.000000] Initmem setup node 0 0000000000000000-000000003ffdb000 [ 0.000000] NODE_DATA [000000003ffd6000 - 000000003ffdafff] [ 0.000000] Zone PFN ranges: [ 0.000000] DMA 0x00000010 -> 0x00001000 [ 0.000000] DMA32 0x00001000 -> 0x00100000 [ 0.000000] Normal empty [ 0.000000] Movable zone start PFN for each node [ 0.000000] early_node_map[2] active PFN ranges [ 0.000000] 0: 0x00000010 -> 0x0000009f [ 0.000000] 0: 0x00000100 -> 0x0003ffdb [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled) [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0]) [ 0.000000] IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] SMP: Allowing 1 CPUs, 0 hotplug CPUs [ 0.000000] PM: Registered nosave memory: 000000000009f000 - 00000000000a0000 [ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000 [ 0.000000] PM: Registered nosave memory: 00000000000f0000 - 0000000000100000 [ 0.000000] Allocating PCI resources starting at 40000000 (gap: 40000000:bffc0000) [ 0.000000] Booting paravirtualized kernel on bare hardware [ 0.000000] setup_percpu: NR_CPUS:64 nr_cpumask_bits:64 nr_cpu_ids:1 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 28 pages/cpu @ffff88003fc00000 s82880 r8192 d23616 u2097152 [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 257893 [ 0.000000] Policy zone: DMA32 [ 0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-3.2.0-35-virtual root=UUID=02147f18-c4e2-47d4-ba41-a162651517cb ro console=ttyS0 console=tty0 rootdelay=1800 [ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes) [ 0.000000] xsave/xrstor: enabled xstate_bv 0x3, cntxt size 0x240 [ 0.000000] Checking aperture... [ 0.000000] No AGP bridge found [ 0.000000] Memory: 1011328k/1048428k available (6540k kernel code, 452k absent, 36648k reserved, 6652k data, 924k init) [ 0.000000] SLUB: Genslabs=15, HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU dyntick-idle grace-period acceleration is enabled. [ 0.000000] NR_IRQS:4352 nr_irqs:256 16 [ 0.000000] Console: colour VGA+ 80x25 [ 0.000000] console [tty0] enabled [ 0.000000] console [ttyS0] enabled [ 0.000000] allocated 8388608 bytes of page_cgroup [ 0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups [ 0.000000] Fast TSC calibration using PIT [ 0.000000] Detected 2294.615 MHz processor. [ 0.017177] Calibrating delay loop (skipped), value calculated using timer frequency.. 4589.23 BogoMIPS (lpj=9178460) [ 0.018523] pid_max: default: 32768 minimum: 301 [ 0.022554] Security Framework initialized [ 0.027850] AppArmor: AppArmor initialized [ 0.028088] Yama: becoming mindful. [ 0.035125] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes) [ 0.037948] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes) [ 0.039547] Mount-cache hash table entries: 256 [ 0.051747] Initializing cgroup subsys cpuacct [ 0.052249] Initializing cgroup subsys memory [ 0.053361] Initializing cgroup subsys devices [ 0.053661] Initializing cgroup subsys freezer [ 0.053893] Initializing cgroup subsys blkio [ 0.054431] Initializing cgroup subsys perf_event [ 0.218357] mce: CPU supports 10 MCE banks [ 0.220802] using AMD E400 aware idle routine [ 0.225829] SMP alternatives: switching to UP code [ 0.468816] Freeing SMP alternatives: 24k freed [ 0.469678] ACPI: Core revision 20110623 [ 0.511700] ftrace: allocating 27024 entries in 106 pages [ 0.541081] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.581863] CPU0: AMD Opteron 23xx (Gen 3 Class Opteron) stepping 03 [ 0.584035] Performance Events: Broken PMU hardware detected, using software events only. [ 0.590663] NMI watchdog disabled (cpu0): hardware events not enabled [ 0.591904] Brought up 1 CPUs [ 0.592190] Total of 1 processors activated (4589.23 BogoMIPS). [ 0.613291] devtmpfs: initialized [ 0.623617] EVM: security.selinux [ 0.623867] EVM: security.SMACK64 [ 0.624060] EVM: security.capability [ 0.636893] print_constraints: dummy: [ 0.638228] RTC time: 3:30:46, date: 06/08/26 [ 0.640149] NET: Registered protocol family 16 [ 0.645801] Extended Config Space enabled on 0 nodes [ 0.646789] ACPI: bus type pci registered [ 0.649552] PCI: Using configuration type 1 for base access [ 0.649848] PCI: Using configuration type 1 for extended access [ 0.673138] bio: create slab at 0 [ 0.676718] ACPI: Added _OSI(Module Device) [ 0.676970] ACPI: Added _OSI(Processor Device) [ 0.677155] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.677366] ACPI: Added _OSI(Processor Aggregator Device) [ 0.704692] ACPI: Interpreter enabled [ 0.705004] ACPI: (supports S0 S5) [ 0.705935] ACPI: Using IOAPIC for interrupt routing [ 0.742259] ACPI: No dock devices found. [ 0.742580] HEST: Table not found. [ 0.742826] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.745437] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.748046] pci_root PNP0A03:00: host bridge window [io 0x0000-0x0cf7] [ 0.748120] pci_root PNP0A03:00: host bridge window [io 0x0d00-0xffff] [ 0.748394] pci_root PNP0A03:00: host bridge window [mem 0x000a0000-0x000bffff] [ 0.748676] pci_root PNP0A03:00: host bridge window [mem 0x40000000-0xfebfffff] [ 0.748935] pci_root PNP0A03:00: host bridge window [mem 0x100000000-0x17fffffff] [ 0.761911] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.762313] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 1.362028] pci0000:00: Requesting ACPI _OSC control (0x1d) [ 1.362522] pci0000:00: ACPI _OSC request failed (AE_NOT_FOUND), returned control mask: 0x1d [ 1.362826] ACPI _OSC control for PCIe not granted, disabling ASPM [ 1.394990] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 1.396086] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 1.396520] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 1.397226] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 1.397766] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 1.403217] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none [ 1.403609] vgaarb: loaded [ 1.403758] vgaarb: bridge control possible 0000:00:02.0 [ 1.406029] i2c-core: driver [aat2870] using legacy suspend method [ 1.406295] i2c-core: driver [aat2870] using legacy resume method [ 1.408949] SCSI subsystem initialized [ 1.411624] usbcore: registered new interface driver usbfs [ 1.412673] usbcore: registered new interface driver hub [ 1.413599] usbcore: registered new device driver usb [ 1.417272] PCI: Using ACPI for IRQ routing [ 1.426761] NetLabel: Initializing [ 1.427020] NetLabel: domain hash size = 128 [ 1.427194] NetLabel: protocols = UNLABELED CIPSOv4 [ 1.428703] NetLabel: unlabeled traffic allowed by default [ 1.512661] AppArmor: AppArmor Filesystem Enabled [ 1.513903] pnp: PnP ACPI init [ 1.514396] ACPI: bus type pnp registered [ 1.524225] pnp: PnP ACPI: found 9 devices [ 1.524504] ACPI: ACPI bus type pnp unregistered [ 1.556544] Switching to clocksource acpi_pm [ 1.559281] NET: Registered protocol family 2 [ 1.565848] IP route cache hash table entries: 32768 (order: 6, 262144 bytes) [ 1.576536] TCP established hash table entries: 131072 (order: 9, 2097152 bytes) [ 1.581178] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes) [ 1.583303] TCP: Hash tables configured (established 131072 bind 65536) [ 1.583719] TCP reno registered [ 1.584249] UDP hash table entries: 512 (order: 2, 16384 bytes) [ 1.584677] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes) [ 1.587091] NET: Registered protocol family 1 [ 1.587658] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 1.587988] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 1.589639] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 1.593154] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11 [ 1.593731] pci 0000:00:01.2: PCI INT D -> Link[LNKD] -> GSI 11 (level, high) -> IRQ 11 [ 1.595099] pci 0000:00:01.2: PCI INT D disabled [ 1.608284] Trying to unpack rootfs image as initramfs... [ 1.629162] audit: initializing netlink socket (disabled) [ 1.630246] type=2000 audit(1780889446.628:1): initialized [ 1.765796] HugeTLB registered 2 MB page size, pre-allocated 0 pages [ 1.804593] VFS: Disk quotas dquot_6.5.2 [ 1.805447] Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 1.825471] fuse init (API version 7.17) [ 1.827870] msgmni has been set to 1975 [ 1.854240] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253) [ 1.855316] io scheduler noop registered [ 1.855609] io scheduler deadline registered (default) [ 1.856537] io scheduler cfq registered [ 1.858847] pci_hotplug: PCI Hot Plug PCI Core version: 0.5 [ 1.860440] pciehp: PCI Express Hot Plug Controller Driver version: 0.4 [ 1.864550] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 1.865669] ACPI: Power Button [PWRF] [ 1.880746] ERST: Table is not found! [ 1.881036] GHES: HEST is not enabled! [ 1.890161] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 10 [ 1.890568] virtio-pci 0000:00:03.0: PCI INT A -> Link[LNKC] -> GSI 10 (level, high) -> IRQ 10 [ 1.893495] virtio-pci 0000:00:04.0: PCI INT A -> Link[LNKD] -> GSI 11 (level, high) -> IRQ 11 [ 1.901734] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10 [ 1.902090] virtio-pci 0000:00:05.0: PCI INT A -> Link[LNKA] -> GSI 10 (level, high) -> IRQ 10 [ 1.909052] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 11 [ 1.909566] virtio-pci 0000:00:06.0: PCI INT A -> Link[LNKB] -> GSI 11 (level, high) -> IRQ 11 [ 1.911122] virtio-pci 0000:00:07.0: PCI INT A -> Link[LNKC] -> GSI 10 (level, high) -> IRQ 10 [ 1.921289] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled [ 1.945321] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A [ 2.020206] 00:01: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A [ 2.061407] Linux agpgart interface v0.103 [ 2.094867] brd: module loaded [ 2.111254] loop: module loaded [ 2.159358] vda: vda1 [ 2.209858] scsi0 : ata_piix [ 2.216641] scsi1 : ata_piix [ 2.218386] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc100 irq 14 [ 2.218883] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc108 irq 15 [ 2.226437] Fixed MDIO Bus: probed [ 2.227161] tun: Universal TUN/TAP device driver, 1.6 [ 2.227372] tun: (C) 1999-2004 Max Krasnyansky [ 2.236855] PPP generic driver version 2.4.2 [ 2.257480] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 2.258338] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 2.258749] uhci_hcd: USB Universal Host Controller Interface driver [ 2.259579] uhci_hcd 0000:00:01.2: PCI INT D -> Link[LNKD] -> GSI 11 (level, high) -> IRQ 11 [ 2.261337] uhci_hcd 0000:00:01.2: UHCI Host Controller [ 2.268788] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 [ 2.270248] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c080 [ 2.287591] hub 1-0:1.0: USB hub found [ 2.288821] hub 1-0:1.0: 2 ports detected [ 2.292320] usbcore: registered new interface driver libusual [ 2.293702] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.297624] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.298144] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.313108] mousedev: PS/2 mouse device common for all mice [ 2.317133] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.319038] rtc_cmos 00:05: RTC can wake from S4 [ 2.330021] rtc_cmos 00:05: rtc core: registered rtc_cmos as rtc0 [ 2.330939] rtc0: alarms up to one day, y3k, 242 bytes nvram [ 2.332407] device-mapper: uevent: version 1.0.3 [ 2.341518] device-mapper: ioctl: 4.22.0-ioctl (2011-10-19) initialised: dm-devel@redhat.com [ 2.342763] cpuidle: using governor ladder [ 2.343035] cpuidle: using governor menu [ 2.343203] EFI Variables Facility v0.08 2004-May-17 [ 2.346297] TCP cubic registered [ 2.347608] NET: Registered protocol family 10 [ 2.360509] NET: Registered protocol family 17 [ 2.360979] Registering the dns_resolver key type [ 2.390476] registered taskstats version 1 [ 2.591975] Freeing initrd memory: 4356k freed [ 2.600659] usb 1-1: new full-speed USB device number 2 using uhci_hcd [ 2.622474] Refined TSC clocksource calibration: 2294.598 MHz. [ 2.622992] Switching to clocksource tsc [ 3.022325] Magic number: 14:393:512 [ 3.023561] rtc_cmos 00:05: setting system clock to 2026-06-08 03:30:48 UTC (1780889448) [ 3.025558] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found [ 3.025816] EDD information not available. [ 3.040064] Freeing unused kernel memory: 924k freed [ 3.080868] Write protecting the kernel read-only data: 12288k [ 3.110560] Freeing unused kernel memory: 1632k freed [ 3.133669] Freeing unused kernel memory: 1200k freed [ 3.996109] udevd[83]: starting version 175 [ 8.294082] EXT4-fs (vda1): mounted filesystem with ordered data mode. Opts: (null) [ 8.944664] FDC 0 is a S82078B [ 14.138132] EXT4-fs (vda1): re-mounted. Opts: (null) [ 241.756525] INFO: task jbd2/vda1-8:196 blocked for more than 120 seconds. [ 241.757322] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 241.757928] jbd2/vda1-8 D ffffffff81806240 0 196 2 0x00000000 [ 241.758670] ffff880037ad5b60 0000000000000046 ffff880037ad5b20 ffffffff8140a97c [ 241.759221] ffff880037ad5fd8 ffff880037ad5fd8 ffff880037ad5fd8 0000000000013700 [ 241.759709] ffffffff81c0d020 ffff880037bd96e0 ffff880037ad5b40 ffff88003fc13fc0 [ 241.760387] Call Trace: [ 241.761543] [] ? do_virtblk_request+0x6c/0x90 [ 241.761970] [] ? __wait_on_buffer+0x30/0x30 [ 241.762299] [] schedule+0x3f/0x60 [ 241.762580] [] io_schedule+0x8f/0xd0 [ 241.762890] [] sleep_on_buffer+0xe/0x20 [ 241.763180] [] __wait_on_bit+0x5f/0x90 [ 241.763472] [] ? generic_make_request+0x68/0x70 [ 241.763806] [] ? __wait_on_buffer+0x30/0x30 [ 241.764234] [] out_of_line_wait_on_bit+0x7c/0x90 [ 241.764564] [] ? autoremove_wake_function+0x40/0x40 [ 241.764950] [] __wait_on_buffer+0x2e/0x30 [ 241.765245] [] __sync_dirty_buffer+0x9b/0xd0 [ 241.765549] [] sync_dirty_buffer+0x13/0x20 [ 241.765883] [] jbd2_journal_update_superblock+0xa1/0x140 [ 241.766251] [] jbd2_journal_commit_transaction+0x1113/0x1240 [ 241.766646] [] ? __switch_to+0xf5/0x360 [ 241.766954] [] ? default_spin_lock_flags+0x9/0x10 [ 241.767281] [] ? _raw_spin_lock_irqsave+0x2e/0x40 [ 241.767642] [] ? lock_timer_base.isra.29+0x38/0x70 [ 241.768260] [] ? try_to_del_timer_sync+0x92/0x130 [ 241.768508] [] kjournald2+0xbb/0x220 [ 241.768725] [] ? add_wait_queue+0x60/0x60 [ 241.768961] [] ? commit_timeout+0x10/0x10 [ 241.769231] [] kthread+0x8c/0xa0 [ 241.769421] [] kernel_thread_helper+0x4/0x10 [ 241.769633] [] ? flush_kthread_worker+0xa0/0xa0 [ 241.769894] [] ? gs_change+0x13/0x13 [ 241.770235] INFO: task run-parts:254 blocked for more than 120 seconds. [ 241.770481] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 241.770769] run-parts D 0000000000000000 0 254 1 0x00000000 [ 241.771130] ffff88003c9618e8 0000000000000082 ffff88003c9618a8 ffffffff8140a97c [ 241.771459] ffff88003c961fd8 ffff88003c961fd8 ffff88003c961fd8 0000000000013700 [ 241.771767] ffff880037b08000 ffff880037a7adc0 ffff88003c9618c8 ffff88003fc13fc0 [ 241.772230] Call Trace: [ 241.772362] [] ? do_virtblk_request+0x6c/0x90 [ 241.772583] [] ? __wait_on_buffer+0x30/0x30 [ 241.772819] [] schedule+0x3f/0x60 [ 241.773017] [] io_schedule+0x8f/0xd0 [ 241.773226] [] sleep_on_buffer+0xe/0x20 [ 241.773429] [] __wait_on_bit+0x5f/0x90 [ 241.773628] [] ? generic_make_request+0x68/0x70 [ 241.773844] [] ? __wait_on_buffer+0x30/0x30 [ 241.774063] [] out_of_line_wait_on_bit+0x7c/0x90 [ 241.774314] [] ? autoremove_wake_function+0x40/0x40 [ 241.774543] [] __wait_on_buffer+0x2e/0x30 [ 241.774746] [] __ext4_get_inode_loc+0x1c2/0x400 [ 241.774974] [] ext4_iget+0x7e/0x7d0 [ 241.775204] [] ? kmem_cache_alloc+0x112/0x120 [ 241.775440] [] ext4_lookup.part.27+0x60/0x150 [ 241.775651] [] ext4_lookup+0x25/0x30 [ 241.775838] [] d_alloc_and_lookup+0x45/0x90 [ 241.776171] [] ? d_lookup+0x35/0x60 [ 241.777289] [] do_lookup+0x202/0x310 [ 241.777486] [] ? security_inode_permission+0x1c/0x30 [ 241.777715] [] link_path_walk+0x138/0x870 [ 241.777920] [] ? ext4_dirty_inode+0x50/0x60 [ 241.778124] [] ? _raw_spin_lock+0xe/0x20 [ 241.778375] [] ? mntput_no_expire+0x30/0xf0 [ 241.778582] [] path_lookupat+0x3a8/0x750 [ 241.778780] [] ? do_wp_page+0x382/0x740 [ 241.778981] [] do_path_lookup+0x31/0xc0 [ 241.779177] [] user_path_at_empty+0x59/0xa0 [ 241.779428] [] ? do_page_fault+0x210/0x520 [ 241.779629] [] user_path_at+0x11/0x20 [ 241.779816] [] vfs_fstatat+0x3a/0x70 [ 241.780009] [] vfs_stat+0x1b/0x20 [ 241.780285] [] sys_newstat+0x1a/0x40 [ 241.780513] [] ? page_fault+0x25/0x30 [ 241.780718] [] system_call_fastpath+0x16/0x1b [ 241.780940] INFO: task mount:276 blocked for more than 120 seconds. [ 241.781148] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 241.781432] mount D ffffffff81806240 0 276 232 0x00000000 [ 241.781727] ffff88003c9f1a18 0000000000000082 ffff88003c9f19d8 ffffffff8140a97c [ 241.782029] ffff88003c9f1fd8 ffff88003c9f1fd8 ffff88003c9f1fd8 0000000000013700 [ 241.782339] ffffffff81c0d020 ffff880037b08000 ffff88003c9f19f8 ffff88003fc13fc0 [ 241.782654] Call Trace: [ 241.782766] [] ? do_virtblk_request+0x6c/0x90 [ 241.782982] [] ? __wait_on_buffer+0x30/0x30 [ 241.783187] [] schedule+0x3f/0x60 [ 241.783380] [] io_schedule+0x8f/0xd0 [ 241.783583] [] sleep_on_buffer+0xe/0x20 [ 241.783773] [] __wait_on_bit+0x5f/0x90 [ 241.783972] [] ? generic_make_request+0x68/0x70 [ 241.784276] [] ? __wait_on_buffer+0x30/0x30 [ 241.784501] [] out_of_line_wait_on_bit+0x7c/0x90 [ 241.784753] [] ? autoremove_wake_function+0x40/0x40 [ 241.784986] [] __wait_on_buffer+0x2e/0x30 [ 241.785183] [] bh_submit_read+0x60/0x80 [ 241.785386] [] ext4_read_inode_bitmap+0x14f/0x350 [ 241.785609] [] ext4_new_inode+0x146/0xb10 [ 241.785808] [] ? ext4_lookup.part.27+0x75/0x150 [ 241.786027] [] ext4_create+0xb8/0x140 [ 241.786215] [] vfs_create+0xb4/0x120 [ 241.786473] [] do_last+0x5c9/0x730 [ 241.786658] [] path_openat+0xd1/0x3f0 [ 241.786845] [] ? putname+0x35/0x50 [ 241.787044] [] do_filp_open+0x42/0xa0 [ 241.787237] [] ? strncpy_from_user+0x31/0x40 [ 241.787490] [] ? do_getname+0x10a/0x180 [ 241.787684] [] ? _raw_spin_lock+0xe/0x20 [ 241.787887] [] ? alloc_fd+0xf7/0x150 [ 241.788148] [] do_sys_open+0xf8/0x240 [ 241.788342] [] ? set_current_blocked+0x52/0x70 [ 241.788581] [] sys_open+0x20/0x30 [ 241.789233] [] system_call_fastpath+0x16/0x1b [ 361.788409] INFO: task jbd2/vda1-8:196 blocked for more than 120 seconds. [ 361.789270] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 361.789772] jbd2/vda1-8 D ffffffff81806240 0 196 2 0x00000000 [ 361.790251] ffff880037ad5b60 0000000000000046 ffff880037ad5b20 ffffffff8140a97c [ 361.790764] ffff880037ad5fd8 ffff880037ad5fd8 ffff880037ad5fd8 0000000000013700 [ 361.791297] ffffffff81c0d020 ffff880037bd96e0 ffff880037ad5b40 ffff88003fc13fc0 [ 361.791787] Call Trace: [ 361.792022] [] ? do_virtblk_request+0x6c/0x90 [ 361.792569] [] ? __wait_on_buffer+0x30/0x30 [ 361.792957] [] schedule+0x3f/0x60 [ 361.793246] [] io_schedule+0x8f/0xd0 [ 361.793569] [] sleep_on_buffer+0xe/0x20 [ 361.793894] [] __wait_on_bit+0x5f/0x90 [ 361.794210] [] ? generic_make_request+0x68/0x70 [ 361.794579] [] ? __wait_on_buffer+0x30/0x30 [ 361.795104] [] out_of_line_wait_on_bit+0x7c/0x90 [ 361.795706] [] ? autoremove_wake_function+0x40/0x40 [ 361.796244] [] __wait_on_buffer+0x2e/0x30 [ 361.796595] [] __sync_dirty_buffer+0x9b/0xd0 [ 361.797001] [] sync_dirty_buffer+0x13/0x20 [ 361.797345] [] jbd2_journal_update_superblock+0xa1/0x140 [ 361.797779] [] jbd2_journal_commit_transaction+0x1113/0x1240 [ 361.798222] [] ? __switch_to+0xf5/0x360 [ 361.798532] [] ? default_spin_lock_flags+0x9/0x10 [ 361.798908] [] ? _raw_spin_lock_irqsave+0x2e/0x40 [ 361.799258] [] ? lock_timer_base.isra.29+0x38/0x70 [ 361.799613] [] ? try_to_del_timer_sync+0x92/0x130 [ 361.800012] [] kjournald2+0xbb/0x220 [ 361.800479] [] ? add_wait_queue+0x60/0x60 [ 361.800920] [] ? commit_timeout+0x10/0x10 [ 361.801259] [] kthread+0x8c/0xa0 [ 361.801552] [] kernel_thread_helper+0x4/0x10 [ 361.801936] [] ? flush_kthread_worker+0xa0/0xa0 [ 361.802282] [] ? gs_change+0x13/0x13 [ 361.802832] INFO: task run-parts:254 blocked for more than 120 seconds. [ 361.803232] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 361.803678] run-parts D 0000000000000000 0 254 1 0x00000000 [ 361.804254] ffff88003c9618e8 0000000000000082 ffff88003c9618a8 ffffffff8140a97c [ 361.804801] ffff88003c961fd8 ffff88003c961fd8 ffff88003c961fd8 0000000000013700 [ 361.805343] ffff880037b08000 ffff880037a7adc0 ffff88003c9618c8 ffff88003fc13fc0 [ 361.805814] Call Trace: [ 361.806030] [] ? do_virtblk_request+0x6c/0x90 [ 361.806365] [] ? __wait_on_buffer+0x30/0x30 [ 361.806686] [] schedule+0x3f/0x60 [ 361.807036] [] io_schedule+0x8f/0xd0 [ 361.807334] [] sleep_on_buffer+0xe/0x20 [ 361.807637] [] __wait_on_bit+0x5f/0x90 [ 361.807954] [] ? generic_make_request+0x68/0x70 [ 361.808469] [] ? __wait_on_buffer+0x30/0x30 [ 361.808849] [] out_of_line_wait_on_bit+0x7c/0x90 [ 361.809242] [] ? autoremove_wake_function+0x40/0x40 [ 361.809604] [] __wait_on_buffer+0x2e/0x30 [ 361.809930] [] __ext4_get_inode_loc+0x1c2/0x400 [ 361.810286] [] ext4_iget+0x7e/0x7d0 [ 361.810565] [] ? kmem_cache_alloc+0x112/0x120 [ 361.810899] [] ext4_lookup.part.27+0x60/0x150 [ 361.811253] [] ext4_lookup+0x25/0x30 [ 361.811555] [] d_alloc_and_lookup+0x45/0x90 [ 361.811915] [] ? d_lookup+0x35/0x60 [ 361.812392] [] do_lookup+0x202/0x310 [ 361.812763] [] ? security_inode_permission+0x1c/0x30 [ 361.813128] [] link_path_walk+0x138/0x870 [ 361.813468] [] ? ext4_dirty_inode+0x50/0x60 [ 361.813786] [] ? _raw_spin_lock+0xe/0x20 [ 361.814111] [] ? mntput_no_expire+0x30/0xf0 [ 361.814548] [] path_lookupat+0x3a8/0x750 [ 361.814885] [] ? do_wp_page+0x382/0x740 [ 361.815198] [] do_path_lookup+0x31/0xc0 [ 361.815526] [] user_path_at_empty+0x59/0xa0 [ 361.815866] [] ? do_page_fault+0x210/0x520 [ 361.816576] [] user_path_at+0x11/0x20 [ 361.816945] [] vfs_fstatat+0x3a/0x70 [ 361.817247] [] vfs_stat+0x1b/0x20 [ 361.817568] [] sys_newstat+0x1a/0x40 [ 361.817877] [] ? page_fault+0x25/0x30 [ 361.818187] [] system_call_fastpath+0x16/0x1b [ 361.818585] INFO: task mount:276 blocked for more than 120 seconds. [ 361.818944] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 361.819385] mount D ffffffff81806240 0 276 232 0x00000000 [ 361.819833] ffff88003c9f1a18 0000000000000082 ffff88003c9f19d8 ffffffff8140a97c [ 361.820476] ffff88003c9f1fd8 ffff88003c9f1fd8 ffff88003c9f1fd8 0000000000013700 [ 361.821037] ffffffff81c0d020 ffff880037b08000 ffff88003c9f19f8 ffff88003fc13fc0 [ 361.821531] Call Trace: [ 361.821723] [] ? do_virtblk_request+0x6c/0x90 [ 361.822070] [] ? __wait_on_buffer+0x30/0x30 [ 361.822444] [] schedule+0x3f/0x60 [ 361.822767] [] io_schedule+0x8f/0xd0 [ 361.823080] [] sleep_on_buffer+0xe/0x20 [ 361.823391] [] __wait_on_bit+0x5f/0x90 [ 361.823724] [] ? generic_make_request+0x68/0x70 [ 361.824254] [] ? __wait_on_buffer+0x30/0x30 [ 361.824588] [] out_of_line_wait_on_bit+0x7c/0x90 [ 361.825001] [] ? autoremove_wake_function+0x40/0x40 [ 361.825361] [] __wait_on_buffer+0x2e/0x30 [ 361.825703] [] bh_submit_read+0x60/0x80 [ 361.826022] [] ext4_read_inode_bitmap+0x14f/0x350 [ 361.826339] [] ext4_new_inode+0x146/0xb10 [ 361.826541] [] ? ext4_lookup.part.27+0x75/0x150 [ 361.826768] [] ext4_create+0xb8/0x140 [ 361.826979] [] vfs_create+0xb4/0x120 [ 361.827165] [] do_last+0x5c9/0x730 [ 361.827344] [] path_openat+0xd1/0x3f0 [ 361.827568] [] ? putname+0x35/0x50 [ 361.828300] [] do_filp_open+0x42/0xa0 [ 361.828639] [] ? strncpy_from_user+0x31/0x40 [ 361.829171] [] ? do_getname+0x10a/0x180 [ 361.829507] [] ? _raw_spin_lock+0xe/0x20 [ 361.829812] [] ? alloc_fd+0xf7/0x150 [ 361.830021] [] do_sys_open+0xf8/0x240 [ 361.830268] [] ? set_current_blocked+0x52/0x70 [ 361.831778] [] sys_open+0x20/0x30 [ 361.832051] [] system_call_fastpath+0x16/0x1b 2026-06-08 03:37:40,105 - ERROR - VM ctest-vm1-test-41561165 does not seem to be fully up. Check logs 2026-06-08 03:37:40,293 - DEBUG - [ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Linux version 3.2.0-35-virtual (buildd@allspice) (gcc version 4.6.3 (Ubuntu/Linaro 4.6.3-1ubuntu5) ) #55-Ubuntu SMP Wed Dec 5 18:02:05 UTC 2012 (Ubuntu 3.2.0-35.55-virtual 3.2.34) [ 0.000000] Command line: BOOT_IMAGE=/boot/vmlinuz-3.2.0-35-virtual root=UUID=02147f18-c4e2-47d4-ba41-a162651517cb ro console=ttyS0 console=tty0 rootdelay=1800 [ 0.000000] KERNEL supported cpus: [ 0.000000] Intel GenuineIntel [ 0.000000] AMD AuthenticAMD [ 0.000000] Centaur CentaurHauls [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: 0000000000000000 - 000000000009fc00 (usable) [ 0.000000] BIOS-e820: 000000000009fc00 - 00000000000a0000 (reserved) [ 0.000000] BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved) [ 0.000000] BIOS-e820: 0000000000100000 - 000000003ffdb000 (usable) [ 0.000000] BIOS-e820: 000000003ffdb000 - 0000000040000000 (reserved) [ 0.000000] BIOS-e820: 00000000fffc0000 - 0000000100000000 (reserved) [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] DMI 2.8 present. [ 0.000000] No AGP bridge found [ 0.000000] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000 [ 0.000000] x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106 [ 0.000000] found SMP MP-table at [ffff8800000f5b30] f5b30 [ 0.000000] Using GB pages for direct mapping [ 0.000000] init_memory_mapping: 0000000000000000-000000003ffdb000 [ 0.000000] RAMDISK: 3776e000 - 37baf000 [ 0.000000] ACPI: RSDP 00000000000f5900 00014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 000000003ffe17da 00030 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 000000003ffe16c6 00074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 000000003ffe0040 01686 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 000000003ffe0000 00040 [ 0.000000] ACPI: APIC 000000003ffe173a 00078 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 000000003ffe17b2 00028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at 0000000000000000-000000003ffdb000 [ 0.000000] Initmem setup node 0 0000000000000000-000000003ffdb000 [ 0.000000] NODE_DATA [000000003ffd6000 - 000000003ffdafff] [ 0.000000] Zone PFN ranges: [ 0.000000] DMA 0x00000010 -> 0x00001000 [ 0.000000] DMA32 0x00001000 -> 0x00100000 [ 0.000000] Normal empty [ 0.000000] Movable zone start PFN for each node [ 0.000000] early_node_map[2] active PFN ranges [ 0.000000] 0: 0x00000010 -> 0x0000009f [ 0.000000] 0: 0x00000100 -> 0x0003ffdb [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled) [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0]) [ 0.000000] IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] SMP: Allowing 1 CPUs, 0 hotplug CPUs [ 0.000000] PM: Registered nosave memory: 000000000009f000 - 00000000000a0000 [ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000 [ 0.000000] PM: Registered nosave memory: 00000000000f0000 - 0000000000100000 [ 0.000000] Allocating PCI resources starting at 40000000 (gap: 40000000:bffc0000) [ 0.000000] Booting paravirtualized kernel on bare hardware [ 0.000000] setup_percpu: NR_CPUS:64 nr_cpumask_bits:64 nr_cpu_ids:1 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 28 pages/cpu @ffff88003fc00000 s82880 r8192 d23616 u2097152 [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 257893 [ 0.000000] Policy zone: DMA32 [ 0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-3.2.0-35-virtual root=UUID=02147f18-c4e2-47d4-ba41-a162651517cb ro console=ttyS0 console=tty0 rootdelay=1800 [ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes) [ 0.000000] xsave/xrstor: enabled xstate_bv 0x3, cntxt size 0x240 [ 0.000000] Checking aperture... [ 0.000000] No AGP bridge found [ 0.000000] Memory: 1011328k/1048428k available (6540k kernel code, 452k absent, 36648k reserved, 6652k data, 924k init) [ 0.000000] SLUB: Genslabs=15, HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU dyntick-idle grace-period acceleration is enabled. [ 0.000000] NR_IRQS:4352 nr_irqs:256 16 [ 0.000000] Console: colour VGA+ 80x25 [ 0.000000] console [tty0] enabled [ 0.000000] console [ttyS0] enabled [ 0.000000] allocated 8388608 bytes of page_cgroup [ 0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups [ 0.000000] Fast TSC calibration using PIT [ 0.000000] Detected 2294.615 MHz processor. [ 0.017177] Calibrating delay loop (skipped), value calculated using timer frequency.. 4589.23 BogoMIPS (lpj=9178460) [ 0.018523] pid_max: default: 32768 minimum: 301 [ 0.022554] Security Framework initialized [ 0.027850] AppArmor: AppArmor initialized [ 0.028088] Yama: becoming mindful. [ 0.035125] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes) [ 0.037948] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes) [ 0.039547] Mount-cache hash table entries: 256 [ 0.051747] Initializing cgroup subsys cpuacct [ 0.052249] Initializing cgroup subsys memory [ 0.053361] Initializing cgroup subsys devices [ 0.053661] Initializing cgroup subsys freezer [ 0.053893] Initializing cgroup subsys blkio [ 0.054431] Initializing cgroup subsys perf_event [ 0.218357] mce: CPU supports 10 MCE banks [ 0.220802] using AMD E400 aware idle routine [ 0.225829] SMP alternatives: switching to UP code [ 0.468816] Freeing SMP alternatives: 24k freed [ 0.469678] ACPI: Core revision 20110623 [ 0.511700] ftrace: allocating 27024 entries in 106 pages [ 0.541081] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.581863] CPU0: AMD Opteron 23xx (Gen 3 Class Opteron) stepping 03 [ 0.584035] Performance Events: Broken PMU hardware detected, using software events only. [ 0.590663] NMI watchdog disabled (cpu0): hardware events not enabled [ 0.591904] Brought up 1 CPUs [ 0.592190] Total of 1 processors activated (4589.23 BogoMIPS). [ 0.613291] devtmpfs: initialized [ 0.623617] EVM: security.selinux [ 0.623867] EVM: security.SMACK64 [ 0.624060] EVM: security.capability [ 0.636893] print_constraints: dummy: [ 0.638228] RTC time: 3:30:46, date: 06/08/26 [ 0.640149] NET: Registered protocol family 16 [ 0.645801] Extended Config Space enabled on 0 nodes [ 0.646789] ACPI: bus type pci registered [ 0.649552] PCI: Using configuration type 1 for base access [ 0.649848] PCI: Using configuration type 1 for extended access [ 0.673138] bio: create slab at 0 [ 0.676718] ACPI: Added _OSI(Module Device) [ 0.676970] ACPI: Added _OSI(Processor Device) [ 0.677155] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.677366] ACPI: Added _OSI(Processor Aggregator Device) [ 0.704692] ACPI: Interpreter enabled [ 0.705004] ACPI: (supports S0 S5) [ 0.705935] ACPI: Using IOAPIC for interrupt routing [ 0.742259] ACPI: No dock devices found. [ 0.742580] HEST: Table not found. [ 0.742826] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.745437] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.748046] pci_root PNP0A03:00: host bridge window [io 0x0000-0x0cf7] [ 0.748120] pci_root PNP0A03:00: host bridge window [io 0x0d00-0xffff] [ 0.748394] pci_root PNP0A03:00: host bridge window [mem 0x000a0000-0x000bffff] [ 0.748676] pci_root PNP0A03:00: host bridge window [mem 0x40000000-0xfebfffff] [ 0.748935] pci_root PNP0A03:00: host bridge window [mem 0x100000000-0x17fffffff] [ 0.761911] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.762313] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 1.362028] pci0000:00: Requesting ACPI _OSC control (0x1d) [ 1.362522] pci0000:00: ACPI _OSC request failed (AE_NOT_FOUND), returned control mask: 0x1d [ 1.362826] ACPI _OSC control for PCIe not granted, disabling ASPM [ 1.394990] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 1.396086] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 1.396520] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 1.397226] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 1.397766] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 1.403217] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none [ 1.403609] vgaarb: loaded [ 1.403758] vgaarb: bridge control possible 0000:00:02.0 [ 1.406029] i2c-core: driver [aat2870] using legacy suspend method [ 1.406295] i2c-core: driver [aat2870] using legacy resume method [ 1.408949] SCSI subsystem initialized [ 1.411624] usbcore: registered new interface driver usbfs [ 1.412673] usbcore: registered new interface driver hub [ 1.413599] usbcore: registered new device driver usb [ 1.417272] PCI: Using ACPI for IRQ routing [ 1.426761] NetLabel: Initializing [ 1.427020] NetLabel: domain hash size = 128 [ 1.427194] NetLabel: protocols = UNLABELED CIPSOv4 [ 1.428703] NetLabel: unlabeled traffic allowed by default [ 1.512661] AppArmor: AppArmor Filesystem Enabled [ 1.513903] pnp: PnP ACPI init [ 1.514396] ACPI: bus type pnp registered [ 1.524225] pnp: PnP ACPI: found 9 devices [ 1.524504] ACPI: ACPI bus type pnp unregistered [ 1.556544] Switching to clocksource acpi_pm [ 1.559281] NET: Registered protocol family 2 [ 1.565848] IP route cache hash table entries: 32768 (order: 6, 262144 bytes) [ 1.576536] TCP established hash table entries: 131072 (order: 9, 2097152 bytes) [ 1.581178] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes) [ 1.583303] TCP: Hash tables configured (established 131072 bind 65536) [ 1.583719] TCP reno registered [ 1.584249] UDP hash table entries: 512 (order: 2, 16384 bytes) [ 1.584677] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes) [ 1.587091] NET: Registered protocol family 1 [ 1.587658] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 1.587988] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 1.589639] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 1.593154] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11 [ 1.593731] pci 0000:00:01.2: PCI INT D -> Link[LNKD] -> GSI 11 (level, high) -> IRQ 11 [ 1.595099] pci 0000:00:01.2: PCI INT D disabled [ 1.608284] Trying to unpack rootfs image as initramfs... [ 1.629162] audit: initializing netlink socket (disabled) [ 1.630246] type=2000 audit(1780889446.628:1): initialized [ 1.765796] HugeTLB registered 2 MB page size, pre-allocated 0 pages [ 1.804593] VFS: Disk quotas dquot_6.5.2 [ 1.805447] Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 1.825471] fuse init (API version 7.17) [ 1.827870] msgmni has been set to 1975 [ 1.854240] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253) [ 1.855316] io scheduler noop registered [ 1.855609] io scheduler deadline registered (default) [ 1.856537] io scheduler cfq registered [ 1.858847] pci_hotplug: PCI Hot Plug PCI Core version: 0.5 [ 1.860440] pciehp: PCI Express Hot Plug Controller Driver version: 0.4 [ 1.864550] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 1.865669] ACPI: Power Button [PWRF] [ 1.880746] ERST: Table is not found! [ 1.881036] GHES: HEST is not enabled! [ 1.890161] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 10 [ 1.890568] virtio-pci 0000:00:03.0: PCI INT A -> Link[LNKC] -> GSI 10 (level, high) -> IRQ 10 [ 1.893495] virtio-pci 0000:00:04.0: PCI INT A -> Link[LNKD] -> GSI 11 (level, high) -> IRQ 11 [ 1.901734] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10 [ 1.902090] virtio-pci 0000:00:05.0: PCI INT A -> Link[LNKA] -> GSI 10 (level, high) -> IRQ 10 [ 1.909052] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 11 [ 1.909566] virtio-pci 0000:00:06.0: PCI INT A -> Link[LNKB] -> GSI 11 (level, high) -> IRQ 11 [ 1.911122] virtio-pci 0000:00:07.0: PCI INT A -> Link[LNKC] -> GSI 10 (level, high) -> IRQ 10 [ 1.921289] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled [ 1.945321] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A [ 2.020206] 00:01: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A [ 2.061407] Linux agpgart interface v0.103 [ 2.094867] brd: module loaded [ 2.111254] loop: module loaded [ 2.159358] vda: vda1 [ 2.209858] scsi0 : ata_piix [ 2.216641] scsi1 : ata_piix [ 2.218386] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc100 irq 14 [ 2.218883] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc108 irq 15 [ 2.226437] Fixed MDIO Bus: probed [ 2.227161] tun: Universal TUN/TAP device driver, 1.6 [ 2.227372] tun: (C) 1999-2004 Max Krasnyansky [ 2.236855] PPP generic driver version 2.4.2 [ 2.257480] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 2.258338] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 2.258749] uhci_hcd: USB Universal Host Controller Interface driver [ 2.259579] uhci_hcd 0000:00:01.2: PCI INT D -> Link[LNKD] -> GSI 11 (level, high) -> IRQ 11 [ 2.261337] uhci_hcd 0000:00:01.2: UHCI Host Controller [ 2.268788] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 [ 2.270248] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c080 [ 2.287591] hub 1-0:1.0: USB hub found [ 2.288821] hub 1-0:1.0: 2 ports detected [ 2.292320] usbcore: registered new interface driver libusual [ 2.293702] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.297624] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.298144] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.313108] mousedev: PS/2 mouse device common for all mice [ 2.317133] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.319038] rtc_cmos 00:05: RTC can wake from S4 [ 2.330021] rtc_cmos 00:05: rtc core: registered rtc_cmos as rtc0 [ 2.330939] rtc0: alarms up to one day, y3k, 242 bytes nvram [ 2.332407] device-mapper: uevent: version 1.0.3 [ 2.341518] device-mapper: ioctl: 4.22.0-ioctl (2011-10-19) initialised: dm-devel@redhat.com [ 2.342763] cpuidle: using governor ladder [ 2.343035] cpuidle: using governor menu [ 2.343203] EFI Variables Facility v0.08 2004-May-17 [ 2.346297] TCP cubic registered [ 2.347608] NET: Registered protocol family 10 [ 2.360509] NET: Registered protocol family 17 [ 2.360979] Registering the dns_resolver key type [ 2.390476] registered taskstats version 1 [ 2.591975] Freeing initrd memory: 4356k freed [ 2.600659] usb 1-1: new full-speed USB device number 2 using uhci_hcd [ 2.622474] Refined TSC clocksource calibration: 2294.598 MHz. [ 2.622992] Switching to clocksource tsc [ 3.022325] Magic number: 14:393:512 [ 3.023561] rtc_cmos 00:05: setting system clock to 2026-06-08 03:30:48 UTC (1780889448) [ 3.025558] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found [ 3.025816] EDD information not available. [ 3.040064] Freeing unused kernel memory: 924k freed [ 3.080868] Write protecting the kernel read-only data: 12288k [ 3.110560] Freeing unused kernel memory: 1632k freed [ 3.133669] Freeing unused kernel memory: 1200k freed [ 3.996109] udevd[83]: starting version 175 [ 8.294082] EXT4-fs (vda1): mounted filesystem with ordered data mode. Opts: (null) [ 8.944664] FDC 0 is a S82078B [ 14.138132] EXT4-fs (vda1): re-mounted. Opts: (null) [ 241.756525] INFO: task jbd2/vda1-8:196 blocked for more than 120 seconds. [ 241.757322] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 241.757928] jbd2/vda1-8 D ffffffff81806240 0 196 2 0x00000000 [ 241.758670] ffff880037ad5b60 0000000000000046 ffff880037ad5b20 ffffffff8140a97c [ 241.759221] ffff880037ad5fd8 ffff880037ad5fd8 ffff880037ad5fd8 0000000000013700 [ 241.759709] ffffffff81c0d020 ffff880037bd96e0 ffff880037ad5b40 ffff88003fc13fc0 [ 241.760387] Call Trace: [ 241.761543] [] ? do_virtblk_request+0x6c/0x90 [ 241.761970] [] ? __wait_on_buffer+0x30/0x30 [ 241.762299] [] schedule+0x3f/0x60 [ 241.762580] [] io_schedule+0x8f/0xd0 [ 241.762890] [] sleep_on_buffer+0xe/0x20 [ 241.763180] [] __wait_on_bit+0x5f/0x90 [ 241.763472] [] ? generic_make_request+0x68/0x70 [ 241.763806] [] ? __wait_on_buffer+0x30/0x30 [ 241.764234] [] out_of_line_wait_on_bit+0x7c/0x90 [ 241.764564] [] ? autoremove_wake_function+0x40/0x40 [ 241.764950] [] __wait_on_buffer+0x2e/0x30 [ 241.765245] [] __sync_dirty_buffer+0x9b/0xd0 [ 241.765549] [] sync_dirty_buffer+0x13/0x20 [ 241.765883] [] jbd2_journal_update_superblock+0xa1/0x140 [ 241.766251] [] jbd2_journal_commit_transaction+0x1113/0x1240 [ 241.766646] [] ? __switch_to+0xf5/0x360 [ 241.766954] [] ? default_spin_lock_flags+0x9/0x10 [ 241.767281] [] ? _raw_spin_lock_irqsave+0x2e/0x40 [ 241.767642] [] ? lock_timer_base.isra.29+0x38/0x70 [ 241.768260] [] ? try_to_del_timer_sync+0x92/0x130 [ 241.768508] [] kjournald2+0xbb/0x220 [ 241.768725] [] ? add_wait_queue+0x60/0x60 [ 241.768961] [] ? commit_timeout+0x10/0x10 [ 241.769231] [] kthread+0x8c/0xa0 [ 241.769421] [] kernel_thread_helper+0x4/0x10 [ 241.769633] [] ? flush_kthread_worker+0xa0/0xa0 [ 241.769894] [] ? gs_change+0x13/0x13 [ 241.770235] INFO: task run-parts:254 blocked for more than 120 seconds. [ 241.770481] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 241.770769] run-parts D 0000000000000000 0 254 1 0x00000000 [ 241.771130] ffff88003c9618e8 0000000000000082 ffff88003c9618a8 ffffffff8140a97c [ 241.771459] ffff88003c961fd8 ffff88003c961fd8 ffff88003c961fd8 0000000000013700 [ 241.771767] ffff880037b08000 ffff880037a7adc0 ffff88003c9618c8 ffff88003fc13fc0 [ 241.772230] Call Trace: [ 241.772362] [] ? do_virtblk_request+0x6c/0x90 [ 241.772583] [] ? __wait_on_buffer+0x30/0x30 [ 241.772819] [] schedule+0x3f/0x60 [ 241.773017] [] io_schedule+0x8f/0xd0 [ 241.773226] [] sleep_on_buffer+0xe/0x20 [ 241.773429] [] __wait_on_bit+0x5f/0x90 [ 241.773628] [] ? generic_make_request+0x68/0x70 [ 241.773844] [] ? __wait_on_buffer+0x30/0x30 [ 241.774063] [] out_of_line_wait_on_bit+0x7c/0x90 [ 241.774314] [] ? autoremove_wake_function+0x40/0x40 [ 241.774543] [] __wait_on_buffer+0x2e/0x30 [ 241.774746] [] __ext4_get_inode_loc+0x1c2/0x400 [ 241.774974] [] ext4_iget+0x7e/0x7d0 [ 241.775204] [] ? kmem_cache_alloc+0x112/0x120 [ 241.775440] [] ext4_lookup.part.27+0x60/0x150 [ 241.775651] [] ext4_lookup+0x25/0x30 [ 241.775838] [] d_alloc_and_lookup+0x45/0x90 [ 241.776171] [] ? d_lookup+0x35/0x60 [ 241.777289] [] do_lookup+0x202/0x310 [ 241.777486] [] ? security_inode_permission+0x1c/0x30 [ 241.777715] [] link_path_walk+0x138/0x870 [ 241.777920] [] ? ext4_dirty_inode+0x50/0x60 [ 241.778124] [] ? _raw_spin_lock+0xe/0x20 [ 241.778375] [] ? mntput_no_expire+0x30/0xf0 [ 241.778582] [] path_lookupat+0x3a8/0x750 [ 241.778780] [] ? do_wp_page+0x382/0x740 [ 241.778981] [] do_path_lookup+0x31/0xc0 [ 241.779177] [] user_path_at_empty+0x59/0xa0 [ 241.779428] [] ? do_page_fault+0x210/0x520 [ 241.779629] [] user_path_at+0x11/0x20 [ 241.779816] [] vfs_fstatat+0x3a/0x70 [ 241.780009] [] vfs_stat+0x1b/0x20 [ 241.780285] [] sys_newstat+0x1a/0x40 [ 241.780513] [] ? page_fault+0x25/0x30 [ 241.780718] [] system_call_fastpath+0x16/0x1b [ 241.780940] INFO: task mount:276 blocked for more than 120 seconds. [ 241.781148] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 241.781432] mount D ffffffff81806240 0 276 232 0x00000000 [ 241.781727] ffff88003c9f1a18 0000000000000082 ffff88003c9f19d8 ffffffff8140a97c [ 241.782029] ffff88003c9f1fd8 ffff88003c9f1fd8 ffff88003c9f1fd8 0000000000013700 [ 241.782339] ffffffff81c0d020 ffff880037b08000 ffff88003c9f19f8 ffff88003fc13fc0 [ 241.782654] Call Trace: [ 241.782766] [] ? do_virtblk_request+0x6c/0x90 [ 241.782982] [] ? __wait_on_buffer+0x30/0x30 [ 241.783187] [] schedule+0x3f/0x60 [ 241.783380] [] io_schedule+0x8f/0xd0 [ 241.783583] [] sleep_on_buffer+0xe/0x20 [ 241.783773] [] __wait_on_bit+0x5f/0x90 [ 241.783972] [] ? generic_make_request+0x68/0x70 [ 241.784276] [] ? __wait_on_buffer+0x30/0x30 [ 241.784501] [] out_of_line_wait_on_bit+0x7c/0x90 [ 241.784753] [] ? autoremove_wake_function+0x40/0x40 [ 241.784986] [] __wait_on_buffer+0x2e/0x30 [ 241.785183] [] bh_submit_read+0x60/0x80 [ 241.785386] [] ext4_read_inode_bitmap+0x14f/0x350 [ 241.785609] [] ext4_new_inode+0x146/0xb10 [ 241.785808] [] ? ext4_lookup.part.27+0x75/0x150 [ 241.786027] [] ext4_create+0xb8/0x140 [ 241.786215] [] vfs_create+0xb4/0x120 [ 241.786473] [] do_last+0x5c9/0x730 [ 241.786658] [] path_openat+0xd1/0x3f0 [ 241.786845] [] ? putname+0x35/0x50 [ 241.787044] [] do_filp_open+0x42/0xa0 [ 241.787237] [] ? strncpy_from_user+0x31/0x40 [ 241.787490] [] ? do_getname+0x10a/0x180 [ 241.787684] [] ? _raw_spin_lock+0xe/0x20 [ 241.787887] [] ? alloc_fd+0xf7/0x150 [ 241.788148] [] do_sys_open+0xf8/0x240 [ 241.788342] [] ? set_current_blocked+0x52/0x70 [ 241.788581] [] sys_open+0x20/0x30 [ 241.789233] [] system_call_fastpath+0x16/0x1b [ 361.788409] INFO: task jbd2/vda1-8:196 blocked for more than 120 seconds. [ 361.789270] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 361.789772] jbd2/vda1-8 D ffffffff81806240 0 196 2 0x00000000 [ 361.790251] ffff880037ad5b60 0000000000000046 ffff880037ad5b20 ffffffff8140a97c [ 361.790764] ffff880037ad5fd8 ffff880037ad5fd8 ffff880037ad5fd8 0000000000013700 [ 361.791297] ffffffff81c0d020 ffff880037bd96e0 ffff880037ad5b40 ffff88003fc13fc0 [ 361.791787] Call Trace: [ 361.792022] [] ? do_virtblk_request+0x6c/0x90 [ 361.792569] [] ? __wait_on_buffer+0x30/0x30 [ 361.792957] [] schedule+0x3f/0x60 [ 361.793246] [] io_schedule+0x8f/0xd0 [ 361.793569] [] sleep_on_buffer+0xe/0x20 [ 361.793894] [] __wait_on_bit+0x5f/0x90 [ 361.794210] [] ? generic_make_request+0x68/0x70 [ 361.794579] [] ? __wait_on_buffer+0x30/0x30 [ 361.795104] [] out_of_line_wait_on_bit+0x7c/0x90 [ 361.795706] [] ? autoremove_wake_function+0x40/0x40 [ 361.796244] [] __wait_on_buffer+0x2e/0x30 [ 361.796595] [] __sync_dirty_buffer+0x9b/0xd0 [ 361.797001] [] sync_dirty_buffer+0x13/0x20 [ 361.797345] [] jbd2_journal_update_superblock+0xa1/0x140 [ 361.797779] [] jbd2_journal_commit_transaction+0x1113/0x1240 [ 361.798222] [] ? __switch_to+0xf5/0x360 [ 361.798532] [] ? default_spin_lock_flags+0x9/0x10 [ 361.798908] [] ? _raw_spin_lock_irqsave+0x2e/0x40 [ 361.799258] [] ? lock_timer_base.isra.29+0x38/0x70 [ 361.799613] [] ? try_to_del_timer_sync+0x92/0x130 [ 361.800012] [] kjournald2+0xbb/0x220 [ 361.800479] [] ? add_wait_queue+0x60/0x60 [ 361.800920] [] ? commit_timeout+0x10/0x10 [ 361.801259] [] kthread+0x8c/0xa0 [ 361.801552] [] kernel_thread_helper+0x4/0x10 [ 361.801936] [] ? flush_kthread_worker+0xa0/0xa0 [ 361.802282] [] ? gs_change+0x13/0x13 [ 361.802832] INFO: task run-parts:254 blocked for more than 120 seconds. [ 361.803232] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 361.803678] run-parts D 0000000000000000 0 254 1 0x00000000 [ 361.804254] ffff88003c9618e8 0000000000000082 ffff88003c9618a8 ffffffff8140a97c [ 361.804801] ffff88003c961fd8 ffff88003c961fd8 ffff88003c961fd8 0000000000013700 [ 361.805343] ffff880037b08000 ffff880037a7adc0 ffff88003c9618c8 ffff88003fc13fc0 [ 361.805814] Call Trace: [ 361.806030] [] ? do_virtblk_request+0x6c/0x90 [ 361.806365] [] ? __wait_on_buffer+0x30/0x30 [ 361.806686] [] schedule+0x3f/0x60 [ 361.807036] [] io_schedule+0x8f/0xd0 [ 361.807334] [] sleep_on_buffer+0xe/0x20 [ 361.807637] [] __wait_on_bit+0x5f/0x90 [ 361.807954] [] ? generic_make_request+0x68/0x70 [ 361.808469] [] ? __wait_on_buffer+0x30/0x30 [ 361.808849] [] out_of_line_wait_on_bit+0x7c/0x90 [ 361.809242] [] ? autoremove_wake_function+0x40/0x40 [ 361.809604] [] __wait_on_buffer+0x2e/0x30 [ 361.809930] [] __ext4_get_inode_loc+0x1c2/0x400 [ 361.810286] [] ext4_iget+0x7e/0x7d0 [ 361.810565] [] ? kmem_cache_alloc+0x112/0x120 [ 361.810899] [] ext4_lookup.part.27+0x60/0x150 [ 361.811253] [] ext4_lookup+0x25/0x30 [ 361.811555] [] d_alloc_and_lookup+0x45/0x90 [ 361.811915] [] ? d_lookup+0x35/0x60 [ 361.812392] [] do_lookup+0x202/0x310 [ 361.812763] [] ? security_inode_permission+0x1c/0x30 [ 361.813128] [] link_path_walk+0x138/0x870 [ 361.813468] [] ? ext4_dirty_inode+0x50/0x60 [ 361.813786] [] ? _raw_spin_lock+0xe/0x20 [ 361.814111] [] ? mntput_no_expire+0x30/0xf0 [ 361.814548] [] path_lookupat+0x3a8/0x750 [ 361.814885] [] ? do_wp_page+0x382/0x740 [ 361.815198] [] do_path_lookup+0x31/0xc0 [ 361.815526] [] user_path_at_empty+0x59/0xa0 [ 361.815866] [] ? do_page_fault+0x210/0x520 [ 361.816576] [] user_path_at+0x11/0x20 [ 361.816945] [] vfs_fstatat+0x3a/0x70 [ 361.817247] [] vfs_stat+0x1b/0x20 [ 361.817568] [] sys_newstat+0x1a/0x40 [ 361.817877] [] ? page_fault+0x25/0x30 [ 361.818187] [] system_call_fastpath+0x16/0x1b [ 361.818585] INFO: task mount:276 blocked for more than 120 seconds. [ 361.818944] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 361.819385] mount D ffffffff81806240 0 276 232 0x00000000 [ 361.819833] ffff88003c9f1a18 0000000000000082 ffff88003c9f19d8 ffffffff8140a97c [ 361.820476] ffff88003c9f1fd8 ffff88003c9f1fd8 ffff88003c9f1fd8 0000000000013700 [ 361.821037] ffffffff81c0d020 ffff880037b08000 ffff88003c9f19f8 ffff88003fc13fc0 [ 361.821531] Call Trace: [ 361.821723] [] ? do_virtblk_request+0x6c/0x90 [ 361.822070] [] ? __wait_on_buffer+0x30/0x30 [ 361.822444] [] schedule+0x3f/0x60 [ 361.822767] [] io_schedule+0x8f/0xd0 [ 361.823080] [] sleep_on_buffer+0xe/0x20 [ 361.823391] [] __wait_on_bit+0x5f/0x90 [ 361.823724] [] ? generic_make_request+0x68/0x70 [ 361.824254] [] ? __wait_on_buffer+0x30/0x30 [ 361.824588] [] out_of_line_wait_on_bit+0x7c/0x90 [ 361.825001] [] ? autoremove_wake_function+0x40/0x40 [ 361.825361] [] __wait_on_buffer+0x2e/0x30 [ 361.825703] [] bh_submit_read+0x60/0x80 [ 361.826022] [] ext4_read_inode_bitmap+0x14f/0x350 [ 361.826339] [] ext4_new_inode+0x146/0xb10 [ 361.826541] [] ? ext4_lookup.part.27+0x75/0x150 [ 361.826768] [] ext4_create+0xb8/0x140 [ 361.826979] [] vfs_create+0xb4/0x120 [ 361.827165] [] do_last+0x5c9/0x730 [ 361.827344] [] path_openat+0xd1/0x3f0 [ 361.827568] [] ? putname+0x35/0x50 [ 361.828300] [] do_filp_open+0x42/0xa0 [ 361.828639] [] ? strncpy_from_user+0x31/0x40 [ 361.829171] [] ? do_getname+0x10a/0x180 [ 361.829507] [] ? _raw_spin_lock+0xe/0x20 [ 361.829812] [] ? alloc_fd+0xf7/0x150 [ 361.830021] [] do_sys_open+0xf8/0x240 [ 361.830268] [] ? set_current_blocked+0x52/0x70 [ 361.831778] [] sys_open+0x20/0x30 [ 361.832051] [] system_call_fastpath+0x16/0x1b 2026-06-08 03:37:40,296 - INFO - Deleting VM ctest-vm1-test-41561165 2026-06-08 03:37:40,368 - INFO - Deleting VN ctest-vn1-vdns-46227128 2026-06-08 03:37:40,411 - DEBUG - VN 13f039d6-6403-4cff-bb13-9bf52dabf50a still in use: Unable to complete operation on network 13f039d6-6403-4cff-bb13-9bf52dabf50a. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-ed3ce753-c4fa-41b5-8e6e-99f9c04ade6d'] 2026-06-08 03:37:40,411 - WARNING - Deleting VN ctest-vn1-vdns-46227128 failed..Will retry 2026-06-08 03:37:42,653 - DEBUG - Response for deleting network () 2026-06-08 03:37:42,735 - DEBUG - Deleting VDNS Entry: ctest-vdns1-35374017 2026-06-08 03:37:42,851 - INFO - VDNS info: ['default-domain', 'ctest-vdns1-35374017'] deleted successfully. 2026-06-08 03:37:42,851 - DEBUG - Requesting: http://10.0.0.33:8082/domains 2026-06-08 03:37:42,885 - DEBUG - Requesting: http://10.0.0.33:8082/domain/2441b78a-01cc-4005-9aa7-6b434eb6fb41 2026-06-08 03:37:42,901 - DEBUG - VDNS information not found in API server 2026-06-08 03:37:42,901 - INFO - VDNS information ctest-vdns1-35374017 removed from the API Server 2026-06-08 03:37:42,906 - INFO - VDNS information ctest-vdns1-35374017 removed in the Control node 2026-06-08 03:37:42,907 - DEBUG - Skipping the deletion of Project ['default-domain', 'ctest-TestvDNSBasic0-05268018'] 2026-06-08 03:37:44,199 - ERROR - AssertionError Python 3.9.25: /usr/bin/python3 Mon Jun 8 03:37:40 2026 A problem occurred in a Python script. Here is the sequence of function calls leading up to the error, in the order they occurred. /contrail-test/tcutils/wrappers.py in wrapper(self=, *args=(), **kwargs={}) 78 log.info('Initial checks done. Running the testcase now') 79 log.info('') 80 result = function(self, *args, **kwargs) 81 if self.inputs.upgrade: 82 pid = os.getpid() result = None function = self = args = () kwargs = {} /contrail-test/scripts/vdns/test_vdns_basic.py in test_vdns_ping_same_vn(self=) 94 vm_fixture[vm_name] = self.useFixture( 95 VMFixture(project_name=self.inputs.project_name, connections=self.connections, vn_obj=vn_quantum_obj, vm_name=vm_name,image_name='ubuntu-traffic')) 96 assert vm_fixture[vm_name].wait_till_vm_is_up(), ('VM %s' 97 ' failed to come up' % (vm_name)) 98 vm_ip = vm_fixture[vm_name].get_vm_ip_from_vm( vm_fixture = {'ctest-vm1-test-41561165': } vm_name = 'ctest-vm1-test-41561165' ].wait_till_vm_is_up undefined AssertionError: VM ctest-vm1-test-41561165 failed to come up __cause__ = None __class__ = __context__ = None __delattr__ = __dict__ = {} __dir__ = __doc__ = 'Assertion failed.' __eq__ = __format__ = __ge__ = __getattribute__ = __gt__ = __hash__ = __init__ = __init_subclass__ = __le__ = __lt__ = __ne__ = __new__ = __reduce__ = __reduce_ex__ = __repr__ = __setattr__ = __setstate__ = __sizeof__ =