is in ACTIVE state now
2025-06-17 00:25:26,615 - INFO - VM name : ctest-TestBasicVMVN-43900606-86741176
2025-06-17 00:25:26,688 - DEBUG - VM ctest-TestBasicVMVN-43900606-86741176 ID is 3e6e7d8a-ce76-436d-8e58-f089ab65aff9
2025-06-17 00:25:26,688 - DEBUG - VM ctest-TestBasicVMVN-43900606-86741176 launched on Node cn-jenkins-deploy-platform-ansible-os-3458-1
2025-06-17 00:25:26,760 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-machine/3e6e7d8a-ce76-436d-8e58-f089ab65aff9
2025-06-17 00:25:26,770 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-machine-interface/f103414a-4bc2-4d0c-81eb-39497dfd4424
2025-06-17 00:25:28,012 - 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.72 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.429 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.429/1.572/2.715/1.143 ms')
2025-06-17 00:25:28,012 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-43900606-86741176 passed
2025-06-17 00:25:28,163 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-06-17 00:25:28,163 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-43900606-86741176, IP 31.1.1.3, Port 22
2025-06-17 00:25:28,318 - DEBUG - VM ctest-TestBasicVMVN-43900606-86741176 is ready for SSH connections
2025-06-17 00:25:28,318 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-06-17 00:25:28,318 - 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.57, gateway password: c0ntrail123
2025-06-17 00:25:28,319 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4
2025-06-17 00:25:32,287 - 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.495 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=0.866 ms
64 bytes from 31.1.2.4: seq=2 ttl=63 time=0.893 ms
--- 31.1.2.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.866/1.751/3.495 ms
2025-06-17 00:25:32,287 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-43900606-34620695 passed
2025-06-17 00:25:32,287 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-06-17 00:25:32,287 - 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.57, gateway password: c0ntrail123
2025-06-17 00:25:32,287 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4
2025-06-17 00:25:35,946 - 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.209 ms
64 bytes from 31.1.1.4: seq=1 ttl=63 time=0.949 ms
64 bytes from 31.1.1.4: seq=2 ttl=63 time=0.848 ms
--- 31.1.1.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.848/1.668/3.209 ms
2025-06-17 00:25:35,946 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-43900606-80480517 passed
2025-06-17 00:25:35,946 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-06-17 00:25:35,946 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-06-17 00:25:35,946 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-06-17 00:25:35,946 - 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.57, gateway password: c0ntrail123
2025-06-17 00:25:35,946 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-06-17 00:25:36,145 - DEBUG - None
2025-06-17 00:25:36,145 - 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.57, gateway password: c0ntrail123
2025-06-17 00:25:36,146 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-06-17 00:25:36,334 - DEBUG - None
2025-06-17 00:25:36,334 - 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.57, gateway password: c0ntrail123
2025-06-17 00:25:36,335 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-06-17 00:25:36,957 - DEBUG - None
2025-06-17 00:25:36,958 - 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.57, gateway password: c0ntrail123
2025-06-17 00:25:36,958 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7
2025-06-17 00:25:39,160 - 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.776 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=5.958 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.828 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.008 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.427 ms
--- 31.1.1.7 ping statistics ---
3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss
round-trip min/avg/max = 0.427/2.199/5.958 ms
2025-06-17 00:25:39,160 - 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.57, gateway password: c0ntrail123
2025-06-17 00:25:39,161 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1
2025-06-17 00:25:41,403 - 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.045 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=3.060 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=4.169 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.426 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.672 ms (DUP!)
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.536 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.348 ms
--- 224.0.0.1 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.348/1.893/4.169 ms
2025-06-17 00:25:41,404 - 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.57, gateway password: c0ntrail123
2025-06-17 00:25:41,404 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255
2025-06-17 00:25:43,641 - 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.614 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.534 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.352 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.432 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.680 ms (DUP!)
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.633 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.345 ms
--- 255.255.255.255 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.345/1.655/3.352 ms
2025-06-17 00:25:43,641 - INFO - Deleting VM ctest-TestBasicVMVN-43900606-86741176
2025-06-17 00:25:43,701 - INFO - Detaching port ceb598b0-09f1-46f0-a4df-d2ba486d0439 from VM ctest-TestBasicVMVN-43900606-80480517
2025-06-17 00:25:43,750 - INFO - Deleting VM ctest-TestBasicVMVN-43900606-80480517
2025-06-17 00:25:43,810 - INFO - Detaching port 7dba8553-d337-4686-9b28-82d8bcd23e99 from VM ctest-TestBasicVMVN-43900606-34620695
2025-06-17 00:25:43,840 - INFO - Deleting VM ctest-TestBasicVMVN-43900606-34620695
2025-06-17 00:25:43,905 - INFO - Deleting VN ctest-vn-42671411
2025-06-17 00:25:44,061 - DEBUG - Response for delete_port : ()
2025-06-17 00:25:44,224 - DEBUG - Response for delete_port : ()
2025-06-17 00:25:44,264 - DEBUG - VN c31100b5-fcb0-4c90-ba1f-8347f7c618c2 still in use: Unable to complete operation on network c31100b5-fcb0-4c90-ba1f-8347f7c618c2. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-e8b29d24-9d63-4032-9ba2-9b22959d7490']
2025-06-17 00:25:44,264 - WARNING - Deleting VN ctest-vn-42671411 failed..Will retry
2025-06-17 00:25:46,401 - DEBUG - Response for deleting network ()
2025-06-17 00:25:46,401 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/94eb1c60-39b9-4486-8f03-d4a78ae8b09f
2025-06-17 00:25:46,407 - DEBUG - Response Code: 404
2025-06-17 00:25:46,408 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2025-06-17 00:25:46,413 - DEBUG - Requesting: http://10.0.0.57:8082/domain/cbac7227-dcf7-4847-8fa1-c3ec2997a090
2025-06-17 00:25:46,472 - DEBUG - Requesting: http://10.0.0.57:8082/project/1513d693-d4be-4a60-aa16-01cb0ec83f5b
2025-06-17 00:25:46,552 - INFO - Validated that VN ctest-vn-42671411 is not found in API Server
2025-06-17 00:25:46,563 - DEBUG - VN ctest-vn-42671411 is not present in Agent 10.0.0.57
2025-06-17 00:25:46,563 - INFO - Validated that VN ctest-vn-42671411 is not in any agent
2025-06-17 00:25:46,568 - DEBUG - VRF 2 is not seen in agent 10.0.0.57
2025-06-17 00:25:46,573 - DEBUG - Vrouter 10.0.0.57 does not have vrf 2 for VN ctest-vn-42671411
2025-06-17 00:25:46,573 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-43900606:ctest-vn-42671411
2025-06-17 00:25:46,583 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-42671411 info
2025-06-17 00:25:46,663 - INFO - IPAM: ctest-ipam-28678807 is not found in API Server
2025-06-17 00:25:46,675 - INFO - IPAM:ctest-ipam-28678807 is not found in control node
2025-06-17 00:25:46,932 - DEBUG - No XMPP flaps were noticed during the test
2025-06-17 00:25:46,932 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:37]
2025-06-17 00:25:46,932 - INFO - --------------------------------------------------------------------------------
2025-06-17 00:25:47,626 - INFO - Deleted project: ctest-TestBasicVMVN-43900606, ID : 1513d693-d4be-4a60-aa16-01cb0ec83f5b