2025-09-11 02:54:39,170 - INFO - Domain Default found not creating 2025-09-11 02:54:39,316 - INFO - Project ctest-TestvDNSBasic0-95472909 not found, creating it 2025-09-11 02:54:39,812 - INFO - Created Project:ctest-TestvDNSBasic0-95472909, ID : ad83218d-693e-407c-ba78-47a1f5379a84 2025-09-11 02:54:41,264 - INFO - ================================================================================ 2025-09-11 02:54:41,264 - INFO - STARTING TEST : test_vdns_ping_same_vn 2025-09-11 02:54:41,265 - 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 2025-09-11 02:54:42,523 - DEBUG - Nothing to compare xmpp stats {'10.0.0.254': {'10.20.0.17': '0', '10.20.0.25': '0'}, '10.0.0.19': {'10.20.0.17': '0', '10.20.0.25': '0'}} with 2025-09-11 02:54:42,524 - INFO - Initial checks done. Running the testcase now 2025-09-11 02:54:42,524 - INFO - 2025-09-11 02:54:43,270 - INFO - Using existing project ['default-domain', 'ctest-TestvDNSBasic0-95472909'](ad83218d-693e-407c-ba78-47a1f5379a84) 2025-09-11 02:54:43,327 - DEBUG - Creating VDNS : ctest-vdns1-75463586 2025-09-11 02:54:43,555 - DEBUG - VDNS: ['default-domain', 'ctest-vdns1-75463586'] created succesfully 2025-09-11 02:54:43,555 - DEBUG - Verify VDNS entry is shown in control node 2025-09-11 02:54:43,572 - DEBUG - Verify VDNS entry is shown in the API server 2025-09-11 02:54:43,573 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-11 02:54:43,864 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-11 02:54:43,894 - DEBUG - Requesting: http://10.0.0.249:8082/domain/6cefd47d-baca-4df6-a10c-ec963319da07 2025-09-11 02:54:43,920 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-DNS/3bd1dc39-cea6-49f2-ad7e-b049e8d282d0 2025-09-11 02:54:44,668 - DEBUG - Response for create_network : {'network': {'id': 'b24cf542-ed45-45c0-9db0-d80ead158dd4', 'name': 'ctest-vn1-vdns-23173364', 'tenant_id': 'ad83218d693e407cba7847a1f5379a84', 'project_id': 'ad83218d693e407cba7847a1f5379a84', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestvDNSBasic0-95472909', 'ctest-vn1-vdns-23173364'], 'port_security_enabled': True, 'description': ''}} 2025-09-11 02:54:44,922 - DEBUG - Response for create_subnet : {'subnet': {'id': 'cb6bc2c7-784d-4fd2-b075-8232e36a870b', 'name': '', 'tenant_id': 'ad83218d693e407cba7847a1f5379a84', 'network_id': 'b24cf542-ed45-45c0-9db0-d80ead158dd4', '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': 'ad83218d693e407cba7847a1f5379a84'}} 2025-09-11 02:54:44,954 - INFO - Created VN ctest-vn1-vdns-23173364 2025-09-11 02:54:44,968 - DEBUG - VN ctest-vn1-vdns-23173364 UUID is b24cf542-ed45-45c0-9db0-d80ead158dd4 2025-09-11 02:54:45,209 - DEBUG - Services list from nova: [, , , ] 2025-09-11 02:54:46,328 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4079-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4079-1) 2025-09-11 02:54:46,329 - INFO - Waiting for VM ctest-vm1-test-99636260 to be up.. 2025-09-11 02:54:46,398 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-09-11 02:54:51,579 - DEBUG - VM is in ACTIVE state now 2025-09-11 02:54:51,579 - INFO - VM name : ctest-vm1-test-99636260 2025-09-11 02:54:51,688 - DEBUG - VM ctest-vm1-test-99636260 ID is af78e853-91ff-40f1-a199-3d5a2054ec32 2025-09-11 02:54:51,688 - DEBUG - VM ctest-vm1-test-99636260 launched on Node an-jenkins-deploy-platform-ansible-os-4079-1 2025-09-11 02:54:51,783 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-machine/af78e853-91ff-40f1-a199-3d5a2054ec32 2025-09-11 02:54:52,088 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-machine/af78e853-91ff-40f1-a199-3d5a2054ec32 2025-09-11 02:54:52,120 - DEBUG - Requesting: http://10.0.0.49:8082/virtual-machine-interface/5c426db8-8193-4ee7-914d-9fd9882fcbd4 2025-09-11 02:54:55,313 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1030ms') 2025-09-11 02:54:55,314 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vm1-test-99636260 failed! 2025-09-11 02:54:55,329 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-95472909:ctest-vn1-vdns-23173364 is 10.10.10.1 and allocation pool is NOT set 2025-09-11 02:54:59,410 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1015ms') 2025-09-11 02:54:59,410 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vm1-test-99636260 failed! 2025-09-11 02:54:59,426 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-95472909:ctest-vn1-vdns-23173364 is 10.10.10.1 and allocation pool is NOT set 2025-09-11 02:55:03,501 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1013ms') 2025-09-11 02:55:03,501 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vm1-test-99636260 failed! 2025-09-11 02:55:03,515 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-95472909:ctest-vn1-vdns-23173364 is 10.10.10.1 and allocation pool is NOT set 2025-09-11 02:55:07,595 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1016ms') 2025-09-11 02:55:07,595 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vm1-test-99636260 failed! 2025-09-11 02:55:07,615 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-95472909:ctest-vn1-vdns-23173364 is 10.10.10.1 and allocation pool is NOT set 2025-09-11 02:55:11,695 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms') 2025-09-11 02:55:11,695 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vm1-test-99636260 failed! 2025-09-11 02:55:11,708 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-95472909:ctest-vn1-vdns-23173364 is 10.10.10.1 and allocation pool is NOT set 2025-09-11 02:55:15,791 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1018ms') 2025-09-11 02:55:15,791 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vm1-test-99636260 failed! 2025-09-11 02:55:15,806 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-95472909:ctest-vn1-vdns-23173364 is 10.10.10.1 and allocation pool is NOT set 2025-09-11 02:55:19,887 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms') 2025-09-11 02:55:19,887 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vm1-test-99636260 failed! 2025-09-11 02:55:19,901 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-95472909:ctest-vn1-vdns-23173364 is 10.10.10.1 and allocation pool is NOT set 2025-09-11 02:55:23,976 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1019ms') 2025-09-11 02:55:23,976 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vm1-test-99636260 failed! 2025-09-11 02:55:23,990 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-95472909:ctest-vn1-vdns-23173364 is 10.10.10.1 and allocation pool is NOT set 2025-09-11 02:55:26,058 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=8.81 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=3.21 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 3.208/6.010/8.813/2.802 ms') 2025-09-11 02:55:26,058 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vm1-test-99636260 passed 2025-09-11 02:55:26,128 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-11 02:55:26,128 - DEBUG - Waiting to SSH to VM ctest-vm1-test-99636260, IP 10.10.10.3, Port 22 2025-09-11 02:55:26,193 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2025-09-11 02:55:26,275 - DEBUG - VM ctest-vm1-test-99636260 is NOT ready for SSH connections, VM status: ACTIVE 2025-09-11 02:55:31,275 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-11 02:55:31,275 - DEBUG - Waiting to SSH to VM ctest-vm1-test-99636260, IP 10.10.10.3, Port 22 2025-09-11 02:55:31,341 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2025-09-11 02:55:31,415 - DEBUG - VM ctest-vm1-test-99636260 is NOT ready for SSH connections, VM status: ACTIVE 2025-09-11 02:55:36,416 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-11 02:55:36,416 - DEBUG - Waiting to SSH to VM ctest-vm1-test-99636260, IP 10.10.10.3, Port 22 2025-09-11 02:55:36,485 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2025-09-11 02:55:36,566 - DEBUG - VM ctest-vm1-test-99636260 is NOT ready for SSH connections, VM status: ACTIVE 2025-09-11 02:55:41,567 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-11 02:55:41,568 - DEBUG - Waiting to SSH to VM ctest-vm1-test-99636260, IP 10.10.10.3, Port 22 2025-09-11 02:55:41,623 - DEBUG - Error on ssh to ubuntu@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2025-09-11 02:55:41,699 - DEBUG - VM ctest-vm1-test-99636260 is NOT ready for SSH connections, VM status: ACTIVE 2025-09-11 02:55:46,700 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-09-11 02:55:46,700 - DEBUG - Waiting to SSH to VM ctest-vm1-test-99636260, IP 10.10.10.3, Port 22 2025-09-11 02:55:46,869 - DEBUG - VM ctest-vm1-test-99636260 is ready for SSH connections 2025-09-11 02:55:46,869 - DEBUG - Running remote_cmd, Cmd : ifconfig | grep 10.10.10.3, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.254, gateway password: c0ntrail123 2025-09-11 02:55:46,869 - DEBUG - ifconfig | grep 10.10.10.3 2025-09-11 02:56:05,890 - DEBUG - inet addr:10.10.10.3 Bcast:10.10.10.255 Mask:255.255.255.0 2025-09-11 02:56:05,891 - DEBUG - Running remote_cmd, Cmd : python -c 'import socket;socket.getaddrinfo("ctest-vm1-test-99636260", None, socket.AF_INET6)', host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.254, gateway password: c0ntrail123 2025-09-11 02:56:05,891 - DEBUG - python -c 'import socket;socket.getaddrinfo("ctest-vm1-test-99636260", None, socket.AF_INET6)' 2025-09-11 02:56:07,124 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 ctest-vm1-test-99636260, host_string: ubuntu@169.254.0.3, password: ubuntugateway: ubuntu@10.0.0.254, gateway password: c0ntrail123 2025-09-11 02:56:07,124 - DEBUG - ping -s 56 -c 3 -W 1 ctest-vm1-test-99636260 2025-09-11 02:56:09,680 - DEBUG - PING ctest-vm1-test-99636260.juniper.net (10.10.10.3) 56(84) bytes of data. 64 bytes from ctest-vm1-test-99636260.juniper.net (10.10.10.3): icmp_req=1 ttl=64 time=4.69 ms 64 bytes from ctest-vm1-test-99636260.juniper.net (10.10.10.3): icmp_req=2 ttl=64 time=2.78 ms 64 bytes from ctest-vm1-test-99636260.juniper.net (10.10.10.3): icmp_req=3 ttl=64 time=0.200 ms --- ctest-vm1-test-99636260.juniper.net ping statistics --- 3 packets transmitted, 3 received, 0% packet loss, time 2004ms rtt min/avg/max/mdev = 0.200/2.561/4.698/1.844 ms 2025-09-11 02:56:09,680 - INFO - Ping to IP ctest-vm1-test-99636260 from VM ctest-vm1-test-99636260 passed 2025-09-11 02:56:09,707 - DEBUG - Requesting: http://10.0.0.249:8092/Snh_PageReq?x=AllEntries%20VdnsServersReq 2025-09-11 02:56:09,714 - DEBUG - Requesting: http://10.0.0.249:8092/Snh_PageReq?x=default-domain:ctest-vdns1-75463586@0%20AllEntriesVdnsRecordsReq 2025-09-11 02:56:09,719 - DEBUG - Requesting: http://10.0.0.249:8092/Snh_PageReq?x=AllEntries%20VdnsServersReq 2025-09-11 02:56:09,724 - DEBUG - Requesting: http://10.0.0.249:8092/Snh_PageReq?x=default-domain:ctest-vdns1-75463586@0%20AllEntriesVdnsRecordsReq 2025-09-11 02:56:09,729 - DEBUG - Requesting: http://10.0.0.249:8092/Snh_PageReq?x=AllEntries%20VdnsServersReq 2025-09-11 02:56:09,733 - DEBUG - Requesting: http://10.0.0.249:8092/Snh_PageReq?x=default-domain:ctest-vdns1-75463586@0%20AllEntriesVdnsRecordsReq 2025-09-11 02:56:09,737 - DEBUG - Actual record data {'name': 'default-domain:ctest-vdns1-75463586:1:ctest-vm1-test-99636260:10.10.10.3', 'rec_name': 'ctest-vm1-test-99636260', 'rec_type': 'A', 'rec_class': 'IN', 'rec_data': '10.10.10.3', 'rec_ttl': '100', 'source': 'Agent', 'installed': 'true', 'flags': '3', 'rec_source_name': 'an-jenkins-deploy-platform-ansible-os-4079-1/dns'} , Expected record data {'rec_data': '10.10.10.3', 'rec_type': 'A', 'rec_class': 'IN', 'rec_ttl': '100', 'rec_name': 'ctest-vm1-test-99636260.juniper.net', 'installed': 'yes', 'zone': 'juniper.net'} 2025-09-11 02:56:09,737 - DEBUG - Actual record data {'name': 'default-domain:ctest-vdns1-75463586:12:3.10.10.10.in-addr.arpa:ctest-vm1-test-99636260', 'rec_name': '3.10.10.10.in-addr.arpa', 'rec_type': 'PTR', 'rec_class': 'IN', 'rec_data': 'ctest-vm1-test-99636260', 'rec_ttl': '100', 'source': 'Agent', 'installed': 'true', 'flags': '3', 'rec_source_name': 'an-jenkins-deploy-platform-ansible-os-4079-1/dns'} , Expected record data {'rec_data': 'ctest-vm1-test-99636260.juniper.net', 'rec_type': 'PTR', 'rec_class': 'IN', 'rec_ttl': '100', 'rec_name': '3.10.10.10.in-addr.arpa', 'installed': 'yes', 'zone': '10.10.10.in-addr.arpa'} 2025-09-11 02:56:11,434 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4079-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4079-2) 2025-09-11 02:56:11,434 - INFO - Waiting for VM ctest-vm2-test-84564869 to be up.. 2025-09-11 02:56:11,505 - DEBUG - VM is in ERROR state now 2025-09-11 02:56:11,505 - ERROR - VM in error state. 2025-09-11 02:56:11,505 - ERROR - VM is not in ACTIVE state 2025-09-11 02:56:11,589 - ERROR - Fatal Nova Exception while getting VM detail 2025-09-11 02:56:11,589 - DEBUG - None 2025-09-11 02:56:11,591 - INFO - Skip interface_detach for VM ctest-vm2-test-84564869 in state ERROR 2025-09-11 02:56:11,591 - INFO - Deleting VM ctest-vm2-test-84564869 2025-09-11 02:56:11,591 - ERROR - VM ctest-vm2-test-84564869 has failed to come up 2025-09-11 02:56:11,591 - ERROR - Fault seen in nova show is: {'code': 500, 'created': '2025-09-11T02:56:11Z', 'message': 'No valid host was found. ', 'details': 'Traceback (most recent call last):\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/conductor/manager.py", line 1581, in schedule_and_build_instances\n instance_uuids, return_alternates=True)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/conductor/manager.py", line 942, in _schedule_instances\n return_alternates=return_alternates)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/scheduler/client/query.py", line 42, in select_destinations\n instance_uuids, return_objects, return_alternates)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/scheduler/rpcapi.py", line 160, in select_destinations\n return cctxt.call(ctxt, \'select_destinations\', **msg_args)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/rpc/client.py", line 192, in call\n retry=self.retry, transport_options=self.transport_options)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/transport.py", line 128, in _send\n transport_options=transport_options)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/_drivers/amqpdriver.py", line 691, in send\n transport_options=transport_options)\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/_drivers/amqpdriver.py", line 681, in _send\n raise result\nnova.exception_Remote.NoValidHost_Remote: No valid host was found. \nTraceback (most recent call last):\n\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/oslo_messaging/rpc/server.py", line 241, in inner\n return func(*args, **kwargs)\n\n File "/var/lib/kolla/venv/lib/python3.6/site-packages/nova/scheduler/manager.py", line 209, in select_destinations\n raise exception.NoValidHost(reason="")\n\nnova.exception.NoValidHost: No valid host was found. \n\n'} 2025-09-11 02:56:11,592 - INFO - Deleting VM ctest-vm1-test-99636260 2025-09-11 02:56:11,657 - INFO - Deleting VN ctest-vn1-vdns-23173364 2025-09-11 02:56:11,696 - DEBUG - VN b24cf542-ed45-45c0-9db0-d80ead158dd4 still in use: Unable to complete operation on network b24cf542-ed45-45c0-9db0-d80ead158dd4. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-b5ec17dd-0364-4d66-a143-a63d005d47b1'] 2025-09-11 02:56:11,696 - WARNING - Deleting VN ctest-vn1-vdns-23173364 failed..Will retry 2025-09-11 02:56:13,882 - DEBUG - Response for deleting network () 2025-09-11 02:56:13,939 - DEBUG - Deleting VDNS Entry: ctest-vdns1-75463586 2025-09-11 02:56:14,031 - INFO - VDNS info: ['default-domain', 'ctest-vdns1-75463586'] deleted successfully. 2025-09-11 02:56:14,031 - DEBUG - Requesting: http://10.0.0.249:8082/domains 2025-09-11 02:56:14,038 - DEBUG - Requesting: http://10.0.0.249:8082/domain/6cefd47d-baca-4df6-a10c-ec963319da07 2025-09-11 02:56:14,078 - DEBUG - VDNS information not found in API server 2025-09-11 02:56:14,078 - INFO - VDNS information ctest-vdns1-75463586 removed from the API Server 2025-09-11 02:56:14,085 - INFO - VDNS information ctest-vdns1-75463586 removed in the Control node 2025-09-11 02:56:14,085 - DEBUG - Skipping the deletion of Project ['default-domain', 'ctest-TestvDNSBasic0-95472909'] 2025-09-11 02:56:15,331 - ERROR - AssertionError Python 3.9.21: /usr/bin/python3 Thu Sep 11 02:56:11 2025 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-99636260': , 'ctest-vm2-test-84564869': } vm_name = 'ctest-vm2-test-84564869' ].wait_till_vm_is_up undefined AssertionError: VM ctest-vm2-test-84564869 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__ = __str__ = __subclasshook__ = __suppress_context__ = False __traceback__ = args = ('VM ctest-vm2-test-84564869 failed to come up',) with_traceback = The above is a description of an error in a Python program. Here is the original traceback: Traceback (most recent call last): File "/contrail-test/tcutils/wrappers.py", line 80, in wrapper result = function(self, *args, **kwargs) File "/contrail-test/scripts/vdns/test_vdns_basic.py", line 96, in test_vdns_ping_same_vn assert vm_fixture[vm_name].wait_till_vm_is_up(), ('VM %s' AssertionError: VM ctest-vm2-test-84564869 failed to come up 2025-09-11 02:56:15,344 - DEBUG - No XMPP flaps were noticed during the test 2025-09-11 02:56:15,344 - INFO -
2025-09-11 02:56:15,344 - INFO - END TEST : test_vdns_ping_same_vn : FAILED[0:01:34]
2025-09-11 02:56:15,344 - INFO - -------------------------------------------------------------------------------- 2025-09-11 02:56:16,089 - INFO - Deleted project: ctest-TestvDNSBasic0-95472909, ID : ad83218d-693e-407c-ba78-47a1f5379a84