Project

General

Profile

Support #38125 » commit-output-slave.txt

Krish Verma, 01/31/2019 01:18 PM

 
[cephuser@zabbix-client ~]$ radosgw-admin period update --commit
2019-01-31 17:42:22.162235 7f7a17d989c0 1 -- :/0 messenger.start
2019-01-31 17:42:22.163239 7f7a17d989c0 1 -- :/3007987558 --> 172.18.84.131:6789/0 -- auth(proto 0 30 bytes epoch 0) v1 -- ?+0 0x558711b95800 con 0x558711b8fcc0
2019-01-31 17:42:23.291054 7f7a17d8e700 1 -- 172.23.18.112:0/3007987558 learned my addr 172.23.18.112:0/3007987558
2019-01-31 17:42:23.882159 7f79fba5d700 1 -- 172.23.18.112:0/3007987558 <== mon.0 172.18.84.131:6789/0 1 ==== mon_map magic: 0 v1 ==== 202+0+0 (1772104362 0 0) 0x7f79e4000a70 con 0x558711b8fcc0
2019-01-31 17:42:23.882405 7f79fba5d700 1 -- 172.23.18.112:0/3007987558 <== mon.0 172.18.84.131:6789/0 2 ==== auth_reply(proto 2 0 (0) Success) v1 ==== 33+0+0 (2891307509 0 0) 0x7f79e4000e30 con 0x558711b8fcc0
2019-01-31 17:42:23.882646 7f79fba5d700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6789/0 -- auth(proto 2 32 bytes epoch 0) v1 -- ?+0 0x7f79f00013e0 con 0x558711b8fcc0
2019-01-31 17:42:24.179085 7f79fba5d700 1 -- 172.23.18.112:0/3007987558 <== mon.0 172.18.84.131:6789/0 3 ==== auth_reply(proto 2 0 (0) Success) v1 ==== 206+0+0 (3809263948 0 0) 0x7f79e4000a70 con 0x558711b8fcc0
2019-01-31 17:42:24.179332 7f79fba5d700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6789/0 -- auth(proto 2 165 bytes epoch 0) v1 -- ?+0 0x7f79f0001860 con 0x558711b8fcc0
2019-01-31 17:42:24.475144 7f79fba5d700 1 -- 172.23.18.112:0/3007987558 <== mon.0 172.18.84.131:6789/0 4 ==== auth_reply(proto 2 0 (0) Success) v1 ==== 393+0+0 (3352817596 0 0) 0x7f79e4000e50 con 0x558711b8fcc0
2019-01-31 17:42:24.475334 7f79fba5d700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6789/0 -- mon_subscribe({monmap=0+}) v2 -- ?+0 0x558711b99920 con 0x558711b8fcc0
2019-01-31 17:42:24.475655 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6789/0 -- mon_subscribe({osdmap=0}) v2 -- ?+0 0x558711b98910 con 0x558711b8fcc0
2019-01-31 17:42:24.476329 7f79ebfff700 2 RGWDataChangesLog::ChangesRenewThread: start
2019-01-31 17:42:24.476381 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b820 obj=.rgw.root:default.realm state=0x558711b9b558 s->prefetch_data=0
2019-01-31 17:42:24.774658 7f79fba5d700 1 -- 172.23.18.112:0/3007987558 <== mon.0 172.18.84.131:6789/0 5 ==== mon_map magic: 0 v1 ==== 202+0+0 (1772104362 0 0) 0x7f79e40010c0 con 0x558711b8fcc0
2019-01-31 17:42:24.774735 7f79fba5d700 1 -- 172.23.18.112:0/3007987558 <== mon.0 172.18.84.131:6789/0 6 ==== osd_map(42..42 src has 1..42) v3 ==== 4746+0+0 (738546261 0 0) 0x7f79e40025d0 con 0x558711b8fcc0
2019-01-31 17:42:24.775159 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:1 1.85fca992 default.realm [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711b9f480 con 0x558711b9df20
2019-01-31 17:42:26.760159 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 1 ==== osd_op_reply(1 default.realm [getxattrs,stat] v0'0 uv1 ondisk = 0) v7 ==== 175+0+20 (2228292990 0 438547248) 0x7f79d0000b70 con 0x558711b9df20
2019-01-31 17:42:26.760295 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:26.760319 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:26.760365 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:2 1.85fca992 default.realm [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711b9fbc0 con 0x558711b9df20
2019-01-31 17:42:27.053153 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 2 ==== osd_op_reply(2 default.realm [read 0~46] v0'0 uv1 ondisk = 0) v7 ==== 133+0+46 (1435556921 0 440825142) 0x7f79d0000b70 con 0x558711b9df20
2019-01-31 17:42:27.053239 7f7a17d989c0 20 rados->read r=0 bl.length=46
2019-01-31 17:42:27.053318 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b880 obj=.rgw.root:realms.1102c891-d81c-480e-9487-c9f874287d13 state=0x558711b9b558 s->prefetch_data=0
2019-01-31 17:42:27.053556 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:3 1.489eb37e realms.1102c891-d81c-480e-9487-c9f874287d13 [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711ba2d60 con 0x558711b9fd00
2019-01-31 17:42:29.044075 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 1 ==== osd_op_reply(3 realms.1102c891-d81c-480e-9487-c9f874287d13 [getxattrs,stat] v0'0 uv3 ondisk = 0) v7 ==== 205+0+20 (3061702216 0 368642961) 0x7f79c8000b90 con 0x558711b9fd00
2019-01-31 17:42:29.044172 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:29.044195 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:29.044239 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:4 1.489eb37e realms.1102c891-d81c-480e-9487-c9f874287d13 [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711ba3410 con 0x558711b9fd00
2019-01-31 17:42:29.338014 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 2 ==== osd_op_reply(4 realms.1102c891-d81c-480e-9487-c9f874287d13 [read 0~106] v0'0 uv3 ondisk = 0) v7 ==== 163+0+106 (678113086 0 309371309) 0x7f79c8000b90 con 0x558711b9fd00
2019-01-31 17:42:29.338093 7f7a17d989c0 20 rados->read r=0 bl.length=106
2019-01-31 17:42:29.338150 7f7a17d989c0 20 realm georep 1102c891-d81c-480e-9487-c9f874287d13
2019-01-31 17:42:29.338185 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b6a0 obj=.rgw.root:realms.1102c891-d81c-480e-9487-c9f874287d13 state=0x558711b9b4c8 s->prefetch_data=0
2019-01-31 17:42:29.338242 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:5 1.489eb37e realms.1102c891-d81c-480e-9487-c9f874287d13 [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711ba3870 con 0x558711b9fd00
2019-01-31 17:42:29.632015 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 3 ==== osd_op_reply(5 realms.1102c891-d81c-480e-9487-c9f874287d13 [getxattrs,stat] v0'0 uv3 ondisk = 0) v7 ==== 205+0+20 (3061702216 0 368642961) 0x7f79c8000b90 con 0x558711b9fd00
2019-01-31 17:42:29.632120 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:29.632141 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:29.632185 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:6 1.489eb37e realms.1102c891-d81c-480e-9487-c9f874287d13 [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711ba3ea0 con 0x558711b9fd00
2019-01-31 17:42:29.926015 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 4 ==== osd_op_reply(6 realms.1102c891-d81c-480e-9487-c9f874287d13 [read 0~106] v0'0 uv3 ondisk = 0) v7 ==== 163+0+106 (678113086 0 309371309) 0x7f79c8000b90 con 0x558711b9fd00
2019-01-31 17:42:29.926097 7f7a17d989c0 20 rados->read r=0 bl.length=106
2019-01-31 17:42:29.926176 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b800 obj=.rgw.root:periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.latest_epoch state=0x558711b9b4c8 s->prefetch_data=0
2019-01-31 17:42:29.926242 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:7 1.ee5a525 periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.latest_epoch [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711ba40e0 con 0x558711b9df20
2019-01-31 17:42:30.222149 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 3 ==== osd_op_reply(7 periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.latest_epoch [getxattrs,stat] v0'0 uv2 ondisk = 0) v7 ==== 219+0+91 (3291355538 0 3739807660) 0x7f79d0000b70 con 0x558711b9df20
2019-01-31 17:42:30.222282 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:30.222305 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:30.222350 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:8 1.ee5a525 periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.latest_epoch [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711ba4710 con 0x558711b9df20
2019-01-31 17:42:30.514090 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 4 ==== osd_op_reply(8 periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.latest_epoch [read 0~10] v0'0 uv2 ondisk = 0) v7 ==== 177+0+10 (1928894770 0 3088233675) 0x7f79d0000b70 con 0x558711b9df20
2019-01-31 17:42:30.514203 7f7a17d989c0 20 rados->read r=0 bl.length=10
2019-01-31 17:42:30.514286 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b820 obj=.rgw.root:periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.5 state=0x558711b9b498 s->prefetch_data=0
2019-01-31 17:42:30.514351 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:9 1.9f4bd3b9 periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.5 [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711ba4dc0 con 0x558711b9fd00
2019-01-31 17:42:30.808004 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 5 ==== osd_op_reply(9 periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.5 [getxattrs,stat] v0'0 uv3 ondisk = 0) v7 ==== 208+0+20 (1788418502 0 729209898) 0x7f79c8000b90 con 0x558711b9fd00
2019-01-31 17:42:30.808140 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:30.808163 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:30.808208 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:10 1.9f4bd3b9 periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.5 [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711ba4b80 con 0x558711b9fd00
2019-01-31 17:42:31.105639 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 6 ==== osd_op_reply(10 periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.5 [read 0~838] v0'0 uv3 ondisk = 0) v7 ==== 166+0+838 (2345790971 0 3569911994) 0x7f79c8000b90 con 0x558711b9fd00
2019-01-31 17:42:31.105749 7f7a17d989c0 20 rados->read r=0 bl.length=838
2019-01-31 17:42:31.105867 7f7a17d989c0 20 current period a4020dca-dc79-43fb-8688-b9e191c5c1e4
2019-01-31 17:42:31.105898 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b2d0 obj=.rgw.root:converted state=0x558711b9b498 s->prefetch_data=0
2019-01-31 17:42:31.105965 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:11 1.636fdd3 converted [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711ba5900 con 0x558711b9df20
2019-01-31 17:42:31.402344 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 5 ==== osd_op_reply(11 converted [getxattrs,stat] v0'0 uv0 ack = -2 ((2) No such file or directory)) v7 ==== 171+0+0 (4150370604 0 0) 0x7f79d0000b70 con 0x558711b9df20
2019-01-31 17:42:31.402538 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457a9e0 obj=.rgw.root:default.realm state=0x558711ba5588 s->prefetch_data=0
2019-01-31 17:42:31.402592 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:12 1.85fca992 default.realm [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711ba63c0 con 0x558711b9df20
2019-01-31 17:42:31.695160 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 6 ==== osd_op_reply(12 default.realm [getxattrs,stat] v0'0 uv1 ondisk = 0) v7 ==== 175+0+20 (2228292990 0 438547248) 0x7f79d0000b70 con 0x558711b9df20
2019-01-31 17:42:31.695287 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:31.695309 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:31.695352 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:13 1.85fca992 default.realm [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711ba69f0 con 0x558711b9df20
2019-01-31 17:42:31.988216 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 7 ==== osd_op_reply(13 default.realm [read 0~46] v0'0 uv1 ondisk = 0) v7 ==== 133+0+46 (1435556921 0 440825142) 0x7f79d0000b70 con 0x558711b9df20
2019-01-31 17:42:31.988322 7f7a17d989c0 20 rados->read r=0 bl.length=46
2019-01-31 17:42:31.988381 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457aa40 obj=.rgw.root:realms.1102c891-d81c-480e-9487-c9f874287d13 state=0x558711ba5538 s->prefetch_data=0
2019-01-31 17:42:31.988442 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:14 1.489eb37e realms.1102c891-d81c-480e-9487-c9f874287d13 [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711ba6e50 con 0x558711b9fd00
2019-01-31 17:42:32.283112 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 7 ==== osd_op_reply(14 realms.1102c891-d81c-480e-9487-c9f874287d13 [getxattrs,stat] v0'0 uv3 ondisk = 0) v7 ==== 205+0+20 (3061702216 0 368642961) 0x7f79c8000b10 con 0x558711b9fd00
2019-01-31 17:42:32.283233 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:32.283255 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:32.283301 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:15 1.489eb37e realms.1102c891-d81c-480e-9487-c9f874287d13 [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711ba72b0 con 0x558711b9fd00
2019-01-31 17:42:32.577101 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 8 ==== osd_op_reply(15 realms.1102c891-d81c-480e-9487-c9f874287d13 [read 0~106] v0'0 uv3 ondisk = 0) v7 ==== 163+0+106 (678113086 0 309371309) 0x7f79c8000b10 con 0x558711b9fd00
2019-01-31 17:42:32.577214 7f7a17d989c0 20 rados->read r=0 bl.length=106
2019-01-31 17:42:32.577306 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457ab60 obj=.rgw.root:default.region state=0x558711ba5498 s->prefetch_data=0
2019-01-31 17:42:32.577369 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:16 1.9a566808 default.region [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711ba74f0 con 0x558711b9df20
2019-01-31 17:42:32.870088 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 8 ==== osd_op_reply(16 default.region [getxattrs,stat] v0'0 uv0 ack = -2 ((2) No such file or directory)) v7 ==== 176+0+0 (778422469 0 0) 0x7f79d0000b70 con 0x558711b9df20
2019-01-31 17:42:32.870417 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:17 1.0 [pgls start_epoch 0] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711ba82c0 con 0x558711b9df20
2019-01-31 17:42:33.163191 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 9 ==== osd_op_reply(17 [pgls start_epoch 0] v27'2 uv2 ondisk = 1) v7 ==== 120+0+103 (812756981 0 3320129761) 0x7f79d0000b70 con 0x558711b9df20
2019-01-31 17:42:33.163334 7f7a17d989c0 20 RGWRados::pool_iterate: got zonegroup_info.dc69ef29-4113-4658-b679-68400f2b3007
2019-01-31 17:42:33.163400 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:18 1.1 [pgls start_epoch 0] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711ba5400 con 0x558711b9fd00
2019-01-31 17:42:33.460591 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 9 ==== osd_op_reply(18 [pgls start_epoch 0] v27'4 uv4 ondisk = 1) v7 ==== 120+0+157 (1822140414 0 2454396650) 0x7f79c8000b10 con 0x558711b9fd00
2019-01-31 17:42:33.460725 7f7a17d989c0 20 RGWRados::pool_iterate: got zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223
2019-01-31 17:42:33.460736 7f7a17d989c0 20 RGWRados::pool_iterate: got periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.5
2019-01-31 17:42:33.460771 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:19 1.2 [pgls start_epoch 0] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711ba7720 con 0x558711b9df20
2019-01-31 17:42:33.753307 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 10 ==== osd_op_reply(19 [pgls start_epoch 0] v27'1 uv1 ondisk = 1) v7 ==== 120+0+65 (2460065955 0 1002471398) 0x7f79d0000b70 con 0x558711b9df20
2019-01-31 17:42:33.753428 7f7a17d989c0 20 RGWRados::pool_iterate: got default.realm
2019-01-31 17:42:33.753497 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:20 1.3 [pgls start_epoch 0] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711ba7720 con 0x558711b9df20
2019-01-31 17:42:34.047093 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 11 ==== osd_op_reply(20 [pgls start_epoch 0] v42'9 uv2 ondisk = 1) v7 ==== 120+0+130 (394976494 0 1592218594) 0x7f79d0000b70 con 0x558711b9df20
2019-01-31 17:42:34.047192 7f7a17d989c0 20 RGWRados::pool_iterate: got zone_names.san-jose
2019-01-31 17:42:34.047202 7f7a17d989c0 20 RGWRados::pool_iterate: got realms.1102c891-d81c-480e-9487-c9f874287d13.control
2019-01-31 17:42:34.047303 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:21 1.4 [pgls start_epoch 0] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711babe30 con 0x558711baa9f0
2019-01-31 17:42:35.770347 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 1 ==== osd_op_reply(21 [pgls start_epoch 0] v0'0 uv0 ondisk = 1) v7 ==== 120+0+44 (1005323475 0 3248547820) 0x7f79c4000b50 con 0x558711baa9f0
2019-01-31 17:42:35.770432 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:22 1.5 [pgls start_epoch 0] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x7f79c4002590 con 0x558711b9df20
2019-01-31 17:42:36.063124 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 12 ==== osd_op_reply(22 [pgls start_epoch 0] v27'6 uv6 ondisk = 1) v7 ==== 120+0+282 (2921360819 0 2118996255) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:36.063224 7f7a17d989c0 20 RGWRados::pool_iterate: got periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.latest_epoch
2019-01-31 17:42:36.063237 7f7a17d989c0 20 RGWRados::pool_iterate: got zone_info.45c690a8-f39c-4b1d-9faf-e0e991ceaaac
2019-01-31 17:42:36.063240 7f7a17d989c0 20 RGWRados::pool_iterate: got default.zone.1102c891-d81c-480e-9487-c9f874287d13
2019-01-31 17:42:36.063243 7f7a17d989c0 20 RGWRados::pool_iterate: got default.zonegroup.1102c891-d81c-480e-9487-c9f874287d13
2019-01-31 17:42:36.063289 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:23 1.6 [pgls start_epoch 0] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bac4c0 con 0x558711b9fd00
2019-01-31 17:42:36.357002 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 10 ==== osd_op_reply(23 [pgls start_epoch 0] v27'4 uv4 ondisk = 1) v7 ==== 120+0+152 (3529165603 0 2367182044) 0x7f79c8000b10 con 0x558711b9fd00
2019-01-31 17:42:36.357115 7f7a17d989c0 20 RGWRados::pool_iterate: got zonegroups_names.noida
2019-01-31 17:42:36.357128 7f7a17d989c0 20 RGWRados::pool_iterate: got realms_names.georep
2019-01-31 17:42:36.357131 7f7a17d989c0 20 RGWRados::pool_iterate: got realms.1102c891-d81c-480e-9487-c9f874287d13
2019-01-31 17:42:36.357175 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:24 1.7 [pgls start_epoch 0] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bac910 con 0x558711baa9f0
2019-01-31 17:42:36.650249 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 2 ==== osd_op_reply(24 [pgls start_epoch 0] v42'5 uv5 ondisk = 1) v7 ==== 120+0+136 (3362421627 0 4280665285) 0x7f79c4000b50 con 0x558711baa9f0
2019-01-31 17:42:36.650355 7f7a17d989c0 20 RGWRados::pool_iterate: got zonegroups_names.default
2019-01-31 17:42:36.650371 7f7a17d989c0 20 RGWRados::pool_iterate: got periods.1102c891-d81c-480e-9487-c9f874287d13:staging
2019-01-31 17:42:36.650427 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457ac10 obj=.rgw.root:zone_names.default state=0x558711ba87b8 s->prefetch_data=0
2019-01-31 17:42:36.650500 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:25 1.7376dc2f zone_names.default [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bac480 con 0x558711baa9f0
2019-01-31 17:42:36.944078 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 3 ==== osd_op_reply(25 zone_names.default [getxattrs,stat] v0'0 uv0 ack = -2 ((2) No such file or directory)) v7 ==== 180+0+0 (2756788729 0 0) 0x7f79c4000b50 con 0x558711baa9f0
2019-01-31 17:42:36.944295 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457ac10 obj=.rgw.root:zonegroups_names.default state=0x558711ba90a8 s->prefetch_data=0
2019-01-31 17:42:36.944376 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:26 1.1eaca32f zonegroups_names.default [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bac480 con 0x558711baa9f0
2019-01-31 17:42:37.238066 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 4 ==== osd_op_reply(26 zonegroups_names.default [getxattrs,stat] v0'0 uv2 ondisk = 0) v7 ==== 186+0+20 (3900113519 0 1275257462) 0x7f79c4000b50 con 0x558711baa9f0
2019-01-31 17:42:37.238212 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:37.238231 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:37.238274 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:27 1.1eaca32f zonegroups_names.default [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bac910 con 0x558711baa9f0
2019-01-31 17:42:37.531096 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 5 ==== osd_op_reply(27 zonegroups_names.default [read 0~46] v0'0 uv2 ondisk = 0) v7 ==== 144+0+46 (802546755 0 339351421) 0x7f79c4000b50 con 0x558711baa9f0
2019-01-31 17:42:37.531349 7f7a17d989c0 20 rados->read r=0 bl.length=46
2019-01-31 17:42:37.531420 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457ac10 obj=.rgw.root:zonegroup_info.dc69ef29-4113-4658-b679-68400f2b3007 state=0x558711ba90a8 s->prefetch_data=0
2019-01-31 17:42:37.531500 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:28 1.46cb86c8 zonegroup_info.dc69ef29-4113-4658-b679-68400f2b3007 [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bacd60 con 0x558711b9df20
2019-01-31 17:42:37.824125 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 13 ==== osd_op_reply(28 zonegroup_info.dc69ef29-4113-4658-b679-68400f2b3007 [getxattrs,stat] v0'0 uv2 ondisk = 0) v7 ==== 213+0+20 (379174640 0 590237501) 0x7f79d0000b30 con 0x558711b9df20
2019-01-31 17:42:37.824248 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:37.824270 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:37.824316 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:29 1.46cb86c8 zonegroup_info.dc69ef29-4113-4658-b679-68400f2b3007 [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bacd60 con 0x558711b9df20
2019-01-31 17:42:38.116090 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 14 ==== osd_op_reply(29 zonegroup_info.dc69ef29-4113-4658-b679-68400f2b3007 [read 0~216] v0'0 uv2 ondisk = 0) v7 ==== 171+0+216 (748397967 0 3900988663) 0x7f79d0000b30 con 0x558711b9df20
2019-01-31 17:42:38.116165 7f7a17d989c0 20 rados->read r=0 bl.length=216
2019-01-31 17:42:38.116254 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b940 obj=.rgw.root:region_map state=0x558711b9b498 s->prefetch_data=0
2019-01-31 17:42:38.116317 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:30 1.bd31b503 region_map [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711ba9010 con 0x558711b9df20
2019-01-31 17:42:38.408152 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 15 ==== osd_op_reply(30 region_map [getxattrs,stat] v0'0 uv0 ack = -2 ((2) No such file or directory)) v7 ==== 172+0+0 (324597954 0 0) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:38.408350 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b1b0 obj=.rgw.root:default.realm state=0x558711ba90a8 s->prefetch_data=0
2019-01-31 17:42:38.408416 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:31 1.85fca992 default.realm [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711b9b640 con 0x558711b9df20
2019-01-31 17:42:38.701199 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 16 ==== osd_op_reply(31 default.realm [getxattrs,stat] v0'0 uv1 ondisk = 0) v7 ==== 175+0+20 (2228292990 0 438547248) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:38.701309 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:38.701331 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:38.701378 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:32 1.85fca992 default.realm [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711b9b400 con 0x558711b9df20
2019-01-31 17:42:38.993155 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 17 ==== osd_op_reply(32 default.realm [read 0~46] v0'0 uv1 ondisk = 0) v7 ==== 133+0+46 (1435556921 0 440825142) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:38.993247 7f7a17d989c0 20 rados->read r=0 bl.length=46
2019-01-31 17:42:38.993302 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b210 obj=.rgw.root:realms.1102c891-d81c-480e-9487-c9f874287d13 state=0x558711ba90a8 s->prefetch_data=0
2019-01-31 17:42:38.993367 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:33 1.489eb37e realms.1102c891-d81c-480e-9487-c9f874287d13 [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711badad0 con 0x558711b9fd00
2019-01-31 17:42:39.285954 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 11 ==== osd_op_reply(33 realms.1102c891-d81c-480e-9487-c9f874287d13 [getxattrs,stat] v0'0 uv3 ondisk = 0) v7 ==== 205+0+20 (3061702216 0 368642961) 0x7f79c8000b10 con 0x558711b9fd00
2019-01-31 17:42:39.286089 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:39.286113 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:39.286157 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:34 1.489eb37e realms.1102c891-d81c-480e-9487-c9f874287d13 [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711badad0 con 0x558711b9fd00
2019-01-31 17:42:39.858801 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 12 ==== osd_op_reply(34 realms.1102c891-d81c-480e-9487-c9f874287d13 [read 0~106] v0'0 uv3 ondisk = 0) v7 ==== 163+0+106 (678113086 0 309371309) 0x7f79c8000b10 con 0x558711b9fd00
2019-01-31 17:42:39.858908 7f7a17d989c0 20 rados->read r=0 bl.length=106
2019-01-31 17:42:39.858972 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b330 obj=.rgw.root:default.zonegroup.1102c891-d81c-480e-9487-c9f874287d13 state=0x558711ba90a8 s->prefetch_data=0
2019-01-31 17:42:39.859032 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:35 1.54fc807d default.zonegroup.1102c891-d81c-480e-9487-c9f874287d13 [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711badf30 con 0x558711b9df20
2019-01-31 17:42:40.152402 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 18 ==== osd_op_reply(35 default.zonegroup.1102c891-d81c-480e-9487-c9f874287d13 [getxattrs,stat] v0'0 uv3 ondisk = 0) v7 ==== 216+0+20 (2499624622 0 3688355587) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:40.152511 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:40.152524 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:40.152559 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:36 1.54fc807d default.zonegroup.1102c891-d81c-480e-9487-c9f874287d13 [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711badad0 con 0x558711b9df20
2019-01-31 17:42:40.445154 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 19 ==== osd_op_reply(36 default.zonegroup.1102c891-d81c-480e-9487-c9f874287d13 [read 0~46] v0'0 uv3 ondisk = 0) v7 ==== 174+0+46 (1798492436 0 3171888795) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:40.445241 7f7a17d989c0 20 rados->read r=0 bl.length=46
2019-01-31 17:42:40.445309 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b560 obj=.rgw.root:zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 state=0x558711ba90a8 s->prefetch_data=0
2019-01-31 17:42:40.445374 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:37 1.3968099 zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bae800 con 0x558711b9fd00
2019-01-31 17:42:40.739005 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 13 ==== osd_op_reply(37 zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 [getxattrs,stat] v0'0 uv4 ondisk = 0) v7 ==== 213+0+20 (371337311 0 1335695401) 0x7f79c8000b10 con 0x558711b9fd00
2019-01-31 17:42:40.739150 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:40.739170 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:40.739212 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:38 1.3968099 zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711badad0 con 0x558711b9fd00
2019-01-31 17:42:41.032988 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 14 ==== osd_op_reply(38 zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 [read 0~554] v0'0 uv4 ondisk = 0) v7 ==== 171+0+554 (3992906434 0 1303797271) 0x7f79c80029e0 con 0x558711b9fd00
2019-01-31 17:42:41.033097 7f7a17d989c0 20 rados->read r=0 bl.length=554
2019-01-31 17:42:41.033157 7f7a17d989c0 20 period zonegroup init ret 0
2019-01-31 17:42:41.033167 7f7a17d989c0 20 period zonegroup name noida
2019-01-31 17:42:41.033169 7f7a17d989c0 20 using current period zonegroup noida
2019-01-31 17:42:41.033200 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b1b0 obj=.rgw.root:default.realm state=0x558711ba90a8 s->prefetch_data=0
2019-01-31 17:42:41.033256 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:39 1.85fca992 default.realm [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711baf400 con 0x558711b9df20
2019-01-31 17:42:41.325239 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 20 ==== osd_op_reply(39 default.realm [getxattrs,stat] v0'0 uv1 ondisk = 0) v7 ==== 175+0+20 (2228292990 0 438547248) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:41.325364 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:41.325388 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:41.325429 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:40 1.85fca992 default.realm [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711baf440 con 0x558711b9df20
2019-01-31 17:42:41.618013 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 21 ==== osd_op_reply(40 default.realm [read 0~46] v0'0 uv1 ondisk = 0) v7 ==== 133+0+46 (1435556921 0 440825142) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:41.618106 7f7a17d989c0 20 rados->read r=0 bl.length=46
2019-01-31 17:42:41.618169 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b210 obj=.rgw.root:realms.1102c891-d81c-480e-9487-c9f874287d13 state=0x558711ba90a8 s->prefetch_data=0
2019-01-31 17:42:41.618226 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:41 1.489eb37e realms.1102c891-d81c-480e-9487-c9f874287d13 [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bafbd0 con 0x558711b9fd00
2019-01-31 17:42:41.910874 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 15 ==== osd_op_reply(41 realms.1102c891-d81c-480e-9487-c9f874287d13 [getxattrs,stat] v0'0 uv3 ondisk = 0) v7 ==== 205+0+20 (3061702216 0 368642961) 0x7f79c80029e0 con 0x558711b9fd00
2019-01-31 17:42:41.910965 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:41.910978 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:41.911013 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:42 1.489eb37e realms.1102c891-d81c-480e-9487-c9f874287d13 [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bb0030 con 0x558711b9fd00
2019-01-31 17:42:42.486114 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 16 ==== osd_op_reply(42 realms.1102c891-d81c-480e-9487-c9f874287d13 [read 0~106] v0'0 uv3 ondisk = 0) v7 ==== 163+0+106 (678113086 0 309371309) 0x7f79c80029e0 con 0x558711b9fd00
2019-01-31 17:42:42.486236 7f7a17d989c0 20 rados->read r=0 bl.length=106
2019-01-31 17:42:42.486304 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b330 obj=.rgw.root:default.zone.1102c891-d81c-480e-9487-c9f874287d13 state=0x558711ba90a8 s->prefetch_data=0
2019-01-31 17:42:42.486367 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:43 1.99d2d2cd default.zone.1102c891-d81c-480e-9487-c9f874287d13 [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bb0440 con 0x558711b9df20
2019-01-31 17:42:42.779131 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 22 ==== osd_op_reply(43 default.zone.1102c891-d81c-480e-9487-c9f874287d13 [getxattrs,stat] v0'0 uv5 ondisk = 0) v7 ==== 211+0+20 (1938875647 0 2515106103) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:42.779265 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:42.779285 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:42.779330 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:44 1.99d2d2cd default.zone.1102c891-d81c-480e-9487-c9f874287d13 [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bb0480 con 0x558711b9df20
2019-01-31 17:42:43.072103 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 23 ==== osd_op_reply(44 default.zone.1102c891-d81c-480e-9487-c9f874287d13 [read 0~46] v0'0 uv5 ondisk = 0) v7 ==== 169+0+46 (4196906645 0 4042612500) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:43.072284 7f7a17d989c0 20 rados->read r=0 bl.length=46
2019-01-31 17:42:43.072342 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b560 obj=.rgw.root:zone_info.45c690a8-f39c-4b1d-9faf-e0e991ceaaac state=0x558711ba90a8 s->prefetch_data=0
2019-01-31 17:42:43.072412 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:45 1.790053b5 zone_info.45c690a8-f39c-4b1d-9faf-e0e991ceaaac [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bb0c10 con 0x558711b9df20
2019-01-31 17:42:43.367231 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 24 ==== osd_op_reply(45 zone_info.45c690a8-f39c-4b1d-9faf-e0e991ceaaac [getxattrs,stat] v0'0 uv4 ondisk = 0) v7 ==== 208+0+20 (2274421836 0 1973944319) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:43.367405 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:43.367424 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:43.367496 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:46 1.790053b5 zone_info.45c690a8-f39c-4b1d-9faf-e0e991ceaaac [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bb03b0 con 0x558711b9df20
2019-01-31 17:42:43.662658 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 25 ==== osd_op_reply(46 zone_info.45c690a8-f39c-4b1d-9faf-e0e991ceaaac [read 0~1302] v0'0 uv4 ondisk = 0) v7 ==== 166+0+1302 (1469066816 0 3335484574) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:43.662832 7f7a17d989c0 20 rados->read r=0 bl.length=1302
2019-01-31 17:42:43.662938 7f7a17d989c0 10 Cannot find current period zone using local zone
2019-01-31 17:42:43.662971 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b880 obj=.rgw.root:zone_info.45c690a8-f39c-4b1d-9faf-e0e991ceaaac state=0x558711bb0208 s->prefetch_data=0
2019-01-31 17:42:43.663025 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:47 1.790053b5 zone_info.45c690a8-f39c-4b1d-9faf-e0e991ceaaac [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bb17f0 con 0x558711b9df20
2019-01-31 17:42:43.958060 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 26 ==== osd_op_reply(47 zone_info.45c690a8-f39c-4b1d-9faf-e0e991ceaaac [getxattrs,stat] v0'0 uv4 ondisk = 0) v7 ==== 208+0+20 (2274421836 0 1973944319) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:43.958240 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:43.958255 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:43.958293 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:48 1.790053b5 zone_info.45c690a8-f39c-4b1d-9faf-e0e991ceaaac [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bb1e20 con 0x558711b9df20
2019-01-31 17:42:44.250341 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 27 ==== osd_op_reply(48 zone_info.45c690a8-f39c-4b1d-9faf-e0e991ceaaac [read 0~1302] v0'0 uv4 ondisk = 0) v7 ==== 166+0+1302 (1469066816 0 3335484574) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:44.250522 7f7a17d989c0 20 rados->read r=0 bl.length=1302
2019-01-31 17:42:44.250613 7f7a17d989c0 1 Cannot find zone id=45c690a8-f39c-4b1d-9faf-e0e991ceaaac (name=san-jose), switching to local zonegroup configuration
2019-01-31 17:42:44.250640 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b6f0 obj=.rgw.root:zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 state=0x558711bb0208 s->prefetch_data=0
2019-01-31 17:42:44.250696 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:49 1.3968099 zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bb24c0 con 0x558711b9fd00
2019-01-31 17:42:44.545272 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 17 ==== osd_op_reply(49 zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 [getxattrs,stat] v0'0 uv4 ondisk = 0) v7 ==== 213+0+20 (371337311 0 1335695401) 0x7f79c8002e30 con 0x558711b9fd00
2019-01-31 17:42:44.545388 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:44.545407 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:44.545470 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:50 1.3968099 zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bb2540 con 0x558711b9fd00
2019-01-31 17:42:44.841401 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 18 ==== osd_op_reply(50 zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 [read 0~554] v0'0 uv4 ondisk = 0) v7 ==== 171+0+554 (3992906434 0 1303797271) 0x7f79c8003450 con 0x558711b9fd00
2019-01-31 17:42:44.841517 7f7a17d989c0 20 rados->read r=0 bl.length=554
2019-01-31 17:42:44.841576 7f7a17d989c0 20 zonegroup noida
2019-01-31 17:42:44.841582 7f7a17d989c0 20 zone san-jose
2019-01-31 17:42:44.841780 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:51 7.4322fa9f notify.0 [create 0~0] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bb3290 con 0x558711baa9f0
2019-01-31 17:42:45.135113 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 6 ==== osd_op_reply(51 notify.0 [create 0~0] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (2041374335 0 0) 0x7f79c4000b50 con 0x558711baa9f0
2019-01-31 17:42:45.135246 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:52 7.4322fa9f notify.0 [watch watch cookie 94038606426768] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bb3b70 con 0x558711baa9f0
2019-01-31 17:42:45.430505 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 7 ==== osd_op_reply(52 notify.0 [watch watch cookie 94038606426768] v42'81 uv1 ondisk = 0) v7 ==== 128+0+0 (3296508538 0 0) 0x7f79c4000b50 con 0x558711baa9f0
2019-01-31 17:42:45.430588 7f7a17d989c0 20 add_watcher() i=0
2019-01-31 17:42:45.430658 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:53 7.16dafda0 notify.1 [create 0~0] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bb3b70 con 0x558711b9df20
2019-01-31 17:42:45.723206 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 28 ==== osd_op_reply(53 notify.1 [create 0~0] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (1444779571 0 0) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:45.723345 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:54 7.16dafda0 notify.1 [watch watch cookie 94038606428464] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bb4580 con 0x558711b9df20
2019-01-31 17:42:46.017121 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 29 ==== osd_op_reply(54 notify.1 [watch watch cookie 94038606428464] v42'81 uv1 ondisk = 0) v7 ==== 128+0+0 (28479916 0 0) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:46.017212 7f7a17d989c0 20 add_watcher() i=1
2019-01-31 17:42:46.017267 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:55 7.88aa5c95 notify.2 [create 0~0] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bb4580 con 0x558711baa9f0
2019-01-31 17:42:46.309244 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 8 ==== osd_op_reply(55 notify.2 [create 0~0] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (832194016 0 0) 0x7f79c4000b50 con 0x558711baa9f0
2019-01-31 17:42:46.309404 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:56 7.88aa5c95 notify.2 [watch watch cookie 94038606431040] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bb4fc0 con 0x558711baa9f0
2019-01-31 17:42:46.476630 7f79ebfff700 2 RGWDataChangesLog::ChangesRenewThread: start
2019-01-31 17:42:46.605472 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 9 ==== osd_op_reply(56 notify.2 [watch watch cookie 94038606431040] v42'161 uv1 ondisk = 0) v7 ==== 128+0+0 (1088293381 0 0) 0x7f79c4000b50 con 0x558711baa9f0
2019-01-31 17:42:46.605569 7f7a17d989c0 20 add_watcher() i=2
2019-01-31 17:42:46.605622 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:57 7.f8c99aee notify.3 [create 0~0] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bb4ff0 con 0x558711b9fd00
2019-01-31 17:42:46.900008 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 19 ==== osd_op_reply(57 notify.3 [create 0~0] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (238726376 0 0) 0x7f79c80029e0 con 0x558711b9fd00
2019-01-31 17:42:46.900175 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:58 7.f8c99aee notify.3 [watch watch cookie 94038606433712] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bb5a20 con 0x558711b9fd00
2019-01-31 17:42:47.195873 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 20 ==== osd_op_reply(58 notify.3 [watch watch cookie 94038606433712] v42'81 uv1 ondisk = 0) v7 ==== 128+0+0 (4193110395 0 0) 0x7f79c80029e0 con 0x558711b9fd00
2019-01-31 17:42:47.195991 7f7a17d989c0 20 add_watcher() i=3
2019-01-31 17:42:47.196054 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:59 7.a204812d notify.4 [create 0~0] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bb5a20 con 0x558711baa9f0
2019-01-31 17:42:47.489157 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 10 ==== osd_op_reply(59 notify.4 [create 0~0] v0'0 uv3 ondisk = 0) v7 ==== 128+0+0 (3623819619 0 0) 0x7f79c4000b50 con 0x558711baa9f0
2019-01-31 17:42:47.489274 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:60 7.a204812d notify.4 [watch watch cookie 94038606436320] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bb63f0 con 0x558711baa9f0
2019-01-31 17:42:47.783093 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 11 ==== osd_op_reply(60 notify.4 [watch watch cookie 94038606436320] v42'162 uv3 ondisk = 0) v7 ==== 128+0+0 (4156701943 0 0) 0x7f79c4000b50 con 0x558711baa9f0
2019-01-31 17:42:47.783167 7f7a17d989c0 20 add_watcher() i=4
2019-01-31 17:42:47.783207 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:61 7.31099063 notify.5 [create 0~0] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bb6420 con 0x558711b9df20
2019-01-31 17:42:48.077277 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 30 ==== osd_op_reply(61 notify.5 [create 0~0] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (3762594662 0 0) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:48.077437 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:62 7.31099063 notify.5 [watch watch cookie 94038606438880] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bb6e30 con 0x558711b9df20
2019-01-31 17:42:48.372262 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 31 ==== osd_op_reply(62 notify.5 [watch watch cookie 94038606438880] v42'81 uv1 ondisk = 0) v7 ==== 128+0+0 (2292946227 0 0) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:48.372349 7f7a17d989c0 20 add_watcher() i=5
2019-01-31 17:42:48.372402 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:63 7.97c520d4 notify.6 [create 0~0] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bb6e30 con 0x558711b9df20
2019-01-31 17:42:48.665120 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 32 ==== osd_op_reply(63 notify.6 [create 0~0] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (1392327011 0 0) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:48.665262 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:64 7.97c520d4 notify.6 [watch watch cookie 94038606441456] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bb77f0 con 0x558711b9df20
2019-01-31 17:42:48.960821 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 33 ==== osd_op_reply(64 notify.6 [watch watch cookie 94038606441456] v42'81 uv1 ondisk = 0) v7 ==== 128+0+0 (3351393991 0 0) 0x7f79d0002710 con 0x558711b9df20
2019-01-31 17:42:48.960912 7f7a17d989c0 20 add_watcher() i=6
2019-01-31 17:42:48.960962 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:65 7.84ada7c9 notify.7 [create 0~0] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bb7820 con 0x558711b9fd00
2019-01-31 17:42:49.255113 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 21 ==== osd_op_reply(65 notify.7 [create 0~0] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (220219888 0 0) 0x7f79c80029e0 con 0x558711b9fd00
2019-01-31 17:42:49.255286 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:66 7.84ada7c9 notify.7 [watch watch cookie 94038606444000] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bb8230 con 0x558711b9fd00
2019-01-31 17:42:49.476266 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:67 7.4322fa9f notify.0 [watch ping cookie 94038606426768] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x7f79cc000ce0 con 0x558711baa9f0
2019-01-31 17:42:49.476334 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:68 7.88aa5c95 notify.2 [watch ping cookie 94038606431040] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x7f79cc001750 con 0x558711baa9f0
2019-01-31 17:42:49.476357 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:69 7.a204812d notify.4 [watch ping cookie 94038606436320] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x7f79cc002130 con 0x558711baa9f0
2019-01-31 17:42:49.476370 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:70 7.16dafda0 notify.1 [watch ping cookie 94038606428464] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x7f79cc002ad0 con 0x558711b9df20
2019-01-31 17:42:49.476389 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:71 7.31099063 notify.5 [watch ping cookie 94038606438880] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x7f79cc0034a0 con 0x558711b9df20
2019-01-31 17:42:49.476410 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:72 7.97c520d4 notify.6 [watch ping cookie 94038606441456] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x7f79cc003e80 con 0x558711b9df20
2019-01-31 17:42:49.476427 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:73 7.f8c99aee notify.3 [watch ping cookie 94038606433712] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x7f79cc004820 con 0x558711b9fd00
2019-01-31 17:42:49.476493 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6789/0 -- mon_subscribe({osdmap=43}) v2 -- ?+0 0x7f79cc004f50 con 0x558711b8fcc0
2019-01-31 17:42:49.476512 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- ping magic: 0 v1 -- ?+0 0x7f79cc005450 con 0x558711b9df20
2019-01-31 17:42:49.476519 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- ping magic: 0 v1 -- ?+0 0x7f79cc005800 con 0x558711b9fd00
2019-01-31 17:42:49.476624 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- ping magic: 0 v1 -- ?+0 0x7f79cc000d20 con 0x558711baa9f0
2019-01-31 17:42:49.558898 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 22 ==== osd_op_reply(66 notify.7 [watch watch cookie 94038606444000] v42'81 uv1 ondisk = 0) v7 ==== 128+0+0 (4109540703 0 0) 0x7f79c80029e0 con 0x558711b9fd00
2019-01-31 17:42:49.558960 7f7a17d989c0 20 add_watcher() i=7
2019-01-31 17:42:49.558968 7f7a17d989c0 2 all 8 watchers are set, enabling cache
2019-01-31 17:42:49.559002 7f7a17d989c0 20 generating connection object for zone noida1 id 71931e0e-1be6-449f-af34-edb4166c4e4a
2019-01-31 17:42:49.560743 7f7a17d989c0 20 init_complete bucket index max shards: 100
2019-01-31 17:42:49.560958 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b840 obj=.rgw.root:default.realm state=0x558711bd0818 s->prefetch_data=0
2019-01-31 17:42:49.560986 7f7a17d989c0 10 cache get: name=.rgw.root+default.realm : miss
2019-01-31 17:42:49.561041 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:74 1.85fca992 default.realm [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bd1970 con 0x558711b9df20
2019-01-31 17:42:49.561117 7f79b27e4700 20 reqs_thread_entry: start
2019-01-31 17:42:49.770238 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 34 ==== osd_op_reply(70 notify.1 [watch ping cookie 94038606428464] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (3823910608 0 0) 0x7f79d0004c30 con 0x558711b9df20
2019-01-31 17:42:49.770343 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 35 ==== osd_op_reply(71 notify.5 [watch ping cookie 94038606438880] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (1794456143 0 0) 0x7f79d0004c30 con 0x558711b9df20
2019-01-31 17:42:49.770370 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 12 ==== osd_op_reply(67 notify.0 [watch ping cookie 94038606426768] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (639767814 0 0) 0x7f79c4002bb0 con 0x558711baa9f0
2019-01-31 17:42:49.770387 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 36 ==== osd_op_reply(72 notify.6 [watch ping cookie 94038606441456] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (631019963 0 0) 0x7f79d0004c30 con 0x558711b9df20
2019-01-31 17:42:49.770422 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 13 ==== osd_op_reply(68 notify.2 [watch ping cookie 94038606431040] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (58232845 0 0) 0x7f79c4002bb0 con 0x558711baa9f0
2019-01-31 17:42:49.770484 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 14 ==== osd_op_reply(69 notify.4 [watch ping cookie 94038606436320] v0'0 uv3 ondisk = 0) v7 ==== 128+0+0 (2742689992 0 0) 0x7f79c4002bb0 con 0x558711baa9f0
2019-01-31 17:42:49.770846 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 23 ==== osd_op_reply(73 notify.3 [watch ping cookie 94038606433712] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (464741895 0 0) 0x7f79c8003810 con 0x558711b9fd00
2019-01-31 17:42:49.853473 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 37 ==== osd_op_reply(74 default.realm [getxattrs,stat] v0'0 uv1 ondisk = 0) v7 ==== 175+0+20 (2228292990 0 438547248) 0x7f79d0005390 con 0x558711b9df20
2019-01-31 17:42:49.853551 7f7a17d989c0 10 cache put: name=.rgw.root+default.realm info.flags=6
2019-01-31 17:42:49.853564 7f7a17d989c0 10 adding .rgw.root+default.realm to cache LRU end
2019-01-31 17:42:49.853570 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:49.853578 7f7a17d989c0 10 cache get: name=.rgw.root+default.realm : type miss (requested=1, cached=6)
2019-01-31 17:42:49.853581 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:49.853615 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:75 1.85fca992 default.realm [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bd22b0 con 0x558711b9df20
2019-01-31 17:42:50.146146 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 38 ==== osd_op_reply(75 default.realm [read 0~46] v0'0 uv1 ondisk = 0) v7 ==== 133+0+46 (1435556921 0 440825142) 0x7f79d0005390 con 0x558711b9df20
2019-01-31 17:42:50.146231 7f7a17d989c0 20 rados->read r=0 bl.length=46
2019-01-31 17:42:50.146281 7f7a17d989c0 10 cache put: name=.rgw.root+default.realm info.flags=1
2019-01-31 17:42:50.146288 7f7a17d989c0 10 moving .rgw.root+default.realm to cache LRU end
2019-01-31 17:42:50.146324 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b8a0 obj=.rgw.root:realms.1102c891-d81c-480e-9487-c9f874287d13 state=0x558711bd0818 s->prefetch_data=0
2019-01-31 17:42:50.146336 7f7a17d989c0 10 cache get: name=.rgw.root+realms.1102c891-d81c-480e-9487-c9f874287d13 : miss
2019-01-31 17:42:50.146402 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:76 1.489eb37e realms.1102c891-d81c-480e-9487-c9f874287d13 [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bd3a40 con 0x558711b9fd00
2019-01-31 17:42:50.441270 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 24 ==== osd_op_reply(76 realms.1102c891-d81c-480e-9487-c9f874287d13 [getxattrs,stat] v0'0 uv3 ondisk = 0) v7 ==== 205+0+20 (3061702216 0 368642961) 0x7f79c8003c50 con 0x558711b9fd00
2019-01-31 17:42:50.441398 7f7a17d989c0 10 cache put: name=.rgw.root+realms.1102c891-d81c-480e-9487-c9f874287d13 info.flags=6
2019-01-31 17:42:50.441423 7f7a17d989c0 10 adding .rgw.root+realms.1102c891-d81c-480e-9487-c9f874287d13 to cache LRU end
2019-01-31 17:42:50.441432 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:50.441443 7f7a17d989c0 10 cache get: name=.rgw.root+realms.1102c891-d81c-480e-9487-c9f874287d13 : type miss (requested=1, cached=6)
2019-01-31 17:42:50.441449 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:50.441511 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:77 1.489eb37e realms.1102c891-d81c-480e-9487-c9f874287d13 [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bd4570 con 0x558711b9fd00
2019-01-31 17:42:50.735158 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 25 ==== osd_op_reply(77 realms.1102c891-d81c-480e-9487-c9f874287d13 [read 0~106] v0'0 uv3 ondisk = 0) v7 ==== 163+0+106 (678113086 0 309371309) 0x7f79c8003c50 con 0x558711b9fd00
2019-01-31 17:42:50.735281 7f7a17d989c0 20 rados->read r=0 bl.length=106
2019-01-31 17:42:50.735313 7f7a17d989c0 10 cache put: name=.rgw.root+realms.1102c891-d81c-480e-9487-c9f874287d13 info.flags=1
2019-01-31 17:42:50.735326 7f7a17d989c0 10 moving .rgw.root+realms.1102c891-d81c-480e-9487-c9f874287d13 to cache LRU end
2019-01-31 17:42:50.735377 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b6c0 obj=.rgw.root:realms.1102c891-d81c-480e-9487-c9f874287d13 state=0x558711bd07e8 s->prefetch_data=0
2019-01-31 17:42:50.735388 7f7a17d989c0 10 cache get: name=.rgw.root+realms.1102c891-d81c-480e-9487-c9f874287d13 : type miss (requested=6, cached=3)
2019-01-31 17:42:50.735442 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:78 1.489eb37e realms.1102c891-d81c-480e-9487-c9f874287d13 [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bd5df0 con 0x558711b9fd00
2019-01-31 17:42:51.030061 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 26 ==== osd_op_reply(78 realms.1102c891-d81c-480e-9487-c9f874287d13 [getxattrs,stat] v0'0 uv3 ondisk = 0) v7 ==== 205+0+20 (3061702216 0 368642961) 0x7f79c8004250 con 0x558711b9fd00
2019-01-31 17:42:51.030191 7f7a17d989c0 10 cache put: name=.rgw.root+realms.1102c891-d81c-480e-9487-c9f874287d13 info.flags=6
2019-01-31 17:42:51.030208 7f7a17d989c0 10 moving .rgw.root+realms.1102c891-d81c-480e-9487-c9f874287d13 to cache LRU end
2019-01-31 17:42:51.030219 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:51.030229 7f7a17d989c0 10 cache get: name=.rgw.root+realms.1102c891-d81c-480e-9487-c9f874287d13 : hit (requested=1, cached=7)
2019-01-31 17:42:51.030279 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b820 obj=.rgw.root:periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.latest_epoch state=0x558711bd07e8 s->prefetch_data=0
2019-01-31 17:42:51.030287 7f7a17d989c0 10 cache get: name=.rgw.root+periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.latest_epoch : miss
2019-01-31 17:42:51.030333 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:79 1.ee5a525 periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.latest_epoch [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bd6660 con 0x558711b9df20
2019-01-31 17:42:51.322213 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 39 ==== osd_op_reply(79 periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.latest_epoch [getxattrs,stat] v0'0 uv2 ondisk = 0) v7 ==== 219+0+91 (3291355538 0 3739807660) 0x7f79d00059a0 con 0x558711b9df20
2019-01-31 17:42:51.322336 7f7a17d989c0 10 cache put: name=.rgw.root+periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.latest_epoch info.flags=6
2019-01-31 17:42:51.322361 7f7a17d989c0 10 adding .rgw.root+periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.latest_epoch to cache LRU end
2019-01-31 17:42:51.322370 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:51.322381 7f7a17d989c0 10 cache get: name=.rgw.root+periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.latest_epoch : type miss (requested=1, cached=6)
2019-01-31 17:42:51.322387 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:51.322429 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:80 1.ee5a525 periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.latest_epoch [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bd70e0 con 0x558711b9df20
2019-01-31 17:42:51.615266 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 40 ==== osd_op_reply(80 periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.latest_epoch [read 0~10] v0'0 uv2 ondisk = 0) v7 ==== 177+0+10 (1928894770 0 3088233675) 0x7f79d00059a0 con 0x558711b9df20
2019-01-31 17:42:51.615354 7f7a17d989c0 20 rados->read r=0 bl.length=10
2019-01-31 17:42:51.615379 7f7a17d989c0 10 cache put: name=.rgw.root+periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.latest_epoch info.flags=1
2019-01-31 17:42:51.615384 7f7a17d989c0 10 moving .rgw.root+periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.latest_epoch to cache LRU end
2019-01-31 17:42:51.615427 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b840 obj=.rgw.root:periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.5 state=0x558711bd07e8 s->prefetch_data=0
2019-01-31 17:42:51.615445 7f7a17d989c0 10 cache get: name=.rgw.root+periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.5 : miss
2019-01-31 17:42:51.615496 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:81 1.9f4bd3b9 periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.5 [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bd8890 con 0x558711b9fd00
2019-01-31 17:42:51.910141 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 27 ==== osd_op_reply(81 periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.5 [getxattrs,stat] v0'0 uv3 ondisk = 0) v7 ==== 208+0+20 (1788418502 0 729209898) 0x7f79c8004250 con 0x558711b9fd00
2019-01-31 17:42:51.910233 7f7a17d989c0 10 cache put: name=.rgw.root+periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.5 info.flags=6
2019-01-31 17:42:51.910250 7f7a17d989c0 10 adding .rgw.root+periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.5 to cache LRU end
2019-01-31 17:42:51.910259 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:51.910269 7f7a17d989c0 10 cache get: name=.rgw.root+periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.5 : type miss (requested=1, cached=6)
2019-01-31 17:42:51.910274 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:51.910328 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:82 1.9f4bd3b9 periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.5 [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bd9110 con 0x558711b9fd00
2019-01-31 17:42:52.204091 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 28 ==== osd_op_reply(82 periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.5 [read 0~838] v0'0 uv3 ondisk = 0) v7 ==== 166+0+838 (2345790971 0 3569911994) 0x7f79c8004250 con 0x558711b9fd00
2019-01-31 17:42:52.204201 7f7a17d989c0 20 rados->read r=0 bl.length=838
2019-01-31 17:42:52.204235 7f7a17d989c0 10 cache put: name=.rgw.root+periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.5 info.flags=1
2019-01-31 17:42:52.204243 7f7a17d989c0 10 moving .rgw.root+periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.5 to cache LRU end
2019-01-31 17:42:52.204289 7f7a17d989c0 20 fork realm 1102c891-d81c-480e-9487-c9f874287d13 period a4020dca-dc79-43fb-8688-b9e191c5c1e4
2019-01-31 17:42:52.204313 7f7a17d989c0 20 update realm 1102c891-d81c-480e-9487-c9f874287d13 period 1102c891-d81c-480e-9487-c9f874287d13:staging
2019-01-31 17:42:52.204379 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:83 1.0 [pgls start_epoch 0] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bdbb10 con 0x558711b9df20
2019-01-31 17:42:52.496122 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 41 ==== osd_op_reply(83 [pgls start_epoch 0] v27'2 uv2 ondisk = 1) v7 ==== 120+0+103 (812756981 0 3320129761) 0x7f79d00059a0 con 0x558711b9df20
2019-01-31 17:42:52.496236 7f7a17d989c0 20 RGWRados::pool_iterate: got zonegroup_info.dc69ef29-4113-4658-b679-68400f2b3007
2019-01-31 17:42:52.496283 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:84 1.1 [pgls start_epoch 0] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bdbf80 con 0x558711b9fd00
2019-01-31 17:42:52.789071 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 29 ==== osd_op_reply(84 [pgls start_epoch 0] v27'4 uv4 ondisk = 1) v7 ==== 120+0+157 (1822140414 0 2454396650) 0x7f79c8004250 con 0x558711b9fd00
2019-01-31 17:42:52.789172 7f7a17d989c0 20 RGWRados::pool_iterate: got zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223
2019-01-31 17:42:52.789183 7f7a17d989c0 20 RGWRados::pool_iterate: got periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.5
2019-01-31 17:42:52.789220 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:85 1.2 [pgls start_epoch 0] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bdc3e0 con 0x558711b9df20
2019-01-31 17:42:53.088379 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 42 ==== osd_op_reply(85 [pgls start_epoch 0] v27'1 uv1 ondisk = 1) v7 ==== 120+0+65 (2460065955 0 1002471398) 0x7f79d00059a0 con 0x558711b9df20
2019-01-31 17:42:53.088507 7f7a17d989c0 20 RGWRados::pool_iterate: got default.realm
2019-01-31 17:42:53.088564 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:86 1.3 [pgls start_epoch 0] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bd09d0 con 0x558711b9df20
2019-01-31 17:42:53.381162 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 43 ==== osd_op_reply(86 [pgls start_epoch 0] v42'9 uv2 ondisk = 1) v7 ==== 120+0+130 (394976494 0 1592218594) 0x7f79d00059a0 con 0x558711b9df20
2019-01-31 17:42:53.381305 7f7a17d989c0 20 RGWRados::pool_iterate: got zone_names.san-jose
2019-01-31 17:42:53.381324 7f7a17d989c0 20 RGWRados::pool_iterate: got realms.1102c891-d81c-480e-9487-c9f874287d13.control
2019-01-31 17:42:53.381370 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:87 1.4 [pgls start_epoch 0] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bdc9e0 con 0x558711baa9f0
2019-01-31 17:42:53.675083 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 15 ==== osd_op_reply(87 [pgls start_epoch 0] v0'0 uv0 ondisk = 1) v7 ==== 120+0+44 (1005323475 0 3248547820) 0x7f79c4002bb0 con 0x558711baa9f0
2019-01-31 17:42:53.675202 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:88 1.5 [pgls start_epoch 0] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x7f79c4004570 con 0x558711b9df20
2019-01-31 17:42:53.968322 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 44 ==== osd_op_reply(88 [pgls start_epoch 0] v27'6 uv6 ondisk = 1) v7 ==== 120+0+282 (2921360819 0 2118996255) 0x7f79d0006130 con 0x558711b9df20
2019-01-31 17:42:53.968466 7f7a17d989c0 20 RGWRados::pool_iterate: got periods.a4020dca-dc79-43fb-8688-b9e191c5c1e4.latest_epoch
2019-01-31 17:42:53.968485 7f7a17d989c0 20 RGWRados::pool_iterate: got zone_info.45c690a8-f39c-4b1d-9faf-e0e991ceaaac
2019-01-31 17:42:53.968488 7f7a17d989c0 20 RGWRados::pool_iterate: got default.zone.1102c891-d81c-480e-9487-c9f874287d13
2019-01-31 17:42:53.968491 7f7a17d989c0 20 RGWRados::pool_iterate: got default.zonegroup.1102c891-d81c-480e-9487-c9f874287d13
2019-01-31 17:42:53.968566 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:89 1.6 [pgls start_epoch 0] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bdb140 con 0x558711b9fd00
2019-01-31 17:42:54.262874 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 30 ==== osd_op_reply(89 [pgls start_epoch 0] v27'4 uv4 ondisk = 1) v7 ==== 120+0+152 (3529165603 0 2367182044) 0x7f79c8004250 con 0x558711b9fd00
2019-01-31 17:42:54.263006 7f7a17d989c0 20 RGWRados::pool_iterate: got zonegroups_names.noida
2019-01-31 17:42:54.263032 7f7a17d989c0 20 RGWRados::pool_iterate: got realms_names.georep
2019-01-31 17:42:54.263046 7f7a17d989c0 20 RGWRados::pool_iterate: got realms.1102c891-d81c-480e-9487-c9f874287d13
2019-01-31 17:42:54.263091 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:90 1.7 [pgls start_epoch 0] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bdb700 con 0x558711baa9f0
2019-01-31 17:42:54.476790 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:91 7.4322fa9f notify.0 [watch ping cookie 94038606426768] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x7f79cc002700 con 0x558711baa9f0
2019-01-31 17:42:54.476862 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:92 7.88aa5c95 notify.2 [watch ping cookie 94038606431040] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x7f79cc003ab0 con 0x558711baa9f0
2019-01-31 17:42:54.476884 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:93 7.a204812d notify.4 [watch ping cookie 94038606436320] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x7f79cc001d60 con 0x558711baa9f0
2019-01-31 17:42:54.476901 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:94 7.16dafda0 notify.1 [watch ping cookie 94038606428464] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x7f79cc002130 con 0x558711b9df20
2019-01-31 17:42:54.476923 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:95 7.31099063 notify.5 [watch ping cookie 94038606438880] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x7f79cc003e80 con 0x558711b9df20
2019-01-31 17:42:54.476952 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:96 7.97c520d4 notify.6 [watch ping cookie 94038606441456] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x7f79cc005f30 con 0x558711b9df20
2019-01-31 17:42:54.476970 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:97 7.f8c99aee notify.3 [watch ping cookie 94038606433712] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x7f79cc0067a0 con 0x558711b9fd00
2019-01-31 17:42:54.476991 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:98 7.84ada7c9 notify.7 [watch ping cookie 94038606444000] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x7f79cc007010 con 0x558711b9fd00
2019-01-31 17:42:54.477008 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- ping magic: 0 v1 -- ?+0 0x7f79cc007550 con 0x558711b9df20
2019-01-31 17:42:54.477015 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- ping magic: 0 v1 -- ?+0 0x7f79cc0078a0 con 0x558711b9fd00
2019-01-31 17:42:54.477021 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- ping magic: 0 v1 -- ?+0 0x7f79cc007bf0 con 0x558711baa9f0
2019-01-31 17:42:54.556215 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 16 ==== osd_op_reply(90 [pgls start_epoch 0] v42'5 uv5 ondisk = 1) v7 ==== 120+0+136 (3362421627 0 4280665285) 0x7f79c4002bb0 con 0x558711baa9f0
2019-01-31 17:42:54.556298 7f7a17d989c0 20 RGWRados::pool_iterate: got zonegroups_names.default
2019-01-31 17:42:54.556312 7f7a17d989c0 20 RGWRados::pool_iterate: got periods.1102c891-d81c-480e-9487-c9f874287d13:staging
2019-01-31 17:42:54.556354 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b5a0 obj=.rgw.root:zonegroups_names.noida state=0x558711bdca78 s->prefetch_data=0
2019-01-31 17:42:54.556375 7f7a17d989c0 10 cache get: name=.rgw.root+zonegroups_names.noida : miss
2019-01-31 17:42:54.556421 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:99 1.dd289f86 zonegroups_names.noida [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bdcf70 con 0x558711b9fd00
2019-01-31 17:42:54.770341 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 17 ==== osd_op_reply(91 notify.0 [watch ping cookie 94038606426768] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (639767814 0 0) 0x7f79c4002bb0 con 0x558711baa9f0
2019-01-31 17:42:54.770337 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 45 ==== osd_op_reply(94 notify.1 [watch ping cookie 94038606428464] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (3823910608 0 0) 0x7f79d0006130 con 0x558711b9df20
2019-01-31 17:42:54.770422 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 18 ==== osd_op_reply(92 notify.2 [watch ping cookie 94038606431040] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (58232845 0 0) 0x7f79c4002bb0 con 0x558711baa9f0
2019-01-31 17:42:54.770442 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 46 ==== osd_op_reply(95 notify.5 [watch ping cookie 94038606438880] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (1794456143 0 0) 0x7f79d0006130 con 0x558711b9df20
2019-01-31 17:42:54.770479 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 19 ==== osd_op_reply(93 notify.4 [watch ping cookie 94038606436320] v0'0 uv3 ondisk = 0) v7 ==== 128+0+0 (2742689992 0 0) 0x7f79c4002bb0 con 0x558711baa9f0
2019-01-31 17:42:54.770502 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 47 ==== osd_op_reply(96 notify.6 [watch ping cookie 94038606441456] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (631019963 0 0) 0x7f79d0006130 con 0x558711b9df20
2019-01-31 17:42:54.771715 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 31 ==== osd_op_reply(97 notify.3 [watch ping cookie 94038606433712] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (464741895 0 0) 0x7f79c8004250 con 0x558711b9fd00
2019-01-31 17:42:54.771774 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 32 ==== osd_op_reply(98 notify.7 [watch ping cookie 94038606444000] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (380383779 0 0) 0x7f79c8004250 con 0x558711b9fd00
2019-01-31 17:42:54.850795 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 33 ==== osd_op_reply(99 zonegroups_names.noida [getxattrs,stat] v0'0 uv4 ondisk = 0) v7 ==== 184+0+20 (1461793547 0 118159300) 0x7f79c8004250 con 0x558711b9fd00
2019-01-31 17:42:54.850883 7f7a17d989c0 10 cache put: name=.rgw.root+zonegroups_names.noida info.flags=6
2019-01-31 17:42:54.850898 7f7a17d989c0 10 adding .rgw.root+zonegroups_names.noida to cache LRU end
2019-01-31 17:42:54.850907 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:54.850917 7f7a17d989c0 10 cache get: name=.rgw.root+zonegroups_names.noida : type miss (requested=1, cached=6)
2019-01-31 17:42:54.850922 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:54.850965 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:100 1.dd289f86 zonegroups_names.noida [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bdd3c0 con 0x558711b9fd00
2019-01-31 17:42:55.144829 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 34 ==== osd_op_reply(100 zonegroups_names.noida [read 0~46] v0'0 uv4 ondisk = 0) v7 ==== 142+0+46 (4183406307 0 3171888795) 0x7f79c8004250 con 0x558711b9fd00
2019-01-31 17:42:55.144924 7f7a17d989c0 20 rados->read r=0 bl.length=46
2019-01-31 17:42:55.144958 7f7a17d989c0 10 cache put: name=.rgw.root+zonegroups_names.noida info.flags=1
2019-01-31 17:42:55.144965 7f7a17d989c0 10 moving .rgw.root+zonegroups_names.noida to cache LRU end
2019-01-31 17:42:55.145003 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b5a0 obj=.rgw.root:zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 state=0x558711bdca78 s->prefetch_data=0
2019-01-31 17:42:55.145022 7f7a17d989c0 10 cache get: name=.rgw.root+zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 : miss
2019-01-31 17:42:55.145069 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:101 1.3968099 zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bdea60 con 0x558711b9fd00
2019-01-31 17:42:55.440610 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 35 ==== osd_op_reply(101 zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 [getxattrs,stat] v0'0 uv4 ondisk = 0) v7 ==== 213+0+20 (371337311 0 1335695401) 0x7f79c8004250 con 0x558711b9fd00
2019-01-31 17:42:55.440749 7f7a17d989c0 10 cache put: name=.rgw.root+zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 info.flags=6
2019-01-31 17:42:55.440774 7f7a17d989c0 10 adding .rgw.root+zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 to cache LRU end
2019-01-31 17:42:55.440783 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:55.440795 7f7a17d989c0 10 cache get: name=.rgw.root+zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 : type miss (requested=1, cached=6)
2019-01-31 17:42:55.440800 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:55.440852 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:102 1.3968099 zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711bdf0f0 con 0x558711b9fd00
2019-01-31 17:42:55.735148 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 36 ==== osd_op_reply(102 zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 [read 0~554] v0'0 uv4 ondisk = 0) v7 ==== 171+0+554 (3992906434 0 1303797271) 0x7f79c80053d0 con 0x558711b9fd00
2019-01-31 17:42:55.735261 7f7a17d989c0 20 rados->read r=0 bl.length=554
2019-01-31 17:42:55.735289 7f7a17d989c0 10 cache put: name=.rgw.root+zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 info.flags=1
2019-01-31 17:42:55.735302 7f7a17d989c0 10 moving .rgw.root+zonegroup_info.74ad391b-fbca-4c05-b9e7-c90fd4851223 to cache LRU end
2019-01-31 17:42:55.735413 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b5a0 obj=.rgw.root:zonegroups_names.default state=0x558711be05f8 s->prefetch_data=0
2019-01-31 17:42:55.735426 7f7a17d989c0 10 cache get: name=.rgw.root+zonegroups_names.default : miss
2019-01-31 17:42:55.735504 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:103 1.1eaca32f zonegroups_names.default [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711be1110 con 0x558711baa9f0
2019-01-31 17:42:56.030362 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 20 ==== osd_op_reply(103 zonegroups_names.default [getxattrs,stat] v0'0 uv2 ondisk = 0) v7 ==== 186+0+20 (3900113519 0 1275257462) 0x7f79c4003a90 con 0x558711baa9f0
2019-01-31 17:42:56.030446 7f7a17d989c0 10 cache put: name=.rgw.root+zonegroups_names.default info.flags=6
2019-01-31 17:42:56.030473 7f7a17d989c0 10 adding .rgw.root+zonegroups_names.default to cache LRU end
2019-01-31 17:42:56.030482 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:56.030491 7f7a17d989c0 10 cache get: name=.rgw.root+zonegroups_names.default : type miss (requested=1, cached=6)
2019-01-31 17:42:56.030497 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:56.030545 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:104 1.1eaca32f zonegroups_names.default [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711be1980 con 0x558711baa9f0
2019-01-31 17:42:56.324528 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 21 ==== osd_op_reply(104 zonegroups_names.default [read 0~46] v0'0 uv2 ondisk = 0) v7 ==== 144+0+46 (802546755 0 339351421) 0x7f79c4003a90 con 0x558711baa9f0
2019-01-31 17:42:56.324613 7f7a17d989c0 20 rados->read r=0 bl.length=46
2019-01-31 17:42:56.324646 7f7a17d989c0 10 cache put: name=.rgw.root+zonegroups_names.default info.flags=1
2019-01-31 17:42:56.324665 7f7a17d989c0 10 moving .rgw.root+zonegroups_names.default to cache LRU end
2019-01-31 17:42:56.324702 7f7a17d989c0 20 get_system_obj_state: rctx=0x7fff3457b5a0 obj=.rgw.root:zonegroup_info.dc69ef29-4113-4658-b679-68400f2b3007 state=0x558711be05f8 s->prefetch_data=0
2019-01-31 17:42:56.324720 7f7a17d989c0 10 cache get: name=.rgw.root+zonegroup_info.dc69ef29-4113-4658-b679-68400f2b3007 : miss
2019-01-31 17:42:56.324773 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:105 1.46cb86c8 zonegroup_info.dc69ef29-4113-4658-b679-68400f2b3007 [getxattrs,stat] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711be32f0 con 0x558711b9df20
2019-01-31 17:42:56.617152 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 48 ==== osd_op_reply(105 zonegroup_info.dc69ef29-4113-4658-b679-68400f2b3007 [getxattrs,stat] v0'0 uv2 ondisk = 0) v7 ==== 213+0+20 (379174640 0 590237501) 0x7f79d0006130 con 0x558711b9df20
2019-01-31 17:42:56.617258 7f7a17d989c0 10 cache put: name=.rgw.root+zonegroup_info.dc69ef29-4113-4658-b679-68400f2b3007 info.flags=6
2019-01-31 17:42:56.617277 7f7a17d989c0 10 adding .rgw.root+zonegroup_info.dc69ef29-4113-4658-b679-68400f2b3007 to cache LRU end
2019-01-31 17:42:56.617285 7f7a17d989c0 20 get_system_obj_state: s->obj_tag was set empty
2019-01-31 17:42:56.617296 7f7a17d989c0 10 cache get: name=.rgw.root+zonegroup_info.dc69ef29-4113-4658-b679-68400f2b3007 : type miss (requested=1, cached=6)
2019-01-31 17:42:56.617300 7f7a17d989c0 20 rados->read ofs=0 len=524288
2019-01-31 17:42:56.617340 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:106 1.46cb86c8 zonegroup_info.dc69ef29-4113-4658-b679-68400f2b3007 [read 0~524288] snapc 0=[] ack+read+known_if_redirected e42) v7 -- ?+0 0x558711be3b60 con 0x558711b9df20
2019-01-31 17:42:56.909041 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 49 ==== osd_op_reply(106 zonegroup_info.dc69ef29-4113-4658-b679-68400f2b3007 [read 0~216] v0'0 uv2 ondisk = 0) v7 ==== 171+0+216 (748397967 0 3900988663) 0x7f79d0006130 con 0x558711b9df20
2019-01-31 17:42:56.909116 7f7a17d989c0 20 rados->read r=0 bl.length=216
2019-01-31 17:42:56.909152 7f7a17d989c0 10 cache put: name=.rgw.root+zonegroup_info.dc69ef29-4113-4658-b679-68400f2b3007 info.flags=1
2019-01-31 17:42:56.909159 7f7a17d989c0 10 moving .rgw.root+zonegroup_info.dc69ef29-4113-4658-b679-68400f2b3007 to cache LRU end
2019-01-31 17:42:56.909188 7f7a17d989c0 20 skipping zonegroup default zone realm id , not on our realm 1102c891-d81c-480e-9487-c9f874287d13
2019-01-31 17:42:56.909360 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:107 1.63e1133f periods.1102c891-d81c-480e-9487-c9f874287d13:staging [delete,create 0~0,writefull 0~1064] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711be6ff0 con 0x558711baa9f0
2019-01-31 17:42:57.205172 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 22 ==== osd_op_reply(107 periods.1102c891-d81c-480e-9487-c9f874287d13:staging [delete,create 0~0,writefull 0~1064] v42'6 uv6 ondisk = 0) v7 ==== 256+0+0 (3852448503 0 0) 0x7f79c4003a90 con 0x558711baa9f0
2019-01-31 17:42:57.205268 7f7a17d989c0 10 cache put: name=.rgw.root+periods.1102c891-d81c-480e-9487-c9f874287d13:staging info.flags=7
2019-01-31 17:42:57.205287 7f7a17d989c0 10 adding .rgw.root+periods.1102c891-d81c-480e-9487-c9f874287d13:staging to cache LRU end
2019-01-31 17:42:57.205343 7f7a17d989c0 10 distributing notification oid=notify.5 bl.length()=1308
2019-01-31 17:42:57.205431 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:108 7.31099063 notify.5 [notify 94038606611808~0] snapc 0=[] ondisk+read+known_if_redirected e42) v7 -- ?+0 0x558711be9010 con 0x558711b9df20
2019-01-31 17:42:57.498153 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 50 ==== watch-notify(notify (1) cookie 94038606438880 notify 180388626434 ret 0) v3 ==== 1350+0+0 (1509028034 0 0) 0x7f79d0006130 con 0x558711b9df20
2019-01-31 17:42:57.498233 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 51 ==== osd_op_reply(108 notify.5 [notify 94038606611808~0] v0'0 uv1 ondisk = 0) v7 ==== 128+0+8 (1926762161 0 209628834) 0x7f79d00071e0 con 0x558711b9df20
2019-01-31 17:42:57.498239 7f79f8956700 10 RGWWatcher::handle_notify() notify_id 180388626434 cookie 94038606438880 notifier 4568 bl.length()=1308
2019-01-31 17:42:57.498293 7f79f8956700 10 cache put: name=.rgw.root+periods.1102c891-d81c-480e-9487-c9f874287d13:staging info.flags=7
2019-01-31 17:42:57.498299 7f79f8956700 10 moving .rgw.root+periods.1102c891-d81c-480e-9487-c9f874287d13:staging to cache LRU end
2019-01-31 17:42:57.498528 7f79f8956700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:109 7.31099063 notify.5 [notify-ack 0~0] snapc 0=[] read+known_if_redirected e42) v7 -- ?+0 0x558711bea460 con 0x558711b9df20
2019-01-31 17:42:57.791268 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 52 ==== watch-notify(notify_complete (2) cookie 94038606611808 notify 180388626434 ret 0) v3 ==== 42+0+48 (1377573541 0 2493762820) 0x7f79d0006130 con 0x558711b9df20
2019-01-31 17:42:57.791346 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 53 ==== osd_op_reply(109 notify.5 [notify-ack 0~0] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (2822192655 0 0) 0x7f79d0007640 con 0x558711b9df20
Sending period to new master zone 71931e0e-1be6-449f-af34-edb4166c4e4a
2019-01-31 17:42:57.791682 7f7a17d989c0 20 RGWEnv::set(): HTTP_DATE: Thu Jan 31 12:12:57 2019
2019-01-31 17:42:57.791697 7f7a17d989c0 20 > HTTP_DATE -> Thu Jan 31 12:12:57 2019
2019-01-31 17:42:57.791717 7f7a17d989c0 10 get_canon_resource(): dest=/admin/realm/period
2019-01-31 17:42:57.791720 7f7a17d989c0 10 generated canonical header: POST


Thu Jan 31 12:12:57 2019
/admin/realm/period
2019-01-31 17:42:57.791779 7f7a17d989c0 15 generated auth header: AWS 99ZO3154HDPWCHYOFBBF:zERxw9GO7bPYnn2emFkPKlKuX7A=
2019-01-31 17:42:57.791834 7f7a17d989c0 20 sending request to http://vlno-ceph01:7480/admin/realm/period?rgwx-zonegroup=74ad391b-fbca-4c05-b9e7-c90fd4851223
2019-01-31 17:42:57.798110 7f7a17d989c0 0 curl_easy_perform returned error: Failed connect to vlno-ceph01:7480; Connection refused
request failed: (22) Invalid argument
failed to commit period: (22) Invalid argument
2019-01-31 17:42:57.799328 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:110 7.4322fa9f notify.0 [watch unwatch cookie 94038606426768] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bb9e60 con 0x558711baa9f0
2019-01-31 17:42:58.093111 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 23 ==== osd_op_reply(110 notify.0 [watch unwatch cookie 94038606426768] v42'82 uv1 ondisk = 0) v7 ==== 128+0+0 (1624396190 0 0) 0x7f79c4002bb0 con 0x558711baa9f0
2019-01-31 17:42:58.093372 7f7a17d989c0 20 remove_watcher() i=0
2019-01-31 17:42:58.093387 7f7a17d989c0 2 removed watcher, disabling cache
2019-01-31 17:42:58.093449 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:111 7.16dafda0 notify.1 [watch unwatch cookie 94038606428464] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bba4c0 con 0x558711b9df20
2019-01-31 17:42:58.389102 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 54 ==== osd_op_reply(111 notify.1 [watch unwatch cookie 94038606428464] v42'82 uv1 ondisk = 0) v7 ==== 128+0+0 (2770106952 0 0) 0x7f79d0006c30 con 0x558711b9df20
2019-01-31 17:42:58.389339 7f7a17d989c0 20 remove_watcher() i=1
2019-01-31 17:42:58.389391 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:112 7.88aa5c95 notify.2 [watch unwatch cookie 94038606431040] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bbab20 con 0x558711baa9f0
2019-01-31 17:42:58.690466 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 24 ==== osd_op_reply(112 notify.2 [watch unwatch cookie 94038606431040] v42'163 uv1 ondisk = 0) v7 ==== 128+0+0 (3917126668 0 0) 0x7f79c4003a90 con 0x558711baa9f0
2019-01-31 17:42:58.690749 7f7a17d989c0 20 remove_watcher() i=2
2019-01-31 17:42:58.690796 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:113 7.f8c99aee notify.3 [watch unwatch cookie 94038606433712] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bbb180 con 0x558711b9fd00
2019-01-31 17:42:58.988960 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 37 ==== osd_op_reply(113 notify.3 [watch unwatch cookie 94038606433712] v42'82 uv1 ondisk = 0) v7 ==== 128+0+0 (1564680863 0 0) 0x7f79c80053d0 con 0x558711b9fd00
2019-01-31 17:42:58.989130 7f7a17d989c0 20 remove_watcher() i=3
2019-01-31 17:42:58.989183 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.131:6800/18266 -- osd_op(client.4568.0:114 7.a204812d notify.4 [watch unwatch cookie 94038606436320] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bbbb10 con 0x558711baa9f0
2019-01-31 17:42:59.284136 7f79eb3fa700 1 -- 172.23.18.112:0/3007987558 <== osd.0 172.18.84.131:6800/18266 25 ==== osd_op_reply(114 notify.4 [watch unwatch cookie 94038606436320] v42'164 uv3 ondisk = 0) v7 ==== 128+0+0 (1783586122 0 0) 0x7f79c4002bb0 con 0x558711baa9f0
2019-01-31 17:42:59.284239 7f7a17d989c0 20 remove_watcher() i=4
2019-01-31 17:42:59.284291 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:115 7.31099063 notify.5 [watch unwatch cookie 94038606438880] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bbc170 con 0x558711b9df20
2019-01-31 17:42:59.477166 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:116 7.97c520d4 notify.6 [watch ping cookie 94038606441456] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x7f79cc002700 con 0x558711b9df20
2019-01-31 17:42:59.477240 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:117 7.84ada7c9 notify.7 [watch ping cookie 94038606444000] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x7f79cc001d60 con 0x558711b9fd00
2019-01-31 17:42:59.477263 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- ping magic: 0 v1 -- ?+0 0x7f79cc004820 con 0x558711b9df20
2019-01-31 17:42:59.477371 7f79fc25e700 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- ping magic: 0 v1 -- ?+0 0x7f79cc007bf0 con 0x558711b9fd00
2019-01-31 17:42:59.578255 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 55 ==== osd_op_reply(115 notify.5 [watch unwatch cookie 94038606438880] v42'82 uv1 ondisk = 0) v7 ==== 128+0+0 (738557655 0 0) 0x7f79d0000d30 con 0x558711b9df20
2019-01-31 17:42:59.578368 7f7a17d989c0 20 remove_watcher() i=5
2019-01-31 17:42:59.578414 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.132:6800/32461 -- osd_op(client.4568.0:118 7.97c520d4 notify.6 [watch unwatch cookie 94038606441456] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bbc7d0 con 0x558711b9df20
2019-01-31 17:42:59.772010 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 38 ==== osd_op_reply(117 notify.7 [watch ping cookie 94038606444000] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (380383779 0 0) 0x7f79c8004250 con 0x558711b9fd00
2019-01-31 17:42:59.845084 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 56 ==== osd_op_reply(116 notify.6 [watch ping cookie 94038606441456] v0'0 uv1 ondisk = 0) v7 ==== 128+0+0 (631019963 0 0) 0x7f79d0000d30 con 0x558711b9df20
2019-01-31 17:42:59.873329 7f79eb7fe700 1 -- 172.23.18.112:0/3007987558 <== osd.1 172.18.84.132:6800/32461 57 ==== osd_op_reply(118 notify.6 [watch unwatch cookie 94038606441456] v42'82 uv1 ondisk = 0) v7 ==== 128+0+0 (1668078883 0 0) 0x7f79d0000d30 con 0x558711b9df20
2019-01-31 17:42:59.873512 7f7a17d989c0 20 remove_watcher() i=6
2019-01-31 17:42:59.873576 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 --> 172.18.84.133:6800/32290 -- osd_op(client.4568.0:119 7.84ada7c9 notify.7 [watch unwatch cookie 94038606444000] snapc 0=[] ondisk+write+known_if_redirected e42) v7 -- ?+0 0x558711bbce30 con 0x558711b9fd00
2019-01-31 17:43:00.172154 7f79eb5fc700 1 -- 172.23.18.112:0/3007987558 <== osd.2 172.18.84.133:6800/32290 39 ==== osd_op_reply(119 notify.7 [watch unwatch cookie 94038606444000] v42'82 uv1 ondisk = 0) v7 ==== 128+0+0 (1348236987 0 0) 0x7f79c80053d0 con 0x558711b9fd00
2019-01-31 17:43:00.172481 7f7a17d989c0 20 remove_watcher() i=7
2019-01-31 17:43:00.173735 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 mark_down 0x558711baa9f0 -- 0x558711ba9730
2019-01-31 17:43:00.174036 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 mark_down 0x558711b9df20 -- 0x558711b9cc10
2019-01-31 17:43:00.174213 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 mark_down 0x558711b9fd00 -- 0x558711ba0720
2019-01-31 17:43:00.174595 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 mark_down 0x558711b8fcc0 -- 0x558711b97650
2019-01-31 17:43:00.175028 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 mark_down_all
2019-01-31 17:43:00.175509 7f7a17d989c0 1 -- 172.23.18.112:0/3007987558 shutdown complete.
[cephuser@zabbix-client ~]$


(2-2/2)