is in ACTIVE state now
2025-04-09 07:49:08,962 - INFO - VM name : ctest-TestBasicVMVN-35329451-46851709
2025-04-09 07:49:09,066 - DEBUG - VM ctest-TestBasicVMVN-35329451-46851709 ID is be213fab-85a9-4eac-9c13-371a8b53ec5a
2025-04-09 07:49:09,066 - DEBUG - VM ctest-TestBasicVMVN-35329451-46851709 launched on Node cn-jenkins-deploy-platform-ansible-os-3060-1
2025-04-09 07:49:09,170 - DEBUG - Requesting: http://10.0.0.52:8082/virtual-machine/be213fab-85a9-4eac-9c13-371a8b53ec5a
2025-04-09 07:49:09,179 - DEBUG - Requesting: http://10.0.0.52:8082/virtual-machine-interface/a005cab3-fbac-45bc-b750-1b984a62a3f2
2025-04-09 07:49:10,436 - 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=4.07 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.528 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.528/2.298/4.068/1.770 ms')
2025-04-09 07:49:10,436 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-35329451-46851709 passed
2025-04-09 07:49:10,596 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 07:49:10,597 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-35329451-46851709, IP 31.1.1.3, Port 22
2025-04-09 07:49:10,756 - DEBUG - VM ctest-TestBasicVMVN-35329451-46851709 is ready for SSH connections
2025-04-09 07:49:10,756 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 07:49:10,756 - 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.52, gateway password: c0ntrail123
2025-04-09 07:49:10,756 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4
2025-04-09 07:49:14,463 - 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.522 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=1.113 ms
64 bytes from 31.1.2.4: seq=2 ttl=63 time=1.048 ms
--- 31.1.2.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.048/2.227/4.522 ms
2025-04-09 07:49:14,463 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-35329451-32665698 passed
2025-04-09 07:49:14,464 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 07:49:14,464 - 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.52, gateway password: c0ntrail123
2025-04-09 07:49:14,464 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4
2025-04-09 07:49:18,147 - 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.035 ms
64 bytes from 31.1.1.4: seq=1 ttl=63 time=1.209 ms
64 bytes from 31.1.1.4: seq=2 ttl=63 time=1.251 ms
--- 31.1.1.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.209/1.831/3.035 ms
2025-04-09 07:49:18,147 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-35329451-52475357 passed
2025-04-09 07:49:18,147 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 07:49:18,148 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 07:49:18,148 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 07:49:18,148 - 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.52, gateway password: c0ntrail123
2025-04-09 07:49:18,148 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-09 07:49:18,354 - DEBUG - None
2025-04-09 07:49:18,354 - 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.52, gateway password: c0ntrail123
2025-04-09 07:49:18,354 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-09 07:49:18,549 - DEBUG - None
2025-04-09 07:49:18,549 - 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.52, gateway password: c0ntrail123
2025-04-09 07:49:18,549 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-09 07:49:19,177 - DEBUG - None
2025-04-09 07:49:19,178 - 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.52, gateway password: c0ntrail123
2025-04-09 07:49:19,178 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7
2025-04-09 07:49:21,386 - 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.009 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=6.565 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.452 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.026 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.385 ms
--- 31.1.1.7 ping statistics ---
3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss
round-trip min/avg/max = 0.385/2.287/6.565 ms
2025-04-09 07:49:21,386 - 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.52, gateway password: c0ntrail123
2025-04-09 07:49:21,386 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1
2025-04-09 07:49:23,636 - 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.988 ms
64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.714 ms (DUP!)
64 bytes from 31.1.1.3: seq=0 ttl=64 time=4.818 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.412 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=1.852 ms (DUP!)
64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.579 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.363 ms
--- 224.0.0.1 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.363/2.103/4.818 ms
2025-04-09 07:49:23,637 - 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.52, gateway password: c0ntrail123
2025-04-09 07:49:23,637 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255
2025-04-09 07:49:25,884 - 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.796 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.699 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.541 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.396 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.028 ms (DUP!)
64 bytes from 31.1.1.3: seq=1 ttl=64 time=3.126 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.429 ms
--- 255.255.255.255 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.396/1.859/3.541 ms
2025-04-09 07:49:25,885 - INFO - Deleting VM ctest-TestBasicVMVN-35329451-46851709
2025-04-09 07:49:25,955 - INFO - Detaching port 89bffb59-7d42-44f9-94f3-946055c48f5a from VM ctest-TestBasicVMVN-35329451-52475357
2025-04-09 07:49:26,002 - INFO - Deleting VM ctest-TestBasicVMVN-35329451-52475357
2025-04-09 07:49:26,073 - INFO - Detaching port 13f928a4-1244-4e3a-91ba-ea5aa5703972 from VM ctest-TestBasicVMVN-35329451-32665698
2025-04-09 07:49:26,106 - INFO - Deleting VM ctest-TestBasicVMVN-35329451-32665698
2025-04-09 07:49:26,196 - INFO - Deleting VN ctest-vn-42501769
2025-04-09 07:49:26,351 - DEBUG - Response for delete_port : ()
2025-04-09 07:49:26,541 - DEBUG - Response for delete_port : ()
2025-04-09 07:49:26,584 - DEBUG - VN d87548fd-7354-4e1f-8e2b-3b938b5ab507 still in use: Unable to complete operation on network d87548fd-7354-4e1f-8e2b-3b938b5ab507. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-23320a29-3151-476f-a6a0-86f775da7b8a']
2025-04-09 07:49:26,584 - WARNING - Deleting VN ctest-vn-42501769 failed..Will retry
2025-04-09 07:49:28,742 - DEBUG - Response for deleting network ()
2025-04-09 07:49:28,742 - DEBUG - Requesting: http://10.0.0.52:8082/routing-instance/358098ee-8e32-4177-8ebf-e098f95dde6e
2025-04-09 07:49:28,749 - DEBUG - Response Code: 404
2025-04-09 07:49:28,749 - DEBUG - Requesting: http://10.0.0.52:8082/domains
2025-04-09 07:49:28,754 - DEBUG - Requesting: http://10.0.0.52:8082/domain/4aed1765-ad63-4c49-b45e-d6877c8c66a9
2025-04-09 07:49:28,805 - DEBUG - Requesting: http://10.0.0.52:8082/project/302eaa76-e973-4ac2-a8bd-5e99ab6f8e5b
2025-04-09 07:49:28,893 - INFO - Validated that VN ctest-vn-42501769 is not found in API Server
2025-04-09 07:49:28,906 - DEBUG - VN ctest-vn-42501769 is not present in Agent 10.0.0.52
2025-04-09 07:49:28,906 - INFO - Validated that VN ctest-vn-42501769 is not in any agent
2025-04-09 07:49:28,912 - DEBUG - VRF 2 is not seen in agent 10.0.0.52
2025-04-09 07:49:28,920 - DEBUG - Vrouter 10.0.0.52 does not have vrf 2 for VN ctest-vn-42501769
2025-04-09 07:49:28,920 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-35329451:ctest-vn-42501769
2025-04-09 07:49:28,932 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-42501769 info
2025-04-09 07:49:29,012 - INFO - IPAM: ctest-ipam-32086136 is not found in API Server
2025-04-09 07:49:29,025 - INFO - IPAM:ctest-ipam-32086136 is not found in control node
2025-04-09 07:49:29,290 - DEBUG - No XMPP flaps were noticed during the test
2025-04-09 07:49:29,290 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:38]
2025-04-09 07:49:29,290 - INFO - --------------------------------------------------------------------------------
2025-04-09 07:49:30,013 - INFO - Deleted project: ctest-TestBasicVMVN-35329451, ID : 302eaa76-e973-4ac2-a8bd-5e99ab6f8e5b