is in ACTIVE state now
2026-08-24 04:38:17,152 - INFO - VM name : ctest-vm2-test-59652473
2026-08-24 04:38:17,241 - DEBUG - VM ctest-vm2-test-59652473 ID is d99ae562-4cc2-4335-9b87-c54d9ba451ad
2026-08-24 04:38:17,241 - DEBUG - VM ctest-vm2-test-59652473 launched on Node cn-jenkins-deploy-platform-ansible-os-6212-1
2026-08-24 04:38:17,330 - DEBUG - Requesting: http://10.0.0.188:8082/virtual-machine/d99ae562-4cc2-4335-9b87-c54d9ba451ad
2026-08-24 04:38:17,342 - DEBUG - Requesting: http://10.0.0.188:8082/virtual-machine-interface/0a71021d-6b0d-4451-a7aa-0edecfe1650d
2026-08-24 04:38:20,618 - 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 1022ms')
2026-08-24 04:38:20,618 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-vm2-test-59652473 failed!
2026-08-24 04:38:20,677 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-31608607:ctest-vn1-vdns-82314336 is 10.10.10.1 and allocation pool is NOT set
2026-08-24 04:38:22,745 - 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=4.72 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.545 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.545/2.632/4.720/2.087 ms')
2026-08-24 04:38:22,745 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vm2-test-59652473 passed
2026-08-24 04:38:22,897 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-08-24 04:38:22,897 - DEBUG - Waiting to SSH to VM ctest-vm2-test-59652473, IP 10.10.10.4, Port 22
2026-08-24 04:38:23,063 - DEBUG - VM ctest-vm2-test-59652473 is ready for SSH connections
2026-08-24 04:38:23,063 - 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.188, gateway password: c0ntrail123
2026-08-24 04:38:23,063 - DEBUG - ifconfig | grep 10.10.10.4
2026-08-24 04:38:24,080 - DEBUG - inet addr:10.10.10.4 Bcast:10.10.10.255 Mask:255.255.255.0
2026-08-24 04:38:24,081 - DEBUG - Running remote_cmd, Cmd : python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-59652473", None, socket.AF_INET6)', host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.188, gateway password: c0ntrail123
2026-08-24 04:38:24,081 - DEBUG - python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-59652473", None, socket.AF_INET6)'
2026-08-24 04:38:24,293 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 ctest-vm2-test-59652473, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.188, gateway password: c0ntrail123
2026-08-24 04:38:24,293 - DEBUG - ping -s 56 -c 3 -W 1 ctest-vm2-test-59652473
2026-08-24 04:38:26,475 - DEBUG - PING ctest-vm2-test-59652473 (10.10.10.4): 56 data bytes
64 bytes from 10.10.10.4: seq=0 ttl=64 time=3.837 ms
64 bytes from 10.10.10.4: seq=1 ttl=64 time=0.489 ms
64 bytes from 10.10.10.4: seq=2 ttl=64 time=0.445 ms
--- ctest-vm2-test-59652473 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.445/1.590/3.837 ms
2026-08-24 04:38:26,475 - INFO - Ping to IP ctest-vm2-test-59652473 from VM ctest-vm2-test-59652473 passed
2026-08-24 04:38:26,492 - DEBUG - Requesting: http://10.0.0.188:8092/Snh_PageReq?x=AllEntries%20VdnsServersReq
2026-08-24 04:38:26,500 - DEBUG - Requesting: http://10.0.0.188:8092/Snh_PageReq?x=default-domain:ctest-vdns1-72474161@0%20AllEntriesVdnsRecordsReq
2026-08-24 04:38:26,507 - DEBUG - Actual record data {'name': 'default-domain:ctest-vdns1-72474161:1:ctest-vm2-test-59652473:10.10.10.4', 'rec_name': 'ctest-vm2-test-59652473', '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-6212-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-59652473.juniper.net', 'installed': 'yes', 'zone': 'juniper.net'}
2026-08-24 04:38:26,507 - DEBUG - Actual record data {'name': 'default-domain:ctest-vdns1-72474161:12:4.10.10.10.in-addr.arpa:ctest-vm2-test-59652473', 'rec_name': '4.10.10.10.in-addr.arpa', 'rec_type': 'PTR', 'rec_class': 'IN', 'rec_data': 'ctest-vm2-test-59652473', 'rec_ttl': '100', 'source': 'Agent', 'installed': 'true', 'flags': '3', 'rec_source_name': 'cn-jenkins-deploy-platform-ansible-os-6212-1/dns'} ,
Expected record data {'rec_data': 'ctest-vm2-test-59652473.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'}
2026-08-24 04:38:26,507 - DEBUG - Running remote_cmd, Cmd : python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-59652473", None, socket.AF_INET6)', host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.188, gateway password: c0ntrail123
2026-08-24 04:38:26,508 - DEBUG - python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-59652473", None, socket.AF_INET6)'
2026-08-24 04:38:26,686 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 ctest-vm2-test-59652473, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.188, gateway password: c0ntrail123
2026-08-24 04:38:26,686 - DEBUG - ping -s 56 -c 3 -W 1 ctest-vm2-test-59652473
2026-08-24 04:38:29,012 - DEBUG - PING ctest-vm2-test-59652473 (10.10.10.4): 56 data bytes
64 bytes from 10.10.10.4: seq=0 ttl=64 time=6.005 ms
64 bytes from 10.10.10.4: seq=1 ttl=64 time=1.041 ms
64 bytes from 10.10.10.4: seq=2 ttl=64 time=1.020 ms
--- ctest-vm2-test-59652473 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.020/2.688/6.005 ms
2026-08-24 04:38:29,012 - INFO - Ping to IP ctest-vm2-test-59652473 from VM ctest-vm1-test-30937653 passed
2026-08-24 04:38:29,012 - INFO - Try deleting the VDNS entry ctest-vdns1-72474161 with back ref of ipam.
2026-08-24 04:38:29,076 - DEBUG - Delete when resource still referred: ['http://10.0.0.188:8082/network-ipam/da032e9c-5a22-454e-825c-089d0d7aa6b1']
2026-08-24 04:38:29,077 - INFO - Deletion of the vdns entry failed with back ref of ipam as expected
2026-08-24 04:38:29,077 - INFO - Add CNAME VDNS record for ctest-vm1-test-30937653 and verify we able to ping by alias name
2026-08-24 04:38:29,124 - DEBUG - Creating VDNS record data : test-rec
2026-08-24 04:38:29,237 - INFO - In verify_on_setup
2026-08-24 04:38:29,333 - DEBUG - VDNS record: ['default-domain', 'ctest-vdns1-72474161', 'test-rec'] created succesfully
2026-08-24 04:38:29,333 - INFO - Verify VDNS record is shown in the API server
2026-08-24 04:38:29,333 - DEBUG - Requesting: http://10.0.0.188:8082/domains
2026-08-24 04:38:29,340 - DEBUG - Requesting: http://10.0.0.188:8082/domain/a50a8990-58af-4da4-8cb1-9f88b28629ea
2026-08-24 04:38:29,352 - DEBUG - Requesting: http://10.0.0.188:8082/virtual-DNS/c5432354-38fa-4e9c-abf5-9334e1817663
2026-08-24 04:38:29,359 - DEBUG - Requesting: http://10.0.0.188:8082/virtual-DNS-record/baec78b6-dfaf-4e33-892a-105b093f58d3
2026-08-24 04:38:29,366 - INFO - Verify VDNS record is shown in the control node
2026-08-24 04:38:29,372 - 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.188, gateway password: c0ntrail123
2026-08-24 04:38:29,373 - DEBUG - python -c 'import socket;socket.getaddrinfo("vm1-test-alias", None, socket.AF_INET6)'
2026-08-24 04:38:29,611 - 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.188, gateway password: c0ntrail123
2026-08-24 04:38:29,612 - DEBUG - ping -s 56 -c 3 -W 1 vm1-test-alias
2026-08-24 04:38:29,894 - DEBUG - ping: bad address 'vm1-test-alias'
2026-08-24 04:38:29,894 - WARNING - Ping to IP vm1-test-alias from VM ctest-vm1-test-30937653 failed
2026-08-24 04:38:30,895 - 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.188, gateway password: c0ntrail123
2026-08-24 04:38:30,895 - DEBUG - python -c 'import socket;socket.getaddrinfo("vm1-test-alias", None, socket.AF_INET6)'
2026-08-24 04:38:31,243 - 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.188, gateway password: c0ntrail123
2026-08-24 04:38:31,243 - DEBUG - ping -s 56 -c 3 -W 1 vm1-test-alias
2026-08-24 04:38:31,531 - DEBUG - ping: bad address 'vm1-test-alias'
2026-08-24 04:38:31,531 - WARNING - Ping to IP vm1-test-alias from VM ctest-vm1-test-30937653 failed
2026-08-24 04:38:32,532 - 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.188, gateway password: c0ntrail123
2026-08-24 04:38:32,532 - DEBUG - python -c 'import socket;socket.getaddrinfo("vm1-test-alias", None, socket.AF_INET6)'
2026-08-24 04:38:32,721 - 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.188, gateway password: c0ntrail123
2026-08-24 04:38:32,721 - DEBUG - ping -s 56 -c 3 -W 1 vm1-test-alias
2026-08-24 04:38:35,035 - DEBUG - PING vm1-test-alias (10.10.10.3): 56 data bytes
64 bytes from 10.10.10.3: seq=0 ttl=64 time=1.731 ms
64 bytes from 10.10.10.3: seq=1 ttl=64 time=2.051 ms
64 bytes from 10.10.10.3: seq=2 ttl=64 time=2.068 ms
--- vm1-test-alias ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.731/1.950/2.068 ms
2026-08-24 04:38:35,035 - INFO - Ping to IP vm1-test-alias from VM ctest-vm1-test-30937653 passed
2026-08-24 04:38:35,035 - DEBUG - Deleting VDNS record data: test-rec
2026-08-24 04:38:35,108 - INFO - VDNS record info: default-domain:ctest-vdns1-72474161:test-rec deleted successfully.
2026-08-24 04:38:35,109 - INFO - Deleting VM ctest-vm2-test-59652473
2026-08-24 04:38:35,196 - INFO - Deleting VM ctest-vm1-test-30937653
2026-08-24 04:38:35,276 - INFO - Deleting VN ctest-vn1-vdns-82314336
2026-08-24 04:38:35,323 - DEBUG - VN 16565201-b45e-45d5-8204-4782922e6d78 still in use: Unable to complete operation on network 16565201-b45e-45d5-8204-4782922e6d78. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-52364036-cae9-4844-971a-49f0bb75db9c']
2026-08-24 04:38:35,323 - WARNING - Deleting VN ctest-vn1-vdns-82314336 failed..Will retry
2026-08-24 04:38:37,379 - DEBUG - VN 16565201-b45e-45d5-8204-4782922e6d78 still in use: Unable to complete operation on network 16565201-b45e-45d5-8204-4782922e6d78. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-58cd8f1b-3a12-44c1-b435-5895897ea066']
2026-08-24 04:38:37,379 - WARNING - Deleting VN ctest-vn1-vdns-82314336 failed..Will retry
2026-08-24 04:38:39,592 - DEBUG - Response for deleting network ()
2026-08-24 04:38:39,625 - DEBUG - Deleting VDNS Entry: ctest-vdns1-72474161
2026-08-24 04:38:39,700 - INFO - VDNS info: ['default-domain', 'ctest-vdns1-72474161'] deleted successfully.
2026-08-24 04:38:39,701 - DEBUG - Requesting: http://10.0.0.188:8082/domains
2026-08-24 04:38:39,707 - DEBUG - Requesting: http://10.0.0.188:8082/domain/a50a8990-58af-4da4-8cb1-9f88b28629ea
2026-08-24 04:38:39,721 - DEBUG - VDNS information not found in API server
2026-08-24 04:38:39,721 - INFO - VDNS information ctest-vdns1-72474161 removed from the API Server
2026-08-24 04:38:39,729 - INFO - VDNS information ctest-vdns1-72474161 removed in the Control node
2026-08-24 04:38:39,729 - DEBUG - Skipping the deletion of Project ['default-domain', 'ctest-TestvDNSBasic0-31608607']
2026-08-24 04:38:39,998 - DEBUG - No XMPP flaps were noticed during the test
2026-08-24 04:38:39,998 - INFO - END TEST : test_vdns_ping_same_vn : PASSED[0:01:37]
2026-08-24 04:38:39,998 - INFO - --------------------------------------------------------------------------------
2026-08-24 04:38:40,850 - INFO - Deleted project: ctest-TestvDNSBasic0-31608607, ID : b5f31141-2a7b-4c72-9c7e-09eff45db425