is in ACTIVE state now
2025-04-09 17:00:29,011 - INFO - VM name : ctest-TestBasicVMVN-98259338-21802760
2025-04-09 17:00:29,178 - DEBUG - VM ctest-TestBasicVMVN-98259338-21802760 ID is bd3be6b1-2a18-4d9f-932d-d32af5f40750
2025-04-09 17:00:29,179 - DEBUG - VM ctest-TestBasicVMVN-98259338-21802760 launched on Node cn-jenkins-deploy-platform-ansible-os-3072-1
2025-04-09 17:00:29,371 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine/bd3be6b1-2a18-4d9f-932d-d32af5f40750
2025-04-09 17:00:29,389 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine-interface/f75e14fd-6dce-42c5-b176-f15a67cfaee9
2025-04-09 17:00:30,700 - 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=6.44 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.940 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.940/3.688/6.437/2.748 ms')
2025-04-09 17:00:30,700 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-98259338-21802760 passed
2025-04-09 17:00:30,877 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 17:00:30,877 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-98259338-21802760, IP 31.1.1.3, Port 22
2025-04-09 17:00:31,071 - DEBUG - VM ctest-TestBasicVMVN-98259338-21802760 is ready for SSH connections
2025-04-09 17:00:31,071 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 17:00:31,072 - 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.254, gateway password: c0ntrail123
2025-04-09 17:00:31,072 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4
2025-04-09 17:00:35,564 - 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=5.468 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.031 ms
64 bytes from 31.1.2.4: seq=2 ttl=63 time=1.207 ms
--- 31.1.2.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.207/2.902/5.468 ms
2025-04-09 17:00:35,565 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-98259338-62176590 passed
2025-04-09 17:00:35,565 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 17:00:35,565 - 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.254, gateway password: c0ntrail123
2025-04-09 17:00:35,565 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4
2025-04-09 17:00:39,606 - 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=4.270 ms
64 bytes from 31.1.1.4: seq=1 ttl=63 time=2.210 ms
64 bytes from 31.1.1.4: seq=2 ttl=63 time=1.993 ms
--- 31.1.1.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.993/2.824/4.270 ms
2025-04-09 17:00:39,606 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-98259338-60038443 passed
2025-04-09 17:00:39,606 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 17:00:39,607 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 17:00:39,607 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-09 17:00:39,607 - 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.254, gateway password: c0ntrail123
2025-04-09 17:00:39,607 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-09 17:00:39,932 - DEBUG - None
2025-04-09 17:00:39,933 - 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.254, gateway password: c0ntrail123
2025-04-09 17:00:39,933 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-09 17:00:40,187 - DEBUG - None
2025-04-09 17:00:40,187 - 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.254, gateway password: c0ntrail123
2025-04-09 17:00:40,188 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-09 17:00:41,108 - DEBUG - None
2025-04-09 17:00:41,108 - 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.254, gateway password: c0ntrail123
2025-04-09 17:00:41,109 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7
2025-04-09 17:00:43,399 - 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.771 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=6.836 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=1.274 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=3.503 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=1.122 ms
--- 31.1.1.7 ping statistics ---
3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss
round-trip min/avg/max = 1.122/2.901/6.836 ms
2025-04-09 17:00:43,400 - 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.254, gateway password: c0ntrail123
2025-04-09 17:00:43,400 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1
2025-04-09 17:00:45,729 - 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.154 ms
64 bytes from 31.1.2.4: seq=0 ttl=63 time=4.980 ms (DUP!)
64 bytes from 31.1.1.3: seq=0 ttl=64 time=10.844 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.601 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.818 ms (DUP!)
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.142 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=1.584 ms
--- 224.0.0.1 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.601/3.303/10.844 ms
2025-04-09 17:00:45,729 - 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.254, gateway password: c0ntrail123
2025-04-09 17:00:45,729 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255
2025-04-09 17:00:48,040 - 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.679 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.507 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=5.953 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.606 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.627 ms (DUP!)
64 bytes from 31.1.2.4: seq=1 ttl=63 time=3.886 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.584 ms
--- 255.255.255.255 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.584/2.406/5.953 ms
2025-04-09 17:00:48,040 - INFO - Deleting VM ctest-TestBasicVMVN-98259338-21802760
2025-04-09 17:00:48,132 - INFO - Detaching port a37dd777-5dd7-4725-976a-377556565b2d from VM ctest-TestBasicVMVN-98259338-60038443
2025-04-09 17:00:48,196 - INFO - Deleting VM ctest-TestBasicVMVN-98259338-60038443
2025-04-09 17:00:48,278 - INFO - Detaching port 8c54ecee-1d17-41d5-b2fb-b90faf25845c from VM ctest-TestBasicVMVN-98259338-62176590
2025-04-09 17:00:48,327 - INFO - Deleting VM ctest-TestBasicVMVN-98259338-62176590
2025-04-09 17:00:48,411 - INFO - Deleting VN ctest-vn-47241184
2025-04-09 17:00:48,646 - DEBUG - Response for delete_port : ()
2025-04-09 17:00:48,899 - DEBUG - Response for delete_port : ()
2025-04-09 17:00:48,945 - DEBUG - VN 1d16b449-3735-4fb8-bed6-84104dab64ec still in use: Unable to complete operation on network 1d16b449-3735-4fb8-bed6-84104dab64ec. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-eb40be7a-1486-4f12-85d7-542f26cfe06f']
2025-04-09 17:00:48,945 - WARNING - Deleting VN ctest-vn-47241184 failed..Will retry
2025-04-09 17:00:51,109 - DEBUG - Response for deleting network ()
2025-04-09 17:00:51,109 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/cf5a4795-2c95-4b2b-aa15-f0f91a7a7bb7
2025-04-09 17:00:51,117 - DEBUG - Response Code: 404
2025-04-09 17:00:51,117 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-04-09 17:00:51,124 - DEBUG - Requesting: http://10.0.0.254:8082/domain/95f60655-3a70-4c88-b7be-750614e898bf
2025-04-09 17:00:51,183 - DEBUG - Requesting: http://10.0.0.254:8082/project/3a68c962-12d2-4606-b077-7ac5e0823c52
2025-04-09 17:00:51,278 - INFO - Validated that VN ctest-vn-47241184 is not found in API Server
2025-04-09 17:00:51,293 - DEBUG - VN ctest-vn-47241184 is not present in Agent 10.0.0.254
2025-04-09 17:00:51,293 - INFO - Validated that VN ctest-vn-47241184 is not in any agent
2025-04-09 17:00:51,300 - DEBUG - VRF 2 is not seen in agent 10.0.0.254
2025-04-09 17:00:51,308 - DEBUG - Vrouter 10.0.0.254 does not have vrf 2 for VN ctest-vn-47241184
2025-04-09 17:00:51,309 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-98259338:ctest-vn-47241184
2025-04-09 17:00:51,325 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-47241184 info
2025-04-09 17:00:51,412 - INFO - IPAM: ctest-ipam-35036311 is not found in API Server
2025-04-09 17:00:51,426 - INFO - IPAM:ctest-ipam-35036311 is not found in control node
2025-04-09 17:00:51,689 - DEBUG - No XMPP flaps were noticed during the test
2025-04-09 17:00:51,689 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:47]
2025-04-09 17:00:51,689 - INFO - --------------------------------------------------------------------------------
2025-04-09 17:00:52,414 - INFO - Deleted project: ctest-TestBasicVMVN-98259338, ID : 3a68c962-12d2-4606-b077-7ac5e0823c52