is in ACTIVE state now
2025-04-23 07:57:08,561 - INFO - VM name : ctest-TestBasicVMVN-75240829-93368361
2025-04-23 07:57:08,624 - DEBUG - VM ctest-TestBasicVMVN-75240829-93368361 ID is 5fd4b71e-6f5f-47a6-a4a3-31d691ccc4e1
2025-04-23 07:57:08,624 - DEBUG - VM ctest-TestBasicVMVN-75240829-93368361 launched on Node cn-jenkins-deploy-platform-ansible-os-3177-1
2025-04-23 07:57:08,689 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-machine/5fd4b71e-6f5f-47a6-a4a3-31d691ccc4e1
2025-04-23 07:57:08,696 - DEBUG - Requesting: http://10.0.0.56:8082/virtual-machine-interface/64d8542d-4e4a-45c2-a3cd-3a81352563e1
2025-04-23 07:57:09,934 - 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.91 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.422 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.422/1.665/2.909/1.243 ms')
2025-04-23 07:57:09,934 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-75240829-93368361 passed
2025-04-23 07:57:10,084 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-23 07:57:10,084 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-75240829-93368361, IP 31.1.1.3, Port 22
2025-04-23 07:57:10,243 - DEBUG - VM ctest-TestBasicVMVN-75240829-93368361 is ready for SSH connections
2025-04-23 07:57:10,243 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-23 07:57:10,243 - 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.56, gateway password: c0ntrail123
2025-04-23 07:57:10,243 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4
2025-04-23 07:57:14,195 - 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.887 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=0.749 ms
64 bytes from 31.1.2.4: seq=2 ttl=63 time=0.828 ms
--- 31.1.2.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.749/2.154/4.887 ms
2025-04-23 07:57:14,195 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-75240829-96431155 passed
2025-04-23 07:57:14,195 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-23 07:57:14,195 - 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.56, gateway password: c0ntrail123
2025-04-23 07:57:14,195 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4
2025-04-23 07:57:17,821 - 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.699 ms
64 bytes from 31.1.1.4: seq=1 ttl=63 time=0.741 ms
64 bytes from 31.1.1.4: seq=2 ttl=63 time=0.774 ms
--- 31.1.1.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.741/1.404/2.699 ms
2025-04-23 07:57:17,821 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-75240829-46370209 passed
2025-04-23 07:57:17,821 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-23 07:57:17,821 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-23 07:57:17,821 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-23 07:57:17,821 - 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.56, gateway password: c0ntrail123
2025-04-23 07:57:17,821 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-23 07:57:17,993 - DEBUG - None
2025-04-23 07:57:17,994 - 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.56, gateway password: c0ntrail123
2025-04-23 07:57:17,994 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-23 07:57:18,166 - DEBUG - None
2025-04-23 07:57:18,166 - 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.56, gateway password: c0ntrail123
2025-04-23 07:57:18,166 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-23 07:57:18,785 - DEBUG - None
2025-04-23 07:57:18,785 - 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.56, gateway password: c0ntrail123
2025-04-23 07:57:18,785 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7
2025-04-23 07:57:20,982 - 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.847 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=4.649 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.354 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.453 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.349 ms
--- 31.1.1.7 ping statistics ---
3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss
round-trip min/avg/max = 0.349/1.730/4.649 ms
2025-04-23 07:57:20,982 - 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.56, gateway password: c0ntrail123
2025-04-23 07:57:20,982 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1
2025-04-23 07:57:23,209 - 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.954 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.658 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.728 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.359 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.501 ms (DUP!)
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.391 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.419 ms
--- 224.0.0.1 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.359/1.715/3.728 ms
2025-04-23 07:57:23,209 - 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.56, gateway password: c0ntrail123
2025-04-23 07:57:23,209 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255
2025-04-23 07:57:25,429 - 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.606 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.313 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.057 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.615 ms (DUP!)
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.414 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.402 ms
--- 255.255.255.255 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.402/1.546/3.057 ms
2025-04-23 07:57:25,429 - INFO - Deleting VM ctest-TestBasicVMVN-75240829-93368361
2025-04-23 07:57:25,489 - INFO - Detaching port e9a50f05-6d6d-4b98-a0cc-2773fffe3e37 from VM ctest-TestBasicVMVN-75240829-46370209
2025-04-23 07:57:25,530 - INFO - Deleting VM ctest-TestBasicVMVN-75240829-46370209
2025-04-23 07:57:25,585 - INFO - Detaching port 1261ca24-25f7-4ed1-bf5a-3776015c26e7 from VM ctest-TestBasicVMVN-75240829-96431155
2025-04-23 07:57:25,613 - INFO - Deleting VM ctest-TestBasicVMVN-75240829-96431155
2025-04-23 07:57:25,671 - INFO - Deleting VN ctest-vn-30340016
2025-04-23 07:57:25,825 - DEBUG - Response for delete_port : ()
2025-04-23 07:57:25,957 - DEBUG - Response for delete_port : ()
2025-04-23 07:57:26,018 - DEBUG - VN 61641684-14f6-4653-9255-21211d86d5f7 still in use: Unable to complete operation on network 61641684-14f6-4653-9255-21211d86d5f7. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-c07e4532-367e-439c-a419-de35ce0d333f']
2025-04-23 07:57:26,018 - WARNING - Deleting VN ctest-vn-30340016 failed..Will retry
2025-04-23 07:57:28,152 - DEBUG - Response for deleting network ()
2025-04-23 07:57:28,152 - DEBUG - Requesting: http://10.0.0.56:8082/routing-instance/cbfcc3bb-48db-4484-8ea2-79a55e5f39a6
2025-04-23 07:57:28,164 - DEBUG - Response Code: 404
2025-04-23 07:57:28,164 - DEBUG - Requesting: http://10.0.0.56:8082/domains
2025-04-23 07:57:28,169 - DEBUG - Requesting: http://10.0.0.56:8082/domain/4dec2203-7d3e-496b-ad65-3c0c3790f4c7
2025-04-23 07:57:28,227 - DEBUG - Requesting: http://10.0.0.56:8082/project/369c6811-0d97-4141-bb9b-5da536b3fd2e
2025-04-23 07:57:28,301 - INFO - Validated that VN ctest-vn-30340016 is not found in API Server
2025-04-23 07:57:28,314 - DEBUG - VN ctest-vn-30340016 is not present in Agent 10.0.0.56
2025-04-23 07:57:28,314 - INFO - Validated that VN ctest-vn-30340016 is not in any agent
2025-04-23 07:57:28,319 - DEBUG - VRF 2 is not seen in agent 10.0.0.56
2025-04-23 07:57:28,324 - DEBUG - Vrouter 10.0.0.56 does not have vrf 2 for VN ctest-vn-30340016
2025-04-23 07:57:28,324 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-75240829:ctest-vn-30340016
2025-04-23 07:57:28,335 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-30340016 info
2025-04-23 07:57:28,419 - INFO - IPAM: ctest-ipam-06833923 is not found in API Server
2025-04-23 07:57:28,430 - INFO - IPAM:ctest-ipam-06833923 is not found in control node
2025-04-23 07:57:28,695 - DEBUG - No XMPP flaps were noticed during the test
2025-04-23 07:57:28,695 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:36]
2025-04-23 07:57:28,695 - INFO - --------------------------------------------------------------------------------
2025-04-23 07:57:29,389 - INFO - Deleted project: ctest-TestBasicVMVN-75240829, ID : 369c6811-0d97-4141-bb9b-5da536b3fd2e