is in ACTIVE state now
2025-04-28 02:08:40,628 - INFO - VM name : ctest-TestBasicVMVN-82430984-66330309
2025-04-28 02:08:40,707 - DEBUG - VM ctest-TestBasicVMVN-82430984-66330309 ID is b9613161-7ae5-4b6a-93e3-3c7de7357490
2025-04-28 02:08:40,707 - DEBUG - VM ctest-TestBasicVMVN-82430984-66330309 launched on Node cn-jenkins-deploy-platform-ansible-os-3230-1
2025-04-28 02:08:40,781 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine/b9613161-7ae5-4b6a-93e3-3c7de7357490
2025-04-28 02:08:40,791 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine-interface/670268a1-6abc-4d6b-8c59-153dd1074f64
2025-04-28 02:08:42,041 - 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.73 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=0.349 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.349/1.539/2.730/1.190 ms')
2025-04-28 02:08:42,041 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestBasicVMVN-82430984-66330309 passed
2025-04-28 02:08:42,195 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-28 02:08:42,195 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVN-82430984-66330309, IP 31.1.1.3, Port 22
2025-04-28 02:08:42,354 - DEBUG - VM ctest-TestBasicVMVN-82430984-66330309 is ready for SSH connections
2025-04-28 02:08:42,355 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-28 02:08:42,355 - 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.254, gateway password: c0ntrail123
2025-04-28 02:08:42,355 - DEBUG - ping -s 56 -c 3 -W 1 31.1.2.4
2025-04-28 02:08:46,357 - 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.523 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=0.754 ms
64 bytes from 31.1.2.4: seq=2 ttl=63 time=0.907 ms
--- 31.1.2.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.754/1.728/3.523 ms
2025-04-28 02:08:46,357 - INFO - Ping to IP 31.1.2.4 from VM ctest-TestBasicVMVN-82430984-46592294 passed
2025-04-28 02:08:46,357 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-28 02:08:46,357 - 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.254, gateway password: c0ntrail123
2025-04-28 02:08:46,357 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.4
2025-04-28 02:08:49,984 - 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.882 ms
64 bytes from 31.1.1.4: seq=1 ttl=63 time=0.899 ms
64 bytes from 31.1.1.4: seq=2 ttl=63 time=2.107 ms
--- 31.1.1.4 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.899/1.962/2.882 ms
2025-04-28 02:08:49,984 - INFO - Ping to IP 31.1.1.4 from VM ctest-TestBasicVMVN-82430984-68165312 passed
2025-04-28 02:08:49,984 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-28 02:08:49,984 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-28 02:08:49,984 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-04-28 02:08:49,984 - 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.254, gateway password: c0ntrail123
2025-04-28 02:08:49,985 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-28 02:08:50,161 - DEBUG - None
2025-04-28 02:08:50,161 - 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.254, gateway password: c0ntrail123
2025-04-28 02:08:50,161 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-28 02:08:50,334 - DEBUG - None
2025-04-28 02:08:50,334 - 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.254, gateway password: c0ntrail123
2025-04-28 02:08:50,334 - DEBUG - echo 0 > /proc/sys/net/ipv4/icmp_echo_ignore_broadcasts
2025-04-28 02:08:50,910 - DEBUG - None
2025-04-28 02:08:50,910 - 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.254, gateway password: c0ntrail123
2025-04-28 02:08:50,910 - DEBUG - ping -s 56 -c 3 -W 1 31.1.1.7
2025-04-28 02:08:53,121 - 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.894 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=5.682 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.387 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.591 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.366 ms
--- 31.1.1.7 ping statistics ---
3 packets transmitted, 3 packets received, 2 duplicates, 0% packet loss
round-trip min/avg/max = 0.366/1.984/5.682 ms
2025-04-28 02:08:53,122 - 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.254, gateway password: c0ntrail123
2025-04-28 02:08:53,122 - DEBUG - ping -s 56 -c 3 -W 1 224.0.0.1
2025-04-28 02:08:55,346 - 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.077 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.853 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.809 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.422 ms
64 bytes from 31.1.1.3: seq=1 ttl=64 time=1.637 ms (DUP!)
64 bytes from 31.1.2.4: seq=1 ttl=63 time=2.451 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.373 ms
--- 224.0.0.1 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.373/1.803/3.809 ms
2025-04-28 02:08:55,347 - 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.254, gateway password: c0ntrail123
2025-04-28 02:08:55,347 - DEBUG - ping -s 56 -c 3 -W 1 255.255.255.255
2025-04-28 02:08:57,576 - 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.624 ms
64 bytes from 31.1.1.3: seq=0 ttl=64 time=2.441 ms (DUP!)
64 bytes from 31.1.2.4: seq=0 ttl=63 time=3.179 ms (DUP!)
64 bytes from 31.1.1.4: seq=1 ttl=64 time=0.447 ms
64 bytes from 31.1.2.4: seq=1 ttl=63 time=1.757 ms (DUP!)
64 bytes from 31.1.1.3: seq=1 ttl=64 time=2.533 ms (DUP!)
64 bytes from 31.1.1.4: seq=2 ttl=64 time=0.360 ms
--- 255.255.255.255 ping statistics ---
3 packets transmitted, 3 packets received, 4 duplicates, 0% packet loss
round-trip min/avg/max = 0.360/1.620/3.179 ms
2025-04-28 02:08:57,576 - INFO - Deleting VM ctest-TestBasicVMVN-82430984-66330309
2025-04-28 02:08:57,639 - INFO - Detaching port 370258dc-fc48-472a-a951-7feec6f4c02a from VM ctest-TestBasicVMVN-82430984-68165312
2025-04-28 02:08:57,689 - INFO - Deleting VM ctest-TestBasicVMVN-82430984-68165312
2025-04-28 02:08:57,755 - INFO - Detaching port 7cf3073f-02b3-47a4-a1e4-ae4c5102f197 from VM ctest-TestBasicVMVN-82430984-46592294
2025-04-28 02:08:57,785 - INFO - Deleting VM ctest-TestBasicVMVN-82430984-46592294
2025-04-28 02:08:57,852 - INFO - Deleting VN ctest-vn-43419770
2025-04-28 02:08:58,016 - DEBUG - Response for delete_port : ()
2025-04-28 02:08:58,168 - DEBUG - Response for delete_port : ()
2025-04-28 02:08:58,218 - DEBUG - VN fcd2a6d7-90fa-4ce6-a4b3-0f8871379bd1 still in use: Unable to complete operation on network fcd2a6d7-90fa-4ce6-a4b3-0f8871379bd1. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-d9b24148-0199-46ee-8d11-cb8b149b9fca']
2025-04-28 02:08:58,218 - WARNING - Deleting VN ctest-vn-43419770 failed..Will retry
2025-04-28 02:09:00,389 - DEBUG - Response for deleting network ()
2025-04-28 02:09:00,389 - DEBUG - Requesting: http://10.0.0.254:8082/routing-instance/1e0d4ee8-a8bf-4b2d-9a09-0d4b69de7dec
2025-04-28 02:09:00,395 - DEBUG - Response Code: 404
2025-04-28 02:09:00,395 - DEBUG - Requesting: http://10.0.0.254:8082/domains
2025-04-28 02:09:00,399 - DEBUG - Requesting: http://10.0.0.254:8082/domain/fa5c208a-72f6-423c-9484-737617bde608
2025-04-28 02:09:00,453 - DEBUG - Requesting: http://10.0.0.254:8082/project/c96daf5f-94dc-4e67-bdf2-ae6fe7f8b3eb
2025-04-28 02:09:00,530 - INFO - Validated that VN ctest-vn-43419770 is not found in API Server
2025-04-28 02:09:00,541 - DEBUG - VN ctest-vn-43419770 is not present in Agent 10.0.0.254
2025-04-28 02:09:00,541 - INFO - Validated that VN ctest-vn-43419770 is not in any agent
2025-04-28 02:09:00,546 - DEBUG - VRF 2 is not seen in agent 10.0.0.254
2025-04-28 02:09:00,551 - DEBUG - Vrouter 10.0.0.254 does not have vrf 2 for VN ctest-vn-43419770
2025-04-28 02:09:00,551 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-TestBasicVMVN-82430984:ctest-vn-43419770
2025-04-28 02:09:00,562 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn-43419770 info
2025-04-28 02:09:00,643 - INFO - IPAM: ctest-ipam-04351722 is not found in API Server
2025-04-28 02:09:00,656 - INFO - IPAM:ctest-ipam-04351722 is not found in control node
2025-04-28 02:09:00,909 - DEBUG - No XMPP flaps were noticed during the test
2025-04-28 02:09:00,910 - INFO - END TEST : test_ping_within_vn_two_vms_two_different_subnets : PASSED[0:00:37]
2025-04-28 02:09:00,910 - INFO - --------------------------------------------------------------------------------
2025-04-28 02:09:01,661 - INFO - Deleted project: ctest-TestBasicVMVN-82430984, ID : c96daf5f-94dc-4e67-bdf2-ae6fe7f8b3eb