Skip to content

Instantly share code, notes, and snippets.

@amarao

amarao/ceph osd debug log

Created June 17, 2016 12:33
Show Gist options
  • Save amarao/d02516a78657ab9b2a3ddab2f5952641 to your computer and use it in GitHub Desktop.
Save amarao/d02516a78657ab9b2a3ddab2f5952641 to your computer and use it in GitHub Desktop.
Download ZIP
debug log from ceph OSD (please ignore if you googled to this)
Raw
ceph osd debug log
# /usr/bin/ceph-osd -d --cluster ceph --id 6 --setuser ceph --setgroup ceph
2016-06-17 12:31:31.111497 7f22c776e8c0 0 set uid:gid to 64045:64045 (ceph:ceph)
2016-06-17 12:31:31.111512 7f22c776e8c0 0 ceph version 10.2.0 (3a9fba20ec743699b69bd0181dd6c54dc01c64b9), process ceph-osd, pid 3595
2016-06-17 12:31:31.111534 7f22c776e8c0 5 object store type is filestore
starting osd.6 at :/0 osd_data /var/lib/ceph/osd/ceph-6 /var/lib/ceph/osd/ceph-6/journal
2016-06-17 12:31:31.111941 7f22c776e8c0 1 accepter.accepter.bind my_inst.addr is 0.0.0.0:6800/3595 need_addr=1
2016-06-17 12:31:31.111957 7f22c776e8c0 1 accepter.accepter.bind my_inst.addr is 0.0.0.0:6801/3595 need_addr=1
2016-06-17 12:31:31.111964 7f22c776e8c0 1 accepter.accepter.bind my_inst.addr is 0.0.0.0:6802/3595 need_addr=1
2016-06-17 12:31:31.111976 7f22c776e8c0 1 accepter.accepter.bind my_inst.addr is 0.0.0.0:6803/3595 need_addr=1
2016-06-17 12:31:31.111978 7f22c776e8c0 0 pidfile_write: ignore empty --pid-file
2016-06-17 12:31:31.117142 7f22c776e8c0 10 ErasureCodePluginSelectJerasure: load: jerasure_sse4
2016-06-17 12:31:31.118433 7f22c776e8c0 10 load: jerasure load: lrc load: isa
2016-06-17 12:31:31.118737 7f22c776e8c0 1 -- 0.0.0.0:6800/3595 messenger.start
2016-06-17 12:31:31.118805 7f22c776e8c0 1 -- :/0 messenger.start
2016-06-17 12:31:31.118824 7f22c776e8c0 1 -- 0.0.0.0:6803/3595 messenger.start
2016-06-17 12:31:31.118852 7f22c776e8c0 1 -- 0.0.0.0:6802/3595 messenger.start
2016-06-17 12:31:31.118892 7f22c776e8c0 1 -- 0.0.0.0:6801/3595 messenger.start
2016-06-17 12:31:31.118909 7f22c776e8c0 1 -- :/0 messenger.start
2016-06-17 12:31:31.119051 7f22c776e8c0 2 osd.6 0 mounting /var/lib/ceph/osd/ceph-6 /var/lib/ceph/osd/ceph-6/journal
2016-06-17 12:31:31.119127 7f22c776e8c0 0 filestore(/var/lib/ceph/osd/ceph-6) backend generic (magic 0xef53)
2016-06-17 12:31:31.119485 7f22c776e8c0 0 genericfilestorebackend(/var/lib/ceph/osd/ceph-6) detect_features: FIEMAP ioctl is disabled via 'filestore fiemap' config option
2016-06-17 12:31:31.119492 7f22c776e8c0 0 genericfilestorebackend(/var/lib/ceph/osd/ceph-6) detect_features: SEEK_DATA/SEEK_HOLE is disabled via 'filestore seek data hole' config option
2016-06-17 12:31:31.119507 7f22c776e8c0 0 genericfilestorebackend(/var/lib/ceph/osd/ceph-6) detect_features: splice is supported
2016-06-17 12:31:31.125462 7f22c776e8c0 0 genericfilestorebackend(/var/lib/ceph/osd/ceph-6) detect_features: syncfs(2) syscall fully supported (by glibc and kernel)
2016-06-17 12:31:31.133707 7f22c776e8c0 0 filestore(/var/lib/ceph/osd/ceph-6) limited size xattrs
2016-06-17 12:31:31.134097 7f22c776e8c0 1 leveldb: Recovering log #61
2016-06-17 12:31:31.134118 7f22c776e8c0 1 leveldb: Level-0 table #63: started
2016-06-17 12:31:31.139592 7f22c776e8c0 1 leveldb: Level-0 table #63: 139 bytes OK
2016-06-17 12:31:31.148254 7f22c776e8c0 1 leveldb: Delete type=0 #61
2016-06-17 12:31:31.148320 7f22c776e8c0 1 leveldb: Delete type=3 #59
2016-06-17 12:31:31.148516 7f22c776e8c0 -1 FileJournal::_open_any: aio not supported without directio; disabling aio
2016-06-17 12:31:31.148529 7f22c776e8c0 0 filestore(/var/lib/ceph/osd/ceph-6) mount: enabling WRITEAHEAD journal mode: checkpoint is not enabled
2016-06-17 12:31:31.148714 7f22c776e8c0 1 journal _open /var/lib/ceph/osd/ceph-6/journal fd 17: 5368709120 bytes, block size 4096 bytes, directio = 0, aio = 0
2016-06-17 12:31:31.149247 7f22c776e8c0 1 journal _open /var/lib/ceph/osd/ceph-6/journal fd 17: 5368709120 bytes, block size 4096 bytes, directio = 0, aio = 0
2016-06-17 12:31:31.149694 7f22c776e8c0 1 filestore(/var/lib/ceph/osd/ceph-6) upgrade
2016-06-17 12:31:31.149712 7f22c776e8c0 2 osd.6 0 boot
2016-06-17 12:31:31.149758 7f22c776e8c0 20 osd.6 0 configured osd_max_object_name[space]_len looks ok
2016-06-17 12:31:31.149810 7f22c776e8c0 10 osd.6 0 read_superblock sb(88b8125c-3c8d-4bfb-abfd-e216806f500b osd.6 f22376a2-bef2-456e-b68e-47971738f723 e6366 [5599,6366] lci=[0,6366])
2016-06-17 12:31:31.149840 7f22c776e8c0 10 open_all_classes
2016-06-17 12:31:31.149901 7f22c776e8c0 10 open_all_classes found replica_log
2016-06-17 12:31:31.149905 7f22c776e8c0 10 _get_class adding new class name replica_log 0x561a79d82540
2016-06-17 12:31:31.149907 7f22c776e8c0 10 _load_class replica_log from /usr/lib/x86_64-linux-gnu/rados-classes/libcls_replica_log.so
2016-06-17 12:31:31.150106 7f22c776e8c0 10 register_class replica_log status 3
2016-06-17 12:31:31.150107 7f22c776e8c0 10 register_cxx_method replica_log.set flags 3 0x7f22b69da320
2016-06-17 12:31:31.150110 7f22c776e8c0 10 register_cxx_method replica_log.get flags 1 0x7f22b69d8d50
2016-06-17 12:31:31.150111 7f22c776e8c0 10 register_cxx_method replica_log.delete flags 3 0x7f22b69d9bb0
2016-06-17 12:31:31.150112 7f22c776e8c0 10 _load_class replica_log success
2016-06-17 12:31:31.150114 7f22c776e8c0 10 open_all_classes found version
2016-06-17 12:31:31.150115 7f22c776e8c0 10 _get_class adding new class name version 0x561a79d82680
2016-06-17 12:31:31.150133 7f22c776e8c0 10 _load_class version from /usr/lib/x86_64-linux-gnu/rados-classes/libcls_version.so
2016-06-17 12:31:31.150420 7f22c776e8c0 10 register_class version status 3
2016-06-17 12:31:31.150421 7f22c776e8c0 10 register_cxx_method version.set flags 3 0x7f22b67d1ac0
2016-06-17 12:31:31.150423 7f22c776e8c0 10 register_cxx_method version.inc flags 3 0x7f22b67d2280
2016-06-17 12:31:31.150424 7f22c776e8c0 10 register_cxx_method version.inc_conds flags 3 0x7f22b67d2280
2016-06-17 12:31:31.150425 7f22c776e8c0 10 register_cxx_method version.read flags 1 0x7f22b67d1790
2016-06-17 12:31:31.150426 7f22c776e8c0 10 register_cxx_method version.check_conds flags 1 0x7f22b67d2b50
2016-06-17 12:31:31.150427 7f22c776e8c0 10 _load_class version success
2016-06-17 12:31:31.150429 7f22c776e8c0 10 open_all_classes found refcount
2016-06-17 12:31:31.150430 7f22c776e8c0 10 _get_class adding new class name refcount 0x561a79d827c0
2016-06-17 12:31:31.150432 7f22c776e8c0 10 _load_class refcount from /usr/lib/x86_64-linux-gnu/rados-classes/libcls_refcount.so
2016-06-17 12:31:31.151535 7f22c776e8c0 10 register_class refcount status 3
2016-06-17 12:31:31.151537 7f22c776e8c0 10 register_cxx_method refcount.get flags 3 0x7f22b653c8f0
2016-06-17 12:31:31.151538 7f22c776e8c0 10 register_cxx_method refcount.put flags 3 0x7f22b653b420
2016-06-17 12:31:31.151539 7f22c776e8c0 10 register_cxx_method refcount.set flags 3 0x7f22b653c100
2016-06-17 12:31:31.151540 7f22c776e8c0 10 register_cxx_method refcount.read flags 1 0x7f22b653ba50
2016-06-17 12:31:31.151541 7f22c776e8c0 10 _load_class refcount success
2016-06-17 12:31:31.151542 7f22c776e8c0 10 open_all_classes found kvs
2016-06-17 12:31:31.151543 7f22c776e8c0 10 _get_class adding new class name kvs 0x561a79d82900
2016-06-17 12:31:31.151545 7f22c776e8c0 10 _load_class kvs from /usr/lib/x86_64-linux-gnu/rados-classes/libcls_kvs.so
2016-06-17 12:31:31.151663 7f22c776e8c0 10 register_class kvs status 3
2016-06-17 12:31:31.151665 7f22c776e8c0 10 register_cxx_method kvs.get_idata_from_key flags 1 0x7f22b62890a0
2016-06-17 12:31:31.151667 7f22c776e8c0 10 register_cxx_method kvs.get_next_idata flags 1 0x7f22b6288300
2016-06-17 12:31:31.151669 7f22c776e8c0 10 register_cxx_method kvs.get_prev_idata flags 1 0x7f22b628a430
2016-06-17 12:31:31.151670 7f22c776e8c0 10 register_cxx_method kvs.read_many flags 1 0x7f22b6281d70
2016-06-17 12:31:31.151670 7f22c776e8c0 10 register_cxx_method kvs.check_writable flags 3 0x7f22b62816f0
2016-06-17 12:31:31.151671 7f22c776e8c0 10 register_cxx_method kvs.assert_size_in_bound flags 2 0x7f22b6281970
2016-06-17 12:31:31.151672 7f22c776e8c0 10 register_cxx_method kvs.omap_insert flags 2 0x7f22b6286e50
2016-06-17 12:31:31.151673 7f22c776e8c0 10 register_cxx_method kvs.create_with_omap flags 2 0x7f22b6286010
2016-06-17 12:31:31.151674 7f22c776e8c0 10 register_cxx_method kvs.omap_remove flags 2 0x7f22b6282ca0
2016-06-17 12:31:31.151676 7f22c776e8c0 10 register_cxx_method kvs.maybe_read_for_balance flags 1 0x7f22b6283f50
2016-06-17 12:31:31.151677 7f22c776e8c0 10 _load_class kvs success
2016-06-17 12:31:31.151678 7f22c776e8c0 10 open_all_classes found hello
2016-06-17 12:31:31.151679 7f22c776e8c0 10 _get_class adding new class name hello 0x561a79d82a40
2016-06-17 12:31:31.151680 7f22c776e8c0 10 _load_class hello from /usr/lib/x86_64-linux-gnu/rados-classes/libcls_hello.so
2016-06-17 12:31:31.151779 7f22c776e8c0 0 <cls> cls/hello/cls_hello.cc:305: loading cls_hello
2016-06-17 12:31:31.151782 7f22c776e8c0 10 register_class hello status 3
2016-06-17 12:31:31.151784 7f22c776e8c0 10 register_cxx_method hello.say_hello flags 1 0x7f22b607a570
2016-06-17 12:31:31.151785 7f22c776e8c0 10 register_cxx_method hello.record_hello flags 10 0x7f22b607b3e0
2016-06-17 12:31:31.151786 7f22c776e8c0 10 register_cxx_method hello.writes_dont_return_data flags 2 0x7f22b607a890
2016-06-17 12:31:31.151787 7f22c776e8c0 10 register_cxx_method hello.replay flags 1 0x7f22b607a470
2016-06-17 12:31:31.151789 7f22c776e8c0 10 register_cxx_method hello.turn_it_to_11 flags 11 0x7f22b607ab00
2016-06-17 12:31:31.151790 7f22c776e8c0 10 register_cxx_method hello.bad_reader flags 2 0x7f22b607a460
2016-06-17 12:31:31.151790 7f22c776e8c0 10 register_cxx_method hello.bad_writer flags 1 0x7f22b607a450
2016-06-17 12:31:31.151793 7f22c776e8c0 10 _load_class hello success
2016-06-17 12:31:31.151794 7f22c776e8c0 10 open_all_classes found rbd
2016-06-17 12:31:31.151796 7f22c776e8c0 10 _get_class adding new class name rbd 0x561a79d82b80
2016-06-17 12:31:31.151798 7f22c776e8c0 10 _load_class rbd from /usr/lib/x86_64-linux-gnu/rados-classes/libcls_rbd.so
2016-06-17 12:31:31.152035 7f22c776e8c0 10 register_class rbd status 3
2016-06-17 12:31:31.152043 7f22c776e8c0 10 register_cxx_method rbd.create flags 3 0x7f22b5e572e0
2016-06-17 12:31:31.152052 7f22c776e8c0 10 register_cxx_method rbd.get_features flags 1 0x7f22b5e5b5a0
2016-06-17 12:31:31.152053 7f22c776e8c0 10 register_cxx_method rbd.set_features flags 3 0x7f22b5e5d4a0
2016-06-17 12:31:31.152054 7f22c776e8c0 10 register_cxx_method rbd.get_size flags 1 0x7f22b5e5b1d0
2016-06-17 12:31:31.152055 7f22c776e8c0 10 register_cxx_method rbd.set_size flags 3 0x7f22b5e5b930
2016-06-17 12:31:31.152056 7f22c776e8c0 10 register_cxx_method rbd.get_snapcontext flags 1 0x7f22b5e61c70
2016-06-17 12:31:31.152057 7f22c776e8c0 10 register_cxx_method rbd.get_object_prefix flags 1 0x7f22b5e5a0c0
2016-06-17 12:31:31.152058 7f22c776e8c0 10 register_cxx_method rbd.get_snapshot_name flags 1 0x7f22b5e58c50
2016-06-17 12:31:31.152059 7f22c776e8c0 10 register_cxx_method rbd.snapshot_add flags 3 0x7f22b5e65d70
2016-06-17 12:31:31.152060 7f22c776e8c0 10 register_cxx_method rbd.snapshot_remove flags 3 0x7f22b5e58ea0
2016-06-17 12:31:31.152061 7f22c776e8c0 10 register_cxx_method rbd.snapshot_rename flags 3 0x7f22b5e62090
2016-06-17 12:31:31.152062 7f22c776e8c0 10 register_cxx_method rbd.get_all_features flags 1 0x7f22b5e55670
2016-06-17 12:31:31.152063 7f22c776e8c0 10 register_cxx_method rbd.copyup flags 3 0x7f22b5e55770
2016-06-17 12:31:31.152064 7f22c776e8c0 10 register_cxx_method rbd.get_parent flags 1 0x7f22b5e5d050
2016-06-17 12:31:31.152065 7f22c776e8c0 10 register_cxx_method rbd.set_parent flags 3 0x7f22b5e5c6a0
2016-06-17 12:31:31.152066 7f22c776e8c0 10 register_cxx_method rbd.remove_parent flags 3 0x7f22b5e60940
2016-06-17 12:31:31.152066 7f22c776e8c0 10 register_cxx_method rbd.set_protection_status flags 3 0x7f22b5e5cc20
2016-06-17 12:31:31.152068 7f22c776e8c0 10 register_cxx_method rbd.get_protection_status flags 1 0x7f22b5e58970
2016-06-17 12:31:31.152069 7f22c776e8c0 10 register_cxx_method rbd.get_stripe_unit_count flags 1 0x7f22b5e5bf90
2016-06-17 12:31:31.152070 7f22c776e8c0 10 register_cxx_method rbd.set_stripe_unit_count flags 3 0x7f22b5e5c1f0
2016-06-17 12:31:31.152083 7f22c776e8c0 10 register_cxx_method rbd.get_flags flags 1 0x7f22b5e5aea0
2016-06-17 12:31:31.152084 7f22c776e8c0 10 register_cxx_method rbd.set_flags flags 3 0x7f22b5e5a8b0
2016-06-17 12:31:31.152098 7f22c776e8c0 10 register_cxx_method rbd.metadata_list flags 1 0x7f22b5e673a0
2016-06-17 12:31:31.152099 7f22c776e8c0 10 register_cxx_method rbd.metadata_set flags 3 0x7f22b5e67b10
2016-06-17 12:31:31.152101 7f22c776e8c0 10 register_cxx_method rbd.metadata_remove flags 3 0x7f22b5e56c60
2016-06-17 12:31:31.152102 7f22c776e8c0 10 register_cxx_method rbd.metadata_get flags 1 0x7f22b5e5f230
2016-06-17 12:31:31.152103 7f22c776e8c0 10 register_cxx_method rbd.add_child flags 3 0x7f22b5e61770
2016-06-17 12:31:31.152104 7f22c776e8c0 10 register_cxx_method rbd.remove_child flags 3 0x7f22b5e64080
2016-06-17 12:31:31.152105 7f22c776e8c0 10 register_cxx_method rbd.get_children flags 1 0x7f22b5e61400
2016-06-17 12:31:31.152106 7f22c776e8c0 10 register_cxx_method rbd.get_id flags 1 0x7f22b5e5f500
2016-06-17 12:31:31.152107 7f22c776e8c0 10 register_cxx_method rbd.set_id flags 3 0x7f22b5e570f0
2016-06-17 12:31:31.152108 7f22c776e8c0 10 register_cxx_method rbd.dir_get_id flags 1 0x7f22b5e59520
2016-06-17 12:31:31.152109 7f22c776e8c0 10 register_cxx_method rbd.dir_get_name flags 1 0x7f22b5e59e30
2016-06-17 12:31:31.152109 7f22c776e8c0 10 register_cxx_method rbd.dir_list flags 1 0x7f22b5e682e0
2016-06-17 12:31:31.152110 7f22c776e8c0 10 register_cxx_method rbd.dir_add_image flags 3 0x7f22b5e671a0
2016-06-17 12:31:31.152111 7f22c776e8c0 10 register_cxx_method rbd.dir_remove_image flags 3 0x7f22b5e59cb0
2016-06-17 12:31:31.152113 7f22c776e8c0 10 register_cxx_method rbd.dir_rename_image flags 3 0x7f22b5e66f60
2016-06-17 12:31:31.152114 7f22c776e8c0 10 register_cxx_method rbd.object_map_load flags 1 0x7f22b5e647d0
2016-06-17 12:31:31.152115 7f22c776e8c0 10 register_cxx_method rbd.object_map_save flags 3 0x7f22b5e64b80
2016-06-17 12:31:31.152116 7f22c776e8c0 10 register_cxx_method rbd.object_map_resize flags 3 0x7f22b5e65a40
2016-06-17 12:31:31.152117 7f22c776e8c0 10 register_cxx_method rbd.object_map_update flags 3 0x7f22b5e65160
2016-06-17 12:31:31.152118 7f22c776e8c0 10 register_cxx_method rbd.object_map_snap_add flags 3 0x7f22b5e64910
2016-06-17 12:31:31.152119 7f22c776e8c0 10 register_cxx_method rbd.object_map_snap_remove flags 3 0x7f22b5e64dd0
2016-06-17 12:31:31.152120 7f22c776e8c0 10 register_cxx_method rbd.snap_list flags 1 0x7f22b5e5dc90
2016-06-17 12:31:31.152122 7f22c776e8c0 10 register_cxx_method rbd.snap_add flags 3 0x7f22b5e5fc50
2016-06-17 12:31:31.152123 7f22c776e8c0 10 register_cxx_method rbd.snap_remove flags 3 0x7f22b5e601d0
2016-06-17 12:31:31.152124 7f22c776e8c0 10 register_cxx_method rbd.snap_rename flags 3 0x7f22b5e57b70
2016-06-17 12:31:31.152136 7f22c776e8c0 10 register_cxx_method rbd.mirror_uuid_get flags 1 0x7f22b5e58500
2016-06-17 12:31:31.152138 7f22c776e8c0 10 register_cxx_method rbd.mirror_uuid_set flags 3 0x7f22b5e5da90
2016-06-17 12:31:31.152139 7f22c776e8c0 10 register_cxx_method rbd.mirror_mode_get flags 1 0x7f22b5e5da30
2016-06-17 12:31:31.152140 7f22c776e8c0 10 register_cxx_method rbd.mirror_mode_set flags 3 0x7f22b5e63540
2016-06-17 12:31:31.152141 7f22c776e8c0 10 register_cxx_method rbd.mirror_peer_list flags 1 0x7f22b5e638e0
2016-06-17 12:31:31.152142 7f22c776e8c0 10 register_cxx_method rbd.mirror_peer_add flags 3 0x7f22b5e63a50
2016-06-17 12:31:31.152143 7f22c776e8c0 10 register_cxx_method rbd.mirror_peer_remove flags 3 0x7f22b5e56e90
2016-06-17 12:31:31.152144 7f22c776e8c0 10 register_cxx_method rbd.mirror_peer_set_client flags 3 0x7f22b5e5e1d0
2016-06-17 12:31:31.152146 7f22c776e8c0 10 register_cxx_method rbd.mirror_peer_set_cluster flags 3 0x7f22b5e5e450
2016-06-17 12:31:31.152147 7f22c776e8c0 10 register_cxx_method rbd.mirror_image_list flags 1 0x7f22b5e68ca0
2016-06-17 12:31:31.152148 7f22c776e8c0 10 register_cxx_method rbd.mirror_image_get_image_id flags 1 0x7f22b5e5a280
2016-06-17 12:31:31.152149 7f22c776e8c0 10 register_cxx_method rbd.mirror_image_get flags 1 0x7f22b5e5e900
2016-06-17 12:31:31.152150 7f22c776e8c0 10 register_cxx_method rbd.mirror_image_set flags 3 0x7f22b5e5f0c0
2016-06-17 12:31:31.152151 7f22c776e8c0 10 register_cxx_method rbd.mirror_image_remove flags 3 0x7f22b5e5fb50
2016-06-17 12:31:31.152153 7f22c776e8c0 10 _load_class rbd success
2016-06-17 12:31:31.152155 7f22c776e8c0 10 open_all_classes found rgw
2016-06-17 12:31:31.152157 7f22c776e8c0 10 _get_class adding new class name rgw 0x561a79d82cc0
2016-06-17 12:31:31.152158 7f22c776e8c0 10 _load_class rgw from /usr/lib/x86_64-linux-gnu/rados-classes/libcls_rgw.so
2016-06-17 12:31:31.153197 7f22c776e8c0 10 register_class rgw status 3
2016-06-17 12:31:31.153199 7f22c776e8c0 10 register_cxx_method rgw.bucket_init_index flags 3 0x7f22b5b83a40
2016-06-17 12:31:31.153201 7f22c776e8c0 10 register_cxx_method rgw.bucket_set_tag_timeout flags 3 0x7f22b5b8cc60
2016-06-17 12:31:31.153213 7f22c776e8c0 10 register_cxx_method rgw.bucket_list flags 1 0x7f22b5b8d180
2016-06-17 12:31:31.153214 7f22c776e8c0 10 register_cxx_method rgw.bucket_check_index flags 1 0x7f22b5b8f8b0
2016-06-17 12:31:31.153215 7f22c776e8c0 10 register_cxx_method rgw.bucket_rebuild_index flags 3 0x7f22b5b8f700
2016-06-17 12:31:31.153216 7f22c776e8c0 10 register_cxx_method rgw.bucket_prepare_op flags 3 0x7f22b5b8ea90
2016-06-17 12:31:31.153217 7f22c776e8c0 10 register_cxx_method rgw.bucket_complete_op flags 3 0x7f22b5b8fc30
2016-06-17 12:31:31.153218 7f22c776e8c0 10 register_cxx_method rgw.bucket_link_olh flags 3 0x7f22b5b938f0
2016-06-17 12:31:31.153219 7f22c776e8c0 10 register_cxx_method rgw.bucket_unlink_instance flags 3 0x7f22b5b92b80
2016-06-17 12:31:31.153226 7f22c776e8c0 10 register_cxx_method rgw.bucket_read_olh_log flags 1 0x7f22b5b94960
2016-06-17 12:31:31.153228 7f22c776e8c0 10 register_cxx_method rgw.bucket_trim_olh_log flags 3 0x7f22b5b92540
2016-06-17 12:31:31.153229 7f22c776e8c0 10 register_cxx_method rgw.bucket_clear_olh flags 3 0x7f22b5b92010
2016-06-17 12:31:31.153230 7f22c776e8c0 10 register_cxx_method rgw.obj_remove flags 3 0x7f22b5b8bda0
2016-06-17 12:31:31.153231 7f22c776e8c0 10 register_cxx_method rgw.obj_store_pg_ver flags 2 0x7f22b5b7fde0
2016-06-17 12:31:31.153232 7f22c776e8c0 10 register_cxx_method rgw.obj_check_attrs_prefix flags 1 0x7f22b5b83c90
2016-06-17 12:31:31.153233 7f22c776e8c0 10 register_cxx_method rgw.obj_check_mtime flags 1 0x7f22b5b7f5e0
2016-06-17 12:31:31.153234 7f22c776e8c0 10 register_cxx_method rgw.bi_get flags 1 0x7f22b5b802f0
2016-06-17 12:31:31.153235 7f22c776e8c0 10 register_cxx_method rgw.bi_put flags 3 0x7f22b5b81a60
2016-06-17 12:31:31.153236 7f22c776e8c0 10 register_cxx_method rgw.bi_list flags 1 0x7f22b5b89d80
2016-06-17 12:31:31.153237 7f22c776e8c0 10 register_cxx_method rgw.bi_log_list flags 1 0x7f22b5b861e0
2016-06-17 12:31:31.153238 7f22c776e8c0 10 register_cxx_method rgw.bi_log_trim flags 3 0x7f22b5b86d70
2016-06-17 12:31:31.153239 7f22c776e8c0 10 register_cxx_method rgw.dir_suggest_changes flags 3 0x7f22b5b90d50
2016-06-17 12:31:31.153240 7f22c776e8c0 10 register_cxx_method rgw.user_usage_log_add flags 3 0x7f22b5b88ce0
2016-06-17 12:31:31.153241 7f22c776e8c0 10 register_cxx_method rgw.user_usage_log_read flags 1 0x7f22b5b884f0
2016-06-17 12:31:31.153243 7f22c776e8c0 10 register_cxx_method rgw.user_usage_log_trim flags 3 0x7f22b5b88b30
2016-06-17 12:31:31.153244 7f22c776e8c0 10 register_cxx_method rgw.gc_set_entry flags 3 0x7f22b5b82df0
2016-06-17 12:31:31.153245 7f22c776e8c0 10 register_cxx_method rgw.gc_defer_entry flags 3 0x7f22b5b828a0
2016-06-17 12:31:31.153246 7f22c776e8c0 10 register_cxx_method rgw.gc_list flags 1 0x7f22b5b84400
2016-06-17 12:31:31.153247 7f22c776e8c0 10 register_cxx_method rgw.gc_remove flags 3 0x7f22b5b83280
2016-06-17 12:31:31.153249 7f22c776e8c0 10 _load_class rgw success
2016-06-17 12:31:31.153250 7f22c776e8c0 10 open_all_classes found cephfs
2016-06-17 12:31:31.153252 7f22c776e8c0 10 _get_class adding new class name cephfs 0x561a79d82e00
2016-06-17 12:31:31.153254 7f22c776e8c0 10 _load_class cephfs from /usr/lib/x86_64-linux-gnu/rados-classes/libcls_cephfs.so
2016-06-17 12:31:31.153345 7f22c776e8c0 0 <cls> cls/cephfs/cls_cephfs.cc:202: loading cephfs_size_scan
2016-06-17 12:31:31.153352 7f22c776e8c0 10 register_class cephfs status 3
2016-06-17 12:31:31.153354 7f22c776e8c0 10 register_cxx_method cephfs.accumulate_inode_metadata flags 3 0x7f22b58cb500
2016-06-17 12:31:31.153356 7f22c776e8c0 10 _load_class cephfs success
2016-06-17 12:31:31.153358 7f22c776e8c0 10 open_all_classes found lock
2016-06-17 12:31:31.153360 7f22c776e8c0 10 _get_class adding new class name lock 0x561a79d82f40
2016-06-17 12:31:31.153362 7f22c776e8c0 10 _load_class lock from /usr/lib/x86_64-linux-gnu/rados-classes/libcls_lock.so
2016-06-17 12:31:31.153517 7f22c776e8c0 10 register_class lock status 3
2016-06-17 12:31:31.153525 7f22c776e8c0 10 register_cxx_method lock.lock flags 11 0x7f22b56c2180
2016-06-17 12:31:31.153527 7f22c776e8c0 10 register_cxx_method lock.unlock flags 11 0x7f22b56c1bf0
2016-06-17 12:31:31.153528 7f22c776e8c0 10 register_cxx_method lock.break_lock flags 3 0x7f22b56c1680
2016-06-17 12:31:31.153528 7f22c776e8c0 10 register_cxx_method lock.get_info flags 1 0x7f22b56c3040
2016-06-17 12:31:31.153529 7f22c776e8c0 10 register_cxx_method lock.list_locks flags 1 0x7f22b56c0240
2016-06-17 12:31:31.153530 7f22c776e8c0 10 register_cxx_method lock.assert_locked flags 9 0x7f22b56c0ab0
2016-06-17 12:31:31.153531 7f22c776e8c0 10 _load_class lock success
2016-06-17 12:31:31.153533 7f22c776e8c0 10 open_all_classes found user
2016-06-17 12:31:31.153534 7f22c776e8c0 10 _get_class adding new class name user 0x561a79d83080
2016-06-17 12:31:31.153536 7f22c776e8c0 10 _load_class user from /usr/lib/x86_64-linux-gnu/rados-classes/libcls_user.so
2016-06-17 12:31:31.153753 7f22c776e8c0 10 register_class user status 3
2016-06-17 12:31:31.153754 7f22c776e8c0 10 register_cxx_method user.set_buckets_info flags 3 0x7f22b54b5610
2016-06-17 12:31:31.153756 7f22c776e8c0 10 register_cxx_method user.complete_stats_sync flags 3 0x7f22b54b3310
2016-06-17 12:31:31.153769 7f22c776e8c0 10 register_cxx_method user.remove_bucket flags 3 0x7f22b54b47c0
2016-06-17 12:31:31.153770 7f22c776e8c0 10 register_cxx_method user.list_buckets flags 1 0x7f22b54b7870
2016-06-17 12:31:31.153771 7f22c776e8c0 10 register_cxx_method user.get_header flags 1 0x7f22b54b2c00
2016-06-17 12:31:31.153772 7f22c776e8c0 10 _load_class user success
2016-06-17 12:31:31.153775 7f22c776e8c0 10 open_all_classes found journal
2016-06-17 12:31:31.153776 7f22c776e8c0 10 _get_class adding new class name journal 0x561a79d831c0
2016-06-17 12:31:31.153797 7f22c776e8c0 10 _load_class journal from /usr/lib/x86_64-linux-gnu/rados-classes/libcls_journal.so
2016-06-17 12:31:31.154012 7f22c776e8c0 10 register_class journal status 3
2016-06-17 12:31:31.154021 7f22c776e8c0 10 register_cxx_method journal.create flags 3 0x7f22b52a3ff0
2016-06-17 12:31:31.154023 7f22c776e8c0 10 register_cxx_method journal.get_order flags 1 0x7f22b52a2330
2016-06-17 12:31:31.154024 7f22c776e8c0 10 register_cxx_method journal.get_splay_width flags 1 0x7f22b52a22d0
2016-06-17 12:31:31.154025 7f22c776e8c0 10 register_cxx_method journal.get_pool_id flags 1 0x7f22b52a1a40
2016-06-17 12:31:31.154026 7f22c776e8c0 10 register_cxx_method journal.get_minimum_set flags 1 0x7f22b52a2910
2016-06-17 12:31:31.154043 7f22c776e8c0 10 register_cxx_method journal.set_minimum_set flags 3 0x7f22b52a2790
2016-06-17 12:31:31.154049 7f22c776e8c0 10 register_cxx_method journal.get_active_set flags 1 0x7f22b52a2720
2016-06-17 12:31:31.154051 7f22c776e8c0 10 register_cxx_method journal.set_active_set flags 3 0x7f22b52a25a0
2016-06-17 12:31:31.154052 7f22c776e8c0 10 register_cxx_method journal.get_client flags 1 0x7f22b52a2cc0
2016-06-17 12:31:31.154053 7f22c776e8c0 10 register_cxx_method journal.client_register flags 3 0x7f22b52a3800
2016-06-17 12:31:31.154054 7f22c776e8c0 10 register_cxx_method journal.client_update_data flags 3 0x7f22b52a43c0
2016-06-17 12:31:31.154055 7f22c776e8c0 10 register_cxx_method journal.client_update_state flags 3 0x7f22b52a2fb0
2016-06-17 12:31:31.154056 7f22c776e8c0 10 register_cxx_method journal.client_unregister flags 3 0x7f22b52a6d20
2016-06-17 12:31:31.154058 7f22c776e8c0 10 register_cxx_method journal.client_commit flags 3 0x7f22b52a3380
2016-06-17 12:31:31.154058 7f22c776e8c0 10 register_cxx_method journal.client_list flags 1 0x7f22b52a4880
2016-06-17 12:31:31.154060 7f22c776e8c0 10 register_cxx_method journal.get_next_tag_tid flags 1 0x7f22b52a2530
2016-06-17 12:31:31.154061 7f22c776e8c0 10 register_cxx_method journal.get_tag flags 1 0x7f22b52a2980
2016-06-17 12:31:31.154062 7f22c776e8c0 10 register_cxx_method journal.tag_create flags 3 0x7f22b52a6fd0
2016-06-17 12:31:31.154063 7f22c776e8c0 10 register_cxx_method journal.tag_list flags 1 0x7f22b52a5060
2016-06-17 12:31:31.154064 7f22c776e8c0 10 register_cxx_method journal.guard_append flags 3 0x7f22b52a1000
2016-06-17 12:31:31.154070 7f22c776e8c0 10 _load_class journal success
2016-06-17 12:31:31.154083 7f22c776e8c0 10 open_all_classes found statelog
2016-06-17 12:31:31.154086 7f22c776e8c0 10 _get_class adding new class name statelog 0x561a79d83300
2016-06-17 12:31:31.154089 7f22c776e8c0 10 _load_class statelog from /usr/lib/x86_64-linux-gnu/rados-classes/libcls_statelog.so
2016-06-17 12:31:31.154236 7f22c776e8c0 10 register_class statelog status 3
2016-06-17 12:31:31.154246 7f22c776e8c0 10 register_cxx_method statelog.add flags 3 0x7f22b5096460
2016-06-17 12:31:31.154261 7f22c776e8c0 10 register_cxx_method statelog.list flags 1 0x7f22b5097430
2016-06-17 12:31:31.154268 7f22c776e8c0 10 register_cxx_method statelog.remove flags 3 0x7f22b5095240
2016-06-17 12:31:31.154269 7f22c776e8c0 10 register_cxx_method statelog.check_state flags 1 0x7f22b5095b00
2016-06-17 12:31:31.154270 7f22c776e8c0 10 _load_class statelog success
2016-06-17 12:31:31.154272 7f22c776e8c0 10 open_all_classes found log
2016-06-17 12:31:31.154274 7f22c776e8c0 10 _get_class adding new class name log 0x561a79d83440
2016-06-17 12:31:31.154275 7f22c776e8c0 10 _load_class log from /usr/lib/x86_64-linux-gnu/rados-classes/libcls_log.so
2016-06-17 12:31:31.154417 7f22c776e8c0 10 register_class log status 3
2016-06-17 12:31:31.154418 7f22c776e8c0 10 register_cxx_method log.add flags 3 0x7f22b4e8c0f0
2016-06-17 12:31:31.154421 7f22c776e8c0 10 register_cxx_method log.list flags 1 0x7f22b4e8d290
2016-06-17 12:31:31.154422 7f22c776e8c0 10 register_cxx_method log.trim flags 3 0x7f22b4e8ca40
2016-06-17 12:31:31.154424 7f22c776e8c0 10 register_cxx_method log.info flags 1 0x7f22b4e8ba90
2016-06-17 12:31:31.154425 7f22c776e8c0 10 _load_class log success
2016-06-17 12:31:31.154427 7f22c776e8c0 10 open_all_classes found timeindex
2016-06-17 12:31:31.154428 7f22c776e8c0 10 _get_class adding new class name timeindex 0x561a79d83580
2016-06-17 12:31:31.154430 7f22c776e8c0 10 _load_class timeindex from /usr/lib/x86_64-linux-gnu/rados-classes/libcls_timeindex.so
2016-06-17 12:31:31.154616 7f22c776e8c0 10 register_class timeindex status 3
2016-06-17 12:31:31.154617 7f22c776e8c0 10 register_cxx_method timeindex.add flags 3 0x7f22b4c835c0
2016-06-17 12:31:31.154619 7f22c776e8c0 10 register_cxx_method timeindex.list flags 1 0x7f22b4c83ff0
2016-06-17 12:31:31.154620 7f22c776e8c0 10 register_cxx_method timeindex.trim flags 3 0x7f22b4c83780
2016-06-17 12:31:31.154621 7f22c776e8c0 10 _load_class timeindex success
2016-06-17 12:31:31.154623 7f22c776e8c0 10 open_all_classes found numops
2016-06-17 12:31:31.154625 7f22c776e8c0 10 _get_class adding new class name numops 0x561a79d836c0
2016-06-17 12:31:31.154626 7f22c776e8c0 10 _load_class numops from /usr/lib/x86_64-linux-gnu/rados-classes/libcls_numops.so
2016-06-17 12:31:31.154760 7f22c776e8c0 10 register_class numops status 3
2016-06-17 12:31:31.154775 7f22c776e8c0 10 register_cxx_method numops.add flags 3 0x7f22b4a7dab0
2016-06-17 12:31:31.154776 7f22c776e8c0 10 register_cxx_method numops.mul flags 3 0x7f22b4a7e540
2016-06-17 12:31:31.154777 7f22c776e8c0 10 _load_class numops success
2016-06-17 12:31:31.154820 7f22c776e8c0 20 osd.6 0 get_map 6366 - loading and decoding 0x561a79e2eb40
2016-06-17 12:31:31.154915 7f22c776e8c0 10 osd.6 0 add_map_bl 6366 18113 bytes
2016-06-17 12:31:31.155092 7f22c776e8c0 0 osd.6 6366 crush map has features 2200130813952, adjusting msgr requires for clients
2016-06-17 12:31:31.155099 7f22c776e8c0 0 osd.6 6366 crush map has features 2200130813952 was 8705, adjusting msgr requires for mons
2016-06-17 12:31:31.155102 7f22c776e8c0 0 osd.6 6366 crush map has features 2200130813952, adjusting msgr requires for osds
2016-06-17 12:31:31.155104 7f22c776e8c0 10 osd.6 6366 create_recoverystate_perf
2016-06-17 12:31:31.155110 7f22c776e8c0 10 osd.6 6366 clear_temp_objects
2016-06-17 12:31:31.155123 7f22c776e8c0 0 osd.6 6366 load_pgs
2016-06-17 12:31:31.155131 7f22c776e8c0 10 osd.6 6366 load_pgs ignoring unrecognized meta
2016-06-17 12:31:31.155133 7f22c776e8c0 0 osd.6 6366 load_pgs opened 0 pgs
2016-06-17 12:31:31.155134 7f22c776e8c0 10 osd.6 6366 build_past_intervals_parallel nothing to build
2016-06-17 12:31:31.155135 7f22c776e8c0 2 osd.6 6366 superblock: i am osd.6
2016-06-17 12:31:31.155136 7f22c776e8c0 0 osd.6 6366 using 0 op queue with priority op cut off at 64.
2016-06-17 12:31:31.155137 7f22c776e8c0 10 osd.6 6366 create_logger
2016-06-17 12:31:31.155189 7f22c776e8c0 1 accepter.accepter.start
2016-06-17 12:31:31.155248 7f22c776e8c0 1 accepter.accepter.start
2016-06-17 12:31:31.155429 7f22c776e8c0 1 accepter.accepter.start
2016-06-17 12:31:31.155520 7f22c776e8c0 1 accepter.accepter.start
2016-06-17 12:31:31.155916 7f22c776e8c0 -1 osd.6 6366 log_to_monitors {default=true}
2016-06-17 12:31:31.156377 7f22c776e8c0 10 osd.6 6366 set_disk_tp_priority class priority -1
2016-06-17 12:31:31.156493 7f22a425a700 20 osd.6 0 update_osd_stat osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:31:31.156509 7f22a425a700 5 osd.6 6366 heartbeat: osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:31:31.156568 7f22a1a55700 10 osd.6 6366 agent_entry start
2016-06-17 12:31:31.156571 7f22a1a55700 20 osd.6 6366 agent_entry empty queue
2016-06-17 12:31:31.156680 7f22c776e8c0 1 -- 0.0.0.0:6800/3595 --> 78.140.137.209:6789/0 -- auth(proto 0 26 bytes epoch 0) v1 -- ?+0 0x561a79e40300 con 0x561a79db3980
2016-06-17 12:31:31.159378 7f22c7769700 1 -- 188.42.216.238:6800/3595 learned my addr 188.42.216.238:6800/3595
2016-06-17 12:31:31.159422 7f22c7769700 10 osd.6 6366 new session (outgoing) 0x561a79da9800 con=0x561a79db2780 addr=188.42.216.238:6800/3595
2016-06-17 12:31:31.159466 7f22c7769700 10 osd.6 6366 OSD::ms_get_authorizer type=mon
2016-06-17 12:31:31.160586 7f22b4a7b700 10 osd.6 6366 ms_handle_connect on mon
2016-06-17 12:31:31.160591 7f22b4a7b700 10 osd.6 6366 send_alive up_thru currently 0 want 0
2016-06-17 12:31:31.160593 7f22b4a7b700 10 osd.6 6366 requeue_pg_temp 0 + 0 -> 0
2016-06-17 12:31:31.160596 7f22b4a7b700 10 osd.6 6366 requeue_failures 0 + 0 -> 0
2016-06-17 12:31:31.160598 7f22b4a7b700 20 osd.6 6366 send_pg_stats
2016-06-17 12:31:31.162194 7f22b4a7b700 1 -- 188.42.216.238:6800/3595 <== mon.1 78.140.137.209:6789/0 1 ==== mon_map magic: 0 v1 ==== 479+0+0 (2697293072 0 0) 0x561a79fe6480 con 0x561a79db3980
2016-06-17 12:31:31.162281 7f22b4a7b700 1 -- 188.42.216.238:6800/3595 <== mon.1 78.140.137.209:6789/0 2 ==== auth_reply(proto 2 0 (0) Success) v1 ==== 33+0+0 (121399811 0 0) 0x561a79e40080 con 0x561a79db3980
2016-06-17 12:31:31.162425 7f22b4a7b700 1 -- 188.42.216.238:6800/3595 --> 78.140.137.209:6789/0 -- auth(proto 2 32 bytes epoch 0) v1 -- ?+0 0x561a79e40580 con 0x561a79db3980
2016-06-17 12:31:31.163977 7f22b4a7b700 1 -- 188.42.216.238:6800/3595 <== mon.1 78.140.137.209:6789/0 3 ==== auth_reply(proto 2 0 (0) Success) v1 ==== 206+0+0 (2992186339 0 0) 0x561a79e40300 con 0x561a79db3980
2016-06-17 12:31:31.164054 7f22b4a7b700 1 -- 188.42.216.238:6800/3595 --> 78.140.137.209:6789/0 -- auth(proto 2 165 bytes epoch 0) v1 -- ?+0 0x561a79e40080 con 0x561a79db3980
2016-06-17 12:31:31.166135 7f22b4a7b700 1 -- 188.42.216.238:6800/3595 <== mon.1 78.140.137.209:6789/0 4 ==== auth_reply(proto 2 0 (0) Success) v1 ==== 393+0+0 (2878987509 0 0) 0x561a79e40580 con 0x561a79db3980
2016-06-17 12:31:31.166235 7f22b4a7b700 1 -- 188.42.216.238:6800/3595 --> 78.140.137.209:6789/0 -- mon_subscribe({monmap=0+}) v2 -- ?+0 0x561a79da9200 con 0x561a79db3980
2016-06-17 12:31:31.166281 7f22b4a7b700 1 -- 188.42.216.238:6800/3595 --> 78.140.137.209:6789/0 -- auth(proto 2 2 bytes epoch 0) v1 -- ?+0 0x561a79e40300 con 0x561a79db3980
2016-06-17 12:31:31.167715 7f22b4a7b700 1 -- 188.42.216.238:6800/3595 <== mon.1 78.140.137.209:6789/0 5 ==== mon_map magic: 0 v1 ==== 479+0+0 (2697293072 0 0) 0x561a79fe6900 con 0x561a79db3980
2016-06-17 12:31:31.167747 7f22b4a7b700 1 -- 188.42.216.238:6800/3595 <== mon.1 78.140.137.209:6789/0 6 ==== auth_reply(proto 2 0 (0) Success) v1 ==== 194+0+0 (1093016383 0 0) 0x561a79e40800 con 0x561a79db3980
2016-06-17 12:31:31.167899 7f22c776e8c0 1 -- 188.42.216.238:6800/3595 --> 78.140.137.209:6789/0 -- mon_subscribe({osdmap=0}) v2 -- ?+0 0x561a79da9400 con 0x561a79db3980
2016-06-17 12:31:31.167912 7f22c776e8c0 10 osd.6 6366 ensuring pgs have consumed prior maps
2016-06-17 12:31:31.167914 7f22c776e8c0 7 osd.6 6366 consume_map version 6366
2016-06-17 12:31:31.167918 7f22c776e8c0 0 osd.6 6366 done with init, starting boot process
2016-06-17 12:31:31.167923 7f22c776e8c0 1 -- 188.42.216.238:6800/3595 --> 78.140.137.209:6789/0 -- mon_subscribe({osd_pg_creates=0+}) v2 -- ?+0 0x561a79da9600 con 0x561a79db3980
2016-06-17 12:31:31.167929 7f22c776e8c0 1 osd.6 6366 We are healthy, booting
2016-06-17 12:31:31.167931 7f22c776e8c0 10 osd.6 6366 start_boot - have maps 5599..6366
2016-06-17 12:31:31.167937 7f22c776e8c0 1 -- 188.42.216.238:6800/3595 --> 78.140.137.209:6789/0 -- mon_get_version(what=osdmap handle=1) v1 -- ?+0 0x561a79da9c00 con 0x561a79db3980
2016-06-17 12:31:31.170349 7f22b4a7b700 1 -- 188.42.216.238:6800/3595 <== mon.1 78.140.137.209:6789/0 7 ==== osd_map(6366..6366 src has 5599..6366) v3 ==== 18153+0+0 (799757880 0 0) 0x561a79e40a80 con 0x561a79db3980
2016-06-17 12:31:31.170372 7f22b4a7b700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:31.170375 7f22b4a7b700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:31.170376 7f22b4a7b700 20 osd.6 6366 _dispatch 0x561a79e40a80 osd_map(6366..6366 src has 5599..6366) v3
2016-06-17 12:31:31.170484 7f22b4a7b700 3 osd.6 6366 handle_osd_map epochs [6366,6366], i have 6366, src has [5599,6366]
2016-06-17 12:31:31.170492 7f22b4a7b700 10 osd.6 6366 no new maps here, dropping
2016-06-17 12:31:31.170493 7f22b4a7b700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:31.170494 7f22b4a7b700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:31.170498 7f22b4a7b700 1 -- 188.42.216.238:6800/3595 <== mon.1 78.140.137.209:6789/0 8 ==== mon_get_version_reply(handle=1 version=6366) v2 ==== 24+0+0 (4273811546 0 0) 0x561a79da9200 con 0x561a79db3980
2016-06-17 12:31:31.170517 7f22ac26a700 10 osd.6 6366 _preboot _preboot mon has osdmaps 5599..6366
2016-06-17 12:31:31.170519 7f22ac26a700 10 osd.6 6366 _send_boot
2016-06-17 12:31:31.170532 7f22ac26a700 10 osd.6 6366 new session (outgoing) 0x561a79da9600 con=0x561a79db2900 addr=188.42.216.238:6801/3595
2016-06-17 12:31:31.170538 7f22ac26a700 10 osd.6 6366 assuming cluster_addr ip matches client_addr
2016-06-17 12:31:31.170540 7f22ac26a700 10 osd.6 6366 assuming hb_back_addr ip matches cluster_addr
2016-06-17 12:31:31.170541 7f22ac26a700 10 osd.6 6366 assuming hb_front_addr ip matches client_addr
2016-06-17 12:31:31.170553 7f22ac26a700 10 osd.6 6366 client_addr 188.42.216.238:6800/3595, cluster_addr 188.42.216.238:6801/3595, hb_back_addr 188.42.216.238:6802/3595, hb_front_addr 188.42.216.238:6803/3595
2016-06-17 12:31:31.218641 7f22ac26a700 10 osd.6 6366 _collect_metadata {arch=x86_64,back_addr=188.42.216.238:6801/3595,backend_filestore_dev_node=unknown,backend_filestore_partition_path=unknown,ceph_version=ceph version 10.2.0 (3a9fba20ec743699b69bd0181dd6c54dc01c64b9),cpu=Intel(R) Xeon(R) CPU E5-2630 v3 @ 2.40GHz,distro=Ubuntu,distro_codename=xenial,distro_description=Ubuntu 16.04 LTS,distro_version=16.04,filestore_backend=generic,filestore_f_type=0xef53,front_addr=188.42.216.238:6800/3595,hb_back_addr=188.42.216.238:6802/3595,hb_front_addr=188.42.216.238:6803/3595,hostname=c1,kernel_description=#43-Ubuntu SMP Wed Jun 8 19:27:37 UTC 2016,kernel_version=4.4.0-24-generic,mem_swap_kb=0,mem_total_kb=6110892,os=Linux,osd_data=/var/lib/ceph/osd/ceph-6,osd_journal=/var/lib/ceph/osd/ceph-6/journal,osd_objectstore=filestore}
2016-06-17 12:31:31.218754 7f22ac26a700 1 -- 188.42.216.238:6800/3595 --> 78.140.137.209:6789/0 -- osd_boot(osd.6 booted 0 features 576460752032874495 v6366) v6 -- ?+0 0x561a79fc2d00 con 0x561a79db3980
2016-06-17 12:31:35.256716 7f22a425a700 20 osd.6 6366 update_osd_stat osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:31:35.256735 7f22a425a700 5 osd.6 6366 heartbeat: osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:31:37.156541 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:37.156564 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:37.156565 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:37.156614 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:37.156616 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:31:37.556956 7f22a425a700 20 osd.6 6366 update_osd_stat osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:31:37.556971 7f22a425a700 5 osd.6 6366 heartbeat: osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:31:38.156784 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:38.156817 7f22bc3e8700 20 osd.6 6366 can_inc_scrubs_pending0 -> 1 (max 1, active 0)
2016-06-17 12:31:38.156838 7f22bc3e8700 20 osd.6 6366 scrub_time_permit should run between 0 - 24 now 12 = yes
2016-06-17 12:31:38.156924 7f22bc3e8700 20 osd.6 6366 scrub_load_below_threshold loadavg 0 < max 0.5 = yes
2016-06-17 12:31:38.157033 7f22bc3e8700 20 osd.6 6366 sched_scrub load_is_low=1
2016-06-17 12:31:38.157036 7f22bc3e8700 20 osd.6 6366 sched_scrub done
2016-06-17 12:31:38.157048 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:38.157050 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:38.157052 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:39.157127 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:39.157153 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:39.157156 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:39.157168 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:39.157172 7f22bc3e8700 20 osd.6 6366 can_inc_scrubs_pending0 -> 1 (max 1, active 0)
2016-06-17 12:31:39.157177 7f22bc3e8700 20 osd.6 6366 scrub_time_permit should run between 0 - 24 now 12 = yes
2016-06-17 12:31:39.157224 7f22bc3e8700 20 osd.6 6366 scrub_load_below_threshold loadavg 0 < max 0.5 = yes
2016-06-17 12:31:39.157270 7f22bc3e8700 20 osd.6 6366 sched_scrub load_is_low=1
2016-06-17 12:31:39.157273 7f22bc3e8700 20 osd.6 6366 sched_scrub done
2016-06-17 12:31:40.157269 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:40.157292 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:40.157296 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:40.157348 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:40.157352 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:31:41.157425 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:41.157444 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:41.157447 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:41.157457 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:41.157482 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:31:41.657306 7f22a425a700 20 osd.6 6366 update_osd_stat osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:31:41.657324 7f22a425a700 5 osd.6 6366 heartbeat: osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:31:42.157604 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:42.157638 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:42.157640 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:42.157680 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:42.157682 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:31:43.157760 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:43.157776 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:43.157827 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:43.157838 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:43.157840 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:31:44.157919 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:44.157940 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:44.157942 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:44.157980 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:44.157984 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:31:45.158057 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:45.158073 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:45.158076 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:45.158087 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:45.158089 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:31:46.158159 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:46.158200 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:46.158202 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:46.158214 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:46.158217 7f22bc3e8700 20 osd.6 6366 can_inc_scrubs_pending0 -> 1 (max 1, active 0)
2016-06-17 12:31:46.158239 7f22bc3e8700 20 osd.6 6366 scrub_time_permit should run between 0 - 24 now 12 = yes
2016-06-17 12:31:46.158300 7f22bc3e8700 20 osd.6 6366 scrub_load_below_threshold loadavg 0 < max 0.5 = yes
2016-06-17 12:31:46.158316 7f22bc3e8700 20 osd.6 6366 sched_scrub load_is_low=1
2016-06-17 12:31:46.158318 7f22bc3e8700 20 osd.6 6366 sched_scrub done
2016-06-17 12:31:46.357532 7f22a425a700 20 osd.6 6366 update_osd_stat osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:31:46.357552 7f22a425a700 5 osd.6 6366 heartbeat: osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:31:47.158322 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:47.158344 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:47.158346 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:47.158443 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:47.158450 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:31:48.158489 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:48.158506 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:48.158508 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:48.158532 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:48.158535 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:31:49.158589 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:49.158605 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:31:49.158613 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:49.158615 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:49.158617 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:50.158739 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:50.158758 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:31:50.158780 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:50.158783 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:50.158784 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:50.457788 7f22a425a700 20 osd.6 6366 update_osd_stat osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:31:50.457806 7f22a425a700 5 osd.6 6366 heartbeat: osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:31:51.158899 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:51.158930 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:51.158933 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:51.158957 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:51.158960 7f22bc3e8700 20 osd.6 6366 can_inc_scrubs_pending0 -> 1 (max 1, active 0)
2016-06-17 12:31:51.158974 7f22bc3e8700 20 osd.6 6366 scrub_time_permit should run between 0 - 24 now 12 = yes
2016-06-17 12:31:51.159038 7f22bc3e8700 20 osd.6 6366 scrub_load_below_threshold loadavg 0 < max 0.5 = yes
2016-06-17 12:31:51.159047 7f22bc3e8700 20 osd.6 6366 sched_scrub load_is_low=1
2016-06-17 12:31:51.159050 7f22bc3e8700 20 osd.6 6366 sched_scrub done
2016-06-17 12:31:52.159066 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:52.159085 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:52.159086 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:52.159219 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:52.159223 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:31:53.159238 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:53.159318 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:53.159319 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:53.159342 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:53.159347 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:31:54.159460 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:54.159469 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:31:54.159477 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:54.159479 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:54.159481 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:55.158000 7f22a425a700 20 osd.6 6366 update_osd_stat osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:31:55.158018 7f22a425a700 5 osd.6 6366 heartbeat: osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:31:55.159603 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:55.159618 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:31:55.159633 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:55.159637 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:55.159640 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:56.159723 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:56.159740 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:31:56.159748 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:56.159751 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:56.159752 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:57.159880 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:57.159904 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:31:57.159918 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:57.159922 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:57.159924 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:57.458255 7f22a425a700 20 osd.6 6366 update_osd_stat osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:31:57.458274 7f22a425a700 5 osd.6 6366 heartbeat: osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:31:58.160113 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:58.160139 7f22bc3e8700 20 osd.6 6366 can_inc_scrubs_pending0 -> 1 (max 1, active 0)
2016-06-17 12:31:58.160155 7f22bc3e8700 20 osd.6 6366 scrub_time_permit should run between 0 - 24 now 12 = yes
2016-06-17 12:31:58.160222 7f22bc3e8700 20 osd.6 6366 scrub_load_below_threshold loadavg 0 < max 0.5 = yes
2016-06-17 12:31:58.160251 7f22bc3e8700 20 osd.6 6366 sched_scrub load_is_low=1
2016-06-17 12:31:58.160255 7f22bc3e8700 20 osd.6 6366 sched_scrub done
2016-06-17 12:31:58.160273 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:58.160277 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:58.160279 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:59.158408 7f22a425a700 20 osd.6 6366 update_osd_stat osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:31:59.158425 7f22a425a700 5 osd.6 6366 heartbeat: osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:31:59.160348 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:31:59.160355 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:31:59.160371 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:31:59.160380 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:31:59.160382 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:32:00.160541 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:32:00.160560 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:32:00.160562 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:32:00.160599 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:32:00.160602 7f22bc3e8700 20 osd.6 6366 can_inc_scrubs_pending0 -> 1 (max 1, active 0)
2016-06-17 12:32:00.160613 7f22bc3e8700 20 osd.6 6366 scrub_time_permit should run between 0 - 24 now 12 = yes
2016-06-17 12:32:00.160668 7f22bc3e8700 20 osd.6 6366 scrub_load_below_threshold loadavg 0 < max 0.5 = yes
2016-06-17 12:32:00.160690 7f22bc3e8700 20 osd.6 6366 sched_scrub load_is_low=1
2016-06-17 12:32:00.160691 7f22bc3e8700 20 osd.6 6366 sched_scrub done
2016-06-17 12:32:01.160714 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:32:01.160757 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:32:01.160761 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:32:01.160784 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:32:01.160788 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:32:02.160897 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:32:02.160916 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:32:02.160918 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:32:02.160941 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:32:02.160943 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:32:03.161062 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:32:03.161085 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:32:03.161088 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:32:03.161108 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:32:03.161112 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:32:04.161265 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:32:04.161327 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:32:04.161349 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:32:04.161352 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:32:04.161354 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:32:04.458752 7f22a425a700 20 osd.6 6366 update_osd_stat osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:32:04.458778 7f22a425a700 5 osd.6 6366 heartbeat: osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:32:05.161436 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:32:05.161458 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:32:05.161459 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:32:05.161470 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:32:05.161475 7f22bc3e8700 20 osd.6 6366 can_inc_scrubs_pending0 -> 1 (max 1, active 0)
2016-06-17 12:32:05.161486 7f22bc3e8700 20 osd.6 6366 scrub_time_permit should run between 0 - 24 now 12 = yes
2016-06-17 12:32:05.161523 7f22bc3e8700 20 osd.6 6366 scrub_load_below_threshold loadavg 0 < max 0.5 = yes
2016-06-17 12:32:05.161532 7f22bc3e8700 20 osd.6 6366 sched_scrub load_is_low=1
2016-06-17 12:32:05.161533 7f22bc3e8700 20 osd.6 6366 sched_scrub done
2016-06-17 12:32:06.161572 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:32:06.161612 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:32:06.161614 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:32:06.161636 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:32:06.161639 7f22bc3e8700 20 osd.6 6366 can_inc_scrubs_pending0 -> 1 (max 1, active 0)
2016-06-17 12:32:06.161649 7f22bc3e8700 20 osd.6 6366 scrub_time_permit should run between 0 - 24 now 12 = yes
2016-06-17 12:32:06.161702 7f22bc3e8700 20 osd.6 6366 scrub_load_below_threshold loadavg 0 < max 0.5 = yes
2016-06-17 12:32:06.161722 7f22bc3e8700 20 osd.6 6366 sched_scrub load_is_low=1
2016-06-17 12:32:06.161723 7f22bc3e8700 20 osd.6 6366 sched_scrub done
2016-06-17 12:32:07.161712 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:32:07.161729 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:32:07.161730 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:32:07.161898 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:32:07.161913 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:32:08.161843 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:32:08.161861 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:32:08.161863 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:32:08.162021 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:32:08.162025 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:32:09.162005 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:32:09.162023 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:32:09.162024 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:32:09.162066 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:32:09.162069 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:32:10.162224 7f22bc3e8700 10 osd.6 6366 tick_without_osd_lock
2016-06-17 12:32:10.162261 7f22bc3e8700 20 osd.6 6366 scrub_random_backoff lost coin flip, randomly backing off
2016-06-17 12:32:10.162274 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:32:10.162285 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:32:10.162287 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
2016-06-17 12:32:10.359032 7f22a425a700 20 osd.6 6366 update_osd_stat osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
2016-06-17 12:32:10.359063 7f22a425a700 5 osd.6 6366 heartbeat: osd_stat(6312 MB used, 85842 MB avail, 96281 MB total, peers []/[] op hist [])
^[OF2016-06-17 12:32:11.162436 7f22bcbe9700 10 osd.6 6366 tick
2016-06-17 12:32:11.162476 7f22bcbe9700 10 osd.6 6366 do_waiters -- start
2016-06-17 12:32:11.162478 7f22bcbe9700 10 osd.6 6366 do_waiters -- finish
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment