is in ACTIVE state now
2025-05-03 09:17:24,762 - INFO - VM name : ctest-TestBasicVMVN-77596259-22266246
2025-05-03 09:17:24,837 - DEBUG - VM ctest-TestBasicVMVN-77596259-22266246 ID is 8c9f0262-cd47-432a-bee9-e2f290bf0c7b
2025-05-03 09:17:24,837 - DEBUG - VM ctest-TestBasicVMVN-77596259-22266246 launched on Node cn-jenkins-deploy-platform-ansible-os-3259-1.
2025-05-03 09:17:24,905 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-machine/8c9f0262-cd47-432a-bee9-e2f290bf0c7b
2025-05-03 09:17:24,912 - DEBUG - Requesting: http://10.0.0.57:8082/virtual-machine-interface/95023fe4-850d-4bd6-a1ec-f5fefd59d869
2025-05-03 09:17:26,148 - 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.88 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.332 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.332/1.607/2.882/1.275 ms')
2025-05-03 09:17:26,148 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-77596259-22266246 passed
2025-05-03 09:17:26,294 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-05-03 09:17:26,294 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-77596259-22266246, IP 31.1.1.3, Port 22
2025-05-03 09:17:26,449 - DEBUG - VM ctest-TestBasicVMVN-77596259-22266246 is ready for SSH connections
2025-05-03 09:17:26,449 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-05-03 09:17:26,449 - 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-05-03 09:17:26,449 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4
2025-05-03 09:17:30,414 - 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.128 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=0.747 ms
64 bytes from 31.1.2.4: seq=2 ttl=63 time=0.701 ms
--- 31.1.2.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.701/1.525/3.128 ms
2025-05-03 09:17:30,414 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-77596259-92340254 passed
2025-05-03 09:17:30,414 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-05-03 09:17:30,414 - 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-05-03 09:17:30,414 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4
2025-05-03 09:17:33,046 - 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.699 ms
64 bytes from 31.1.1.4: seq=1 ttl=63 time=0.772 ms
64 bytes from 31.1.1.4: seq=2 ttl=63 time=0.705 ms
--- 31.1.1.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.705/1.392/2.699 ms
2025-05-03 09:17:33,046 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-77596259-29577185 passed
2025-05-03 09:17:33,046 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-05-03 09:17:33,046 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-05-03 09:17:33,046 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-05-03 09:17:33,046 - 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-05-03 09:17:33,046 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-05-03 09:17:33,222 - DEBUG - None
2025-05-03 09:17:33,223 - 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-05-03 09:17:33,223 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-05-03 09:17:33,397 - DEBUG - None
2025-05-03 09:17:33,397 - 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-05-03 09:17:33,397 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-05-03 09:17:34,023 - DEBUG - None
2025-05-03 09:17:34,023 - 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-05-03 09:17:34,023 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7
2025-05-03 09:17:36,227 - 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=2.375 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=5.080 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.395 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.760 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.341 ms
--- 31.1.1.7 ping statistics ---
3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss
round-trip min/avg/max = 0.341/1.990/5.080 ms
2025-05-03 09:17:36,227 - 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-05-03 09:17:36,227 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1
2025-05-03 09:17:38,464 - 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.902 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.705 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.715 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.491 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.651 ms (DUP!)
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.385 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.713 ms
--- 224.0.0.1 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.491/1.794/3.715 ms
2025-05-03 09:17:38,464 - 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-05-03 09:17:38,464 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255
2025-05-03 09:17:40,691 - 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.643 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.958 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.742 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.418 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=1.645 ms (DUP!)
64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.426 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.343 ms
--- 255.255.255.255 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.343/1.739/3.742 ms
2025-05-03 09:17:40,691 - INFO - Deleting VM ctest-TestBasicVMVN-77596259-22266246
2025-05-03 09:17:40,752 - INFO - Detaching port bf42afac-d6bc-449a-b64e-41cd21dc6d79 from VM ctest-TestBasicVMVN-77596259-29577185
2025-05-03 09:17:40,797 - INFO - Deleting VM ctest-TestBasicVMVN-77596259-29577185
2025-05-03 09:17:40,855 - INFO - Detaching port 9dfcd5af-0b8e-4992-8b43-b62c217586f4 from VM ctest-TestBasicVMVN-77596259-92340254
2025-05-03 09:17:40,889 - INFO - Deleting VM ctest-TestBasicVMVN-77596259-92340254
2025-05-03 09:17:40,954 - INFO - Deleting VN ctest-vn-10312322
2025-05-03 09:17:41,104 - DEBUG - Response for delete_port : ()
2025-05-03 09:17:41,244 - DEBUG - Response for delete_port : ()
2025-05-03 09:17:41,280 - DEBUG - VN 0177606b-6e85-468b-8e83-765fb6081e0e still in use: Unable to complete operation on network 0177606b-6e85-468b-8e83-765fb6081e0e. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-36777b36-0103-458c-8441-926b66acf38d']
2025-05-03 09:17:41,281 - WARNING - Deleting VN ctest-vn-10312322 failed..Will retry
2025-05-03 09:17:43,425 - DEBUG - Response for deleting network ()
2025-05-03 09:17:43,425 - DEBUG - Requesting: http://10.0.0.57:8082/routing-instance/c6870a9a-b8e1-4b8c-b5dd-127ad9124f12
2025-05-03 09:17:43,433 - DEBUG - Response Code: 404
2025-05-03 09:17:43,433 - DEBUG - Requesting: http://10.0.0.57:8082/domains
2025-05-03 09:17:43,437 - DEBUG - Requesting: http://10.0.0.57:8082/domain/99060a80-482b-401e-b3fc-aebb8828ae60
2025-05-03 09:17:43,493 - DEBUG - Requesting: http://10.0.0.57:8082/project/b00e4f80-70f6-4de9-9685-7be0abc16743
2025-05-03 09:17:43,572 - INFO - Validated that VN ctest-vn-10312322 is not found in API Server
2025-05-03 09:17:43,591 - DEBUG - VN ctest-vn-10312322 is not present in Agent 10.0.0.57
2025-05-03 09:17:43,591 - INFO - Validated that VN ctest-vn-10312322 is not in any agent
2025-05-03 09:17:43,597 - DEBUG - VRF 2 is not seen in agent 10.0.0.57
2025-05-03 09:17:43,604 - DEBUG - Vrouter 10.0.0.57 does not have vrf 2 for VN ctest-vn-10312322
2025-05-03 09:17:43,604 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-77596259:ctest-vn-10312322
2025-05-03 09:17:43,612 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-10312322 info
2025-05-03 09:17:43,690 - INFO - IPAM: ctest-ipam-70955237 is not found in API Server
2025-05-03 09:17:43,700 - INFO - IPAM:ctest-ipam-70955237 is not found in control node
2025-05-03 09:17:43,958 - DEBUG - No XMPP flaps were noticed during the test
2025-05-03 09:17:43,958 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:51]
2025-05-03 09:17:43,958 - INFO - --------------------------------------------------------------------------------
2025-05-03 09:17:44,624 - INFO - Deleted project: ctest-TestBasicVMVN-77596259, ID : b00e4f80-70f6-4de9-9685-7be0abc16743