yahoo-eng-team team mailing list archive

Thread
Date
[Bug 1226469] Re: deleted image requested in setUpClass (tempest.api.compute.images.test_list_image_filters:ListImageFiltersTestJSON)

To: yahoo-eng-team@xxxxxxxxxxxxxxxxxxx
From: Attila Fazekas <afazekas@xxxxxxxxxx>
Date: Fri, 13 Dec 2013 09:23:06 -0000
Reply-to: Bug 1226469 <1226469@xxxxxxxxxxxxxxxxxx>
Sender: bounces@xxxxxxxxxxxxx
** Also affects: glance
   Importance: Undecided
       Status: New

** Also affects: swift
   Importance: Undecided
       Status: New

-- 
You received this bug notification because you are a member of Yahoo!
Engineering Team, which is subscribed to Glance.
https://bugs.launchpad.net/bugs/1226469

Title:
  deleted image requested in setUpClass
  (tempest.api.compute.images.test_list_image_filters:ListImageFiltersTestJSON)

Status in OpenStack Image Registry and Delivery Service (Glance):
  New
Status in OpenStack Object Storage (Swift):
  New
Status in Tempest:
  Incomplete

Bug description:
  This occurred in: http://logs.openstack.org/79/46879/1/check/gate-
  tempest-devstack-vm-full/6d0c9aa/

  The relevant part of the glance-registry log:

  2013-09-17 05:45:51.023 22288 INFO glance.registry.api.v1.images [c85dd8b4-ec3b-40e9-91dd-7346681aa947 6efac1abd8d3460382749a65a04e179e 02a9c1884e0943d4ba4d9f414700590f] Successfully retrieved image cabbbaef-e97e-4ded-a8d6-c277983fbc3c
  2013-09-17 05:45:51.026 22288 DEBUG keystoneclient.middleware.auth_token [-] Authenticating user token __call__ /opt/stack/new/python-keystoneclient/keystoneclient/middleware/auth_token.py:532
  2013-09-17 05:45:51.027 22288 DEBUG keystoneclient.middleware.auth_token [-] Removing headers from request environment: X-Identity-Status,X-Domain-Id,X-Domain-Name,X-Project-Id,X-Project-Name,X-Project-Domain-Id,X-Project-Domain-Name,X-User-Id,X-User-Name,X-User-Domain-Id,X-User-Domain-Name,X-Roles,X-Service-Catalog,X-User,X-Tenant-Id,X-Tenant-Name,X-Tenant,X-Role _remove_auth_headers /opt/stack/new/python-keystoneclient/keystoneclient/middleware/auth_token.py:591
  2013-09-17 05:45:51.027 22288 DEBUG keystoneclient.middleware.auth_token [-] Returning cached token a1c0f2b2085517948ad0a0ba27808c76 _cache_get /opt/stack/new/python-keystoneclient/keystoneclient/middleware/auth_token.py:982
  2013-09-17 05:45:51.028 22288 DEBUG glance.api.policy [-] Loaded policy rules: {u'context_is_admin': 'role:admin', u'default': '@', u'manage_image_cache': 'role:admin'} load_rules /opt/stack/new/glance/glance/api/policy.py:75
  2013-09-17 05:45:51.029 22288 DEBUG routes.middleware [-] Matched PUT /images/cabbbaef-e97e-4ded-a8d6-c277983fbc3c __call__ /usr/lib/python2.7/dist-packages/routes/middleware.py:100
  2013-09-17 05:45:51.029 22288 DEBUG routes.middleware [-] Route path: '/images/{id}', defaults: {'action': u'update', 'controller': <glance.common.wsgi.Resource object at 0x407c610>} __call__ /usr/lib/python2.7/dist-packages/routes/middleware.py:102
  2013-09-17 05:45:51.029 22288 DEBUG routes.middleware [-] Match dict: {'action': u'update', 'controller': <glance.common.wsgi.Resource object at 0x407c610>, 'id': u'cabbbaef-e97e-4ded-a8d6-c277983fbc3c'} __call__ /usr/lib/python2.7/dist-packages/routes/middleware.py:103
  2013-09-17 05:45:51.030 22288 DEBUG glance.registry.api.v1.images [a26f57b5-2f1d-4b76-b0f2-65d2df1a9469 6efac1abd8d3460382749a65a04e179e 02a9c1884e0943d4ba4d9f414700590f] Updating image cabbbaef-e97e-4ded-a8d6-c277983fbc3c with metadata: {u'status': u'deleted'} update /opt/stack/new/glance/glance/registry/api/v1/images.py:436
  2013-09-17 05:45:51.049 22288 INFO glance.registry.api.v1.images [a26f57b5-2f1d-4b76-b0f2-65d2df1a9469 6efac1abd8d3460382749a65a04e179e 02a9c1884e0943d4ba4d9f414700590f] Updating metadata for image cabbbaef-e97e-4ded-a8d6-c277983fbc3c
  2013-09-17 05:45:51.052 22288 DEBUG keystoneclient.middleware.auth_token [-] Authenticating user token __call__ /opt/stack/new/python-keystoneclient/keystoneclient/middleware/auth_token.py:532
  2013-09-17 05:45:51.052 22288 DEBUG keystoneclient.middleware.auth_token [-] Removing headers from request environment: X-Identity-Status,X-Domain-Id,X-Domain-Name,X-Project-Id,X-Project-Name,X-Project-Domain-Id,X-Project-Domain-Name,X-User-Id,X-User-Name,X-User-Domain-Id,X-User-Domain-Name,X-Roles,X-Service-Catalog,X-User,X-Tenant-Id,X-Tenant-Name,X-Tenant,X-Role _remove_auth_headers /opt/stack/new/python-keystoneclient/keystoneclient/middleware/auth_token.py:591
  2013-09-17 05:45:51.052 22288 DEBUG keystoneclient.middleware.auth_token [-] Returning cached token a1c0f2b2085517948ad0a0ba27808c76 _cache_get /opt/stack/new/python-keystoneclient/keystoneclient/middleware/auth_token.py:982
  2013-09-17 05:45:51.053 22288 DEBUG glance.api.policy [-] Loaded policy rules: {u'context_is_admin': 'role:admin', u'default': '@', u'manage_image_cache': 'role:admin'} load_rules /opt/stack/new/glance/glance/api/policy.py:75
  2013-09-17 05:45:51.053 22288 DEBUG routes.middleware [-] Matched DELETE /images/cabbbaef-e97e-4ded-a8d6-c277983fbc3c __call__ /usr/lib/python2.7/dist-packages/routes/middleware.py:100
  2013-09-17 05:45:51.053 22288 DEBUG routes.middleware [-] Route path: '/images/{id}', defaults: {'action': u'delete', 'controller': <glance.common.wsgi.Resource object at 0x407c610>} __call__ /usr/lib/python2.7/dist-packages/routes/middleware.py:102
  2013-09-17 05:45:51.053 22288 DEBUG routes.middleware [-] Match dict: {'action': u'delete', 'controller': <glance.common.wsgi.Resource object at 0x407c610>, 'id': u'cabbbaef-e97e-4ded-a8d6-c277983fbc3c'} __call__ /usr/lib/python2.7/dist-packages/routes/middleware.py:103
  2013-09-17 05:45:51.068 22288 INFO glance.registry.api.v1.images [eabca9b6-a691-4d87-93ba-84c482333ecb 6efac1abd8d3460382749a65a04e179e 02a9c1884e0943d4ba4d9f414700590f] Successfully deleted image cabbbaef-e97e-4ded-a8d6-c277983fbc3c
  2013-09-17 05:45:51.357 22288 DEBUG keystoneclient.middleware.auth_token [-] Authenticating user token __call__ /opt/stack/new/python-keystoneclient/keystoneclient/middleware/auth_token.py:532
  2013-09-17 05:45:51.357 22288 DEBUG keystoneclient.middleware.auth_token [-] Removing headers from request environment: X-Identity-Status,X-Domain-Id,X-Domain-Name,X-Project-Id,X-Project-Name,X-Project-Domain-Id,X-Project-Domain-Name,X-User-Id,X-User-Name,X-User-Domain-Id,X-User-Domain-Name,X-Roles,X-Service-Catalog,X-User,X-Tenant-Id,X-Tenant-Name,X-Tenant,X-Role _remove_auth_headers /opt/stack/new/python-keystoneclient/keystoneclient/middleware/auth_token.py:591
  2013-09-17 05:45:51.358 22288 DEBUG keystoneclient.middleware.auth_token [-] Returning cached token a1c0f2b2085517948ad0a0ba27808c76 _cache_get /opt/stack/new/python-keystoneclient/keystoneclient/middleware/auth_token.py:982
  2013-09-17 05:45:51.359 22288 DEBUG glance.api.policy [-] Loaded policy rules: {u'context_is_admin': 'role:admin', u'default': '@', u'manage_image_cache': 'role:admin'} load_rules /opt/stack/new/glance/glance/api/policy.py:75
  2013-09-17 05:45:51.359 22288 DEBUG routes.middleware [-] Matched GET /images/cabbbaef-e97e-4ded-a8d6-c277983fbc3c __call__ /usr/lib/python2.7/dist-packages/routes/middleware.py:100
  2013-09-17 05:45:51.359 22288 DEBUG routes.middleware [-] Route path: '/images/{id}', defaults: {'action': u'show', 'controller': <glance.common.wsgi.Resource object at 0x407c610>} __call__ /usr/lib/python2.7/dist-packages/routes/middleware.py:102
  2013-09-17 05:45:51.360 22288 DEBUG routes.middleware [-] Match dict: {'action': u'show', 'controller': <glance.common.wsgi.Resource object at 0x407c610>, 'id': u'cabbbaef-e97e-4ded-a8d6-c277983fbc3c'} __call__ /usr/lib/python2.7/dist-packages/routes/middleware.py:103
  2013-09-17 05:45:51.369 22288 DEBUG glance.db.sqlalchemy.api [0905dfb8-a659-4116-8856-565ab4ecb73e 6efac1abd8d3460382749a65a04e179e 02a9c1884e0943d4ba4d9f414700590f] No image found with ID cabbbaef-e97e-4ded-a8d6-c277983fbc3c _image_get /opt/stack/new/glance/glance/db/sqlalchemy/api.py:334
  2013-09-17 05:45:51.369 22288 INFO glance.registry.api.v1.images [0905dfb8-a659-4116-8856-565ab4ecb73e 6efac1abd8d3460382749a65a04e179e 02a9c1884e0943d4ba4d9f414700590f] Image cabbbaef-e97e-4ded-a8d6-c277983fbc3c not found

  This gets returned to nova-api:

  2013-09-17 05:45:51.373 22679 DEBUG glanceclient.common.http [-] 
  HTTP/1.1 404 Not Found
  date: Tue, 17 Sep 2013 05:45:51 GMT
  content-length: 0
  content-type: text/plain; charset=UTF-8
  x-openstack-request-id: req-808aa231-ee50-4f8a-998f-6a07cac7a19a
   log_http_response /opt/stack/new/python-glanceclient/glanceclient/common/http.py:150
  2013-09-17 05:45:51.373 22679 ERROR glanceclient.common.http [-] Request returned failure status.
  2013-09-17 05:45:51.374 INFO nova.api.openstack.wsgi [req-fbaa9e87-805a-444f-a570-8f173ed43c5c ListImageFiltersTestJSON1655636038-user ListImageFiltersTestJSON1727356788-tenant] HTTP exception thrown: Image not found.

  And finally turned into this traceback in the test:

  [x]

          
  ft2.1: setUpClass (tempest.api.compute.images.test_list_image_filters.ListImageFiltersTestJSON)_StringException: Traceback (most recent call last):
    File "tempest/api/compute/images/test_list_image_filters.py", line 60, in setUpClass
      cls.client.wait_for_image_status(cls.image3_id, 'ACTIVE')
    File "tempest/services/compute/json/images_client.py", line 104, in wait_for_image_status
      resp, image = self.get_image(image_id)
    File "tempest/services/compute/json/images_client.py", line 74, in get_image
      resp, body = self.get("images/%s" % str(image_id))
    File "tempest/common/rest_client.py", line 263, in get
      return self.request('GET', url, headers)
    File "tempest/common/rest_client.py", line 394, in request
      resp, resp_body)
    File "tempest/common/rest_client.py", line 439, in _error_checker
      raise exceptions.NotFound(resp_body)
  NotFound: Object not found
  Details: {"itemNotFound": {"message": "Image not found.", "code": 404}}

To manage notifications about this bug go to:
https://bugs.launchpad.net/glance/+bug/1226469/+subscriptions