Attachment 891409 Details for Bug 1093299 – Glance api.log

Glance api.log

api.log (text/plain), 90.84 KB, created by Tzach Shefi on 2014-05-01 08:44:11 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Tzach Shefi

Created: 2014-05-01 08:44:11 UTC

Size: 90.84 KB

patch

obsolete

>2014-05-01 11:21:51.655 2459 DEBUG qpid.messaging.io.raw [-] OPEN[4515368]: 10.35.160.73:5672 connect /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:530
>2014-05-01 11:21:51.656 2459 DEBUG qpid.messaging.io.raw [-] SENT[4515368]: 'AMQP\x01\x01\x00\n' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.657 2459 DEBUG qpid.messaging.io.raw [-] READ[4515368]: 'AMQP\x01\x01\x00\n\x0f\x00\x00~\x00\x00\x00\x00\x00\x00\x00\x00\x01\x01\x07\x00\x00\x00\x00?\x00\x00\x00\x01\x13qpid.federation_tag\x95\x00$62e96915-063e-4b1b-b169-c90278559d74\x00\x00\x00\x17\x95\x00\x00\x00\x02\x00\tANONYMOUS\x00\x05PLAIN\x00\x00\x00\x0c\x95\x00\x00\x00\x01\x00\x05en_US' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.657 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4515368]: ConnectionStart(server_properties={u'qpid.federation_tag': u'62e96915-063e-4b1b-b169-c90278559d74'}, mechanisms=[u'ANONYMOUS', u'PLAIN'], locales=[u'en_US']) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.658 2459 DEBUG qpid.messaging.io.ops [-] SENT[4515368]: ConnectionStartOk(client_properties={'product': 'qpid python client', 'qpid.client_ppid': 2451, 'qpid.client_process': 'glance-api', 'platform': 'posix', 'qpid.client_pid': 2459, 'version': 'development'}, mechanism='ANONYMOUS', response='anonymous@orange-vdsf.qa.lab.tlv.redhat.com') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.658 2459 DEBUG qpid.messaging.io.raw [-] SENT[4515368]: '\x0f\x00\x00\xe9\x00\x00\x00\x00\x00\x00\x00\x00\x01\x02\x07\x00\x00\x00\x00\x9c\x00\x00\x00\x06\x07product\x95\x00\x12qpid python client\x10qpid.client_ppid1\x00\x00\x00\x00\x00\x00\t\x93\x13qpid.client_process\x95\x00\nglance-api\x08platform\x95\x00\x05posix\x0fqpid.client_pid1\x00\x00\x00\x00\x00\x00\t\x9b\x07version\x95\x00\x0bdevelopment\tANONYMOUS\x00\x00\x00+anonymous@orange-vdsf.qa.lab.tlv.redhat.com' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.659 2459 DEBUG qpid.messaging.io.raw [-] READ[4515368]: '\x0f\x00\x00\x18\x00\x00\x00\x00\x00\x00\x00\x00\x01\x05\x0f\x00\x7f\xff\xff\xff\x00\x00\x00x' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.659 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4515368]: ConnectionTune(channel_max=32767, max_frame_size=65535, heartbeat_min=0, heartbeat_max=120) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.659 2459 DEBUG qpid.messaging.io.ops [-] SENT[4515368]: ConnectionTuneOk(channel_max=32767, heartbeat=60) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.660 2459 DEBUG qpid.messaging.io.ops [-] SENT[4515368]: ConnectionOpen() write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.660 2459 DEBUG qpid.messaging.io.raw [-] SENT[4515368]: '\x0f\x00\x00\x14\x00\x00\x00\x00\x00\x00\x00\x00\x01\x06\x05\x00\x7f\xff\x00<\x0f\x00\x00\x10\x00\x00\x00\x00\x00\x00\x00\x00\x01\x07\x00\x00' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.661 2459 DEBUG qpid.messaging.io.raw [-] READ[4515368]: '\x0f\x00\x005\x00\x00\x00\x00\x00\x00\x00\x00\x01\x08\x01\x00\x00\x00\x00!\x95\x00\x00\x00\x01\x00\x1aamqp:tcp:10.35.160.73:5672' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.661 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4515368]: ConnectionOpenOk(known_hosts=[u'amqp:tcp:10.35.160.73:5672']) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.661 2459 INFO glance.notifier.notify_qpid [-] Connected to AMQP server on 10.35.160.73:5672
>2014-05-01 11:21:51.662 2459 DEBUG qpid.messaging.io.ops [-] SENT[4515368]: SessionAttach(name='b341ff2c-aac5-4c9f-bb8f-e310ee49bbf4:0') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.662 2459 DEBUG qpid.messaging.io.ops [-] SENT[4515368]: SessionCommandPoint(command_id=serial(0), command_offset=0) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.663 2459 DEBUG qpid.messaging.io.ops [-] SENT[4515368]: ExchangeQuery(name='glance', id=serial(0), sync=True) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.664 2459 DEBUG qpid.messaging.io.ops [-] SENT[4515368]: QueueQuery(queue='glance', id=serial(1), sync=True) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.664 2459 DEBUG qpid.messaging.io.raw [-] SENT[4515368]: '\x0f\x00\x008\x00\x00\x00\x00\x00\x00\x00\x00\x02\x01\x01\x00\x00&b341ff2c-aac5-4c9f-bb8f-e310ee49bbf4:0\x0f\x00\x00\x1c\x00\x00\x00\x00\x00\x00\x00\x00\x02\x07\x03\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x0f\x01\x00\x19\x00\x01\x00\x00\x00\x00\x00\x00\x07\x03\x01\x01\x01\x00\x06glance\x0f\x01\x00\x19\x00\x01\x00\x00\x00\x00\x00\x00\x08\x04\x01\x01\x01\x00\x06glance' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.665 2459 DEBUG qpid.messaging.io.raw [-] READ[4515368]: '\x0f\x00\x008\x00\x00\x00\x00\x00\x00\x00\x00\x02\x02\x01\x00\x00&b341ff2c-aac5-4c9f-bb8f-e310ee49bbf4:0\x0f\x00\x00\x1c\x00\x00\x00\x00\x00\x00\x00\x00\x02\x07\x03\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x0f\x01\x00,\x00\x01\x00\x00\x00\x00\x00\x00\x03\x02\x01\x00\x03\x00\x00\x00\x00\x00\x00\x00\x00\x12\x07\x01\t\x00\x05topic\x00\x00\x00\x04\x00\x00\x00\x00\x0f\x00\x00\x1a\x00\x00\x00\x00\x00\x00\x00\x00\x02\n\x01\x00\x00\x08\x00\x00\x00\x00\x00\x00\x00\x00\x0f\x01\x00\x1e\x00\x01\x00\x00\x00\x00\x00\x00\x03\x02\x01\x00\x03\x00\x00\x00\x00\x01\x00\x00\x00\x04\x08\x01\x00\x00\x0f\x00\x00\x1a\x00\x00\x00\x00\x00\x00\x00\x00\x02\n\x01\x00\x00\x08\x00\x00\x00\x00\x00\x00\x00\x01' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.665 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4515368]: SessionAttached(name='b341ff2c-aac5-4c9f-bb8f-e310ee49bbf4:0') write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.666 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4515368]: SessionCommandPoint(command_id=serial(0), command_offset=0) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.666 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4515368]: ExecutionResult(command_id=serial(0), value=ExchangeQueryResult(type=u'topic', arguments={}), id=serial(0)) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.666 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4515368]: SessionCompleted(commands=[0-0]) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.666 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4515368]: ExecutionResult(command_id=serial(1), value=QueueQueryResult(), id=serial(1)) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.667 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4515368]: SessionCompleted(commands=[0-1]) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.668 2459 DEBUG qpid.messaging.io.ops [-] SENT[4515368]: MessageTransfer(destination='glance', id=serial(2), sync=True, headers=(DeliveryProperties(routing_key='notifications.info'), MessageProperties(content_type='amqp/map', application_headers={'qpid.subject': 'notifications.info'})), payload='\x00\x00\x02J\x00\x00\x00\x06\nevent_type\x95\x00\x0cimage.upload\ttimestamp\x95\x00\x1a2014-05-01 08:21:51.655143\nmessage_id\x95\x00$5ed5421b-6e49-483a-a6dc-9662e16b46a2\x08priority\x95\x00\x04INFO\x0cpublisher_id\x95\x00!orange-vdsf.qa.lab.tlv.redhat.com\x07payload\xa8\x00\x00\x01\x85\x00\x00\x00\x11\x06status\x95\x00\x06saving\ncreated_at\x95\x00\x132014-05-01T08:19:47\x04name\x95\x00\x0btshefi_cli2\x07deleted\x08\x00\x10container_format\x95\x00\x04bare\x07min_ram1\x00\x00\x00\x00\x00\x00\x00\x00\x0bdisk_format\x95\x00\x03raw\nupdated_at\x95\x00\x132014-05-01T08:21:51\nproperties\xa8\x00\x00\x00\x04\x00\x00\x00\x00\x08min_disk1\x00\x00\x00\x00\x00\x00\x00\x00\tprotected\x08\x00\x08checksum\x95\x00 3ed25f2f8aa24d6807c48e6588861382\x05owner\x95\x00 5502ab8e099843cfa39df71b3037ccd6\tis_public\x08\x00\ndeleted_at\xf0\x02id\x95\x00$ac574a2b-6e68-4833-89f3-16a94e7f3479\x04size1\x00\x00\x00\x01\x80\x00\x00\x01') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.669 2459 DEBUG qpid.messaging [-] SENT[4504200]: Message(properties={'qpid.subject': 'notifications.info'}, content={'event_type': 'image.upload', 'timestamp': '2014-05-01 08:21:51.655143', 'message_id': '5ed5421b-6e49-483a-a6dc-9662e16b46a2', 'priority': 'INFO', 'publisher_id': 'orange-vdsf.qa.lab.tlv.redhat.com', 'payload': {u'status': u'saving', u'created_at': u'2014-05-01T08:19:47', u'name': u'tshefi_cli2', u'deleted': False, u'container_format': u'bare', u'min_ram': 0, u'disk_format': u'raw', u'updated_at': u'2014-05-01T08:21:51', u'properties': {}, u'min_disk': 0, u'protected': False, u'checksum': u'3ed25f2f8aa24d6807c48e6588861382', u'owner': u'5502ab8e099843cfa39df71b3037ccd6', u'is_public': False, u'deleted_at': None, u'id': u'ac574a2b-6e68-4833-89f3-16a94e7f3479', u'size': 6442450945}}) send /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:1280
>2014-05-01 11:21:51.670 2459 DEBUG qpid.messaging.io.raw [-] SENT[4515368]: '\x0b\x01\x00\x19\x00\x01\x00\x00\x00\x00\x00\x00\x04\x01\x01\x01\x01\x00\x06glance\x03\x02\x00b\x00\x01\x00\x00\x00\x00\x00\x00\x00\x00\x00\x17\x04\x01\x00\x02\x12notifications.info\x00\x00\x007\x04\x03\x10\x01\x08amqp/map\x00\x00\x00&\x00\x00\x00\x01\x0cqpid.subject\x95\x00\x12notifications.info\x07\x03\x02Z\x00\x01\x00\x00\x00\x00\x00\x00\x00\x00\x02J\x00\x00\x00\x06\nevent_type\x95\x00\x0cimage.upload\ttimestamp\x95\x00\x1a2014-05-01 08:21:51.655143\nmessage_id\x95\x00$5ed5421b-6e49-483a-a6dc-9662e16b46a2\x08priority\x95\x00\x04INFO\x0cpublisher_id\x95\x00!orange-vdsf.qa.lab.tlv.redhat.com\x07payload\xa8\x00\x00\x01\x85\x00\x00\x00\x11\x06status\x95\x00\x06saving\ncreated_at\x95\x00\x132014-05-01T08:19:47\x04name\x95\x00\x0btshefi_cli2\x07deleted\x08\x00\x10container_format\x95\x00\x04bare\x07min_ram1\x00\x00\x00\x00\x00\x00\x00\x00\x0bdisk_format\x95\x00\x03raw\nupdated_at\x95\x00\x132014-05-01T08:21:51\nproperties\xa8\x00\x00\x00\x04\x00\x00\x00\x00\x08min_disk1\x00\x00\x00\x00\x00\x00\x00\x00\tprotected\x08\x00\x08checksum\x95\x00 3ed25f2f8aa24d6807c48e6588861382\x05owner\x95\x00 5502ab8e099843cfa39df71b3037ccd6\tis_public\x08\x00\ndeleted_at\xf0\x02id\x95\x00$ac574a2b-6e68-4833-89f3-16a94e7f3479\x04size1\x00\x00\x00\x01\x80\x00\x00\x01' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.670 2459 DEBUG qpid.messaging.io.raw [-] READ[4515368]: '\x0f\x00\x00\x1a\x00\x00\x00\x00\x00\x00\x00\x00\x02\n\x01\x00\x00\x08\x00\x00\x00\x00\x00\x00\x00\x02' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.670 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4515368]: SessionCompleted(commands=[0-2]) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.671 2459 DEBUG qpid.messaging [-] RACK[4504200]: Message(properties={'qpid.subject': 'notifications.info'}, content={'event_type': 'image.upload', 'timestamp': '2014-05-01 08:21:51.655143', 'message_id': '5ed5421b-6e49-483a-a6dc-9662e16b46a2', 'priority': 'INFO', 'publisher_id': 'orange-vdsf.qa.lab.tlv.redhat.com', 'payload': {u'status': u'saving', u'created_at': u'2014-05-01T08:19:47', u'name': u'tshefi_cli2', u'deleted': False, u'container_format': u'bare', u'min_ram': 0, u'disk_format': u'raw', u'updated_at': u'2014-05-01T08:21:51', u'properties': {}, u'min_disk': 0, u'protected': False, u'checksum': u'3ed25f2f8aa24d6807c48e6588861382', u'owner': u'5502ab8e099843cfa39df71b3037ccd6', u'is_public': False, u'deleted_at': None, u'id': u'ac574a2b-6e68-4833-89f3-16a94e7f3479', u'size': 6442450945}}) msg_acked /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:1269
>2014-05-01 11:21:51.671 2459 DEBUG qpid.messaging.io.ops [-] SENT[4515368]: SessionDetach(name='b341ff2c-aac5-4c9f-bb8f-e310ee49bbf4:0') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.672 2459 DEBUG qpid.messaging.io.raw [-] SENT[4515368]: '\x0f\x00\x008\x00\x00\x00\x00\x00\x00\x00\x00\x02\x03\x01\x00\x00&b341ff2c-aac5-4c9f-bb8f-e310ee49bbf4:0' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.672 2459 DEBUG qpid.messaging.io.raw [-] READ[4515368]: '\x0f\x00\x009\x00\x00\x00\x00\x00\x00\x00\x00\x02\x04\x03\x00\x00&b341ff2c-aac5-4c9f-bb8f-e310ee49bbf4:0\x00' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.673 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4515368]: SessionDetached(name='b341ff2c-aac5-4c9f-bb8f-e310ee49bbf4:0', code=0) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.673 2459 DEBUG qpid.messaging.io.ops [-] SENT[4515368]: ConnectionClose(reply_code=200) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.674 2459 DEBUG qpid.messaging.io.raw [-] SENT[4515368]: '\x0f\x00\x00\x12\x00\x00\x00\x00\x00\x00\x00\x00\x01\x0b\x01\x00\x00\xc8' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.674 2459 DEBUG qpid.messaging.io.raw [-] READ[4515368]: '\x0f\x00\x00\x10\x00\x00\x00\x00\x00\x00\x00\x00\x01\x0c\x00\x00' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.674 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4515368]: ConnectionCloseOk() write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.675 2459 DEBUG glance.registry.client.v1.api [-] Updating image metadata for image ac574a2b-6e68-4833-89f3-16a94e7f3479... update_image_metadata /usr/lib/python2.6/site-packages/glance/registry/client/v1/api.py:168
>2014-05-01 11:21:51.675 2459 DEBUG glance.common.client [-] Constructed URL: http://0.0.0.0:9191/images/ac574a2b-6e68-4833-89f3-16a94e7f3479 _construct_url /usr/lib/python2.6/site-packages/glance/common/client.py:408
>2014-05-01 11:21:51.796 2459 DEBUG glance.registry.client.v1.client [-] Registry request PUT /images/ac574a2b-6e68-4833-89f3-16a94e7f3479 HTTP 200 request id req-4fb8a19f-3957-468c-8f04-e9626e02d8ae do_request /usr/lib/python2.6/site-packages/glance/registry/client/v1/client.py:115
>2014-05-01 11:21:51.797 2459 DEBUG qpid.messaging.io.raw [-] OPEN[4092290]: 10.35.160.73:5672 connect /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:530
>2014-05-01 11:21:51.799 2459 DEBUG qpid.messaging.io.raw [-] SENT[4092290]: 'AMQP\x01\x01\x00\n' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.799 2459 DEBUG qpid.messaging.io.raw [-] READ[4092290]: 'AMQP\x01\x01\x00\n\x0f\x00\x00~\x00\x00\x00\x00\x00\x00\x00\x00\x01\x01\x07\x00\x00\x00\x00?\x00\x00\x00\x01\x13qpid.federation_tag\x95\x00$62e96915-063e-4b1b-b169-c90278559d74\x00\x00\x00\x17\x95\x00\x00\x00\x02\x00\tANONYMOUS\x00\x05PLAIN\x00\x00\x00\x0c\x95\x00\x00\x00\x01\x00\x05en_US' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.800 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4092290]: ConnectionStart(server_properties={u'qpid.federation_tag': u'62e96915-063e-4b1b-b169-c90278559d74'}, mechanisms=[u'ANONYMOUS', u'PLAIN'], locales=[u'en_US']) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.800 2459 DEBUG qpid.messaging.io.ops [-] SENT[4092290]: ConnectionStartOk(client_properties={'product': 'qpid python client', 'qpid.client_ppid': 2451, 'qpid.client_process': 'glance-api', 'platform': 'posix', 'qpid.client_pid': 2459, 'version': 'development'}, mechanism='ANONYMOUS', response='anonymous@orange-vdsf.qa.lab.tlv.redhat.com') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.801 2459 DEBUG qpid.messaging.io.raw [-] SENT[4092290]: '\x0f\x00\x00\xe9\x00\x00\x00\x00\x00\x00\x00\x00\x01\x02\x07\x00\x00\x00\x00\x9c\x00\x00\x00\x06\x07product\x95\x00\x12qpid python client\x10qpid.client_ppid1\x00\x00\x00\x00\x00\x00\t\x93\x13qpid.client_process\x95\x00\nglance-api\x08platform\x95\x00\x05posix\x0fqpid.client_pid1\x00\x00\x00\x00\x00\x00\t\x9b\x07version\x95\x00\x0bdevelopment\tANONYMOUS\x00\x00\x00+anonymous@orange-vdsf.qa.lab.tlv.redhat.com' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.801 2459 DEBUG qpid.messaging.io.raw [-] READ[4092290]: '\x0f\x00\x00\x18\x00\x00\x00\x00\x00\x00\x00\x00\x01\x05\x0f\x00\x7f\xff\xff\xff\x00\x00\x00x' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.801 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4092290]: ConnectionTune(channel_max=32767, max_frame_size=65535, heartbeat_min=0, heartbeat_max=120) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.802 2459 DEBUG qpid.messaging.io.ops [-] SENT[4092290]: ConnectionTuneOk(channel_max=32767, heartbeat=60) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.802 2459 DEBUG qpid.messaging.io.ops [-] SENT[4092290]: ConnectionOpen() write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.802 2459 DEBUG qpid.messaging.io.raw [-] SENT[4092290]: '\x0f\x00\x00\x14\x00\x00\x00\x00\x00\x00\x00\x00\x01\x06\x05\x00\x7f\xff\x00<\x0f\x00\x00\x10\x00\x00\x00\x00\x00\x00\x00\x00\x01\x07\x00\x00' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.803 2459 DEBUG qpid.messaging.io.raw [-] READ[4092290]: '\x0f\x00\x005\x00\x00\x00\x00\x00\x00\x00\x00\x01\x08\x01\x00\x00\x00\x00!\x95\x00\x00\x00\x01\x00\x1aamqp:tcp:10.35.160.73:5672' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.803 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4092290]: ConnectionOpenOk(known_hosts=[u'amqp:tcp:10.35.160.73:5672']) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.804 2459 INFO glance.notifier.notify_qpid [-] Connected to AMQP server on 10.35.160.73:5672
>2014-05-01 11:21:51.804 2459 DEBUG qpid.messaging.io.ops [-] SENT[4092290]: SessionAttach(name='2a690124-c3b5-449f-b472-a7dae5a0956a:0') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.804 2459 DEBUG qpid.messaging.io.ops [-] SENT[4092290]: SessionCommandPoint(command_id=serial(0), command_offset=0) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.806 2459 DEBUG qpid.messaging.io.ops [-] SENT[4092290]: ExchangeQuery(name='glance', id=serial(0), sync=True) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.806 2459 DEBUG qpid.messaging.io.ops [-] SENT[4092290]: QueueQuery(queue='glance', id=serial(1), sync=True) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.807 2459 DEBUG qpid.messaging.io.raw [-] SENT[4092290]: '\x0f\x00\x008\x00\x00\x00\x00\x00\x00\x00\x00\x02\x01\x01\x00\x00&2a690124-c3b5-449f-b472-a7dae5a0956a:0\x0f\x00\x00\x1c\x00\x00\x00\x00\x00\x00\x00\x00\x02\x07\x03\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x0f\x01\x00\x19\x00\x01\x00\x00\x00\x00\x00\x00\x07\x03\x01\x01\x01\x00\x06glance\x0f\x01\x00\x19\x00\x01\x00\x00\x00\x00\x00\x00\x08\x04\x01\x01\x01\x00\x06glance' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.807 2459 DEBUG qpid.messaging.io.raw [-] READ[4092290]: '\x0f\x00\x008\x00\x00\x00\x00\x00\x00\x00\x00\x02\x02\x01\x00\x00&2a690124-c3b5-449f-b472-a7dae5a0956a:0\x0f\x00\x00\x1c\x00\x00\x00\x00\x00\x00\x00\x00\x02\x07\x03\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x0f\x01\x00,\x00\x01\x00\x00\x00\x00\x00\x00\x03\x02\x01\x00\x03\x00\x00\x00\x00\x00\x00\x00\x00\x12\x07\x01\t\x00\x05topic\x00\x00\x00\x04\x00\x00\x00\x00\x0f\x00\x00\x1a\x00\x00\x00\x00\x00\x00\x00\x00\x02\n\x01\x00\x00\x08\x00\x00\x00\x00\x00\x00\x00\x00\x0f\x01\x00\x1e\x00\x01\x00\x00\x00\x00\x00\x00\x03\x02\x01\x00\x03\x00\x00\x00\x00\x01\x00\x00\x00\x04\x08\x01\x00\x00\x0f\x00\x00\x1a\x00\x00\x00\x00\x00\x00\x00\x00\x02\n\x01\x00\x00\x08\x00\x00\x00\x00\x00\x00\x00\x01' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.809 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4092290]: SessionAttached(name='2a690124-c3b5-449f-b472-a7dae5a0956a:0') write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.809 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4092290]: SessionCommandPoint(command_id=serial(0), command_offset=0) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.809 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4092290]: ExecutionResult(command_id=serial(0), value=ExchangeQueryResult(type=u'topic', arguments={}), id=serial(0)) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.809 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4092290]: SessionCompleted(commands=[0-0]) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.810 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4092290]: ExecutionResult(command_id=serial(1), value=QueueQueryResult(), id=serial(1)) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.810 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4092290]: SessionCompleted(commands=[0-1]) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.811 2459 DEBUG qpid.messaging.io.ops [-] SENT[4092290]: MessageTransfer(destination='glance', id=serial(2), sync=True, headers=(DeliveryProperties(routing_key='notifications.info'), MessageProperties(content_type='amqp/map', application_headers={'qpid.subject': 'notifications.info'})), payload='\x00\x00\x02L\x00\x00\x00\x06\nevent_type\x95\x00\x0eimage.activate\ttimestamp\x95\x00\x1a2014-05-01 08:21:51.797346\nmessage_id\x95\x00$805868f5-3b9f-4992-9683-bc605bae61e3\x08priority\x95\x00\x04INFO\x0cpublisher_id\x95\x00!orange-vdsf.qa.lab.tlv.redhat.com\x07payload\xa8\x00\x00\x01\x85\x00\x00\x00\x11\x06status\x95\x00\x06active\ncreated_at\x95\x00\x132014-05-01T08:19:47\x04name\x95\x00\x0btshefi_cli2\x07deleted\x08\x00\x10container_format\x95\x00\x04bare\x07min_ram1\x00\x00\x00\x00\x00\x00\x00\x00\x0bdisk_format\x95\x00\x03raw\nupdated_at\x95\x00\x132014-05-01T08:21:51\nproperties\xa8\x00\x00\x00\x04\x00\x00\x00\x00\x08min_disk1\x00\x00\x00\x00\x00\x00\x00\x00\tprotected\x08\x00\x08checksum\x95\x00 3ed25f2f8aa24d6807c48e6588861382\x05owner\x95\x00 5502ab8e099843cfa39df71b3037ccd6\tis_public\x08\x00\ndeleted_at\xf0\x02id\x95\x00$ac574a2b-6e68-4833-89f3-16a94e7f3479\x04size1\x00\x00\x00\x01\x80\x00\x00\x01') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.812 2459 DEBUG qpid.messaging [-] SENT[4504878]: Message(properties={'qpid.subject': 'notifications.info'}, content={'event_type': 'image.activate', 'timestamp': '2014-05-01 08:21:51.797346', 'message_id': '805868f5-3b9f-4992-9683-bc605bae61e3', 'priority': 'INFO', 'publisher_id': 'orange-vdsf.qa.lab.tlv.redhat.com', 'payload': {u'status': u'active', u'created_at': u'2014-05-01T08:19:47', u'name': u'tshefi_cli2', u'deleted': False, u'container_format': u'bare', u'min_ram': 0, u'disk_format': u'raw', u'updated_at': u'2014-05-01T08:21:51', u'properties': {}, u'min_disk': 0, u'protected': False, u'checksum': u'3ed25f2f8aa24d6807c48e6588861382', u'owner': u'5502ab8e099843cfa39df71b3037ccd6', u'is_public': False, u'deleted_at': None, u'id': u'ac574a2b-6e68-4833-89f3-16a94e7f3479', u'size': 6442450945}}) send /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:1280
>2014-05-01 11:21:51.813 2459 DEBUG qpid.messaging.io.raw [-] SENT[4092290]: '\x0b\x01\x00\x19\x00\x01\x00\x00\x00\x00\x00\x00\x04\x01\x01\x01\x01\x00\x06glance\x03\x02\x00b\x00\x01\x00\x00\x00\x00\x00\x00\x00\x00\x00\x17\x04\x01\x00\x02\x12notifications.info\x00\x00\x007\x04\x03\x10\x01\x08amqp/map\x00\x00\x00&\x00\x00\x00\x01\x0cqpid.subject\x95\x00\x12notifications.info\x07\x03\x02\\\x00\x01\x00\x00\x00\x00\x00\x00\x00\x00\x02L\x00\x00\x00\x06\nevent_type\x95\x00\x0eimage.activate\ttimestamp\x95\x00\x1a2014-05-01 08:21:51.797346\nmessage_id\x95\x00$805868f5-3b9f-4992-9683-bc605bae61e3\x08priority\x95\x00\x04INFO\x0cpublisher_id\x95\x00!orange-vdsf.qa.lab.tlv.redhat.com\x07payload\xa8\x00\x00\x01\x85\x00\x00\x00\x11\x06status\x95\x00\x06active\ncreated_at\x95\x00\x132014-05-01T08:19:47\x04name\x95\x00\x0btshefi_cli2\x07deleted\x08\x00\x10container_format\x95\x00\x04bare\x07min_ram1\x00\x00\x00\x00\x00\x00\x00\x00\x0bdisk_format\x95\x00\x03raw\nupdated_at\x95\x00\x132014-05-01T08:21:51\nproperties\xa8\x00\x00\x00\x04\x00\x00\x00\x00\x08min_disk1\x00\x00\x00\x00\x00\x00\x00\x00\tprotected\x08\x00\x08checksum\x95\x00 3ed25f2f8aa24d6807c48e6588861382\x05owner\x95\x00 5502ab8e099843cfa39df71b3037ccd6\tis_public\x08\x00\ndeleted_at\xf0\x02id\x95\x00$ac574a2b-6e68-4833-89f3-16a94e7f3479\x04size1\x00\x00\x00\x01\x80\x00\x00\x01' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.813 2459 DEBUG qpid.messaging.io.raw [-] READ[4092290]: '\x0f\x00\x00\x1a\x00\x00\x00\x00\x00\x00\x00\x00\x02\n\x01\x00\x00\x08\x00\x00\x00\x00\x00\x00\x00\x02' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.813 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4092290]: SessionCompleted(commands=[0-2]) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.814 2459 DEBUG qpid.messaging [-] RACK[4504878]: Message(properties={'qpid.subject': 'notifications.info'}, content={'event_type': 'image.activate', 'timestamp': '2014-05-01 08:21:51.797346', 'message_id': '805868f5-3b9f-4992-9683-bc605bae61e3', 'priority': 'INFO', 'publisher_id': 'orange-vdsf.qa.lab.tlv.redhat.com', 'payload': {u'status': u'active', u'created_at': u'2014-05-01T08:19:47', u'name': u'tshefi_cli2', u'deleted': False, u'container_format': u'bare', u'min_ram': 0, u'disk_format': u'raw', u'updated_at': u'2014-05-01T08:21:51', u'properties': {}, u'min_disk': 0, u'protected': False, u'checksum': u'3ed25f2f8aa24d6807c48e6588861382', u'owner': u'5502ab8e099843cfa39df71b3037ccd6', u'is_public': False, u'deleted_at': None, u'id': u'ac574a2b-6e68-4833-89f3-16a94e7f3479', u'size': 6442450945}}) msg_acked /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:1269
>2014-05-01 11:21:51.815 2459 DEBUG qpid.messaging.io.ops [-] SENT[4092290]: SessionDetach(name='2a690124-c3b5-449f-b472-a7dae5a0956a:0') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.815 2459 DEBUG qpid.messaging.io.raw [-] SENT[4092290]: '\x0f\x00\x008\x00\x00\x00\x00\x00\x00\x00\x00\x02\x03\x01\x00\x00&2a690124-c3b5-449f-b472-a7dae5a0956a:0' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.816 2459 DEBUG qpid.messaging.io.raw [-] READ[4092290]: '\x0f\x00\x009\x00\x00\x00\x00\x00\x00\x00\x00\x02\x04\x03\x00\x00&2a690124-c3b5-449f-b472-a7dae5a0956a:0\x00' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.816 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4092290]: SessionDetached(name='2a690124-c3b5-449f-b472-a7dae5a0956a:0', code=0) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.816 2459 DEBUG qpid.messaging.io.ops [-] SENT[4092290]: ConnectionClose(reply_code=200) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.817 2459 DEBUG qpid.messaging.io.raw [-] SENT[4092290]: '\x0f\x00\x00\x12\x00\x00\x00\x00\x00\x00\x00\x00\x01\x0b\x01\x00\x00\xc8' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.817 2459 DEBUG qpid.messaging.io.raw [-] READ[4092290]: '\x0f\x00\x00\x10\x00\x00\x00\x00\x00\x00\x00\x00\x01\x0c\x00\x00' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.818 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4092290]: ConnectionCloseOk() write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.819 2459 DEBUG qpid.messaging.io.raw [-] OPEN[444b998]: 10.35.160.73:5672 connect /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:530
>2014-05-01 11:21:51.820 2459 DEBUG qpid.messaging.io.raw [-] SENT[444b998]: 'AMQP\x01\x01\x00\n' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.820 2459 DEBUG qpid.messaging.io.raw [-] READ[444b998]: 'AMQP\x01\x01\x00\n\x0f\x00\x00~\x00\x00\x00\x00\x00\x00\x00\x00\x01\x01\x07\x00\x00\x00\x00?\x00\x00\x00\x01\x13qpid.federation_tag\x95\x00$62e96915-063e-4b1b-b169-c90278559d74\x00\x00\x00\x17\x95\x00\x00\x00\x02\x00\tANONYMOUS\x00\x05PLAIN\x00\x00\x00\x0c\x95\x00\x00\x00\x01\x00\x05en_US' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.821 2459 DEBUG qpid.messaging.io.ops [-] RCVD[444b998]: ConnectionStart(server_properties={u'qpid.federation_tag': u'62e96915-063e-4b1b-b169-c90278559d74'}, mechanisms=[u'ANONYMOUS', u'PLAIN'], locales=[u'en_US']) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.821 2459 DEBUG qpid.messaging.io.ops [-] SENT[444b998]: ConnectionStartOk(client_properties={'product': 'qpid python client', 'qpid.client_ppid': 2451, 'qpid.client_process': 'glance-api', 'platform': 'posix', 'qpid.client_pid': 2459, 'version': 'development'}, mechanism='ANONYMOUS', response='anonymous@orange-vdsf.qa.lab.tlv.redhat.com') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.822 2459 DEBUG qpid.messaging.io.raw [-] SENT[444b998]: '\x0f\x00\x00\xe9\x00\x00\x00\x00\x00\x00\x00\x00\x01\x02\x07\x00\x00\x00\x00\x9c\x00\x00\x00\x06\x07product\x95\x00\x12qpid python client\x10qpid.client_ppid1\x00\x00\x00\x00\x00\x00\t\x93\x13qpid.client_process\x95\x00\nglance-api\x08platform\x95\x00\x05posix\x0fqpid.client_pid1\x00\x00\x00\x00\x00\x00\t\x9b\x07version\x95\x00\x0bdevelopment\tANONYMOUS\x00\x00\x00+anonymous@orange-vdsf.qa.lab.tlv.redhat.com' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.822 2459 DEBUG qpid.messaging.io.raw [-] READ[444b998]: '\x0f\x00\x00\x18\x00\x00\x00\x00\x00\x00\x00\x00\x01\x05\x0f\x00\x7f\xff\xff\xff\x00\x00\x00x' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.823 2459 DEBUG qpid.messaging.io.ops [-] RCVD[444b998]: ConnectionTune(channel_max=32767, max_frame_size=65535, heartbeat_min=0, heartbeat_max=120) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.823 2459 DEBUG qpid.messaging.io.ops [-] SENT[444b998]: ConnectionTuneOk(channel_max=32767, heartbeat=60) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.823 2459 DEBUG qpid.messaging.io.ops [-] SENT[444b998]: ConnectionOpen() write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.824 2459 DEBUG qpid.messaging.io.raw [-] SENT[444b998]: '\x0f\x00\x00\x14\x00\x00\x00\x00\x00\x00\x00\x00\x01\x06\x05\x00\x7f\xff\x00<\x0f\x00\x00\x10\x00\x00\x00\x00\x00\x00\x00\x00\x01\x07\x00\x00' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.824 2459 DEBUG qpid.messaging.io.raw [-] READ[444b998]: '\x0f\x00\x005\x00\x00\x00\x00\x00\x00\x00\x00\x01\x08\x01\x00\x00\x00\x00!\x95\x00\x00\x00\x01\x00\x1aamqp:tcp:10.35.160.73:5672' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.825 2459 DEBUG qpid.messaging.io.ops [-] RCVD[444b998]: ConnectionOpenOk(known_hosts=[u'amqp:tcp:10.35.160.73:5672']) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.825 2459 INFO glance.notifier.notify_qpid [-] Connected to AMQP server on 10.35.160.73:5672
>2014-05-01 11:21:51.825 2459 DEBUG qpid.messaging.io.ops [-] SENT[444b998]: SessionAttach(name='6770aaa0-581a-4d8c-bd0d-7915cc6bf88b:0') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.826 2459 DEBUG qpid.messaging.io.ops [-] SENT[444b998]: SessionCommandPoint(command_id=serial(0), command_offset=0) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.827 2459 DEBUG qpid.messaging.io.ops [-] SENT[444b998]: ExchangeQuery(name='glance', id=serial(0), sync=True) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.827 2459 DEBUG qpid.messaging.io.ops [-] SENT[444b998]: QueueQuery(queue='glance', id=serial(1), sync=True) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.827 2459 DEBUG qpid.messaging.io.raw [-] SENT[444b998]: '\x0f\x00\x008\x00\x00\x00\x00\x00\x00\x00\x00\x02\x01\x01\x00\x00&6770aaa0-581a-4d8c-bd0d-7915cc6bf88b:0\x0f\x00\x00\x1c\x00\x00\x00\x00\x00\x00\x00\x00\x02\x07\x03\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x0f\x01\x00\x19\x00\x01\x00\x00\x00\x00\x00\x00\x07\x03\x01\x01\x01\x00\x06glance\x0f\x01\x00\x19\x00\x01\x00\x00\x00\x00\x00\x00\x08\x04\x01\x01\x01\x00\x06glance' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.828 2459 DEBUG qpid.messaging.io.raw [-] READ[444b998]: '\x0f\x00\x008\x00\x00\x00\x00\x00\x00\x00\x00\x02\x02\x01\x00\x00&6770aaa0-581a-4d8c-bd0d-7915cc6bf88b:0\x0f\x00\x00\x1c\x00\x00\x00\x00\x00\x00\x00\x00\x02\x07\x03\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x0f\x01\x00,\x00\x01\x00\x00\x00\x00\x00\x00\x03\x02\x01\x00\x03\x00\x00\x00\x00\x00\x00\x00\x00\x12\x07\x01\t\x00\x05topic\x00\x00\x00\x04\x00\x00\x00\x00\x0f\x00\x00\x1a\x00\x00\x00\x00\x00\x00\x00\x00\x02\n\x01\x00\x00\x08\x00\x00\x00\x00\x00\x00\x00\x00\x0f\x01\x00\x1e\x00\x01\x00\x00\x00\x00\x00\x00\x03\x02\x01\x00\x03\x00\x00\x00\x00\x01\x00\x00\x00\x04\x08\x01\x00\x00\x0f\x00\x00\x1a\x00\x00\x00\x00\x00\x00\x00\x00\x02\n\x01\x00\x00\x08\x00\x00\x00\x00\x00\x00\x00\x01' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.828 2459 DEBUG qpid.messaging.io.ops [-] RCVD[444b998]: SessionAttached(name='6770aaa0-581a-4d8c-bd0d-7915cc6bf88b:0') write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.829 2459 DEBUG qpid.messaging.io.ops [-] RCVD[444b998]: SessionCommandPoint(command_id=serial(0), command_offset=0) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.829 2459 DEBUG qpid.messaging.io.ops [-] RCVD[444b998]: ExecutionResult(command_id=serial(0), value=ExchangeQueryResult(type=u'topic', arguments={}), id=serial(0)) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.829 2459 DEBUG qpid.messaging.io.ops [-] RCVD[444b998]: SessionCompleted(commands=[0-0]) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.829 2459 DEBUG qpid.messaging.io.ops [-] RCVD[444b998]: ExecutionResult(command_id=serial(1), value=QueueQueryResult(), id=serial(1)) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.829 2459 DEBUG qpid.messaging.io.ops [-] RCVD[444b998]: SessionCompleted(commands=[0-1]) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.831 2459 DEBUG qpid.messaging.io.ops [-] SENT[444b998]: MessageTransfer(destination='glance', id=serial(2), sync=True, headers=(DeliveryProperties(routing_key='notifications.info'), MessageProperties(content_type='amqp/map', application_headers={'qpid.subject': 'notifications.info'})), payload='\x00\x00\x02J\x00\x00\x00\x06\nevent_type\x95\x00\x0cimage.update\ttimestamp\x95\x00\x1a2014-05-01 08:21:51.818659\nmessage_id\x95\x00$7f3398cc-5494-460b-aa7a-d4838a2a47f5\x08priority\x95\x00\x04INFO\x0cpublisher_id\x95\x00!orange-vdsf.qa.lab.tlv.redhat.com\x07payload\xa8\x00\x00\x01\x85\x00\x00\x00\x11\x06status\x95\x00\x06active\ncreated_at\x95\x00\x132014-05-01T08:19:47\x04name\x95\x00\x0btshefi_cli2\x07deleted\x08\x00\x10container_format\x95\x00\x04bare\x07min_ram1\x00\x00\x00\x00\x00\x00\x00\x00\x0bdisk_format\x95\x00\x03raw\nupdated_at\x95\x00\x132014-05-01T08:21:51\nproperties\xa8\x00\x00\x00\x04\x00\x00\x00\x00\x08min_disk1\x00\x00\x00\x00\x00\x00\x00\x00\tprotected\x08\x00\x08checksum\x95\x00 3ed25f2f8aa24d6807c48e6588861382\x05owner\x95\x00 5502ab8e099843cfa39df71b3037ccd6\tis_public\x08\x00\ndeleted_at\xf0\x02id\x95\x00$ac574a2b-6e68-4833-89f3-16a94e7f3479\x04size1\x00\x00\x00\x01\x80\x00\x00\x01') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.831 2459 DEBUG qpid.messaging [-] SENT[4584098]: Message(properties={'qpid.subject': 'notifications.info'}, content={'event_type': 'image.update', 'timestamp': '2014-05-01 08:21:51.818659', 'message_id': '7f3398cc-5494-460b-aa7a-d4838a2a47f5', 'priority': 'INFO', 'publisher_id': 'orange-vdsf.qa.lab.tlv.redhat.com', 'payload': {u'status': u'active', u'created_at': u'2014-05-01T08:19:47', u'name': u'tshefi_cli2', u'deleted': False, u'container_format': u'bare', u'min_ram': 0, u'disk_format': u'raw', u'updated_at': u'2014-05-01T08:21:51', u'properties': {}, u'min_disk': 0, u'protected': False, u'checksum': u'3ed25f2f8aa24d6807c48e6588861382', u'owner': u'5502ab8e099843cfa39df71b3037ccd6', u'is_public': False, u'deleted_at': None, u'id': u'ac574a2b-6e68-4833-89f3-16a94e7f3479', u'size': 6442450945}}) send /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:1280
>2014-05-01 11:21:51.832 2459 DEBUG qpid.messaging.io.raw [-] SENT[444b998]: '\x0b\x01\x00\x19\x00\x01\x00\x00\x00\x00\x00\x00\x04\x01\x01\x01\x01\x00\x06glance\x03\x02\x00b\x00\x01\x00\x00\x00\x00\x00\x00\x00\x00\x00\x17\x04\x01\x00\x02\x12notifications.info\x00\x00\x007\x04\x03\x10\x01\x08amqp/map\x00\x00\x00&\x00\x00\x00\x01\x0cqpid.subject\x95\x00\x12notifications.info\x07\x03\x02Z\x00\x01\x00\x00\x00\x00\x00\x00\x00\x00\x02J\x00\x00\x00\x06\nevent_type\x95\x00\x0cimage.update\ttimestamp\x95\x00\x1a2014-05-01 08:21:51.818659\nmessage_id\x95\x00$7f3398cc-5494-460b-aa7a-d4838a2a47f5\x08priority\x95\x00\x04INFO\x0cpublisher_id\x95\x00!orange-vdsf.qa.lab.tlv.redhat.com\x07payload\xa8\x00\x00\x01\x85\x00\x00\x00\x11\x06status\x95\x00\x06active\ncreated_at\x95\x00\x132014-05-01T08:19:47\x04name\x95\x00\x0btshefi_cli2\x07deleted\x08\x00\x10container_format\x95\x00\x04bare\x07min_ram1\x00\x00\x00\x00\x00\x00\x00\x00\x0bdisk_format\x95\x00\x03raw\nupdated_at\x95\x00\x132014-05-01T08:21:51\nproperties\xa8\x00\x00\x00\x04\x00\x00\x00\x00\x08min_disk1\x00\x00\x00\x00\x00\x00\x00\x00\tprotected\x08\x00\x08checksum\x95\x00 3ed25f2f8aa24d6807c48e6588861382\x05owner\x95\x00 5502ab8e099843cfa39df71b3037ccd6\tis_public\x08\x00\ndeleted_at\xf0\x02id\x95\x00$ac574a2b-6e68-4833-89f3-16a94e7f3479\x04size1\x00\x00\x00\x01\x80\x00\x00\x01' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.832 2459 DEBUG qpid.messaging.io.raw [-] READ[444b998]: '\x0f\x00\x00\x1a\x00\x00\x00\x00\x00\x00\x00\x00\x02\n\x01\x00\x00\x08\x00\x00\x00\x00\x00\x00\x00\x02' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.832 2459 DEBUG qpid.messaging.io.ops [-] RCVD[444b998]: SessionCompleted(commands=[0-2]) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.832 2459 DEBUG qpid.messaging [-] RACK[4584098]: Message(properties={'qpid.subject': 'notifications.info'}, content={'event_type': 'image.update', 'timestamp': '2014-05-01 08:21:51.818659', 'message_id': '7f3398cc-5494-460b-aa7a-d4838a2a47f5', 'priority': 'INFO', 'publisher_id': 'orange-vdsf.qa.lab.tlv.redhat.com', 'payload': {u'status': u'active', u'created_at': u'2014-05-01T08:19:47', u'name': u'tshefi_cli2', u'deleted': False, u'container_format': u'bare', u'min_ram': 0, u'disk_format': u'raw', u'updated_at': u'2014-05-01T08:21:51', u'properties': {}, u'min_disk': 0, u'protected': False, u'checksum': u'3ed25f2f8aa24d6807c48e6588861382', u'owner': u'5502ab8e099843cfa39df71b3037ccd6', u'is_public': False, u'deleted_at': None, u'id': u'ac574a2b-6e68-4833-89f3-16a94e7f3479', u'size': 6442450945}}) msg_acked /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:1269
>2014-05-01 11:21:51.833 2459 DEBUG qpid.messaging.io.ops [-] SENT[444b998]: SessionDetach(name='6770aaa0-581a-4d8c-bd0d-7915cc6bf88b:0') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.833 2459 DEBUG qpid.messaging.io.raw [-] SENT[444b998]: '\x0f\x00\x008\x00\x00\x00\x00\x00\x00\x00\x00\x02\x03\x01\x00\x00&6770aaa0-581a-4d8c-bd0d-7915cc6bf88b:0' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.834 2459 DEBUG qpid.messaging.io.raw [-] READ[444b998]: '\x0f\x00\x009\x00\x00\x00\x00\x00\x00\x00\x00\x02\x04\x03\x00\x00&6770aaa0-581a-4d8c-bd0d-7915cc6bf88b:0\x00' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.834 2459 DEBUG qpid.messaging.io.ops [-] RCVD[444b998]: SessionDetached(name='6770aaa0-581a-4d8c-bd0d-7915cc6bf88b:0', code=0) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:21:51.834 2459 DEBUG qpid.messaging.io.ops [-] SENT[444b998]: ConnectionClose(reply_code=200) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:21:51.835 2459 DEBUG qpid.messaging.io.raw [-] SENT[444b998]: '\x0f\x00\x00\x12\x00\x00\x00\x00\x00\x00\x00\x00\x01\x0b\x01\x00\x00\xc8' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:21:51.835 2459 DEBUG qpid.messaging.io.raw [-] READ[444b998]: '\x0f\x00\x00\x10\x00\x00\x00\x00\x00\x00\x00\x00\x01\x0c\x00\x00' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:21:51.835 2459 DEBUG qpid.messaging.io.ops [-] RCVD[444b998]: ConnectionCloseOk() write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:26:04.537 2458 DEBUG glance.api.middleware.version_negotiation [-] Determining version of request: GET /v1/images/detail Accept:  process_request /usr/lib/python2.6/site-packages/glance/api/middleware/version_negotiation.py:46
>2014-05-01 11:26:04.537 2458 DEBUG glance.api.middleware.version_negotiation [-] Using url versioning process_request /usr/lib/python2.6/site-packages/glance/api/middleware/version_negotiation.py:59
>2014-05-01 11:26:04.538 2458 DEBUG glance.api.middleware.version_negotiation [-] Matched version: v1 process_request /usr/lib/python2.6/site-packages/glance/api/middleware/version_negotiation.py:71
>2014-05-01 11:26:04.538 2458 DEBUG glance.api.middleware.version_negotiation [-] new path /v1/images/detail process_request /usr/lib/python2.6/site-packages/glance/api/middleware/version_negotiation.py:72
>2014-05-01 11:26:04.538 2458 DEBUG keystoneclient.middleware.auth_token [-] Authenticating user token __call__ /usr/lib/python2.6/site-packages/keystoneclient/middleware/auth_token.py:569
>2014-05-01 11:26:04.538 2458 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 /usr/lib/python2.6/site-packages/keystoneclient/middleware/auth_token.py:628
>2014-05-01 11:26:04.540 2458 INFO urllib3.connectionpool [-] Starting new HTTP connection (1): 10.35.160.73
>2014-05-01 11:26:04.571 2458 DEBUG urllib3.connectionpool [-] "GET /v2.0/tokens/revoked HTTP/1.1" 200 686 _make_request /usr/lib/python2.6/site-packages/urllib3/connectionpool.py:295
>2014-05-01 11:26:04.608 2458 DEBUG iso8601.iso8601 [-] Parsed 2014-05-02T08:26:04Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'08', 'tz_hour': None, 'month': u'05', 'timezone': u'Z', 'second': u'04', 'tz_minute': None, 'year': u'2014', 'separator': u'T', 'day': u'02', 'minute': u'26'} with default timezone <iso8601.iso8601.Utc object at 0x29d4050> parse_date /usr/lib/python2.6/site-packages/iso8601/iso8601.py:166
>2014-05-01 11:26:04.609 2458 DEBUG iso8601.iso8601 [-] Got u'2014' for 'year' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:26:04.609 2458 DEBUG iso8601.iso8601 [-] Got u'05' for 'month' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:26:04.609 2458 DEBUG iso8601.iso8601 [-] Got u'02' for 'day' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:26:04.609 2458 DEBUG iso8601.iso8601 [-] Got u'08' for 'hour' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:26:04.610 2458 DEBUG iso8601.iso8601 [-] Got u'26' for 'minute' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:26:04.610 2458 DEBUG iso8601.iso8601 [-] Got u'04' for 'second' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:26:04.610 2458 DEBUG keystoneclient.middleware.auth_token [-] Storing token in cache _cache_put /usr/lib/python2.6/site-packages/keystoneclient/middleware/auth_token.py:1144
>2014-05-01 11:26:04.611 2458 DEBUG keystoneclient.middleware.auth_token [-] Received request from user: 81c761b68ebb423cb29312b8bede978a with project_id : 5502ab8e099843cfa39df71b3037ccd6 and roles: admin  _build_user_headers /usr/lib/python2.6/site-packages/keystoneclient/middleware/auth_token.py:933
>2014-05-01 11:26:04.615 2458 DEBUG routes.middleware [-] Matched GET /images/detail __call__ /usr/lib/python2.6/site-packages/Routes-1.12.3-py2.6.egg/routes/middleware.py:100
>2014-05-01 11:26:04.615 2458 DEBUG routes.middleware [-] Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x40857d0>} __call__ /usr/lib/python2.6/site-packages/Routes-1.12.3-py2.6.egg/routes/middleware.py:102
>2014-05-01 11:26:04.615 2458 DEBUG routes.middleware [-] Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x40857d0>} __call__ /usr/lib/python2.6/site-packages/Routes-1.12.3-py2.6.egg/routes/middleware.py:103
>2014-05-01 11:26:04.616 2458 DEBUG glance.api.policy [f52c6b98-4e38-417a-9289-9f15d5d695c3 81c761b68ebb423cb29312b8bede978a 5502ab8e099843cfa39df71b3037ccd6] Loaded policy rules: {u'context_is_admin': 'role:admin', u'default': '@', u'manage_image_cache': 'role:admin'} load_rules /usr/lib/python2.6/site-packages/glance/api/policy.py:75
>2014-05-01 11:26:04.617 2458 DEBUG glance.common.client [f52c6b98-4e38-417a-9289-9f15d5d695c3 81c761b68ebb423cb29312b8bede978a 5502ab8e099843cfa39df71b3037ccd6] Constructed URL: http://0.0.0.0:9191/images/detail?limit=10 _construct_url /usr/lib/python2.6/site-packages/glance/common/client.py:408
>2014-05-01 11:26:04.734 2458 DEBUG glance.registry.client.v1.client [f52c6b98-4e38-417a-9289-9f15d5d695c3 81c761b68ebb423cb29312b8bede978a 5502ab8e099843cfa39df71b3037ccd6] Registry request GET /images/detail HTTP 200 request id req-21fab0d7-86f2-4336-97f1-d7d377af7c85 do_request /usr/lib/python2.6/site-packages/glance/registry/client/v1/client.py:115
>2014-05-01 11:31:04.533 2458 DEBUG glance.api.middleware.version_negotiation [-] Determining version of request: GET /v1/images/detail Accept:  process_request /usr/lib/python2.6/site-packages/glance/api/middleware/version_negotiation.py:46
>2014-05-01 11:31:04.534 2458 DEBUG glance.api.middleware.version_negotiation [-] Using url versioning process_request /usr/lib/python2.6/site-packages/glance/api/middleware/version_negotiation.py:59
>2014-05-01 11:31:04.534 2458 DEBUG glance.api.middleware.version_negotiation [-] Matched version: v1 process_request /usr/lib/python2.6/site-packages/glance/api/middleware/version_negotiation.py:71
>2014-05-01 11:31:04.534 2458 DEBUG glance.api.middleware.version_negotiation [-] new path /v1/images/detail process_request /usr/lib/python2.6/site-packages/glance/api/middleware/version_negotiation.py:72
>2014-05-01 11:31:04.534 2458 DEBUG keystoneclient.middleware.auth_token [-] Authenticating user token __call__ /usr/lib/python2.6/site-packages/keystoneclient/middleware/auth_token.py:569
>2014-05-01 11:31:04.535 2458 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 /usr/lib/python2.6/site-packages/keystoneclient/middleware/auth_token.py:628
>2014-05-01 11:31:04.550 2458 DEBUG iso8601.iso8601 [-] Parsed 2014-05-02T08:31:04Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'08', 'tz_hour': None, 'month': u'05', 'timezone': u'Z', 'second': u'04', 'tz_minute': None, 'year': u'2014', 'separator': u'T', 'day': u'02', 'minute': u'31'} with default timezone <iso8601.iso8601.Utc object at 0x29d4050> parse_date /usr/lib/python2.6/site-packages/iso8601/iso8601.py:166
>2014-05-01 11:31:04.551 2458 DEBUG iso8601.iso8601 [-] Got u'2014' for 'year' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:31:04.551 2458 DEBUG iso8601.iso8601 [-] Got u'05' for 'month' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:31:04.551 2458 DEBUG iso8601.iso8601 [-] Got u'02' for 'day' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:31:04.551 2458 DEBUG iso8601.iso8601 [-] Got u'08' for 'hour' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:31:04.551 2458 DEBUG iso8601.iso8601 [-] Got u'31' for 'minute' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:31:04.552 2458 DEBUG iso8601.iso8601 [-] Got u'04' for 'second' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:31:04.552 2458 DEBUG keystoneclient.middleware.auth_token [-] Storing token in cache _cache_put /usr/lib/python2.6/site-packages/keystoneclient/middleware/auth_token.py:1144
>2014-05-01 11:31:04.553 2458 DEBUG keystoneclient.middleware.auth_token [-] Received request from user: 81c761b68ebb423cb29312b8bede978a with project_id : 5502ab8e099843cfa39df71b3037ccd6 and roles: admin  _build_user_headers /usr/lib/python2.6/site-packages/keystoneclient/middleware/auth_token.py:933
>2014-05-01 11:31:04.557 2458 DEBUG routes.middleware [-] Matched GET /images/detail __call__ /usr/lib/python2.6/site-packages/Routes-1.12.3-py2.6.egg/routes/middleware.py:100
>2014-05-01 11:31:04.557 2458 DEBUG routes.middleware [-] Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x40857d0>} __call__ /usr/lib/python2.6/site-packages/Routes-1.12.3-py2.6.egg/routes/middleware.py:102
>2014-05-01 11:31:04.557 2458 DEBUG routes.middleware [-] Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x40857d0>} __call__ /usr/lib/python2.6/site-packages/Routes-1.12.3-py2.6.egg/routes/middleware.py:103
>2014-05-01 11:31:04.558 2458 DEBUG glance.api.policy [7ba777fb-6ebc-4bb1-81c2-01153da1bb99 81c761b68ebb423cb29312b8bede978a 5502ab8e099843cfa39df71b3037ccd6] Loaded policy rules: {u'context_is_admin': 'role:admin', u'default': '@', u'manage_image_cache': 'role:admin'} load_rules /usr/lib/python2.6/site-packages/glance/api/policy.py:75
>2014-05-01 11:31:04.558 2458 DEBUG glance.common.client [7ba777fb-6ebc-4bb1-81c2-01153da1bb99 81c761b68ebb423cb29312b8bede978a 5502ab8e099843cfa39df71b3037ccd6] Constructed URL: http://0.0.0.0:9191/images/detail?limit=10 _construct_url /usr/lib/python2.6/site-packages/glance/common/client.py:408
>2014-05-01 11:31:04.628 2458 DEBUG glance.registry.client.v1.client [7ba777fb-6ebc-4bb1-81c2-01153da1bb99 81c761b68ebb423cb29312b8bede978a 5502ab8e099843cfa39df71b3037ccd6] Registry request GET /images/detail HTTP 200 request id req-2fdddbd3-67ae-4973-9db6-52920519bd02 do_request /usr/lib/python2.6/site-packages/glance/registry/client/v1/client.py:115
>2014-05-01 11:35:03.950 2459 DEBUG glance.api.middleware.version_negotiation [-] Determining version of request: POST /v1/images Accept:  process_request /usr/lib/python2.6/site-packages/glance/api/middleware/version_negotiation.py:46
>2014-05-01 11:35:03.951 2459 DEBUG glance.api.middleware.version_negotiation [-] Using url versioning process_request /usr/lib/python2.6/site-packages/glance/api/middleware/version_negotiation.py:59
>2014-05-01 11:35:03.951 2459 DEBUG glance.api.middleware.version_negotiation [-] Matched version: v1 process_request /usr/lib/python2.6/site-packages/glance/api/middleware/version_negotiation.py:71
>2014-05-01 11:35:03.952 2459 DEBUG glance.api.middleware.version_negotiation [-] new path /v1/images process_request /usr/lib/python2.6/site-packages/glance/api/middleware/version_negotiation.py:72
>2014-05-01 11:35:03.952 2459 DEBUG keystoneclient.middleware.auth_token [-] Authenticating user token __call__ /usr/lib/python2.6/site-packages/keystoneclient/middleware/auth_token.py:569
>2014-05-01 11:35:03.952 2459 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 /usr/lib/python2.6/site-packages/keystoneclient/middleware/auth_token.py:628
>2014-05-01 11:35:03.954 2459 INFO urllib3.connectionpool [-] Starting new HTTP connection (1): 10.35.160.73
>2014-05-01 11:35:03.989 2459 DEBUG urllib3.connectionpool [-] "GET /v2.0/tokens/revoked HTTP/1.1" 200 686 _make_request /usr/lib/python2.6/site-packages/urllib3/connectionpool.py:295
>2014-05-01 11:35:04.024 2459 DEBUG iso8601.iso8601 [-] Parsed 2014-05-02T08:35:03Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'08', 'tz_hour': None, 'month': u'05', 'timezone': u'Z', 'second': u'03', 'tz_minute': None, 'year': u'2014', 'separator': u'T', 'day': u'02', 'minute': u'35'} with default timezone <iso8601.iso8601.Utc object at 0x29d4050> parse_date /usr/lib/python2.6/site-packages/iso8601/iso8601.py:166
>2014-05-01 11:35:04.025 2459 DEBUG iso8601.iso8601 [-] Got u'2014' for 'year' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:35:04.025 2459 DEBUG iso8601.iso8601 [-] Got u'05' for 'month' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:35:04.025 2459 DEBUG iso8601.iso8601 [-] Got u'02' for 'day' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:35:04.025 2459 DEBUG iso8601.iso8601 [-] Got u'08' for 'hour' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:35:04.025 2459 DEBUG iso8601.iso8601 [-] Got u'35' for 'minute' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:35:04.026 2459 DEBUG iso8601.iso8601 [-] Got u'03' for 'second' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:35:04.026 2459 DEBUG keystoneclient.middleware.auth_token [-] Storing token in cache _cache_put /usr/lib/python2.6/site-packages/keystoneclient/middleware/auth_token.py:1144
>2014-05-01 11:35:04.027 2459 DEBUG keystoneclient.middleware.auth_token [-] Received request from user: 81c761b68ebb423cb29312b8bede978a with project_id : 5502ab8e099843cfa39df71b3037ccd6 and roles: admin  _build_user_headers /usr/lib/python2.6/site-packages/keystoneclient/middleware/auth_token.py:933
>2014-05-01 11:35:04.031 2459 DEBUG routes.middleware [-] Matched POST /images __call__ /usr/lib/python2.6/site-packages/Routes-1.12.3-py2.6.egg/routes/middleware.py:100
>2014-05-01 11:35:04.031 2459 DEBUG routes.middleware [-] Route path: '/images', defaults: {'action': u'create', 'controller': <glance.common.wsgi.Resource object at 0x40857d0>} __call__ /usr/lib/python2.6/site-packages/Routes-1.12.3-py2.6.egg/routes/middleware.py:102
>2014-05-01 11:35:04.031 2459 DEBUG routes.middleware [-] Match dict: {'action': u'create', 'controller': <glance.common.wsgi.Resource object at 0x40857d0>} __call__ /usr/lib/python2.6/site-packages/Routes-1.12.3-py2.6.egg/routes/middleware.py:103
>2014-05-01 11:35:04.032 2459 DEBUG glance.api.policy [1c352829-7644-4c95-87e0-1cf3dc03ddd5 81c761b68ebb423cb29312b8bede978a 5502ab8e099843cfa39df71b3037ccd6] Loaded policy rules: {u'context_is_admin': 'role:admin', u'default': '@', u'manage_image_cache': 'role:admin'} load_rules /usr/lib/python2.6/site-packages/glance/api/policy.py:75
>2014-05-01 11:35:04.032 2459 DEBUG glance.api.policy [1c352829-7644-4c95-87e0-1cf3dc03ddd5 81c761b68ebb423cb29312b8bede978a 5502ab8e099843cfa39df71b3037ccd6] Loaded policy rules: {u'context_is_admin': 'role:admin', u'default': '@', u'manage_image_cache': 'role:admin'} load_rules /usr/lib/python2.6/site-packages/glance/api/policy.py:75
>2014-05-01 11:35:04.039 2459 DEBUG glance.registry.client.v1.api [1c352829-7644-4c95-87e0-1cf3dc03ddd5 81c761b68ebb423cb29312b8bede978a 5502ab8e099843cfa39df71b3037ccd6] Adding image metadata... add_image_metadata /usr/lib/python2.6/site-packages/glance/registry/client/v1/api.py:161
>2014-05-01 11:35:04.040 2459 DEBUG glance.common.client [1c352829-7644-4c95-87e0-1cf3dc03ddd5 81c761b68ebb423cb29312b8bede978a 5502ab8e099843cfa39df71b3037ccd6] Constructed URL: http://0.0.0.0:9191/images _construct_url /usr/lib/python2.6/site-packages/glance/common/client.py:408
>2014-05-01 11:35:04.216 2459 DEBUG glance.registry.client.v1.client [1c352829-7644-4c95-87e0-1cf3dc03ddd5 81c761b68ebb423cb29312b8bede978a 5502ab8e099843cfa39df71b3037ccd6] Registry request POST /images HTTP 200 request id req-c1ec4332-f60d-4d02-89c3-5d55cca1e249 do_request /usr/lib/python2.6/site-packages/glance/registry/client/v1/client.py:115
>2014-05-01 11:35:04.219 2459 DEBUG qpid.messaging.io.raw [-] OPEN[4584fc8]: 10.35.160.73:5672 connect /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:530
>2014-05-01 11:35:04.221 2459 DEBUG qpid.messaging.io.raw [-] SENT[4584fc8]: 'AMQP\x01\x01\x00\n' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:35:04.221 2459 DEBUG qpid.messaging.io.raw [-] READ[4584fc8]: 'AMQP\x01\x01\x00\n\x0f\x00\x00~\x00\x00\x00\x00\x00\x00\x00\x00\x01\x01\x07\x00\x00\x00\x00?\x00\x00\x00\x01\x13qpid.federation_tag\x95\x00$62e96915-063e-4b1b-b169-c90278559d74\x00\x00\x00\x17\x95\x00\x00\x00\x02\x00\tANONYMOUS\x00\x05PLAIN\x00\x00\x00\x0c\x95\x00\x00\x00\x01\x00\x05en_US' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:35:04.221 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4584fc8]: ConnectionStart(server_properties={u'qpid.federation_tag': u'62e96915-063e-4b1b-b169-c90278559d74'}, mechanisms=[u'ANONYMOUS', u'PLAIN'], locales=[u'en_US']) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.222 2459 DEBUG qpid.messaging.io.ops [-] SENT[4584fc8]: ConnectionStartOk(client_properties={'product': 'qpid python client', 'qpid.client_ppid': 2451, 'qpid.client_process': 'glance-api', 'platform': 'posix', 'qpid.client_pid': 2459, 'version': 'development'}, mechanism='ANONYMOUS', response='anonymous@orange-vdsf.qa.lab.tlv.redhat.com') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.222 2459 DEBUG qpid.messaging.io.raw [-] SENT[4584fc8]: '\x0f\x00\x00\xe9\x00\x00\x00\x00\x00\x00\x00\x00\x01\x02\x07\x00\x00\x00\x00\x9c\x00\x00\x00\x06\x07product\x95\x00\x12qpid python client\x10qpid.client_ppid1\x00\x00\x00\x00\x00\x00\t\x93\x13qpid.client_process\x95\x00\nglance-api\x08platform\x95\x00\x05posix\x0fqpid.client_pid1\x00\x00\x00\x00\x00\x00\t\x9b\x07version\x95\x00\x0bdevelopment\tANONYMOUS\x00\x00\x00+anonymous@orange-vdsf.qa.lab.tlv.redhat.com' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:35:04.223 2459 DEBUG qpid.messaging.io.raw [-] READ[4584fc8]: '\x0f\x00\x00\x18\x00\x00\x00\x00\x00\x00\x00\x00\x01\x05\x0f\x00\x7f\xff\xff\xff\x00\x00\x00x' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:35:04.223 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4584fc8]: ConnectionTune(channel_max=32767, max_frame_size=65535, heartbeat_min=0, heartbeat_max=120) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.224 2459 DEBUG qpid.messaging.io.ops [-] SENT[4584fc8]: ConnectionTuneOk(channel_max=32767, heartbeat=60) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.224 2459 DEBUG qpid.messaging.io.ops [-] SENT[4584fc8]: ConnectionOpen() write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.224 2459 DEBUG qpid.messaging.io.raw [-] SENT[4584fc8]: '\x0f\x00\x00\x14\x00\x00\x00\x00\x00\x00\x00\x00\x01\x06\x05\x00\x7f\xff\x00<\x0f\x00\x00\x10\x00\x00\x00\x00\x00\x00\x00\x00\x01\x07\x00\x00' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:35:04.225 2459 DEBUG qpid.messaging.io.raw [-] READ[4584fc8]: '\x0f\x00\x005\x00\x00\x00\x00\x00\x00\x00\x00\x01\x08\x01\x00\x00\x00\x00!\x95\x00\x00\x00\x01\x00\x1aamqp:tcp:10.35.160.73:5672' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:35:04.225 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4584fc8]: ConnectionOpenOk(known_hosts=[u'amqp:tcp:10.35.160.73:5672']) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.226 2459 INFO glance.notifier.notify_qpid [1c352829-7644-4c95-87e0-1cf3dc03ddd5 81c761b68ebb423cb29312b8bede978a 5502ab8e099843cfa39df71b3037ccd6] Connected to AMQP server on 10.35.160.73:5672
>2014-05-01 11:35:04.226 2459 DEBUG qpid.messaging.io.ops [-] SENT[4584fc8]: SessionAttach(name='b3ab0d35-e5f4-4398-bb35-fca0f9a7c64f:0') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.226 2459 DEBUG qpid.messaging.io.ops [-] SENT[4584fc8]: SessionCommandPoint(command_id=serial(0), command_offset=0) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.228 2459 DEBUG qpid.messaging.io.ops [-] SENT[4584fc8]: ExchangeQuery(name='glance', id=serial(0), sync=True) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.228 2459 DEBUG qpid.messaging.io.ops [-] SENT[4584fc8]: QueueQuery(queue='glance', id=serial(1), sync=True) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.229 2459 DEBUG qpid.messaging.io.raw [-] SENT[4584fc8]: '\x0f\x00\x008\x00\x00\x00\x00\x00\x00\x00\x00\x02\x01\x01\x00\x00&b3ab0d35-e5f4-4398-bb35-fca0f9a7c64f:0\x0f\x00\x00\x1c\x00\x00\x00\x00\x00\x00\x00\x00\x02\x07\x03\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x0f\x01\x00\x19\x00\x01\x00\x00\x00\x00\x00\x00\x07\x03\x01\x01\x01\x00\x06glance\x0f\x01\x00\x19\x00\x01\x00\x00\x00\x00\x00\x00\x08\x04\x01\x01\x01\x00\x06glance' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:35:04.229 2459 DEBUG qpid.messaging.io.raw [-] READ[4584fc8]: '\x0f\x00\x008\x00\x00\x00\x00\x00\x00\x00\x00\x02\x02\x01\x00\x00&b3ab0d35-e5f4-4398-bb35-fca0f9a7c64f:0\x0f\x00\x00\x1c\x00\x00\x00\x00\x00\x00\x00\x00\x02\x07\x03\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x0f\x01\x00,\x00\x01\x00\x00\x00\x00\x00\x00\x03\x02\x01\x00\x03\x00\x00\x00\x00\x00\x00\x00\x00\x12\x07\x01\t\x00\x05topic\x00\x00\x00\x04\x00\x00\x00\x00\x0f\x00\x00\x1a\x00\x00\x00\x00\x00\x00\x00\x00\x02\n\x01\x00\x00\x08\x00\x00\x00\x00\x00\x00\x00\x00\x0f\x01\x00\x1e\x00\x01\x00\x00\x00\x00\x00\x00\x03\x02\x01\x00\x03\x00\x00\x00\x00\x01\x00\x00\x00\x04\x08\x01\x00\x00\x0f\x00\x00\x1a\x00\x00\x00\x00\x00\x00\x00\x00\x02\n\x01\x00\x00\x08\x00\x00\x00\x00\x00\x00\x00\x01' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:35:04.230 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4584fc8]: SessionAttached(name='b3ab0d35-e5f4-4398-bb35-fca0f9a7c64f:0') write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.230 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4584fc8]: SessionCommandPoint(command_id=serial(0), command_offset=0) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.231 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4584fc8]: ExecutionResult(command_id=serial(0), value=ExchangeQueryResult(type=u'topic', arguments={}), id=serial(0)) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.231 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4584fc8]: SessionCompleted(commands=[0-0]) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.231 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4584fc8]: ExecutionResult(command_id=serial(1), value=QueueQueryResult(), id=serial(1)) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.232 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4584fc8]: SessionCompleted(commands=[0-1]) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.233 2459 DEBUG qpid.messaging.io.ops [-] SENT[4584fc8]: MessageTransfer(destination='glance', id=serial(2), sync=True, headers=(DeliveryProperties(routing_key='notifications.info'), MessageProperties(content_type='amqp/map', application_headers={'qpid.subject': 'notifications.info'})), payload='\x00\x00\x02(\x00\x00\x00\x06\nevent_type\x95\x00\x0cimage.create\ttimestamp\x95\x00\x1a2014-05-01 08:35:04.217448\nmessage_id\x95\x00$928684c1-ca71-426e-8e01-cbea991479c0\x08priority\x95\x00\x04INFO\x0cpublisher_id\x95\x00!orange-vdsf.qa.lab.tlv.redhat.com\x07payload\xa8\x00\x00\x01c\x00\x00\x00\x11\x06status\x95\x00\x06queued\ncreated_at\x95\x00\x132014-05-01T08:35:04\x04name\x95\x00\x0btshefi_cli2\x07deleted\x08\x00\x10container_format\x95\x00\x04bare\x07min_ram1\x00\x00\x00\x00\x00\x00\x00\x00\x0bdisk_format\x95\x00\x03raw\nupdated_at\x95\x00\x132014-05-01T08:35:04\nproperties\xa8\x00\x00\x00\x04\x00\x00\x00\x00\x08min_disk1\x00\x00\x00\x00\x00\x00\x00\x00\tprotected\x08\x00\x08checksum\xf0\x05owner\x95\x00 5502ab8e099843cfa39df71b3037ccd6\tis_public\x08\x00\ndeleted_at\xf0\x02id\x95\x00$5e8913e7-d4b6-4d44-9aa8-58dd9482c2a3\x04size1\x00\x00\x00\x01\x80\x00\x00\x01') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.234 2459 DEBUG qpid.messaging [-] SENT[4098c20]: Message(properties={'qpid.subject': 'notifications.info'}, content={'event_type': 'image.create', 'timestamp': '2014-05-01 08:35:04.217448', 'message_id': '928684c1-ca71-426e-8e01-cbea991479c0', 'priority': 'INFO', 'publisher_id': 'orange-vdsf.qa.lab.tlv.redhat.com', 'payload': {u'status': u'queued', u'created_at': u'2014-05-01T08:35:04', u'name': u'tshefi_cli2', u'deleted': False, u'container_format': u'bare', u'min_ram': 0, u'disk_format': u'raw', u'updated_at': u'2014-05-01T08:35:04', u'properties': {}, u'min_disk': 0, u'protected': False, u'checksum': None, u'owner': u'5502ab8e099843cfa39df71b3037ccd6', u'is_public': False, u'deleted_at': None, u'id': u'5e8913e7-d4b6-4d44-9aa8-58dd9482c2a3', u'size': 6442450945}}) send /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:1280
>2014-05-01 11:35:04.234 2459 DEBUG qpid.messaging.io.raw [-] SENT[4584fc8]: '\x0b\x01\x00\x19\x00\x01\x00\x00\x00\x00\x00\x00\x04\x01\x01\x01\x01\x00\x06glance\x03\x02\x00b\x00\x01\x00\x00\x00\x00\x00\x00\x00\x00\x00\x17\x04\x01\x00\x02\x12notifications.info\x00\x00\x007\x04\x03\x10\x01\x08amqp/map\x00\x00\x00&\x00\x00\x00\x01\x0cqpid.subject\x95\x00\x12notifications.info\x07\x03\x028\x00\x01\x00\x00\x00\x00\x00\x00\x00\x00\x02(\x00\x00\x00\x06\nevent_type\x95\x00\x0cimage.create\ttimestamp\x95\x00\x1a2014-05-01 08:35:04.217448\nmessage_id\x95\x00$928684c1-ca71-426e-8e01-cbea991479c0\x08priority\x95\x00\x04INFO\x0cpublisher_id\x95\x00!orange-vdsf.qa.lab.tlv.redhat.com\x07payload\xa8\x00\x00\x01c\x00\x00\x00\x11\x06status\x95\x00\x06queued\ncreated_at\x95\x00\x132014-05-01T08:35:04\x04name\x95\x00\x0btshefi_cli2\x07deleted\x08\x00\x10container_format\x95\x00\x04bare\x07min_ram1\x00\x00\x00\x00\x00\x00\x00\x00\x0bdisk_format\x95\x00\x03raw\nupdated_at\x95\x00\x132014-05-01T08:35:04\nproperties\xa8\x00\x00\x00\x04\x00\x00\x00\x00\x08min_disk1\x00\x00\x00\x00\x00\x00\x00\x00\tprotected\x08\x00\x08checksum\xf0\x05owner\x95\x00 5502ab8e099843cfa39df71b3037ccd6\tis_public\x08\x00\ndeleted_at\xf0\x02id\x95\x00$5e8913e7-d4b6-4d44-9aa8-58dd9482c2a3\x04size1\x00\x00\x00\x01\x80\x00\x00\x01' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:35:04.235 2459 DEBUG qpid.messaging.io.raw [-] READ[4584fc8]: '\x0f\x00\x00\x1a\x00\x00\x00\x00\x00\x00\x00\x00\x02\n\x01\x00\x00\x08\x00\x00\x00\x00\x00\x00\x00\x02' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:35:04.235 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4584fc8]: SessionCompleted(commands=[0-2]) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.236 2459 DEBUG qpid.messaging [-] RACK[4098c20]: Message(properties={'qpid.subject': 'notifications.info'}, content={'event_type': 'image.create', 'timestamp': '2014-05-01 08:35:04.217448', 'message_id': '928684c1-ca71-426e-8e01-cbea991479c0', 'priority': 'INFO', 'publisher_id': 'orange-vdsf.qa.lab.tlv.redhat.com', 'payload': {u'status': u'queued', u'created_at': u'2014-05-01T08:35:04', u'name': u'tshefi_cli2', u'deleted': False, u'container_format': u'bare', u'min_ram': 0, u'disk_format': u'raw', u'updated_at': u'2014-05-01T08:35:04', u'properties': {}, u'min_disk': 0, u'protected': False, u'checksum': None, u'owner': u'5502ab8e099843cfa39df71b3037ccd6', u'is_public': False, u'deleted_at': None, u'id': u'5e8913e7-d4b6-4d44-9aa8-58dd9482c2a3', u'size': 6442450945}}) msg_acked /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:1269
>2014-05-01 11:35:04.236 2459 DEBUG qpid.messaging.io.ops [-] SENT[4584fc8]: SessionDetach(name='b3ab0d35-e5f4-4398-bb35-fca0f9a7c64f:0') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.237 2459 DEBUG qpid.messaging.io.raw [-] SENT[4584fc8]: '\x0f\x00\x008\x00\x00\x00\x00\x00\x00\x00\x00\x02\x03\x01\x00\x00&b3ab0d35-e5f4-4398-bb35-fca0f9a7c64f:0' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:35:04.237 2459 DEBUG qpid.messaging.io.raw [-] READ[4584fc8]: '\x0f\x00\x009\x00\x00\x00\x00\x00\x00\x00\x00\x02\x04\x03\x00\x00&b3ab0d35-e5f4-4398-bb35-fca0f9a7c64f:0\x00' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:35:04.238 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4584fc8]: SessionDetached(name='b3ab0d35-e5f4-4398-bb35-fca0f9a7c64f:0', code=0) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.238 2459 DEBUG qpid.messaging.io.ops [-] SENT[4584fc8]: ConnectionClose(reply_code=200) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.239 2459 DEBUG qpid.messaging.io.raw [-] SENT[4584fc8]: '\x0f\x00\x00\x12\x00\x00\x00\x00\x00\x00\x00\x00\x01\x0b\x01\x00\x00\xc8' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:35:04.239 2459 DEBUG qpid.messaging.io.raw [-] READ[4584fc8]: '\x0f\x00\x00\x10\x00\x00\x00\x00\x00\x00\x00\x00\x01\x0c\x00\x00' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:35:04.239 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4584fc8]: ConnectionCloseOk() write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.240 2459 INFO glance.api.v1.images [1c352829-7644-4c95-87e0-1cf3dc03ddd5 81c761b68ebb423cb29312b8bede978a 5502ab8e099843cfa39df71b3037ccd6] Triggering asynchronous copy from external source
>2014-05-01 11:35:04.246 2459 DEBUG glance.api.v1.images [-] Setting image 5e8913e7-d4b6-4d44-9aa8-58dd9482c2a3 to status 'saving' _upload /usr/lib/python2.6/site-packages/glance/api/v1/images.py:543
>2014-05-01 11:35:04.247 2459 DEBUG glance.registry.client.v1.api [-] Updating image metadata for image 5e8913e7-d4b6-4d44-9aa8-58dd9482c2a3... update_image_metadata /usr/lib/python2.6/site-packages/glance/registry/client/v1/api.py:168
>2014-05-01 11:35:04.247 2459 DEBUG glance.common.client [-] Constructed URL: http://0.0.0.0:9191/images/5e8913e7-d4b6-4d44-9aa8-58dd9482c2a3 _construct_url /usr/lib/python2.6/site-packages/glance/common/client.py:408
>2014-05-01 11:35:04.315 2459 DEBUG glance.registry.client.v1.client [-] Registry request PUT /images/5e8913e7-d4b6-4d44-9aa8-58dd9482c2a3 HTTP 200 request id req-87ae9b7a-9231-4bb1-9f00-7733f39d5139 do_request /usr/lib/python2.6/site-packages/glance/registry/client/v1/client.py:115
>2014-05-01 11:35:04.316 2459 DEBUG glance.api.v1.images [-] Uploading image data for image 5e8913e7-d4b6-4d44-9aa8-58dd9482c2a3 to file store _upload /usr/lib/python2.6/site-packages/glance/api/v1/images.py:548
>2014-05-01 11:35:04.317 2459 DEBUG qpid.messaging.io.raw [-] OPEN[4592710]: 10.35.160.73:5672 connect /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:530
>2014-05-01 11:35:04.318 2459 DEBUG qpid.messaging.io.raw [-] SENT[4592710]: 'AMQP\x01\x01\x00\n' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:35:04.319 2459 DEBUG qpid.messaging.io.raw [-] READ[4592710]: 'AMQP\x01\x01\x00\n\x0f\x00\x00~\x00\x00\x00\x00\x00\x00\x00\x00\x01\x01\x07\x00\x00\x00\x00?\x00\x00\x00\x01\x13qpid.federation_tag\x95\x00$62e96915-063e-4b1b-b169-c90278559d74\x00\x00\x00\x17\x95\x00\x00\x00\x02\x00\tANONYMOUS\x00\x05PLAIN\x00\x00\x00\x0c\x95\x00\x00\x00\x01\x00\x05en_US' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:35:04.319 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4592710]: ConnectionStart(server_properties={u'qpid.federation_tag': u'62e96915-063e-4b1b-b169-c90278559d74'}, mechanisms=[u'ANONYMOUS', u'PLAIN'], locales=[u'en_US']) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.319 2459 DEBUG qpid.messaging.io.ops [-] SENT[4592710]: ConnectionStartOk(client_properties={'product': 'qpid python client', 'qpid.client_ppid': 2451, 'qpid.client_process': 'glance-api', 'platform': 'posix', 'qpid.client_pid': 2459, 'version': 'development'}, mechanism='ANONYMOUS', response='anonymous@orange-vdsf.qa.lab.tlv.redhat.com') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.320 2459 DEBUG qpid.messaging.io.raw [-] SENT[4592710]: '\x0f\x00\x00\xe9\x00\x00\x00\x00\x00\x00\x00\x00\x01\x02\x07\x00\x00\x00\x00\x9c\x00\x00\x00\x06\x07product\x95\x00\x12qpid python client\x10qpid.client_ppid1\x00\x00\x00\x00\x00\x00\t\x93\x13qpid.client_process\x95\x00\nglance-api\x08platform\x95\x00\x05posix\x0fqpid.client_pid1\x00\x00\x00\x00\x00\x00\t\x9b\x07version\x95\x00\x0bdevelopment\tANONYMOUS\x00\x00\x00+anonymous@orange-vdsf.qa.lab.tlv.redhat.com' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:35:04.321 2459 DEBUG qpid.messaging.io.raw [-] READ[4592710]: '\x0f\x00\x00\x18\x00\x00\x00\x00\x00\x00\x00\x00\x01\x05\x0f\x00\x7f\xff\xff\xff\x00\x00\x00x' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:35:04.321 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4592710]: ConnectionTune(channel_max=32767, max_frame_size=65535, heartbeat_min=0, heartbeat_max=120) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.321 2459 DEBUG qpid.messaging.io.ops [-] SENT[4592710]: ConnectionTuneOk(channel_max=32767, heartbeat=60) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.321 2459 DEBUG qpid.messaging.io.ops [-] SENT[4592710]: ConnectionOpen() write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.322 2459 DEBUG qpid.messaging.io.raw [-] SENT[4592710]: '\x0f\x00\x00\x14\x00\x00\x00\x00\x00\x00\x00\x00\x01\x06\x05\x00\x7f\xff\x00<\x0f\x00\x00\x10\x00\x00\x00\x00\x00\x00\x00\x00\x01\x07\x00\x00' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:35:04.322 2459 DEBUG qpid.messaging.io.raw [-] READ[4592710]: '\x0f\x00\x005\x00\x00\x00\x00\x00\x00\x00\x00\x01\x08\x01\x00\x00\x00\x00!\x95\x00\x00\x00\x01\x00\x1aamqp:tcp:10.35.160.73:5672' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:35:04.323 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4592710]: ConnectionOpenOk(known_hosts=[u'amqp:tcp:10.35.160.73:5672']) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.323 2459 INFO glance.notifier.notify_qpid [-] Connected to AMQP server on 10.35.160.73:5672
>2014-05-01 11:35:04.323 2459 DEBUG qpid.messaging.io.ops [-] SENT[4592710]: SessionAttach(name='13ad89c0-2a05-4f97-9850-7cfd1530a524:0') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.324 2459 DEBUG qpid.messaging.io.ops [-] SENT[4592710]: SessionCommandPoint(command_id=serial(0), command_offset=0) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.325 2459 DEBUG qpid.messaging.io.ops [-] SENT[4592710]: ExchangeQuery(name='glance', id=serial(0), sync=True) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.326 2459 DEBUG qpid.messaging.io.ops [-] SENT[4592710]: QueueQuery(queue='glance', id=serial(1), sync=True) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.326 2459 DEBUG qpid.messaging.io.raw [-] SENT[4592710]: '\x0f\x00\x008\x00\x00\x00\x00\x00\x00\x00\x00\x02\x01\x01\x00\x00&13ad89c0-2a05-4f97-9850-7cfd1530a524:0\x0f\x00\x00\x1c\x00\x00\x00\x00\x00\x00\x00\x00\x02\x07\x03\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x0f\x01\x00\x19\x00\x01\x00\x00\x00\x00\x00\x00\x07\x03\x01\x01\x01\x00\x06glance\x0f\x01\x00\x19\x00\x01\x00\x00\x00\x00\x00\x00\x08\x04\x01\x01\x01\x00\x06glance' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:35:04.327 2459 DEBUG qpid.messaging.io.raw [-] READ[4592710]: '\x0f\x00\x008\x00\x00\x00\x00\x00\x00\x00\x00\x02\x02\x01\x00\x00&13ad89c0-2a05-4f97-9850-7cfd1530a524:0\x0f\x00\x00\x1c\x00\x00\x00\x00\x00\x00\x00\x00\x02\x07\x03\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x0f\x01\x00,\x00\x01\x00\x00\x00\x00\x00\x00\x03\x02\x01\x00\x03\x00\x00\x00\x00\x00\x00\x00\x00\x12\x07\x01\t\x00\x05topic\x00\x00\x00\x04\x00\x00\x00\x00\x0f\x00\x00\x1a\x00\x00\x00\x00\x00\x00\x00\x00\x02\n\x01\x00\x00\x08\x00\x00\x00\x00\x00\x00\x00\x00\x0f\x01\x00\x1e\x00\x01\x00\x00\x00\x00\x00\x00\x03\x02\x01\x00\x03\x00\x00\x00\x00\x01\x00\x00\x00\x04\x08\x01\x00\x00\x0f\x00\x00\x1a\x00\x00\x00\x00\x00\x00\x00\x00\x02\n\x01\x00\x00\x08\x00\x00\x00\x00\x00\x00\x00\x01' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:35:04.327 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4592710]: SessionAttached(name='13ad89c0-2a05-4f97-9850-7cfd1530a524:0') write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.328 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4592710]: SessionCommandPoint(command_id=serial(0), command_offset=0) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.328 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4592710]: ExecutionResult(command_id=serial(0), value=ExchangeQueryResult(type=u'topic', arguments={}), id=serial(0)) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.328 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4592710]: SessionCompleted(commands=[0-0]) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.328 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4592710]: ExecutionResult(command_id=serial(1), value=QueueQueryResult(), id=serial(1)) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.329 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4592710]: SessionCompleted(commands=[0-1]) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.330 2459 DEBUG qpid.messaging.io.ops [-] SENT[4592710]: MessageTransfer(destination='glance', id=serial(2), sync=True, headers=(DeliveryProperties(routing_key='notifications.info'), MessageProperties(content_type='amqp/map', application_headers={'qpid.subject': 'notifications.info'})), payload='\x00\x00\x02)\x00\x00\x00\x06\nevent_type\x95\x00\rimage.prepare\ttimestamp\x95\x00\x1a2014-05-01 08:35:04.317050\nmessage_id\x95\x00$52a35d49-d9b4-45c1-97a4-0f2eb16adf31\x08priority\x95\x00\x04INFO\x0cpublisher_id\x95\x00!orange-vdsf.qa.lab.tlv.redhat.com\x07payload\xa8\x00\x00\x01c\x00\x00\x00\x11\x06status\x95\x00\x06queued\ncreated_at\x95\x00\x132014-05-01T08:35:04\x04name\x95\x00\x0btshefi_cli2\x07deleted\x08\x00\x10container_format\x95\x00\x04bare\x07min_ram1\x00\x00\x00\x00\x00\x00\x00\x00\x0bdisk_format\x95\x00\x03raw\nupdated_at\x95\x00\x132014-05-01T08:35:04\nproperties\xa8\x00\x00\x00\x04\x00\x00\x00\x00\x08min_disk1\x00\x00\x00\x00\x00\x00\x00\x00\tprotected\x08\x00\x08checksum\xf0\x05owner\x95\x00 5502ab8e099843cfa39df71b3037ccd6\tis_public\x08\x00\ndeleted_at\xf0\x02id\x95\x00$5e8913e7-d4b6-4d44-9aa8-58dd9482c2a3\x04size1\x00\x00\x00\x01\x80\x00\x00\x01') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.331 2459 DEBUG qpid.messaging [-] SENT[45955f0]: Message(properties={'qpid.subject': 'notifications.info'}, content={'event_type': 'image.prepare', 'timestamp': '2014-05-01 08:35:04.317050', 'message_id': '52a35d49-d9b4-45c1-97a4-0f2eb16adf31', 'priority': 'INFO', 'publisher_id': 'orange-vdsf.qa.lab.tlv.redhat.com', 'payload': {u'status': u'queued', u'created_at': u'2014-05-01T08:35:04', u'name': u'tshefi_cli2', u'deleted': False, u'container_format': u'bare', u'min_ram': 0, u'disk_format': u'raw', u'updated_at': u'2014-05-01T08:35:04', u'properties': {}, u'min_disk': 0, u'protected': False, u'checksum': None, u'owner': u'5502ab8e099843cfa39df71b3037ccd6', u'is_public': False, u'deleted_at': None, u'id': u'5e8913e7-d4b6-4d44-9aa8-58dd9482c2a3', u'size': 6442450945}}) send /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:1280
>2014-05-01 11:35:04.332 2459 DEBUG qpid.messaging.io.raw [-] SENT[4592710]: '\x0b\x01\x00\x19\x00\x01\x00\x00\x00\x00\x00\x00\x04\x01\x01\x01\x01\x00\x06glance\x03\x02\x00b\x00\x01\x00\x00\x00\x00\x00\x00\x00\x00\x00\x17\x04\x01\x00\x02\x12notifications.info\x00\x00\x007\x04\x03\x10\x01\x08amqp/map\x00\x00\x00&\x00\x00\x00\x01\x0cqpid.subject\x95\x00\x12notifications.info\x07\x03\x029\x00\x01\x00\x00\x00\x00\x00\x00\x00\x00\x02)\x00\x00\x00\x06\nevent_type\x95\x00\rimage.prepare\ttimestamp\x95\x00\x1a2014-05-01 08:35:04.317050\nmessage_id\x95\x00$52a35d49-d9b4-45c1-97a4-0f2eb16adf31\x08priority\x95\x00\x04INFO\x0cpublisher_id\x95\x00!orange-vdsf.qa.lab.tlv.redhat.com\x07payload\xa8\x00\x00\x01c\x00\x00\x00\x11\x06status\x95\x00\x06queued\ncreated_at\x95\x00\x132014-05-01T08:35:04\x04name\x95\x00\x0btshefi_cli2\x07deleted\x08\x00\x10container_format\x95\x00\x04bare\x07min_ram1\x00\x00\x00\x00\x00\x00\x00\x00\x0bdisk_format\x95\x00\x03raw\nupdated_at\x95\x00\x132014-05-01T08:35:04\nproperties\xa8\x00\x00\x00\x04\x00\x00\x00\x00\x08min_disk1\x00\x00\x00\x00\x00\x00\x00\x00\tprotected\x08\x00\x08checksum\xf0\x05owner\x95\x00 5502ab8e099843cfa39df71b3037ccd6\tis_public\x08\x00\ndeleted_at\xf0\x02id\x95\x00$5e8913e7-d4b6-4d44-9aa8-58dd9482c2a3\x04size1\x00\x00\x00\x01\x80\x00\x00\x01' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:35:04.332 2459 DEBUG qpid.messaging.io.raw [-] READ[4592710]: '\x0f\x00\x00\x1a\x00\x00\x00\x00\x00\x00\x00\x00\x02\n\x01\x00\x00\x08\x00\x00\x00\x00\x00\x00\x00\x02' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:35:04.332 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4592710]: SessionCompleted(commands=[0-2]) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.333 2459 DEBUG qpid.messaging [-] RACK[45955f0]: Message(properties={'qpid.subject': 'notifications.info'}, content={'event_type': 'image.prepare', 'timestamp': '2014-05-01 08:35:04.317050', 'message_id': '52a35d49-d9b4-45c1-97a4-0f2eb16adf31', 'priority': 'INFO', 'publisher_id': 'orange-vdsf.qa.lab.tlv.redhat.com', 'payload': {u'status': u'queued', u'created_at': u'2014-05-01T08:35:04', u'name': u'tshefi_cli2', u'deleted': False, u'container_format': u'bare', u'min_ram': 0, u'disk_format': u'raw', u'updated_at': u'2014-05-01T08:35:04', u'properties': {}, u'min_disk': 0, u'protected': False, u'checksum': None, u'owner': u'5502ab8e099843cfa39df71b3037ccd6', u'is_public': False, u'deleted_at': None, u'id': u'5e8913e7-d4b6-4d44-9aa8-58dd9482c2a3', u'size': 6442450945}}) msg_acked /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:1269
>2014-05-01 11:35:04.333 2459 DEBUG qpid.messaging.io.ops [-] SENT[4592710]: SessionDetach(name='13ad89c0-2a05-4f97-9850-7cfd1530a524:0') write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.334 2459 DEBUG qpid.messaging.io.raw [-] SENT[4592710]: '\x0f\x00\x008\x00\x00\x00\x00\x00\x00\x00\x00\x02\x03\x01\x00\x00&13ad89c0-2a05-4f97-9850-7cfd1530a524:0' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:35:04.334 2459 DEBUG qpid.messaging.io.raw [-] READ[4592710]: '\x0f\x00\x009\x00\x00\x00\x00\x00\x00\x00\x00\x02\x04\x03\x00\x00&13ad89c0-2a05-4f97-9850-7cfd1530a524:0\x00' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:35:04.335 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4592710]: SessionDetached(name='13ad89c0-2a05-4f97-9850-7cfd1530a524:0', code=0) write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:35:04.335 2459 DEBUG qpid.messaging.io.ops [-] SENT[4592710]: ConnectionClose(reply_code=200) write_op /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:686
>2014-05-01 11:35:04.336 2459 DEBUG qpid.messaging.io.raw [-] SENT[4592710]: '\x0f\x00\x00\x12\x00\x00\x00\x00\x00\x00\x00\x00\x01\x0b\x01\x00\x00\xc8' writeable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:480
>2014-05-01 11:35:04.336 2459 DEBUG qpid.messaging.io.raw [-] READ[4592710]: '\x0f\x00\x00\x10\x00\x00\x00\x00\x00\x00\x00\x00\x01\x0c\x00\x00' readable /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:416
>2014-05-01 11:35:04.336 2459 DEBUG qpid.messaging.io.ops [-] RCVD[4592710]: ConnectionCloseOk() write /usr/lib/python2.6/site-packages/qpid/messaging/driver.py:654
>2014-05-01 11:36:04.516 2458 DEBUG glance.api.middleware.version_negotiation [-] Determining version of request: GET /v1/images/detail Accept:  process_request /usr/lib/python2.6/site-packages/glance/api/middleware/version_negotiation.py:46
>2014-05-01 11:36:04.516 2458 DEBUG glance.api.middleware.version_negotiation [-] Using url versioning process_request /usr/lib/python2.6/site-packages/glance/api/middleware/version_negotiation.py:59
>2014-05-01 11:36:04.516 2458 DEBUG glance.api.middleware.version_negotiation [-] Matched version: v1 process_request /usr/lib/python2.6/site-packages/glance/api/middleware/version_negotiation.py:71
>2014-05-01 11:36:04.517 2458 DEBUG glance.api.middleware.version_negotiation [-] new path /v1/images/detail process_request /usr/lib/python2.6/site-packages/glance/api/middleware/version_negotiation.py:72
>2014-05-01 11:36:04.517 2458 DEBUG keystoneclient.middleware.auth_token [-] Authenticating user token __call__ /usr/lib/python2.6/site-packages/keystoneclient/middleware/auth_token.py:569
>2014-05-01 11:36:04.517 2458 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 /usr/lib/python2.6/site-packages/keystoneclient/middleware/auth_token.py:628
>2014-05-01 11:36:04.519 2458 INFO urllib3.connectionpool [-] Starting new HTTP connection (1): 10.35.160.73
>2014-05-01 11:36:04.554 2458 DEBUG urllib3.connectionpool [-] "GET /v2.0/tokens/revoked HTTP/1.1" 200 686 _make_request /usr/lib/python2.6/site-packages/urllib3/connectionpool.py:295
>2014-05-01 11:36:04.595 2458 DEBUG iso8601.iso8601 [-] Parsed 2014-05-02T08:36:04Z into {'tz_sign': None, 'second_fraction': None, 'hour': u'08', 'tz_hour': None, 'month': u'05', 'timezone': u'Z', 'second': u'04', 'tz_minute': None, 'year': u'2014', 'separator': u'T', 'day': u'02', 'minute': u'36'} with default timezone <iso8601.iso8601.Utc object at 0x29d4050> parse_date /usr/lib/python2.6/site-packages/iso8601/iso8601.py:166
>2014-05-01 11:36:04.596 2458 DEBUG iso8601.iso8601 [-] Got u'2014' for 'year' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:36:04.596 2458 DEBUG iso8601.iso8601 [-] Got u'05' for 'month' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:36:04.596 2458 DEBUG iso8601.iso8601 [-] Got u'02' for 'day' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:36:04.596 2458 DEBUG iso8601.iso8601 [-] Got u'08' for 'hour' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:36:04.596 2458 DEBUG iso8601.iso8601 [-] Got u'36' for 'minute' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:36:04.596 2458 DEBUG iso8601.iso8601 [-] Got u'04' for 'second' with default None to_int /usr/lib/python2.6/site-packages/iso8601/iso8601.py:124
>2014-05-01 11:36:04.597 2458 DEBUG keystoneclient.middleware.auth_token [-] Storing token in cache _cache_put /usr/lib/python2.6/site-packages/keystoneclient/middleware/auth_token.py:1144
>2014-05-01 11:36:04.598 2458 DEBUG keystoneclient.middleware.auth_token [-] Received request from user: 81c761b68ebb423cb29312b8bede978a with project_id : 5502ab8e099843cfa39df71b3037ccd6 and roles: admin  _build_user_headers /usr/lib/python2.6/site-packages/keystoneclient/middleware/auth_token.py:933
>2014-05-01 11:36:04.600 2458 DEBUG routes.middleware [-] Matched GET /images/detail __call__ /usr/lib/python2.6/site-packages/Routes-1.12.3-py2.6.egg/routes/middleware.py:100
>2014-05-01 11:36:04.601 2458 DEBUG routes.middleware [-] Route path: '/images/detail', defaults: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x40857d0>} __call__ /usr/lib/python2.6/site-packages/Routes-1.12.3-py2.6.egg/routes/middleware.py:102
>2014-05-01 11:36:04.601 2458 DEBUG routes.middleware [-] Match dict: {'action': u'detail', 'controller': <glance.common.wsgi.Resource object at 0x40857d0>} __call__ /usr/lib/python2.6/site-packages/Routes-1.12.3-py2.6.egg/routes/middleware.py:103
>2014-05-01 11:36:04.601 2458 DEBUG glance.api.policy [fce8b32f-c5fa-4d46-a758-591dbad00515 81c761b68ebb423cb29312b8bede978a 5502ab8e099843cfa39df71b3037ccd6] Loaded policy rules: {u'context_is_admin': 'role:admin', u'default': '@', u'manage_image_cache': 'role:admin'} load_rules /usr/lib/python2.6/site-packages/glance/api/policy.py:75
>2014-05-01 11:36:04.602 2458 DEBUG glance.common.client [fce8b32f-c5fa-4d46-a758-591dbad00515 81c761b68ebb423cb29312b8bede978a 5502ab8e099843cfa39df71b3037ccd6] Constructed URL: http://0.0.0.0:9191/images/detail?limit=10 _construct_url /usr/lib/python2.6/site-packages/glance/common/client.py:408
>2014-05-01 11:36:04.782 2458 DEBUG glance.registry.client.v1.client [fce8b32f-c5fa-4d46-a758-591dbad00515 81c761b68ebb423cb29312b8bede978a 5502ab8e099843cfa39df71b3037ccd6] Registry request GET /images/detail HTTP 200 request id req-8cc7d0a5-2c01-4aaf-87a1-e0da55267de1 do_request /usr/lib/python2.6/site-packages/glance/registry/client/v1/client.py:115

Actions: View

Attachments on bug 1093299: 891409