Yes, it is disabled
grep 'cache' /etc/ceph/ceph.conf | grep rgw
rgw_cache_enabled = false ;rgw cache enabled
rgw_cache_lru_size = 10000 ;num of entries in rgw cache
--
Regards
Dominik
2013/12/7 Yehuda Sadeh <yehuda@xxxxxxxxxxx>:
> 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
> <dominikmostowiec@xxxxxxxxx> 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=<NULL> 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) 0x7ffbb4000a60 con 0xd8b210
>> 2013-12-07 17:32:42.746052 7ff79b1c6700 1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:115 test1 [call
>> version.check_conds,call version.read,read 0~524288] 4.bddbf0b9 e192)
>> v4 -- ?+0 0x7ff794008d80 con 0xd8b210
>> 2013-12-07 17:32:42.746920 7ffbd96ec700 1 -- 10.174.33.11:0/1270294
>> <== osd.0 10.174.33.11:6802/225929 54 ==== osd_op_reply(115 test1
>> [call,call,read 0~111] ondisk = 0) v4 ==== 188+0+159 (3524501340 0
>> 3138215039) 0x7ffbb4000a60 con 0xd8b210
>> 2013-12-07 17:32:42.747053 7ff79b1c6700 1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.13:6800/296091 -- osd_op(client.95391.0:116
>> .bucket.meta.test1:default.78189.1 [call version.read,getxattrs,stat]
>> 4.50558ec5 e192) v4 -- ?+0 0x7ff794007390 con 0xd8f710
>> 2013-12-07 17:32:42.748661 7ffbd96ec700 1 -- 10.174.33.11:0/1270294
>> <== osd.24 10.174.33.13:6800/296091 19 ==== osd_op_reply(116
>> .bucket.meta.test1:default.78189.1 [call,getxattrs,stat] ondisk = 0)
>> v4 ==== 217+0+268 (1054813027 0 2886434386) 0x7ffbac0057b0 con
>> 0xd8f710
>> 2013-12-07 17:32:42.748815 7ff79b1c6700 1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.13:6800/296091 -- osd_op(client.95391.0:117
>> .bucket.meta.test1:default.78189.1 [call version.check_conds,call
>> version.read,read 0~524288] 4.50558ec5 e192) v4 -- ?+0 0x7ff79400c050
>> con 0xd8f710
>> 2013-12-07 17:32:42.750149 7ffbd96ec700 1 -- 10.174.33.11:0/1270294
>> <== osd.24 10.174.33.13:6800/296091 20 ==== osd_op_reply(117
>> .bucket.meta.test1:default.78189.1 [call,call,read 0~147] ondisk = 0)
>> v4 ==== 217+0+195 (284787856 0 526624477) 0x7ffbac001f80 con 0xd8f710
>> 2013-12-07 17:32:42.750245 7ff79b1c6700 0 WARNING: couldn't find acl
>> header for object, generating default
>> 2013-12-07 17:32:42.750288 7ff79b1c6700 1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:118 0
>> [getxattrs,stat] 6.f18a3536 e192) v4 -- ?+0 0x7ff794007670 con
>> 0xd8b210
>> 2013-12-07 17:32:42.751004 7ffbd96ec700 1 -- 10.174.33.11:0/1270294
>> <== osd.0 10.174.33.11:6802/225929 55 ==== osd_op_reply(118 0
>> [getxattrs,stat] ondisk = 0) v4 ==== 142+0+91 (2507304458 0
>> 3496592801) 0x7ffbb4000a60 con 0xd8b210
>> 2013-12-07 17:32:42.751107 7ff79b1c6700 1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:119 0
>> [getxattrs,stat] 6.f18a3536 e192) v4 -- ?+0 0x7ff794007650 con
>> 0xd8b210
>> 2013-12-07 17:32:42.751786 7ffbd96ec700 1 -- 10.174.33.11:0/1270294
>> <== osd.0 10.174.33.11:6802/225929 56 ==== osd_op_reply(119 0
>> [getxattrs,stat] ondisk = 0) v4 ==== 142+0+91 (2507304458 0
>> 3496592801) 0x7ffbb4000a60 con 0xd8b210
>> 2013-12-07 17:32:42.751881 7ff79b1c6700 1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:120 0 [read
>> 0~524288] 6.f18a3536 e192) v4 -- ?+0 0x7ff794007000 con 0xd8b210
>> 2013-12-07 17:32:42.752528 7ffbd96ec700 1 -- 10.174.33.11:0/1270294
>> <== osd.0 10.174.33.11:6802/225929 57 ==== osd_op_reply(120 0 [read
>> 0~254] ondisk = 0) v4 ==== 100+0+254 (3890176355 0 3457830132)
>> 0x7ffbb4000a60 con 0xd8b210
>> 2013-12-07 17:32:42.752684 7ff79b1c6700 1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.11:6804/161220 -- osd_op(client.95391.0:121
>> .dir.default.95391.1 [create 0~0,call rgw.bucket_init_index]
>> 8.5a45c1c6 e192) v4 -- ?+0 0x7ff794007540 con 0xd908d0
>> 2013-12-07 17:32:42.756042 7ffbd96ec700 1 -- 10.174.33.11:0/1270294
>> <== osd.1 10.174.33.11:6804/161220 26 ==== osd_op_reply(121
>> .dir.default.95391.1 [create 0~0,call] ack = 0) v4 ==== 161+0+0
>> (905452886 0 0) 0x7ffba40019c0 con 0xd908d0
>> 2013-12-07 17:32:42.756314 7ff79b1c6700 1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:122
>> .bucket.meta.test1:default.95391.1 [create 0~0,call
>> version.set,writefull 0~147,setxattr user.rgw.acl (109)] 4.e2d85709
>> e192) v4 -- ?+0 0x7ff794007540 con 0xd8b210
>> 2013-12-07 17:32:42.758993 7ffbd96ec700 1 -- 10.174.33.11:0/1270294
>> <== osd.0 10.174.33.11:6802/225929 58 ==== osd_op_reply(122
>> .bucket.meta.test1:default.95391.1 [create 0~0,call,writefull
>> 0~147,setxattr (109)] ack = 0) v4 ==== 259+0+0 (1466420163 0 0)
>> 0x7ffbb4000a60 con 0xd8b210
>> 2013-12-07 17:32:42.759256 7ff79b1c6700 1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:123 test1
>> [create 0~0,call version.set,writefull 0~111] 4.bddbf0b9 e192) v4 --
>> ?+0 0x7ff794008960 con 0xd8b210
>> 2013-12-07 17:32:42.760000 7ffbd96ec700 1 -- 10.174.33.11:0/1270294
>> <== osd.0 10.174.33.11:6802/225929 59 ==== osd_op_reply(123 test1
>> [create 0~0,call,writefull 0~111] ondisk = -17 (File exists)) v4 ====
>> 188+0+0 (208006733 0 0) 0x7ffbb4000a30 con 0xd8b210
>> 2013-12-07 17:32:42.760144 7ff79b1c6700 1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:124 test1 [call
>> version.read,getxattrs,stat] 4.bddbf0b9 e192) v4 -- ?+0 0x7ff794008490
>> con 0xd8b210
>> 2013-12-07 17:32:42.760924 7ffbd96ec700 1 -- 10.174.33.11:0/1270294
>> <== osd.0 10.174.33.11:6802/225929 60 ==== osd_op_reply(124 test1
>> [call,getxattrs,stat] ondisk = 0) v4 ==== 188+0+139 (2921607002 0
>> 1685432528) 0x7ffbb4000a30 con 0xd8b210
>> 2013-12-07 17:32:42.761044 7ff79b1c6700 1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:125 test1
>> [getxattrs,stat] 4.bddbf0b9 e192) v4 -- ?+0 0x7ff794008100 con
>> 0xd8b210
>> 2013-12-07 17:32:42.761759 7ffbd96ec700 1 -- 10.174.33.11:0/1270294
>> <== osd.0 10.174.33.11:6802/225929 61 ==== osd_op_reply(125 test1
>> [getxattrs,stat] ondisk = 0) v4 ==== 146+0+91 (167695905 0 2385301879)
>> 0x7ffbb4000a30 con 0xd8b210
>> 2013-12-07 17:32:42.761908 7ff79b1c6700 1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.11:6802/225929 -- osd_op(client.95391.0:126 test1 [call
>> version.check_conds,call version.read,read 0~524288] 4.bddbf0b9 e192)
>> v4 -- ?+0 0x7ff79400c6e0 con 0xd8b210
>> 2013-12-07 17:32:42.762712 7ffbd96ec700 1 -- 10.174.33.11:0/1270294
>> <== osd.0 10.174.33.11:6802/225929 62 ==== osd_op_reply(126 test1
>> [call,call,read 0~111] ondisk = 0) v4 ==== 188+0+159 (3524501340 0
>> 3138215039) 0x7ffbb4000a30 con 0xd8b210
>> 2013-12-07 17:32:42.762848 7ff79b1c6700 1 -- 10.174.33.11:0/1270294
>> --> 10.174.33.13:6800/296091 -- osd_op(client.95391.0:127
>> .bucket.meta.test1:default.78189.1 [call version.check_conds,call
>> version.read,getxattrs,stat] 4.50558ec5 e192) v4 -- ?+0 0x7ff79400c6e0
>> con 0xd8f710
>> 2013-12-07 17:32:42.764173 7ffbd96ec700 1 -- 10.174.33.11:0/1270294
>> <== osd.24 10.174.33.13:6800/296091 21 ==== osd_op_reply(127
>> .bucket.meta.test1:default.78189.1 [call,call,getxattrs,stat] ondisk =
>> -125 (Operation canceled)) v4 ==== 259+0+0 (3728706219 0 0)
>> 0x7ffbac002090 con 0xd8f710
>> 2013-12-07 17:32:42.764338 7ff79b1c6700 0 get_bucket_info returned -125
>> 2013-12-07 17:32:42.764368 7ff79b1c6700 0 WARNING: set_req_state_err
>> err_no=125 resorting to 500
>> 2013-12-07 17:32:42.764431 7ff79b1c6700 2 req 1:0.027995:s3:PUT
>> /test1/:create_bucket:http status=500
>> 2013-12-07 17:32:42.764561 7ff79b1c6700 1 ====== req done
>> req=0xe60860 http_status=500 ======
>> 2013-12-07 17:32:42.794156 7ffbd1ffb700 2
>> RGWDataChangesLog::ChangesRenewThread: start
>>
>> -------------------
>>
>>
>> --
>> Regards
>> Dominik
>>
>> 2013/12/7 Yehuda Sadeh <yehuda@xxxxxxxxxxx>:
>>> 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
>>> <dominikmostowiec@xxxxxxxxx> 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.000063::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=<NULL> 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=<NULL> 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 <yehuda@xxxxxxxxxxx>:
>>>>> 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
>>>>> <dominikmostowiec@xxxxxxxxx> 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=<NULL> 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@xxxxxxxxxxxxxx
>>>>>> http://lists.ceph.com/listinfo.cgi/ceph-users-ceph.com
>>>>
>>>>
>>>>
>>>> --
>>>> Pozdrawiam
>>>> Dominik
>>
>>
>>
>> --
>> Pozdrawiam
>> Dominik
--
Pozdrawiam
Dominik
_______________________________________________
ceph-users mailing list
ceph-users@xxxxxxxxxxxxxx
http://lists.ceph.com/listinfo.cgi/ceph-users-ceph.com
