is in ACTIVE state now
2025-11-14 07:54:28,604 - INFO - VM name : ctest-vm2-test-21221886
2025-11-14 07:54:28,682 - DEBUG - VM ctest-vm2-test-21221886 ID is b275c623-3a70-4df1-bb53-c707dbd0b8a7
2025-11-14 07:54:28,682 - DEBUG - VM ctest-vm2-test-21221886 launched on Node cn-jenkins-deploy-platform-ansible-os-4728-1
2025-11-14 07:54:28,764 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine/b275c623-3a70-4df1-bb53-c707dbd0b8a7
2025-11-14 07:54:28,771 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/0e8eb76a-f738-4487-b2a0-c9428c2712bb
2025-11-14 07:54:32,032 - 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 1027ms')
2025-11-14 07:54:32,032 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-vm2-test-21221886 failed!
2025-11-14 07:54:32,089 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-04591641:ctest-vn1-vdns-44877814 is 10.10.10.1 and allocation pool is NOT set
2025-11-14 07:54:34,153 - 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.82 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.775 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.775/2.799/4.823/2.024 ms')
2025-11-14 07:54:34,153 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vm2-test-21221886 passed
2025-11-14 07:54:34,301 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-14 07:54:34,301 - DEBUG - Waiting to SSH to VM ctest-vm2-test-21221886, IP 10.10.10.4, Port 22
2025-11-14 07:54:34,475 - DEBUG - VM ctest-vm2-test-21221886 is ready for SSH connections
2025-11-14 07:54:34,476 - 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.141, gateway password: c0ntrail123
2025-11-14 07:54:34,476 - DEBUG - ifconfig | grep 10.10.10.4
2025-11-14 07:54:36,102 - DEBUG - inet addr:10.10.10.4 Bcast:10.10.10.255 Mask:255.255.255.0
2025-11-14 07:54:36,102 - DEBUG - Running remote_cmd, Cmd : python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-21221886", None, socket.AF_INET6)', host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.141, gateway password: c0ntrail123
2025-11-14 07:54:36,102 - DEBUG - python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-21221886", None, socket.AF_INET6)'
2025-11-14 07:54:36,354 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 ctest-vm2-test-21221886, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.141, gateway password: c0ntrail123
2025-11-14 07:54:36,354 - DEBUG - ping -s 56 -c 3 -W 1 ctest-vm2-test-21221886
2025-11-14 07:54:38,644 - DEBUG - PING ctest-vm2-test-21221886 (10.10.10.4): 56 data bytes
64 bytes from 10.10.10.4: seq=0 ttl=64 time=3.447 ms
64 bytes from 10.10.10.4: seq=1 ttl=64 time=0.551 ms
64 bytes from 10.10.10.4: seq=2 ttl=64 time=0.411 ms
--- ctest-vm2-test-21221886 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.411/1.469/3.447 ms
2025-11-14 07:54:38,644 - INFO - Ping to IP ctest-vm2-test-21221886 from VM ctest-vm2-test-21221886 passed
2025-11-14 07:54:38,657 - DEBUG - Requesting: http://10.0.0.141:8092/Snh_PageReq?x=AllEntries%20VdnsServersReq
2025-11-14 07:54:38,662 - DEBUG - Requesting: http://10.0.0.141:8092/Snh_PageReq?x=default-domain:ctest-vdns1-36125646@0%20AllEntriesVdnsRecordsReq
2025-11-14 07:54:38,666 - DEBUG - Actual record data {'name': 'default-domain:ctest-vdns1-36125646:1:ctest-vm2-test-21221886:10.10.10.4', 'rec_name': 'ctest-vm2-test-21221886', '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-4728-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-21221886.juniper.net', 'installed': 'yes', 'zone': 'juniper.net'}
2025-11-14 07:54:38,667 - DEBUG - Actual record data {'name': 'default-domain:ctest-vdns1-36125646:12:4.10.10.10.in-addr.arpa:ctest-vm2-test-21221886', 'rec_name': '4.10.10.10.in-addr.arpa', 'rec_type': 'PTR', 'rec_class': 'IN', 'rec_data': 'ctest-vm2-test-21221886', 'rec_ttl': '100', 'source': 'Agent', 'installed': 'true', 'flags': '3', 'rec_source_name': 'cn-jenkins-deploy-platform-ansible-os-4728-1/dns'} ,
Expected record data {'rec_data': 'ctest-vm2-test-21221886.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-11-14 07:54:38,667 - DEBUG - Running remote_cmd, Cmd : python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-21221886", None, socket.AF_INET6)', host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.141, gateway password: c0ntrail123
2025-11-14 07:54:38,667 - DEBUG - python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-21221886", None, socket.AF_INET6)'
2025-11-14 07:54:38,851 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 ctest-vm2-test-21221886, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.141, gateway password: c0ntrail123
2025-11-14 07:54:38,852 - DEBUG - ping -s 56 -c 3 -W 1 ctest-vm2-test-21221886
2025-11-14 07:54:41,114 - DEBUG - PING ctest-vm2-test-21221886 (10.10.10.4): 56 data bytes
64 bytes from 10.10.10.4: seq=0 ttl=64 time=5.824 ms
64 bytes from 10.10.10.4: seq=1 ttl=64 time=0.999 ms
64 bytes from 10.10.10.4: seq=2 ttl=64 time=0.939 ms
--- ctest-vm2-test-21221886 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.939/2.587/5.824 ms
2025-11-14 07:54:41,114 - INFO - Ping to IP ctest-vm2-test-21221886 from VM ctest-vm1-test-88417880 passed
2025-11-14 07:54:41,114 - INFO - Try deleting the VDNS entry ctest-vdns1-36125646 with back ref of ipam.
2025-11-14 07:54:41,169 - DEBUG - Delete when resource still referred: ['http://10.0.0.141:8082/network-ipam/0a2c63d4-f337-4fdc-b547-3a2b8267cb7e']
2025-11-14 07:54:41,169 - INFO - Deletion of the vdns entry failed with back ref of ipam as expected
2025-11-14 07:54:41,169 - INFO - Add CNAME VDNS record for ctest-vm1-test-88417880 and verify we able to ping by alias name
2025-11-14 07:54:41,217 - DEBUG - Creating VDNS record data : test-rec
2025-11-14 07:54:41,337 - INFO - In verify_on_setup
2025-11-14 07:54:41,433 - DEBUG - VDNS record: ['default-domain', 'ctest-vdns1-36125646', 'test-rec'] created succesfully
2025-11-14 07:54:41,433 - INFO - Verify VDNS record is shown in the API server
2025-11-14 07:54:41,433 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2025-11-14 07:54:41,439 - DEBUG - Requesting: http://10.0.0.141:8082/domain/cca70740-afe2-4c9c-87cf-b2c7b25a6d2c
2025-11-14 07:54:41,451 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-DNS/e4a73725-2ff1-4dfb-aac0-dfa3f1a29757
2025-11-14 07:54:41,459 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-DNS-record/2fdd32ab-5ba2-441b-8b56-61900b127c6e
2025-11-14 07:54:41,465 - INFO - Verify VDNS record is shown in the control node
2025-11-14 07:54:41,474 - 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.141, gateway password: c0ntrail123
2025-11-14 07:54:41,474 - DEBUG - python -c 'import socket;socket.getaddrinfo("vm1-test-alias", None, socket.AF_INET6)'
2025-11-14 07:54:41,661 - 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.141, gateway password: c0ntrail123
2025-11-14 07:54:41,661 - DEBUG - ping -s 56 -c 3 -W 1 vm1-test-alias
2025-11-14 07:54:41,900 - DEBUG - ping: bad address 'vm1-test-alias'
2025-11-14 07:54:41,900 - WARNING - Ping to IP vm1-test-alias from VM ctest-vm1-test-88417880 failed
2025-11-14 07:54:42,901 - 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.141, gateway password: c0ntrail123
2025-11-14 07:54:42,901 - DEBUG - python -c 'import socket;socket.getaddrinfo("vm1-test-alias", None, socket.AF_INET6)'
2025-11-14 07:54:43,097 - 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.141, gateway password: c0ntrail123
2025-11-14 07:54:43,097 - DEBUG - ping -s 56 -c 3 -W 1 vm1-test-alias
2025-11-14 07:54:43,344 - DEBUG - ping: bad address 'vm1-test-alias'
2025-11-14 07:54:43,344 - WARNING - Ping to IP vm1-test-alias from VM ctest-vm1-test-88417880 failed
2025-11-14 07:54:44,345 - 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.141, gateway password: c0ntrail123
2025-11-14 07:54:44,345 - DEBUG - python -c 'import socket;socket.getaddrinfo("vm1-test-alias", None, socket.AF_INET6)'
2025-11-14 07:54:44,531 - 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.141, gateway password: c0ntrail123
2025-11-14 07:54:44,531 - DEBUG - ping -s 56 -c 3 -W 1 vm1-test-alias
2025-11-14 07:54:46,788 - 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.348 ms
64 bytes from 10.10.10.3: seq=1 ttl=64 time=0.356 ms
64 bytes from 10.10.10.3: seq=2 ttl=64 time=0.299 ms
--- vm1-test-alias ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.299/0.334/0.356 ms
2025-11-14 07:54:46,788 - INFO - Ping to IP vm1-test-alias from VM ctest-vm1-test-88417880 passed
2025-11-14 07:54:46,788 - DEBUG - Deleting VDNS record data: test-rec
2025-11-14 07:54:46,861 - INFO - VDNS record info: default-domain:ctest-vdns1-36125646:test-rec deleted successfully.
2025-11-14 07:54:46,861 - INFO - Deleting VM ctest-vm2-test-21221886
2025-11-14 07:54:46,944 - INFO - Deleting VM ctest-vm1-test-88417880
2025-11-14 07:54:47,020 - INFO - Deleting VN ctest-vn1-vdns-44877814
2025-11-14 07:54:47,055 - DEBUG - VN 99a25e28-dd96-4986-8bab-029b80139b3a still in use: Unable to complete operation on network 99a25e28-dd96-4986-8bab-029b80139b3a. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-93c7ef9d-6bea-403a-bd24-64256d2b3577']
2025-11-14 07:54:47,055 - WARNING - Deleting VN ctest-vn1-vdns-44877814 failed..Will retry
2025-11-14 07:54:49,311 - DEBUG - Response for deleting network ()
2025-11-14 07:54:49,337 - DEBUG - Deleting VDNS Entry: ctest-vdns1-36125646
2025-11-14 07:54:49,409 - INFO - VDNS info: ['default-domain', 'ctest-vdns1-36125646'] deleted successfully.
2025-11-14 07:54:49,409 - DEBUG - Requesting: http://10.0.0.141:8082/domains
2025-11-14 07:54:49,416 - DEBUG - Requesting: http://10.0.0.141:8082/domain/cca70740-afe2-4c9c-87cf-b2c7b25a6d2c
2025-11-14 07:54:49,432 - DEBUG - VDNS information not found in API server
2025-11-14 07:54:49,432 - INFO - VDNS information ctest-vdns1-36125646 removed from the API Server
2025-11-14 07:54:49,438 - INFO - VDNS information ctest-vdns1-36125646 removed in the Control node
2025-11-14 07:54:49,438 - DEBUG - Skipping the deletion of Project ['default-domain', 'ctest-TestvDNSBasic0-04591641']
2025-11-14 07:54:49,694 - DEBUG - No XMPP flaps were noticed during the test
2025-11-14 07:54:49,694 - INFO - END TEST : test_vdns_ping_same_vn : PASSED[0:00:46]
2025-11-14 07:54:49,694 - INFO - --------------------------------------------------------------------------------
2025-11-14 07:54:50,377 - INFO - Deleted project: ctest-TestvDNSBasic0-04591641, ID : a3e16909-1cc5-4229-a9b1-a2735ed1ca6f