test_list_security_groups_list_all_tenants_filter

[Derek Higgins]

Error during grenade in the gate

http://logs.openstack.org/33/109033/1/gate/gate-grenade-dsvm-partial-ncpu/00379f7/logs/grenade.sh.txt.gz

2014-07-24 02:47:56.532 | tempest.api.compute.security_groups.test_security_groups.SecurityGroupsTestJSON.test_server_security_groups[gate,network,smoke] 18.994
2014-07-24 02:47:56.532 |
2014-07-24 02:47:56.532 | ==============================
2014-07-24 02:47:56.532 | Failed 1 tests - output below:
2014-07-24 02:47:56.532 | ==============================
2014-07-24 02:47:56.533 |
2014-07-24 02:47:56.533 | tempest.api.compute.admin.test_security_groups.SecurityGroupsTestAdminXML.test_list_security_groups_list_all_tenants_filter[gate,network,smoke]
2014-07-24 02:47:56.533 | -----------------------------------------------------------------------------------------------------------------------------------------------
2014-07-24 02:47:56.533 |
2014-07-24 02:47:56.533 | Captured traceback:
2014-07-24 02:47:56.533 | ~~~~~~~~~~~~~~~~~~~
2014-07-24 02:47:56.533 | Traceback (most recent call last):
2014-07-24 02:47:56.533 | File "tempest/test.py", line 128, in wrapper
2014-07-24 02:47:56.533 | return f(self, *func_args, **func_kwargs)
2014-07-24 02:47:56.533 | File "tempest/api/compute/admin/test_security_groups.py", line 69, in test_list_security_groups_list_all_tenants_filter
2014-07-24 02:47:56.533 | description))
2014-07-24 02:47:56.533 | File "tempest/services/compute/xml/security_groups_client.py", line 73, in create_security_group
2014-07-24 02:47:56.533 | str(xml_utils.Document(security_group)))
2014-07-24 02:47:56.533 | File "tempest/common/rest_client.py", line 218, in post
2014-07-24 02:47:56.533 | return self.request('POST', url, extra_headers, headers, body)
2014-07-24 02:47:56.533 | File "tempest/common/rest_client.py", line 430, in request
2014-07-24 02:47:56.533 | resp, resp_body)
2014-07-24 02:47:56.533 | File "tempest/common/rest_client.py", line 526, in _error_checker
2014-07-24 02:47:56.533 | raise exceptions.ServerFault(message)
2014-07-24 02:47:56.533 | ServerFault: Got server fault
2014-07-24 02:47:56.533 | Details: The server has either erred or is incapable of performing the requested operation.
2014-07-24 02:47:56.533 |
2014-07-24 02:47:56.534 |
2014-07-24 02:47:56.534 | Captured pythonlogging:
2014-07-24 02:47:56.534 | ~~~~~~~~~~~~~~~~~~~~~~~
2014-07-24 02:47:56.534 | 2014-07-24 02:41:09,715 1886 INFO [tempest.common.rest_client] Request (SecurityGroupsTestAdminXML:test_list_security_groups_list_all_tenants_filter): 200 POST http://127.0.0.1:5000/v2.0/tokens
2014-07-24 02:47:56.534 | 2014-07-24 02:41:09,791 1886 INFO [tempest.common.rest_client] Request (SecurityGroupsTestAdminXML:test_list_security_groups_list_all_tenants_filter): 200 POST http://127.0.0.1:8774/v2/4cfeb6b7364e48fcbd7b930c9c3eea3c/os-security-groups 0.075s
2014-07-24 02:47:56.534 | 2014-07-24 02:41:09,916 1886 INFO [tempest.common.rest_client] Request (SecurityGroupsTestAdminXML:test_list_security_groups_list_all_tenants_filter): 200 POST http://127.0.0.1:8774/v2/4cfeb6b7364e48fcbd7b930c9c3eea3c/os-security-groups 0.124s
2014-07-24 02:47:56.534 | 2014-07-24 02:41:10,163 1886 INFO [tempest.common.rest_client] Request (SecurityGroupsTestAdminXML:test_list_security_groups_list_all_tenants_filter): 200 POST http://127.0.0.1:5000/v2.0/tokens
2014-07-24 02:47:56.534 | 2014-07-24 02:41:10,268 1886 INFO [tempest.common.rest_client] Request (SecurityGroupsTestAdminXML:test_list_security_groups_list_all_tenants_filter): 200 POST http://127.0.0.1:8774/v2/6ef984821ac44a64b42a9f8a30e6a08b/os-security-groups 0.104s
2014-07-24 02:47:56.534 | 2014-07-24 02:41:10,348 1886 INFO [tempest.common.rest_client] Request (SecurityGroupsTestAdminXML:test_list_security_groups_list_all_tenants_filter): 500 POST http://127.0.0.1:8774/v2/6ef984821ac44a64b42a9f8a30e6a08b/os-security-groups 0.079s
2014-07-24 02:47:56.534 | 2014-07-24 02:41:10,441 1886 INFO [tempest.common.rest_client] Request (SecurityGroupsTestAdminXML:_run_cleanups): 202 DELETE http://127.0.0.1:8774/v2/6ef984821ac44a64b42a9f8a30e6a08b/os-security-groups/6 0.089s
2014-07-24 02:47:56.534 | 2014-07-24 02:41:10,568 1886 INFO [tempest.common.rest_client] Request (SecurityGroupsTestAdminXML:_run_cleanups): 202 DELETE http://127.0.0.1:8774/v2/4cfeb6b7364e48fcbd7b930c9c3eea3c/os-security-groups/4 0.126s
2014-07-24 02:47:56.534 | 2014-07-24 02:41:10,847 1886 INFO [tempest.common.rest_client] Request (SecurityGroupsTestAdminXML:_run_cleanups): 202 DELETE http://127.0.0.1:8774/v2/4cfeb6b7364e48fcbd7b930c9c3eea3c/os-security-groups/3 0.277s
2014-07-24 02:47:56.534 |
2014-07-24 02:47:56.534 |
2014-07-24 02:47:56.534 |

[Christopher Yeoh (cyeoh-0)]

looks like some db deadlock is ocurring

2014-07-24 02:41:10.333 ERROR nova.api.openstack [req-fada9cb0-dc8f-4df2-9091-63fa8cd122bb SecurityGroupsTestAdminXML-1229086057 SecurityGroupsTestAdminXML-905056083] Caught error: (OperationalError) (1213, 'Deadlock found when trying to get lock; try restarting transaction') 'SELECT quota_usages.created_at AS quota_usages_created_at, quota_usages.updated_at AS quota_usages_updated_at, quota_usages.deleted_at AS quota_usages_deleted_at, quota_usages.deleted AS quota_usages_deleted, quota_usages.id AS quota_usages_id, quota_usages.project_id AS quota_usages_project_id, quota_usages.user_id AS quota_usages_user_id, quota_usages.resource AS quota_usages_resource, quota_usages.in_use AS quota_usages_in_use, quota_usages.reserved AS quota_usages_reserved, quota_usages.until_refresh AS quota_usages_until_refresh \nFROM quota_usages \nWHERE quota_usages.deleted = %s AND quota_usages.project_id = %s FOR UPDATE' (0, '6ef984821ac44a64b42a9f8a30e6a08b')