stestr run tempest.scenario.test_shelve_instance.TestShelveInstance.test_shelve_volume_backed_instance
{0} tempest.scenario.test_shelve_instance.TestShelveInstance.test_shelve_volume_backed_instance [55.185040s] ... FAILED
Captured traceback:
~~~~~~~~~~~~~~~~~~~
Traceback (most recent call last):
File "/opt/venv/tempest/lib/python3.8/site-packages/tempest/common/utils/__init__.py", line 70, in wrapper
return f(*func_args, **func_kwargs)
File "/opt/venv/tempest/lib/python3.8/site-packages/tempest/scenario/test_shelve_instance.py", line 120, in test_shelve_volume_backed_instance
self._create_server_then_shelve_and_unshelve(boot_from_volume=True)
File "/opt/venv/tempest/lib/python3.8/site-packages/tempest/scenario/test_shelve_instance.py", line 101, in _create_server_then_shelve_and_unshelve
timestamp2 = self.get_timestamp(instance_ip,
File "/opt/venv/tempest/lib/python3.8/site-packages/tempest/scenario/manager.py", line 1163, in get_timestamp
timestamp = ssh_client.exec_command('sudo cat %s/timestamp'
File "/opt/venv/tempest/lib/python3.8/site-packages/tempest/lib/common/utils/linux/remote_client.py", line 31, in wrapper
return function(self, *args, **kwargs)
File "/opt/venv/tempest/lib/python3.8/site-packages/tempest/lib/common/utils/linux/remote_client.py", line 115, in exec_command
return self.ssh_client.exec_command(cmd)
File "/opt/venv/tempest/lib/python3.8/site-packages/tempest/lib/common/ssh.py", line 238, in exec_command
raise exceptions.SSHExecCommandFailed(
tempest.lib.exceptions.SSHExecCommandFailed: Command 'set -eu -o pipefail; PATH=$PATH:/sbin:/usr/sbin; sudo cat /tmp/timestamp', exit status: 1, stderr:
cat: /tmp/timestamp: No such file or directory
stdout:
Captured pythonlogging:
~~~~~~~~~~~~~~~~~~~~~~~
2023-08-18 09:58:32,846 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 POST https://myurl.com:8774/v2.1/os-keypairs 0.207s
2023-08-18 09:58:33,128 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 201 POST https://myurl.com:9696/v2.0/security-groups 0.281s
2023-08-18 09:58:33,243 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 201 POST https://myurl.com:9696/v2.0/security-group-rules 0.114s
2023-08-18 09:58:33,355 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 201 POST https://myurl.com:9696/v2.0/security-group-rules 0.112s
2023-08-18 09:58:33,435 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 201 POST https://myurl.com:9696/v2.0/security-group-rules 0.081s
2023-08-18 09:58:33,529 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 201 POST https://myurl.com:9696/v2.0/security-group-rules 0.093s
2023-08-18 09:58:33,636 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 201 POST https://myurl.com:9696/v2.0/security-group-rules 0.107s
2023-08-18 09:58:33,717 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 201 POST https://myurl.com:9696/v2.0/security-group-rules 0.081s
2023-08-18 09:58:34,063 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 201 POST https://myurl.com:5000/v3/auth/tokens 0.343s
2023-08-18 09:58:34,240 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:9696/v2.0/networks 0.177s
2023-08-18 09:58:34,240 1935344 INFO [tempest.lib.common.fixed_network] (TestShelveInstance:test_shelve_volume_backed_instance) Found network {'id': '8ab536e2-17ff-41cb-abfe-7acf0c4081f4', 'name': 'tempest-bgp-net', 'tenant_id': 'd14aee1cdd6d44c8b87ee19d3a097323', 'admin_state_up': True, 'mtu': 1450, 'status': 'ACTIVE', 'subnets': ['da75e700-6462-4a1c-90c6-fc102ae77766'], 'shared': True, 'availability_zone_hints': [], 'availability_zones': ['nova'], 'ipv4_address_scope': '51360fb5-a536-47f2-8bc2-e2937f933af9', 'ipv6_address_scope': None, 'router:external': False, 'description': '', 'port_security_enabled': True, 'dns_domain': '', 'tags': [], 'created_at': '2023-08-17T10:27:46Z', 'updated_at': '2023-08-17T10:30:58Z', 'revision_number': 4, 'project_id': 'd14aee1cdd6d44c8b87ee19d3a097323', 'provider:network_type': 'vxlan', 'provider:physical_network': None, 'provider:segmentation_id': 868} available for tenant
2023-08-18 09:58:34,547 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 202 POST https://myurl.com:8776/v3/7f9af036b539495cab471bde8e98b74d/volumes 0.306s
2023-08-18 09:58:34,602 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8776/v3/7f9af036b539495cab471bde8e98b74d/volumes/7f7241e2-f599-4358-8ee5-66f13513ea42 0.049s
2023-08-18 09:58:35,645 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8776/v3/7f9af036b539495cab471bde8e98b74d/volumes/7f7241e2-f599-4358-8ee5-66f13513ea42 0.035s
2023-08-18 09:58:35,651 1935344 INFO [tempest.common.waiters] volume 7f7241e2-f599-4358-8ee5-66f13513ea42 reached available after waiting for 1.651414 seconds
2023-08-18 09:58:36,473 1935344 IN
FO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 202 POST https://myurl.com:8774/v2.1/servers 0.822s
2023-08-18 09:58:36,628 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.153s
2023-08-18 09:58:37,809 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.173s
2023-08-18 09:58:37,815 1935344 INFO [tempest.common.waiters] State transition "BUILD/scheduling" ==> "BUILD/None" after 1 second wait
2023-08-18 09:58:39,020 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.204s
2023-08-18 09:58:39,026 1935344 INFO [tempest.common.waiters] State transition "BUILD/None" ==> "BUILD/block_device_mapping" after 3 second wait
2023-08-18 09:58:40,222 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.194s
2023-08-18 09:58:40,228 1935344 INFO [tempest.common.waiters] State transition "BUILD/block_device_mapping" ==> "BUILD/spawning" after 4 second wait
2023-08-18 09:58:41,381 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.152s
2023-08-18 09:58:41,388 1935344 INFO [tempest.common.waiters] State transition "BUILD/spawning" ==> "ACTIVE/None" after 5 second wait
2023-08-18 09:58:41,588 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.200s
2023-08-18 09:58:41,595 1935344 INFO [tempest.lib.common.ssh] Creating ssh connection to 'myinstanceipaddress:22' as 'ubuntu' with public key authentication
2023-08-18 09:58:48,705 1935344 WARNING [tempest.lib.common.ssh] Failed to establish authenticated ssh connection to ubuntu@myinstanceipaddress ([Errno None] Unable to connect to port 22 on myinstanceipaddress). Number attempts: 1. Retry after 2 seconds.
2023-08-18 09:58:51,209 1935344 WARNING [tempest.lib.common.ssh] Failed to establish authenticated ssh connection to ubuntu@myinstanceipaddress ([Errno None] Unable to connect to port 22 on myinstanceipaddress). Number attempts: 2. Retry after 3 seconds.
2023-08-18 09:58:54,731 1935344 INFO [paramiko.transport] Connected (version 2.0, client OpenSSH_8.2p1)
2023-08-18 09:58:54,774 1935344 INFO [paramiko.transport] Authentication (publickey) successful!
2023-08-18 09:58:54,774 1935344 INFO [tempest.lib.common.ssh] ssh connection to ubuntu@myinstanceipaddress successfully created
2023-08-18 09:58:54,775 1935344 INFO [tempest.lib.common.ssh] Creating ssh connection to 'myinstanceipaddress:22' as 'ubuntu' with public key authentication
2023-08-18 09:58:54,783 1935344 INFO [paramiko.transport] Connected (version 2.0, client OpenSSH_8.2p1)
2023-08-18 09:58:54,822 1935344 INFO [paramiko.transport] Authentication (publickey) successful!
2023-08-18 09:58:54,822 1935344 INFO [tempest.lib.common.ssh] ssh connection to ubuntu@myinstanceipaddress successfully created
2023-08-18 09:58:56,115 1935344 INFO [tempest.lib.common.ssh] Creating ssh connection to 'myinstanceipaddress:22' as 'ubuntu' with public key authentication
2023-08-18 09:58:56,123 1935344 INFO [paramiko.transport] Connected (version 2.0, client OpenSSH_8.2p1)
2023-08-18 09:58:56,167 1935344 INFO [paramiko.transport] Authentication (publickey) successful!
2023-08-18 09:58:56,167 1935344 INFO [tempest
.lib.common.ssh] ssh connection to ubuntu@myinstanceipaddress successfully created
2023-08-18 09:58:56,521 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 202 POST https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa/action 0.094s
2023-08-18 09:58:56,666 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.145s
2023-08-18 09:58:57,830 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.132s
2023-08-18 09:58:58,987 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.149s
2023-08-18 09:59:00,111 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.117s
2023-08-18 09:59:01,250 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.132s
2023-08-18 09:59:02,387 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.129s
2023-08-18 09:59:03,526 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.131s
2023-08-18 09:59:03,532 1935344 INFO [tempest.common.waiters] State transition "ACTIVE/shelving" ==> "SHELVED_OFFLOADED/None" after 7 second wait
2023-08-18 09:59:04,037 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 202 POST https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa/action 0.505s
2023-08-18 09:59:04,291 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.254s
2023-08-18 09:59:05,406 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.107s
2023-08-18 09:59:06,553 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.140s
2023-08-18 09:59:06,559 1935344 INFO [tempest.common.waiters] State transition "SHELVED_OFFLOADED/unshelving" ==> "SHELVED_OFFLOADED/spawning" after 2 second wait
2023-08-18 09:59:07,697 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.136s
2023-08-18 09:59:08,946 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.241s
2023-08-18 09:59:08,952 1935344 INFO [tempest.common.waiters] State transition "SHELVED_OFFLOADED/spawning" ==> "ACTIVE/None" after 4 second wait
2023-08-18 09:59:08,953 1935344 INFO [tempest.lib.common.ssh] Creating ssh connection to 'myinstanceipaddress:
22' as 'ubuntu' with public key authentication
2023-08-18 09:59:24,308 1935344 INFO [paramiko.transport] Connected (version 2.0, client OpenSSH_8.2p1)
2023-08-18 09:59:24,351 1935344 INFO [paramiko.transport] Authentication (publickey) successful!
2023-08-18 09:59:24,351 1935344 INFO [tempest.lib.common.ssh] ssh connection to ubuntu@myinstanceipaddress successfully created
2023-08-18 09:59:24,351 1935344 INFO [tempest.lib.common.ssh] Creating ssh connection to 'myinstanceipaddress:22' as 'ubuntu' with public key authentication
2023-08-18 09:59:24,362 1935344 INFO [paramiko.transport] Connected (version 2.0, client OpenSSH_8.2p1)
2023-08-18 09:59:24,404 1935344 INFO [paramiko.transport] Authentication (publickey) successful!
2023-08-18 09:59:24,404 1935344 INFO [tempest.lib.common.ssh] ssh connection to ubuntu@myinstanceipaddress successfully created
2023-08-18 09:59:25,347 1935344 ERROR [tempest.lib.common.utils.linux.remote_client] (TestShelveInstance:test_shelve_volume_backed_instance) Executing command on myinstanceipaddress failed. Error: Command 'set -eu -o pipefail; PATH=$PATH:/sbin:/usr/sbin; sudo cat /tmp/timestamp', exit status: 1, stderr:
cat: /tmp/timestamp: No such file or directory
stdout:
2023-08-18 09:59:25,455 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:_run_cleanups): 204 DELETE https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.107s
2023-08-18 09:59:25,583 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:_run_cleanups): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.127s
2023-08-18 09:59:26,664 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:_run_cleanups): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.073s
2023-08-18 09:59:27,707 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:_run_cleanups): 404 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.036s
2023-08-18 09:59:27,786 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:_run_cleanups): 204 DELETE https://myurl.com:9696/v2.0/security-groups/700544d4-94a6-47b7-a81f-8013b1dfa8f8 0.079s
2023-08-18 09:59:27,822 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:_run_cleanups): 202 DELETE https://myurl.com:8774/v2.1/os-keypairs/tempest-TestShelveInstance-1571633657 0.036s
==============================
Failed 1 tests - output below:
==============================
tempest.scenario.test_shelve_instance.TestShelveInstance.test_shelve_volume_backed_instance[compute,id-c1b6318c-b9da-490b-9c67-9339b627271f,image,network,slow,volume]
----------------------------------------------------------------------------------------------------------------------------------------------------------------------
Captured traceback:
~~~~~~~~~~~~~~~~~~~
Traceback (most recent call last):
File "/opt/venv/tempest/lib/python3.8/site-packages/tempest/common/utils/__init__.py", line 70, in wrapper
return f(*func_args, **func_kwargs)
File "/opt/venv/tempest/lib/python3.8/site-packages/tempest/scenario/test_shelve_instance.py", line 120, in test_shelve_volume_backed_instance
self._create_server_then_shelve_and_unshelve(boot_from_volume=True)
File "/opt/venv/tempest/lib/python3.8/site-packages/tempest/scenario/test_shelve_instance.py", line 101, in _create_server_then_shelve_and_unshelve
timestamp2 = self.get_timestamp(instance_ip,
File "/opt/venv/tempest/lib/python3.8/site-packages/tempest/scenario/manager.py", line 1163, in get_timestamp
timestamp = ssh_client.exec_command('sudo cat %s/timestamp'
File "/opt/venv/tempest/lib/python3.8/site-packages/tempest/lib/common/utils/linux/remote_client.py", line 31, in wrapper
return function(self, *args, **kwargs)
File "/opt/venv/tempest/lib/python3.8/site-packages/tempest/lib/common/utils/linux/remote_client.py", line 115, in exec_command
return self.ssh_client.exec_command(cmd)
File "/opt/venv/tempest/lib/python3.8/site-packages/tempest/lib/common/ssh.py", line 238, in exec_command
raise exceptions.SSHExecCommandFailed(
tempest.lib.exceptions.SSHExecCommandFailed: Command 'set -eu -o pipefail; PATH=$PATH:/sbin:/usr/sbin; sudo cat /tmp/timestamp', exit status: 1, stderr:
cat: /tmp/timestamp: No such file or directory
stdout:
Captured pythonlogging:
~~~~~~~~~~~~~~~~~~~~~~~
2023-08-18 09:58:32,846 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 POST https://myurl.com:8774/v2.1/os-keypairs 0.207s
2023-08-18 09:58:33,128 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 201 POST https://myurl.com:9696/v2.0/security-groups 0.281s
2023-08-18 09:58:33,243 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 201 POST https://myurl.com:9696/v2.0/security-group-rules 0.114s
2023-08-18 09:58:33,355 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 201 POST https://myurl.com:9696/v2.0/security-group-rules 0.112s
2023-08-18 09:58:33,435 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 201 POST https://myurl.com:9696/v2.0/security-group-rules 0.081s
2023-08-18 09:58:33,529 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 201 POST https://myurl.com:9696/v2.0/security-group-rules 0.093s
2023-08-18 09:58:33,636 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 201 POST https://myurl.com:9696/v2.0/security-group-rules 0.107s
2023-08-18 09:58:33,717 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 201 POST https://myurl.com:9696/v2.0/security-group-rules 0.081s
2023-08-18 09:58:34,063 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 201 POST https://myurl.com:5000/v3/auth/tokens 0.343s
2023-08-18 09:58:34,240 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:9696/v2.0/networks 0.177s
2023-08-18 09:58:34,240 1935344 INFO [tempest.lib.common.fixed_network] (TestShelveInstance:test_shelve_volume_backed_instance) Found network {'id': '8ab536e2-17ff-41cb-abfe-7acf0c4081f4', 'name': 'tempest-bgp-net', 'tenant_id': 'd14aee1cdd6d44c8b87ee19d3a097323', 'admin_state_up': True, 'mtu': 1450, 'status': 'ACTIVE', 'subnets': ['da75e700-6462-4a1c-90c6-fc102ae77766'], 'shared': True, 'availability_zone_hints': [], 'availability_zones': ['nova'], 'ipv4_address_scope': '51360fb5-a536-47f2-8bc2-e2937f933af9', 'ipv6_address_scope': None, 'router:external': False, 'description': '', 'port_security_enabled': True, 'dns_domain': '', 'tags': [], 'created_at': '2023-08-17T10:27:46Z', 'updated_at': '2023-08-17T10:30:58Z', 'revision_number': 4, 'project_id': 'd14aee1cdd6d44c8b87ee19d3a097323', 'provider:network_type': 'vxlan', 'provider:physical_network': None, 'provider:segmentation_id': 868} available for tenant
2023-08-18 09:58:34,547 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 202 POST https://myurl.com:8776/v3/7f9af036b539495cab471bde8e98b74d/volumes 0.306s
2023-08-18 09:58:34,602 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8776/v3/7f9af036b539495cab471bde8e98b74d/volumes/7f7241e2-f599-4358-8ee5-66f13513ea42 0.049s
2023-08-18 09:58:35,645 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8776/v3/7f9af036b539495cab471bde8e98b74d/volumes/7f7241e2-f599-4358-8ee5-66f13513ea42 0.035s
2023-08-18 09:58:35,651 1935344 INFO [tempest.common.waiters] volume 7f7241e2-f599-4358-8ee5-66f13513ea42 reached available after waiting for 1.651414 seconds
2023-08-18 09:58:36,473 1935344 IN
FO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 202 POST https://myurl.com:8774/v2.1/servers 0.822s
2023-08-18 09:58:36,628 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.153s
2023-08-18 09:58:37,809 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.173s
2023-08-18 09:58:37,815 1935344 INFO [tempest.common.waiters] State transition "BUILD/scheduling" ==> "BUILD/None" after 1 second wait
2023-08-18 09:58:39,020 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.204s
2023-08-18 09:58:39,026 1935344 INFO [tempest.common.waiters] State transition "BUILD/None" ==> "BUILD/block_device_mapping" after 3 second wait
2023-08-18 09:58:40,222 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.194s
2023-08-18 09:58:40,228 1935344 INFO [tempest.common.waiters] State transition "BUILD/block_device_mapping" ==> "BUILD/spawning" after 4 second wait
2023-08-18 09:58:41,381 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.152s
2023-08-18 09:58:41,388 1935344 INFO [tempest.common.waiters] State transition "BUILD/spawning" ==> "ACTIVE/None" after 5 second wait
2023-08-18 09:58:41,588 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.200s
2023-08-18 09:58:41,595 1935344 INFO [tempest.lib.common.ssh] Creating ssh connection to 'myinstanceipaddress:22' as 'ubuntu' with public key authentication
2023-08-18 09:58:48,705 1935344 WARNING [tempest.lib.common.ssh] Failed to establish authenticated ssh connection to ubuntu@myinstanceipaddress ([Errno None] Unable to connect to port 22 on myinstanceipaddress). Number attempts: 1. Retry after 2 seconds.
2023-08-18 09:58:51,209 1935344 WARNING [tempest.lib.common.ssh] Failed to establish authenticated ssh connection to ubuntu@myinstanceipaddress ([Errno None] Unable to connect to port 22 on myinstanceipaddress). Number attempts: 2. Retry after 3 seconds.
2023-08-18 09:58:54,731 1935344 INFO [paramiko.transport] Connected (version 2.0, client OpenSSH_8.2p1)
2023-08-18 09:58:54,774 1935344 INFO [paramiko.transport] Authentication (publickey) successful!
2023-08-18 09:58:54,774 1935344 INFO [tempest.lib.common.ssh] ssh connection to ubuntu@myinstanceipaddress successfully created
2023-08-18 09:58:54,775 1935344 INFO [tempest.lib.common.ssh] Creating ssh connection to 'myinstanceipaddress:22' as 'ubuntu' with public key authentication
2023-08-18 09:58:54,783 1935344 INFO [paramiko.transport] Connected (version 2.0, client OpenSSH_8.2p1)
2023-08-18 09:58:54,822 1935344 INFO [paramiko.transport] Authentication (publickey) successful!
2023-08-18 09:58:54,822 1935344 INFO [tempest.lib.common.ssh] ssh connection to ubuntu@myinstanceipaddress successfully created
2023-08-18 09:58:56,115 1935344 INFO [tempest.lib.common.ssh] Creating ssh connection to 'myinstanceipaddress:22' as 'ubuntu' with public key authentication
2023-08-18 09:58:56,123 1935344 INFO [paramiko.transport] Connected (version 2.0, client OpenSSH_8.2p1)
2023-08-18 09:58:56,167 1935344 INFO [paramiko.transport] Authentication (publickey) successful!
2023-08-18 09:58:56,167 1935344 INFO [tempest
.lib.common.ssh] ssh connection to ubuntu@myinstanceipaddress successfully created
2023-08-18 09:58:56,521 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 202 POST https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa/action 0.094s
2023-08-18 09:58:56,666 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.145s
2023-08-18 09:58:57,830 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.132s
2023-08-18 09:58:58,987 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.149s
2023-08-18 09:59:00,111 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.117s
2023-08-18 09:59:01,250 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.132s
2023-08-18 09:59:02,387 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.129s
2023-08-18 09:59:03,526 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.131s
2023-08-18 09:59:03,532 1935344 INFO [tempest.common.waiters] State transition "ACTIVE/shelving" ==> "SHELVED_OFFLOADED/None" after 7 second wait
2023-08-18 09:59:04,037 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 202 POST https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa/action 0.505s
2023-08-18 09:59:04,291 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.254s
2023-08-18 09:59:05,406 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.107s
2023-08-18 09:59:06,553 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.140s
2023-08-18 09:59:06,559 1935344 INFO [tempest.common.waiters] State transition "SHELVED_OFFLOADED/unshelving" ==> "SHELVED_OFFLOADED/spawning" after 2 second wait
2023-08-18 09:59:07,697 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.136s
2023-08-18 09:59:08,946 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:test_shelve_volume_backed_instance): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.241s
2023-08-18 09:59:08,952 1935344 INFO [tempest.common.waiters] State transition "SHELVED_OFFLOADED/spawning" ==> "ACTIVE/None" after 4 second wait
2023-08-18 09:59:08,953 1935344 INFO [tempest.lib.common.ssh] Creating ssh connection to 'myinstanceipaddress:
22' as 'ubuntu' with public key authentication
2023-08-18 09:59:24,308 1935344 INFO [paramiko.transport] Connected (version 2.0, client OpenSSH_8.2p1)
2023-08-18 09:59:24,351 1935344 INFO [paramiko.transport] Authentication (publickey) successful!
2023-08-18 09:59:24,351 1935344 INFO [tempest.lib.common.ssh] ssh connection to ubuntu@myinstanceipaddress successfully created
2023-08-18 09:59:24,351 1935344 INFO [tempest.lib.common.ssh] Creating ssh connection to 'myinstanceipaddress:22' as 'ubuntu' with public key authentication
2023-08-18 09:59:24,362 1935344 INFO [paramiko.transport] Connected (version 2.0, client OpenSSH_8.2p1)
2023-08-18 09:59:24,404 1935344 INFO [paramiko.transport] Authentication (publickey) successful!
2023-08-18 09:59:24,404 1935344 INFO [tempest.lib.common.ssh] ssh connection to ubuntu@myinstanceipaddress successfully created
2023-08-18 09:59:25,347 1935344 ERROR [tempest.lib.common.utils.linux.remote_client] (TestShelveInstance:test_shelve_volume_backed_instance) Executing command on myinstanceipaddress failed. Error: Command 'set -eu -o pipefail; PATH=$PATH:/sbin:/usr/sbin; sudo cat /tmp/timestamp', exit status: 1, stderr:
cat: /tmp/timestamp: No such file or directory
stdout:
2023-08-18 09:59:25,455 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:_run_cleanups): 204 DELETE https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.107s
2023-08-18 09:59:25,583 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:_run_cleanups): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.127s
2023-08-18 09:59:26,664 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:_run_cleanups): 200 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.073s
2023-08-18 09:59:27,707 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:_run_cleanups): 404 GET https://myurl.com:8774/v2.1/servers/b1564dd8-73b5-486a-ad1b-ebc4e9e0c3aa 0.036s
2023-08-18 09:59:27,786 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:_run_cleanups): 204 DELETE https://myurl.com:9696/v2.0/security-groups/700544d4-94a6-47b7-a81f-8013b1dfa8f8 0.079s
2023-08-18 09:59:27,822 1935344 INFO [tempest.lib.common.rest_client] Request (TestShelveInstance:_run_cleanups): 202 DELETE https://myurl.com:8774/v2.1/os-keypairs/tempest-TestShelveInstance-1571633657 0.036s
======
Totals
======
Ran: 1 tests in 55.1850 sec.
- Passed: 0
- Skipped: 0
- Expected Fail: 0
- Unexpected Success: 0
- Failed: 1
Sum of execute time for each test: 55.1850 sec.
==============
Worker Balance
==============
- Worker 0 (1 tests) => 0:00:55.185040
No tests were successful during the run