2025-10-13 20:58:59,025 - INFO - Domain Default found not creating
2025-10-13 20:58:59,150 - INFO - Project ctest-TestvDNSBasic0-31958471 not found, creating it
2025-10-13 20:58:59,566 - INFO - Created Project:ctest-TestvDNSBasic0-31958471, ID : a8abd5c8-7dfa-4441-8efa-dba50a64b6a1 
2025-10-13 20:59:00,973 - INFO - ================================================================================
2025-10-13 20:59:00,973 - INFO - STARTING TEST    : test_vdns_ping_same_vn
2025-10-13 20:59:00,973 - 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-10-13 20:59:01,232 - DEBUG - Nothing to compare xmpp stats {'10.0.0.254': {'10.20.0.254': '0'}} with
2025-10-13 20:59:01,232 - INFO - Initial checks done. Running the testcase now
2025-10-13 20:59:01,232 - INFO - 
2025-10-13 20:59:01,909 - INFO - Using existing project ['default-domain', 'ctest-TestvDNSBasic0-31958471'](a8abd5c8-7dfa-4441-8efa-dba50a64b6a1)
2025-10-13 20:59:01,958 - DEBUG - Creating VDNS : ctest-vdns1-32836417
2025-10-13 20:59:02,162 - DEBUG - VDNS: ['default-domain', 'ctest-vdns1-32836417'] created succesfully
2025-10-13 20:59:02,163 - DEBUG - Verify VDNS entry is shown in control node
2025-10-13 20:59:02,168 - DEBUG - Verify VDNS entry is shown in the API server
2025-10-13 20:59:02,168 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-13 20:59:02,458 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-13 20:59:02,482 - DEBUG - Requesting: http://10.0.0.254:8082/domain/d51c86b7-829c-4bd4-a0b8-0335f4678f98
2025-10-13 20:59:02,493 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-DNS/f3911a1c-6d89-4fc5-aa8f-3b9fb67abd7e
2025-10-13 20:59:03,030 - DEBUG - Response for create_network : {'network': {'id': '8de8ac4a-4935-4949-918c-074856187a40', 'name': 'ctest-vn1-vdns-59446247', 'tenant_id': 'a8abd5c87dfa44418efadba50a64b6a1', 'project_id': 'a8abd5c87dfa44418efadba50a64b6a1', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestvDNSBasic0-31958471', 'ctest-vn1-vdns-59446247'], 'port_security_enabled': True, 'description': ''}}
2025-10-13 20:59:03,207 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e61f6905-6fe9-46c9-bbfd-0d9f134ca5c0', 'name': '', 'tenant_id': 'a8abd5c87dfa44418efadba50a64b6a1', 'network_id': '8de8ac4a-4935-4949-918c-074856187a40', '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': 'a8abd5c87dfa44418efadba50a64b6a1'}}
2025-10-13 20:59:03,221 - INFO - Created VN ctest-vn1-vdns-59446247
2025-10-13 20:59:03,271 - DEBUG - VN ctest-vn1-vdns-59446247 UUID is 8de8ac4a-4935-4949-918c-074856187a40
2025-10-13 20:59:03,449 - DEBUG - Services list from nova: [, , ]
2025-10-13 20:59:04,498 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4310-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4310-1)
2025-10-13 20:59:04,498 - INFO - Waiting for VM ctest-vm1-test-77139291 to be up..
2025-10-13 20:59:04,531 - DEBUG - VM  is still in BUILD state, Expected: ACTIVE
2025-10-13 20:59:09,611 - DEBUG - VM  is in ACTIVE state now
2025-10-13 20:59:09,611 - INFO - VM name : ctest-vm1-test-77139291
2025-10-13 20:59:09,685 - DEBUG - VM ctest-vm1-test-77139291 ID is b84e7f08-ab2e-415f-81e7-56725aac884a
2025-10-13 20:59:09,686 - DEBUG - VM ctest-vm1-test-77139291 launched on Node cn-jenkins-deploy-platform-ansible-os-4310-1
2025-10-13 20:59:09,761 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine/b84e7f08-ab2e-415f-81e7-56725aac884a
2025-10-13 20:59:09,769 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine-interface/ee29e5b7-f514-4a56-b1ad-1d30d4147658
2025-10-13 20:59:13,020 - 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 1011ms')
2025-10-13 20:59:13,020 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vm1-test-77139291 failed!
2025-10-13 20:59:13,070 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-31958471:ctest-vn1-vdns-59446247 is 10.10.10.1 and allocation pool is NOT set
2025-10-13 20:59:15,134 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=3.77 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.720 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.720/2.245/3.770/1.525 ms')
2025-10-13 20:59:15,134 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vm1-test-77139291 passed
2025-10-13 20:59:15,282 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-13 20:59:15,283 - DEBUG - Waiting to SSH to VM ctest-vm1-test-77139291, IP 10.10.10.3, Port 22
2025-10-13 20:59:15,352 - DEBUG - Error on ssh to cirros@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-10-13 20:59:15,415 - DEBUG - VM ctest-vm1-test-77139291 is NOT ready for SSH connections, VM status: ACTIVE
2025-10-13 20:59:20,416 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-13 20:59:20,416 - DEBUG - Waiting to SSH to VM ctest-vm1-test-77139291, IP 10.10.10.3, Port 22
2025-10-13 20:59:20,578 - DEBUG - VM ctest-vm1-test-77139291 is ready for SSH connections
2025-10-13 20:59:20,578 - DEBUG - Running remote_cmd, Cmd : ifconfig | grep 10.10.10.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123
2025-10-13 20:59:20,578 - DEBUG - ifconfig | grep 10.10.10.3
2025-10-13 20:59:22,259 - DEBUG - inet addr:10.10.10.3  Bcast:10.10.10.255  Mask:255.255.255.0
2025-10-13 20:59:22,260 - DEBUG - Running remote_cmd, Cmd : python -c 'import socket;socket.getaddrinfo("ctest-vm1-test-77139291", None, socket.AF_INET6)', host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123
2025-10-13 20:59:22,260 - DEBUG - python -c 'import socket;socket.getaddrinfo("ctest-vm1-test-77139291", None, socket.AF_INET6)'
2025-10-13 20:59:22,501 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1  ctest-vm1-test-77139291, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123
2025-10-13 20:59:22,501 - DEBUG - ping -s 56 -c 3 -W 1  ctest-vm1-test-77139291
2025-10-13 20:59:24,755 - DEBUG - PING ctest-vm1-test-77139291 (10.10.10.3): 56 data bytes
64 bytes from 10.10.10.3: seq=0 ttl=64 time=3.190 ms
64 bytes from 10.10.10.3: seq=1 ttl=64 time=0.326 ms
64 bytes from 10.10.10.3: seq=2 ttl=64 time=0.443 ms
--- ctest-vm1-test-77139291 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.326/1.319/3.190 ms
2025-10-13 20:59:24,755 - INFO - Ping to IP ctest-vm1-test-77139291 from VM ctest-vm1-test-77139291 passed
2025-10-13 20:59:24,767 - DEBUG - Requesting: http://10.0.0.254:8092/Snh_PageReq?x=AllEntries%20VdnsServersReq
2025-10-13 20:59:24,772 - DEBUG - Requesting: http://10.0.0.254:8092/Snh_PageReq?x=default-domain:ctest-vdns1-32836417@0%20AllEntriesVdnsRecordsReq
2025-10-13 20:59:24,776 - DEBUG - Actual record data {'name': 'default-domain:ctest-vdns1-32836417:1:ctest-vm1-test-77139291:10.10.10.3', 'rec_name': 'ctest-vm1-test-77139291', 'rec_type': 'A', 'rec_class': 'IN', 'rec_data': '10.10.10.3', 'rec_ttl': '100', 'source': 'Agent', 'installed': 'true', 'flags': '3', 'rec_source_name': 'cn-jenkins-deploy-platform-ansible-os-4310-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-77139291.juniper.net', 'installed': 'yes', 'zone': 'juniper.net'}
2025-10-13 20:59:24,776 - DEBUG - Actual record data {'name': 'default-domain:ctest-vdns1-32836417:12:3.10.10.10.in-addr.arpa:ctest-vm1-test-77139291', 'rec_name': '3.10.10.10.in-addr.arpa', 'rec_type': 'PTR', 'rec_class': 'IN', 'rec_data': 'ctest-vm1-test-77139291', 'rec_ttl': '100', 'source': 'Agent', 'installed': 'true', 'flags': '3', 'rec_source_name': 'cn-jenkins-deploy-platform-ansible-os-4310-1/dns'} ,
 Expected record data {'rec_data': 'ctest-vm1-test-77139291.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-10-13 20:59:25,869 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4310-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4310-1)
2025-10-13 20:59:25,869 - INFO - Waiting for VM ctest-vm2-test-30845927 to be up..
2025-10-13 20:59:25,906 - DEBUG - VM  is still in BUILD state, Expected: ACTIVE
2025-10-13 20:59:30,971 - DEBUG - VM  is in ACTIVE state now
2025-10-13 20:59:30,971 - INFO - VM name : ctest-vm2-test-30845927
2025-10-13 20:59:31,043 - DEBUG - VM ctest-vm2-test-30845927 ID is cac6796e-ad4a-4033-9802-931a43810196
2025-10-13 20:59:31,043 - DEBUG - VM ctest-vm2-test-30845927 launched on Node cn-jenkins-deploy-platform-ansible-os-4310-1
2025-10-13 20:59:31,119 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine/cac6796e-ad4a-4033-9802-931a43810196
2025-10-13 20:59:31,126 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine-interface/e0c7b2cd-25a4-4d22-95d4-50de7731c404
2025-10-13 20:59:34,363 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1003ms')
2025-10-13 20:59:34,363 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-vm2-test-30845927 failed!
2025-10-13 20:59:34,415 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-31958471:ctest-vn1-vdns-59446247 is 10.10.10.1 and allocation pool is NOT set
2025-10-13 20:59:36,472 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n64 bytes from 169.254.0.4: icmp_seq=1 ttl=63 time=3.71 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.662 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.662/2.186/3.711/1.524 ms')
2025-10-13 20:59:36,473 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vm2-test-30845927 passed
2025-10-13 20:59:36,618 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-13 20:59:36,619 - DEBUG - Waiting to SSH to VM ctest-vm2-test-30845927, IP 10.10.10.4, Port 22
2025-10-13 20:59:36,785 - DEBUG - VM ctest-vm2-test-30845927 is ready for SSH connections
2025-10-13 20:59:36,785 - DEBUG - Running remote_cmd, Cmd : ifconfig | grep 10.10.10.4, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123
2025-10-13 20:59:36,785 - DEBUG - ifconfig | grep 10.10.10.4
2025-10-13 20:59:38,400 - DEBUG - inet addr:10.10.10.4  Bcast:10.10.10.255  Mask:255.255.255.0
2025-10-13 20:59:38,400 - DEBUG - Running remote_cmd, Cmd : python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-30845927", None, socket.AF_INET6)', host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123
2025-10-13 20:59:38,400 - DEBUG - python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-30845927", None, socket.AF_INET6)'
2025-10-13 20:59:38,644 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1  ctest-vm2-test-30845927, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123
2025-10-13 20:59:38,644 - DEBUG - ping -s 56 -c 3 -W 1  ctest-vm2-test-30845927
2025-10-13 20:59:40,896 - DEBUG - PING ctest-vm2-test-30845927 (10.10.10.4): 56 data bytes
64 bytes from 10.10.10.4: seq=0 ttl=64 time=3.275 ms
64 bytes from 10.10.10.4: seq=1 ttl=64 time=0.349 ms
64 bytes from 10.10.10.4: seq=2 ttl=64 time=0.387 ms
--- ctest-vm2-test-30845927 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.349/1.337/3.275 ms
2025-10-13 20:59:40,896 - INFO - Ping to IP ctest-vm2-test-30845927 from VM ctest-vm2-test-30845927 passed
2025-10-13 20:59:40,908 - DEBUG - Requesting: http://10.0.0.254:8092/Snh_PageReq?x=AllEntries%20VdnsServersReq
2025-10-13 20:59:40,914 - DEBUG - Requesting: http://10.0.0.254:8092/Snh_PageReq?x=default-domain:ctest-vdns1-32836417@0%20AllEntriesVdnsRecordsReq
2025-10-13 20:59:40,918 - DEBUG - Actual record data {'name': 'default-domain:ctest-vdns1-32836417:1:ctest-vm2-test-30845927:10.10.10.4', 'rec_name': 'ctest-vm2-test-30845927', 'rec_type': 'A', 'rec_class': 'IN', 'rec_data': '10.10.10.4', 'rec_ttl': '100', 'source': 'Agent', 'installed': 'true', 'flags': '3', 'rec_source_name': 'cn-jenkins-deploy-platform-ansible-os-4310-1/dns'} ,
 Expected record data {'rec_data': '10.10.10.4', 'rec_type': 'A', 'rec_class': 'IN', 'rec_ttl': '100', 'rec_name': 'ctest-vm2-test-30845927.juniper.net', 'installed': 'yes', 'zone': 'juniper.net'}
2025-10-13 20:59:40,918 - DEBUG - Actual record data {'name': 'default-domain:ctest-vdns1-32836417:12:4.10.10.10.in-addr.arpa:ctest-vm2-test-30845927', 'rec_name': '4.10.10.10.in-addr.arpa', 'rec_type': 'PTR', 'rec_class': 'IN', 'rec_data': 'ctest-vm2-test-30845927', 'rec_ttl': '100', 'source': 'Agent', 'installed': 'true', 'flags': '3', 'rec_source_name': 'cn-jenkins-deploy-platform-ansible-os-4310-1/dns'} ,
 Expected record data {'rec_data': 'ctest-vm2-test-30845927.juniper.net', 'rec_type': 'PTR', 'rec_class': 'IN', 'rec_ttl': '100', 'rec_name': '4.10.10.10.in-addr.arpa', 'installed': 'yes', 'zone': '10.10.10.in-addr.arpa'}
2025-10-13 20:59:40,919 - DEBUG - Running remote_cmd, Cmd : python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-30845927", None, socket.AF_INET6)', host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123
2025-10-13 20:59:40,919 - DEBUG - python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-30845927", None, socket.AF_INET6)'
2025-10-13 20:59:41,102 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1  ctest-vm2-test-30845927, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123
2025-10-13 20:59:41,102 - DEBUG - ping -s 56 -c 3 -W 1  ctest-vm2-test-30845927
2025-10-13 20:59:43,351 - DEBUG - PING ctest-vm2-test-30845927 (10.10.10.4): 56 data bytes
64 bytes from 10.10.10.4: seq=0 ttl=64 time=5.760 ms
64 bytes from 10.10.10.4: seq=1 ttl=64 time=0.879 ms
64 bytes from 10.10.10.4: seq=2 ttl=64 time=1.020 ms
--- ctest-vm2-test-30845927 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.879/2.553/5.760 ms
2025-10-13 20:59:43,351 - INFO - Ping to IP ctest-vm2-test-30845927 from VM ctest-vm1-test-77139291 passed
2025-10-13 20:59:43,351 - INFO - Try deleting the VDNS entry ctest-vdns1-32836417 with back ref of ipam.
2025-10-13 20:59:43,406 - DEBUG - Delete when resource still referred: ['http://10.0.0.254:8082/network-ipam/cef8049d-9252-4f44-9231-bed8025ce212']
2025-10-13 20:59:43,406 - INFO - Deletion of the vdns entry failed with back ref of ipam as expected
2025-10-13 20:59:43,406 - INFO - Add CNAME VDNS record for ctest-vm1-test-77139291 and verify we able to ping by alias name
2025-10-13 20:59:43,454 - DEBUG - Creating VDNS record data : test-rec
2025-10-13 20:59:43,566 - INFO - In verify_on_setup
2025-10-13 20:59:43,666 - DEBUG - VDNS record: ['default-domain', 'ctest-vdns1-32836417', 'test-rec'] created succesfully
2025-10-13 20:59:43,666 - INFO - Verify VDNS record  is shown in the API server
2025-10-13 20:59:43,667 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-13 20:59:43,671 - DEBUG - Requesting: http://10.0.0.254:8082/domain/d51c86b7-829c-4bd4-a0b8-0335f4678f98
2025-10-13 20:59:43,681 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-DNS/f3911a1c-6d89-4fc5-aa8f-3b9fb67abd7e
2025-10-13 20:59:43,687 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-DNS-record/c06331fb-6787-4717-9f79-440c73664804
2025-10-13 20:59:43,691 - INFO - Verify VDNS record  is shown in the control node
2025-10-13 20:59:43,695 - DEBUG - Running remote_cmd, Cmd : python -c 'import socket;socket.getaddrinfo("vm1-test-alias", None, socket.AF_INET6)', host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123
2025-10-13 20:59:43,695 - DEBUG - python -c 'import socket;socket.getaddrinfo("vm1-test-alias", None, socket.AF_INET6)'
2025-10-13 20:59:43,869 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1  vm1-test-alias, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123
2025-10-13 20:59:43,869 - DEBUG - ping -s 56 -c 3 -W 1  vm1-test-alias
2025-10-13 20:59:44,119 - DEBUG - ping: bad address 'vm1-test-alias'
2025-10-13 20:59:44,120 - WARNING - Ping to IP vm1-test-alias from VM ctest-vm1-test-77139291 failed
2025-10-13 20:59:45,120 - DEBUG - Running remote_cmd, Cmd : python -c 'import socket;socket.getaddrinfo("vm1-test-alias", None, socket.AF_INET6)', host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123
2025-10-13 20:59:45,120 - DEBUG - python -c 'import socket;socket.getaddrinfo("vm1-test-alias", None, socket.AF_INET6)'
2025-10-13 20:59:45,303 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1  vm1-test-alias, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123
2025-10-13 20:59:45,303 - DEBUG - ping -s 56 -c 3 -W 1  vm1-test-alias
2025-10-13 20:59:45,547 - DEBUG - ping: bad address 'vm1-test-alias'
2025-10-13 20:59:45,547 - WARNING - Ping to IP vm1-test-alias from VM ctest-vm1-test-77139291 failed
2025-10-13 20:59:46,548 - DEBUG - Running remote_cmd, Cmd : python -c 'import socket;socket.getaddrinfo("vm1-test-alias", None, socket.AF_INET6)', host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123
2025-10-13 20:59:46,548 - DEBUG - python -c 'import socket;socket.getaddrinfo("vm1-test-alias", None, socket.AF_INET6)'
2025-10-13 20:59:46,720 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1  vm1-test-alias, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123
2025-10-13 20:59:46,720 - DEBUG - ping -s 56 -c 3 -W 1  vm1-test-alias
2025-10-13 20:59:48,961 - DEBUG - PING vm1-test-alias (10.10.10.3): 56 data bytes
64 bytes from 10.10.10.3: seq=0 ttl=64 time=0.327 ms
64 bytes from 10.10.10.3: seq=1 ttl=64 time=0.321 ms
64 bytes from 10.10.10.3: seq=2 ttl=64 time=0.336 ms
--- vm1-test-alias ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.321/0.328/0.336 ms
2025-10-13 20:59:48,961 - INFO - Ping to IP vm1-test-alias from VM ctest-vm1-test-77139291 passed
2025-10-13 20:59:48,961 - DEBUG - Deleting VDNS record data: test-rec
2025-10-13 20:59:49,026 - INFO - VDNS record info: default-domain:ctest-vdns1-32836417:test-rec deleted successfully.
2025-10-13 20:59:49,026 - INFO - Deleting VM ctest-vm2-test-30845927
2025-10-13 20:59:49,090 - INFO - Deleting VM ctest-vm1-test-77139291
2025-10-13 20:59:49,150 - INFO - Deleting VN ctest-vn1-vdns-59446247 
2025-10-13 20:59:49,181 - DEBUG - VN 8de8ac4a-4935-4949-918c-074856187a40 still in use: Unable to complete operation on network 8de8ac4a-4935-4949-918c-074856187a40. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-d66152bb-0868-4be6-8266-00822693cb66']
2025-10-13 20:59:49,181 - WARNING - Deleting VN ctest-vn1-vdns-59446247 failed..Will retry
2025-10-13 20:59:51,411 - DEBUG - Response for deleting network ()
2025-10-13 20:59:51,434 - DEBUG - Deleting VDNS Entry: ctest-vdns1-32836417
2025-10-13 20:59:51,498 - INFO - VDNS info: ['default-domain', 'ctest-vdns1-32836417'] deleted successfully.
2025-10-13 20:59:51,498 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-10-13 20:59:51,504 - DEBUG - Requesting: http://10.0.0.254:8082/domain/d51c86b7-829c-4bd4-a0b8-0335f4678f98
2025-10-13 20:59:51,515 - DEBUG - VDNS information not found in API server
2025-10-13 20:59:51,515 - INFO - VDNS information ctest-vdns1-32836417 removed from the API Server
2025-10-13 20:59:51,522 - INFO - VDNS information ctest-vdns1-32836417 removed in the Control node
2025-10-13 20:59:51,522 - DEBUG - Skipping the deletion of Project ['default-domain', 'ctest-TestvDNSBasic0-31958471']
2025-10-13 20:59:51,775 - DEBUG - No XMPP flaps were noticed during the test
2025-10-13 20:59:51,775 - INFO - END TEST : test_vdns_ping_same_vn : PASSED[0:00:51]
2025-10-13 20:59:51,775 - INFO - --------------------------------------------------------------------------------
2025-10-13 20:59:52,415 - INFO - Deleted project: ctest-TestvDNSBasic0-31958471, ID : a8abd5c8-7dfa-4441-8efa-dba50a64b6a1