is in ACTIVE state now
2026-08-04 06:23:45,960 - INFO - VM name : ctest-vm2-test-62923412
2026-08-04 06:23:46,053 - DEBUG - VM ctest-vm2-test-62923412 ID is 6139915f-e568-4b4b-b656-357261af63df
2026-08-04 06:23:46,053 - DEBUG - VM ctest-vm2-test-62923412 launched on Node cn-jenkins-deploy-platform-ansible-os-6130-1
2026-08-04 06:23:46,147 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/6139915f-e568-4b4b-b656-357261af63df
2026-08-04 06:23:46,158 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/b660ddfc-5421-4c98-84ea-702abccb7d3f
2026-08-04 06:23:49,447 - 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 1032ms')
2026-08-04 06:23:49,447 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-vm2-test-62923412 failed!
2026-08-04 06:23:49,505 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-96212599:ctest-vn1-vdns-90187132 is 10.10.10.1 and allocation pool is NOT set
2026-08-04 06:23:51,572 - 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.02 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.585 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.585/2.303/4.022/1.718 ms')
2026-08-04 06:23:51,573 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vm2-test-62923412 passed
2026-08-04 06:23:51,729 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-08-04 06:23:51,730 - DEBUG - Waiting to SSH to VM ctest-vm2-test-62923412, IP 10.10.10.4, Port 22
2026-08-04 06:23:51,903 - DEBUG - VM ctest-vm2-test-62923412 is ready for SSH connections
2026-08-04 06:23:51,903 - 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.50, gateway password: c0ntrail123
2026-08-04 06:23:51,903 - DEBUG - ifconfig | grep 10.10.10.4
2026-08-04 06:23:52,981 - DEBUG - inet addr:10.10.10.4 Bcast:10.10.10.255 Mask:255.255.255.0
2026-08-04 06:23:52,982 - DEBUG - Running remote_cmd, Cmd : python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-62923412", None, socket.AF_INET6)', host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2026-08-04 06:23:52,982 - DEBUG - python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-62923412", None, socket.AF_INET6)'
2026-08-04 06:23:53,196 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 ctest-vm2-test-62923412, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2026-08-04 06:23:53,196 - DEBUG - ping -s 56 -c 3 -W 1 ctest-vm2-test-62923412
2026-08-04 06:23:55,395 - DEBUG - PING ctest-vm2-test-62923412 (10.10.10.4): 56 data bytes
64 bytes from 10.10.10.4: seq=0 ttl=64 time=5.774 ms
64 bytes from 10.10.10.4: seq=1 ttl=64 time=0.441 ms
64 bytes from 10.10.10.4: seq=2 ttl=64 time=0.747 ms
--- ctest-vm2-test-62923412 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.441/2.320/5.774 ms
2026-08-04 06:23:55,395 - INFO - Ping to IP ctest-vm2-test-62923412 from VM ctest-vm2-test-62923412 passed
2026-08-04 06:23:55,413 - DEBUG - Requesting: http://10.0.0.50:8092/Snh_PageReq?x=AllEntries%20VdnsServersReq
2026-08-04 06:23:55,420 - DEBUG - Requesting: http://10.0.0.50:8092/Snh_PageReq?x=default-domain:ctest-vdns1-81716005@0%20AllEntriesVdnsRecordsReq
2026-08-04 06:23:55,427 - DEBUG - Actual record data {'name': 'default-domain:ctest-vdns1-81716005:1:ctest-vm2-test-62923412:10.10.10.4', 'rec_name': 'ctest-vm2-test-62923412', '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-6130-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-62923412.juniper.net', 'installed': 'yes', 'zone': 'juniper.net'}
2026-08-04 06:23:55,427 - DEBUG - Actual record data {'name': 'default-domain:ctest-vdns1-81716005:12:4.10.10.10.in-addr.arpa:ctest-vm2-test-62923412', 'rec_name': '4.10.10.10.in-addr.arpa', 'rec_type': 'PTR', 'rec_class': 'IN', 'rec_data': 'ctest-vm2-test-62923412', 'rec_ttl': '100', 'source': 'Agent', 'installed': 'true', 'flags': '3', 'rec_source_name': 'cn-jenkins-deploy-platform-ansible-os-6130-1/dns'} ,
Expected record data {'rec_data': 'ctest-vm2-test-62923412.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-04 06:23:55,427 - DEBUG - Running remote_cmd, Cmd : python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-62923412", None, socket.AF_INET6)', host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2026-08-04 06:23:55,428 - DEBUG - python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-62923412", None, socket.AF_INET6)'
2026-08-04 06:23:55,566 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 ctest-vm2-test-62923412, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2026-08-04 06:23:55,567 - DEBUG - ping -s 56 -c 3 -W 1 ctest-vm2-test-62923412
2026-08-04 06:23:57,762 - DEBUG - PING ctest-vm2-test-62923412 (10.10.10.4): 56 data bytes
64 bytes from 10.10.10.4: seq=0 ttl=64 time=7.842 ms
64 bytes from 10.10.10.4: seq=1 ttl=64 time=1.189 ms
64 bytes from 10.10.10.4: seq=2 ttl=64 time=1.120 ms
--- ctest-vm2-test-62923412 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.120/3.383/7.842 ms
2026-08-04 06:23:57,762 - INFO - Ping to IP ctest-vm2-test-62923412 from VM ctest-vm1-test-09252132 passed
2026-08-04 06:23:57,763 - INFO - Try deleting the VDNS entry ctest-vdns1-81716005 with back ref of ipam.
2026-08-04 06:23:57,825 - DEBUG - Delete when resource still referred: ['http://10.0.0.50:8082/network-ipam/4063b67a-ab9d-4e9a-b6b8-51a90fe70d20']
2026-08-04 06:23:57,825 - INFO - Deletion of the vdns entry failed with back ref of ipam as expected
2026-08-04 06:23:57,825 - INFO - Add CNAME VDNS record for ctest-vm1-test-09252132 and verify we able to ping by alias name
2026-08-04 06:23:57,873 - DEBUG - Creating VDNS record data : test-rec
2026-08-04 06:23:57,993 - INFO - In verify_on_setup
2026-08-04 06:23:58,093 - DEBUG - VDNS record: ['default-domain', 'ctest-vdns1-81716005', 'test-rec'] created succesfully
2026-08-04 06:23:58,093 - INFO - Verify VDNS record is shown in the API server
2026-08-04 06:23:58,094 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2026-08-04 06:23:58,101 - DEBUG - Requesting: http://10.0.0.50:8082/domain/9c93f504-bac6-4fd6-9e84-cb4b34ac1e18
2026-08-04 06:23:58,116 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-DNS/04840e49-6d7f-463b-a799-d5ca41ff6f8f
2026-08-04 06:23:58,125 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-DNS-record/6e67baa5-9da1-4db1-bb30-1e9f7f03954e
2026-08-04 06:23:58,132 - INFO - Verify VDNS record is shown in the control node
2026-08-04 06:23:58,140 - 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.50, gateway password: c0ntrail123
2026-08-04 06:23:58,140 - DEBUG - python -c 'import socket;socket.getaddrinfo("vm1-test-alias", None, socket.AF_INET6)'
2026-08-04 06:23:58,267 - 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.50, gateway password: c0ntrail123
2026-08-04 06:23:58,268 - DEBUG - ping -s 56 -c 3 -W 1 vm1-test-alias
2026-08-04 06:23:58,454 - DEBUG - ping: bad address 'vm1-test-alias'
2026-08-04 06:23:58,455 - WARNING - Ping to IP vm1-test-alias from VM ctest-vm1-test-09252132 failed
2026-08-04 06:23:59,455 - 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.50, gateway password: c0ntrail123
2026-08-04 06:23:59,456 - DEBUG - python -c 'import socket;socket.getaddrinfo("vm1-test-alias", None, socket.AF_INET6)'
2026-08-04 06:23:59,583 - 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.50, gateway password: c0ntrail123
2026-08-04 06:23:59,583 - DEBUG - ping -s 56 -c 3 -W 1 vm1-test-alias
2026-08-04 06:23:59,754 - DEBUG - ping: bad address 'vm1-test-alias'
2026-08-04 06:23:59,754 - WARNING - Ping to IP vm1-test-alias from VM ctest-vm1-test-09252132 failed
2026-08-04 06:24:00,755 - 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.50, gateway password: c0ntrail123
2026-08-04 06:24:00,756 - DEBUG - python -c 'import socket;socket.getaddrinfo("vm1-test-alias", None, socket.AF_INET6)'
2026-08-04 06:24:00,895 - 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.50, gateway password: c0ntrail123
2026-08-04 06:24:00,895 - DEBUG - ping -s 56 -c 3 -W 1 vm1-test-alias
2026-08-04 06:24:03,067 - 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.326 ms
64 bytes from 10.10.10.3: seq=1 ttl=64 time=0.410 ms
64 bytes from 10.10.10.3: seq=2 ttl=64 time=0.429 ms
--- vm1-test-alias ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.326/0.388/0.429 ms
2026-08-04 06:24:03,067 - INFO - Ping to IP vm1-test-alias from VM ctest-vm1-test-09252132 passed
2026-08-04 06:24:03,067 - DEBUG - Deleting VDNS record data: test-rec
2026-08-04 06:24:03,149 - INFO - VDNS record info: default-domain:ctest-vdns1-81716005:test-rec deleted successfully.
2026-08-04 06:24:03,149 - INFO - Deleting VM ctest-vm2-test-62923412
2026-08-04 06:24:03,245 - INFO - Deleting VM ctest-vm1-test-09252132
2026-08-04 06:24:03,349 - INFO - Deleting VN ctest-vn1-vdns-90187132
2026-08-04 06:24:03,390 - DEBUG - VN 916bfb8e-7827-4e49-b331-811bd82e9d84 still in use: Unable to complete operation on network 916bfb8e-7827-4e49-b331-811bd82e9d84. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-c5ea2fd1-b853-4dc7-b4cf-99b6a9cf5cd5']
2026-08-04 06:24:03,390 - WARNING - Deleting VN ctest-vn1-vdns-90187132 failed..Will retry
2026-08-04 06:24:05,451 - DEBUG - VN 916bfb8e-7827-4e49-b331-811bd82e9d84 still in use: Unable to complete operation on network 916bfb8e-7827-4e49-b331-811bd82e9d84. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-96eed8ff-8d3b-4549-8a08-f1c7749f29ab']
2026-08-04 06:24:05,451 - WARNING - Deleting VN ctest-vn1-vdns-90187132 failed..Will retry
2026-08-04 06:24:07,721 - DEBUG - Response for deleting network ()
2026-08-04 06:24:07,765 - DEBUG - Deleting VDNS Entry: ctest-vdns1-81716005
2026-08-04 06:24:07,849 - INFO - VDNS info: ['default-domain', 'ctest-vdns1-81716005'] deleted successfully.
2026-08-04 06:24:07,849 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2026-08-04 06:24:07,858 - DEBUG - Requesting: http://10.0.0.50:8082/domain/9c93f504-bac6-4fd6-9e84-cb4b34ac1e18
2026-08-04 06:24:07,873 - DEBUG - VDNS information not found in API server
2026-08-04 06:24:07,873 - INFO - VDNS information ctest-vdns1-81716005 removed from the API Server
2026-08-04 06:24:07,882 - INFO - VDNS information ctest-vdns1-81716005 removed in the Control node
2026-08-04 06:24:07,882 - DEBUG - Skipping the deletion of Project ['default-domain', 'ctest-TestvDNSBasic0-96212599']
2026-08-04 06:24:08,149 - DEBUG - No XMPP flaps were noticed during the test
2026-08-04 06:24:08,150 - INFO - END TEST : test_vdns_ping_same_vn : PASSED[0:01:38]
2026-08-04 06:24:08,150 - INFO - --------------------------------------------------------------------------------
2026-08-04 06:24:08,962 - INFO - Deleted project: ctest-TestvDNSBasic0-96212599, ID : 6c50f715-1a28-4762-90d2-6d18b1e93e15