2024-10-22 22:13:12,431 - INFO - Domain Default found not creating
2024-10-22 22:13:12,589 - INFO - Project ctest-TestBasicVMVNx-29488212 not found, creating it
2024-10-22 22:13:13,095 - INFO - Created Project:ctest-TestBasicVMVNx-29488212, ID : 5d270e11-9496-47dc-b469-e1129aebc569
2024-10-22 22:13:14,565 - INFO - ================================================================================
2024-10-22 22:13:14,565 - INFO - STARTING TEST : test_vm_file_trf_scp_tests
2024-10-22 22:13:14,565 - INFO - TEST DESCRIPTION :
Description: Test to validate File Transfer using scp between VMs. Files of different sizes.
Test steps:
1. Creating vm's - vm1 and vm2 and a Vn - vn222
2. Transfer file from vm1 to vm2 with diferrent file sizes using scp
3. file sizes - 64,1202,2210,10000
4. verify files present in vm2 match with the size of the file sent.
Pass criteria: File in vm2 should match with the transferred file size from vm1
Maintainer : ganeshahv@juniper.net
2024-10-22 22:13:14,829 - DEBUG - Nothing to compare xmpp stats {'10.0.0.32': {'10.20.0.24': '0'}} with
2024-10-22 22:13:14,829 - INFO - Initial checks done. Running the testcase now
2024-10-22 22:13:14,829 - INFO -
2024-10-22 22:13:15,430 - DEBUG - Response for create_network : {'network': {'id': 'baebeada-9fc3-4b3c-93dc-a2548d308572', 'name': 'ctest-vn-36910395', 'tenant_id': '5d270e11949647dcb469e1129aebc569', 'project_id': '5d270e11949647dcb469e1129aebc569', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestBasicVMVNx-29488212', 'ctest-vn-36910395'], 'port_security_enabled': True, 'description': ''}}
2024-10-22 22:13:15,680 - DEBUG - Response for create_subnet : {'subnet': {'id': '356f18a7-ac9f-46a7-afc5-2be27f462c34', 'name': '', 'tenant_id': '5d270e11949647dcb469e1129aebc569', 'network_id': 'baebeada-9fc3-4b3c-93dc-a2548d308572', 'ip_version': 4, 'cidr': '53.208.30.128/26', 'allocation_pools': [{'start': '53.208.30.130', 'end': '53.208.30.190'}], 'gateway_ip': '53.208.30.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '53.208.30.130', 'tags': [], 'project_id': '5d270e11949647dcb469e1129aebc569'}}
2024-10-22 22:13:15,703 - INFO - Created VN ctest-vn-36910395
2024-10-22 22:13:15,760 - DEBUG - VN ctest-vn-36910395 UUID is baebeada-9fc3-4b3c-93dc-a2548d308572
2024-10-22 22:13:15,933 - DEBUG - Services list from nova: [, , ]
2024-10-22 22:13:17,022 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-2127-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-2127-1)
2024-10-22 22:13:18,174 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-2127-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-2127-1)
2024-10-22 22:13:18,174 - INFO - Waiting for VM ctest-TestBasicVMVNx-29488212-01194061 to be up..
2024-10-22 22:13:18,257 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2024-10-22 22:13:23,336 - DEBUG - VM is in ACTIVE state now
2024-10-22 22:13:23,336 - INFO - VM name : ctest-TestBasicVMVNx-29488212-01194061
2024-10-22 22:13:23,424 - DEBUG - VM ctest-TestBasicVMVNx-29488212-01194061 ID is acf5f10c-2dfa-4e49-be87-dad3130efc4f
2024-10-22 22:13:23,448 - DEBUG - VM ctest-TestBasicVMVNx-29488212-01194061 launched on Node cn-jenkins-deploy-platform-ansible-os-2127-1
2024-10-22 22:13:23,537 - DEBUG - Requesting: http://10.0.0.32:8082/virtual-machine/acf5f10c-2dfa-4e49-be87-dad3130efc4f
2024-10-22 22:13:23,844 - DEBUG - Requesting: http://10.0.0.32:8082/virtual-machine/acf5f10c-2dfa-4e49-be87-dad3130efc4f
2024-10-22 22:13:23,879 - DEBUG - Requesting: http://10.0.0.32:8082/virtual-machine-interface/96f722dd-9b7e-4173-8362-72914cb06aa5
2024-10-22 22:13:27,156 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1027ms')
2024-10-22 22:13:27,157 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVNx-29488212-01194061 failed!
2024-10-22 22:13:27,220 - DEBUG - Gateway for vn default-domain:ctest-TestBasicVMVNx-29488212:ctest-vn-36910395 is 53.208.30.129 and allocation pool is NOT set
2024-10-22 22:13:29,279 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=1 ttl=63 time=2.73 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.414 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.414/1.569/2.725/1.155 ms')
2024-10-22 22:13:29,279 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestBasicVMVNx-29488212-01194061 passed
2024-10-22 22:13:29,436 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2024-10-22 22:13:29,436 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVNx-29488212-01194061, IP 53.208.30.131, Port 22
2024-10-22 22:13:29,586 - DEBUG - VM ctest-TestBasicVMVNx-29488212-01194061 is ready for SSH connections
2024-10-22 22:13:29,587 - INFO - Waiting for VM ctest-TestBasicVMVNx-29488212-85389291 to be up..
2024-10-22 22:13:29,666 - DEBUG - VM is in ACTIVE state now
2024-10-22 22:13:29,666 - INFO - VM name : ctest-TestBasicVMVNx-29488212-85389291
2024-10-22 22:13:29,747 - DEBUG - VM ctest-TestBasicVMVNx-29488212-85389291 ID is 785170d1-d425-40b4-ad11-5a5c7682601d
2024-10-22 22:13:29,747 - DEBUG - VM ctest-TestBasicVMVNx-29488212-85389291 launched on Node cn-jenkins-deploy-platform-ansible-os-2127-1
2024-10-22 22:13:29,825 - DEBUG - Requesting: http://10.0.0.32:8082/virtual-machine/785170d1-d425-40b4-ad11-5a5c7682601d
2024-10-22 22:13:29,835 - DEBUG - Requesting: http://10.0.0.32:8082/virtual-machine-interface/a09f6be8-15c1-4828-96c9-7e87d9172722
2024-10-22 22:13:31,083 - 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.10 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.474 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1000ms\r\nrtt min/avg/max/mdev = 0.474/1.786/3.099/1.312 ms')
2024-10-22 22:13:31,083 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestBasicVMVNx-29488212-85389291 passed
2024-10-22 22:13:31,256 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2024-10-22 22:13:31,256 - DEBUG - Waiting to SSH to VM ctest-TestBasicVMVNx-29488212-85389291, IP 53.208.30.132, Port 22
2024-10-22 22:13:31,422 - DEBUG - VM ctest-TestBasicVMVNx-29488212-85389291 is ready for SSH connections
2024-10-22 22:13:31,422 - DEBUG - FILE SIZE = 1303B
2024-10-22 22:13:31,422 - DEBUG - Transferring the file from ctest-TestBasicVMVNx-29488212-01194061 to ctest-TestBasicVMVNx-29488212-85389291 using scp
2024-10-22 22:13:31,422 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2024-10-22 22:13:31,429 - 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.32, gateway password: c0ntrail123
2024-10-22 22:13:31,429 - DEBUG - dd bs=1303 count=1 if=/dev/zero of=testfile
2024-10-22 22:13:33,291 - DEBUG - 1+0 records in
1+0 records out
2024-10-22 22:13:34,050 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2024-10-22 22:13:34,376 - DEBUG - Running remote_cmd, Cmd : ls -l testfile, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.32, gateway password: c0ntrail123
2024-10-22 22:13:34,376 - DEBUG - ls -l testfile
2024-10-22 22:13:35,949 - DEBUG - -rw------- 1 cirros cirros 1303 Oct 22 16:13 [0;0mtestfile[0m
2024-10-22 22:13:35,950 - INFO - File of size 1303 is trasferred successfully to ctest-TestBasicVMVNx-29488212-85389291
2024-10-22 22:13:35,950 - INFO - Deleting VM ctest-TestBasicVMVNx-29488212-85389291
2024-10-22 22:13:36,011 - INFO - Deleting VM ctest-TestBasicVMVNx-29488212-01194061
2024-10-22 22:13:36,080 - INFO - Deleting VN ctest-vn-36910395
2024-10-22 22:13:36,119 - DEBUG - VN baebeada-9fc3-4b3c-93dc-a2548d308572 still in use: Unable to complete operation on network baebeada-9fc3-4b3c-93dc-a2548d308572. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-81c00bc8-d18c-47f4-ab94-ea594b4151ca']
2024-10-22 22:13:36,119 - WARNING - Deleting VN ctest-vn-36910395 failed..Will retry
2024-10-22 22:13:38,225 - DEBUG - Response for deleting network ()
2024-10-22 22:13:38,477 - DEBUG - No XMPP flaps were noticed during the test
2024-10-22 22:13:38,477 - INFO - END TEST : test_vm_file_trf_scp_tests : PASSED[0:00:24]
2024-10-22 22:13:38,478 - INFO - --------------------------------------------------------------------------------
2024-10-22 22:13:39,239 - INFO - Deleted project: ctest-TestBasicVMVNx-29488212, ID : 5d270e11-9496-47dc-b469-e1129aebc569