is in ACTIVE state now
2025-05-06 07:19:36,496 - INFO - VM name : ctest-TestBasicVMVN-99424246-36995856
2025-05-06 07:19:36,571 - DEBUG - VM ctest-TestBasicVMVN-99424246-36995856 ID is 6d58b6a5-3c8a-474e-9d86-68dbeadc44cc
2025-05-06 07:19:36,572 - DEBUG - VM ctest-TestBasicVMVN-99424246-36995856 launched on Node cn-jenkins-deploy-platform-ansible-os-3274-1
2025-05-06 07:19:36,647 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/6d58b6a5-3c8a-474e-9d86-68dbeadc44cc
2025-05-06 07:19:36,658 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/ef021954-d99c-42cb-be28-d26cbfc37e0d
2025-05-06 07:19:37,896 - 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.53 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.406 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.406/1.966/3.526/1.560 ms')
2025-05-06 07:19:37,897 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-99424246-36995856 passed
2025-05-06 07:19:38,051 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-05-06 07:19:38,052 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-99424246-36995856, IP 31.1.1.3, Port 22
2025-05-06 07:19:38,211 - DEBUG - VM ctest-TestBasicVMVN-99424246-36995856 is ready for SSH connections
2025-05-06 07:19:38,211 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-05-06 07:19:38,211 - 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-05-06 07:19:38,211 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4
2025-05-06 07:19:42,197 - 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.921 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=0.926 ms
64 bytes from 31.1.2.4: seq=2 ttl=63 time=0.936 ms
--- 31.1.2.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.926/1.927/3.921 ms
2025-05-06 07:19:42,197 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-99424246-48930988 passed
2025-05-06 07:19:42,197 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-05-06 07:19:42,197 - 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-05-06 07:19:42,197 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4
2025-05-06 07:19:45,840 - 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.893 ms
64 bytes from 31.1.1.4: seq=1 ttl=63 time=1.061 ms
64 bytes from 31.1.1.4: seq=2 ttl=63 time=0.815 ms
--- 31.1.1.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.815/1.589/2.893 ms
2025-05-06 07:19:45,840 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-99424246-12246002 passed
2025-05-06 07:19:45,841 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-05-06 07:19:45,841 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-05-06 07:19:45,841 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-05-06 07:19:45,841 - 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-05-06 07:19:45,841 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-05-06 07:19:46,026 - DEBUG - None
2025-05-06 07:19:46,027 - 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-05-06 07:19:46,027 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-05-06 07:19:46,225 - DEBUG - None
2025-05-06 07:19:46,225 - 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-05-06 07:19:46,225 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-05-06 07:19:46,855 - DEBUG - None
2025-05-06 07:19:46,855 - 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-05-06 07:19:46,855 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7
2025-05-06 07:19:49,109 - 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.980 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=4.251 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.407 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.974 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.439 ms
--- 31.1.1.7 ping statistics ---
3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss
round-trip min/avg/max = 0.407/1.810/4.251 ms
2025-05-06 07:19:49,109 - 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-05-06 07:19:49,109 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1
2025-05-06 07:19:51,370 - 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.965 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.972 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=4.135 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.380 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=1.613 ms (DUP!)
64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.354 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.676 ms
--- 224.0.0.1 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.380/1.870/4.135 ms
2025-05-06 07:19:51,371 - 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-05-06 07:19:51,371 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255
2025-05-06 07:19:53,608 - 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.774 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.931 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.691 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.429 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.694 ms (DUP!)
64 bytes from 31.1.1.3: seq=1 ttl=64 time=3.569 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.332 ms
--- 255.255.255.255 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.332/2.060/3.691 ms
2025-05-06 07:19:53,609 - INFO - Deleting VM ctest-TestBasicVMVN-99424246-36995856
2025-05-06 07:19:53,679 - INFO - Detaching port 302848e5-bbff-4dd1-8533-cfe767d0cc35 from VM ctest-TestBasicVMVN-99424246-12246002
2025-05-06 07:19:53,735 - INFO - Deleting VM ctest-TestBasicVMVN-99424246-12246002
2025-05-06 07:19:53,811 - INFO - Detaching port fb96c7bd-40e4-47c4-9053-018604fb18ae from VM ctest-TestBasicVMVN-99424246-48930988
2025-05-06 07:19:53,853 - INFO - Deleting VM ctest-TestBasicVMVN-99424246-48930988
2025-05-06 07:19:53,930 - INFO - Deleting VN ctest-vn-53016084
2025-05-06 07:19:54,149 - DEBUG - Response for delete_port : ()
2025-05-06 07:19:54,347 - DEBUG - Response for delete_port : ()
2025-05-06 07:19:54,406 - DEBUG - VN 992d45e6-bf9b-48a1-8192-079c4221b7bd still in use: Unable to complete operation on network 992d45e6-bf9b-48a1-8192-079c4221b7bd. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-48988bc5-9c88-4074-96dd-1f7bb76381c1']
2025-05-06 07:19:54,406 - WARNING - Deleting VN ctest-vn-53016084 failed..Will retry
2025-05-06 07:19:56,544 - DEBUG - Response for deleting network ()
2025-05-06 07:19:56,544 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/e94f3e8c-ca92-464f-a0f0-46aaa4b3cd10
2025-05-06 07:19:56,557 - DEBUG - Response Code: 404
2025-05-06 07:19:56,557 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2025-05-06 07:19:56,564 - DEBUG - Requesting: http://10.0.0.50:8082/domain/e6916306-8f8e-4eca-b242-c7d9f2de7972
2025-05-06 07:19:56,620 - DEBUG - Requesting: http://10.0.0.50:8082/project/239d33ea-02c5-4cfc-9453-3581fb9b3de9
2025-05-06 07:19:56,723 - INFO - Validated that VN ctest-vn-53016084 is not found in API Server
2025-05-06 07:19:56,736 - DEBUG - VN ctest-vn-53016084 is not present in Agent 10.0.0.50
2025-05-06 07:19:56,736 - INFO - Validated that VN ctest-vn-53016084 is not in any agent
2025-05-06 07:19:56,752 - DEBUG - VRF 2 is not seen in agent 10.0.0.50
2025-05-06 07:19:56,762 - DEBUG - Vrouter 10.0.0.50 does not have vrf 2 for VN ctest-vn-53016084
2025-05-06 07:19:56,762 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-99424246:ctest-vn-53016084
2025-05-06 07:19:56,774 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-53016084 info
2025-05-06 07:19:56,859 - INFO - IPAM: ctest-ipam-60227176 is not found in API Server
2025-05-06 07:19:56,872 - INFO - IPAM:ctest-ipam-60227176 is not found in control node
2025-05-06 07:19:57,139 - DEBUG - No XMPP flaps were noticed during the test
2025-05-06 07:19:57,139 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:38]
2025-05-06 07:19:57,139 - INFO - --------------------------------------------------------------------------------
2025-05-06 07:19:57,911 - INFO - Deleted project: ctest-TestBasicVMVN-99424246, ID : 239d33ea-02c5-4cfc-9453-3581fb9b3de9