is in ACTIVE state now
2025-03-31 02:41:29,554 - INFO - VM name : ctest-TestBasicVMVN-92103856-66111740
2025-03-31 02:41:29,628 - DEBUG - VM ctest-TestBasicVMVN-92103856-66111740 ID is e7de40e9-57e7-4e7e-868e-e38410c5fea7
2025-03-31 02:41:29,629 - DEBUG - VM ctest-TestBasicVMVN-92103856-66111740 launched on Node cn-jenkins-deploy-platform-ansible-os-3014-1
2025-03-31 02:41:29,699 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/e7de40e9-57e7-4e7e-868e-e38410c5fea7
2025-03-31 02:41:29,707 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/d5268c8c-23ec-4925-8032-97cd5c82ac08
2025-03-31 02:41:30,944 - 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.03 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.402 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.402/2.215/4.029/1.813 ms')
2025-03-31 02:41:30,944 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-92103856-66111740 passed
2025-03-31 02:41:31,094 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-03-31 02:41:31,094 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-92103856-66111740, IP 31.1.1.3, Port 22
2025-03-31 02:41:31,249 - DEBUG - VM ctest-TestBasicVMVN-92103856-66111740 is ready for SSH connections
2025-03-31 02:41:31,249 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-03-31 02:41:31,249 - 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.22, gateway password: c0ntrail123
2025-03-31 02:41:31,249 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4
2025-03-31 02:41:35,203 - 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.220 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=0.756 ms
64 bytes from 31.1.2.4: seq=2 ttl=63 time=1.223 ms
--- 31.1.2.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.756/1.733/3.220 ms
2025-03-31 02:41:35,203 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-92103856-76600119 passed
2025-03-31 02:41:35,203 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-03-31 02:41:35,203 - 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.22, gateway password: c0ntrail123
2025-03-31 02:41:35,203 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4
2025-03-31 02:41:38,828 - 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.957 ms
64 bytes from 31.1.1.4: seq=1 ttl=63 time=0.841 ms
64 bytes from 31.1.1.4: seq=2 ttl=63 time=0.729 ms
--- 31.1.1.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.729/1.509/2.957 ms
2025-03-31 02:41:38,829 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-92103856-75692045 passed
2025-03-31 02:41:38,829 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-03-31 02:41:38,829 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-03-31 02:41:38,829 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-03-31 02:41:38,829 - 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.22, gateway password: c0ntrail123
2025-03-31 02:41:38,829 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-03-31 02:41:39,005 - DEBUG - None
2025-03-31 02:41:39,006 - 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.22, gateway password: c0ntrail123
2025-03-31 02:41:39,006 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-03-31 02:41:39,180 - DEBUG - None
2025-03-31 02:41:39,180 - 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.22, gateway password: c0ntrail123
2025-03-31 02:41:39,180 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-03-31 02:41:39,795 - DEBUG - None
2025-03-31 02:41:39,796 - 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.22, gateway password: c0ntrail123
2025-03-31 02:41:39,796 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7
2025-03-31 02:41:42,003 - 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.688 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=6.153 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.549 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.333 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.364 ms
--- 31.1.1.7 ping statistics ---
3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss
round-trip min/avg/max = 0.364/2.217/6.153 ms
2025-03-31 02:41:42,003 - 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.22, gateway password: c0ntrail123
2025-03-31 02:41:42,003 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1
2025-03-31 02:41:44,239 - 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.990 ms
64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.733 ms (DUP!)
64 bytes from 31.1.1.3: seq=0 ttl=64 time=4.850 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.372 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.058 ms (DUP!)
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.785 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.398 ms
--- 224.0.0.1 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.372/2.169/4.850 ms
2025-03-31 02:41:44,239 - 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.22, gateway password: c0ntrail123
2025-03-31 02:41:44,239 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255
2025-03-31 02:41:46,469 - 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.614 ms
64 bytes from 31.1.2.4: seq=0 ttl=63 time=2.572 ms (DUP!)
64 bytes from 31.1.1.3: seq=0 ttl=64 time=3.476 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.390 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=2.981 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.389 ms
--- 255.255.255.255 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.389/1.778/3.476 ms
2025-03-31 02:41:46,469 - INFO - Deleting VM ctest-TestBasicVMVN-92103856-66111740
2025-03-31 02:41:46,547 - INFO - Detaching port 8d8ae0ff-aac2-473e-9a6a-bd92ee2ae524 from VM ctest-TestBasicVMVN-92103856-75692045
2025-03-31 02:41:46,597 - INFO - Deleting VM ctest-TestBasicVMVN-92103856-75692045
2025-03-31 02:41:46,660 - INFO - Detaching port 2dc040e8-4c00-47f7-bbfc-cabacd384152 from VM ctest-TestBasicVMVN-92103856-76600119
2025-03-31 02:41:46,697 - INFO - Deleting VM ctest-TestBasicVMVN-92103856-76600119
2025-03-31 02:41:46,765 - INFO - Deleting VN ctest-vn-70829571
2025-03-31 02:41:46,944 - DEBUG - Response for delete_port : ()
2025-03-31 02:41:47,147 - DEBUG - Response for delete_port : ()
2025-03-31 02:41:47,200 - DEBUG - VN 2d2d642e-5fa6-422b-82d5-3ac07aca25f3 still in use: Unable to complete operation on network 2d2d642e-5fa6-422b-82d5-3ac07aca25f3. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-76cfe573-e02d-47dc-bb0d-abff74a19a8b']
2025-03-31 02:41:47,200 - WARNING - Deleting VN ctest-vn-70829571 failed..Will retry
2025-03-31 02:41:49,326 - DEBUG - Response for deleting network ()
2025-03-31 02:41:49,326 - DEBUG - Requesting: http://10.0.0.22:8082/routing-instance/0ba29fd3-073c-4578-a444-51fd16f56781
2025-03-31 02:41:49,333 - DEBUG - Response Code: 404
2025-03-31 02:41:49,333 - DEBUG - Requesting: http://10.0.0.22:8082/domains
2025-03-31 02:41:49,338 - DEBUG - Requesting: http://10.0.0.22:8082/domain/2e3ba078-0ff6-4cdb-b0cb-5f08421c2c62
2025-03-31 02:41:49,391 - DEBUG - Requesting: http://10.0.0.22:8082/project/dcdf44c2-12e7-46d4-a949-1f159f4f1e1b
2025-03-31 02:41:49,473 - INFO - Validated that VN ctest-vn-70829571 is not found in API Server
2025-03-31 02:41:49,485 - DEBUG - VN ctest-vn-70829571 is not present in Agent 10.0.0.22
2025-03-31 02:41:49,485 - INFO - Validated that VN ctest-vn-70829571 is not in any agent
2025-03-31 02:41:49,492 - DEBUG - VRF 2 is not seen in agent 10.0.0.22
2025-03-31 02:41:49,497 - DEBUG - Vrouter 10.0.0.22 does not have vrf 2 for VN ctest-vn-70829571
2025-03-31 02:41:49,497 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-92103856:ctest-vn-70829571
2025-03-31 02:41:49,516 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-70829571 info
2025-03-31 02:41:49,594 - INFO - IPAM: ctest-ipam-96407287 is not found in API Server
2025-03-31 02:41:49,606 - INFO - IPAM:ctest-ipam-96407287 is not found in control node
2025-03-31 02:41:49,863 - DEBUG - No XMPP flaps were noticed during the test
2025-03-31 02:41:49,863 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:37]
2025-03-31 02:41:49,863 - INFO - --------------------------------------------------------------------------------
2025-03-31 02:41:50,576 - INFO - Deleted project: ctest-TestBasicVMVN-92103856, ID : dcdf44c2-12e7-46d4-a949-1f159f4f1e1b