is in ACTIVE state now
2025-04-08 14:33:30,276 - INFO - VM name : ctest-TestBasicVMVN-10231829-85331877
2025-04-08 14:33:30,361 - DEBUG - VM ctest-TestBasicVMVN-10231829-85331877 ID is 0ce12157-386a-491a-ac8c-861d40293941
2025-04-08 14:33:30,361 - DEBUG - VM ctest-TestBasicVMVN-10231829-85331877 launched on Node cn-jenkins-deploy-platform-ansible-os-3054-1
2025-04-08 14:33:30,436 - DEBUG - Requesting: http://10.0.0.46:8082/virtual-machine/0ce12157-386a-491a-ac8c-861d40293941
2025-04-08 14:33:30,446 - DEBUG - Requesting: http://10.0.0.46:8082/virtual-machine-interface/043a44e1-c6d7-4744-9e86-3d0ce9cc2411
2025-04-08 14:33:31,688 - 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.28 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.789 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.789/2.536/4.284/1.747 ms')
2025-04-08 14:33:31,688 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-10231829-85331877 passed
2025-04-08 14:33:31,842 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-08 14:33:31,843 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-10231829-85331877, IP 31.1.1.3, Port 22
2025-04-08 14:33:31,998 - DEBUG - VM ctest-TestBasicVMVN-10231829-85331877 is ready for SSH connections
2025-04-08 14:33:31,998 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-08 14:33:31,998 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 31.1.2.4, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.46, gateway password: c0ntrail123
2025-04-08 14:33:31,998 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4
2025-04-08 14:33:35,991 - 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.906 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=0.701 ms
64 bytes from 31.1.2.4: seq=2 ttl=63 time=1.068 ms
--- 31.1.2.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.701/1.891/3.906 ms
2025-04-08 14:33:35,991 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-10231829-45431087 passed
2025-04-08 14:33:35,992 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-08 14:33:35,992 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 31.1.1.4, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.46, gateway password: c0ntrail123
2025-04-08 14:33:35,992 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4
2025-04-08 14:33:39,624 - 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.973 ms
64 bytes from 31.1.1.4: seq=1 ttl=63 time=0.825 ms
64 bytes from 31.1.1.4: seq=2 ttl=63 time=1.062 ms
--- 31.1.1.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.825/1.620/2.973 ms
2025-04-08 14:33:39,624 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-10231829-47159868 passed
2025-04-08 14:33:39,624 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-08 14:33:39,624 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-08 14:33:39,624 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-08 14:33:39,624 - 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.46, gateway password: c0ntrail123
2025-04-08 14:33:39,624 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-08 14:33:39,802 - DEBUG - None
2025-04-08 14:33:39,802 - 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.46, gateway password: c0ntrail123
2025-04-08 14:33:39,802 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-08 14:33:39,992 - DEBUG - None
2025-04-08 14:33:39,992 - 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.46, gateway password: c0ntrail123
2025-04-08 14:33:39,992 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-08 14:33:40,624 - DEBUG - None
2025-04-08 14:33:40,624 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 31.1.1.7, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.46, gateway password: c0ntrail123
2025-04-08 14:33:40,624 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7
2025-04-08 14:33:42,833 - 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.760 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=6.320 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.533 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.805 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.385 ms
--- 31.1.1.7 ping statistics ---
3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss
round-trip min/avg/max = 0.385/2.160/6.320 ms
2025-04-08 14:33:42,834 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 224.0.0.1, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.46, gateway password: c0ntrail123
2025-04-08 14:33:42,834 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1
2025-04-08 14:33:45,078 - 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.180 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=4.383 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=5.624 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.463 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=1.641 ms (DUP!)
64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.323 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.350 ms
--- 224.0.0.1 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.350/2.280/5.624 ms
2025-04-08 14:33:45,078 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 255.255.255.255, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.46, gateway password: c0ntrail123
2025-04-08 14:33:45,079 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255
2025-04-08 14:33:47,327 - 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.810 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.586 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.520 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.509 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.718 ms (DUP!)
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.570 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.550 ms
--- 255.255.255.255 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.509/1.751/3.520 ms
2025-04-08 14:33:47,327 - INFO - Deleting VM ctest-TestBasicVMVN-10231829-85331877
2025-04-08 14:33:47,402 - INFO - Detaching port 0d646b4d-57d1-4a4b-8d6a-0a68ed1d8bd2 from VM ctest-TestBasicVMVN-10231829-47159868
2025-04-08 14:33:47,458 - INFO - Deleting VM ctest-TestBasicVMVN-10231829-47159868
2025-04-08 14:33:47,521 - INFO - Detaching port 7724c288-8876-42f2-904d-dcdad20cb004 from VM ctest-TestBasicVMVN-10231829-45431087
2025-04-08 14:33:47,557 - INFO - Deleting VM ctest-TestBasicVMVN-10231829-45431087
2025-04-08 14:33:47,635 - INFO - Deleting VN ctest-vn-32446048
2025-04-08 14:33:47,827 - DEBUG - Response for delete_port : ()
2025-04-08 14:33:48,041 - DEBUG - Response for delete_port : ()
2025-04-08 14:33:48,091 - DEBUG - VN 924d2467-ea71-4004-a89d-f8e37426adcb still in use: Unable to complete operation on network 924d2467-ea71-4004-a89d-f8e37426adcb. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-ba812a15-2a56-4c79-b975-61ac32fa915c']
2025-04-08 14:33:48,091 - WARNING - Deleting VN ctest-vn-32446048 failed..Will retry
2025-04-08 14:33:50,252 - DEBUG - Response for deleting network ()
2025-04-08 14:33:50,252 - DEBUG - Requesting: http://10.0.0.46:8082/routing-instance/bd0b4065-f5a9-433d-9204-bab3bf5eca79
2025-04-08 14:33:50,257 - DEBUG - Response Code: 404
2025-04-08 14:33:50,257 - DEBUG - Requesting: http://10.0.0.46:8082/domains
2025-04-08 14:33:50,263 - DEBUG - Requesting: http://10.0.0.46:8082/domain/b9b09fe9-8c01-4dba-8594-b5e0931ec90e
2025-04-08 14:33:50,317 - DEBUG - Requesting: http://10.0.0.46:8082/project/20df115d-ccbc-4cab-8d1f-edb83a1672ef
2025-04-08 14:33:50,393 - INFO - Validated that VN ctest-vn-32446048 is not found in API Server
2025-04-08 14:33:50,404 - DEBUG - VN ctest-vn-32446048 is not present in Agent 10.0.0.46
2025-04-08 14:33:50,404 - INFO - Validated that VN ctest-vn-32446048 is not in any agent
2025-04-08 14:33:50,410 - DEBUG - VRF 2 is not seen in agent 10.0.0.46
2025-04-08 14:33:50,415 - DEBUG - Vrouter 10.0.0.46 does not have vrf 2 for VN ctest-vn-32446048
2025-04-08 14:33:50,415 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-10231829:ctest-vn-32446048
2025-04-08 14:33:50,428 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-32446048 info
2025-04-08 14:33:50,506 - INFO - IPAM: ctest-ipam-97812183 is not found in API Server
2025-04-08 14:33:50,517 - INFO - IPAM:ctest-ipam-97812183 is not found in control node
2025-04-08 14:33:50,773 - DEBUG - No XMPP flaps were noticed during the test
2025-04-08 14:33:50,773 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:38]
2025-04-08 14:33:50,773 - INFO - --------------------------------------------------------------------------------
2025-04-08 14:33:51,498 - INFO - Deleted project: ctest-TestBasicVMVN-10231829, ID : 20df115d-ccbc-4cab-8d1f-edb83a1672ef