is in ACTIVE state now
2025-04-26 08:45:07,927 - INFO - VM name : ctest-TestBasicVMVN-95456355-66385746
2025-04-26 08:45:08,008 - DEBUG - VM ctest-TestBasicVMVN-95456355-66385746 ID is bca4d014-5bde-4d9e-b37b-e655c5b83386
2025-04-26 08:45:08,008 - DEBUG - VM ctest-TestBasicVMVN-95456355-66385746 launched on Node cn-jenkins-deploy-platform-ansible-os-3219-1
2025-04-26 08:45:08,087 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/bca4d014-5bde-4d9e-b37b-e655c5b83386
2025-04-26 08:45:08,096 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/5be47292-eca6-4c05-b086-f487ed626777
2025-04-26 08:45:09,341 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n64 bytes from 169.254.0.5: icmp_seq=1 ttl=63 time=2.67 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.322 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.322/1.496/2.670/1.174 ms')
2025-04-26 08:45:09,341 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-95456355-66385746 passed
2025-04-26 08:45:09,491 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-26 08:45:09,491 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-95456355-66385746, IP 31.1.1.3, Port 22
2025-04-26 08:45:09,647 - DEBUG - VM ctest-TestBasicVMVN-95456355-66385746 is ready for SSH connections
2025-04-26 08:45:09,647 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-26 08:45:09,647 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 31.1.2.4, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.22, gateway password: c0ntrail123
2025-04-26 08:45:09,647 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4
2025-04-26 08:45:13,617 - DEBUG - PING 31.1.2.4 (31.1.2.4): 56 data bytes
64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.534 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=0.851 ms
64 bytes from 31.1.2.4: seq=2 ttl=63 time=0.829 ms
--- 31.1.2.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.829/1.738/3.534 ms
2025-04-26 08:45:13,617 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-95456355-30838704 passed
2025-04-26 08:45:13,617 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-26 08:45:13,617 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 31.1.1.4, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.22, gateway password: c0ntrail123
2025-04-26 08:45:13,618 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4
2025-04-26 08:45:17,250 - DEBUG - PING 31.1.1.4 (31.1.1.4): 56 data bytes
64 bytes from 31.1.1.4: seq=0 ttl=63 time=2.950 ms
64 bytes from 31.1.1.4: seq=1 ttl=63 time=0.847 ms
64 bytes from 31.1.1.4: seq=2 ttl=63 time=0.773 ms
--- 31.1.1.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.773/1.523/2.950 ms
2025-04-26 08:45:17,250 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-95456355-90568737 passed
2025-04-26 08:45:17,251 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-26 08:45:17,251 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-26 08:45:17,251 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-26 08:45:17,251 - DEBUG - Running remote_cmd, Cmd : echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.22, gateway password: c0ntrail123
2025-04-26 08:45:17,251 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-26 08:45:17,426 - DEBUG - None
2025-04-26 08:45:17,426 - DEBUG - Running remote_cmd, Cmd : echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.22, gateway password: c0ntrail123
2025-04-26 08:45:17,426 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-26 08:45:17,613 - DEBUG - None
2025-04-26 08:45:17,613 - DEBUG - Running remote_cmd, Cmd : echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts, host_string: cirros@169.254.0.5, password: cubswin:)gateway: ubuntu@10.0.0.22, gateway password: c0ntrail123
2025-04-26 08:45:17,613 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-26 08:45:18,194 - DEBUG - None
2025-04-26 08:45:18,194 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 31.1.1.7, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.22, gateway password: c0ntrail123
2025-04-26 08:45:18,194 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7
2025-04-26 08:45:20,398 - DEBUG - PING 31.1.1.7 (31.1.1.7): 56 data bytes
64 bytes from 31.1.1.4: seq=0 ttl=64 time=1.882 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=5.121 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.380 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.485 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.381 ms
--- 31.1.1.7 ping statistics ---
3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss
round-trip min/avg/max = 0.380/1.849/5.121 ms
2025-04-26 08:45:20,399 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 224.0.0.1, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.22, gateway password: c0ntrail123
2025-04-26 08:45:20,399 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1
2025-04-26 08:45:22,632 - DEBUG - PING 224.0.0.1 (224.0.0.1): 56 data bytes
64 bytes from 31.1.1.4: seq=0 ttl=64 time=0.927 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.883 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.922 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.377 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=1.486 ms (DUP!)
64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.319 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.350 ms
--- 224.0.0.1 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.350/1.752/3.922 ms
2025-04-26 08:45:22,633 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 255.255.255.255, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.22, gateway password: c0ntrail123
2025-04-26 08:45:22,633 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255
2025-04-26 08:45:24,901 - DEBUG - PING 255.255.255.255 (255.255.255.255): 56 data bytes
64 bytes from 31.1.1.4: seq=0 ttl=64 time=0.737 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.782 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.570 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.387 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.516 ms (DUP!)
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.390 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.383 ms
--- 255.255.255.255 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.383/1.680/3.570 ms
2025-04-26 08:45:24,901 - INFO - Deleting VM ctest-TestBasicVMVN-95456355-66385746
2025-04-26 08:45:24,964 - INFO - Detaching port 1d92a571-6c83-40c8-8086-e49780fa2100 from VM ctest-TestBasicVMVN-95456355-90568737
2025-04-26 08:45:25,012 - INFO - Deleting VM ctest-TestBasicVMVN-95456355-90568737
2025-04-26 08:45:25,078 - INFO - Detaching port 02967f8b-550a-4e39-a1ac-10a56214c715 from VM ctest-TestBasicVMVN-95456355-30838704
2025-04-26 08:45:25,109 - INFO - Deleting VM ctest-TestBasicVMVN-95456355-30838704
2025-04-26 08:45:25,176 - INFO - Deleting VN ctest-vn-25088971
2025-04-26 08:45:25,324 - DEBUG - Response for delete_port : ()
2025-04-26 08:45:25,497 - DEBUG - Response for delete_port : ()
2025-04-26 08:45:25,538 - DEBUG - VN 448dfaff-cd93-4496-965d-a7a86a2863b1 still in use: Unable to complete operation on network 448dfaff-cd93-4496-965d-a7a86a2863b1. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-76636dab-e2db-4566-b594-82a21f88b066']
2025-04-26 08:45:25,538 - WARNING - Deleting VN ctest-vn-25088971 failed..Will retry
2025-04-26 08:45:27,689 - DEBUG - Response for deleting network ()
2025-04-26 08:45:27,689 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/d931787f-508d-4fcc-af24-158278fffbf4
2025-04-26 08:45:27,695 - DEBUG - Response Code: 404
2025-04-26 08:45:27,695 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2025-04-26 08:45:27,701 - DEBUG - Requesting: http://10.0.0.22:8082/domain/4618d77d-6252-44fc-b2fc-7fe1d2036a79
2025-04-26 08:45:27,766 - DEBUG - Requesting: http://10.0.0.22:8082/project/b98b7570-e995-4d84-adba-c9782d95355e
2025-04-26 08:45:27,846 - INFO - Validated that VN ctest-vn-25088971 is not found in API Server
2025-04-26 08:45:27,857 - DEBUG - VN ctest-vn-25088971 is not present in Agent 10.0.0.22
2025-04-26 08:45:27,857 - INFO - Validated that VN ctest-vn-25088971 is not in any agent
2025-04-26 08:45:27,862 - DEBUG - VRF 2 is not seen in agent 10.0.0.22
2025-04-26 08:45:27,867 - DEBUG - Vrouter 10.0.0.22 does not have vrf 2 for VN ctest-vn-25088971
2025-04-26 08:45:27,867 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-95456355:ctest-vn-25088971
2025-04-26 08:45:27,879 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-25088971 info
2025-04-26 08:45:27,959 - INFO - IPAM: ctest-ipam-14968912 is not found in API Server
2025-04-26 08:45:27,970 - INFO - IPAM:ctest-ipam-14968912 is not found in control node
2025-04-26 08:45:28,225 - DEBUG - No XMPP flaps were noticed during the test
2025-04-26 08:45:28,225 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:42]
2025-04-26 08:45:28,225 - INFO - --------------------------------------------------------------------------------
2025-04-26 08:45:28,922 - INFO - Deleted project: ctest-TestBasicVMVN-95456355, ID : b98b7570-e995-4d84-adba-c9782d95355e