is in ACTIVE state now
2025-04-22 20:50:53,336 - INFO - VM name : ctest-TestBasicVMVN-13306984-57657089
2025-04-22 20:50:53,412 - DEBUG - VM ctest-TestBasicVMVN-13306984-57657089 ID is a433460c-0392-40fc-b48d-1dad856d771c
2025-04-22 20:50:53,412 - DEBUG - VM ctest-TestBasicVMVN-13306984-57657089 launched on Node cn-jenkins-deploy-platform-ansible-os-3173-1
2025-04-22 20:50:53,484 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/a433460c-0392-40fc-b48d-1dad856d771c
2025-04-22 20:50:53,492 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/927c21e0-9225-43f4-a6b0-6b357834a19c
2025-04-22 20:50:54,734 - 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.09 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.375 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.375/1.731/3.087/1.356 ms')
2025-04-22 20:50:54,735 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-13306984-57657089 passed
2025-04-22 20:50:54,888 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-22 20:50:54,888 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-13306984-57657089, IP 31.1.1.3, Port 22
2025-04-22 20:50:55,048 - DEBUG - VM ctest-TestBasicVMVN-13306984-57657089 is ready for SSH connections
2025-04-22 20:50:55,048 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-22 20:50:55,048 - 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-04-22 20:50:55,048 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4
2025-04-22 20:50:59,140 - 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.881 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=0.729 ms
64 bytes from 31.1.2.4: seq=2 ttl=63 time=1.084 ms
--- 31.1.2.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.729/1.898/3.881 ms
2025-04-22 20:50:59,140 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-13306984-05828261 passed
2025-04-22 20:50:59,140 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-22 20:50:59,140 - 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-04-22 20:50:59,140 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4
2025-04-22 20:51:02,793 - 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.739 ms
64 bytes from 31.1.1.4: seq=1 ttl=63 time=0.828 ms
64 bytes from 31.1.1.4: seq=2 ttl=63 time=0.738 ms
--- 31.1.1.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.738/1.768/3.739 ms
2025-04-22 20:51:02,793 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-13306984-78372303 passed
2025-04-22 20:51:02,793 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-22 20:51:02,793 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-22 20:51:02,793 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-22 20:51:02,794 - 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-04-22 20:51:02,794 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-22 20:51:02,988 - DEBUG - None
2025-04-22 20:51:02,989 - 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-04-22 20:51:02,989 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-22 20:51:03,184 - DEBUG - None
2025-04-22 20:51:03,184 - 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-04-22 20:51:03,184 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-22 20:51:03,821 - DEBUG - None
2025-04-22 20:51:03,821 - 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-04-22 20:51:03,821 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7
2025-04-22 20:51:06,056 - 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.143 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=5.455 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.374 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.775 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.570 ms
--- 31.1.1.7 ping statistics ---
3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss
round-trip min/avg/max = 0.374/2.063/5.455 ms
2025-04-22 20:51:06,056 - 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-04-22 20:51:06,057 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1
2025-04-22 20:51:08,314 - 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.044 ms
64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.299 ms (DUP!)
64 bytes from 31.1.1.3: seq=0 ttl=64 time=4.556 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.485 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=1.689 ms (DUP!)
64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.513 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.371 ms
--- 224.0.0.1 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.371/1.993/4.556 ms
2025-04-22 20:51:08,315 - 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-04-22 20:51:08,315 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255
2025-04-22 20:51:10,568 - 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.730 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.783 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.646 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.410 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.789 ms (DUP!)
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.563 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.453 ms
--- 255.255.255.255 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.410/1.767/3.646 ms
2025-04-22 20:51:10,569 - INFO - Deleting VM ctest-TestBasicVMVN-13306984-57657089
2025-04-22 20:51:10,633 - INFO - Detaching port a80d3e79-016a-4401-be96-4290125e53ff from VM ctest-TestBasicVMVN-13306984-78372303
2025-04-22 20:51:10,680 - INFO - Deleting VM ctest-TestBasicVMVN-13306984-78372303
2025-04-22 20:51:10,745 - INFO - Detaching port f1233198-3fb7-4e21-8ef3-4910c5a00440 from VM ctest-TestBasicVMVN-13306984-05828261
2025-04-22 20:51:10,779 - INFO - Deleting VM ctest-TestBasicVMVN-13306984-05828261
2025-04-22 20:51:10,847 - INFO - Deleting VN ctest-vn-61245059
2025-04-22 20:51:11,034 - DEBUG - Response for delete_port : ()
2025-04-22 20:51:11,185 - DEBUG - Response for delete_port : ()
2025-04-22 20:51:11,225 - DEBUG - VN c25dfebf-827d-46ce-ac09-ff48f1662563 still in use: Unable to complete operation on network c25dfebf-827d-46ce-ac09-ff48f1662563. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-065579c1-f316-423b-bd39-594da4257342']
2025-04-22 20:51:11,225 - WARNING - Deleting VN ctest-vn-61245059 failed..Will retry
2025-04-22 20:51:13,359 - DEBUG - Response for deleting network ()
2025-04-22 20:51:13,359 - DEBUG - Requesting: http://10.0.0.50:8082/routing-instance/454e4973-fe7f-49c4-9d25-f058637046ba
2025-04-22 20:51:13,367 - DEBUG - Response Code: 404
2025-04-22 20:51:13,368 - DEBUG - Requesting: http://10.0.0.50:8082/domains
2025-04-22 20:51:13,375 - DEBUG - Requesting: http://10.0.0.50:8082/domain/d0c349e1-aa54-41c9-a81e-44a5a6e075d5
2025-04-22 20:51:13,430 - DEBUG - Requesting: http://10.0.0.50:8082/project/25a264f5-c2e8-42eb-90eb-f3f051466a1e
2025-04-22 20:51:13,503 - INFO - Validated that VN ctest-vn-61245059 is not found in API Server
2025-04-22 20:51:13,516 - DEBUG - VN ctest-vn-61245059 is not present in Agent 10.0.0.50
2025-04-22 20:51:13,516 - INFO - Validated that VN ctest-vn-61245059 is not in any agent
2025-04-22 20:51:13,522 - DEBUG - VRF 2 is not seen in agent 10.0.0.50
2025-04-22 20:51:13,527 - DEBUG - Vrouter 10.0.0.50 does not have vrf 2 for VN ctest-vn-61245059
2025-04-22 20:51:13,527 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-13306984:ctest-vn-61245059
2025-04-22 20:51:13,542 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-61245059 info
2025-04-22 20:51:13,620 - INFO - IPAM: ctest-ipam-43026655 is not found in API Server
2025-04-22 20:51:13,631 - INFO - IPAM:ctest-ipam-43026655 is not found in control node
2025-04-22 20:51:13,892 - DEBUG - No XMPP flaps were noticed during the test
2025-04-22 20:51:13,892 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:37]
2025-04-22 20:51:13,892 - INFO - --------------------------------------------------------------------------------
2025-04-22 20:51:14,647 - INFO - Deleted project: ctest-TestBasicVMVN-13306984, ID : 25a264f5-c2e8-42eb-90eb-f3f051466a1e