is in ACTIVE state now
2025-04-28 15:39:44,915 - INFO - VM name : ctest-TestBasicVMVN-31003758-26621690
2025-04-28 15:39:44,987 - DEBUG - VM ctest-TestBasicVMVN-31003758-26621690 ID is b7ab60be-f728-44dc-80e8-583cba708040
2025-04-28 15:39:44,987 - DEBUG - VM ctest-TestBasicVMVN-31003758-26621690 launched on Node cn-jenkins-deploy-platform-ansible-os-3239-1
2025-04-28 15:39:45,069 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine/b7ab60be-f728-44dc-80e8-583cba708040
2025-04-28 15:39:45,077 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine-interface/6e0e75e1-210e-4169-abff-4a0983c44b34
2025-04-28 15:39:46,230 - 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=3.07 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.387 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.387/1.730/3.074/1.343 ms')
2025-04-28 15:39:46,230 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-31003758-26621690 passed
2025-04-28 15:39:46,294 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-28 15:39:46,294 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-31003758-26621690, IP 31.1.1.3, Port 22
2025-04-28 15:39:46,373 - DEBUG - VM ctest-TestBasicVMVN-31003758-26621690 is ready for SSH connections
2025-04-28 15:39:46,374 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-28 15:39:46,374 - 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.242, gateway password: c0ntrail123
2025-04-28 15:39:46,374 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4
2025-04-28 15:39:50,362 - 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.413 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=0.893 ms
64 bytes from 31.1.2.4: seq=2 ttl=63 time=1.026 ms
--- 31.1.2.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.893/2.110/4.413 ms
2025-04-28 15:39:50,362 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-31003758-46495545 passed
2025-04-28 15:39:50,362 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-28 15:39:50,362 - 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.242, gateway password: c0ntrail123
2025-04-28 15:39:50,362 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4
2025-04-28 15:39:54,401 - 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.293 ms
64 bytes from 31.1.1.4: seq=1 ttl=63 time=0.883 ms
64 bytes from 31.1.1.4: seq=2 ttl=63 time=0.831 ms
--- 31.1.1.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.831/1.669/3.293 ms
2025-04-28 15:39:54,402 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-31003758-89069369 passed
2025-04-28 15:39:54,402 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-28 15:39:54,402 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-28 15:39:54,402 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-28 15:39:54,402 - 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.242, gateway password: c0ntrail123
2025-04-28 15:39:54,402 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-28 15:39:54,557 - DEBUG - None
2025-04-28 15:39:54,557 - 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.242, gateway password: c0ntrail123
2025-04-28 15:39:54,557 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-28 15:39:54,711 - DEBUG - None
2025-04-28 15:39:54,711 - 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.242, gateway password: c0ntrail123
2025-04-28 15:39:54,711 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-28 15:39:55,682 - DEBUG - None
2025-04-28 15:39:55,682 - 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.242, gateway password: c0ntrail123
2025-04-28 15:39:55,682 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7
2025-04-28 15:39:57,904 - 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.089 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=6.738 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.418 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.709 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.512 ms
--- 31.1.1.7 ping statistics ---
3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss
round-trip min/avg/max = 0.418/2.293/6.738 ms
2025-04-28 15:39:57,904 - 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.242, gateway password: c0ntrail123
2025-04-28 15:39:57,904 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1
2025-04-28 15:40:00,080 - 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.037 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=3.222 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=4.325 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.438 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.839 ms (DUP!)
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.626 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.503 ms
--- 224.0.0.1 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.438/1.998/4.325 ms
2025-04-28 15:40:00,080 - 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.242, gateway password: c0ntrail123
2025-04-28 15:40:00,080 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255
2025-04-28 15:40:02,294 - 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.737 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=4.304 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=5.261 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.438 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.793 ms (DUP!)
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.789 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.366 ms
--- 255.255.255.255 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.366/2.241/5.261 ms
2025-04-28 15:40:02,294 - INFO - Deleting VM ctest-TestBasicVMVN-31003758-26621690
2025-04-28 15:40:02,362 - INFO - Detaching port 84c38ec7-05bc-4a16-ab5c-3157dd6c2605 from VM ctest-TestBasicVMVN-31003758-89069369
2025-04-28 15:40:02,414 - INFO - Deleting VM ctest-TestBasicVMVN-31003758-89069369
2025-04-28 15:40:02,479 - INFO - Detaching port e351627c-1a8c-405c-b899-c7c241d54d5e from VM ctest-TestBasicVMVN-31003758-46495545
2025-04-28 15:40:02,510 - INFO - Deleting VM ctest-TestBasicVMVN-31003758-46495545
2025-04-28 15:40:02,590 - INFO - Deleting VN ctest-vn-80426290
2025-04-28 15:40:02,808 - DEBUG - Response for delete_port : ()
2025-04-28 15:40:03,000 - DEBUG - Response for delete_port : ()
2025-04-28 15:40:03,055 - DEBUG - VN c2358f9d-cd0a-45c1-891a-3abc42dce1ae still in use: Unable to complete operation on network c2358f9d-cd0a-45c1-891a-3abc42dce1ae. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-8d816c32-f4b4-4184-9d27-d8bc3c400512']
2025-04-28 15:40:03,056 - WARNING - Deleting VN ctest-vn-80426290 failed..Will retry
2025-04-28 15:40:05,184 - DEBUG - Response for deleting network ()
2025-04-28 15:40:05,184 - DEBUG - Requesting: http://10.0.0.242:8082/routing-instance/29bc2367-bea9-49b0-a489-6157c38b8724
2025-04-28 15:40:05,189 - DEBUG - Response Code: 404
2025-04-28 15:40:05,189 - DEBUG - Requesting: http://10.0.0.242:8082/domains
2025-04-28 15:40:05,195 - DEBUG - Requesting: http://10.0.0.242:8082/domain/9e2bcec0-0ae6-4df0-a99f-45c06c7cdccf
2025-04-28 15:40:05,248 - DEBUG - Requesting: http://10.0.0.242:8082/project/8532331a-3f1b-4385-95d9-e1316119efdb
2025-04-28 15:40:05,280 - INFO - Validated that VN ctest-vn-80426290 is not found in API Server
2025-04-28 15:40:05,292 - DEBUG - VN ctest-vn-80426290 is not present in Agent 10.0.0.242
2025-04-28 15:40:05,292 - INFO - Validated that VN ctest-vn-80426290 is not in any agent
2025-04-28 15:40:05,298 - DEBUG - VRF 2 is not seen in agent 10.0.0.242
2025-04-28 15:40:05,304 - DEBUG - Vrouter 10.0.0.242 does not have vrf 2 for VN ctest-vn-80426290
2025-04-28 15:40:05,304 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-31003758:ctest-vn-80426290
2025-04-28 15:40:05,315 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-80426290 info
2025-04-28 15:40:05,349 - INFO - IPAM: ctest-ipam-00068153 is not found in API Server
2025-04-28 15:40:05,362 - INFO - IPAM:ctest-ipam-00068153 is not found in control node
2025-04-28 15:40:05,448 - DEBUG - No XMPP flaps were noticed during the test
2025-04-28 15:40:05,448 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:37]
2025-04-28 15:40:05,449 - INFO - --------------------------------------------------------------------------------
2025-04-28 15:40:06,082 - INFO - Deleted project: ctest-TestBasicVMVN-31003758, ID : 8532331a-3f1b-4385-95d9-e1316119efdb