Project

General

Profile

Bug #14662 ยป client.radosgw.gateway.log

Yusuke Tanimura, 02/05/2016 03:08 AM

 
2016-01-27 11:16:41.217059 7f9710d6e840 0 ceph version 0.94.5 (9764da52395923e0b32908d83a9f7304401fee43), process radosgw, pid 13182
2016-01-27 11:16:41.852076 7f9710d6e840 0 framework: civetweb
2016-01-27 11:16:41.852114 7f9710d6e840 0 framework conf key: port, val: 80
2016-01-27 11:16:41.852128 7f9710d6e840 0 framework: civetweb
2016-01-27 11:16:41.852176 7f9710d6e840 0 framework conf key: port, val: 443s
2016-01-27 11:16:41.852192 7f9710d6e840 0 framework conf key: ssl_certificate, val: /home/hama/cert02.pem
2016-01-27 11:16:41.852205 7f9710d6e840 0 starting handler: civetweb
2016-01-27 11:16:41.853762 7f9710d6e840 0 starting handler: civetweb
2016-01-27 11:17:05.311209 7f96dbfff700 1 handle_sigterm
2016-01-27 11:17:05.311238 7f96dbfff700 1 handle_sigterm set alarm for 120
2016-01-27 11:17:05.311271 7f9710d6e840 -1 shutting down
2016-01-27 11:17:05.712994 7f96a8f99700 -1 *** Caught signal (Segmentation fault) **
in thread 7f96a8f99700

ceph version 0.94.5 (9764da52395923e0b32908d83a9f7304401fee43)
1: /usr/bin/radosgw() [0x6b712a]
2: (()+0x10340) [0x7f970d66c340]
3: (pthread_mutex_destroy()+0) [0x7f970d6663e0]
4: /usr/bin/radosgw() [0x67e996]
5: (()+0x8182) [0x7f970d664182]
6: (clone()+0x6d) [0x7f970bdbd47d]
NOTE: a copy of the executable, or `objdump -rdS <executable>` is needed to interpret this.

--- begin dump of recent events ---
-431> 2016-01-27 11:16:41.215802 7f9710d6e840 5 asok(0x3ebaf20) register_command perfcounters_dump hook 0x3ebd0b0
-430> 2016-01-27 11:16:41.215818 7f9710d6e840 5 asok(0x3ebaf20) register_command 1 hook 0x3ebd0b0
-429> 2016-01-27 11:16:41.215820 7f9710d6e840 5 asok(0x3ebaf20) register_command perf dump hook 0x3ebd0b0
-428> 2016-01-27 11:16:41.215823 7f9710d6e840 5 asok(0x3ebaf20) register_command perfcounters_schema hook 0x3ebd0b0
-427> 2016-01-27 11:16:41.215825 7f9710d6e840 5 asok(0x3ebaf20) register_command 2 hook 0x3ebd0b0
-426> 2016-01-27 11:16:41.215827 7f9710d6e840 5 asok(0x3ebaf20) register_command perf schema hook 0x3ebd0b0
-425> 2016-01-27 11:16:41.215829 7f9710d6e840 5 asok(0x3ebaf20) register_command perf reset hook 0x3ebd0b0
-424> 2016-01-27 11:16:41.215830 7f9710d6e840 5 asok(0x3ebaf20) register_command config show hook 0x3ebd0b0
-423> 2016-01-27 11:16:41.215832 7f9710d6e840 5 asok(0x3ebaf20) register_command config set hook 0x3ebd0b0
-422> 2016-01-27 11:16:41.215833 7f9710d6e840 5 asok(0x3ebaf20) register_command config get hook 0x3ebd0b0
-421> 2016-01-27 11:16:41.215834 7f9710d6e840 5 asok(0x3ebaf20) register_command config diff hook 0x3ebd0b0
-420> 2016-01-27 11:16:41.215835 7f9710d6e840 5 asok(0x3ebaf20) register_command log flush hook 0x3ebd0b0
-419> 2016-01-27 11:16:41.215838 7f9710d6e840 5 asok(0x3ebaf20) register_command log dump hook 0x3ebd0b0
-418> 2016-01-27 11:16:41.215839 7f9710d6e840 5 asok(0x3ebaf20) register_command log reopen hook 0x3ebd0b0
-417> 2016-01-27 11:16:41.217059 7f9710d6e840 0 ceph version 0.94.5 (9764da52395923e0b32908d83a9f7304401fee43), process radosgw, pid 13182
-416> 2016-01-27 11:16:41.217924 7f9710d6e840 5 asok(0x3ebaf20) init /var/run/ceph/ceph-client.radosgw.gateway.asok
-415> 2016-01-27 11:16:41.217931 7f9710d6e840 5 asok(0x3ebaf20) bind_and_listen /var/run/ceph/ceph-client.radosgw.gateway.asok
-414> 2016-01-27 11:16:41.217947 7f9710d6e840 5 asok(0x3ebaf20) register_command 0 hook 0x3f0d660
-413> 2016-01-27 11:16:41.217949 7f9710d6e840 5 asok(0x3ebaf20) register_command version hook 0x3f0d660
-412> 2016-01-27 11:16:41.217951 7f9710d6e840 5 asok(0x3ebaf20) register_command git_version hook 0x3f0d660
-411> 2016-01-27 11:16:41.217954 7f9710d6e840 5 asok(0x3ebaf20) register_command help hook 0x3ec0c40
-410> 2016-01-27 11:16:41.217955 7f9710d6e840 5 asok(0x3ebaf20) register_command get_command_descriptions hook 0x3f0e2c0
-409> 2016-01-27 11:16:41.219244 7f9710d6e840 10 monclient(hunting): build_initial_monmap
-408> 2016-01-27 11:16:41.219295 7f9710d6e840 1 librados: starting msgr at :/0
-407> 2016-01-27 11:16:41.219300 7f9710d6e840 1 librados: starting objecter
-406> 2016-01-27 11:16:41.219340 7f9710d6e840 5 asok(0x3ebaf20) register_command objecter_requests hook 0x3f0ffe0
-405> 2016-01-27 11:16:41.219392 7f9710d6e840 1 -- :/0 messenger.start
-404> 2016-01-27 11:16:41.219410 7f9710d6e840 1 librados: setting wanted keys
-403> 2016-01-27 11:16:41.219411 7f9710d6e840 1 librados: calling monclient init
-402> 2016-01-27 11:16:41.219414 7f9710d6e840 10 monclient(hunting): init
-401> 2016-01-27 11:16:41.219419 7f9710d6e840 5 adding auth protocol: cephx
-400> 2016-01-27 11:16:41.219422 7f9710d6e840 10 monclient(hunting): auth_supported 2 method cephx
-399> 2016-01-27 11:16:41.219592 7f9710d6e840 2 auth: KeyRing::load: loaded key file /etc/ceph/ceph.client.radosgw.keyring
-398> 2016-01-27 11:16:41.219634 7f9710d6e840 10 monclient(hunting): _reopen_session rank -1 name
-397> 2016-01-27 11:16:41.219666 7f9710d6e840 10 monclient(hunting): picked mon.noname-a con 0x3f4b8c0 addr 10.0.2.15:6789/0
-396> 2016-01-27 11:16:41.219675 7f9710d6e840 10 monclient(hunting): _send_mon_message to mon.noname-a at 10.0.2.15:6789/0
-395> 2016-01-27 11:16:41.219677 7f9710d6e840 1 -- :/1013182 --> 10.0.2.15:6789/0 -- auth(proto 0 40 bytes epoch 0) v1 -- ?+0 0x3f4bd50 con 0x3f4b8c0
-394> 2016-01-27 11:16:41.219684 7f9710d6e840 10 monclient(hunting): renew_subs
-393> 2016-01-27 11:16:41.219686 7f9710d6e840 10 monclient(hunting): authenticate will time out at 2016-01-27 11:21:41.219686
-392> 2016-01-27 11:16:41.219760 7f9704858700 5 asok(0x3ebaf20) entry start
-391> 2016-01-27 11:16:41.219959 7f9710d6c700 1 -- 10.0.2.15:0/1013182 learned my addr 10.0.2.15:0/1013182
-390> 2016-01-27 11:16:41.220254 7f970301a700 1 -- 10.0.2.15:0/1013182 <== mon.0 10.0.2.15:6789/0 1 ==== mon_map magic: 0 v1 ==== 194+0+0 (855210083 0 0) 0x7f96ec000af0 con 0x3f4b8c0
-389> 2016-01-27 11:16:41.220278 7f970301a700 10 monclient(hunting): handle_monmap mon_map magic: 0 v1
-388> 2016-01-27 11:16:41.220281 7f970301a700 10 monclient(hunting): got monmap 1, mon.noname-a is now rank -1
-387> 2016-01-27 11:16:41.220282 7f970301a700 10 monclient(hunting): dump:
epoch 1
fsid 3b47a58f-97de-4d79-9503-98824ad13cad
last_changed 2016-01-12 10:58:35.494296
created 2016-01-12 10:58:35.494296
0: 10.0.2.15:6789/0 mon.v-ub

-386> 2016-01-27 11:16:41.220324 7f970301a700 1 -- 10.0.2.15:0/1013182 <== mon.0 10.0.2.15:6789/0 2 ==== auth_reply(proto 2 0 (0) Success) v1 ==== 33+0+0 (1918751906 0 0) 0x7f96ec000eb0 con 0x3f4b8c0
-385> 2016-01-27 11:16:41.220344 7f970301a700 10 monclient(hunting): my global_id is 34130
-384> 2016-01-27 11:16:41.220429 7f970301a700 10 monclient(hunting): _send_mon_message to mon.v-ub at 10.0.2.15:6789/0
-383> 2016-01-27 11:16:41.220432 7f970301a700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6789/0 -- auth(proto 2 32 bytes epoch 0) v1 -- ?+0 0x7f96f00012a0 con 0x3f4b8c0
-382> 2016-01-27 11:16:41.220629 7f970301a700 1 -- 10.0.2.15:0/1013182 <== mon.0 10.0.2.15:6789/0 3 ==== auth_reply(proto 2 0 (0) Success) v1 ==== 222+0+0 (3225448281 0 0) 0x7f96ec000b10 con 0x3f4b8c0
-381> 2016-01-27 11:16:41.220688 7f970301a700 10 monclient(hunting): _send_mon_message to mon.v-ub at 10.0.2.15:6789/0
-380> 2016-01-27 11:16:41.220695 7f970301a700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6789/0 -- auth(proto 2 181 bytes epoch 0) v1 -- ?+0 0x7f96f0002090 con 0x3f4b8c0
-379> 2016-01-27 11:16:41.220902 7f970301a700 1 -- 10.0.2.15:0/1013182 <== mon.0 10.0.2.15:6789/0 4 ==== auth_reply(proto 2 0 (0) Success) v1 ==== 425+0+0 (2113848310 0 0) 0x7f96ec0010b0 con 0x3f4b8c0
-378> 2016-01-27 11:16:41.220940 7f970301a700 1 monclient(hunting): found mon.v-ub
-377> 2016-01-27 11:16:41.220945 7f970301a700 10 monclient: _send_mon_message to mon.v-ub at 10.0.2.15:6789/0
-376> 2016-01-27 11:16:41.220949 7f970301a700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6789/0 -- mon_subscribe({monmap=0+}) v2 -- ?+0 0x3f49010 con 0x3f4b8c0
-375> 2016-01-27 11:16:41.220970 7f9710d6e840 5 monclient: authenticate success, global_id 34130
-374> 2016-01-27 11:16:41.220978 7f9710d6e840 10 monclient: renew_subs
-373> 2016-01-27 11:16:41.220979 7f9710d6e840 10 monclient: _send_mon_message to mon.v-ub at 10.0.2.15:6789/0
-372> 2016-01-27 11:16:41.220980 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6789/0 -- mon_subscribe({monmap=2+,osdmap=0}) v2 -- ?+0 0x3f492d0 con 0x3f4b8c0
-371> 2016-01-27 11:16:41.221125 7f9710d6e840 10 monclient: renew_subs
-370> 2016-01-27 11:16:41.221128 7f9710d6e840 10 monclient: _send_mon_message to mon.v-ub at 10.0.2.15:6789/0
-369> 2016-01-27 11:16:41.221130 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6789/0 -- mon_subscribe({monmap=2+,osdmap=0}) v2 -- ?+0 0x3f4d250 con 0x3f4b8c0
-368> 2016-01-27 11:16:41.221140 7f9710d6e840 1 librados: init done
-367> 2016-01-27 11:16:41.221448 7f970301a700 1 -- 10.0.2.15:0/1013182 <== mon.0 10.0.2.15:6789/0 5 ==== mon_map magic: 0 v1 ==== 194+0+0 (855210083 0 0) 0x7f96ec0010b0 con 0x3f4b8c0
-366> 2016-01-27 11:16:41.221459 7f970301a700 10 monclient: handle_monmap mon_map magic: 0 v1
-365> 2016-01-27 11:16:41.221464 7f970301a700 10 monclient: got monmap 1, mon.v-ub is now rank 0
-364> 2016-01-27 11:16:41.221467 7f970301a700 10 monclient: dump:
epoch 1
fsid 3b47a58f-97de-4d79-9503-98824ad13cad
last_changed 2016-01-12 10:58:35.494296
created 2016-01-12 10:58:35.494296
0: 10.0.2.15:6789/0 mon.v-ub

-363> 2016-01-27 11:16:41.221503 7f970301a700 1 -- 10.0.2.15:0/1013182 <== mon.0 10.0.2.15:6789/0 6 ==== mon_subscribe_ack(300s) v1 ==== 20+0+0 (3851642343 0 0) 0x7f96ec0010b0 con 0x3f4b8c0
-362> 2016-01-27 11:16:41.221511 7f970301a700 10 monclient: handle_subscribe_ack sent 2016-01-27 11:16:41.219685 renew after 2016-01-27 11:19:11.219685
-361> 2016-01-27 11:16:41.221540 7f970301a700 1 -- 10.0.2.15:0/1013182 <== mon.0 10.0.2.15:6789/0 7 ==== osd_map(114..114 src has 1..114) v3 ==== 4837+0+0 (243332324 0 0) 0x7f96ec0023a0 con 0x3f4b8c0
-360> 2016-01-27 11:16:41.221705 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:1 default.region [getxattrs,stat] 1.9a566808 ack+read+known_if_redirected e114) v5 -- ?+0 0x3f5a470 con 0x3f59060
-359> 2016-01-27 11:16:41.221740 7f970301a700 1 -- 10.0.2.15:0/1013182 <== mon.0 10.0.2.15:6789/0 8 ==== mon_subscribe_ack(300s) v1 ==== 20+0+0 (3851642343 0 0) 0x7f96ec0010b0 con 0x3f4b8c0
-358> 2016-01-27 11:16:41.221747 7f970301a700 10 monclient: handle_subscribe_ack sent 0.000000, ignoring
-357> 2016-01-27 11:16:41.221766 7f970301a700 1 -- 10.0.2.15:0/1013182 <== mon.0 10.0.2.15:6789/0 9 ==== osd_map(114..114 src has 1..114) v3 ==== 4837+0+0 (243332324 0 0) 0x7f96ec0023a0 con 0x3f4b8c0
-356> 2016-01-27 11:16:41.221783 7f970301a700 1 -- 10.0.2.15:0/1013182 <== mon.0 10.0.2.15:6789/0 10 ==== mon_subscribe_ack(300s) v1 ==== 20+0+0 (3851642343 0 0) 0x7f96ec0010b0 con 0x3f4b8c0
-355> 2016-01-27 11:16:41.221789 7f970301a700 10 monclient: handle_subscribe_ack sent 0.000000, ignoring
-354> 2016-01-27 11:16:41.221799 7f96eaffd700 2 RGWDataChangesLog::ChangesRenewThread: start
-353> 2016-01-27 11:16:41.222543 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 1 ==== osd_op_reply(1 default.region [getxattrs,stat] v0'0 uv2 ondisk = 0) v6 ==== 223+0+20 (1677715541 0 152960122) 0x7f96e0000cc0 con 0x3f59060
-352> 2016-01-27 11:16:41.222597 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:2 default.region [read 0~524288] 1.9a566808 ack+read+known_if_redirected e114) v5 -- ?+0 0x3f5a470 con 0x3f59060
-351> 2016-01-27 11:16:41.222850 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 2 ==== osd_op_reply(2 default.region [read 0~17] v0'0 uv2 ondisk = 0) v6 ==== 181+0+17 (2626652735 0 2082767461) 0x7f96e0000cc0 con 0x3f59060
-350> 2016-01-27 11:16:41.222905 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:3 region_info.default [getxattrs,stat] 1.43611588 ack+read+known_if_redirected e114) v5 -- ?+0 0x3f5a470 con 0x3f59060
-349> 2016-01-27 11:16:41.223154 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 3 ==== osd_op_reply(3 region_info.default [getxattrs,stat] v0'0 uv1 ondisk = 0) v6 ==== 228+0+20 (4215904539 0 835294885) 0x7f96e0000cc0 con 0x3f59060
-348> 2016-01-27 11:16:41.223185 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:4 region_info.default [read 0~524288] 1.43611588 ack+read+known_if_redirected e114) v5 -- ?+0 0x3f5a470 con 0x3f59060
-347> 2016-01-27 11:16:41.223415 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 4 ==== osd_op_reply(4 region_info.default [read 0~153] v0'0 uv1 ondisk = 0) v6 ==== 186+0+153 (932449108 0 2953594856) 0x7f96e00008c0 con 0x3f59060
-346> 2016-01-27 11:16:41.223471 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:5 zone_info.default [getxattrs,stat] 1.e01f9ae ack+read+known_if_redirected e114) v5 -- ?+0 0x3f5b110 con 0x3f59060
-345> 2016-01-27 11:16:41.223720 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 5 ==== osd_op_reply(5 zone_info.default [getxattrs,stat] v0'0 uv1 ondisk = 0) v6 ==== 226+0+20 (1124971298 0 2561144409) 0x7f96e00008c0 con 0x3f59060
-344> 2016-01-27 11:16:41.223751 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:6 zone_info.default [read 0~524288] 1.e01f9ae ack+read+known_if_redirected e114) v5 -- ?+0 0x3f5b110 con 0x3f59060
-343> 2016-01-27 11:16:41.224009 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 6 ==== osd_op_reply(6 zone_info.default [read 0~678] v0'0 uv1 ondisk = 0) v6 ==== 184+0+678 (696917122 0 714617163) 0x7f96e0001bd0 con 0x3f59060
-342> 2016-01-27 11:16:41.224041 7f9710d6e840 2 zone default is master
-341> 2016-01-27 11:16:41.224065 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:7 region_map [getxattrs,stat] 1.bd31b503 ack+read+known_if_redirected e114) v5 -- ?+0 0x3f5bae0 con 0x3f59060
-340> 2016-01-27 11:16:41.224352 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 7 ==== osd_op_reply(7 region_map [getxattrs,stat] v0'0 uv0 ack = -2 ((2) No such file or directory)) v6 ==== 219+0+0 (2120180325 0 0) 0x7f96e00008c0 con 0x3f59060
-339> 2016-01-27 11:16:41.224433 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:8 notify.0 [create 0~0] 2.4322fa9f ondisk+write+known_if_redirected e114) v5 -- ?+0 0x3f5ba00 con 0x3f59060
-338> 2016-01-27 11:16:41.254856 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 8 ==== osd_op_reply(8 notify.0 [create 0~0] v114'73 uv73 ondisk = 0) v6 ==== 175+0+0 (919909557 0 0) 0x7f96e00008c0 con 0x3f59060
-337> 2016-01-27 11:16:41.255023 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:9 notify.0 [watch watch cookie 66434800] 2.4322fa9f ondisk+write+known_if_redirected e114) v5 -- ?+0 0x3f5c320 con 0x3f59060
-336> 2016-01-27 11:16:41.279194 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 9 ==== osd_op_reply(9 notify.0 [watch watch cookie 66434800] v114'74 uv73 ondisk = 0) v6 ==== 175+0+0 (915951511 0 0) 0x7f96e00008c0 con 0x3f59060
-335> 2016-01-27 11:16:41.279516 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- osd_op(client.34130.0:10 notify.1 [create 0~0] 2.16dafda0 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x3f631c0 con 0x3f61e30
-334> 2016-01-27 11:16:41.346126 7f9700411700 1 -- 10.0.2.15:0/1013182 <== osd.2 10.0.2.15:6802/9479 1 ==== osd_op_reply(10 notify.1 [create 0~0] v114'73 uv73 ondisk = 0) v6 ==== 175+0+0 (1400559551 0 0) 0x7f96e00008c0 con 0x3f61e30
-333> 2016-01-27 11:16:41.346300 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- osd_op(client.34130.0:11 notify.1 [watch watch cookie 66466240] 2.16dafda0 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x3f63940 con 0x3f61e30
-332> 2016-01-27 11:16:41.380910 7f9700411700 1 -- 10.0.2.15:0/1013182 <== osd.2 10.0.2.15:6802/9479 2 ==== osd_op_reply(11 notify.1 [watch watch cookie 66466240] v114'74 uv73 ondisk = 0) v6 ==== 175+0+0 (2423396652 0 0) 0x7f96e00008c0 con 0x3f61e30
-331> 2016-01-27 11:16:41.381074 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:12 notify.2 [create 0~0] 2.88aa5c95 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x3f64000 con 0x3f59060
-330> 2016-01-27 11:16:41.464368 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 10 ==== osd_op_reply(12 notify.2 [create 0~0] v114'145 uv145 ondisk = 0) v6 ==== 175+0+0 (1147717469 0 0) 0x7f96e00008c0 con 0x3f59060
-329> 2016-01-27 11:16:41.464548 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:13 notify.2 [watch watch cookie 66469888] 2.88aa5c95 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x3f63940 con 0x3f59060
-328> 2016-01-27 11:16:41.498776 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 11 ==== osd_op_reply(13 notify.2 [watch watch cookie 66469888] v114'146 uv145 ondisk = 0) v6 ==== 175+0+0 (3606799389 0 0) 0x7f96e00008c0 con 0x3f59060
-327> 2016-01-27 11:16:41.498950 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:14 notify.3 [create 0~0] 2.f8c99aee ondisk+write+known_if_redirected e114) v5 -- ?+0 0x3f63940 con 0x3f59060
-326> 2016-01-27 11:16:41.533823 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 12 ==== osd_op_reply(14 notify.3 [create 0~0] v114'73 uv73 ondisk = 0) v6 ==== 175+0+0 (2275395477 0 0) 0x7f96e00008c0 con 0x3f59060
-325> 2016-01-27 11:16:41.534002 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:15 notify.3 [watch watch cookie 66467616] 2.f8c99aee ondisk+write+known_if_redirected e114) v5 -- ?+0 0x3f64aa0 con 0x3f59060
-324> 2016-01-27 11:16:41.568305 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 13 ==== osd_op_reply(15 notify.3 [watch watch cookie 66467616] v114'74 uv73 ondisk = 0) v6 ==== 175+0+0 (3192204864 0 0) 0x7f96e00008c0 con 0x3f59060
-323> 2016-01-27 11:16:41.568505 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:16 notify.4 [create 0~0] 2.a204812d ondisk+write+known_if_redirected e114) v5 -- ?+0 0x3f64880 con 0x3f59060
-322> 2016-01-27 11:16:41.602823 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 14 ==== osd_op_reply(16 notify.4 [create 0~0] v114'147 uv147 ondisk = 0) v6 ==== 175+0+0 (4068567986 0 0) 0x7f96e00008c0 con 0x3f59060
-321> 2016-01-27 11:16:41.602943 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:17 notify.4 [watch watch cookie 66468288] 2.a204812d ondisk+write+known_if_redirected e114) v5 -- ?+0 0x3f65330 con 0x3f59060
-320> 2016-01-27 11:16:41.636521 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 15 ==== osd_op_reply(17 notify.4 [watch watch cookie 66468288] v114'148 uv147 ondisk = 0) v6 ==== 175+0+0 (1597826217 0 0) 0x7f96e00008c0 con 0x3f59060
-319> 2016-01-27 11:16:41.636625 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:18 notify.5 [create 0~0] 2.31099063 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x3f65910 con 0x3f59060
-318> 2016-01-27 11:16:41.672344 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 16 ==== osd_op_reply(18 notify.5 [create 0~0] v114'73 uv73 ondisk = 0) v6 ==== 175+0+0 (2962489280 0 0) 0x7f96e00008c0 con 0x3f59060
-317> 2016-01-27 11:16:41.672521 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:19 notify.5 [watch watch cookie 66472304] 2.31099063 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x3f65b30 con 0x3f59060
-316> 2016-01-27 11:16:41.706829 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 17 ==== osd_op_reply(19 notify.5 [watch watch cookie 66472304] v114'74 uv73 ondisk = 0) v6 ==== 175+0+0 (1175251486 0 0) 0x7f96e00008c0 con 0x3f59060
-315> 2016-01-27 11:16:41.707009 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:20 notify.6 [create 0~0] 2.97c520d4 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x3f66110 con 0x3f59060
-314> 2016-01-27 11:16:41.741400 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 18 ==== osd_op_reply(20 notify.6 [create 0~0] v114'73 uv73 ondisk = 0) v6 ==== 175+0+0 (1920721925 0 0) 0x7f96e00008c0 con 0x3f59060
-313> 2016-01-27 11:16:41.741576 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:21 notify.6 [watch watch cookie 66476304] 2.97c520d4 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x3f66330 con 0x3f59060
-312> 2016-01-27 11:16:41.776422 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 19 ==== osd_op_reply(21 notify.6 [watch watch cookie 66476304] v114'74 uv73 ondisk = 0) v6 ==== 175+0+0 (199223316 0 0) 0x7f96e00008c0 con 0x3f59060
-311> 2016-01-27 11:16:41.776587 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- osd_op(client.34130.0:22 notify.7 [create 0~0] 2.84ada7c9 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x3f66910 con 0x3f61e30
-310> 2016-01-27 11:16:41.808102 7f9700411700 1 -- 10.0.2.15:0/1013182 <== osd.2 10.0.2.15:6802/9479 3 ==== osd_op_reply(22 notify.7 [create 0~0] v114'73 uv73 ondisk = 0) v6 ==== 175+0+0 (1720221506 0 0) 0x7f96e00008c0 con 0x3f61e30
-309> 2016-01-27 11:16:41.808296 7f9710d6e840 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- osd_op(client.34130.0:23 notify.7 [watch watch cookie 66480400] 2.84ada7c9 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x3f66330 con 0x3f61e30
-308> 2016-01-27 11:16:41.842800 7f9700411700 1 -- 10.0.2.15:0/1013182 <== osd.2 10.0.2.15:6802/9479 4 ==== osd_op_reply(23 notify.7 [watch watch cookie 66480400] v114'74 uv73 ondisk = 0) v6 ==== 175+0+0 (1506317323 0 0) 0x7f96e00008c0 con 0x3f61e30
-307> 2016-01-27 11:16:41.842913 7f9710d6e840 2 all 8 watchers are set, enabling cache
-306> 2016-01-27 11:16:41.848236 7f96e8ff9700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- osd_op(client.34130.0:24 [pgls start_epoch 0] 5.0 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96dc001650 con 0x3f61e30
-305> 2016-01-27 11:16:41.849769 7f9700411700 1 -- 10.0.2.15:0/1013182 <== osd.2 10.0.2.15:6802/9479 5 ==== osd_op_reply(24 [pgls start_epoch 0] v0'0 uv0 ondisk = 1) v6 ==== 167+0+44 (3049501340 0 139081063) 0x7f96e00008c0 con 0x3f61e30
-304> 2016-01-27 11:16:41.849889 7f9700411700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:25 [pgls start_epoch 0] 5.1 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e0005310 con 0x3f59060
-303> 2016-01-27 11:16:41.850971 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 20 ==== osd_op_reply(25 [pgls start_epoch 0] v82'1 uv1 ondisk = 1) v6 ==== 167+0+60 (1901944412 0 4218040837) 0x7f96e0005310 con 0x3f59060
-302> 2016-01-27 11:16:41.851574 7f96e9ffb700 2 garbage collection: start
-301> 2016-01-27 11:16:41.851604 7f96e8ff9700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:26 [pgls start_epoch 0] 5.2 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96dc009ae0 con 0x7f96dc003f60
-300> 2016-01-27 11:16:41.851644 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:27 gc.7 [call lock.lock] 4.21d2251d ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4002310 con 0x3f59060
-299> 2016-01-27 11:16:41.852076 7f9710d6e840 0 framework: civetweb
-298> 2016-01-27 11:16:41.852114 7f9710d6e840 0 framework conf key: port, val: 80
-297> 2016-01-27 11:16:41.852128 7f9710d6e840 0 framework: civetweb
-296> 2016-01-27 11:16:41.852176 7f9710d6e840 0 framework conf key: port, val: 443s
-295> 2016-01-27 11:16:41.852192 7f9710d6e840 0 framework conf key: ssl_certificate, val: /home/hama/cert02.pem
-294> 2016-01-27 11:16:41.852205 7f9710d6e840 0 starting handler: civetweb
-293> 2016-01-27 11:16:41.853762 7f9710d6e840 0 starting handler: civetweb
-292> 2016-01-27 11:16:41.857148 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 1 ==== osd_op_reply(26 [pgls start_epoch 0] v0'0 uv0 ondisk = 1) v6 ==== 167+0+44 (2873258949 0 139081063) 0x7f96f4030730 con 0x7f96dc003f60
-291> 2016-01-27 11:16:41.857183 7f970020f700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:28 [pgls start_epoch 0] 5.3 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96f40325b0 con 0x7f96dc003f60
-290> 2016-01-27 11:16:41.857474 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 2 ==== osd_op_reply(28 [pgls start_epoch 0] v0'0 uv0 ondisk = 1) v6 ==== 167+0+44 (653568017 0 139081063) 0x7f96f40325b0 con 0x7f96dc003f60
-289> 2016-01-27 11:16:41.857496 7f970020f700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:29 [pgls start_epoch 0] 5.4 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96f4032c10 con 0x7f96dc003f60
-288> 2016-01-27 11:16:41.857770 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 3 ==== osd_op_reply(29 [pgls start_epoch 0] v0'0 uv0 ondisk = 1) v6 ==== 167+0+44 (2294296622 0 139081063) 0x7f96f40325b0 con 0x7f96dc003f60
-287> 2016-01-27 11:16:41.857792 7f970020f700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:30 [pgls start_epoch 0] 5.5 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96f40322b0 con 0x7f96dc003f60
-286> 2016-01-27 11:16:41.858059 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 4 ==== osd_op_reply(30 [pgls start_epoch 0] v114'18 uv18 ondisk = 1) v6 ==== 167+0+68 (3088027563 0 2793412893) 0x7f96f40322b0 con 0x7f96dc003f60
-285> 2016-01-27 11:16:41.858092 7f96e8ff9700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- osd_op(client.34130.0:31 [pgls start_epoch 0] 5.6 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96dc01fc10 con 0x3f61e30
-284> 2016-01-27 11:16:41.858412 7f9700411700 1 -- 10.0.2.15:0/1013182 <== osd.2 10.0.2.15:6802/9479 6 ==== osd_op_reply(31 [pgls start_epoch 0] v0'0 uv0 ondisk = 1) v6 ==== 167+0+44 (2520904055 0 139081063) 0x7f96e0001230 con 0x3f61e30
-283> 2016-01-27 11:16:41.858430 7f9700411700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:32 [pgls start_epoch 0] 5.7 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e0004270 con 0x7f96dc003f60
-282> 2016-01-27 11:16:41.858700 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 5 ==== osd_op_reply(32 [pgls start_epoch 0] v0'0 uv0 ondisk = 1) v6 ==== 167+0+44 (469183139 0 139081063) 0x7f96f40322b0 con 0x7f96dc003f60
-281> 2016-01-27 11:16:41.858739 7f96e8ff9700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:33 testuser.buckets [call user.get_header] 5.23bd04cd ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96dc038a50 con 0x7f96dc003f60
-280> 2016-01-27 11:16:41.859056 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 6 ==== osd_op_reply(33 testuser.buckets [call] v0'0 uv18 ondisk = 0) v6 ==== 183+0+58 (3859415978 0 2814231482) 0x7f96f40322b0 con 0x7f96dc003f60
-279> 2016-01-27 11:16:41.878319 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 21 ==== osd_op_reply(27 gc.7 [call] v114'2961 uv2961 ondisk = 0) v6 ==== 171+0+0 (2384105998 0 0) 0x7f96e0001230 con 0x3f59060
-278> 2016-01-27 11:16:41.878399 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:34 gc.7 [call rgw.gc_list] 4.21d2251d ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e40636d0 con 0x3f59060
-277> 2016-01-27 11:16:41.879141 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 22 ==== osd_op_reply(34 gc.7 [call] v0'0 uv2961 ondisk = 0) v6 ==== 171+0+11 (1642631009 0 1993775135) 0x7f96e0001230 con 0x3f59060
-276> 2016-01-27 11:16:41.879321 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:35 gc.7 [call lock.unlock] 4.21d2251d ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e40633d0 con 0x3f59060
-275> 2016-01-27 11:16:41.913983 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 23 ==== osd_op_reply(35 gc.7 [call] v114'2962 uv2962 ondisk = 0) v6 ==== 171+0+0 (235779971 0 0) 0x7f96e0001230 con 0x3f59060
-274> 2016-01-27 11:16:41.914160 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:36 gc.8 [call lock.lock] 4.61b8e3df ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4067050 con 0x3f59060
-273> 2016-01-27 11:16:41.948612 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 24 ==== osd_op_reply(36 gc.8 [call] v114'2961 uv2961 ondisk = 0) v6 ==== 171+0+0 (4173577492 0 0) 0x7f96e0001230 con 0x3f59060
-272> 2016-01-27 11:16:41.948748 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:37 gc.8 [call rgw.gc_list] 4.61b8e3df ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4067010 con 0x3f59060
-271> 2016-01-27 11:16:41.949606 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 25 ==== osd_op_reply(37 gc.8 [call] v0'0 uv2961 ondisk = 0) v6 ==== 171+0+11 (389128315 0 1993775135) 0x7f96e0001230 con 0x3f59060
-270> 2016-01-27 11:16:41.949699 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:38 gc.8 [call lock.unlock] 4.61b8e3df ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4067010 con 0x3f59060
-269> 2016-01-27 11:16:41.984280 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 26 ==== osd_op_reply(38 gc.8 [call] v114'2962 uv2962 ondisk = 0) v6 ==== 171+0+0 (2027198617 0 0) 0x7f96e0001230 con 0x3f59060
-268> 2016-01-27 11:16:41.984500 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:39 gc.9 [call lock.lock] 4.3768e783 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4067010 con 0x7f96dc003f60
-267> 2016-01-27 11:16:42.089975 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 7 ==== osd_op_reply(39 gc.9 [call] v114'4441 uv4441 ondisk = 0) v6 ==== 171+0+0 (3348662115 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-266> 2016-01-27 11:16:42.090135 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:40 gc.9 [call rgw.gc_list] 4.3768e783 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4067bd0 con 0x7f96dc003f60
-265> 2016-01-27 11:16:42.091315 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 8 ==== osd_op_reply(40 gc.9 [call] v0'0 uv4441 ondisk = 0) v6 ==== 171+0+11 (197035441 0 1993775135) 0x7f96f40322b0 con 0x7f96dc003f60
-264> 2016-01-27 11:16:42.091435 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:41 gc.9 [call lock.unlock] 4.3768e783 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e40670e0 con 0x7f96dc003f60
-263> 2016-01-27 11:16:42.124532 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 9 ==== osd_op_reply(41 gc.9 [call] v114'4442 uv4442 ondisk = 0) v6 ==== 171+0+0 (1200595694 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-262> 2016-01-27 11:16:42.124716 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:42 gc.10 [call lock.lock] 4.eaec33ee ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e40670e0 con 0x7f96dc003f60
-261> 2016-01-27 11:16:42.147842 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 10 ==== osd_op_reply(42 gc.10 [call] v114'5181 uv5181 ondisk = 0) v6 ==== 172+0+0 (1537461914 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-260> 2016-01-27 11:16:42.148046 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:43 gc.10 [call rgw.gc_list] 4.eaec33ee ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e40670e0 con 0x7f96dc003f60
-259> 2016-01-27 11:16:42.149141 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 11 ==== osd_op_reply(43 gc.10 [call] v0'0 uv5181 ondisk = 0) v6 ==== 172+0+11 (4079264029 0 1993775135) 0x7f96f40322b0 con 0x7f96dc003f60
-258> 2016-01-27 11:16:42.149263 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:44 gc.10 [call lock.unlock] 4.eaec33ee ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e40670e0 con 0x7f96dc003f60
-257> 2016-01-27 11:16:42.170396 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 12 ==== osd_op_reply(44 gc.10 [call] v114'5182 uv5182 ondisk = 0) v6 ==== 172+0+0 (3686066967 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-256> 2016-01-27 11:16:42.170561 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:45 gc.11 [call lock.lock] 4.6a0e9a15 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e40670e0 con 0x3f59060
-255> 2016-01-27 11:16:42.202988 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 27 ==== osd_op_reply(45 gc.11 [call] v114'2963 uv2963 ondisk = 0) v6 ==== 172+0+0 (3250877742 0 0) 0x7f96e0001230 con 0x3f59060
-254> 2016-01-27 11:16:42.203154 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:46 gc.11 [call rgw.gc_list] 4.6a0e9a15 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e40670e0 con 0x3f59060
-253> 2016-01-27 11:16:42.204246 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 28 ==== osd_op_reply(46 gc.11 [call] v0'0 uv2963 ondisk = 0) v6 ==== 172+0+11 (369369143 0 1993775135) 0x7f96e0001230 con 0x3f59060
-252> 2016-01-27 11:16:42.204372 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:47 gc.11 [call lock.unlock] 4.6a0e9a15 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4069770 con 0x3f59060
-251> 2016-01-27 11:16:42.237457 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 29 ==== osd_op_reply(47 gc.11 [call] v114'2964 uv2964 ondisk = 0) v6 ==== 172+0+0 (2301993670 0 0) 0x7f96e0001230 con 0x3f59060
-250> 2016-01-27 11:16:42.237631 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:48 gc.12 [call lock.lock] 4.a45046b8 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e40670e0 con 0x7f96dc003f60
-249> 2016-01-27 11:16:42.263237 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 13 ==== osd_op_reply(48 gc.12 [call] v114'2221 uv2221 ondisk = 0) v6 ==== 172+0+0 (3955493257 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-248> 2016-01-27 11:16:42.263403 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:49 gc.12 [call rgw.gc_list] 4.a45046b8 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4069840 con 0x7f96dc003f60
-247> 2016-01-27 11:16:42.264503 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 14 ==== osd_op_reply(49 gc.12 [call] v0'0 uv2221 ondisk = 0) v6 ==== 172+0+11 (1554433028 0 1993775135) 0x7f96f40322b0 con 0x7f96dc003f60
-246> 2016-01-27 11:16:42.264627 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:50 gc.12 [call lock.unlock] 4.a45046b8 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e40671b0 con 0x7f96dc003f60
-245> 2016-01-27 11:16:42.286150 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 15 ==== osd_op_reply(50 gc.12 [call] v114'2222 uv2222 ondisk = 0) v6 ==== 172+0+0 (1809001476 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-244> 2016-01-27 11:16:42.286320 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:51 gc.13 [call lock.lock] 4.48504074 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e40671b0 con 0x3f59060
-243> 2016-01-27 11:16:42.374960 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 30 ==== osd_op_reply(51 gc.13 [call] v114'3701 uv3701 ondisk = 0) v6 ==== 172+0+0 (607490558 0 0) 0x7f96e0001230 con 0x3f59060
-242> 2016-01-27 11:16:42.375023 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:52 gc.13 [call rgw.gc_list] 4.48504074 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e406b0e0 con 0x3f59060
-241> 2016-01-27 11:16:42.375408 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 31 ==== osd_op_reply(52 gc.13 [call] v0'0 uv3701 ondisk = 0) v6 ==== 172+0+11 (2432597482 0 1993775135) 0x7f96e0001230 con 0x3f59060
-240> 2016-01-27 11:16:42.375442 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:53 gc.13 [call lock.unlock] 4.48504074 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e406b0e0 con 0x3f59060
-239> 2016-01-27 11:16:42.409298 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 32 ==== osd_op_reply(53 gc.13 [call] v114'3702 uv3702 ondisk = 0) v6 ==== 172+0+0 (2753737843 0 0) 0x7f96e0001230 con 0x3f59060
-238> 2016-01-27 11:16:42.409374 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:54 gc.14 [call lock.lock] 4.94de7ebe ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e406b0e0 con 0x7f96dc003f60
-237> 2016-01-27 11:16:42.435141 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 16 ==== osd_op_reply(54 gc.14 [call] v114'5183 uv5183 ondisk = 0) v6 ==== 172+0+0 (2455141860 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-236> 2016-01-27 11:16:42.435204 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:55 gc.14 [call rgw.gc_list] 4.94de7ebe ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e406b0e0 con 0x7f96dc003f60
-235> 2016-01-27 11:16:42.435561 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 17 ==== osd_op_reply(55 gc.14 [call] v0'0 uv5183 ondisk = 0) v6 ==== 172+0+11 (48454165 0 1993775135) 0x7f96f40322b0 con 0x7f96dc003f60
-234> 2016-01-27 11:16:42.435595 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:56 gc.14 [call lock.unlock] 4.94de7ebe ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e406bcb0 con 0x7f96dc003f60
-233> 2016-01-27 11:16:42.458235 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 18 ==== osd_op_reply(56 gc.14 [call] v114'5184 uv5184 ondisk = 0) v6 ==== 172+0+0 (2395637154 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-232> 2016-01-27 11:16:42.458300 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:57 gc.15 [call lock.lock] 4.685c6f7 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e406bcb0 con 0x3f59060
-231> 2016-01-27 11:16:42.489975 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 33 ==== osd_op_reply(57 gc.15 [call] v114'2963 uv2963 ondisk = 0) v6 ==== 172+0+0 (2426543336 0 0) 0x7f96e0001230 con 0x3f59060
-230> 2016-01-27 11:16:42.490037 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:58 gc.15 [call rgw.gc_list] 4.685c6f7 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e40671b0 con 0x3f59060
-229> 2016-01-27 11:16:42.490431 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 34 ==== osd_op_reply(58 gc.15 [call] v0'0 uv2963 ondisk = 0) v6 ==== 172+0+11 (1197623793 0 1993775135) 0x7f96e0001230 con 0x3f59060
-228> 2016-01-27 11:16:42.490466 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:59 gc.15 [call lock.unlock] 4.685c6f7 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e40671b0 con 0x3f59060
-227> 2016-01-27 11:16:42.526345 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 35 ==== osd_op_reply(59 gc.15 [call] v114'2964 uv2964 ondisk = 0) v6 ==== 172+0+0 (3629370112 0 0) 0x7f96e0001230 con 0x3f59060
-226> 2016-01-27 11:16:42.526533 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:60 gc.16 [call lock.lock] 4.c2ff39f3 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e40671b0 con 0x7f96dc003f60
-225> 2016-01-27 11:16:42.552156 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 19 ==== osd_op_reply(60 gc.16 [call] v114'4443 uv4443 ondisk = 0) v6 ==== 172+0+0 (2209667507 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-224> 2016-01-27 11:16:42.552341 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:61 gc.16 [call rgw.gc_list] 4.c2ff39f3 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e40671b0 con 0x7f96dc003f60
-223> 2016-01-27 11:16:42.553660 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 20 ==== osd_op_reply(61 gc.16 [call] v0'0 uv4443 ondisk = 0) v6 ==== 172+0+11 (2007012119 0 1993775135) 0x7f96f40322b0 con 0x7f96dc003f60
-222> 2016-01-27 11:16:42.553800 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:62 gc.16 [call lock.unlock] 4.c2ff39f3 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e40671b0 con 0x7f96dc003f60
-221> 2016-01-27 11:16:42.597071 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 21 ==== osd_op_reply(62 gc.16 [call] v114'4444 uv4444 ondisk = 0) v6 ==== 172+0+0 (3410300507 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-220> 2016-01-27 11:16:42.597166 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:63 gc.17 [call lock.lock] 4.fe80bd8c ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e40671b0 con 0x3f59060
-219> 2016-01-27 11:16:42.630422 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 36 ==== osd_op_reply(63 gc.17 [call] v114'3703 uv3703 ondisk = 0) v6 ==== 172+0+0 (4179101499 0 0) 0x7f96e0001230 con 0x3f59060
-218> 2016-01-27 11:16:42.630611 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:64 gc.17 [call rgw.gc_list] 4.fe80bd8c ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e40671b0 con 0x3f59060
-217> 2016-01-27 11:16:42.631272 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 37 ==== osd_op_reply(64 gc.17 [call] v0'0 uv3703 ondisk = 0) v6 ==== 172+0+11 (1977721689 0 1993775135) 0x7f96e0001230 con 0x3f59060
-216> 2016-01-27 11:16:42.631325 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:65 gc.17 [call lock.unlock] 4.fe80bd8c ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e40671b0 con 0x3f59060
-215> 2016-01-27 11:16:42.663624 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 38 ==== osd_op_reply(65 gc.17 [call] v114'3704 uv3704 ondisk = 0) v6 ==== 172+0+0 (633881320 0 0) 0x7f96e0001230 con 0x3f59060
-214> 2016-01-27 11:16:42.663712 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:66 gc.18 [call lock.lock] 4.90752cb4 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e40671b0 con 0x3f59060
-213> 2016-01-27 11:16:42.698326 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 39 ==== osd_op_reply(66 gc.18 [call] v114'3705 uv3705 ondisk = 0) v6 ==== 172+0+0 (1537353482 0 0) 0x7f96e0001230 con 0x3f59060
-212> 2016-01-27 11:16:42.698408 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:67 gc.18 [call rgw.gc_list] 4.90752cb4 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e40671b0 con 0x3f59060
-211> 2016-01-27 11:16:42.699446 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 40 ==== osd_op_reply(67 gc.18 [call] v0'0 uv3705 ondisk = 0) v6 ==== 172+0+11 (2143582762 0 1993775135) 0x7f96e0001230 con 0x3f59060
-210> 2016-01-27 11:16:42.699585 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:68 gc.18 [call lock.unlock] 4.90752cb4 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e40671b0 con 0x3f59060
-209> 2016-01-27 11:16:42.757675 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 41 ==== osd_op_reply(68 gc.18 [call] v114'3706 uv3706 ondisk = 0) v6 ==== 172+0+0 (3686072967 0 0) 0x7f96e0001230 con 0x3f59060
-208> 2016-01-27 11:16:42.757862 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:69 gc.19 [call lock.lock] 4.3abc5326 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e40671b0 con 0x7f96dc003f60
-207> 2016-01-27 11:16:42.793796 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 22 ==== osd_op_reply(69 gc.19 [call] v114'5185 uv5185 ondisk = 0) v6 ==== 172+0+0 (3505744254 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-206> 2016-01-27 11:16:42.793926 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:70 gc.19 [call rgw.gc_list] 4.3abc5326 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e40671b0 con 0x7f96dc003f60
-205> 2016-01-27 11:16:42.795104 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 23 ==== osd_op_reply(70 gc.19 [call] v0'0 uv5185 ondisk = 0) v6 ==== 172+0+11 (3195916520 0 1993775135) 0x7f96f40322b0 con 0x7f96dc003f60
-204> 2016-01-27 11:16:42.795243 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:71 gc.19 [call lock.unlock] 4.3abc5326 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e40671b0 con 0x7f96dc003f60
-203> 2016-01-27 11:16:42.829088 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 24 ==== osd_op_reply(71 gc.19 [call] v114'5186 uv5186 ondisk = 0) v6 ==== 172+0+0 (1357008115 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-202> 2016-01-27 11:16:42.829281 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:72 gc.20 [call lock.lock] 4.9955331c ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e40671b0 con 0x3f59060
-201> 2016-01-27 11:16:42.966508 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 42 ==== osd_op_reply(72 gc.20 [call] v114'3707 uv3707 ondisk = 0) v6 ==== 172+0+0 (3749099047 0 0) 0x7f96e0001230 con 0x3f59060
-200> 2016-01-27 11:16:42.966758 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:73 gc.20 [call rgw.gc_list] 4.9955331c ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4068d80 con 0x3f59060
-199> 2016-01-27 11:16:42.968804 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 43 ==== osd_op_reply(73 gc.20 [call] v0'0 uv3707 ondisk = 0) v6 ==== 172+0+11 (3273827185 0 1993775135) 0x7f96e0001230 con 0x3f59060
-198> 2016-01-27 11:16:42.968979 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:74 gc.20 [call lock.unlock] 4.9955331c ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4068d80 con 0x3f59060
-197> 2016-01-27 11:16:42.999126 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 44 ==== osd_op_reply(74 gc.20 [call] v114'3708 uv3708 ondisk = 0) v6 ==== 172+0+0 (2542232015 0 0) 0x7f96e0001230 con 0x3f59060
-196> 2016-01-27 11:16:42.999357 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:75 gc.21 [call lock.lock] 4.6dc01772 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4068d80 con 0x3f59060
-195> 2016-01-27 11:16:43.034751 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 45 ==== osd_op_reply(75 gc.21 [call] v114'1481 uv1481 ondisk = 0) v6 ==== 172+0+0 (782697437 0 0) 0x7f96e0001230 con 0x3f59060
-194> 2016-01-27 11:16:43.034937 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:76 gc.21 [call rgw.gc_list] 4.6dc01772 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4068d80 con 0x3f59060
-193> 2016-01-27 11:16:43.036370 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 46 ==== osd_op_reply(76 gc.21 [call] v0'0 uv1481 ondisk = 0) v6 ==== 172+0+11 (182057718 0 1993775135) 0x7f96e0001230 con 0x3f59060
-192> 2016-01-27 11:16:43.036501 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:77 gc.21 [call lock.unlock] 4.6dc01772 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4068d80 con 0x3f59060
-191> 2016-01-27 11:16:43.069113 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 47 ==== osd_op_reply(77 gc.21 [call] v114'1482 uv1482 ondisk = 0) v6 ==== 172+0+0 (2930779728 0 0) 0x7f96e0001230 con 0x3f59060
-190> 2016-01-27 11:16:43.069301 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:78 gc.22 [call lock.lock] 4.97748d0d ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4068d80 con 0x3f59060
-189> 2016-01-27 11:16:43.103874 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 48 ==== osd_op_reply(78 gc.22 [call] v114'2965 uv2965 ondisk = 0) v6 ==== 172+0+0 (2431126008 0 0) 0x7f96e0001230 con 0x3f59060
-188> 2016-01-27 11:16:43.104109 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:79 gc.22 [call rgw.gc_list] 4.97748d0d ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e406bcb0 con 0x3f59060
-187> 2016-01-27 11:16:43.105830 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 49 ==== osd_op_reply(79 gc.22 [call] v0'0 uv2965 ondisk = 0) v6 ==== 172+0+11 (259949691 0 1993775135) 0x7f96e0001230 con 0x3f59060
-186> 2016-01-27 11:16:43.105965 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:80 gc.22 [call lock.unlock] 4.97748d0d ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073b50 con 0x3f59060
-185> 2016-01-27 11:16:43.138393 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 50 ==== osd_op_reply(80 gc.22 [call] v114'2966 uv2966 ondisk = 0) v6 ==== 172+0+0 (285158517 0 0) 0x7f96e0001230 con 0x3f59060
-184> 2016-01-27 11:16:43.138608 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:81 gc.23 [call lock.lock] 4.64f84676 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-183> 2016-01-27 11:16:43.175438 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 25 ==== osd_op_reply(81 gc.23 [call] v114'5187 uv5187 ondisk = 0) v6 ==== 172+0+0 (3121015883 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-182> 2016-01-27 11:16:43.175640 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:82 gc.23 [call rgw.gc_list] 4.64f84676 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-181> 2016-01-27 11:16:43.177058 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 26 ==== osd_op_reply(82 gc.23 [call] v0'0 uv5187 ondisk = 0) v6 ==== 172+0+11 (3971751339 0 1993775135) 0x7f96f40322b0 con 0x7f96dc003f60
-180> 2016-01-27 11:16:43.177204 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:83 gc.23 [call lock.unlock] 4.64f84676 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e406bcb0 con 0x7f96dc003f60
-179> 2016-01-27 11:16:43.209864 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 27 ==== osd_op_reply(83 gc.23 [call] v114'5188 uv5188 ondisk = 0) v6 ==== 172+0+0 (4076288931 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-178> 2016-01-27 11:16:43.210069 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:84 gc.24 [call lock.lock] 4.8bdc9d ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x3f59060
-177> 2016-01-27 11:16:43.241369 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 51 ==== osd_op_reply(84 gc.24 [call] v114'2967 uv2967 ondisk = 0) v6 ==== 172+0+0 (2693126454 0 0) 0x7f96e0001230 con 0x3f59060
-176> 2016-01-27 11:16:43.241548 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:85 gc.24 [call rgw.gc_list] 4.8bdc9d ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x3f59060
-175> 2016-01-27 11:16:43.244122 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 52 ==== osd_op_reply(85 gc.24 [call] v0'0 uv2967 ondisk = 0) v6 ==== 172+0+11 (119610563 0 1993775135) 0x7f96e0001230 con 0x3f59060
-174> 2016-01-27 11:16:43.244258 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:86 gc.24 [call lock.unlock] 4.8bdc9d ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x3f59060
-173> 2016-01-27 11:16:43.334448 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 53 ==== osd_op_reply(86 gc.24 [call] v114'2968 uv2968 ondisk = 0) v6 ==== 172+0+0 (2085985509 0 0) 0x7f96e0001230 con 0x3f59060
-172> 2016-01-27 11:16:43.334633 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:87 gc.25 [call lock.lock] 4.51baec8a ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x3f59060
-171> 2016-01-27 11:16:43.369388 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 54 ==== osd_op_reply(87 gc.25 [call] v114'1483 uv1483 ondisk = 0) v6 ==== 172+0+0 (3724304140 0 0) 0x7f96e0001230 con 0x3f59060
-170> 2016-01-27 11:16:43.369596 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:88 gc.25 [call rgw.gc_list] 4.51baec8a ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x3f59060
-169> 2016-01-27 11:16:43.371174 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 55 ==== osd_op_reply(88 gc.25 [call] v0'0 uv1483 ondisk = 0) v6 ==== 172+0+11 (3249598033 0 1993775135) 0x7f96e0001230 con 0x3f59060
-168> 2016-01-27 11:16:43.371303 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:89 gc.25 [call lock.unlock] 4.51baec8a ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x3f59060
-167> 2016-01-27 11:16:43.403853 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 56 ==== osd_op_reply(89 gc.25 [call] v114'1484 uv1484 ondisk = 0) v6 ==== 172+0+0 (2500692196 0 0) 0x7f96e0001230 con 0x3f59060
-166> 2016-01-27 11:16:43.404120 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:90 gc.26 [call lock.lock] 4.386217e ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-165> 2016-01-27 11:16:43.440855 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 28 ==== osd_op_reply(90 gc.26 [call] v114'5189 uv5189 ondisk = 0) v6 ==== 172+0+0 (4164954049 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-164> 2016-01-27 11:16:43.441057 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:91 gc.26 [call rgw.gc_list] 4.386217e ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-163> 2016-01-27 11:16:43.442414 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 29 ==== osd_op_reply(91 gc.26 [call] v0'0 uv5189 ondisk = 0) v6 ==== 172+0+11 (3870035643 0 1993775135) 0x7f96f40322b0 con 0x7f96dc003f60
-162> 2016-01-27 11:16:43.442590 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:92 gc.26 [call lock.unlock] 4.386217e ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-161> 2016-01-27 11:16:43.475470 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 30 ==== osd_op_reply(92 gc.26 [call] v114'5190 uv5190 ondisk = 0) v6 ==== 172+0+0 (2018968140 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-160> 2016-01-27 11:16:43.475686 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:93 gc.27 [call lock.lock] 4.eba9ff7b ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-159> 2016-01-27 11:16:43.578863 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 31 ==== osd_op_reply(93 gc.27 [call] v114'4445 uv4445 ondisk = 0) v6 ==== 172+0+0 (1228845301 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-158> 2016-01-27 11:16:43.579076 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:94 gc.27 [call rgw.gc_list] 4.eba9ff7b ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-157> 2016-01-27 11:16:43.580476 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 32 ==== osd_op_reply(94 gc.27 [call] v0'0 uv4445 ondisk = 0) v6 ==== 172+0+11 (4118553291 0 1993775135) 0x7f96f40322b0 con 0x7f96dc003f60
-156> 2016-01-27 11:16:43.580631 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:95 gc.27 [call lock.unlock] 4.eba9ff7b ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-155> 2016-01-27 11:16:43.613890 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 33 ==== osd_op_reply(95 gc.27 [call] v114'4446 uv4446 ondisk = 0) v6 ==== 172+0+0 (3374945656 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-154> 2016-01-27 11:16:43.614106 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:96 gc.28 [call lock.lock] 4.4070ac6b ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-153> 2016-01-27 11:16:43.648772 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 34 ==== osd_op_reply(96 gc.28 [call] v114'4447 uv4447 ondisk = 0) v6 ==== 172+0+0 (3973482537 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-152> 2016-01-27 11:16:43.648975 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:97 gc.28 [call rgw.gc_list] 4.4070ac6b ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-151> 2016-01-27 11:16:43.650331 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 35 ==== osd_op_reply(97 gc.28 [call] v0'0 uv4447 ondisk = 0) v6 ==== 172+0+11 (1755730529 0 1993775135) 0x7f96f40322b0 con 0x7f96dc003f60
-150> 2016-01-27 11:16:43.650464 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:98 gc.28 [call lock.unlock] 4.4070ac6b ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-149> 2016-01-27 11:16:43.683317 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 36 ==== osd_op_reply(98 gc.28 [call] v114'4448 uv4448 ondisk = 0) v6 ==== 172+0+0 (1190607475 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-148> 2016-01-27 11:16:43.683534 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:99 gc.29 [call lock.lock] 4.65639084 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x3f59060
-147> 2016-01-27 11:16:43.715356 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 57 ==== osd_op_reply(99 gc.29 [call] v114'3709 uv3709 ondisk = 0) v6 ==== 172+0+0 (3151948376 0 0) 0x7f96e0001230 con 0x3f59060
-146> 2016-01-27 11:16:43.715536 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:100 gc.29 [call rgw.gc_list] 4.65639084 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x3f59060
-145> 2016-01-27 11:16:43.717279 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 58 ==== osd_op_reply(100 gc.29 [call] v0'0 uv3709 ondisk = 0) v6 ==== 172+0+11 (4024182676 0 1993775135) 0x7f96e0001230 con 0x3f59060
-144> 2016-01-27 11:16:43.717410 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:101 gc.29 [call lock.unlock] 4.65639084 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x3f59060
-143> 2016-01-27 11:16:43.750027 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 59 ==== osd_op_reply(101 gc.29 [call] v114'3710 uv3710 ondisk = 0) v6 ==== 172+0+0 (1003081685 0 0) 0x7f96e0001230 con 0x3f59060
-142> 2016-01-27 11:16:43.750218 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:102 gc.30 [call lock.lock] 4.36574d2e ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-141> 2016-01-27 11:16:43.787428 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 37 ==== osd_op_reply(102 gc.30 [call] v114'5191 uv5191 ondisk = 0) v6 ==== 172+0+0 (1257375040 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-140> 2016-01-27 11:16:43.787608 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:103 gc.30 [call rgw.gc_list] 4.36574d2e ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-139> 2016-01-27 11:16:43.789017 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 38 ==== osd_op_reply(103 gc.30 [call] v0'0 uv5191 ondisk = 0) v6 ==== 172+0+11 (1814848588 0 1993775135) 0x7f96f40322b0 con 0x7f96dc003f60
-138> 2016-01-27 11:16:43.789145 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:104 gc.30 [call lock.unlock] 4.36574d2e ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-137> 2016-01-27 11:16:43.821823 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 39 ==== osd_op_reply(104 gc.30 [call] v114'5192 uv5192 ondisk = 0) v6 ==== 172+0+0 (2518827155 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-136> 2016-01-27 11:16:43.822052 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:105 gc.31 [call lock.lock] 4.1040a0a3 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-135> 2016-01-27 11:16:43.855932 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 40 ==== osd_op_reply(105 gc.31 [call] v114'4449 uv4449 ondisk = 0) v6 ==== 172+0+0 (1869039038 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-134> 2016-01-27 11:16:43.856116 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:106 gc.31 [call rgw.gc_list] 4.1040a0a3 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-133> 2016-01-27 11:16:43.857278 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 41 ==== osd_op_reply(106 gc.31 [call] v0'0 uv4449 ondisk = 0) v6 ==== 172+0+11 (182865798 0 1993775135) 0x7f96f40322b0 con 0x7f96dc003f60
-132> 2016-01-27 11:16:43.857383 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:107 gc.31 [call lock.unlock] 4.1040a0a3 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-131> 2016-01-27 11:16:43.890650 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 42 ==== osd_op_reply(107 gc.31 [call] v114'4450 uv4450 ondisk = 0) v6 ==== 172+0+0 (4017119283 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-130> 2016-01-27 11:16:43.890926 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:108 gc.0 [call lock.lock] 4.990e66d8 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e406bcb0 con 0x7f96dc003f60
-129> 2016-01-27 11:16:43.925960 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 43 ==== osd_op_reply(108 gc.0 [call] v114'2223 uv2223 ondisk = 0) v6 ==== 171+0+0 (1785160478 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-128> 2016-01-27 11:16:43.926139 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:109 gc.0 [call rgw.gc_list] 4.990e66d8 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-127> 2016-01-27 11:16:43.927260 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 44 ==== osd_op_reply(109 gc.0 [call] v0'0 uv2223 ondisk = 0) v6 ==== 171+0+11 (3845646053 0 1993775135) 0x7f96f40322b0 con 0x7f96dc003f60
-126> 2016-01-27 11:16:43.927343 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:110 gc.0 [call lock.unlock] 4.990e66d8 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-125> 2016-01-27 11:16:43.959673 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 45 ==== osd_op_reply(110 gc.0 [call] v114'2224 uv2224 ondisk = 0) v6 ==== 171+0+0 (2602071114 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-124> 2016-01-27 11:16:43.959892 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:111 gc.1 [call lock.lock] 4.6830fb87 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x3f59060
-123> 2016-01-27 11:16:44.092049 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 60 ==== osd_op_reply(111 gc.1 [call] v114'2965 uv2965 ondisk = 0) v6 ==== 171+0+0 (2300189965 0 0) 0x7f96e0001230 con 0x3f59060
-122> 2016-01-27 11:16:44.092237 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:112 gc.1 [call rgw.gc_list] 4.6830fb87 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x3f59060
-121> 2016-01-27 11:16:44.094571 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 61 ==== osd_op_reply(112 gc.1 [call] v0'0 uv2965 ondisk = 0) v6 ==== 171+0+11 (378310798 0 1993775135) 0x7f96e0001230 con 0x3f59060
-120> 2016-01-27 11:16:44.094780 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:113 gc.1 [call lock.unlock] 4.6830fb87 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x3f59060
-119> 2016-01-27 11:16:44.142486 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 62 ==== osd_op_reply(113 gc.1 [call] v114'2966 uv2966 ondisk = 0) v6 ==== 171+0+0 (151861376 0 0) 0x7f96e0001230 con 0x3f59060
-118> 2016-01-27 11:16:44.142780 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:114 gc.2 [call lock.lock] 4.3b1b8c5b ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-117> 2016-01-27 11:16:44.202860 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 46 ==== osd_op_reply(114 gc.2 [call] v114'4451 uv4451 ondisk = 0) v6 ==== 171+0+0 (872808614 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-116> 2016-01-27 11:16:44.203034 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:115 gc.2 [call rgw.gc_list] 4.3b1b8c5b ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-115> 2016-01-27 11:16:44.204563 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 47 ==== osd_op_reply(115 gc.2 [call] v0'0 uv4451 ondisk = 0) v6 ==== 171+0+11 (1773486824 0 1993775135) 0x7f96f40322b0 con 0x7f96dc003f60
-114> 2016-01-27 11:16:44.204693 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:116 gc.2 [call lock.unlock] 4.3b1b8c5b ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-113> 2016-01-27 11:16:44.219778 7f9701817700 10 monclient: tick
-112> 2016-01-27 11:16:44.219831 7f9701817700 10 monclient: renew subs? (now: 2016-01-27 11:16:44.219830; renew after: 2016-01-27 11:19:11.219685) -- no
-111> 2016-01-27 11:16:44.237538 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 48 ==== osd_op_reply(116 gc.2 [call] v114'4452 uv4452 ondisk = 0) v6 ==== 171+0+0 (2096617294 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-110> 2016-01-27 11:16:44.237727 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:117 gc.3 [call lock.lock] 4.7820b530 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-109> 2016-01-27 11:16:44.272408 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 49 ==== osd_op_reply(117 gc.3 [call] v114'2225 uv2225 ondisk = 0) v6 ==== 171+0+0 (3481015783 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-108> 2016-01-27 11:16:44.272587 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:118 gc.3 [call rgw.gc_list] 4.7820b530 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-107> 2016-01-27 11:16:44.273971 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 50 ==== osd_op_reply(118 gc.3 [call] v0'0 uv2225 ondisk = 0) v6 ==== 171+0+11 (751655967 0 1993775135) 0x7f96f40322b0 con 0x7f96dc003f60
-106> 2016-01-27 11:16:44.274103 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:119 gc.3 [call lock.unlock] 4.7820b530 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-105> 2016-01-27 11:16:44.305187 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 51 ==== osd_op_reply(119 gc.3 [call] v114'2226 uv2226 ondisk = 0) v6 ==== 171+0+0 (1332424810 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-104> 2016-01-27 11:16:44.305262 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- osd_op(client.34130.0:120 gc.4 [call lock.lock] 4.370bf669 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x3f61e30
-103> 2016-01-27 11:16:44.356116 7f9700411700 1 -- 10.0.2.15:0/1013182 <== osd.2 10.0.2.15:6802/9479 7 ==== osd_op_reply(120 gc.4 [call] v114'741 uv741 ondisk = 0) v6 ==== 171+0+0 (717316953 0 0) 0x7f96e0067f60 con 0x3f61e30
-102> 2016-01-27 11:16:44.356182 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- osd_op(client.34130.0:121 gc.4 [call rgw.gc_list] 4.370bf669 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x3f61e30
-101> 2016-01-27 11:16:44.356596 7f9700411700 1 -- 10.0.2.15:0/1013182 <== osd.2 10.0.2.15:6802/9479 8 ==== osd_op_reply(121 gc.4 [call] v0'0 uv741 ondisk = 0) v6 ==== 171+0+11 (1803151440 0 1993775135) 0x7f96e006e050 con 0x3f61e30
-100> 2016-01-27 11:16:44.356626 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- osd_op(client.34130.0:122 gc.4 [call lock.unlock] 4.370bf669 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x3f61e30
-99> 2016-01-27 11:16:44.391325 7f9700411700 1 -- 10.0.2.15:0/1013182 <== osd.2 10.0.2.15:6802/9479 9 ==== osd_op_reply(122 gc.4 [call] v114'742 uv742 ondisk = 0) v6 ==== 171+0+0 (2866169556 0 0) 0x7f96e0068180 con 0x3f61e30
-98> 2016-01-27 11:16:44.391520 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:123 gc.5 [call lock.lock] 4.15a298d6 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-97> 2016-01-27 11:16:44.422150 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 52 ==== osd_op_reply(123 gc.5 [call] v114'5193 uv5193 ondisk = 0) v6 ==== 171+0+0 (3612933709 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-96> 2016-01-27 11:16:44.422329 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:124 gc.5 [call rgw.gc_list] 4.15a298d6 ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-95> 2016-01-27 11:16:44.423760 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 53 ==== osd_op_reply(124 gc.5 [call] v0'0 uv5193 ondisk = 0) v6 ==== 171+0+11 (1494836739 0 1993775135) 0x7f96f40322b0 con 0x7f96dc003f60
-94> 2016-01-27 11:16:44.423892 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6800/9219 -- osd_op(client.34130.0:125 gc.5 [call lock.unlock] 4.15a298d6 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x7f96dc003f60
-93> 2016-01-27 11:16:44.456772 7f970020f700 1 -- 10.0.2.15:0/1013182 <== osd.0 10.0.2.15:6800/9219 54 ==== osd_op_reply(125 gc.5 [call] v114'5194 uv5194 ondisk = 0) v6 ==== 171+0+0 (1464851392 0 0) 0x7f96f40322b0 con 0x7f96dc003f60
-92> 2016-01-27 11:16:44.456961 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:126 gc.6 [call lock.lock] 4.170a8acf ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x3f59060
-91> 2016-01-27 11:16:44.488539 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 63 ==== osd_op_reply(126 gc.6 [call] v114'2967 uv2967 ondisk = 0) v6 ==== 171+0+0 (875371419 0 0) 0x7f96e0068180 con 0x3f59060
-90> 2016-01-27 11:16:44.488767 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:127 gc.6 [call rgw.gc_list] 4.170a8acf ack+read+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x3f59060
-89> 2016-01-27 11:16:44.490312 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 64 ==== osd_op_reply(127 gc.6 [call] v0'0 uv2967 ondisk = 0) v6 ==== 171+0+11 (2475286126 0 1993775135) 0x7f96e0068180 con 0x3f59060
-88> 2016-01-27 11:16:44.490447 7f96e9ffb700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:128 gc.6 [call lock.unlock] 4.170a8acf ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96e4073a80 con 0x3f59060
-87> 2016-01-27 11:16:44.521600 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 65 ==== osd_op_reply(128 gc.6 [call] v114'2968 uv2968 ondisk = 0) v6 ==== 171+0+0 (3908918856 0 0) 0x7f96e0068180 con 0x3f59060
-86> 2016-01-27 11:16:44.521644 7f96e9ffb700 2 garbage collection: stop
-85> 2016-01-27 11:16:46.221315 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:129 notify.0 [watch ping cookie 66434800] 2.4322fa9f ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc01fc10 con 0x3f59060
-84> 2016-01-27 11:16:46.221430 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:130 notify.2 [watch ping cookie 66469888] 2.88aa5c95 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc0008c0 con 0x3f59060
-83> 2016-01-27 11:16:46.221461 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:131 notify.3 [watch ping cookie 66467616] 2.f8c99aee ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc0022a0 con 0x3f59060
-82> 2016-01-27 11:16:46.221482 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:132 notify.4 [watch ping cookie 66468288] 2.a204812d ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc002b70 con 0x3f59060
-81> 2016-01-27 11:16:46.221505 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:133 notify.5 [watch ping cookie 66472304] 2.31099063 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc020350 con 0x3f59060
-80> 2016-01-27 11:16:46.221527 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:134 notify.6 [watch ping cookie 66476304] 2.97c520d4 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc020c50 con 0x3f59060
-79> 2016-01-27 11:16:46.221551 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- osd_op(client.34130.0:135 notify.1 [watch ping cookie 66466240] 2.16dafda0 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc021aa0 con 0x3f61e30
-78> 2016-01-27 11:16:46.221579 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- osd_op(client.34130.0:136 notify.7 [watch ping cookie 66480400] 2.84ada7c9 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc022410 con 0x3f61e30
-77> 2016-01-27 11:16:46.221602 7f970381b700 10 monclient: renew_subs
-76> 2016-01-27 11:16:46.221609 7f970381b700 10 monclient: _send_mon_message to mon.v-ub at 10.0.2.15:6789/0
-75> 2016-01-27 11:16:46.221615 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6789/0 -- mon_subscribe({monmap=2+,osdmap=115}) v2 -- ?+0 0x7f96dc022ab0 con 0x3f4b8c0
-74> 2016-01-27 11:16:46.221635 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- ping magic: 0 v1 -- ?+0 0x7f96dc06c050 con 0x3f59060
-73> 2016-01-27 11:16:46.221647 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- ping magic: 0 v1 -- ?+0 0x7f96dc06c340 con 0x3f61e30
-72> 2016-01-27 11:16:46.226087 7f9700411700 1 -- 10.0.2.15:0/1013182 <== osd.2 10.0.2.15:6802/9479 10 ==== osd_op_reply(135 notify.1 [watch ping cookie 66466240] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (2863862098 0 0) 0x7f96e0068180 con 0x3f61e30
-71> 2016-01-27 11:16:46.226242 7f9700411700 1 -- 10.0.2.15:0/1013182 <== osd.2 10.0.2.15:6802/9479 11 ==== osd_op_reply(136 notify.7 [watch ping cookie 66480400] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (1661574261 0 0) 0x7f96e0068180 con 0x3f61e30
-70> 2016-01-27 11:16:46.226408 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 66 ==== osd_op_reply(129 notify.0 [watch ping cookie 66434800] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (207177705 0 0) 0x7f96e0068180 con 0x3f59060
-69> 2016-01-27 11:16:46.228102 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 67 ==== osd_op_reply(130 notify.2 [watch ping cookie 66469888] v0'0 uv145 ondisk = 0) v6 ==== 175+0+0 (3906579139 0 0) 0x7f96e0068180 con 0x3f59060
-68> 2016-01-27 11:16:46.228267 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 68 ==== osd_op_reply(131 notify.3 [watch ping cookie 66467616] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (2223253054 0 0) 0x7f96e0068180 con 0x3f59060
-67> 2016-01-27 11:16:46.229152 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 69 ==== osd_op_reply(132 notify.4 [watch ping cookie 66468288] v0'0 uv147 ondisk = 0) v6 ==== 175+0+0 (692646637 0 0) 0x7f96e0068180 con 0x3f59060
-66> 2016-01-27 11:16:46.230028 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 70 ==== osd_op_reply(133 notify.5 [watch ping cookie 66472304] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (2093867616 0 0) 0x7f96e0068180 con 0x3f59060
-65> 2016-01-27 11:16:46.230787 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 71 ==== osd_op_reply(134 notify.6 [watch ping cookie 66476304] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (824107114 0 0) 0x7f96e0068180 con 0x3f59060
-64> 2016-01-27 11:16:46.238540 7f970301a700 1 -- 10.0.2.15:0/1013182 <== mon.0 10.0.2.15:6789/0 11 ==== mon_subscribe_ack(300s) v1 ==== 20+0+0 (3851642343 0 0) 0x7f96ec064970 con 0x3f4b8c0
-63> 2016-01-27 11:16:46.238562 7f970301a700 10 monclient: handle_subscribe_ack sent 2016-01-27 11:16:46.221606 renew after 2016-01-27 11:19:16.221606
-62> 2016-01-27 11:16:51.221978 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:137 notify.0 [watch ping cookie 66434800] 2.4322fa9f ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc022ab0 con 0x3f59060
-61> 2016-01-27 11:16:51.222080 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:138 notify.2 [watch ping cookie 66469888] 2.88aa5c95 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc01ffc0 con 0x3f59060
-60> 2016-01-27 11:16:51.222108 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:139 notify.3 [watch ping cookie 66467616] 2.f8c99aee ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc022040 con 0x3f59060
-59> 2016-01-27 11:16:51.222132 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:140 notify.4 [watch ping cookie 66468288] 2.a204812d ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc020880 con 0x3f59060
-58> 2016-01-27 11:16:51.222154 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:141 notify.5 [watch ping cookie 66472304] 2.31099063 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc01fc10 con 0x3f59060
-57> 2016-01-27 11:16:51.222176 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:142 notify.6 [watch ping cookie 66476304] 2.97c520d4 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc002b70 con 0x3f59060
-56> 2016-01-27 11:16:51.222199 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- osd_op(client.34130.0:143 notify.1 [watch ping cookie 66466240] 2.16dafda0 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc020c50 con 0x3f61e30
-55> 2016-01-27 11:16:51.222229 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- osd_op(client.34130.0:144 notify.7 [watch ping cookie 66480400] 2.84ada7c9 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc06cb30 con 0x3f61e30
-54> 2016-01-27 11:16:51.222252 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- ping magic: 0 v1 -- ?+0 0x7f96dc06d050 con 0x3f59060
-53> 2016-01-27 11:16:51.222264 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- ping magic: 0 v1 -- ?+0 0x7f96dc06d300 con 0x3f61e30
-52> 2016-01-27 11:16:51.226233 7f9700411700 1 -- 10.0.2.15:0/1013182 <== osd.2 10.0.2.15:6802/9479 12 ==== osd_op_reply(143 notify.1 [watch ping cookie 66466240] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (2863862098 0 0) 0x7f96e0068180 con 0x3f61e30
-51> 2016-01-27 11:16:51.226425 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 72 ==== osd_op_reply(137 notify.0 [watch ping cookie 66434800] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (207177705 0 0) 0x7f96e0068180 con 0x3f59060
-50> 2016-01-27 11:16:51.227460 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 73 ==== osd_op_reply(138 notify.2 [watch ping cookie 66469888] v0'0 uv145 ondisk = 0) v6 ==== 175+0+0 (3906579139 0 0) 0x7f96e0068180 con 0x3f59060
-49> 2016-01-27 11:16:51.227945 7f9700411700 1 -- 10.0.2.15:0/1013182 <== osd.2 10.0.2.15:6802/9479 13 ==== osd_op_reply(144 notify.7 [watch ping cookie 66480400] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (1661574261 0 0) 0x7f96e0069d80 con 0x3f61e30
-48> 2016-01-27 11:16:51.228856 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 74 ==== osd_op_reply(139 notify.3 [watch ping cookie 66467616] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (2223253054 0 0) 0x7f96e0069d80 con 0x3f59060
-47> 2016-01-27 11:16:51.229790 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 75 ==== osd_op_reply(140 notify.4 [watch ping cookie 66468288] v0'0 uv147 ondisk = 0) v6 ==== 175+0+0 (692646637 0 0) 0x7f96e0069d80 con 0x3f59060
-46> 2016-01-27 11:16:51.230718 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 76 ==== osd_op_reply(141 notify.5 [watch ping cookie 66472304] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (2093867616 0 0) 0x7f96e0069d80 con 0x3f59060
-45> 2016-01-27 11:16:51.231666 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 77 ==== osd_op_reply(142 notify.6 [watch ping cookie 66476304] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (824107114 0 0) 0x7f96e0069d80 con 0x3f59060
-44> 2016-01-27 11:16:54.220162 7f9701817700 10 monclient: tick
-43> 2016-01-27 11:16:54.220215 7f9701817700 10 monclient: renew subs? (now: 2016-01-27 11:16:54.220213; renew after: 2016-01-27 11:19:16.221606) -- no
-42> 2016-01-27 11:16:56.222589 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:145 notify.0 [watch ping cookie 66434800] 2.4322fa9f ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc022ab0 con 0x3f59060
-41> 2016-01-27 11:16:56.222725 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:146 notify.2 [watch ping cookie 66469888] 2.88aa5c95 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc01ffc0 con 0x3f59060
-40> 2016-01-27 11:16:56.222759 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:147 notify.3 [watch ping cookie 66467616] 2.f8c99aee ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc020350 con 0x3f59060
-39> 2016-01-27 11:16:56.222783 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:148 notify.4 [watch ping cookie 66468288] 2.a204812d ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc022040 con 0x3f59060
-38> 2016-01-27 11:16:56.222806 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:149 notify.5 [watch ping cookie 66472304] 2.31099063 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc01fc10 con 0x3f59060
-37> 2016-01-27 11:16:56.222828 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:150 notify.6 [watch ping cookie 66476304] 2.97c520d4 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc06c820 con 0x3f59060
-36> 2016-01-27 11:16:56.222852 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- osd_op(client.34130.0:151 notify.1 [watch ping cookie 66466240] 2.16dafda0 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc06d7f0 con 0x3f61e30
-35> 2016-01-27 11:16:56.222881 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- osd_op(client.34130.0:152 notify.7 [watch ping cookie 66480400] 2.84ada7c9 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc072050 con 0x3f61e30
-34> 2016-01-27 11:16:56.222904 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- ping magic: 0 v1 -- ?+0 0x7f96dc002d10 con 0x3f59060
-33> 2016-01-27 11:16:56.222917 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- ping magic: 0 v1 -- ?+0 0x7f96dc072620 con 0x3f61e30
-32> 2016-01-27 11:16:56.225730 7f9700411700 1 -- 10.0.2.15:0/1013182 <== osd.2 10.0.2.15:6802/9479 14 ==== osd_op_reply(151 notify.1 [watch ping cookie 66466240] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (2863862098 0 0) 0x7f96e006a510 con 0x3f61e30
-31> 2016-01-27 11:16:56.225864 7f9700411700 1 -- 10.0.2.15:0/1013182 <== osd.2 10.0.2.15:6802/9479 15 ==== osd_op_reply(152 notify.7 [watch ping cookie 66480400] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (1661574261 0 0) 0x7f96e006a510 con 0x3f61e30
-30> 2016-01-27 11:16:56.227112 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 78 ==== osd_op_reply(145 notify.0 [watch ping cookie 66434800] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (207177705 0 0) 0x7f96e006a510 con 0x3f59060
-29> 2016-01-27 11:16:56.228141 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 79 ==== osd_op_reply(146 notify.2 [watch ping cookie 66469888] v0'0 uv145 ondisk = 0) v6 ==== 175+0+0 (3906579139 0 0) 0x7f96e006a510 con 0x3f59060
-28> 2016-01-27 11:16:56.229082 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 80 ==== osd_op_reply(147 notify.3 [watch ping cookie 66467616] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (2223253054 0 0) 0x7f96e006a510 con 0x3f59060
-27> 2016-01-27 11:16:56.230030 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 81 ==== osd_op_reply(148 notify.4 [watch ping cookie 66468288] v0'0 uv147 ondisk = 0) v6 ==== 175+0+0 (692646637 0 0) 0x7f96e006a510 con 0x3f59060
-26> 2016-01-27 11:16:56.231091 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 82 ==== osd_op_reply(149 notify.5 [watch ping cookie 66472304] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (2093867616 0 0) 0x7f96e006a510 con 0x3f59060
-25> 2016-01-27 11:16:56.232117 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 83 ==== osd_op_reply(150 notify.6 [watch ping cookie 66476304] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (824107114 0 0) 0x7f96e006a510 con 0x3f59060
-24> 2016-01-27 11:17:01.223216 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:153 notify.0 [watch ping cookie 66434800] 2.4322fa9f ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc022ab0 con 0x3f59060
-23> 2016-01-27 11:17:01.223299 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:154 notify.2 [watch ping cookie 66469888] 2.88aa5c95 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc002c20 con 0x3f59060
-22> 2016-01-27 11:17:01.223322 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:155 notify.3 [watch ping cookie 66467616] 2.f8c99aee ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc01ffc0 con 0x3f59060
-21> 2016-01-27 11:17:01.223341 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:156 notify.4 [watch ping cookie 66468288] 2.a204812d ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc06dcf0 con 0x3f59060
-20> 2016-01-27 11:17:01.223360 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:157 notify.5 [watch ping cookie 66472304] 2.31099063 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc020350 con 0x3f59060
-19> 2016-01-27 11:17:01.223379 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- osd_op(client.34130.0:158 notify.6 [watch ping cookie 66476304] 2.97c520d4 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc01fc10 con 0x3f59060
-18> 2016-01-27 11:17:01.223399 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- osd_op(client.34130.0:159 notify.1 [watch ping cookie 66466240] 2.16dafda0 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc06d7d0 con 0x3f61e30
-17> 2016-01-27 11:17:01.223422 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- osd_op(client.34130.0:160 notify.7 [watch ping cookie 66480400] 2.84ada7c9 ondisk+write+known_if_redirected e114) v5 -- ?+0 0x7f96dc072cd0 con 0x3f61e30
-16> 2016-01-27 11:17:01.223441 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6807/9349 -- ping magic: 0 v1 -- ?+0 0x7f96dc0731d0 con 0x3f59060
-15> 2016-01-27 11:17:01.223451 7f970381b700 1 -- 10.0.2.15:0/1013182 --> 10.0.2.15:6802/9479 -- ping magic: 0 v1 -- ?+0 0x7f96dc073460 con 0x3f61e30
-14> 2016-01-27 11:17:01.225250 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 84 ==== osd_op_reply(153 notify.0 [watch ping cookie 66434800] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (207177705 0 0) 0x7f96e006a510 con 0x3f59060
-13> 2016-01-27 11:17:01.226171 7f9700411700 1 -- 10.0.2.15:0/1013182 <== osd.2 10.0.2.15:6802/9479 16 ==== osd_op_reply(159 notify.1 [watch ping cookie 66466240] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (2863862098 0 0) 0x7f96e006a510 con 0x3f61e30
-12> 2016-01-27 11:17:01.227110 7f9700411700 1 -- 10.0.2.15:0/1013182 <== osd.2 10.0.2.15:6802/9479 17 ==== osd_op_reply(160 notify.7 [watch ping cookie 66480400] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (1661574261 0 0) 0x7f96e006a510 con 0x3f61e30
-11> 2016-01-27 11:17:01.228173 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 85 ==== osd_op_reply(154 notify.2 [watch ping cookie 66469888] v0'0 uv145 ondisk = 0) v6 ==== 175+0+0 (3906579139 0 0) 0x7f96e006a510 con 0x3f59060
-10> 2016-01-27 11:17:01.229255 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 86 ==== osd_op_reply(155 notify.3 [watch ping cookie 66467616] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (2223253054 0 0) 0x7f96e006a510 con 0x3f59060
-9> 2016-01-27 11:17:01.230197 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 87 ==== osd_op_reply(156 notify.4 [watch ping cookie 66468288] v0'0 uv147 ondisk = 0) v6 ==== 175+0+0 (692646637 0 0) 0x7f96e006a510 con 0x3f59060
-8> 2016-01-27 11:17:01.230815 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 88 ==== osd_op_reply(157 notify.5 [watch ping cookie 66472304] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (2093867616 0 0) 0x7f96e006a510 con 0x3f59060
-7> 2016-01-27 11:17:01.231067 7f9700613700 1 -- 10.0.2.15:0/1013182 <== osd.1 10.0.2.15:6807/9349 89 ==== osd_op_reply(158 notify.6 [watch ping cookie 66476304] v0'0 uv73 ondisk = 0) v6 ==== 175+0+0 (824107114 0 0) 0x7f96e006a510 con 0x3f59060
-6> 2016-01-27 11:17:03.222079 7f96eaffd700 2 RGWDataChangesLog::ChangesRenewThread: start
-5> 2016-01-27 11:17:04.220537 7f9701817700 10 monclient: tick
-4> 2016-01-27 11:17:04.220591 7f9701817700 10 monclient: renew subs? (now: 2016-01-27 11:17:04.220590; renew after: 2016-01-27 11:19:16.221606) -- no
-3> 2016-01-27 11:17:05.311209 7f96dbfff700 1 handle_sigterm
-2> 2016-01-27 11:17:05.311238 7f96dbfff700 1 handle_sigterm set alarm for 120
-1> 2016-01-27 11:17:05.311271 7f9710d6e840 -1 shutting down
0> 2016-01-27 11:17:05.712994 7f96a8f99700 -1 *** Caught signal (Segmentation fault) **
in thread 7f96a8f99700

ceph version 0.94.5 (9764da52395923e0b32908d83a9f7304401fee43)
1: /usr/bin/radosgw() [0x6b712a]
2: (()+0x10340) [0x7f970d66c340]
3: (pthread_mutex_destroy()+0) [0x7f970d6663e0]
4: /usr/bin/radosgw() [0x67e996]
5: (()+0x8182) [0x7f970d664182]
6: (clone()+0x6d) [0x7f970bdbd47d]
NOTE: a copy of the executable, or `objdump -rdS <executable>` is needed to interpret this.

--- logging levels ---
0/ 5 none
0/ 1 lockdep
0/ 1 context
1/ 1 crush
1/ 5 mds
1/ 5 mds_balancer
1/ 5 mds_locker
1/ 5 mds_log
1/ 5 mds_log_expire
1/ 5 mds_migrator
0/ 1 buffer
0/ 1 timer
0/ 1 filer
0/ 1 striper
0/ 1 objecter
0/ 5 rados
0/ 5 rbd
0/ 5 rbd_replay
0/ 5 journaler
0/ 5 objectcacher
0/ 5 client
0/ 5 osd
0/ 5 optracker
0/ 5 objclass
1/ 3 filestore
1/ 3 keyvaluestore
1/ 3 journal
0/ 5 ms
1/ 5 mon
0/10 monc
1/ 5 paxos
0/ 5 tp
1/ 5 auth
1/ 5 crypto
1/ 1 finisher
1/ 5 heartbeatmap
1/ 5 perfcounter
1/ 5 rgw
1/10 civetweb
1/ 5 javaclient
1/ 5 asok
1/ 1 throttle
0/ 0 refs
1/ 5 xio
-2/-2 (syslog threshold)
-1/-1 (stderr threshold)
max_recent 10000
max_new 1000
log_file /var/log/radosgw/client.radosgw.gateway.log
--- end dump of recent events ---
    (1-1/1)