is in ACTIVE state now
2025-03-20 17:09:37,951 - INFO - VM name : ctest-vm2-test-59585570
2025-03-20 17:09:38,038 - DEBUG - VM ctest-vm2-test-59585570 ID is f4d4ac97-283f-4e11-acc5-7706872b5199
2025-03-20 17:09:38,038 - DEBUG - VM ctest-vm2-test-59585570 launched on Node cn-jenkins-deploy-platform-ansible-os-2930-1
2025-03-20 17:09:38,127 - DEBUG - Requesting: http://10.0.0.31:8082/virtual-machine/f4d4ac97-283f-4e11-acc5-7706872b5199
2025-03-20 17:09:38,138 - DEBUG - Requesting: http://10.0.0.31:8082/virtual-machine-interface/40acbe8c-02ff-43e6-9f87-cd1b28a38067
2025-03-20 17:09:41,411 - 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 1025ms')
2025-03-20 17:09:41,411 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-vm2-test-59585570 failed!
2025-03-20 17:09:41,473 - DEBUG - Gateway for vn default-domain:ctest-TestvDNSBasic0-84616660:ctest-vn1-vdns-32239005 is 10.10.10.1 and allocation pool is NOT set
2025-03-20 17:09:45,538 - 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=2 ttl=63 time=5.19 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1006ms\r\nrtt min/avg/max/mdev = 5.190/5.190/5.190/0.000 ms')
2025-03-20 17:09:45,538 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vm2-test-59585570 passed
2025-03-20 17:09:45,697 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-03-20 17:09:45,697 - DEBUG - Waiting to SSH to VM ctest-vm2-test-59585570, IP 10.10.10.4, Port 22
2025-03-20 17:09:45,853 - DEBUG - VM ctest-vm2-test-59585570 is ready for SSH connections
2025-03-20 17:09:45,853 - 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.31, gateway password: c0ntrail123
2025-03-20 17:09:45,853 - DEBUG - ifconfig | grep 10.10.10.4
2025-03-20 17:09:46,533 - DEBUG - inet addr:10.10.10.4 Bcast:10.10.10.255 Mask:255.255.255.0
2025-03-20 17:09:46,534 - DEBUG - Running remote_cmd, Cmd : python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-59585570", None, socket.AF_INET6)', host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.31, gateway password: c0ntrail123
2025-03-20 17:09:46,534 - DEBUG - python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-59585570", None, socket.AF_INET6)'
2025-03-20 17:09:46,781 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 ctest-vm2-test-59585570, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.31, gateway password: c0ntrail123
2025-03-20 17:09:46,781 - DEBUG - ping -s 56 -c 3 -W 1 ctest-vm2-test-59585570
2025-03-20 17:09:49,063 - DEBUG - PING ctest-vm2-test-59585570 (10.10.10.4): 56 data bytes
64 bytes from 10.10.10.4: seq=0 ttl=64 time=3.424 ms
64 bytes from 10.10.10.4: seq=1 ttl=64 time=0.429 ms
64 bytes from 10.10.10.4: seq=2 ttl=64 time=0.504 ms
--- ctest-vm2-test-59585570 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.429/1.452/3.424 ms
2025-03-20 17:09:49,063 - INFO - Ping to IP ctest-vm2-test-59585570 from VM ctest-vm2-test-59585570 passed
2025-03-20 17:09:49,077 - DEBUG - Requesting: http://10.0.0.31:8092/Snh_PageReq?x=AllEntries%20VdnsServersReq
2025-03-20 17:09:49,084 - DEBUG - Requesting: http://10.0.0.31:8092/Snh_PageReq?x=default-domain:ctest-vdns1-67085382@0%20AllEntriesVdnsRecordsReq
2025-03-20 17:09:49,091 - DEBUG - Actual record data {'name': 'default-domain:ctest-vdns1-67085382:1:ctest-vm2-test-59585570:10.10.10.4', 'rec_name': 'ctest-vm2-test-59585570', '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-2930-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-59585570.juniper.net', 'installed': 'yes', 'zone': 'juniper.net'}
2025-03-20 17:09:49,091 - DEBUG - Actual record data {'name': 'default-domain:ctest-vdns1-67085382:12:4.10.10.10.in-addr.arpa:ctest-vm2-test-59585570', 'rec_name': '4.10.10.10.in-addr.arpa', 'rec_type': 'PTR', 'rec_class': 'IN', 'rec_data': 'ctest-vm2-test-59585570', 'rec_ttl': '100', 'source': 'Agent', 'installed': 'true', 'flags': '3', 'rec_source_name': 'cn-jenkins-deploy-platform-ansible-os-2930-1/dns'} ,
Expected record data {'rec_data': 'ctest-vm2-test-59585570.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-03-20 17:09:49,091 - DEBUG - Running remote_cmd, Cmd : python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-59585570", None, socket.AF_INET6)', host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.31, gateway password: c0ntrail123
2025-03-20 17:09:49,091 - DEBUG - python -c 'import socket;socket.getaddrinfo("ctest-vm2-test-59585570", None, socket.AF_INET6)'
2025-03-20 17:09:49,300 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 ctest-vm2-test-59585570, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.31, gateway password: c0ntrail123
2025-03-20 17:09:49,300 - DEBUG - ping -s 56 -c 3 -W 1 ctest-vm2-test-59585570
2025-03-20 17:09:51,577 - DEBUG - PING ctest-vm2-test-59585570 (10.10.10.4): 56 data bytes
64 bytes from 10.10.10.4: seq=0 ttl=64 time=5.952 ms
64 bytes from 10.10.10.4: seq=1 ttl=64 time=0.995 ms
64 bytes from 10.10.10.4: seq=2 ttl=64 time=1.251 ms
--- ctest-vm2-test-59585570 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.995/2.732/5.952 ms
2025-03-20 17:09:51,577 - INFO - Ping to IP ctest-vm2-test-59585570 from VM ctest-vm1-test-48789488 passed
2025-03-20 17:09:51,577 - INFO - Try deleting the VDNS entry ctest-vdns1-67085382 with back ref of ipam.
2025-03-20 17:09:51,633 - DEBUG - Delete when resource still referred: ['http://10.0.0.31:8082/network-ipam/3f0a8bb9-1462-4ced-b07b-76af276ab255']
2025-03-20 17:09:51,634 - INFO - Deletion of the vdns entry failed with back ref of ipam as expected
2025-03-20 17:09:51,634 - INFO - Add CNAME VDNS record for ctest-vm1-test-48789488 and verify we able to ping by alias name
2025-03-20 17:09:51,681 - DEBUG - Creating VDNS record data : test-rec
2025-03-20 17:09:51,797 - INFO - In verify_on_setup
2025-03-20 17:09:51,897 - DEBUG - VDNS record: ['default-domain', 'ctest-vdns1-67085382', 'test-rec'] created succesfully
2025-03-20 17:09:51,897 - INFO - Verify VDNS record is shown in the API server
2025-03-20 17:09:51,897 - DEBUG - Requesting: http://10.0.0.31:8082/domains
2025-03-20 17:09:51,904 - DEBUG - Requesting: http://10.0.0.31:8082/domain/f44969ab-99bd-4d44-9177-d6623635728e
2025-03-20 17:09:51,919 - DEBUG - Requesting: http://10.0.0.31:8082/virtual-DNS/41a9b63d-26d0-45fc-b2ae-a87ef9182f56
2025-03-20 17:09:51,928 - DEBUG - Requesting: http://10.0.0.31:8082/virtual-DNS-record/60a39f2e-18bb-45e5-9798-3b6ecdaf3089
2025-03-20 17:09:51,937 - INFO - Verify VDNS record is shown in the control node
2025-03-20 17:09:51,943 - 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.31, gateway password: c0ntrail123
2025-03-20 17:09:51,943 - DEBUG - python -c 'import socket;socket.getaddrinfo("vm1-test-alias", None, socket.AF_INET6)'
2025-03-20 17:09:52,148 - 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.31, gateway password: c0ntrail123
2025-03-20 17:09:52,148 - DEBUG - ping -s 56 -c 3 -W 1 vm1-test-alias
2025-03-20 17:09:52,430 - DEBUG - ping: bad address 'vm1-test-alias'
2025-03-20 17:09:52,430 - WARNING - Ping to IP vm1-test-alias from VM ctest-vm1-test-48789488 failed
2025-03-20 17:09:53,430 - 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.31, gateway password: c0ntrail123
2025-03-20 17:09:53,431 - DEBUG - python -c 'import socket;socket.getaddrinfo("vm1-test-alias", None, socket.AF_INET6)'
2025-03-20 17:09:53,669 - 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.31, gateway password: c0ntrail123
2025-03-20 17:09:53,669 - DEBUG - ping -s 56 -c 3 -W 1 vm1-test-alias
2025-03-20 17:09:53,937 - DEBUG - ping: bad address 'vm1-test-alias'
2025-03-20 17:09:53,938 - WARNING - Ping to IP vm1-test-alias from VM ctest-vm1-test-48789488 failed
2025-03-20 17:09:54,939 - 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.31, gateway password: c0ntrail123
2025-03-20 17:09:54,939 - DEBUG - python -c 'import socket;socket.getaddrinfo("vm1-test-alias", None, socket.AF_INET6)'
2025-03-20 17:09:55,133 - 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.31, gateway password: c0ntrail123
2025-03-20 17:09:55,133 - DEBUG - ping -s 56 -c 3 -W 1 vm1-test-alias
2025-03-20 17:09:57,424 - 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.417 ms
64 bytes from 10.10.10.3: seq=1 ttl=64 time=0.475 ms
64 bytes from 10.10.10.3: seq=2 ttl=64 time=0.352 ms
--- vm1-test-alias ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.352/0.414/0.475 ms
2025-03-20 17:09:57,424 - INFO - Ping to IP vm1-test-alias from VM ctest-vm1-test-48789488 passed
2025-03-20 17:09:57,424 - DEBUG - Deleting VDNS record data: test-rec
2025-03-20 17:09:57,493 - INFO - VDNS record info: default-domain:ctest-vdns1-67085382:test-rec deleted successfully.
2025-03-20 17:09:57,493 - INFO - Deleting VM ctest-vm2-test-59585570
2025-03-20 17:09:57,570 - INFO - Deleting VM ctest-vm1-test-48789488
2025-03-20 17:09:57,655 - INFO - Deleting VN ctest-vn1-vdns-32239005
2025-03-20 17:09:57,698 - DEBUG - VN 1f36bc79-9da0-4910-9bf0-6e3a3940e6f1 still in use: Unable to complete operation on network 1f36bc79-9da0-4910-9bf0-6e3a3940e6f1. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-2a3ac1b8-38a8-48ad-9ca2-fb84bb9f2ff1']
2025-03-20 17:09:57,699 - WARNING - Deleting VN ctest-vn1-vdns-32239005 failed..Will retry
2025-03-20 17:09:59,867 - DEBUG - Response for deleting network ()
2025-03-20 17:09:59,906 - DEBUG - Deleting VDNS Entry: ctest-vdns1-67085382
2025-03-20 17:09:59,989 - INFO - VDNS info: ['default-domain', 'ctest-vdns1-67085382'] deleted successfully.
2025-03-20 17:09:59,989 - DEBUG - Requesting: http://10.0.0.31:8082/domains
2025-03-20 17:09:59,997 - DEBUG - Requesting: http://10.0.0.31:8082/domain/f44969ab-99bd-4d44-9177-d6623635728e
2025-03-20 17:10:00,019 - DEBUG - VDNS information not found in API server
2025-03-20 17:10:00,019 - INFO - VDNS information ctest-vdns1-67085382 removed from the API Server
2025-03-20 17:10:00,026 - INFO - VDNS information ctest-vdns1-67085382 removed in the Control node
2025-03-20 17:10:00,026 - DEBUG - Skipping the deletion of Project ['default-domain', 'ctest-TestvDNSBasic0-84616660']
2025-03-20 17:10:00,284 - DEBUG - No XMPP flaps were noticed during the test
2025-03-20 17:10:00,284 - INFO - END TEST : test_vdns_ping_same_vn : PASSED[0:00:50]
2025-03-20 17:10:00,284 - INFO - --------------------------------------------------------------------------------
2025-03-20 17:10:01,018 - INFO - Deleted project: ctest-TestvDNSBasic0-84616660, ID : 0f5c26ad-15b3-413d-8ef5-982c992151e4