is in ACTIVE state now
2025-01-07 11:56:12,673 - INFO - VM name : ctest-TestBasicVMVNx-71941794-12911704
2025-01-07 11:56:12,759 - DEBUG - VM ctest-TestBasicVMVNx-71941794-12911704 ID is 880557ff-1377-43ab-abc9-77756a21c08e
2025-01-07 11:56:12,759 - DEBUG - VM ctest-TestBasicVMVNx-71941794-12911704 launched on Node cn-jenkins-deploy-platform-ansible-os-2549-1
2025-01-07 11:56:12,859 - DEBUG - Requesting: http://10.0.0.31:8082/virtual-machine/880557ff-1377-43ab-abc9-77756a21c08e
2025-01-07 11:56:12,885 - DEBUG - Requesting: http://10.0.0.31:8082/virtual-machine-interface/47fcf388-4b1f-466e-8ccc-df6d2af28e4f
2025-01-07 11:56:14,135 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n64 bytes from 169.254.0.4: icmp_seq=1 ttl=63 time=3.75 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=1.09 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 1.085/2.416/3.747/1.331 ms')
2025-01-07 11:56:14,135 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBasicVMVNx-71941794-12911704 passed
2025-01-07 11:56:14,290 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-07 11:56:14,290 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVNx-71941794-12911704, IP 1.54.64.132, Port 22
2025-01-07 11:56:14,346 - DEBUG - Error on ssh to cirros@169.254.0.4:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.4/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.4/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.4/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2025-01-07 11:56:14,435 - DEBUG - VM ctest-TestBasicVMVNx-71941794-12911704 is NOT ready for SSH connections, VM status: ACTIVE
2025-01-07 11:56:19,436 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-07 11:56:19,436 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVNx-71941794-12911704, IP 1.54.64.132, Port 22
2025-01-07 11:56:19,608 - DEBUG - VM ctest-TestBasicVMVNx-71941794-12911704 is ready for SSH connections
2025-01-07 11:56:19,608 - DEBUG - FILE SIZE = 1303B
2025-01-07 11:56:19,608 - DEBUG - Transferring the file from ctest-TestBasicVMVNx-71941794-43890465 to ctest-TestBasicVMVNx-71941794-12911704 using scp
2025-01-07 11:56:19,609 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-07 11:56:19,628 - DEBUG - Running remote_cmd, Cmd : dd bs=1303 count=1 if=/dev/zero of=testfile, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.31, gateway password: c0ntrail123
2025-01-07 11:56:19,628 - DEBUG - dd bs=1303 count=1 if=/dev/zero of=testfile
2025-01-07 11:56:21,548 - DEBUG - 1+0 records in
1+0 records out
2025-01-07 11:56:22,362 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-01-07 11:56:22,682 - DEBUG - Running remote_cmd, Cmd : ls -l testfile, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.31, gateway password: c0ntrail123
2025-01-07 11:56:22,682 - DEBUG - ls -l testfile
2025-01-07 11:56:24,257 - DEBUG - -rw------- 1 cirros cirros 1303 Jan 7 04:56 [0;0mtestfile[0m
2025-01-07 11:56:24,257 - INFO - File of size 1303 is trasferred successfully to ctest-TestBasicVMVNx-71941794-12911704
2025-01-07 11:56:24,257 - INFO - Deleting VM ctest-TestBasicVMVNx-71941794-12911704
2025-01-07 11:56:24,352 - INFO - Deleting VM ctest-TestBasicVMVNx-71941794-43890465
2025-01-07 11:56:24,422 - INFO - Deleting VN ctest-vn-16951984
2025-01-07 11:56:24,458 - DEBUG - VN 3c94690c-e9da-4885-bd28-ccfda9b51193 still in use: Unable to complete operation on network 3c94690c-e9da-4885-bd28-ccfda9b51193. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-66e73e17-aa42-4a2d-a5f5-47f2003e798c']
2025-01-07 11:56:24,458 - WARNING - Deleting VN ctest-vn-16951984 failed..Will retry
2025-01-07 11:56:26,568 - DEBUG - Response for deleting network ()
2025-01-07 11:56:26,824 - DEBUG - No XMPP flaps were noticed during the test
2025-01-07 11:56:26,824 - INFO - END TEST : test_vm_file_trf_scp_tests : PASSED[0:00:29]
2025-01-07 11:56:26,824 - INFO - --------------------------------------------------------------------------------
2025-01-07 11:56:27,532 - INFO - Deleted project: ctest-TestBasicVMVNx-71941794, ID : 15f1ce43-14d1-4679-a3f4-3a2ee7d8c9b3