Re: [ceph-users] recreate bucket error

2014-01-22 Thread Yehuda Sadeh
On Wed, Jan 22, 2014 at 2:33 AM, Sylvain Munaut
 wrote:
> Hi,
>
> On Sat, Dec 7, 2013 at 6:34 PM, Yehuda Sadeh  wrote:
>> Sounds like disabling the cache triggers some bug. I'll open a relevant 
>> ticket.
>
> Any news on this ?
>
> I have the same issue, but the cache only masks the problem. If you
> restart radosgw, you'll get it again (once for each bucket).
>

There's a related issue in the ceph tracker (#6951), and it's still up
on my list.

Yehuda
___
ceph-users mailing list
ceph-users@lists.ceph.com
http://lists.ceph.com/listinfo.cgi/ceph-users-ceph.com


Re: [ceph-users] recreate bucket error

2014-01-22 Thread Sylvain Munaut
Hi,

On Sat, Dec 7, 2013 at 6:34 PM, Yehuda Sadeh  wrote:
> Sounds like disabling the cache triggers some bug. I'll open a relevant 
> ticket.

Any news on this ?

I have the same issue, but the cache only masks the problem. If you
restart radosgw, you'll get it again (once for each bucket).

Cheers,

Sylvain
___
ceph-users mailing list
ceph-users@lists.ceph.com
http://lists.ceph.com/listinfo.cgi/ceph-users-ceph.com


Re: [ceph-users] recreate bucket error

2013-12-07 Thread Dominik Mostowiec
Thanks for Your help !!

---
Regards
Dominik

On Dec 7, 2013 6:34 PM, "Yehuda Sadeh"  wrote:
>
> Sounds like disabling the cache triggers some bug. I'll open a relevant 
> ticket.
>
> Thanks,
> Yehuda
>
> On Sat, Dec 7, 2013 at 9:29 AM, Dominik Mostowiec
>  wrote:
> > ok, enabling cache helps :-)
> > What was wrong ?
> >
> > --
> > Dominik
> >
> > 2013/12/7 Dominik Mostowiec :
> >> Yes, it is disabled
> >> grep 'cache' /etc/ceph/ceph.conf  | grep rgw
> >> rgw_cache_enabled = false ;rgw cache enabled
> >> rgw_cache_lru_size = 1 ;num of entries in rgw cache
> >>
> >> --
> >> Regards
> >> Dominik
> >>
> >> 2013/12/7 Yehuda Sadeh :
> >>> Did you disable the cache by any chance (e.g., 'rgw cache enabled = 
> >>> false')?
> >>>
> >>>
> >>>
> >>> On Sat, Dec 7, 2013 at 8:34 AM, Dominik Mostowiec
> >>>  wrote:
>  Hi,
>  Log:
>  -
>  2013-12-07 17:32:42.736396 7ffbe36d3780 10 allocated request req=0xe66f40
>  2013-12-07 17:32:42.736438 7ff79b1c6700  1 == starting new request
>  req=0xe60860 =
>  2013-12-07 17:32:42.736590 7ff79b1c6700  2 req 1:0.000153::PUT
>  /test1/::initializing
>  2013-12-07 17:32:42.736659 7ff79b1c6700 10 meta>> HTTP_X_AMZ_DATE
>  2013-12-07 17:32:42.736686 7ff79b1c6700 10 x>> x-amz-date:Sat, 07 Dec
>  2013 16:32:42 GMT
>  2013-12-07 17:32:42.736758 7ff79b1c6700 10 s->object= 
>  s->bucket=test1
>  2013-12-07 17:32:42.736788 7ff79b1c6700  2 req 1:0.000351:s3:PUT
>  /test1/::getting op
>  2013-12-07 17:32:42.736800 7ff79b1c6700  2 req 1:0.000364:s3:PUT
>  /test1/:create_bucket:authorizing
>  2013-12-07 17:32:42.736907 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>  --> 10.174.33.11:6804/161220 -- osd_op(client.95391.0:107
>  F7P3E755K6BN5LR3N85U [getxattrs,stat] 7.62531457 e192) v4 -- ?+0 0x7ff
>  794005a90 con 0xd908d0
>  2013-12-07 17:32:42.738159 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
>  <== osd.1 10.174.33.11:6804/161220 23  osd_op_reply(107
>  F7P3E755K6BN5LR3N85U [getxattrs,stat] ondisk = 0) v4  161+0+20 (
>  1539386342 0 1044315090) 0x7ffba40019c0 con 0xd908d0
>  2013-12-07 17:32:42.738341 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>  --> 10.174.33.11:6804/161220 -- osd_op(client.95391.0:108
>  F7P3E755K6BN5LR3N85U [getxattrs,stat] 7.62531457 e192) v4 -- ?+0 0x7ff
>  794005c20 con 0xd908d0
>  2013-12-07 17:32:42.739230 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
>  <== osd.1 10.174.33.11:6804/161220 24  osd_op_reply(108
>  F7P3E755K6BN5LR3N85U [getxattrs,stat] ondisk = 0) v4  161+0+20 (
>  1539386342 0 1044315090) 0x7ffba40019c0 con 0xd908d0
>  2013-12-07 17:32:42.739349 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>  --> 10.174.33.11:6804/161220 -- osd_op(client.95391.0:109
>  F7P3E755K6BN5LR3N85U [read 0~524288] 7.62531457 e192) v4 -- ?+0 0x7ff7
>  94005a90 con 0xd908d0
>  2013-12-07 17:32:42.740172 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
>  <== osd.1 10.174.33.11:6804/161220 25  osd_op_reply(109
>  F7P3E755K6BN5LR3N85U [read 0~5] ondisk = 0) v4  119+0+5 (9359852
>  51 0 150087197) 0x7ffba40019c0 con 0xd908d0
>  2013-12-07 17:32:42.740310 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>  --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:110 0
>  [getxattrs,stat] 6.f18a3536 e192) v4 -- ?+0 0x7ff794006570 con 0xd8b
>  210
>  2013-12-07 17:32:42.741208 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
>  <== osd.0 10.174.33.11:6802/225929 49  osd_op_reply(110 0
>  [getxattrs,stat] ondisk = 0) v4  142+0+91 (2507304458 0 349659
>  2801) 0x7ffbb4000a60 con 0xd8b210
>  2013-12-07 17:32:42.741326 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>  --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:111 0
>  [getxattrs,stat] 6.f18a3536 e192) v4 -- ?+0 0x7ff7940063a0 con 0xd8b
>  210
>  2013-12-07 17:32:42.742153 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
>  <== osd.0 10.174.33.11:6802/225929 50  osd_op_reply(111 0
>  [getxattrs,stat] ondisk = 0) v4  142+0+91 (2507304458 0 349659
>  2801) 0x7ffbb4000a60 con 0xd8b210
>  2013-12-07 17:32:42.742268 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>  --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:112 0 [read
>  0~524288] 6.f18a3536 e192) v4 -- ?+0 0x7ff7940063a0 con 0xd8b2
>  10
>  2013-12-07 17:32:42.743159 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
>  <== osd.0 10.174.33.11:6802/225929 51  osd_op_reply(112 0 [read
>  0~254] ondisk = 0) v4  100+0+254 (3890176355 0 345783013
>  2) 0x7ffbb4000a60 con 0xd8b210
>  2013-12-07 17:32:42.743315 7ff79b1c6700 10 get_canon_resource(): dest=
>  2013-12-07 17:32:42.743326 7ff79b1c6700 10 auth_hdr:
>  PUT
> 
> 
> 
>  x-amz-date:Sat, 07 Dec 2013 16:32:42 GMT
>  /test1/
>  2013-12-07 17:32:42.743459 7ff79b1c6700  2 req 1:0.007023:s3:PUT
>  /

Re: [ceph-users] recreate bucket error

2013-12-07 Thread Yehuda Sadeh
Sounds like disabling the cache triggers some bug. I'll open a relevant ticket.

Thanks,
Yehuda

On Sat, Dec 7, 2013 at 9:29 AM, Dominik Mostowiec
 wrote:
> ok, enabling cache helps :-)
> What was wrong ?
>
> --
> Dominik
>
> 2013/12/7 Dominik Mostowiec :
>> Yes, it is disabled
>> grep 'cache' /etc/ceph/ceph.conf  | grep rgw
>> rgw_cache_enabled = false ;rgw cache enabled
>> rgw_cache_lru_size = 1 ;num of entries in rgw cache
>>
>> --
>> Regards
>> Dominik
>>
>> 2013/12/7 Yehuda Sadeh :
>>> Did you disable the cache by any chance (e.g., 'rgw cache enabled = false')?
>>>
>>>
>>>
>>> On Sat, Dec 7, 2013 at 8:34 AM, Dominik Mostowiec
>>>  wrote:
 Hi,
 Log:
 -
 2013-12-07 17:32:42.736396 7ffbe36d3780 10 allocated request req=0xe66f40
 2013-12-07 17:32:42.736438 7ff79b1c6700  1 == starting new request
 req=0xe60860 =
 2013-12-07 17:32:42.736590 7ff79b1c6700  2 req 1:0.000153::PUT
 /test1/::initializing
 2013-12-07 17:32:42.736659 7ff79b1c6700 10 meta>> HTTP_X_AMZ_DATE
 2013-12-07 17:32:42.736686 7ff79b1c6700 10 x>> x-amz-date:Sat, 07 Dec
 2013 16:32:42 GMT
 2013-12-07 17:32:42.736758 7ff79b1c6700 10 s->object= s->bucket=test1
 2013-12-07 17:32:42.736788 7ff79b1c6700  2 req 1:0.000351:s3:PUT
 /test1/::getting op
 2013-12-07 17:32:42.736800 7ff79b1c6700  2 req 1:0.000364:s3:PUT
 /test1/:create_bucket:authorizing
 2013-12-07 17:32:42.736907 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
 --> 10.174.33.11:6804/161220 -- osd_op(client.95391.0:107
 F7P3E755K6BN5LR3N85U [getxattrs,stat] 7.62531457 e192) v4 -- ?+0 0x7ff
 794005a90 con 0xd908d0
 2013-12-07 17:32:42.738159 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
 <== osd.1 10.174.33.11:6804/161220 23  osd_op_reply(107
 F7P3E755K6BN5LR3N85U [getxattrs,stat] ondisk = 0) v4  161+0+20 (
 1539386342 0 1044315090) 0x7ffba40019c0 con 0xd908d0
 2013-12-07 17:32:42.738341 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
 --> 10.174.33.11:6804/161220 -- osd_op(client.95391.0:108
 F7P3E755K6BN5LR3N85U [getxattrs,stat] 7.62531457 e192) v4 -- ?+0 0x7ff
 794005c20 con 0xd908d0
 2013-12-07 17:32:42.739230 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
 <== osd.1 10.174.33.11:6804/161220 24  osd_op_reply(108
 F7P3E755K6BN5LR3N85U [getxattrs,stat] ondisk = 0) v4  161+0+20 (
 1539386342 0 1044315090) 0x7ffba40019c0 con 0xd908d0
 2013-12-07 17:32:42.739349 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
 --> 10.174.33.11:6804/161220 -- osd_op(client.95391.0:109
 F7P3E755K6BN5LR3N85U [read 0~524288] 7.62531457 e192) v4 -- ?+0 0x7ff7
 94005a90 con 0xd908d0
 2013-12-07 17:32:42.740172 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
 <== osd.1 10.174.33.11:6804/161220 25  osd_op_reply(109
 F7P3E755K6BN5LR3N85U [read 0~5] ondisk = 0) v4  119+0+5 (9359852
 51 0 150087197) 0x7ffba40019c0 con 0xd908d0
 2013-12-07 17:32:42.740310 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
 --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:110 0
 [getxattrs,stat] 6.f18a3536 e192) v4 -- ?+0 0x7ff794006570 con 0xd8b
 210
 2013-12-07 17:32:42.741208 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
 <== osd.0 10.174.33.11:6802/225929 49  osd_op_reply(110 0
 [getxattrs,stat] ondisk = 0) v4  142+0+91 (2507304458 0 349659
 2801) 0x7ffbb4000a60 con 0xd8b210
 2013-12-07 17:32:42.741326 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
 --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:111 0
 [getxattrs,stat] 6.f18a3536 e192) v4 -- ?+0 0x7ff7940063a0 con 0xd8b
 210
 2013-12-07 17:32:42.742153 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
 <== osd.0 10.174.33.11:6802/225929 50  osd_op_reply(111 0
 [getxattrs,stat] ondisk = 0) v4  142+0+91 (2507304458 0 349659
 2801) 0x7ffbb4000a60 con 0xd8b210
 2013-12-07 17:32:42.742268 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
 --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:112 0 [read
 0~524288] 6.f18a3536 e192) v4 -- ?+0 0x7ff7940063a0 con 0xd8b2
 10
 2013-12-07 17:32:42.743159 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
 <== osd.0 10.174.33.11:6802/225929 51  osd_op_reply(112 0 [read
 0~254] ondisk = 0) v4  100+0+254 (3890176355 0 345783013
 2) 0x7ffbb4000a60 con 0xd8b210
 2013-12-07 17:32:42.743315 7ff79b1c6700 10 get_canon_resource(): dest=
 2013-12-07 17:32:42.743326 7ff79b1c6700 10 auth_hdr:
 PUT



 x-amz-date:Sat, 07 Dec 2013 16:32:42 GMT
 /test1/
 2013-12-07 17:32:42.743459 7ff79b1c6700  2 req 1:0.007023:s3:PUT
 /test1/:create_bucket:reading permissions
 2013-12-07 17:32:42.743475 7ff79b1c6700  2 req 1:0.007038:s3:PUT
 /test1/:create_bucket:verifying op mask
 2013-12-07 17:32:42.743479 7ff79b1c6700  2 req 1:0.007043:s3:PUT
 /test1/:create_bucket:verifying op permissions
 2013-12-07 17:32:42.743542 7ff79b1c6

Re: [ceph-users] recreate bucket error

2013-12-07 Thread Dominik Mostowiec
ok, enabling cache helps :-)
What was wrong ?

--
Dominik

2013/12/7 Dominik Mostowiec :
> Yes, it is disabled
> grep 'cache' /etc/ceph/ceph.conf  | grep rgw
> rgw_cache_enabled = false ;rgw cache enabled
> rgw_cache_lru_size = 1 ;num of entries in rgw cache
>
> --
> Regards
> Dominik
>
> 2013/12/7 Yehuda Sadeh :
>> Did you disable the cache by any chance (e.g., 'rgw cache enabled = false')?
>>
>>
>>
>> On Sat, Dec 7, 2013 at 8:34 AM, Dominik Mostowiec
>>  wrote:
>>> Hi,
>>> Log:
>>> -
>>> 2013-12-07 17:32:42.736396 7ffbe36d3780 10 allocated request req=0xe66f40
>>> 2013-12-07 17:32:42.736438 7ff79b1c6700  1 == starting new request
>>> req=0xe60860 =
>>> 2013-12-07 17:32:42.736590 7ff79b1c6700  2 req 1:0.000153::PUT
>>> /test1/::initializing
>>> 2013-12-07 17:32:42.736659 7ff79b1c6700 10 meta>> HTTP_X_AMZ_DATE
>>> 2013-12-07 17:32:42.736686 7ff79b1c6700 10 x>> x-amz-date:Sat, 07 Dec
>>> 2013 16:32:42 GMT
>>> 2013-12-07 17:32:42.736758 7ff79b1c6700 10 s->object= s->bucket=test1
>>> 2013-12-07 17:32:42.736788 7ff79b1c6700  2 req 1:0.000351:s3:PUT
>>> /test1/::getting op
>>> 2013-12-07 17:32:42.736800 7ff79b1c6700  2 req 1:0.000364:s3:PUT
>>> /test1/:create_bucket:authorizing
>>> 2013-12-07 17:32:42.736907 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>>> --> 10.174.33.11:6804/161220 -- osd_op(client.95391.0:107
>>> F7P3E755K6BN5LR3N85U [getxattrs,stat] 7.62531457 e192) v4 -- ?+0 0x7ff
>>> 794005a90 con 0xd908d0
>>> 2013-12-07 17:32:42.738159 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
>>> <== osd.1 10.174.33.11:6804/161220 23  osd_op_reply(107
>>> F7P3E755K6BN5LR3N85U [getxattrs,stat] ondisk = 0) v4  161+0+20 (
>>> 1539386342 0 1044315090) 0x7ffba40019c0 con 0xd908d0
>>> 2013-12-07 17:32:42.738341 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>>> --> 10.174.33.11:6804/161220 -- osd_op(client.95391.0:108
>>> F7P3E755K6BN5LR3N85U [getxattrs,stat] 7.62531457 e192) v4 -- ?+0 0x7ff
>>> 794005c20 con 0xd908d0
>>> 2013-12-07 17:32:42.739230 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
>>> <== osd.1 10.174.33.11:6804/161220 24  osd_op_reply(108
>>> F7P3E755K6BN5LR3N85U [getxattrs,stat] ondisk = 0) v4  161+0+20 (
>>> 1539386342 0 1044315090) 0x7ffba40019c0 con 0xd908d0
>>> 2013-12-07 17:32:42.739349 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>>> --> 10.174.33.11:6804/161220 -- osd_op(client.95391.0:109
>>> F7P3E755K6BN5LR3N85U [read 0~524288] 7.62531457 e192) v4 -- ?+0 0x7ff7
>>> 94005a90 con 0xd908d0
>>> 2013-12-07 17:32:42.740172 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
>>> <== osd.1 10.174.33.11:6804/161220 25  osd_op_reply(109
>>> F7P3E755K6BN5LR3N85U [read 0~5] ondisk = 0) v4  119+0+5 (9359852
>>> 51 0 150087197) 0x7ffba40019c0 con 0xd908d0
>>> 2013-12-07 17:32:42.740310 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>>> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:110 0
>>> [getxattrs,stat] 6.f18a3536 e192) v4 -- ?+0 0x7ff794006570 con 0xd8b
>>> 210
>>> 2013-12-07 17:32:42.741208 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
>>> <== osd.0 10.174.33.11:6802/225929 49  osd_op_reply(110 0
>>> [getxattrs,stat] ondisk = 0) v4  142+0+91 (2507304458 0 349659
>>> 2801) 0x7ffbb4000a60 con 0xd8b210
>>> 2013-12-07 17:32:42.741326 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>>> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:111 0
>>> [getxattrs,stat] 6.f18a3536 e192) v4 -- ?+0 0x7ff7940063a0 con 0xd8b
>>> 210
>>> 2013-12-07 17:32:42.742153 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
>>> <== osd.0 10.174.33.11:6802/225929 50  osd_op_reply(111 0
>>> [getxattrs,stat] ondisk = 0) v4  142+0+91 (2507304458 0 349659
>>> 2801) 0x7ffbb4000a60 con 0xd8b210
>>> 2013-12-07 17:32:42.742268 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>>> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:112 0 [read
>>> 0~524288] 6.f18a3536 e192) v4 -- ?+0 0x7ff7940063a0 con 0xd8b2
>>> 10
>>> 2013-12-07 17:32:42.743159 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
>>> <== osd.0 10.174.33.11:6802/225929 51  osd_op_reply(112 0 [read
>>> 0~254] ondisk = 0) v4  100+0+254 (3890176355 0 345783013
>>> 2) 0x7ffbb4000a60 con 0xd8b210
>>> 2013-12-07 17:32:42.743315 7ff79b1c6700 10 get_canon_resource(): dest=
>>> 2013-12-07 17:32:42.743326 7ff79b1c6700 10 auth_hdr:
>>> PUT
>>>
>>>
>>>
>>> x-amz-date:Sat, 07 Dec 2013 16:32:42 GMT
>>> /test1/
>>> 2013-12-07 17:32:42.743459 7ff79b1c6700  2 req 1:0.007023:s3:PUT
>>> /test1/:create_bucket:reading permissions
>>> 2013-12-07 17:32:42.743475 7ff79b1c6700  2 req 1:0.007038:s3:PUT
>>> /test1/:create_bucket:verifying op mask
>>> 2013-12-07 17:32:42.743479 7ff79b1c6700  2 req 1:0.007043:s3:PUT
>>> /test1/:create_bucket:verifying op permissions
>>> 2013-12-07 17:32:42.743542 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>>> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:113 0.buckets
>>> [omap-get-vals 0~16] 6.f01626b7 e192) v4 -- ?+0 0x7ff7940066
>>> 00 con 0xd8b210
>>> 2013-12-07 17:32:42.744679 7ffbd96ec700  1 -- 10.174.33.11:0/1270294

Re: [ceph-users] recreate bucket error

2013-12-07 Thread Dominik Mostowiec
Yes, it is disabled
grep 'cache' /etc/ceph/ceph.conf  | grep rgw
rgw_cache_enabled = false ;rgw cache enabled
rgw_cache_lru_size = 1 ;num of entries in rgw cache

--
Regards
Dominik

2013/12/7 Yehuda Sadeh :
> Did you disable the cache by any chance (e.g., 'rgw cache enabled = false')?
>
>
>
> On Sat, Dec 7, 2013 at 8:34 AM, Dominik Mostowiec
>  wrote:
>> Hi,
>> Log:
>> -
>> 2013-12-07 17:32:42.736396 7ffbe36d3780 10 allocated request req=0xe66f40
>> 2013-12-07 17:32:42.736438 7ff79b1c6700  1 == starting new request
>> req=0xe60860 =
>> 2013-12-07 17:32:42.736590 7ff79b1c6700  2 req 1:0.000153::PUT
>> /test1/::initializing
>> 2013-12-07 17:32:42.736659 7ff79b1c6700 10 meta>> HTTP_X_AMZ_DATE
>> 2013-12-07 17:32:42.736686 7ff79b1c6700 10 x>> x-amz-date:Sat, 07 Dec
>> 2013 16:32:42 GMT
>> 2013-12-07 17:32:42.736758 7ff79b1c6700 10 s->object= s->bucket=test1
>> 2013-12-07 17:32:42.736788 7ff79b1c6700  2 req 1:0.000351:s3:PUT
>> /test1/::getting op
>> 2013-12-07 17:32:42.736800 7ff79b1c6700  2 req 1:0.000364:s3:PUT
>> /test1/:create_bucket:authorizing
>> 2013-12-07 17:32:42.736907 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.11:6804/161220 -- osd_op(client.95391.0:107
>> F7P3E755K6BN5LR3N85U [getxattrs,stat] 7.62531457 e192) v4 -- ?+0 0x7ff
>> 794005a90 con 0xd908d0
>> 2013-12-07 17:32:42.738159 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
>> <== osd.1 10.174.33.11:6804/161220 23  osd_op_reply(107
>> F7P3E755K6BN5LR3N85U [getxattrs,stat] ondisk = 0) v4  161+0+20 (
>> 1539386342 0 1044315090) 0x7ffba40019c0 con 0xd908d0
>> 2013-12-07 17:32:42.738341 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.11:6804/161220 -- osd_op(client.95391.0:108
>> F7P3E755K6BN5LR3N85U [getxattrs,stat] 7.62531457 e192) v4 -- ?+0 0x7ff
>> 794005c20 con 0xd908d0
>> 2013-12-07 17:32:42.739230 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
>> <== osd.1 10.174.33.11:6804/161220 24  osd_op_reply(108
>> F7P3E755K6BN5LR3N85U [getxattrs,stat] ondisk = 0) v4  161+0+20 (
>> 1539386342 0 1044315090) 0x7ffba40019c0 con 0xd908d0
>> 2013-12-07 17:32:42.739349 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.11:6804/161220 -- osd_op(client.95391.0:109
>> F7P3E755K6BN5LR3N85U [read 0~524288] 7.62531457 e192) v4 -- ?+0 0x7ff7
>> 94005a90 con 0xd908d0
>> 2013-12-07 17:32:42.740172 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
>> <== osd.1 10.174.33.11:6804/161220 25  osd_op_reply(109
>> F7P3E755K6BN5LR3N85U [read 0~5] ondisk = 0) v4  119+0+5 (9359852
>> 51 0 150087197) 0x7ffba40019c0 con 0xd908d0
>> 2013-12-07 17:32:42.740310 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:110 0
>> [getxattrs,stat] 6.f18a3536 e192) v4 -- ?+0 0x7ff794006570 con 0xd8b
>> 210
>> 2013-12-07 17:32:42.741208 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
>> <== osd.0 10.174.33.11:6802/225929 49  osd_op_reply(110 0
>> [getxattrs,stat] ondisk = 0) v4  142+0+91 (2507304458 0 349659
>> 2801) 0x7ffbb4000a60 con 0xd8b210
>> 2013-12-07 17:32:42.741326 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:111 0
>> [getxattrs,stat] 6.f18a3536 e192) v4 -- ?+0 0x7ff7940063a0 con 0xd8b
>> 210
>> 2013-12-07 17:32:42.742153 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
>> <== osd.0 10.174.33.11:6802/225929 50  osd_op_reply(111 0
>> [getxattrs,stat] ondisk = 0) v4  142+0+91 (2507304458 0 349659
>> 2801) 0x7ffbb4000a60 con 0xd8b210
>> 2013-12-07 17:32:42.742268 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:112 0 [read
>> 0~524288] 6.f18a3536 e192) v4 -- ?+0 0x7ff7940063a0 con 0xd8b2
>> 10
>> 2013-12-07 17:32:42.743159 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
>> <== osd.0 10.174.33.11:6802/225929 51  osd_op_reply(112 0 [read
>> 0~254] ondisk = 0) v4  100+0+254 (3890176355 0 345783013
>> 2) 0x7ffbb4000a60 con 0xd8b210
>> 2013-12-07 17:32:42.743315 7ff79b1c6700 10 get_canon_resource(): dest=
>> 2013-12-07 17:32:42.743326 7ff79b1c6700 10 auth_hdr:
>> PUT
>>
>>
>>
>> x-amz-date:Sat, 07 Dec 2013 16:32:42 GMT
>> /test1/
>> 2013-12-07 17:32:42.743459 7ff79b1c6700  2 req 1:0.007023:s3:PUT
>> /test1/:create_bucket:reading permissions
>> 2013-12-07 17:32:42.743475 7ff79b1c6700  2 req 1:0.007038:s3:PUT
>> /test1/:create_bucket:verifying op mask
>> 2013-12-07 17:32:42.743479 7ff79b1c6700  2 req 1:0.007043:s3:PUT
>> /test1/:create_bucket:verifying op permissions
>> 2013-12-07 17:32:42.743542 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:113 0.buckets
>> [omap-get-vals 0~16] 6.f01626b7 e192) v4 -- ?+0 0x7ff7940066
>> 00 con 0xd8b210
>> 2013-12-07 17:32:42.744679 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
>> <== osd.0 10.174.33.11:6802/225929 52  osd_op_reply(113 0.buckets
>> [omap-get-vals 0~16] ondisk = 0) v4  108+0+288 (360462
>> 5994 0 2810901914) 0x7ffbb4000a60 con 0xd8b210
>> 2013-12

Re: [ceph-users] recreate bucket error

2013-12-07 Thread Yehuda Sadeh
Did you disable the cache by any chance (e.g., 'rgw cache enabled = false')?



On Sat, Dec 7, 2013 at 8:34 AM, Dominik Mostowiec
 wrote:
> Hi,
> Log:
> -
> 2013-12-07 17:32:42.736396 7ffbe36d3780 10 allocated request req=0xe66f40
> 2013-12-07 17:32:42.736438 7ff79b1c6700  1 == starting new request
> req=0xe60860 =
> 2013-12-07 17:32:42.736590 7ff79b1c6700  2 req 1:0.000153::PUT
> /test1/::initializing
> 2013-12-07 17:32:42.736659 7ff79b1c6700 10 meta>> HTTP_X_AMZ_DATE
> 2013-12-07 17:32:42.736686 7ff79b1c6700 10 x>> x-amz-date:Sat, 07 Dec
> 2013 16:32:42 GMT
> 2013-12-07 17:32:42.736758 7ff79b1c6700 10 s->object= s->bucket=test1
> 2013-12-07 17:32:42.736788 7ff79b1c6700  2 req 1:0.000351:s3:PUT
> /test1/::getting op
> 2013-12-07 17:32:42.736800 7ff79b1c6700  2 req 1:0.000364:s3:PUT
> /test1/:create_bucket:authorizing
> 2013-12-07 17:32:42.736907 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
> --> 10.174.33.11:6804/161220 -- osd_op(client.95391.0:107
> F7P3E755K6BN5LR3N85U [getxattrs,stat] 7.62531457 e192) v4 -- ?+0 0x7ff
> 794005a90 con 0xd908d0
> 2013-12-07 17:32:42.738159 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
> <== osd.1 10.174.33.11:6804/161220 23  osd_op_reply(107
> F7P3E755K6BN5LR3N85U [getxattrs,stat] ondisk = 0) v4  161+0+20 (
> 1539386342 0 1044315090) 0x7ffba40019c0 con 0xd908d0
> 2013-12-07 17:32:42.738341 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
> --> 10.174.33.11:6804/161220 -- osd_op(client.95391.0:108
> F7P3E755K6BN5LR3N85U [getxattrs,stat] 7.62531457 e192) v4 -- ?+0 0x7ff
> 794005c20 con 0xd908d0
> 2013-12-07 17:32:42.739230 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
> <== osd.1 10.174.33.11:6804/161220 24  osd_op_reply(108
> F7P3E755K6BN5LR3N85U [getxattrs,stat] ondisk = 0) v4  161+0+20 (
> 1539386342 0 1044315090) 0x7ffba40019c0 con 0xd908d0
> 2013-12-07 17:32:42.739349 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
> --> 10.174.33.11:6804/161220 -- osd_op(client.95391.0:109
> F7P3E755K6BN5LR3N85U [read 0~524288] 7.62531457 e192) v4 -- ?+0 0x7ff7
> 94005a90 con 0xd908d0
> 2013-12-07 17:32:42.740172 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
> <== osd.1 10.174.33.11:6804/161220 25  osd_op_reply(109
> F7P3E755K6BN5LR3N85U [read 0~5] ondisk = 0) v4  119+0+5 (9359852
> 51 0 150087197) 0x7ffba40019c0 con 0xd908d0
> 2013-12-07 17:32:42.740310 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:110 0
> [getxattrs,stat] 6.f18a3536 e192) v4 -- ?+0 0x7ff794006570 con 0xd8b
> 210
> 2013-12-07 17:32:42.741208 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
> <== osd.0 10.174.33.11:6802/225929 49  osd_op_reply(110 0
> [getxattrs,stat] ondisk = 0) v4  142+0+91 (2507304458 0 349659
> 2801) 0x7ffbb4000a60 con 0xd8b210
> 2013-12-07 17:32:42.741326 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:111 0
> [getxattrs,stat] 6.f18a3536 e192) v4 -- ?+0 0x7ff7940063a0 con 0xd8b
> 210
> 2013-12-07 17:32:42.742153 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
> <== osd.0 10.174.33.11:6802/225929 50  osd_op_reply(111 0
> [getxattrs,stat] ondisk = 0) v4  142+0+91 (2507304458 0 349659
> 2801) 0x7ffbb4000a60 con 0xd8b210
> 2013-12-07 17:32:42.742268 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:112 0 [read
> 0~524288] 6.f18a3536 e192) v4 -- ?+0 0x7ff7940063a0 con 0xd8b2
> 10
> 2013-12-07 17:32:42.743159 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
> <== osd.0 10.174.33.11:6802/225929 51  osd_op_reply(112 0 [read
> 0~254] ondisk = 0) v4  100+0+254 (3890176355 0 345783013
> 2) 0x7ffbb4000a60 con 0xd8b210
> 2013-12-07 17:32:42.743315 7ff79b1c6700 10 get_canon_resource(): dest=
> 2013-12-07 17:32:42.743326 7ff79b1c6700 10 auth_hdr:
> PUT
>
>
>
> x-amz-date:Sat, 07 Dec 2013 16:32:42 GMT
> /test1/
> 2013-12-07 17:32:42.743459 7ff79b1c6700  2 req 1:0.007023:s3:PUT
> /test1/:create_bucket:reading permissions
> 2013-12-07 17:32:42.743475 7ff79b1c6700  2 req 1:0.007038:s3:PUT
> /test1/:create_bucket:verifying op mask
> 2013-12-07 17:32:42.743479 7ff79b1c6700  2 req 1:0.007043:s3:PUT
> /test1/:create_bucket:verifying op permissions
> 2013-12-07 17:32:42.743542 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:113 0.buckets
> [omap-get-vals 0~16] 6.f01626b7 e192) v4 -- ?+0 0x7ff7940066
> 00 con 0xd8b210
> 2013-12-07 17:32:42.744679 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
> <== osd.0 10.174.33.11:6802/225929 52  osd_op_reply(113 0.buckets
> [omap-get-vals 0~16] ondisk = 0) v4  108+0+288 (360462
> 5994 0 2810901914) 0x7ffbb4000a60 con 0xd8b210
> 2013-12-07 17:32:42.744782 7ff79b1c6700  2 req 1:0.008346:s3:PUT
> /test1/:create_bucket:verifying op params
> 2013-12-07 17:32:42.744791 7ff79b1c6700  2 req 1:0.008355:s3:PUT
> /test1/:create_bucket:executing
> 2013-12-07 17:32:42.744895 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
> --> 10.174.33.11:6802/225929 -- osd_op(client.95

Re: [ceph-users] recreate bucket error

2013-12-07 Thread Dominik Mostowiec
Hi,
Log:
-
2013-12-07 17:32:42.736396 7ffbe36d3780 10 allocated request req=0xe66f40
2013-12-07 17:32:42.736438 7ff79b1c6700  1 == starting new request
req=0xe60860 =
2013-12-07 17:32:42.736590 7ff79b1c6700  2 req 1:0.000153::PUT
/test1/::initializing
2013-12-07 17:32:42.736659 7ff79b1c6700 10 meta>> HTTP_X_AMZ_DATE
2013-12-07 17:32:42.736686 7ff79b1c6700 10 x>> x-amz-date:Sat, 07 Dec
2013 16:32:42 GMT
2013-12-07 17:32:42.736758 7ff79b1c6700 10 s->object= s->bucket=test1
2013-12-07 17:32:42.736788 7ff79b1c6700  2 req 1:0.000351:s3:PUT
/test1/::getting op
2013-12-07 17:32:42.736800 7ff79b1c6700  2 req 1:0.000364:s3:PUT
/test1/:create_bucket:authorizing
2013-12-07 17:32:42.736907 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
--> 10.174.33.11:6804/161220 -- osd_op(client.95391.0:107
F7P3E755K6BN5LR3N85U [getxattrs,stat] 7.62531457 e192) v4 -- ?+0 0x7ff
794005a90 con 0xd908d0
2013-12-07 17:32:42.738159 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
<== osd.1 10.174.33.11:6804/161220 23  osd_op_reply(107
F7P3E755K6BN5LR3N85U [getxattrs,stat] ondisk = 0) v4  161+0+20 (
1539386342 0 1044315090) 0x7ffba40019c0 con 0xd908d0
2013-12-07 17:32:42.738341 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
--> 10.174.33.11:6804/161220 -- osd_op(client.95391.0:108
F7P3E755K6BN5LR3N85U [getxattrs,stat] 7.62531457 e192) v4 -- ?+0 0x7ff
794005c20 con 0xd908d0
2013-12-07 17:32:42.739230 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
<== osd.1 10.174.33.11:6804/161220 24  osd_op_reply(108
F7P3E755K6BN5LR3N85U [getxattrs,stat] ondisk = 0) v4  161+0+20 (
1539386342 0 1044315090) 0x7ffba40019c0 con 0xd908d0
2013-12-07 17:32:42.739349 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
--> 10.174.33.11:6804/161220 -- osd_op(client.95391.0:109
F7P3E755K6BN5LR3N85U [read 0~524288] 7.62531457 e192) v4 -- ?+0 0x7ff7
94005a90 con 0xd908d0
2013-12-07 17:32:42.740172 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
<== osd.1 10.174.33.11:6804/161220 25  osd_op_reply(109
F7P3E755K6BN5LR3N85U [read 0~5] ondisk = 0) v4  119+0+5 (9359852
51 0 150087197) 0x7ffba40019c0 con 0xd908d0
2013-12-07 17:32:42.740310 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
--> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:110 0
[getxattrs,stat] 6.f18a3536 e192) v4 -- ?+0 0x7ff794006570 con 0xd8b
210
2013-12-07 17:32:42.741208 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
<== osd.0 10.174.33.11:6802/225929 49  osd_op_reply(110 0
[getxattrs,stat] ondisk = 0) v4  142+0+91 (2507304458 0 349659
2801) 0x7ffbb4000a60 con 0xd8b210
2013-12-07 17:32:42.741326 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
--> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:111 0
[getxattrs,stat] 6.f18a3536 e192) v4 -- ?+0 0x7ff7940063a0 con 0xd8b
210
2013-12-07 17:32:42.742153 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
<== osd.0 10.174.33.11:6802/225929 50  osd_op_reply(111 0
[getxattrs,stat] ondisk = 0) v4  142+0+91 (2507304458 0 349659
2801) 0x7ffbb4000a60 con 0xd8b210
2013-12-07 17:32:42.742268 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
--> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:112 0 [read
0~524288] 6.f18a3536 e192) v4 -- ?+0 0x7ff7940063a0 con 0xd8b2
10
2013-12-07 17:32:42.743159 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
<== osd.0 10.174.33.11:6802/225929 51  osd_op_reply(112 0 [read
0~254] ondisk = 0) v4  100+0+254 (3890176355 0 345783013
2) 0x7ffbb4000a60 con 0xd8b210
2013-12-07 17:32:42.743315 7ff79b1c6700 10 get_canon_resource(): dest=
2013-12-07 17:32:42.743326 7ff79b1c6700 10 auth_hdr:
PUT



x-amz-date:Sat, 07 Dec 2013 16:32:42 GMT
/test1/
2013-12-07 17:32:42.743459 7ff79b1c6700  2 req 1:0.007023:s3:PUT
/test1/:create_bucket:reading permissions
2013-12-07 17:32:42.743475 7ff79b1c6700  2 req 1:0.007038:s3:PUT
/test1/:create_bucket:verifying op mask
2013-12-07 17:32:42.743479 7ff79b1c6700  2 req 1:0.007043:s3:PUT
/test1/:create_bucket:verifying op permissions
2013-12-07 17:32:42.743542 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
--> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:113 0.buckets
[omap-get-vals 0~16] 6.f01626b7 e192) v4 -- ?+0 0x7ff7940066
00 con 0xd8b210
2013-12-07 17:32:42.744679 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
<== osd.0 10.174.33.11:6802/225929 52  osd_op_reply(113 0.buckets
[omap-get-vals 0~16] ondisk = 0) v4  108+0+288 (360462
5994 0 2810901914) 0x7ffbb4000a60 con 0xd8b210
2013-12-07 17:32:42.744782 7ff79b1c6700  2 req 1:0.008346:s3:PUT
/test1/:create_bucket:verifying op params
2013-12-07 17:32:42.744791 7ff79b1c6700  2 req 1:0.008355:s3:PUT
/test1/:create_bucket:executing
2013-12-07 17:32:42.744895 7ff79b1c6700  1 -- 10.174.33.11:0/1270294
--> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:114 test1 [call
version.read,getxattrs,stat] 4.bddbf0b9 e192) v4 -- ?+0 0x
7ff7940083a0 con 0xd8b210
2013-12-07 17:32:42.745873 7ffbd96ec700  1 -- 10.174.33.11:0/1270294
<== osd.0 10.174.33.11:6802/225929 53  osd_op_reply(114 test1
[call,getxattrs,stat] ondisk = 0) v4  188+0+139 (2921607002 0
1685432528)

Re: [ceph-users] recreate bucket error

2013-12-07 Thread Yehuda Sadeh
Not sure what could be the reason. Can you turn set 'debug ms = 1',
and 'debug rgw = 20'?

Thanks,
Yehuda

On Sat, Dec 7, 2013 at 4:33 AM, Dominik Mostowiec
 wrote:
>> Are you running on latest dumpling
> Yes. It was installed, not upgraded from prev version.
> This is new crated bucket.
> I rebuilded cluster from scratch.
>
> User add command "radosgw-admin user create ..." shows:
> WARNING: cannot read region map
>
> Create first time bucket 'test1' via 's3 -u craete test1' got error.
> But in radosgw logs it seems ok:
> ---
> 2013-12-07 10:40:04.328277 7f7746ff5700  1 == starting new request
> req=0x1f5c7b0 =
> 2013-12-07 10:40:04.328339 7f7746ff5700  2 req 2:0.63::PUT
> /test1/::initializing
> 2013-12-07 10:40:04.328361 7f7746ff5700 10 meta>> HTTP_X_AMZ_DATE
> 2013-12-07 10:40:04.328368 7f7746ff5700 10 x>> x-amz-date:Sat, 07 Dec
> 2013 09:40:04 GMT
> 2013-12-07 10:40:04.328383 7f7746ff5700 10 s->object= s->bucket=test1
> 2013-12-07 10:40:04.328390 7f7746ff5700  2 req 2:0.000114:s3:PUT
> /test1/::getting op
> 2013-12-07 10:40:04.328394 7f7746ff5700  2 req 2:0.000118:s3:PUT
> /test1/:create_bucket:authorizing
> 2013-12-07 10:40:04.334424 7f7746ff5700 10 get_canon_resource(): dest=
> 2013-12-07 10:40:04.334433 7f7746ff5700 10 auth_hdr:
> PUT
>
>
>
> x-amz-date:Sat, 07 Dec 2013 09:40:04 GMT
> /test1/
> 2013-12-07 10:40:04.334476 7f7746ff5700  2 req 2:0.006200:s3:PUT
> /test1/:create_bucket:reading permissions
> 2013-12-07 10:40:04.334481 7f7746ff5700  2 req 2:0.006205:s3:PUT
> /test1/:create_bucket:verifying op mask
> 2013-12-07 10:40:04.334483 7f7746ff5700  2 req 2:0.006207:s3:PUT
> /test1/:create_bucket:verifying op permissions
> 2013-12-07 10:40:04.335391 7f7746ff5700  2 req 2:0.007115:s3:PUT
> /test1/:create_bucket:verifying op params
> 2013-12-07 10:40:04.335402 7f7746ff5700  2 req 2:0.007126:s3:PUT
> /test1/:create_bucket:executing
> 2013-12-07 10:40:05.420459 7f7746ff5700  2 req 2:1.092182:s3:PUT
> /test1/:create_bucket:http status=200
> 2013-12-07 10:40:05.420621 7f7746ff5700  1 == req done
> req=0x1f5c7b0 http_status=200 ==
> ---
>
>
> Second try:
> ---
> 2013-12-07 10:40:06.421876 7f778d95d780 10 allocated request req=0x1f5c710
> 2013-12-07 10:40:06.421936 7f77317ca700  1 == starting new request
> req=0x1f5bc10 =
> 2013-12-07 10:40:06.422038 7f77317ca700  2 req 3:0.000104::PUT
> /test1/::initializing
> 2013-12-07 10:40:06.422069 7f77317ca700 10 meta>> HTTP_X_AMZ_DATE
> 2013-12-07 10:40:06.422080 7f77317ca700 10 x>> x-amz-date:Sat, 07 Dec
> 2013 09:40:06 GMT
> 2013-12-07 10:40:06.422101 7f77317ca700 10 s->object= s->bucket=test1
> 2013-12-07 10:40:06.422110 7f77317ca700  2 req 3:0.000176:s3:PUT
> /test1/::getting op
> 2013-12-07 10:40:06.422117 7f77317ca700  2 req 3:0.000183:s3:PUT
> /test1/:create_bucket:authorizing
> 2013-12-07 10:40:06.429576 7f77317ca700 10 get_canon_resource(): dest=
> 2013-12-07 10:40:06.429592 7f77317ca700 10 auth_hdr:
> PUT
>
>
>
> x-amz-date:Sat, 07 Dec 2013 09:40:06 GMT
> /test1/
> 2013-12-07 10:40:06.429679 7f77317ca700  2 req 3:0.007745:s3:PUT
> /test1/:create_bucket:reading permissions
> 2013-12-07 10:40:06.429690 7f77317ca700  2 req 3:0.007756:s3:PUT
> /test1/:create_bucket:verifying op mask
> 2013-12-07 10:40:06.429693 7f77317ca700  2 req 3:0.007759:s3:PUT
> /test1/:create_bucket:verifying op permissions
> 2013-12-07 10:40:06.430945 7f77317ca700  2 req 3:0.009010:s3:PUT
> /test1/:create_bucket:verifying op params
> 2013-12-07 10:40:06.430964 7f77317ca700  2 req 3:0.009030:s3:PUT
> /test1/:create_bucket:executing
> 2013-12-07 10:40:06.436301 7f77317ca700  0 WARNING: couldn't find acl
> header for object, generating default
> 2013-12-07 10:40:06.451160 7f77317ca700  0 get_bucket_info returned -125
> 2013-12-07 10:40:06.451188 7f77317ca700  0 WARNING: set_req_state_err
> err_no=125 resorting to 500
> 2013-12-07 10:40:06.451223 7f77317ca700  2 req 3:0.029289:s3:PUT
> /test1/:create_bucket:http status=500
> 2013-12-07 10:40:06.451335 7f77317ca700  1 == req done
> req=0x1f5bc10 http_status=500 ==
> ---
>
> ceph -s
>   cluster 92833861-954f-4c66-a72b-5a83090a2b3f
>health HEALTH_OK
>
> ceph -v
> ceph version 0.67.4 (ad85b8bfafea6232d64cb7ba76a8b6e8252fa0c7)
>
> I have strange behavior after cluster create.
> All PGs were on osd.0 and marked as stale degraded.
> After add more osd's it didn't ifxed.
> "ceph pg force_create_pg" helps.
>
> After setup cluster I changed crushmap.
> Removed osd.0 and added it again to cluster.
>
> It can be a reason?
>
> 
> Regards
> Dominik
>
> 2013/12/6 Yehuda Sadeh :
>> I'm having trouble reproducing this one. Are you running on latest
>> dumpling? Does it happen with any newly created bucket, or just with
>> buckets that existed before?
>>
>> Yehuda
>>
>> On Fri, Dec 6, 2013 at 5:07 AM, Dominik Mostowiec
>>  wrote:
>>> Hi,
>>> In version dumpling upgraded from bobtail working create the same bucket.
>>>
>>> root@vm-1:/etc/apache2/sites-enabled# s3 -u create testcreate
>>> Bucket suc

Re: [ceph-users] recreate bucket error

2013-12-07 Thread Dominik Mostowiec
> Are you running on latest dumpling
Yes. It was installed, not upgraded from prev version.
This is new crated bucket.
I rebuilded cluster from scratch.

User add command "radosgw-admin user create ..." shows:
WARNING: cannot read region map

Create first time bucket 'test1' via 's3 -u craete test1' got error.
But in radosgw logs it seems ok:
---
2013-12-07 10:40:04.328277 7f7746ff5700  1 == starting new request
req=0x1f5c7b0 =
2013-12-07 10:40:04.328339 7f7746ff5700  2 req 2:0.63::PUT
/test1/::initializing
2013-12-07 10:40:04.328361 7f7746ff5700 10 meta>> HTTP_X_AMZ_DATE
2013-12-07 10:40:04.328368 7f7746ff5700 10 x>> x-amz-date:Sat, 07 Dec
2013 09:40:04 GMT
2013-12-07 10:40:04.328383 7f7746ff5700 10 s->object= s->bucket=test1
2013-12-07 10:40:04.328390 7f7746ff5700  2 req 2:0.000114:s3:PUT
/test1/::getting op
2013-12-07 10:40:04.328394 7f7746ff5700  2 req 2:0.000118:s3:PUT
/test1/:create_bucket:authorizing
2013-12-07 10:40:04.334424 7f7746ff5700 10 get_canon_resource(): dest=
2013-12-07 10:40:04.334433 7f7746ff5700 10 auth_hdr:
PUT



x-amz-date:Sat, 07 Dec 2013 09:40:04 GMT
/test1/
2013-12-07 10:40:04.334476 7f7746ff5700  2 req 2:0.006200:s3:PUT
/test1/:create_bucket:reading permissions
2013-12-07 10:40:04.334481 7f7746ff5700  2 req 2:0.006205:s3:PUT
/test1/:create_bucket:verifying op mask
2013-12-07 10:40:04.334483 7f7746ff5700  2 req 2:0.006207:s3:PUT
/test1/:create_bucket:verifying op permissions
2013-12-07 10:40:04.335391 7f7746ff5700  2 req 2:0.007115:s3:PUT
/test1/:create_bucket:verifying op params
2013-12-07 10:40:04.335402 7f7746ff5700  2 req 2:0.007126:s3:PUT
/test1/:create_bucket:executing
2013-12-07 10:40:05.420459 7f7746ff5700  2 req 2:1.092182:s3:PUT
/test1/:create_bucket:http status=200
2013-12-07 10:40:05.420621 7f7746ff5700  1 == req done
req=0x1f5c7b0 http_status=200 ==
---


Second try:
---
2013-12-07 10:40:06.421876 7f778d95d780 10 allocated request req=0x1f5c710
2013-12-07 10:40:06.421936 7f77317ca700  1 == starting new request
req=0x1f5bc10 =
2013-12-07 10:40:06.422038 7f77317ca700  2 req 3:0.000104::PUT
/test1/::initializing
2013-12-07 10:40:06.422069 7f77317ca700 10 meta>> HTTP_X_AMZ_DATE
2013-12-07 10:40:06.422080 7f77317ca700 10 x>> x-amz-date:Sat, 07 Dec
2013 09:40:06 GMT
2013-12-07 10:40:06.422101 7f77317ca700 10 s->object= s->bucket=test1
2013-12-07 10:40:06.422110 7f77317ca700  2 req 3:0.000176:s3:PUT
/test1/::getting op
2013-12-07 10:40:06.422117 7f77317ca700  2 req 3:0.000183:s3:PUT
/test1/:create_bucket:authorizing
2013-12-07 10:40:06.429576 7f77317ca700 10 get_canon_resource(): dest=
2013-12-07 10:40:06.429592 7f77317ca700 10 auth_hdr:
PUT



x-amz-date:Sat, 07 Dec 2013 09:40:06 GMT
/test1/
2013-12-07 10:40:06.429679 7f77317ca700  2 req 3:0.007745:s3:PUT
/test1/:create_bucket:reading permissions
2013-12-07 10:40:06.429690 7f77317ca700  2 req 3:0.007756:s3:PUT
/test1/:create_bucket:verifying op mask
2013-12-07 10:40:06.429693 7f77317ca700  2 req 3:0.007759:s3:PUT
/test1/:create_bucket:verifying op permissions
2013-12-07 10:40:06.430945 7f77317ca700  2 req 3:0.009010:s3:PUT
/test1/:create_bucket:verifying op params
2013-12-07 10:40:06.430964 7f77317ca700  2 req 3:0.009030:s3:PUT
/test1/:create_bucket:executing
2013-12-07 10:40:06.436301 7f77317ca700  0 WARNING: couldn't find acl
header for object, generating default
2013-12-07 10:40:06.451160 7f77317ca700  0 get_bucket_info returned -125
2013-12-07 10:40:06.451188 7f77317ca700  0 WARNING: set_req_state_err
err_no=125 resorting to 500
2013-12-07 10:40:06.451223 7f77317ca700  2 req 3:0.029289:s3:PUT
/test1/:create_bucket:http status=500
2013-12-07 10:40:06.451335 7f77317ca700  1 == req done
req=0x1f5bc10 http_status=500 ==
---

ceph -s
  cluster 92833861-954f-4c66-a72b-5a83090a2b3f
   health HEALTH_OK

ceph -v
ceph version 0.67.4 (ad85b8bfafea6232d64cb7ba76a8b6e8252fa0c7)

I have strange behavior after cluster create.
All PGs were on osd.0 and marked as stale degraded.
After add more osd's it didn't ifxed.
"ceph pg force_create_pg" helps.

After setup cluster I changed crushmap.
Removed osd.0 and added it again to cluster.

It can be a reason?


Regards
Dominik

2013/12/6 Yehuda Sadeh :
> I'm having trouble reproducing this one. Are you running on latest
> dumpling? Does it happen with any newly created bucket, or just with
> buckets that existed before?
>
> Yehuda
>
> On Fri, Dec 6, 2013 at 5:07 AM, Dominik Mostowiec
>  wrote:
>> Hi,
>> In version dumpling upgraded from bobtail working create the same bucket.
>>
>> root@vm-1:/etc/apache2/sites-enabled# s3 -u create testcreate
>> Bucket successfully created.
>> root@vm-1:/etc/apache2/sites-enabled# s3 -u create testcreate
>> Bucket successfully created.
>>
>> I installed new dumpling cluster and:
>> root@s1:/var/log/radosgw# s3 -u create test1
>> Bucket successfully created.
>> root@s1:/var/log/radosgw# s3 -u create test1
>>
>> ERROR: ErrorUnknown
>>
>> In radosgw logs:
>>
>> 2013-12-06 13:59:56.083109 7f162d7c2700  1 ==

Re: [ceph-users] recreate bucket error

2013-12-06 Thread Yehuda Sadeh
I'm having trouble reproducing this one. Are you running on latest
dumpling? Does it happen with any newly created bucket, or just with
buckets that existed before?

Yehuda

On Fri, Dec 6, 2013 at 5:07 AM, Dominik Mostowiec
 wrote:
> Hi,
> In version dumpling upgraded from bobtail working create the same bucket.
>
> root@vm-1:/etc/apache2/sites-enabled# s3 -u create testcreate
> Bucket successfully created.
> root@vm-1:/etc/apache2/sites-enabled# s3 -u create testcreate
> Bucket successfully created.
>
> I installed new dumpling cluster and:
> root@s1:/var/log/radosgw# s3 -u create test1
> Bucket successfully created.
> root@s1:/var/log/radosgw# s3 -u create test1
>
> ERROR: ErrorUnknown
>
> In radosgw logs:
>
> 2013-12-06 13:59:56.083109 7f162d7c2700  1 == starting new request
> req=0xb7d480 =
> 2013-12-06 13:59:56.083227 7f162d7c2700  2 req 5:0.000119::PUT
> /test1/::initializing
> 2013-12-06 13:59:56.083261 7f162d7c2700 10 meta>> HTTP_X_AMZ_DATE
> 2013-12-06 13:59:56.083274 7f162d7c2700 10 x>> x-amz-date:Fri, 06 Dec
> 2013 12:59:56 GMT
> 2013-12-06 13:59:56.083298 7f162d7c2700 10 s->object= s->bucket=test1
> 2013-12-06 13:59:56.083307 7f162d7c2700  2 req 5:0.000199:s3:PUT
> /test1/::getting op
> 2013-12-06 13:59:56.083315 7f162d7c2700  2 req 5:0.000207:s3:PUT
> /test1/:create_bucket:authorizing
> 2013-12-06 13:59:56.091724 7f162d7c2700 10 get_canon_resource(): dest=
> 2013-12-06 13:59:56.091742 7f162d7c2700 10 auth_hdr:
> PUT
>
>
>
> x-amz-date:Fri, 06 Dec 2013 12:59:56 GMT
> /test1/
> 2013-12-06 13:59:56.091836 7f162d7c2700  2 req 5:0.008728:s3:PUT
> /test1/:create_bucket:reading permissions
> 2013-12-06 13:59:56.091848 7f162d7c2700  2 req 5:0.008740:s3:PUT
> /test1/:create_bucket:verifying op mask
> 2013-12-06 13:59:56.091852 7f162d7c2700  2 req 5:0.008744:s3:PUT
> /test1/:create_bucket:verifying op permissions
> 2013-12-06 13:59:56.093858 7f162d7c2700  2 req 5:0.010750:s3:PUT
> /test1/:create_bucket:verifying op params
> 2013-12-06 13:59:56.093882 7f162d7c2700  2 req 5:0.010773:s3:PUT
> /test1/:create_bucket:executing
> 2013-12-06 13:59:56.104819 7f162d7c2700  0 WARNING: couldn't find acl
> header for object, generating default
> 2013-12-06 13:59:56.132625 7f162d7c2700  0 get_bucket_info returned -125
> 2013-12-06 13:59:56.132656 7f162d7c2700  0 WARNING: set_req_state_err
> err_no=125 resorting to 500
> 2013-12-06 13:59:56.132693 7f162d7c2700  2 req 5:0.049584:s3:PUT
> /test1/:create_bucket:http status=500
> 2013-12-06 13:59:56.132890 7f162d7c2700  1 == req done
> req=0xb7d480 http_status=500 ==
>
> --
> Regards
> Dominik
> ___
> ceph-users mailing list
> ceph-users@lists.ceph.com
> http://lists.ceph.com/listinfo.cgi/ceph-users-ceph.com
___
ceph-users mailing list
ceph-users@lists.ceph.com
http://lists.ceph.com/listinfo.cgi/ceph-users-ceph.com


[ceph-users] recreate bucket error

2013-12-06 Thread Dominik Mostowiec
Hi,
In version dumpling upgraded from bobtail working create the same bucket.

root@vm-1:/etc/apache2/sites-enabled# s3 -u create testcreate
Bucket successfully created.
root@vm-1:/etc/apache2/sites-enabled# s3 -u create testcreate
Bucket successfully created.

I installed new dumpling cluster and:
root@s1:/var/log/radosgw# s3 -u create test1
Bucket successfully created.
root@s1:/var/log/radosgw# s3 -u create test1

ERROR: ErrorUnknown

In radosgw logs:

2013-12-06 13:59:56.083109 7f162d7c2700  1 == starting new request
req=0xb7d480 =
2013-12-06 13:59:56.083227 7f162d7c2700  2 req 5:0.000119::PUT
/test1/::initializing
2013-12-06 13:59:56.083261 7f162d7c2700 10 meta>> HTTP_X_AMZ_DATE
2013-12-06 13:59:56.083274 7f162d7c2700 10 x>> x-amz-date:Fri, 06 Dec
2013 12:59:56 GMT
2013-12-06 13:59:56.083298 7f162d7c2700 10 s->object= s->bucket=test1
2013-12-06 13:59:56.083307 7f162d7c2700  2 req 5:0.000199:s3:PUT
/test1/::getting op
2013-12-06 13:59:56.083315 7f162d7c2700  2 req 5:0.000207:s3:PUT
/test1/:create_bucket:authorizing
2013-12-06 13:59:56.091724 7f162d7c2700 10 get_canon_resource(): dest=
2013-12-06 13:59:56.091742 7f162d7c2700 10 auth_hdr:
PUT



x-amz-date:Fri, 06 Dec 2013 12:59:56 GMT
/test1/
2013-12-06 13:59:56.091836 7f162d7c2700  2 req 5:0.008728:s3:PUT
/test1/:create_bucket:reading permissions
2013-12-06 13:59:56.091848 7f162d7c2700  2 req 5:0.008740:s3:PUT
/test1/:create_bucket:verifying op mask
2013-12-06 13:59:56.091852 7f162d7c2700  2 req 5:0.008744:s3:PUT
/test1/:create_bucket:verifying op permissions
2013-12-06 13:59:56.093858 7f162d7c2700  2 req 5:0.010750:s3:PUT
/test1/:create_bucket:verifying op params
2013-12-06 13:59:56.093882 7f162d7c2700  2 req 5:0.010773:s3:PUT
/test1/:create_bucket:executing
2013-12-06 13:59:56.104819 7f162d7c2700  0 WARNING: couldn't find acl
header for object, generating default
2013-12-06 13:59:56.132625 7f162d7c2700  0 get_bucket_info returned -125
2013-12-06 13:59:56.132656 7f162d7c2700  0 WARNING: set_req_state_err
err_no=125 resorting to 500
2013-12-06 13:59:56.132693 7f162d7c2700  2 req 5:0.049584:s3:PUT
/test1/:create_bucket:http status=500
2013-12-06 13:59:56.132890 7f162d7c2700  1 == req done
req=0xb7d480 http_status=500 ==

-- 
Regards
Dominik
___
ceph-users mailing list
ceph-users@lists.ceph.com
http://lists.ceph.com/listinfo.cgi/ceph-users-ceph.com