is in ACTIVE state now
2025-04-28 02:10:41,011 - INFO - VM name : ctest-TestBasicVMVN-18617834-61985194
2025-04-28 02:10:41,074 - DEBUG - VM ctest-TestBasicVMVN-18617834-61985194 ID is e6326a31-f7b6-4e43-b620-b9f325fa2881
2025-04-28 02:10:41,074 - DEBUG - VM ctest-TestBasicVMVN-18617834-61985194 launched on Node cn-jenkins-deploy-platform-ansible-os-3232-1
2025-04-28 02:10:41,144 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/e6326a31-f7b6-4e43-b620-b9f325fa2881
2025-04-28 02:10:41,153 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/5ee6d141-0f2c-4a20-a020-baf751657224
2025-04-28 02:10:42,393 - 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.49 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.414 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.414/1.453/2.493/1.039 ms')
2025-04-28 02:10:42,393 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-18617834-61985194 passed
2025-04-28 02:10:42,545 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-28 02:10:42,545 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-18617834-61985194, IP 31.1.1.3, Port 22
2025-04-28 02:10:42,696 - DEBUG - VM ctest-TestBasicVMVN-18617834-61985194 is ready for SSH connections
2025-04-28 02:10:42,697 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-28 02:10:42,697 - 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.50, gateway password: c0ntrail123
2025-04-28 02:10:42,697 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4
2025-04-28 02:10:46,631 - 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.673 ms
64 bytes from 31.1.2.4: seq=2 ttl=63 time=0.816 ms
--- 31.1.2.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.673/1.539/3.128 ms
2025-04-28 02:10:46,631 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-18617834-12695483 passed
2025-04-28 02:10:46,631 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-28 02:10:46,631 - 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.50, gateway password: c0ntrail123
2025-04-28 02:10:46,631 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4
2025-04-28 02:10:50,263 - 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.659 ms
64 bytes from 31.1.1.4: seq=1 ttl=63 time=0.715 ms
64 bytes from 31.1.1.4: seq=2 ttl=63 time=0.712 ms
--- 31.1.1.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.712/1.362/2.659 ms
2025-04-28 02:10:50,263 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-18617834-09115788 passed
2025-04-28 02:10:50,263 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-28 02:10:50,263 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-28 02:10:50,263 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-28 02:10:50,263 - 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.50, gateway password: c0ntrail123
2025-04-28 02:10:50,264 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-28 02:10:50,450 - DEBUG - None
2025-04-28 02:10:50,450 - 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.50, gateway password: c0ntrail123
2025-04-28 02:10:50,450 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-28 02:10:50,624 - DEBUG - None
2025-04-28 02:10:50,624 - 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.50, gateway password: c0ntrail123
2025-04-28 02:10:50,624 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-28 02:10:51,224 - DEBUG - None
2025-04-28 02:10:51,225 - 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.50, gateway password: c0ntrail123
2025-04-28 02:10:51,225 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7
2025-04-28 02:10:53,423 - 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.827 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=4.198 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.349 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.486 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.347 ms
--- 31.1.1.7 ping statistics ---
3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss
round-trip min/avg/max = 0.347/1.641/4.198 ms
2025-04-28 02:10:53,424 - 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.50, gateway password: c0ntrail123
2025-04-28 02:10:53,424 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1
2025-04-28 02:10:55,662 - 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.008 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=3.942 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=5.005 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.356 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.616 ms (DUP!)
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.393 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.547 ms
--- 224.0.0.1 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.356/2.123/5.005 ms
2025-04-28 02:10:55,662 - 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.50, gateway password: c0ntrail123
2025-04-28 02:10:55,662 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255
2025-04-28 02:10:57,889 - 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.729 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.433 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.174 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.365 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=1.511 ms (DUP!)
64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.206 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.387 ms
--- 255.255.255.255 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.365/1.543/3.174 ms
2025-04-28 02:10:57,890 - INFO - Deleting VM ctest-TestBasicVMVN-18617834-61985194
2025-04-28 02:10:57,948 - INFO - Detaching port 7b36b221-bf1e-4551-a670-83a071962c25 from VM ctest-TestBasicVMVN-18617834-09115788
2025-04-28 02:10:57,992 - INFO - Deleting VM ctest-TestBasicVMVN-18617834-09115788
2025-04-28 02:10:58,052 - INFO - Detaching port 56ba67ab-41f4-4aed-8186-9284d7e51528 from VM ctest-TestBasicVMVN-18617834-12695483
2025-04-28 02:10:58,082 - INFO - Deleting VM ctest-TestBasicVMVN-18617834-12695483
2025-04-28 02:10:58,166 - INFO - Deleting VN ctest-vn-54832851
2025-04-28 02:10:58,309 - DEBUG - Response for delete_port : ()
2025-04-28 02:10:58,484 - DEBUG - Response for delete_port : ()
2025-04-28 02:10:58,532 - DEBUG - VN d14d0b49-3279-4181-9018-b1a4642edf5b still in use: Unable to complete operation on network d14d0b49-3279-4181-9018-b1a4642edf5b. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-06f11ca0-5471-424a-9fa5-2fe15d2cf322']
2025-04-28 02:10:58,532 - WARNING - Deleting VN ctest-vn-54832851 failed..Will retry
2025-04-28 02:11:00,666 - DEBUG - Response for deleting network ()
2025-04-28 02:11:00,666 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/60dd9a68-5bc9-412d-b24a-37a1d60c782e
2025-04-28 02:11:00,671 - DEBUG - Response Code: 404
2025-04-28 02:11:00,671 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2025-04-28 02:11:00,676 - DEBUG - Requesting: http://10.0.0.50:8082/domain/09530269-b2df-4ef6-995f-dfbc59aefc94
2025-04-28 02:11:00,733 - DEBUG - Requesting: http://10.0.0.50:8082/project/86251532-b625-4af6-bee3-e458616f9e15
2025-04-28 02:11:00,810 - INFO - Validated that VN ctest-vn-54832851 is not found in API Server
2025-04-28 02:11:00,821 - DEBUG - VN ctest-vn-54832851 is not present in Agent 10.0.0.50
2025-04-28 02:11:00,821 - INFO - Validated that VN ctest-vn-54832851 is not in any agent
2025-04-28 02:11:00,825 - DEBUG - VRF 2 is not seen in agent 10.0.0.50
2025-04-28 02:11:00,831 - DEBUG - Vrouter 10.0.0.50 does not have vrf 2 for VN ctest-vn-54832851
2025-04-28 02:11:00,831 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-18617834:ctest-vn-54832851
2025-04-28 02:11:00,841 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-54832851 info
2025-04-28 02:11:00,921 - INFO - IPAM: ctest-ipam-18906348 is not found in API Server
2025-04-28 02:11:00,932 - INFO - IPAM:ctest-ipam-18906348 is not found in control node
2025-04-28 02:11:01,190 - DEBUG - No XMPP flaps were noticed during the test
2025-04-28 02:11:01,190 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:37]
2025-04-28 02:11:01,190 - INFO - --------------------------------------------------------------------------------
2025-04-28 02:11:01,879 - INFO - Deleted project: ctest-TestBasicVMVN-18617834, ID : 86251532-b625-4af6-bee3-e458616f9e15