is in ACTIVE state now
2025-04-07 09:43:21,186 - INFO - VM name : ctest-TestBasicVMVN-19210390-05817292
2025-04-07 09:43:21,270 - DEBUG - VM ctest-TestBasicVMVN-19210390-05817292 ID is a710b3d1-4804-4f4b-a680-6211dd7a19f5
2025-04-07 09:43:21,271 - DEBUG - VM ctest-TestBasicVMVN-19210390-05817292 launched on Node cn-jenkins-deploy-platform-ansible-os-3045-1
2025-04-07 09:43:21,356 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-machine/a710b3d1-4804-4f4b-a680-6211dd7a19f5
2025-04-07 09:43:21,365 - DEBUG - Requesting: http://10.0.0.24:8082/virtual-machine-interface/96836d32-75fc-4320-b11a-c78e20d805fa
2025-04-07 09:43:22,620 - 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=3.01 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.496 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.496/1.753/3.010/1.257 ms')
2025-04-07 09:43:22,620 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-19210390-05817292 passed
2025-04-07 09:43:22,774 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-07 09:43:22,774 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-19210390-05817292, IP 31.1.1.3, Port 22
2025-04-07 09:43:22,930 - DEBUG - VM ctest-TestBasicVMVN-19210390-05817292 is ready for SSH connections
2025-04-07 09:43:22,930 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-07 09:43:22,930 - 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.24, gateway password: c0ntrail123
2025-04-07 09:43:22,930 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4
2025-04-07 09:43:26,998 - 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=4.226 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=1.035 ms
64 bytes from 31.1.2.4: seq=2 ttl=63 time=1.325 ms
--- 31.1.2.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.035/2.195/4.226 ms
2025-04-07 09:43:26,998 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-19210390-09677816 passed
2025-04-07 09:43:26,998 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-07 09:43:26,998 - 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.24, gateway password: c0ntrail123
2025-04-07 09:43:26,998 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4
2025-04-07 09:43:30,713 - 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=3.361 ms
64 bytes from 31.1.1.4: seq=1 ttl=63 time=1.092 ms
64 bytes from 31.1.1.4: seq=2 ttl=63 time=1.003 ms
--- 31.1.1.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.003/1.818/3.361 ms
2025-04-07 09:43:30,713 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-19210390-32527251 passed
2025-04-07 09:43:30,713 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-07 09:43:30,714 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-07 09:43:30,714 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-07 09:43:30,714 - 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.24, gateway password: c0ntrail123
2025-04-07 09:43:30,714 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-07 09:43:30,904 - DEBUG - None
2025-04-07 09:43:30,904 - 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.24, gateway password: c0ntrail123
2025-04-07 09:43:30,904 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-07 09:43:31,080 - DEBUG - None
2025-04-07 09:43:31,080 - 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.24, gateway password: c0ntrail123
2025-04-07 09:43:31,080 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-07 09:43:31,729 - DEBUG - None
2025-04-07 09:43:31,730 - 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.24, gateway password: c0ntrail123
2025-04-07 09:43:31,730 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7
2025-04-07 09:43:33,939 - 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.952 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=6.698 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.440 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.309 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.383 ms
--- 31.1.1.7 ping statistics ---
3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss
round-trip min/avg/max = 0.383/2.356/6.698 ms
2025-04-07 09:43:33,939 - 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.24, gateway password: c0ntrail123
2025-04-07 09:43:33,940 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1
2025-04-07 09:43:36,197 - 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=1.027 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=3.005 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=4.141 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.455 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.177 ms (DUP!)
64 bytes from 31.1.1.3: seq=1 ttl=64 time=3.099 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.427 ms
--- 224.0.0.1 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.427/2.047/4.141 ms
2025-04-07 09:43:36,197 - 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.24, gateway password: c0ntrail123
2025-04-07 09:43:36,197 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255
2025-04-07 09:43:38,452 - 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=1.042 ms
64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.134 ms (DUP!)
64 bytes from 31.1.1.3: seq=0 ttl=64 time=3.986 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.440 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.243 ms (DUP!)
64 bytes from 31.1.1.3: seq=1 ttl=64 time=3.117 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.397 ms
--- 255.255.255.255 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.397/2.051/3.986 ms
2025-04-07 09:43:38,452 - INFO - Deleting VM ctest-TestBasicVMVN-19210390-05817292
2025-04-07 09:43:38,521 - INFO - Detaching port cf541e17-c671-4b86-81c2-a55472c4cb19 from VM ctest-TestBasicVMVN-19210390-32527251
2025-04-07 09:43:38,570 - INFO - Deleting VM ctest-TestBasicVMVN-19210390-32527251
2025-04-07 09:43:38,639 - INFO - Detaching port e38b2f2a-a749-4726-908c-85b0118cb7b6 from VM ctest-TestBasicVMVN-19210390-09677816
2025-04-07 09:43:38,669 - INFO - Deleting VM ctest-TestBasicVMVN-19210390-09677816
2025-04-07 09:43:38,751 - INFO - Deleting VN ctest-vn-40308985
2025-04-07 09:43:38,920 - DEBUG - Response for delete_port : ()
2025-04-07 09:43:39,132 - DEBUG - Response for delete_port : ()
2025-04-07 09:43:39,183 - DEBUG - VN 9cbb8ed3-49fe-46fa-8170-f49418422214 still in use: Unable to complete operation on network 9cbb8ed3-49fe-46fa-8170-f49418422214. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-84528967-2723-4075-9a1f-56179d892e9f']
2025-04-07 09:43:39,184 - WARNING - Deleting VN ctest-vn-40308985 failed..Will retry
2025-04-07 09:43:41,348 - DEBUG - Response for deleting network ()
2025-04-07 09:43:41,348 - DEBUG - Requesting: http://10.0.0.24:8082/routing-instance/325b4606-6526-4850-88f2-4b1dbeedb30b
2025-04-07 09:43:41,355 - DEBUG - Response Code: 404
2025-04-07 09:43:41,355 - DEBUG - Requesting: http://10.0.0.24:8082/domains
2025-04-07 09:43:41,361 - DEBUG - Requesting: http://10.0.0.24:8082/domain/0a5b2712-129a-482e-9c0c-7b2b56783eec
2025-04-07 09:43:41,416 - DEBUG - Requesting: http://10.0.0.24:8082/project/0ea06f89-c139-476e-b63e-39dac7f2cf09
2025-04-07 09:43:41,500 - INFO - Validated that VN ctest-vn-40308985 is not found in API Server
2025-04-07 09:43:41,513 - DEBUG - VN ctest-vn-40308985 is not present in Agent 10.0.0.24
2025-04-07 09:43:41,513 - INFO - Validated that VN ctest-vn-40308985 is not in any agent
2025-04-07 09:43:41,519 - DEBUG - VRF 2 is not seen in agent 10.0.0.24
2025-04-07 09:43:41,525 - DEBUG - Vrouter 10.0.0.24 does not have vrf 2 for VN ctest-vn-40308985
2025-04-07 09:43:41,525 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-19210390:ctest-vn-40308985
2025-04-07 09:43:41,539 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-40308985 info
2025-04-07 09:43:41,622 - INFO - IPAM: ctest-ipam-67270150 is not found in API Server
2025-04-07 09:43:41,633 - INFO - IPAM:ctest-ipam-67270150 is not found in control node
2025-04-07 09:43:41,902 - DEBUG - No XMPP flaps were noticed during the test
2025-04-07 09:43:41,902 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:39]
2025-04-07 09:43:41,902 - INFO - --------------------------------------------------------------------------------
2025-04-07 09:43:42,646 - INFO - Deleted project: ctest-TestBasicVMVN-19210390, ID : 0ea06f89-c139-476e-b63e-39dac7f2cf09