neutron

tempest.scenario.test_snapshot_pattern.TestSnapshotPattern.test_snapshot_pattern failing on Jenkins

Bug #1404848 reported by Fawad Khaliq on 2014-12-22

6

This bug affects 1 person

Affects		Status	Importance	Assigned to	Milestone
	OpenStack Compute (nova)	Invalid	Undecided	Unassigned
	neutron	Expired	Undecided	Unassigned

Bug Description

tempest.scenario.test_snapshot_pattern.TestSnapshotPattern.test_snapshot_pattern failing on Jenkins.

Here's the traceback:

2014-12-22 10:19:41.732 |
2014-12-22 10:19:41.732 | Traceback (most recent call last):
2014-12-22 10:19:41.732 | File "tempest/test.py", line 112, in wrapper
2014-12-22 10:19:41.732 | return f(self, *func_args, **func_kwargs)
2014-12-22 10:19:41.732 | File "tempest/scenario/test_snapshot_pattern.py", line 69, in test_snapshot_pattern
2014-12-22 10:19:41.732 | server = self._boot_image(CONF.compute.image_ref)
2014-12-22 10:19:41.732 | File "tempest/scenario/test_snapshot_pattern.py", line 45, in _boot_image
2014-12-22 10:19:41.733 | return self.create_server(image=image_id, create_kwargs=create_kwargs)
2014-12-22 10:19:41.733 | File "tempest/scenario/manager.py", line 209, in create_server
2014-12-22 10:19:41.733 | status='ACTIVE')
2014-12-22 10:19:41.733 | File "tempest/services/compute/json/servers_client.py", line 183, in wait_for_server_status
2014-12-22 10:19:41.733 | ready_wait=ready_wait)
2014-12-22 10:19:41.733 | File "tempest/common/waiters.py", line 66, in wait_for_server_status
2014-12-22 10:19:41.733 | resp, body = client.get_server(server_id)
2014-12-22 10:19:41.733 | File "tempest/services/compute/json/servers_client.py", line 142, in get_server
2014-12-22 10:19:41.733 | resp, body = self.get("servers/%s" % str(server_id))
2014-12-22 10:19:41.733 | File "tempest/common/rest_client.py", line 239, in get
2014-12-22 10:19:41.733 | return self.request('GET', url, extra_headers, headers)
2014-12-22 10:19:41.734 | File "tempest/common/rest_client.py", line 450, in request
2014-12-22 10:19:41.734 | resp, resp_body)
2014-12-22 10:19:41.734 | File "tempest/common/rest_client.py", line 547, in _error_checker
2014-12-22 10:19:41.734 | raise exceptions.ServerFault(message)
2014-12-22 10:19:41.734 | ServerFault: Got server fault
2014-12-22 10:19:41.734 | Details: The server has either erred or is incapable of performing the requested operation.
201

Revision history for this message

Fawad Khaliq (fawadkhaliq) wrote on 2014-12-22:

#1

Download full text (87.3 KiB)

2014-12-22 10:19:31.465 | {2} tempest.scenario.test_snapshot_pattern.TestSnapshotPattern.test_snapshot_pattern [103.813929s] ... FAILED
2014-12-22 10:19:38.646 | {2} tempest.scenario.test_volume_boot_pattern.TestVolumeBootPatternV2.test_volume_boot_pattern ... SKIPPED: Skipped until Bug: 1373513 is resolved.
2014-12-22 10:19:41.639 |
2014-12-22 10:19:41.640 | ==============================
2014-12-22 10:19:41.640 | Failed 1 tests - output below:
2014-12-22 10:19:41.640 | ==============================
2014-12-22 10:19:41.640 |
2014-12-22 10:19:41.640 | tempest.scenario.test_snapshot_pattern.TestSnapshotPattern.test_snapshot_pattern[compute,image,network]
2014-12-22 10:19:41.640 | -------------------------------------------------------------------------------------------------------
2014-12-22 10:19:41.640 |
2014-12-22 10:19:41.640 | Captured traceback:
2014-12-22 10:19:41.640 | ~~~~~~~~~~~~~~~~~~~
2014-12-22 10:19:41.640 | Traceback (most recent call last):
2014-12-22 10:19:41.640 | _StringException: Empty attachments:
2014-12-22 10:19:41.641 | stderr
2014-12-22 10:19:41.641 | stdout
2014-12-22 10:19:41.641 |
2014-12-22 10:19:41.641 | pythonlogging:'': {{{
2014-12-22 10:19:41.641 | 2014-12-22 10:17:47,722 5288 DEBUG [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 POST http://127.0.0.1:5000/v2.0/tokens
2014-12-22 10:19:41.641 | Request - Headers: {}
2014-12-22 10:19:41.641 | Body: None
2014-12-22 10:19:41.641 | Response - Headers: {'vary': 'X-Auth-Token', 'connection': 'close', 'content-length': '4803', 'status': '200', 'date': 'Mon, 22 Dec 2014 10:17:47 GMT', 'content-type': 'application/json'}
2014-12-22 10:19:41.641 | Body: None
2014-12-22 10:19:41.641 | 2014-12-22 10:17:48,434 5288 DEBUG [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 POST http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/os-keypairs 0.711s
2014-12-22 10:19:41.641 | Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.642 | Body: {"keypair": {"name": "TestSnapshotPattern-1934688003"}}
2014-12-22 10:19:41.642 | Response - Headers: {'connection': 'close', 'content-length': '2311', 'status': '200', 'x-compute-request-id': 'req-07e2a75a-d6e8-4b0f-bd87-8a94266a0e5a', 'date': 'Mon, 22 Dec 2014 10:17:48 GMT', 'content-type': 'application/json'}
2014-12-22 10:19:41.642 | Body: {"keypair": {"public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDJ2iUH/Ealvq1EOrI9w2Epsr3bfMlmeCOgXAy1VJqdnFSPL8V0vYN4BtjvlYR0XX0g0PU6K7q5yHHXAn42syzQfFLDp0DMo15RXRZ8qsL0j25FpMPx/uudAaHEeGw4l6Jnp8CE3A15Q365nkWXC6qA3gGlIKIzSFAGwdRMdsv4Usb5D9vMhnFJdoTZBi+rjla4joQQj+X8u1UNbn0248PG831s+3drC66Un9rLgGePWctbR5RjutdgoVeQB+hcDSX2QLyLcdR36LuBxqiLNBiey3muw7g8+W2nujpiWMmEoGzz+3RW44vFm12EQ7oCWKzza8Rz11ld6Hf65PsKzSrf Generated-by-Nova\n", "private_key": "-----BEGIN RSA PRIVATE KEY-----\nMIIEpQIBAAKCAQEAydolB/xGpb6tRDqyPcNhKbK923zJZngjoFwMtVSanZxUjy/F\ndL2DeAbY75WEdF19IND1Oiu6uchx1wJ+NrMs0HxSw6dAzKNeUV0WfKrC9I9uRaTD\n8f7rnQGhxHhsOJeiZ...

2014-12-22 10:19:31.465 | {2} tempest.scenario.test_snapshot_pattern.TestSnapshotPattern.test_snapshot_pattern [103.813929s] ... FAILED
2014-12-22 10:19:38.646 | {2} tempest.scenario.test_volume_boot_pattern.TestVolumeBootPatternV2.test_volume_boot_pattern ... SKIPPED: Skipped until Bug: 1373513 is resolved.
2014-12-22 10:19:41.639 | 
2014-12-22 10:19:41.640 | ==============================
2014-12-22 10:19:41.640 | Failed 1 tests - output below:
2014-12-22 10:19:41.640 | ==============================
2014-12-22 10:19:41.640 | 
2014-12-22 10:19:41.640 | tempest.scenario.test_snapshot_pattern.TestSnapshotPattern.test_snapshot_pattern[compute,image,network]
2014-12-22 10:19:41.640 | -------------------------------------------------------------------------------------------------------
2014-12-22 10:19:41.640 | 
2014-12-22 10:19:41.640 | Captured traceback:
2014-12-22 10:19:41.640 | ~~~~~~~~~~~~~~~~~~~
2014-12-22 10:19:41.640 |     Traceback (most recent call last):
2014-12-22 10:19:41.640 |     _StringException: Empty attachments:
2014-12-22 10:19:41.641 |       stderr
2014-12-22 10:19:41.641 |       stdout
2014-12-22 10:19:41.641 |     
2014-12-22 10:19:41.641 |     pythonlogging:'': {{{
2014-12-22 10:19:41.641 |     2014-12-22 10:17:47,722 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 POST http://127.0.0.1:5000/v2.0/tokens
2014-12-22 10:19:41.641 |         Request - Headers: {}
2014-12-22 10:19:41.641 |             Body: None
2014-12-22 10:19:41.641 |         Response - Headers: {'vary': 'X-Auth-Token', 'connection': 'close', 'content-length': '4803', 'status': '200', 'date': 'Mon, 22 Dec 2014 10:17:47 GMT', 'content-type': 'application/json'}
2014-12-22 10:19:41.641 |             Body: None
2014-12-22 10:19:41.641 |     2014-12-22 10:17:48,434 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 POST http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/os-keypairs 0.711s
2014-12-22 10:19:41.641 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.642 |             Body: {"keypair": {"name": "TestSnapshotPattern-1934688003"}}
2014-12-22 10:19:41.642 |         Response - Headers: {'connection': 'close', 'content-length': '2311', 'status': '200', 'x-compute-request-id': 'req-07e2a75a-d6e8-4b0f-bd87-8a94266a0e5a', 'date': 'Mon, 22 Dec 2014 10:17:48 GMT', 'content-type': 'application/json'}
2014-12-22 10:19:41.642 |             Body: {"keypair": {"public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDJ2iUH/Ealvq1EOrI9w2Epsr3bfMlmeCOgXAy1VJqdnFSPL8V0vYN4BtjvlYR0XX0g0PU6K7q5yHHXAn42syzQfFLDp0DMo15RXRZ8qsL0j25FpMPx/uudAaHEeGw4l6Jnp8CE3A15Q365nkWXC6qA3gGlIKIzSFAGwdRMdsv4Usb5D9vMhnFJdoTZBi+rjla4joQQj+X8u1UNbn0248PG831s+3drC66Un9rLgGePWctbR5RjutdgoVeQB+hcDSX2QLyLcdR36LuBxqiLNBiey3muw7g8+W2nujpiWMmEoGzz+3RW44vFm12EQ7oCWKzza8Rz11ld6Hf65PsKzSrf Generated-by-Nova\n", "private_key": "-----BEGIN RSA PRIVATE KEY-----\nMIIEpQIBAAKCAQEAydolB/xGpb6tRDqyPcNhKbK923zJZngjoFwMtVSanZxUjy/F\ndL2DeAbY75WEdF19IND1Oiu6uchx1wJ+NrMs0HxSw6dAzKNeUV0WfKrC9I9uRaTD\n8f7rnQGhxHhsOJeiZ6fAhNwNeUN+uZ5FlwuqgN4BpSCiM0hQBsHUTHbL+FLG+Q/b\nzIZxSXaE2QYvq45WuI6EEI/l/LtVDW59NuPDxvN9bPt3awuulJ/ay4Bnj1nLW0eU\nY7rXYKFXkAfoXA0l9kC8i3HUd+i7gcaoizQYnst5rsO4PPltp7o6YljJhKBs8/t0\nVuOLxZtdhEO6Alis82vEc9dZXeh3+uT7Cs0q3wIDAQABAoIBAHnUCxO1xOIWorcS\ngi/a85LaSdLmjxwkmMQZqqXrCWLlTvgZCiE6nNXdtCNuZ8JgBry+wbO5Xvrwqxzt\naUYUgJDY6I8kLG0WkT+kYoUd/4rh4tlv57/wbz6VFJDjadYCV0gerIjD0/IDtcHM\ncA4JQYCD/hQvDRbMp1hctojsDpGyODEURhlChrMVzTgk1stJrgO3uAdIqhC5nd9S\nQ66/x81PajhYrEfJNyZDYMvsHY/ZzZBrS0S5ir3GUzXw07RB58VdT492z/JBJ8RT\n6QDmO6KNMw+uFgeSpUTN+/cOVd77Za9VSPhJNEWgR8wbXq2Z0LiQ8joniQ+z8b5q\nuZHFX0kCgYEA/pauwZwzOuwhHDwmTftS8GiGaxRbTJFWeEzWpkpJ+cj5nSKJTiJi\nQ3clBfca52s66j9v/lGfXJnJ3VSQd+b2HZ8rS0QSw1mfnTcu8nmPE4sT58Eu4vDP\n8fEW5EwMXtpZhVrhsJrDjLZYqp4O/CAZSIvAUzHjtnuxCM6GK4GXZN0CgYEAyvie\nCPhEWlhO4F1VAXwJ61Q/Ixt8lCEd7OGFk1ZHb4uYUfrBw0g5ltFGagvSwfshjlmP\nX6duOkMDWewenQXlpQGTPUB4RCSj9Y2woFMA+h8OnU59/tFOX+t0Uz05w8ulFl95\nYUXKL9pmbzm54pfZSa+iT89Gnm3rzlklqBKupOsCgYEAjuSkUacKWhgOvXpFRZ+6\nfZUtXQyf8enhTsRR9iPcQYa8E6Y+yswhuxw0e5SmVR2qg6/3fBb0C1WGJ+Q+8g2A\nNkAQXL5oiZzUKbm/b/kqhR2anomfd2ESVgmrf5fvmY2UkXThF+7Fs0Tln133qyuZ\nBU7rM8bcuJ/UTc0dIW4rO0ECgYEAx3PyUFwvRxx6Pi5ZB0FtuewqswQisqmsb4fa\nLEPfpPRndT/VwmGp/dOevzzpGaf/fJPzuQqd3fDWTTojhygxV6mpl8pPpJ7g478d\nrx6B2khEoz5rv8jMnKOSxu1mY0ot60Nc0sKzAb07ZdczHEEdzDQkawsDmVHpI/gk\ncfoR1osCgYEAohN97lYRw+YWAkpT9tzbD9IwrvooENun8kdccssn4NcuJ8auidOn\n63lZw00f7C3nOcsmFGBekOj4FyrcyHXFNZbIkC+TuwMrYvAA2zWhboRONLiDpqJS\nD4957d8M2km8wSUbdH2H4E7bwFYOkOP/dKd0lD4pgyHZgg2vfJLybKs=\n-----END RSA PRIVATE KEY-----\n", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1934688003", "fingerprint": "e4:90:14:c9:2c:b7:43:0e:08:6b:88:20:5a:10:28:3d"}}
2014-12-22 10:19:41.642 |     2014-12-22 10:17:48,978 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 POST http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/os-security-groups 0.541s
2014-12-22 10:19:41.642 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.642 |             Body: {"security_group": {"description": "TestSnapshotPattern-907887027 description", "name": "TestSnapshotPattern-907887027"}}
2014-12-22 10:19:41.642 |         Response - Headers: {'connection': 'close', 'content-length': '229', 'status': '200', 'x-compute-request-id': 'req-a9b7ea14-7c5c-4a70-a0a0-1be2ccecc805', 'date': 'Mon, 22 Dec 2014 10:17:48 GMT', 'content-type': 'application/json'}
2014-12-22 10:19:41.642 |             Body: {"security_group": {"rules": [], "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "id": "5b30a96e-57fc-4b76-adfd-0391eee58fc0", "name": "TestSnapshotPattern-907887027", "description": "TestSnapshotPattern-907887027 description"}}
2014-12-22 10:19:41.643 |     2014-12-22 10:17:49,281 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 POST http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/os-security-group-rules 0.296s
2014-12-22 10:19:41.643 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.643 |             Body: {"security_group_rule": {"ip_protocol": "tcp", "to_port": 22, "cidr": "0.0.0.0/0", "from_port": 22, "parent_group_id": "5b30a96e-57fc-4b76-adfd-0391eee58fc0", "group_id": null}}
2014-12-22 10:19:41.643 |         Response - Headers: {'connection': 'close', 'content-length': '232', 'status': '200', 'x-compute-request-id': 'req-96e3bcdb-b682-4c4f-826e-d74bc37092e1', 'date': 'Mon, 22 Dec 2014 10:17:49 GMT', 'content-type': 'application/json'}
2014-12-22 10:19:41.643 |             Body: {"security_group_rule": {"from_port": 22, "group": {}, "ip_protocol": "tcp", "to_port": 22, "parent_group_id": "5b30a96e-57fc-4b76-adfd-0391eee58fc0", "ip_range": {"cidr": "0.0.0.0/0"}, "id": "3cb72e34-ba2f-43d4-b36a-b47bedbecdfc"}}
2014-12-22 10:19:41.643 |     2014-12-22 10:17:49,350 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 POST http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/os-security-group-rules 0.063s
2014-12-22 10:19:41.643 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.643 |             Body: {"security_group_rule": {"ip_protocol": "icmp", "to_port": -1, "cidr": "0.0.0.0/0", "from_port": -1, "parent_group_id": "5b30a96e-57fc-4b76-adfd-0391eee58fc0", "group_id": null}}
2014-12-22 10:19:41.643 |         Response - Headers: {'connection': 'close', 'content-length': '233', 'status': '200', 'x-compute-request-id': 'req-f9fd3331-53cc-4263-964a-af888cafcb3e', 'date': 'Mon, 22 Dec 2014 10:17:49 GMT', 'content-type': 'application/json'}
2014-12-22 10:19:41.643 |             Body: {"security_group_rule": {"from_port": -1, "group": {}, "ip_protocol": "icmp", "to_port": -1, "parent_group_id": "5b30a96e-57fc-4b76-adfd-0391eee58fc0", "ip_range": {"cidr": "0.0.0.0/0"}, "id": "9c123846-5376-47d1-97d3-02b6985a2ba2"}}
2014-12-22 10:19:41.644 |     2014-12-22 10:17:49,354 5288 DEBUG    [tempest.scenario.manager] Creating a server (name: TestSnapshotPattern-1936364961, image: 5ca1c666-b7d9-41a6-9b6e-4b8768df6b37, flavor: 42)
2014-12-22 10:19:41.644 |     2014-12-22 10:17:51,293 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 202 POST http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers 1.938s
2014-12-22 10:19:41.644 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.644 |             Body: {"server": {"imageRef": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "flavorRef": "42", "key_name": "TestSnapshotPattern-1934688003", "name": "TestSnapshotPattern-1936364961", "security_groups": [{"name": "TestSnapshotPattern-907887027"}]}}
2014-12-22 10:19:41.644 |         Response - Headers: {'connection': 'close', 'location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-length': '456', 'status': '202', 'x-compute-request-id': 'req-2640fef3-980e-4218-9084-a712caef9cb9', 'date': 'Mon, 22 Dec 2014 10:17:51 GMT', 'content-type': 'application/json'}
2014-12-22 10:19:41.677 |             Body: {"server": {"security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-DCF:diskConfig": "MANUAL", "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "adminPass": "zz3N7MsxoDA9"}}
2014-12-22 10:19:41.677 |     2014-12-22 10:17:51,372 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.075s
2014-12-22 10:19:41.677 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.677 |             Body: None
2014-12-22 10:19:41.677 |         Response - Headers: {'connection': 'close', 'content-length': '1338', 'status': '200', 'x-compute-request-id': 'req-599b1150-0bd3-4025-99de-c0c34f72812a', 'date': 'Mon, 22 Dec 2014 10:17:51 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.677 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:51Z", "hostId": "", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "scheduling", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.677 |     2014-12-22 10:17:52,630 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.205s
2014-12-22 10:19:41.678 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.678 |             Body: None
2014-12-22 10:19:41.678 |         Response - Headers: {'connection': 'close', 'content-length': '1468', 'status': '200', 'x-compute-request-id': 'req-b3f41bb9-597d-47d8-9bf3-9ed48754b225', 'date': 'Mon, 22 Dec 2014 10:17:52 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.678 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "block_device_mapping", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.678 |     2014-12-22 10:17:52,644 5288 INFO     [tempest.common.waiters] State transition "BUILD/scheduling" ==> "BUILD/block_device_mapping" after 1 second wait
2014-12-22 10:19:41.678 |     2014-12-22 10:17:53,836 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.190s
2014-12-22 10:19:41.678 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.678 |             Body: None
2014-12-22 10:19:41.679 |         Response - Headers: {'connection': 'close', 'content-length': '1456', 'status': '200', 'x-compute-request-id': 'req-986c3715-840b-4297-b1dc-bc5f9cc1ae9e', 'date': 'Mon, 22 Dec 2014 10:17:53 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.679 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.679 |     2014-12-22 10:17:53,851 5288 INFO     [tempest.common.waiters] State transition "BUILD/block_device_mapping" ==> "BUILD/spawning" after 2 second wait
2014-12-22 10:19:41.679 |     2014-12-22 10:17:55,022 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.169s
2014-12-22 10:19:41.679 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.679 |             Body: None
2014-12-22 10:19:41.679 |         Response - Headers: {'connection': 'close', 'content-length': '1456', 'status': '200', 'x-compute-request-id': 'req-ed167783-df38-487e-8605-8b3149a914d3', 'date': 'Mon, 22 Dec 2014 10:17:55 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.679 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.680 |     2014-12-22 10:17:56,446 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.409s
2014-12-22 10:19:41.680 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.680 |             Body: None
2014-12-22 10:19:41.680 |         Response - Headers: {'connection': 'close', 'content-length': '1460', 'status': '200', 'x-compute-request-id': 'req-e7a2cc32-073e-49da-8347-b0f98913589c', 'date': 'Mon, 22 Dec 2014 10:17:56 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.680 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "foo_zone", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.680 |     2014-12-22 10:17:57,560 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.099s
2014-12-22 10:19:41.680 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.680 |             Body: None
2014-12-22 10:19:41.681 |         Response - Headers: {'connection': 'close', 'content-length': '1456', 'status': '200', 'x-compute-request-id': 'req-0eefa9cc-2174-4dc9-af39-9a15b562b267', 'date': 'Mon, 22 Dec 2014 10:17:57 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.681 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.681 |     2014-12-22 10:17:58,661 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.087s
2014-12-22 10:19:41.681 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.681 |             Body: None
2014-12-22 10:19:41.681 |         Response - Headers: {'connection': 'close', 'content-length': '1456', 'status': '200', 'x-compute-request-id': 'req-eb817207-9d50-4a9d-af86-3d14f61aa660', 'date': 'Mon, 22 Dec 2014 10:17:58 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.681 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.681 |     2014-12-22 10:18:00,074 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.396s
2014-12-22 10:19:41.681 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.682 |             Body: None
2014-12-22 10:19:41.682 |         Response - Headers: {'connection': 'close', 'content-length': '1456', 'status': '200', 'x-compute-request-id': 'req-0226c944-1b4f-4943-bdfb-f24bf4642545', 'date': 'Mon, 22 Dec 2014 10:18:00 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.682 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.682 |     2014-12-22 10:18:01,184 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.096s
2014-12-22 10:19:41.682 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.682 |             Body: None
2014-12-22 10:19:41.682 |         Response - Headers: {'connection': 'close', 'content-length': '1456', 'status': '200', 'x-compute-request-id': 'req-9d8e3ef0-bdfd-4c82-b312-a1636f9cdbdc', 'date': 'Mon, 22 Dec 2014 10:18:01 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.683 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.683 |     2014-12-22 10:18:02,280 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.082s
2014-12-22 10:19:41.683 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.683 |             Body: None
2014-12-22 10:19:41.683 |         Response - Headers: {'connection': 'close', 'content-length': '1456', 'status': '200', 'x-compute-request-id': 'req-75f51be9-943e-407c-980f-6dacaebb5dc3', 'date': 'Mon, 22 Dec 2014 10:18:02 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.683 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.683 |     2014-12-22 10:18:03,375 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.078s
2014-12-22 10:19:41.683 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.683 |             Body: None
2014-12-22 10:19:41.683 |         Response - Headers: {'connection': 'close', 'content-length': '1456', 'status': '200', 'x-compute-request-id': 'req-7269e698-f0e2-4a34-9a0b-61de201ba7a4', 'date': 'Mon, 22 Dec 2014 10:18:03 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.684 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.684 |     2014-12-22 10:19:30,261 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 500 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 85.872s
2014-12-22 10:19:41.684 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.684 |             Body: None
2014-12-22 10:19:41.684 |         Response - Headers: {'connection': 'close', 'content-length': '128', 'status': '500', 'x-compute-request-id': 'req-1a525fdf-f745-426c-a2ba-8a0596c372b1', 'date': 'Mon, 22 Dec 2014 10:19:30 GMT', 'content-type': 'application/json; charset=UTF-8'}
2014-12-22 10:19:41.684 |             Body: {"computeFault": {"message": "The server has either erred or is incapable of performing the requested operation.", "code": 500}}
2014-12-22 10:19:41.684 |     2014-12-22 10:19:31,154 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:_run_cleanups): 204 DELETE http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.890s
2014-12-22 10:19:41.684 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.684 |             Body: None
2014-12-22 10:19:41.685 |         Response - Headers: {'connection': 'close', 'content-length': '0', 'status': '204', 'x-compute-request-id': 'req-c2fce0c0-2a16-44d9-bf73-194507ebb6f4', 'date': 'Mon, 22 Dec 2014 10:19:31 GMT', 'content-type': 'application/json'}
2014-12-22 10:19:41.685 |             Body: 
2014-12-22 10:19:41.685 |     2014-12-22 10:19:31,191 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:_run_cleanups): 404 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.036s
2014-12-22 10:19:41.685 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.685 |             Body: None
2014-12-22 10:19:41.685 |         Response - Headers: {'connection': 'close', 'content-length': '111', 'status': '404', 'x-compute-request-id': 'req-a888cb70-00f6-40af-bf4e-da46eb3f110c', 'date': 'Mon, 22 Dec 2014 10:19:31 GMT', 'content-type': 'application/json; charset=UTF-8'}
2014-12-22 10:19:41.685 |             Body: {"itemNotFound": {"message": "Instance 04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 could not be found.", "code": 404}}
2014-12-22 10:19:41.685 |     2014-12-22 10:19:31,246 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:_run_cleanups): 202 DELETE http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/os-security-group-rules/9c123846-5376-47d1-97d3-02b6985a2ba2 0.054s
2014-12-22 10:19:41.685 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.685 |             Body: None
2014-12-22 10:19:41.686 |         Response - Headers: {'connection': 'close', 'content-length': '0', 'status': '202', 'x-compute-request-id': 'req-90160f31-274b-46e2-8fe1-cf2869d66e6d', 'date': 'Mon, 22 Dec 2014 10:19:31 GMT', 'content-type': 'text/html; charset=UTF-8'}
2014-12-22 10:19:41.686 |             Body: 
2014-12-22 10:19:41.686 |     2014-12-22 10:19:31,332 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:_run_cleanups): 202 DELETE http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/os-security-group-rules/3cb72e34-ba2f-43d4-b36a-b47bedbecdfc 0.085s
2014-12-22 10:19:41.686 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.686 |             Body: None
2014-12-22 10:19:41.686 |         Response - Headers: {'connection': 'close', 'content-length': '0', 'status': '202', 'x-compute-request-id': 'req-7fd70395-503d-4210-a66c-8eb989fc45fb', 'date': 'Mon, 22 Dec 2014 10:19:31 GMT', 'content-type': 'text/html; charset=UTF-8'}
2014-12-22 10:19:41.686 |             Body: 
2014-12-22 10:19:41.714 |     2014-12-22 10:19:31,385 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:_run_cleanups): 202 DELETE http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/os-security-groups/5b30a96e-57fc-4b76-adfd-0391eee58fc0 0.052s
2014-12-22 10:19:41.714 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.714 |             Body: None
2014-12-22 10:19:41.714 |         Response - Headers: {'connection': 'close', 'content-length': '0', 'status': '202', 'x-compute-request-id': 'req-1b889217-c8ac-48da-9f6a-015e103e43e2', 'date': 'Mon, 22 Dec 2014 10:19:31 GMT', 'content-type': 'text/html; charset=UTF-8'}
2014-12-22 10:19:41.715 |             Body: 
2014-12-22 10:19:41.715 |     2014-12-22 10:19:31,407 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:_run_cleanups): 202 DELETE http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/os-keypairs/TestSnapshotPattern-1934688003 0.021s
2014-12-22 10:19:41.715 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.715 |             Body: None
2014-12-22 10:19:41.715 |         Response - Headers: {'connection': 'close', 'content-length': '0', 'status': '202', 'x-compute-request-id': 'req-1c748c25-2e79-4760-8d60-fb09f023e1a5', 'date': 'Mon, 22 Dec 2014 10:19:31 GMT', 'content-type': 'text/html; charset=UTF-8'}
2014-12-22 10:19:41.715 |             Body: 
2014-12-22 10:19:41.715 |     2014-12-22 10:19:31,441 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:_run_cleanups): 404 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.033s
2014-12-22 10:19:41.715 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.715 |             Body: None
2014-12-22 10:19:41.715 |         Response - Headers: {'connection': 'close', 'content-length': '111', 'status': '404', 'x-compute-request-id': 'req-659a026a-e9a9-4ec7-b9e8-79ca423e36ae', 'date': 'Mon, 22 Dec 2014 10:19:31 GMT', 'content-type': 'application/json; charset=UTF-8'}
2014-12-22 10:19:41.715 |             Body: {"itemNotFound": {"message": "Instance 04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 could not be found.", "code": 404}}
2014-12-22 10:19:41.716 |     }}}
2014-12-22 10:19:41.716 |     
2014-12-22 10:19:41.716 |     Traceback (most recent call last):
2014-12-22 10:19:41.716 |       File "tempest/test.py", line 112, in wrapper
2014-12-22 10:19:41.716 |         return f(self, *func_args, **func_kwargs)
2014-12-22 10:19:41.716 |       File "tempest/scenario/test_snapshot_pattern.py", line 69, in test_snapshot_pattern
2014-12-22 10:19:41.716 |         server = self._boot_image(CONF.compute.image_ref)
2014-12-22 10:19:41.716 |       File "tempest/scenario/test_snapshot_pattern.py", line 45, in _boot_image
2014-12-22 10:19:41.716 |         return self.create_server(image=image_id, create_kwargs=create_kwargs)
2014-12-22 10:19:41.716 |       File "tempest/scenario/manager.py", line 209, in create_server
2014-12-22 10:19:41.716 |         status='ACTIVE')
2014-12-22 10:19:41.717 |       File "tempest/services/compute/json/servers_client.py", line 183, in wait_for_server_status
2014-12-22 10:19:41.717 |         ready_wait=ready_wait)
2014-12-22 10:19:41.717 |       File "tempest/common/waiters.py", line 66, in wait_for_server_status
2014-12-22 10:19:41.717 |         resp, body = client.get_server(server_id)
2014-12-22 10:19:41.717 |       File "tempest/services/compute/json/servers_client.py", line 142, in get_server
2014-12-22 10:19:41.717 |         resp, body = self.get("servers/%s" % str(server_id))
2014-12-22 10:19:41.717 |       File "tempest/common/rest_client.py", line 239, in get
2014-12-22 10:19:41.717 |         return self.request('GET', url, extra_headers, headers)
2014-12-22 10:19:41.717 |       File "tempest/common/rest_client.py", line 450, in request
2014-12-22 10:19:41.717 |         resp, resp_body)
2014-12-22 10:19:41.717 |       File "tempest/common/rest_client.py", line 547, in _error_checker
2014-12-22 10:19:41.717 |         raise exceptions.ServerFault(message)
2014-12-22 10:19:41.718 |     ServerFault: Got server fault
2014-12-22 10:19:41.718 |     Details: The server has either erred or is incapable of performing the requested operation.
2014-12-22 10:19:41.718 |     
2014-12-22 10:19:41.718 |     Traceback (most recent call last):
2014-12-22 10:19:41.718 |     _StringException: Empty attachments:
2014-12-22 10:19:41.718 |       stderr
2014-12-22 10:19:41.718 |       stdout
2014-12-22 10:19:41.718 |     
2014-12-22 10:19:41.718 |     pythonlogging:'': {{{
2014-12-22 10:19:41.718 |     2014-12-22 10:17:47,722 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 POST http://127.0.0.1:5000/v2.0/tokens
2014-12-22 10:19:41.718 |         Request - Headers: {}
2014-12-22 10:19:41.719 |             Body: None
2014-12-22 10:19:41.719 |         Response - Headers: {'vary': 'X-Auth-Token', 'connection': 'close', 'content-length': '4803', 'status': '200', 'date': 'Mon, 22 Dec 2014 10:17:47 GMT', 'content-type': 'application/json'}
2014-12-22 10:19:41.719 |             Body: None
2014-12-22 10:19:41.719 |     2014-12-22 10:17:48,434 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 POST http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/os-keypairs 0.711s
2014-12-22 10:19:41.719 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.719 |             Body: {"keypair": {"name": "TestSnapshotPattern-1934688003"}}
2014-12-22 10:19:41.719 |         Response - Headers: {'connection': 'close', 'content-length': '2311', 'status': '200', 'x-compute-request-id': 'req-07e2a75a-d6e8-4b0f-bd87-8a94266a0e5a', 'date': 'Mon, 22 Dec 2014 10:17:48 GMT', 'content-type': 'application/json'}
2014-12-22 10:19:41.719 |             Body: {"keypair": {"public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDJ2iUH/Ealvq1EOrI9w2Epsr3bfMlmeCOgXAy1VJqdnFSPL8V0vYN4BtjvlYR0XX0g0PU6K7q5yHHXAn42syzQfFLDp0DMo15RXRZ8qsL0j25FpMPx/uudAaHEeGw4l6Jnp8CE3A15Q365nkWXC6qA3gGlIKIzSFAGwdRMdsv4Usb5D9vMhnFJdoTZBi+rjla4joQQj+X8u1UNbn0248PG831s+3drC66Un9rLgGePWctbR5RjutdgoVeQB+hcDSX2QLyLcdR36LuBxqiLNBiey3muw7g8+W2nujpiWMmEoGzz+3RW44vFm12EQ7oCWKzza8Rz11ld6Hf65PsKzSrf Generated-by-Nova\n", "private_key": "-----BEGIN RSA PRIVATE KEY-----\nMIIEpQIBAAKCAQEAydolB/xGpb6tRDqyPcNhKbK923zJZngjoFwMtVSanZxUjy/F\ndL2DeAbY75WEdF19IND1Oiu6uchx1wJ+NrMs0HxSw6dAzKNeUV0WfKrC9I9uRaTD\n8f7rnQGhxHhsOJeiZ6fAhNwNeUN+uZ5FlwuqgN4BpSCiM0hQBsHUTHbL+FLG+Q/b\nzIZxSXaE2QYvq45WuI6EEI/l/LtVDW59NuPDxvN9bPt3awuulJ/ay4Bnj1nLW0eU\nY7rXYKFXkAfoXA0l9kC8i3HUd+i7gcaoizQYnst5rsO4PPltp7o6YljJhKBs8/t0\nVuOLxZtdhEO6Alis82vEc9dZXeh3+uT7Cs0q3wIDAQABAoIBAHnUCxO1xOIWorcS\ngi/a85LaSdLmjxwkmMQZqqXrCWLlTvgZCiE6nNXdtCNuZ8JgBry+wbO5Xvrwqxzt\naUYUgJDY6I8kLG0WkT+kYoUd/4rh4tlv57/wbz6VFJDjadYCV0gerIjD0/IDtcHM\ncA4JQYCD/hQvDRbMp1hctojsDpGyODEURhlChrMVzTgk1stJrgO3uAdIqhC5nd9S\nQ66/x81PajhYrEfJNyZDYMvsHY/ZzZBrS0S5ir3GUzXw07RB58VdT492z/JBJ8RT\n6QDmO6KNMw+uFgeSpUTN+/cOVd77Za9VSPhJNEWgR8wbXq2Z0LiQ8joniQ+z8b5q\nuZHFX0kCgYEA/pauwZwzOuwhHDwmTftS8GiGaxRbTJFWeEzWpkpJ+cj5nSKJTiJi\nQ3clBfca52s66j9v/lGfXJnJ3VSQd+b2HZ8rS0QSw1mfnTcu8nmPE4sT58Eu4vDP\n8fEW5EwMXtpZhVrhsJrDjLZYqp4O/CAZSIvAUzHjtnuxCM6GK4GXZN0CgYEAyvie\nCPhEWlhO4F1VAXwJ61Q/Ixt8lCEd7OGFk1ZHb4uYUfrBw0g5ltFGagvSwfshjlmP\nX6duOkMDWewenQXlpQGTPUB4RCSj9Y2woFMA+h8OnU59/tFOX+t0Uz05w8ulFl95\nYUXKL9pmbzm54pfZSa+iT89Gnm3rzlklqBKupOsCgYEAjuSkUacKWhgOvXpFRZ+6\nfZUtXQyf8enhTsRR9iPcQYa8E6Y+yswhuxw0e5SmVR2qg6/3fBb0C1WGJ+Q+8g2A\nNkAQXL5oiZzUKbm/b/kqhR2anomfd2ESVgmrf5fvmY2UkXThF+7Fs0Tln133qyuZ\nBU7rM8bcuJ/UTc0dIW4rO0ECgYEAx3PyUFwvRxx6Pi5ZB0FtuewqswQisqmsb4fa\nLEPfpPRndT/VwmGp/dOevzzpGaf/fJPzuQqd3fDWTTojhygxV6mpl8pPpJ7g478d\nrx6B2khEoz5rv8jMnKOSxu1mY0ot60Nc0sKzAb07ZdczHEEdzDQkawsDmVHpI/gk\ncfoR1osCgYEAohN97lYRw+YWAkpT9tzbD9IwrvooENun8kdccssn4NcuJ8auidOn\n63lZw00f7C3nOcsmFGBekOj4FyrcyHXFNZbIkC+TuwMrYvAA2zWhboRONLiDpqJS\nD4957d8M2km8wSUbdH2H4E7bwFYOkOP/dKd0lD4pgyHZgg2vfJLybKs=\n-----END RSA PRIVATE KEY-----\n", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1934688003", "fingerprint": "e4:90:14:c9:2c:b7:43:0e:08:6b:88:20:5a:10:28:3d"}}
2014-12-22 10:19:41.720 |     2014-12-22 10:17:48,978 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 POST http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/os-security-groups 0.541s
2014-12-22 10:19:41.720 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.720 |             Body: {"security_group": {"description": "TestSnapshotPattern-907887027 description", "name": "TestSnapshotPattern-907887027"}}
2014-12-22 10:19:41.720 |         Response - Headers: {'connection': 'close', 'content-length': '229', 'status': '200', 'x-compute-request-id': 'req-a9b7ea14-7c5c-4a70-a0a0-1be2ccecc805', 'date': 'Mon, 22 Dec 2014 10:17:48 GMT', 'content-type': 'application/json'}
2014-12-22 10:19:41.720 |             Body: {"security_group": {"rules": [], "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "id": "5b30a96e-57fc-4b76-adfd-0391eee58fc0", "name": "TestSnapshotPattern-907887027", "description": "TestSnapshotPattern-907887027 description"}}
2014-12-22 10:19:41.720 |     2014-12-22 10:17:49,281 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 POST http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/os-security-group-rules 0.296s
2014-12-22 10:19:41.720 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.720 |             Body: {"security_group_rule": {"ip_protocol": "tcp", "to_port": 22, "cidr": "0.0.0.0/0", "from_port": 22, "parent_group_id": "5b30a96e-57fc-4b76-adfd-0391eee58fc0", "group_id": null}}
2014-12-22 10:19:41.720 |         Response - Headers: {'connection': 'close', 'content-length': '232', 'status': '200', 'x-compute-request-id': 'req-96e3bcdb-b682-4c4f-826e-d74bc37092e1', 'date': 'Mon, 22 Dec 2014 10:17:49 GMT', 'content-type': 'application/json'}
2014-12-22 10:19:41.720 |             Body: {"security_group_rule": {"from_port": 22, "group": {}, "ip_protocol": "tcp", "to_port": 22, "parent_group_id": "5b30a96e-57fc-4b76-adfd-0391eee58fc0", "ip_range": {"cidr": "0.0.0.0/0"}, "id": "3cb72e34-ba2f-43d4-b36a-b47bedbecdfc"}}
2014-12-22 10:19:41.721 |     2014-12-22 10:17:49,350 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 POST http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/os-security-group-rules 0.063s
2014-12-22 10:19:41.721 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.721 |             Body: {"security_group_rule": {"ip_protocol": "icmp", "to_port": -1, "cidr": "0.0.0.0/0", "from_port": -1, "parent_group_id": "5b30a96e-57fc-4b76-adfd-0391eee58fc0", "group_id": null}}
2014-12-22 10:19:41.721 |         Response - Headers: {'connection': 'close', 'content-length': '233', 'status': '200', 'x-compute-request-id': 'req-f9fd3331-53cc-4263-964a-af888cafcb3e', 'date': 'Mon, 22 Dec 2014 10:17:49 GMT', 'content-type': 'application/json'}
2014-12-22 10:19:41.721 |             Body: {"security_group_rule": {"from_port": -1, "group": {}, "ip_protocol": "icmp", "to_port": -1, "parent_group_id": "5b30a96e-57fc-4b76-adfd-0391eee58fc0", "ip_range": {"cidr": "0.0.0.0/0"}, "id": "9c123846-5376-47d1-97d3-02b6985a2ba2"}}
2014-12-22 10:19:41.721 |     2014-12-22 10:17:49,354 5288 DEBUG    [tempest.scenario.manager] Creating a server (name: TestSnapshotPattern-1936364961, image: 5ca1c666-b7d9-41a6-9b6e-4b8768df6b37, flavor: 42)
2014-12-22 10:19:41.721 |     2014-12-22 10:17:51,293 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 202 POST http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers 1.938s
2014-12-22 10:19:41.721 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.721 |             Body: {"server": {"imageRef": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "flavorRef": "42", "key_name": "TestSnapshotPattern-1934688003", "name": "TestSnapshotPattern-1936364961", "security_groups": [{"name": "TestSnapshotPattern-907887027"}]}}
2014-12-22 10:19:41.721 |         Response - Headers: {'connection': 'close', 'location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-length': '456', 'status': '202', 'x-compute-request-id': 'req-2640fef3-980e-4218-9084-a712caef9cb9', 'date': 'Mon, 22 Dec 2014 10:17:51 GMT', 'content-type': 'application/json'}
2014-12-22 10:19:41.722 |             Body: {"server": {"security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-DCF:diskConfig": "MANUAL", "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "adminPass": "zz3N7MsxoDA9"}}
2014-12-22 10:19:41.722 |     2014-12-22 10:17:51,372 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.075s
2014-12-22 10:19:41.722 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.722 |             Body: None
2014-12-22 10:19:41.722 |         Response - Headers: {'connection': 'close', 'content-length': '1338', 'status': '200', 'x-compute-request-id': 'req-599b1150-0bd3-4025-99de-c0c34f72812a', 'date': 'Mon, 22 Dec 2014 10:17:51 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.722 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:51Z", "hostId": "", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "scheduling", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.722 |     2014-12-22 10:17:52,630 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.205s
2014-12-22 10:19:41.722 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.722 |             Body: None
2014-12-22 10:19:41.723 |         Response - Headers: {'connection': 'close', 'content-length': '1468', 'status': '200', 'x-compute-request-id': 'req-b3f41bb9-597d-47d8-9bf3-9ed48754b225', 'date': 'Mon, 22 Dec 2014 10:17:52 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.723 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "block_device_mapping", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.723 |     2014-12-22 10:17:52,644 5288 INFO     [tempest.common.waiters] State transition "BUILD/scheduling" ==> "BUILD/block_device_mapping" after 1 second wait
2014-12-22 10:19:41.723 |     2014-12-22 10:17:53,836 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.190s
2014-12-22 10:19:41.723 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.723 |             Body: None
2014-12-22 10:19:41.723 |         Response - Headers: {'connection': 'close', 'content-length': '1456', 'status': '200', 'x-compute-request-id': 'req-986c3715-840b-4297-b1dc-bc5f9cc1ae9e', 'date': 'Mon, 22 Dec 2014 10:17:53 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.723 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.723 |     2014-12-22 10:17:53,851 5288 INFO     [tempest.common.waiters] State transition "BUILD/block_device_mapping" ==> "BUILD/spawning" after 2 second wait
2014-12-22 10:19:41.724 |     2014-12-22 10:17:55,022 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.169s
2014-12-22 10:19:41.724 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.724 |             Body: None
2014-12-22 10:19:41.724 |         Response - Headers: {'connection': 'close', 'content-length': '1456', 'status': '200', 'x-compute-request-id': 'req-ed167783-df38-487e-8605-8b3149a914d3', 'date': 'Mon, 22 Dec 2014 10:17:55 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.724 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.724 |     2014-12-22 10:17:56,446 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.409s
2014-12-22 10:19:41.724 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.724 |             Body: None
2014-12-22 10:19:41.724 |         Response - Headers: {'connection': 'close', 'content-length': '1460', 'status': '200', 'x-compute-request-id': 'req-e7a2cc32-073e-49da-8347-b0f98913589c', 'date': 'Mon, 22 Dec 2014 10:17:56 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.725 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "foo_zone", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.725 |     2014-12-22 10:17:57,560 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.099s
2014-12-22 10:19:41.725 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.725 |             Body: None
2014-12-22 10:19:41.725 |         Response - Headers: {'connection': 'close', 'content-length': '1456', 'status': '200', 'x-compute-request-id': 'req-0eefa9cc-2174-4dc9-af39-9a15b562b267', 'date': 'Mon, 22 Dec 2014 10:17:57 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.725 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.725 |     2014-12-22 10:17:58,661 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.087s
2014-12-22 10:19:41.725 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.725 |             Body: None
2014-12-22 10:19:41.726 |         Response - Headers: {'connection': 'close', 'content-length': '1456', 'status': '200', 'x-compute-request-id': 'req-eb817207-9d50-4a9d-af86-3d14f61aa660', 'date': 'Mon, 22 Dec 2014 10:17:58 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.726 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.726 |     2014-12-22 10:18:00,074 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.396s
2014-12-22 10:19:41.726 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.726 |             Body: None
2014-12-22 10:19:41.726 |         Response - Headers: {'connection': 'close', 'content-length': '1456', 'status': '200', 'x-compute-request-id': 'req-0226c944-1b4f-4943-bdfb-f24bf4642545', 'date': 'Mon, 22 Dec 2014 10:18:00 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.726 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.726 |     2014-12-22 10:18:01,184 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.096s
2014-12-22 10:19:41.726 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.727 |             Body: None
2014-12-22 10:19:41.727 |         Response - Headers: {'connection': 'close', 'content-length': '1456', 'status': '200', 'x-compute-request-id': 'req-9d8e3ef0-bdfd-4c82-b312-a1636f9cdbdc', 'date': 'Mon, 22 Dec 2014 10:18:01 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.727 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.727 |     2014-12-22 10:18:02,280 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.082s
2014-12-22 10:19:41.727 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.727 |             Body: None
2014-12-22 10:19:41.727 |         Response - Headers: {'connection': 'close', 'content-length': '1456', 'status': '200', 'x-compute-request-id': 'req-75f51be9-943e-407c-980f-6dacaebb5dc3', 'date': 'Mon, 22 Dec 2014 10:18:02 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.727 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.727 |     2014-12-22 10:18:03,375 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 200 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.078s
2014-12-22 10:19:41.728 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.728 |             Body: None
2014-12-22 10:19:41.728 |         Response - Headers: {'connection': 'close', 'content-length': '1456', 'status': '200', 'x-compute-request-id': 'req-7269e698-f0e2-4a34-9a0b-61de201ba7a4', 'date': 'Mon, 22 Dec 2014 10:18:03 GMT', 'content-location': 'http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17', 'content-type': 'application/json'}
2014-12-22 10:19:41.728 |             Body: {"server": {"status": "BUILD", "updated": "2014-12-22T10:17:52Z", "hostId": "f18264b72ab914619c8de596294a4dd3e12556802cac6f528bd33a1c", "addresses": {}, "links": [{"href": "http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "self"}, {"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "rel": "bookmark"}], "key_name": "TestSnapshotPattern-1934688003", "image": {"id": "5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/images/5ca1c666-b7d9-41a6-9b6e-4b8768df6b37", "rel": "bookmark"}]}, "OS-EXT-STS:task_state": "spawning", "OS-EXT-STS:vm_state": "building", "OS-SRV-USG:launched_at": null, "flavor": {"id": "42", "links": [{"href": "http://127.0.0.1:8774/dd16335a922c4d76ba18cfbaec41ca39/flavors/42", "rel": "bookmark"}]}, "id": "04d4299f-28ce-4d9c-9ff6-5def0c3bdc17", "security_groups": [{"name": "TestSnapshotPattern-907887027"}], "OS-SRV-USG:terminated_at": null, "OS-EXT-AZ:availability_zone": "nova", "user_id": "000a1d7dcb3846c2a6461624ec65f47e", "name": "TestSnapshotPattern-1936364961", "created": "2014-12-22T10:17:50Z", "tenant_id": "dd16335a922c4d76ba18cfbaec41ca39", "OS-DCF:diskConfig": "MANUAL", "os-extended-volumes:volumes_attached": [], "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "config_drive": "", "metadata": {}}}
2014-12-22 10:19:41.728 |     2014-12-22 10:19:30,261 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:test_snapshot_pattern): 500 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 85.872s
2014-12-22 10:19:41.728 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.728 |             Body: None
2014-12-22 10:19:41.728 |         Response - Headers: {'connection': 'close', 'content-length': '128', 'status': '500', 'x-compute-request-id': 'req-1a525fdf-f745-426c-a2ba-8a0596c372b1', 'date': 'Mon, 22 Dec 2014 10:19:30 GMT', 'content-type': 'application/json; charset=UTF-8'}
2014-12-22 10:19:41.728 |             Body: {"computeFault": {"message": "The server has either erred or is incapable of performing the requested operation.", "code": 500}}
2014-12-22 10:19:41.729 |     2014-12-22 10:19:31,154 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:_run_cleanups): 204 DELETE http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.890s
2014-12-22 10:19:41.729 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.729 |             Body: None
2014-12-22 10:19:41.729 |         Response - Headers: {'connection': 'close', 'content-length': '0', 'status': '204', 'x-compute-request-id': 'req-c2fce0c0-2a16-44d9-bf73-194507ebb6f4', 'date': 'Mon, 22 Dec 2014 10:19:31 GMT', 'content-type': 'application/json'}
2014-12-22 10:19:41.729 |             Body: 
2014-12-22 10:19:41.729 |     2014-12-22 10:19:31,191 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:_run_cleanups): 404 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.036s
2014-12-22 10:19:41.729 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.729 |             Body: None
2014-12-22 10:19:41.729 |         Response - Headers: {'connection': 'close', 'content-length': '111', 'status': '404', 'x-compute-request-id': 'req-a888cb70-00f6-40af-bf4e-da46eb3f110c', 'date': 'Mon, 22 Dec 2014 10:19:31 GMT', 'content-type': 'application/json; charset=UTF-8'}
2014-12-22 10:19:41.729 |             Body: {"itemNotFound": {"message": "Instance 04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 could not be found.", "code": 404}}
2014-12-22 10:19:41.729 |     2014-12-22 10:19:31,246 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:_run_cleanups): 202 DELETE http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/os-security-group-rules/9c123846-5376-47d1-97d3-02b6985a2ba2 0.054s
2014-12-22 10:19:41.730 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.730 |             Body: None
2014-12-22 10:19:41.730 |         Response - Headers: {'connection': 'close', 'content-length': '0', 'status': '202', 'x-compute-request-id': 'req-90160f31-274b-46e2-8fe1-cf2869d66e6d', 'date': 'Mon, 22 Dec 2014 10:19:31 GMT', 'content-type': 'text/html; charset=UTF-8'}
2014-12-22 10:19:41.730 |             Body: 
2014-12-22 10:19:41.730 |     2014-12-22 10:19:31,332 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:_run_cleanups): 202 DELETE http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/os-security-group-rules/3cb72e34-ba2f-43d4-b36a-b47bedbecdfc 0.085s
2014-12-22 10:19:41.730 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.730 |             Body: None
2014-12-22 10:19:41.730 |         Response - Headers: {'connection': 'close', 'content-length': '0', 'status': '202', 'x-compute-request-id': 'req-7fd70395-503d-4210-a66c-8eb989fc45fb', 'date': 'Mon, 22 Dec 2014 10:19:31 GMT', 'content-type': 'text/html; charset=UTF-8'}
2014-12-22 10:19:41.730 |             Body: 
2014-12-22 10:19:41.730 |     2014-12-22 10:19:31,385 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:_run_cleanups): 202 DELETE http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/os-security-groups/5b30a96e-57fc-4b76-adfd-0391eee58fc0 0.052s
2014-12-22 10:19:41.731 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.731 |             Body: None
2014-12-22 10:19:41.731 |         Response - Headers: {'connection': 'close', 'content-length': '0', 'status': '202', 'x-compute-request-id': 'req-1b889217-c8ac-48da-9f6a-015e103e43e2', 'date': 'Mon, 22 Dec 2014 10:19:31 GMT', 'content-type': 'text/html; charset=UTF-8'}
2014-12-22 10:19:41.731 |             Body: 
2014-12-22 10:19:41.731 |     2014-12-22 10:19:31,407 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:_run_cleanups): 202 DELETE http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/os-keypairs/TestSnapshotPattern-1934688003 0.021s
2014-12-22 10:19:41.731 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.731 |             Body: None
2014-12-22 10:19:41.731 |         Response - Headers: {'connection': 'close', 'content-length': '0', 'status': '202', 'x-compute-request-id': 'req-1c748c25-2e79-4760-8d60-fb09f023e1a5', 'date': 'Mon, 22 Dec 2014 10:19:31 GMT', 'content-type': 'text/html; charset=UTF-8'}
2014-12-22 10:19:41.731 |             Body: 
2014-12-22 10:19:41.731 |     2014-12-22 10:19:31,441 5288 DEBUG    [tempest.common.rest_client] Request (TestSnapshotPattern:_run_cleanups): 404 GET http://127.0.0.1:8774/v2/dd16335a922c4d76ba18cfbaec41ca39/servers/04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 0.033s
2014-12-22 10:19:41.732 |         Request - Headers: {'Content-Type': 'application/json', 'X-Auth-Token': '<omitted>', 'Accept': 'application/json'}
2014-12-22 10:19:41.732 |             Body: None
2014-12-22 10:19:41.732 |         Response - Headers: {'connection': 'close', 'content-length': '111', 'status': '404', 'x-compute-request-id': 'req-659a026a-e9a9-4ec7-b9e8-79ca423e36ae', 'date': 'Mon, 22 Dec 2014 10:19:31 GMT', 'content-type': 'application/json; charset=UTF-8'}
2014-12-22 10:19:41.732 |             Body: {"itemNotFound": {"message": "Instance 04d4299f-28ce-4d9c-9ff6-5def0c3bdc17 could not be found.", "code": 404}}
2014-12-22 10:19:41.732 |     }}}
2014-12-22 10:19:41.732 |     
2014-12-22 10:19:41.732 |     Traceback (most recent call last):
2014-12-22 10:19:41.732 |       File "tempest/test.py", line 112, in wrapper
2014-12-22 10:19:41.732 |         return f(self, *func_args, **func_kwargs)
2014-12-22 10:19:41.732 |       File "tempest/scenario/test_snapshot_pattern.py", line 69, in test_snapshot_pattern
2014-12-22 10:19:41.732 |         server = self._boot_image(CONF.compute.image_ref)
2014-12-22 10:19:41.732 |       File "tempest/scenario/test_snapshot_pattern.py", line 45, in _boot_image
2014-12-22 10:19:41.733 |         return self.create_server(image=image_id, create_kwargs=create_kwargs)
2014-12-22 10:19:41.733 |       File "tempest/scenario/manager.py", line 209, in create_server
2014-12-22 10:19:41.733 |         status='ACTIVE')
2014-12-22 10:19:41.733 |       File "tempest/services/compute/json/servers_client.py", line 183, in wait_for_server_status
2014-12-22 10:19:41.733 |         ready_wait=ready_wait)
2014-12-22 10:19:41.733 |       File "tempest/common/waiters.py", line 66, in wait_for_server_status
2014-12-22 10:19:41.733 |         resp, body = client.get_server(server_id)
2014-12-22 10:19:41.733 |       File "tempest/services/compute/json/servers_client.py", line 142, in get_server
2014-12-22 10:19:41.733 |         resp, body = self.get("servers/%s" % str(server_id))
2014-12-22 10:19:41.733 |       File "tempest/common/rest_client.py", line 239, in get
2014-12-22 10:19:41.733 |         return self.request('GET', url, extra_headers, headers)
2014-12-22 10:19:41.734 |       File "tempest/common/rest_client.py", line 450, in request
2014-12-22 10:19:41.734 |         resp, resp_body)
2014-12-22 10:19:41.734 |       File "tempest/common/rest_client.py", line 547, in _error_checker
2014-12-22 10:19:41.734 |         raise exceptions.ServerFault(message)
2014-12-22 10:19:41.734 |     ServerFault: Got server fault
2014-12-22 10:19:41.734 |     Details: The server has either erred or is incapable of performing the requested operation.
2014-12-22 10:19:41.734 |     
2014-12-22 10:19:41.734 |     
2014-12-22 10:19:41.734 | 
2014-12-22 10:19:41.734 | 
2014-12-22 10:19:41.734 | ======
2014-12-22 10:19:41.735 | Totals
2014-12-22 10:19:41.735 | ======
2014-12-22 10:19:41.735 | Run: 548 in 2278.407309 sec.
2014-12-22 10:19:41.735 |  - Passed: 502
2014-12-22 10:19:41.735 |  - Skipped: 45
2014-12-22 10:19:41.735 |  - Failed: 1

Revision history for this message

Fawad Khaliq (fawadkhaliq) wrote on 2014-12-22:

#2

URL to complete logs

http://logs.openstack.org/15/143315/3/check/check-grenade-dsvm-neutron/90ca1e9/

Revision history for this message

Joe Gordon (jogo) wrote on 2014-12-22:

#3

Looks like a neutron error: http://logs.openstack.org/15/143315/3/check/check-grenade-dsvm-neutron/90ca1e9/logs/new/screen-n-api.txt.gz#_2014-12-22_10_19_30_242

Changed in nova:
status:	New → Incomplete

Revision history for this message

Sean Dague (sdague) wrote on 2015-04-01:

#4

no longer an ER bug we are tracking

Changed in nova:
status:	Incomplete → Invalid

Revision history for this message

Armando Migliaccio (armando-migliaccio) wrote on 2016-07-08:

#5

This bug is > 365 days without activity. We are unsetting assignee and milestone and setting status to Incomplete in order to allow its expiry in 60 days.

If the bug is still valid, then update the bug status.

Changed in neutron:
status:	New → Incomplete

Revision history for this message

Launchpad Janitor (janitor) wrote on 2016-09-07:

#6

[Expired for neutron because there has been no activity for 60 days.]

Changed in neutron:
status:	Incomplete → Expired

Report a bug

This report contains Public information

Everyone can see this information.

You are

Subscribing...

Edit bug mail

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.