application/json; charset=UTF-8
Wed, 20 Nov 2013 08:35:33 GMT
x-amz-copy-source:new-bucket%2Fs3stor.exe
/new-bucket/s3stor.exe
2013-11-20 16:35:33.127040 7fb20e7ec700 15 calculated digest=+lsrvKDBXm600g8dCE7B+0gluto=
2013-11-20 16:35:33.127049 7fb20e7ec700 15 auth_sign=+lsrvKDBXm600g8dCE7B+0gluto=
2013-11-20 16:35:33.127053 7fb20e7ec700 15 compare=0
2013-11-20 16:35:33.127059 7fb20e7ec700 20 system request
2013-11-20 16:35:33.127082 7fb20e7ec700 2 req 330:0.001041:s3:PUT /new-bucket/s3stor.exe:copy_obj:reading permissions
2013-11-20 16:35:33.127127 7fb20e7ec700 20 get_obj_state: rctx=0x7fb1b400e970 obj=.us-west.rgw.root:new-bucket%2Fs3stor
.exe state=0x7fb1b40128b8 s->prefetch_data=0
2013-11-20 16:35:33.127147 7fb20e7ec700 10 cache get: name=.us-west.rgw.root+new-bucket%2Fs3stor.exe : miss
2013-11-20 16:35:33.131924 7fb20e7ec700 10 cache put: name=.us-west.rgw.root+new-bucket%2Fs3stor.exe
2013-11-20 16:35:33.132005 7fb20e7ec700 10 adding .us-west.rgw.root+new-bucket%2Fs3stor.exe to cache LRU end
2013-11-20 16:35:33.132072 7fb20e7ec700 20 get_obj_state: rctx=0x7fb1b400e970 obj=.us-west.rgw.root:new-bucket state=0x7fb1b400ebd8 s->prefetch_data=0
2013-11-20 16:35:33.132101 7fb20e7ec700 10 cache get: name=.us-west.rgw.root+new-bucket : miss
2013-11-20 16:35:33.138252 7fb20e7ec700 10 cache put: name=.us-west.rgw.root+new-bucket
2013-11-20 16:35:33.138277 7fb20e7ec700 10 adding .us-west.rgw.root+new-bucket to cache LRU end
2013-11-20 16:35:33.138293 7fb20e7ec700 20 get_obj_state: s->obj_tag was set empty
2013-11-20 16:35:33.138300 7fb20e7ec700 20 Read xattr: user.rgw.idtag
2013-11-20 16:35:33.138305 7fb20e7ec700 20 Read xattr: user.rgw.manifest
2013-11-20 16:35:33.138319 7fb20e7ec700 10 moving .us-west.rgw.root+new-bucket to cache LRU end
2013-11-20 16:35:33.138325 7fb20e7ec700 10 cache get: name=.us-west.rgw.root+new-bucket : type miss (requested=17, cached=22)
2013-11-20 16:35:33.138337 7fb20e7ec700 20 get_obj_state: rctx=0x7fb1b400e970 obj=.us-west.rgw.root:new-bucket state=0x7fb1b400ebd8 s->prefetch_data=0
2013-11-20 16:35:33.138348 7fb20e7ec700 20 get_obj_state: rctx=0x7fb1b400e970 obj=.us-west.rgw.root:new-bucket state=0x7fb1b400ebd8 s->prefetch_data=0
2013-11-20 16:35:33.138355 7fb20e7ec700 20 state for obj=.us-west.rgw.root:new-bucket is not atomic, not appending atomic test
2013-11-20 16:35:33.138460 7fb20e7ec700 20 rados->read obj-ofs=0 read_ofs=0 read_len=524288
2013-11-20 16:35:33.144207 7fb20e7ec700 20 rados->read r=0 bl.length=114
2013-11-20 16:35:33.144254 7fb20e7ec700 10 cache put: name=.us-west.rgw.root+new-bucket
2013-11-20 16:35:33.144263 7fb20e7ec700 10 moving .us-west.rgw.root+new-bucket to cache LRU end
2013-11-20 16:35:33.144288 7fb20e7ec700 20 rgw_get_bucket_info: bucket instance: new-bucket(@.rgw.buckets[us-east.6555.1])
2013-11-20 16:35:33.144313 7fb20e7ec700 20 reading from .us-west.rgw.root:.bucket.meta.new-bucket:us-east.6555.1
2013-11-20 16:35:33.144341 7fb20e7ec700 20 get_obj_state: rctx=0x7fb1b400e970 obj=.us-west.rgw.root:.bucket.meta.
new-bucket:us-east.6555.1 state=0x7fb1b400ff28 s->prefetch_data=0
2013-11-20 16:35:33.144361 7fb20e7ec700 10 moving .us-west.rgw.root+.bucket.meta.new-bucket:us-east.6555.1 to cache LRU end
2013-11-20 16:35:33.144368 7fb20e7ec700 10 cache get: name=.us-west.rgw.root+.bucket.meta.new-bucket:us-east.6555.1 : type miss (requested=22, cached=19)
2013-11-20 16:35:33.150922 7fb20e7ec700 10 cache put: name=.us-west.rgw.root+.bucket.meta.new-bucket:us-east.6555.1
2013-11-20 16:35:33.150941 7fb20e7ec700 10 moving .us-west.rgw.root+.bucket.meta.new-bucket:us-east.6555.1 to cache LRU end
2013-11-20 16:35:33.150953 7fb20e7ec700 10 updating xattr: name=user.rgw.acl bl.length()=221
2013-11-20 16:35:33.150970 7fb20e7ec700 20 get_obj_state: s->obj_tag was set empty
2013-11-20 16:35:33.150979 7fb20e7ec700 20 Read xattr: user.rgw.acl
2013-11-20 16:35:33.150983 7fb20e7ec700 20 Read xattr: user.rgw.idtag
2013-11-20 16:35:33.150987 7fb20e7ec700 20 Read xattr: user.rgw.manifest
2013-11-20 16:35:33.151000 7fb20e7ec700 10 moving .us-west.rgw.root+.bucket.meta.new-bucket:us-east.6555.1 to cache LRU end
2013-11-20 16:35:33.151006 7fb20e7ec700 10 cache get: name=.us-west.rgw.root+.bucket.meta.new-bucket:us-east.6555.1 : hit
2013-11-20 16:35:33.151081 7fb20e7ec700 15 Read AccessControlPolicy<AccessControlPolicy xmlns="http://s3.amazonaws.
com/doc/2006-03-01/"><Owner><ID>us-east</ID><DisplayName>Region-US Zone-East</DisplayName></Owner><AccessControlList>
<Grant><Grantee xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xsi:type="Group"><URI>http://acs.amazonaws.com/g
roups/global/AllUsers</URI></Grantee><Permission>READ</Permission></Grant><Grant><Grantee xmlns:xsi="http://www.w3.org/
2001/XMLSchema-instance" xsi:type="CanonicalUser"><ID>us-east</ID><DisplayName>Region-US Zone-East</DisplayName></Grantee>
<Permission>FULL_CONTROL</Permission></Grant></AccessControlList></AccessControlPolicy>
2013-11-20 16:35:33.151124 7fb20e7ec700 2 req 330:0.025083:s3:PUT /new-bucket/s3stor.exe:copy_obj:init op
2013-11-20 16:35:33.151139 7fb20e7ec700 2 req 330:0.025098:s3:PUT /new-bucket/s3stor.exe:copy_obj:verifying op mask
2013-11-20 16:35:33.151147 7fb20e7ec700 20 required_mask= 2 user.op_mask=7
2013-11-20 16:35:33.151153 7fb20e7ec700 2 req 330:0.025112:s3:PUT /new-bucket/s3stor.exe:copy_obj:verifying op permissions
2013-11-20 16:35:33.151191 7fb20e7ec700 20 get_obj_state: rctx=0x7fb1b400e970 obj=.us-west.rgw.root:new-bucket state=0x7fb1b400ebd8 s->prefetch_data=0
2013-11-20 16:35:33.151205 7fb20e7ec700 20 Read xattr: user.rgw.idtag
2013-11-20 16:35:33.151208 7fb20e7ec700 20 Read xattr: user.rgw.manifest
2013-11-20 16:35:33.151221 7fb20e7ec700 10 moving .us-west.rgw.root+new-bucket to cache LRU end
2013-11-20 16:35:33.151227 7fb20e7ec700 10 cache get: name=.us-west.rgw.root+new-bucket : hit
2013-11-20 16:35:33.151250 7fb20e7ec700 20 rgw_get_bucket_info: bucket instance: new-bucket(@.rgw.buckets[us-east.6555.1])
2013-11-20 16:35:33.151262 7fb20e7ec700 20 reading from .us-west.rgw.root:.bucket.meta.new-bucket:us-east.6555.1
2013-11-20 16:35:33.151276 7fb20e7ec700 20 get_obj_state: rctx=0x7fb1b400e970 obj=.us-west.rgw.root:.bucke
t.meta.new-bucket:us-east.6555.1 state=0x7fb1b400ff28 s->prefetch_data=0
2013-11-20 16:35:33.151287 7fb20e7ec700 20 Read xattr: user.rgw.acl
2013-11-20 16:35:33.151291 7fb20e7ec700 20 Read xattr: user.rgw.idtag
2013-11-20 16:35:33.151295 7fb20e7ec700 20 Read xattr: user.rgw.manifest
2013-11-20 16:35:33.151306 7fb20e7ec700 10 moving .us-west.rgw.root+.bucket.meta.new-bucket:us-east.6555.1 to cache LRU end
2013-11-20 16:35:33.151312 7fb20e7ec700 10 cache get: name=.us-west.rgw.root+.bucket.meta.new-bucket:us-east.6555.1 : hit
2013-11-20 16:35:33.151355 7fb20e7ec700 0 WARNING: couldn't find acl header for bucket, generating default
2013-11-20 16:35:33.151379 7fb20e7ec700 20 get_obj_state: rctx=0x7fb1b401e770 obj=.us-west.users.uid:us-east state=0x7fb1b401e838 s->prefetch_data=0
2013-11-20 16:35:33.151396 7fb20e7ec700 10 cache get: name=.us-west.users.uid+us-east : miss
2013-11-20 16:35:33.157848 7fb20e7ec700 10 cache put: name=.us-west.users.uid+us-east
2013-11-20 16:35:33.157872 7fb20e7ec700 10 adding .us-west.users.uid+us-east to cache LRU end
2013-11-20 16:35:33.157885 7fb20e7ec700 20 get_obj_state: s->obj_tag was set empty
2013-11-20 16:35:33.157904 7fb20e7ec700 10 moving .us-west.users.uid+us-east to cache LRU end
2013-11-20 16:35:33.157910 7fb20e7ec700 10 cache get: name=.us-west.users.uid+us-east : type miss (requested=1, cached=6)
2013-11-20 16:35:33.157924 7fb20e7ec700 20 get_obj_state: rctx=0x7fb1b401e770 obj=.us-west.users.uid:us-east state=0x7fb1b401ebd8 s->prefetch_data=0
2013-11-20 16:35:33.157940 7fb20e7ec700 10 moving .us-west.users.uid+us-east to cache LRU end
2013-11-20 16:35:33.157945 7fb20e7ec700 10 cache get: name=.us-west.users.uid+us-east : hit
2013-11-20 16:35:33.157957 7fb20e7ec700 20 get_obj_state: s->obj_tag was set empty
2013-11-20 16:35:33.157963 7fb20e7ec700 20 get_obj_state: rctx=0x7fb1b401e770 obj=.us-west.users.uid:us-east state=0x7fb1b401ebd8 s->prefetch_data=0
2013-11-20 16:35:33.157971 7fb20e7ec700 20 state for obj=.us-west.users.uid:us-east is not atomic, not appending atomic test
2013-11-20 16:35:33.157977 7fb20e7ec700 20 rados->read obj-ofs=0 read_ofs=0 read_len=524288
2013-11-20 16:35:33.162948 7fb20e7ec700 20 rados->read r=0 bl.length=304
2013-11-20 16:35:33.162991 7fb20e7ec700 10 cache put: name=.us-west.users.uid+us-east
2013-11-20 16:35:33.162999 7fb20e7ec700 10 moving .us-west.users.uid+us-east to cache LRU end
2013-11-20 16:35:33.163076 7fb20e7ec700 2 req 330:0.037035:s3:PUT /new-bucket/s3stor.exe:copy_obj:verifying op params
2013-11-20 16:35:33.163090 7fb20e7ec700 2 req 330:0.037050:s3:PUT /new-bucket/s3stor.exe:copy_obj:executing
2013-11-20 16:35:33.163163 7fb20e7ec700 10 x>> x-amz-copy-source:new-bucket%2Fs3stor.exe
2013-11-20 16:35:33.163347 7fb20e7ec700 5 Copy object new-bucket(@.rgw.buckets[us-east.6555.1]):s3stor
.exe => new-bucket(@.rgw.buckets[us-east.6555.1]):s3stor.exe
2013-11-20 16:35:33.178959 7fb20e7ec700 10 meta>> HTTP_X_AMZ_COPY_SOURCE
2013-11-20 16:35:33.179017 7fb20e7ec700 10 x>> x-amz-copy-source:new-bucket%2Fs3stor.exe
2013-11-20 16:35:33.179024 7fb20e7ec700 0 > HTTP_DATE -> Wed Nov 20 08:35:33 2013
2013-11-20 16:35:33.179028 7fb20e7ec700 0 > HTTP_X_AMZ_COPY_SOURCE -> new-bucket%2Fs3stor.exe
2013-11-20 16:35:33.179055 7fb20e7ec700 10 get_canon_resource(): dest=/new-bucket/s3stor.exe
2013-11-20 16:35:33.179062 7fb20e7ec700 10 generated canonical header: GET
Wed Nov 20 08:35:33 2013
x-amz-copy-source:new-bucket%2Fs3stor.exe
/new-bucket/s3stor.exe
2013-11-20 16:35:33.179215 7fb20e7ec700 15 generated auth header: AWS CQHH7O4XULLINBNQQSPB:8jSTyaLmUuJPpCbu6r+o56Ex8GY=
2013-11-20 16:35:33.179289 7fb20e7ec700 20 sending request to http://ceph-osd26.com:80/new-bucket/s3st
or.exe?rgwx-uid=us-west&rgwx-region=us&rgwx-prepend-metadata=us
2013-11-20 16:35:33.186334 7fb20e7ec700 10 receive_http_header
2013-11-20 16:35:33.186375 7fb20e7ec700 10 received header:HTTP/1.1 411 Length Required
2013-11-20 16:35:33.186399 7fb20e7ec700 10 receive_http_header
2013-11-20 16:35:33.186407 7fb20e7ec700 10 received header:Date: Wed, 20 Nov 2013 08:35:33 GMT
2013-11-20 16:35:33.186491 7fb20e7ec700 10 receive_http_header
2013-11-20 16:35:33.186501 7fb20e7ec700 10 received header:Server: Apache/2.2.22 (Ubuntu)
2013-11-20 16:35:33.186520 7fb20e7ec700 10 receive_http_header
2013-11-20 16:35:33.186527 7fb20e7ec700 10 received header:Vary: Accept-Encoding
2013-11-20 16:35:33.186555 7fb20e7ec700 10 receive_http_header
2013-11-20 16:35:33.186564 7fb20e7ec700 10 received header:Content-Length: 238
2013-11-20 16:35:33.186585 7fb20e7ec700 10 receive_http_header
2013-11-20 16:35:33.186594 7fb20e7ec700 10 received header:Connection: close
2013-11-20 16:35:33.186615 7fb20e7ec700 10 receive_http_header
2013-11-20 16:35:33.186622 7fb20e7ec700 10 received header:Content-Type: text/html; charset=iso-8859-1
2013-11-20 16:35:33.186640 7fb20e7ec700 10 receive_http_header
2013-11-20 16:35:33.186647 7fb20e7ec700 10 received header:
2013-11-20 16:35:33.201761 7fb20e7ec700 0 WARNING: set_req_state_err err_no=5 resorting to 500
2013-11-20 16:35:33.201902 7fb20e7ec700 2 req 330:0.075861:s3:PUT /new-bucket/s3stor.exe:copy_obj:http status=500
2013-11-20 16:35:33.202212 7fb20e7ec700 1 ====== req done req=0x26268c0 http_status=500 ======
2013-11-20 16:35:33.211946 7fb251aa8780 20 enqueued request req=0x26407d0
2013-11-20 16:35:33.212029 7fb251aa8780 20 RGWWQ:
2013-11-20 16:35:33.212052 7fb251aa8780 20 req: 0x26407d0
2013-11-20 16:35:33.212118 7fb251aa8780 10 allocated request req=0x2626250
2013-11-20 16:35:33.212221 7fb20cfe9700 20 dequeued request req=0x26407d0
2013-11-20 16:35:33.212251 7fb20cfe9700 20 RGWWQ: empty
2013-11-20 16:35:33.212289 7fb20cfe9700 1 ====== starting new request req=0x26407d0 =====
2013-11-20 16:35:33.212630 7fb20cfe9700 2 req 331:0.000343::GET /admin/opstate::initializing
2013-11-20 16:35:33.212666 7fb20cfe9700 10 host=ceph-rgw41.com rgw_dns_name=ceph-rgw42
2013-11-20 16:35:33.212885 7fb20cfe9700 20 FCGI_ROLE=RESPONDER
2013-11-20 16:35:33.212899 7fb20cfe9700 20 SCRIPT_URL=/admin/opstate
2013-11-20 16:35:33.212909 7fb20cfe9700 20 SCRIPT_URI=http://ceph-rgw41.com/admin/opstate
2013-11-20 16:35:33.212919 7fb20cfe9700 20 HTTP_AUTHORIZATION=AWS CQHH7O4XULLINBNQQSPB:lhw7eiH89XFA8LaKc86d9uByiXA=
2013-11-20 16:35:33.212930 7fb20cfe9700 20 HTTP_HOST=ceph-rgw41.com
2013-11-20 16:35:33.212939 7fb20cfe9700 20 CONTENT_LENGTH=0
2013-11-20 16:35:33.212949 7fb20cfe9700 20 HTTP_ACCEPT_ENCODING=gzip, deflate, compress
2013-11-20 16:35:33.212958 7fb20cfe9700 20 HTTP_ACCEPT=*/*
2013-11-20 16:35:33.212968 7fb20cfe9700 20 HTTP_USER_AGENT=Boto/2.16.0 Python/2.7.3 Linux/3.5.0-23-generic
2013-11-20 16:35:33.212978 7fb20cfe9700 20 HTTP_DATE=Wed, 20 Nov 2013 08:35:33 GMT
2013-11-20 16:35:33.212987 7fb20cfe9700 20 PATH=/usr/local/bin:/usr/bin:/bin
2013-11-20 16:35:33.212995 7fb20cfe9700 20 SERVER_SIGNATURE=
2013-11-20 16:35:33.213004 7fb20cfe9700 20 SERVER_SOFTWARE=Apache/2.2.22 (Ubuntu)
2013-11-20 16:35:33.213014 7fb20cfe9700 20 SERVER_NAME=ceph-rgw41.com
2013-11-20 16:35:33.213022 7fb20cfe9700 20 SERVER_ADDR=192.168.50.91
2013-11-20 16:35:33.213031 7fb20cfe9700 20 SERVER_PORT=80
2013-11-20 16:35:33.213039 7fb20cfe9700 20 REMOTE_ADDR=192.168.50.91
2013-11-20 16:35:33.213207 7fb20cfe9700 20 DOCUMENT_ROOT=/var/www/
2013-11-20 16:35:33.213232 7fb20cfe9700 20 SERVER_ADMIN=[no address given]
2013-11-20 16:35:33.213248 7fb20cfe9700 20 SCRIPT_FILENAME=/var/www/s3gw.fcgi
2013-11-20 16:35:33.213262 7fb20cfe9700 20 REMOTE_PORT=56878
2013-11-20 16:35:33.213278 7fb20cfe9700 20 GATEWAY_INTERFACE=CGI/1.1
2013-11-20 16:35:33.213293 7fb20cfe9700 20 SERVER_PROTOCOL=HTTP/1.1
2013-11-20 16:35:33.213306 7fb20cfe9700 20 REQUEST_METHOD=GET
2013-11-20 16:35:33.213320 7fb20cfe9700 20 QUERY_STRING=page=admin¶ms=/opstate&client-id=radosgw-agent
&object=new-bucket%2Fs3stor.exe&op-id=ceph-rgw41%3A8977%3A1
2013-11-20 16:35:33.213346 7fb20cfe9700 20 REQUEST_URI=/admin/opstate?client-id=radosgw-agent&object=new
-bucket%2Fs3stor.exe&op-id=ceph-rgw41%3A8977%3A1
2013-11-20 16:35:33.213367 7fb20cfe9700 20 SCRIPT_NAME=/admin/opstate
2013-11-20 16:35:33.213386 7fb20cfe9700 2 req 331:0.001098::GET /admin/opstate::getting op
2013-11-20 16:35:33.213426 7fb20cfe9700 2 req 331:0.001138::GET /admin/opstate:opstate_list:authorizing
2013-11-20 16:35:33.213550 7fb20cfe9700 20 get_obj_state: rctx=0x7fb1c800e970 obj=.us-west.users:CQHH7O4
XULLINBNQQSPB state=0x7fb1c8005e38 s->prefetch_data=0
2013-11-20 16:35:33.213625 7fb20cfe9700 10 moving .us-west.users+CQHH7O4XULLINBNQQSPB to cache LRU end
2013-11-20 16:35:33.213655 7fb20cfe9700 10 cache get: name=.us-west.users+CQHH7O4XULLINBNQQSPB : hit
2013-11-20 16:35:33.213714 7fb20cfe9700 20 get_obj_state: s->obj_tag was set empty
2013-11-20 16:35:33.213775 7fb20cfe9700 10 moving .us-west.users+CQHH7O4XULLINBNQQSPB to cache LRU end
2013-11-20 16:35:33.213793 7fb20cfe9700 10 cache get: name=.us-west.users+CQHH7O4XULLINBNQQSPB : hit
2013-11-20 16:35:33.213883 7fb20cfe9700 20 get_obj_state: rctx=0x7fb1c800ce40 obj=.us-west.users.uid:
us-west state=0x7fb1c8005e38 s->prefetch_data=0
2013-11-20 16:35:33.213931 7fb20cfe9700 10 moving .us-west.users.uid+us-west to cache LRU end
2013-11-20 16:35:33.213948 7fb20cfe9700 10 cache get: name=.us-west.users.uid+us-west : hit
2013-11-20 16:35:33.213983 7fb20cfe9700 20 get_obj_state: s->obj_tag was set empty
2013-11-20 16:35:33.214021 7fb20cfe9700 10 moving .us-west.users.uid+us-west to cache LRU end
2013-11-20 16:35:33.214037 7fb20cfe9700 10 cache get: name=.us-west.users.uid+us-west : hit
2013-11-20 16:35:33.214293 7fb20cfe9700 10 get_canon_resource(): dest=/admin/opstate
2013-11-20 16:35:33.214314 7fb20cfe9700 10 auth_hdr:
GET
Wed, 20 Nov 2013 08:35:33 GMT
/admin/opstate
2013-11-20 16:35:33.214636 7fb20cfe9700 15 calculated digest=lhw7eiH89XFA8LaKc86d9uByiXA=
2013-11-20 16:35:33.214656 7fb20cfe9700 15 auth_sign=lhw7eiH89XFA8LaKc86d9uByiXA=
2013-11-20 16:35:33.214667 7fb20cfe9700 15 compare=0
2013-11-20 16:35:33.214682 7fb20cfe9700 20 system request
2013-11-20 16:35:33.214707 7fb20cfe9700 2 req 331:0.002418::GET /admin/opstate:opstate_list:reading permissions
2013-11-20 16:35:33.214733 7fb20cfe9700 2 req 331:0.002446::GET /admin/opstate:opstate_list:init op
2013-11-20 16:35:33.214755 7fb20cfe9700 2 req 331:0.002468::GET /admin/opstate:opstate_list:verifying op mask
2013-11-20 16:35:33.214777 7fb20cfe9700 20 required_mask= 0 user.op_mask=7
2013-11-20 16:35:33.214791 7fb20cfe9700 2 req 331:0.002505::GET /admin/opstate:opstate_list:verifying op permissions
2013-11-20 16:35:33.214815 7fb20cfe9700 2 overriding permissions due to system operation
2013-11-20 16:35:33.214827 7fb20cfe9700 2 req 331:0.002540::GET /admin/opstate:opstate_list:verifying op params
2013-11-20 16:35:33.214847 7fb20cfe9700 2 req 331:0.002560::GET /admin/opstate:opstate_list:executing
2013-11-20 16:35:33.221832 7fb20cfe9700 2 req 331:0.009544::GET /admin/opstate:opstate_list:http status=200
2013-11-20 16:35:33.222078 7fb20cfe9700 1 ====== req done req=0x26407d0 http_status=200 ======
2013-11-20 16:35:33.238655 7fb251aa8780 20 enqueued request req=0x2626250
2013-11-20 16:35:33.238700 7fb251aa8780 20 RGWWQ:
2013-11-20 16:35:33.238709 7fb251aa8780 20 req: 0x2626250
2013-11-20 16:35:33.238732 7fb251aa8780 10 allocated request req=0x261fbf0
2013-11-20 16:35:33.238750 7fb20c7e8700 20 dequeued request req=0x2626250
2013-11-20 16:35:33.238761 7fb20c7e8700 20 RGWWQ: empty
2013-11-20 16:35:33.238777 7fb20c7e8700 1 ====== starting new request req=0x2626250 =====
2013-11-20 16:35:33.238937 7fb20c7e8700 2 req 332:0.000162::PUT /new-bucket/test::initializing
2013-11-20 16:35:33.238953 7fb20c7e8700 10 host=ceph-rgw41.com rgw_dns_name=ceph-rgw42
2013-11-20 16:35:33.238983 7fb20c7e8700 10 meta>> HTTP_X_AMZ_COPY_SOURCE
2013-11-20 16:35:33.239008 7fb20c7e8700 10 x>> x-amz-copy-source:new-bucket%2Ftest
2013-11-20 16:35:33.239063 7fb20c7e8700 10 s->object=test s->bucket=new-bucket
2013-11-20 16:35:33.239083 7fb20c7e8700 20 FCGI_ROLE=RESPONDER
2013-11-20 16:35:33.239088 7fb20c7e8700 20 SCRIPT_URL=/new-bucket/test
2013-11-20 16:35:33.239091 7fb20c7e8700 20 SCRIPT_URI=http://ceph-rgw41.com/new-bucket/test
2013-11-20 16:35:33.239095 7fb20c7e8700 20 HTTP_AUTHORIZATION=AWS CQHH7O4XULLINBNQQSPB:7bvQR/5nqrjw6h58CmiigPwX8sY=
2013-11-20 16:35:33.239098 7fb20c7e8700 20 HTTP_HOST=ceph-rgw41.com
2013-11-20 16:35:33.239102 7fb20c7e8700 20 CONTENT_LENGTH=0
2013-11-20 16:35:33.239106 7fb20c7e8700 20 HTTP_ACCEPT_ENCODING=gzip, deflate, compress
2013-11-20 16:35:33.239110 7fb20c7e8700 20 HTTP_ACCEPT=*/*
2013-11-20 16:35:33.239114 7fb20c7e8700 20 HTTP_USER_AGENT=Boto/2.16.0 Python/2.7.3 Linux/3.5.0-23-generic
2013-11-20 16:35:33.239117 7fb20c7e8700 20 HTTP_X_AMZ_COPY_SOURCE=new-bucket%2Ftest
2013-11-20 16:35:33.239121 7fb20c7e8700 20 HTTP_DATE=Wed, 20 Nov 2013 08:35:33 GMT
2013-11-20 16:35:33.239124 7fb20c7e8700 20 CONTENT_TYPE=application/json; charset=UTF-8
2013-11-20 16:35:33.239127 7fb20c7e8700 20 PATH=/usr/local/bin:/usr/bin:/bin
2013-11-20 16:35:33.239131 7fb20c7e8700 20 SERVER_SIGNATURE=
2013-11-20 16:35:33.239134 7fb20c7e8700 20 SERVER_SOFTWARE=Apache/2.2.22 (Ubuntu)
2013-11-20 16:35:33.239138 7fb20c7e8700 20 SERVER_NAME=ceph-rgw41.com
2013-11-20 16:35:33.239141 7fb20c7e8700 20 SERVER_ADDR=192.168.50.91
2013-11-20 16:35:33.239144 7fb20c7e8700 20 SERVER_PORT=80
2013-11-20 16:35:33.239148 7fb20c7e8700 20 REMOTE_ADDR=192.168.50.91
2013-11-20 16:35:33.239151 7fb20c7e8700 20 DOCUMENT_ROOT=/var/www/
2013-11-20 16:35:33.239155 7fb20c7e8700 20 SERVER_ADMIN=[no address given]
2013-11-20 16:35:33.239158 7fb20c7e8700 20 SCRIPT_FILENAME=/var/www/s3gw.fcgi
2013-11-20 16:35:33.239161 7fb20c7e8700 20 REMOTE_PORT=56879
2013-11-20 16:35:33.239164 7fb20c7e8700 20 GATEWAY_INTERFACE=CGI/1.1
2013-11-20 16:35:33.239168 7fb20c7e8700 20 SERVER_PROTOCOL=HTTP/1.1
2013-11-20 16:35:33.239171 7fb20c7e8700 20 REQUEST_METHOD=PUT
2013-11-20 16:35:33.239174 7fb20c7e8700 20 QUERY_STRING=page=new-bucket¶ms=/test&rgwx-op-id
=ceph-rgw41%3A8977%3A2&rgwx-source-zone=us-east&rgwx-client-id=radosgw-agent
2013-11-20 16:35:33.239180 7fb20c7e8700 20 REQUEST_URI=/new-bucket/test?rgwx-op-id=ceph-rgw41%3A
8977%3A2&rgwx-source-zone=us-east&rgwx-client-id=radosgw-agent
2013-11-20 16:35:33.239185 7fb20c7e8700 20 SCRIPT_NAME=/new-bucket/test
2013-11-20 16:35:33.239189 7fb20c7e8700 2 req 332:0.000413:s3:PUT /new-bucket/test::getting op
2013-11-20 16:35:33.239201 7fb20c7e8700 2 req 332:0.000426:s3:PUT /new-bucket/test:copy_obj:authorizing
2013-11-20 16:35:33.239241 7fb20c7e8700 20 get_obj_state: rctx=0x7fb1c4014c40 obj=.us-west.users
:CQHH7O4XULLINBNQQSPB state=0x7fb1c4003198 s->prefetch_data=0
2013-11-20 16:35:33.239262 7fb20c7e8700 10 moving .us-west.users+CQHH7O4XULLINBNQQSPB to cache LRU end
2013-11-20 16:35:33.239271 7fb20c7e8700 10 cache get: name=.us-west.users+CQHH7O4XULLINBNQQSPB : hit
2013-11-20 16:35:33.239287 7fb20c7e8700 20 get_obj_state: s->obj_tag was set empty
2013-11-20 16:35:33.239303 7fb20c7e8700 10 moving .us-west.users+CQHH7O4XULLINBNQQSPB to cache LRU end
2013-11-20 16:35:33.239309 7fb20c7e8700 10 cache get: name=.us-west.users+CQHH7O4XULLINBNQQSPB : hit
2013-11-20 16:35:33.239346 7fb20c7e8700 20 get_obj_state: rctx=0x7fb1c4003120 obj=.us-west.users.
uid:us-west state=0x7fb1c401e798 s->prefetch_data=0
2013-11-20 16:35:33.239363 7fb20c7e8700 10 moving .us-west.users.uid+us-west to cache LRU end
2013-11-20 16:35:33.239370 7fb20c7e8700 10 cache get: name=.us-west.users.uid+us-west : hit
2013-11-20 16:35:33.239382 7fb20c7e8700 20 get_obj_state: s->obj_tag was set empty
2013-11-20 16:35:33.239396 7fb20c7e8700 10 moving .us-west.users.uid+us-west to cache LRU end
2013-11-20 16:35:33.239402 7fb20c7e8700 10 cache get: name=.us-west.users.uid+us-west : hit
2013-11-20 16:35:33.239505 7fb20c7e8700 10 get_canon_resource(): dest=/new-bucket/test
2013-11-20 16:35:33.239513 7fb20c7e8700 10 auth_hdr:
PUT