Re: luminous ceph-osd crash

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

 



Hi,

/var/log/ceph/ceph-osd.0.log is attached.
My sdb is 128MB and sdc (journal) is 16MB:

[root@server0 ~]# ceph-disk list
/dev/dm-0 other, xfs, mounted on /
/dev/dm-1 swap, swap
/dev/sda :
 /dev/sda1 other, 0x83
 /dev/sda2 other, xfs, mounted on /boot
 /dev/sda3 other, LVM2_member
/dev/sdb :
 /dev/sdb1 ceph data, active, cluster ceph, osd.0, journal /dev/sdc1
/dev/sdc :
 /dev/sdc1 ceph journal, for /dev/sdb1

Marcin

On Thu, Aug 31, 2017 at 3:05 PM, Sage Weil <sage@xxxxxxxxxxxx> wrote:
Hi Marcin,

Can you reproduce the crash with 'debug bluestore = 20' set, and then
ceph-post-file /var/log/ceph/ceph-osd.0.log?

My guess is that we're not handling a very small device properly?

sage


On Thu, 31 Aug 2017, Marcin Dulak wrote:

> Hi,
>
> I have a virtual CentOS 7.3 test setup at:
> https://github.com/marcindulak/github-test-local/blob/a339ff7505267545f593f
> d949a6453a56cdfd7fe/vagrant-ceph-rbd-tutorial-centos7.sh
>
> It seems to crash reproducibly with luminous, and works with kraken.
> Is this a known issue?
>
> [ceph_deploy.conf][DEBUG ] found configuration file at:
> /home/ceph/.cephdeploy.conf
> [ceph_deploy.cli][INFO  ] Invoked (1.5.37): /bin/ceph-deploy osd activate
> server0:/dev/sdb1:/dev/sdc server1:/dev/sdb1:/dev/sdc
> server2:/dev/sdb1:/dev/sdc
> [ceph_deploy.cli][INFO  ] ceph-deploy options:
> [ceph_deploy.cli][INFO  ]  username                      : None
> [ceph_deploy.cli][INFO  ]  verbose                       : False
> [ceph_deploy.cli][INFO  ]  overwrite_conf                : False
> [ceph_deploy.cli][INFO  ]  subcommand                    : activate
> [ceph_deploy.cli][INFO  ]  quiet                         : False
> [ceph_deploy.cli][INFO  ]  cd_conf                       :
> <ceph_deploy.conf.cephdeploy.Conf instance at 0x10ae710>
> [ceph_deploy.cli][INFO  ]  cluster                       : ceph
> [ceph_deploy.cli][INFO  ]  func                          : <function osd at
> 0x109fb90>
> [ceph_deploy.cli][INFO  ]  ceph_conf                     : None
> [ceph_deploy.cli][INFO  ]  default_release               : False
> [ceph_deploy.cli][INFO  ]  disk                          : [('server0',
> '/dev/sdb1', '/dev/sdc'), ('server1', '/dev/sdb1', '/dev/sdc'), ('server2',
> '/dev/sdb1', '/dev/sdc')]
> [ceph_deploy.osd][DEBUG ] Activating cluster ceph disks
> server0:/dev/sdb1:/dev/sdc server1:/dev/sdb1:/dev/sdc
> server2:/dev/sdb1:/dev/sdc
> [server0][DEBUG ] connection detected need for sudo
> [server0][DEBUG ] connected to host: server0 
> [server0][DEBUG ] detect platform information from remote host
> [server0][DEBUG ] detect machine type
> [server0][DEBUG ] find the location of an executable
> [ceph_deploy.osd][INFO  ] Distro info: CentOS Linux 7.3.1611 Core
> [ceph_deploy.osd][DEBUG ] activating host server0 disk /dev/sdb1
> [ceph_deploy.osd][DEBUG ] will use init type: systemd
> [server0][DEBUG ] find the location of an executable
> [server0][INFO  ] Running command: sudo /usr/sbin/ceph-disk -v activate
> --mark-init systemd --mount /dev/sdb1
> [server0][WARNIN] main_activate: path = /dev/sdb1
> [server0][WARNIN] get_dm_uuid: get_dm_uuid /dev/sdb1 uuid path is
> /sys/dev/block/8:17/dm/uuid
> [server0][WARNIN] command: Running command: /sbin/blkid -o udev -p /dev/sdb1
> [server0][WARNIN] command: Running command: /sbin/blkid -p -s TYPE -o value
> -- /dev/sdb1
> [server0][WARNIN] command: Running command: /usr/bin/ceph-conf
> --cluster=ceph --name=osd. --lookup osd_mount_options_xfs
> [server0][WARNIN] command: Running command: /usr/bin/ceph-conf
> --cluster=ceph --name=osd. --lookup osd_fs_mount_options_xfs
> [server0][WARNIN] mount: Mounting /dev/sdb1 on /var/lib/ceph/tmp/mnt.wfKzzb
> with options noatime,inode64
> [server0][WARNIN] command_check_call: Running command: /usr/bin/mount -t xfs
> -o noatime,inode64 -- /dev/sdb1 /var/lib/ceph/tmp/mnt.wfKzzb
> [server0][WARNIN] command: Running command: /sbin/restorecon
> /var/lib/ceph/tmp/mnt.wfKzzb
> [server0][WARNIN] activate: Cluster uuid is
> 04e79ca9-308c-41a5-b40d-a2737c34238d
> [server0][WARNIN] command: Running command: /usr/bin/ceph-osd --cluster=ceph
> --show-config-value=fsid
> [server0][WARNIN] activate: Cluster name is ceph
> [server0][WARNIN] activate: OSD uuid is 46d7cc0b-a087-4c8c-b00c-ff584c941cf9
> [server0][WARNIN] activate: OSD id is 0
> [server0][WARNIN] activate: Initializing OSD...
> [server0][WARNIN] command_check_call: Running command: /usr/bin/ceph
> --cluster ceph --name client.bootstrap-osd --keyring
> /var/lib/ceph/bootstrap-osd/ceph.keyring mon getmap -o
> /var/lib/ceph/tmp/mnt.wfKzzb/activate.monmap
> [server0][WARNIN] got monmap epoch 1
> [server0][WARNIN] command_check_call: Running command: /usr/bin/ceph-osd
> --cluster ceph --mkfs -i 0 --monmap
> /var/lib/ceph/tmp/mnt.wfKzzb/activate.monmap --osd-data
> /var/lib/ceph/tmp/mnt.wfKzzb --osd-uuid 46d7cc0b-a087-4c8c-b00c-ff584c941cf9
> --setuser ceph --setgroup ceph
> [server0][WARNIN]/home/jenkins-build/build/workspace/ceph-build/ARCH/x86_64/AVAILABLE_ARCH/x
> 86_64/AVAILABLE_DIST/centos7/DIST/centos7/MACHINE_SIZE/huge/release/12.2.0/
> rpm/el7/BUILD/ceph-12.2.0/src/os/bluestore/BlueFS.cc: In function 'void
> BlueFS::add_block_extent(unsigned int, uint64_t, uint64_t)' thread
> 7fef4f0cfd00 time 2017-08-31 10:05:31.892519
> [server0][WARNIN]/home/jenkins-build/build/workspace/ceph-build/ARCH/x86_64/AVAILABLE_ARCH/x
> 86_64/AVAILABLE_DIST/centos7/DIST/centos7/MACHINE_SIZE/huge/release/12.2.0/
> rpm/el7/BUILD/ceph-12.2.0/src/os/bluestore/BlueFS.cc: 172: FAILED
> assert(bdev[id]->get_size() >= offset + length)
> [server0][WARNIN]  ceph version 12.2.0
> (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc)
> [server0][WARNIN]  1: (ceph::__ceph_assert_fail(char const*, char const*,
> int, char const*)+0x110) [0x7fef4fb4c510]
> [server0][WARNIN]  2: (BlueFS::add_block_extent(unsigned int, unsigned long,
> unsigned long)+0x4d8) [0x7fef4fad1f88]
> [server0][WARNIN]  3: (BlueStore::_open_db(bool)+0xc4f) [0x7fef4f9f597f]
> [server0][WARNIN]  4: (BlueStore::mkfs()+0xd0d) [0x7fef4f9ff99d]
> [server0][WARNIN]  5: (OSD::mkfs(CephContext*, ObjectStore*, std::string
> const&, uuid_d, int)+0x29b) [0x7fef4f5b6f1b]
> [server0][WARNIN]  6: (main()+0xf42) [0x7fef4f4f6972]
> [server0][WARNIN]  7: (__libc_start_main()+0xf5) [0x7fef4b72fb35]
> [server0][WARNIN]  8: (()+0x4acb56) [0x7fef4f596b56]
>
> Cheers,
>
> Marcin
>
>

2017-08-31 23:05:31.571475 7f2f3fb7ed00  0 set uid:gid to 1001:1001 (ceph:ceph)
2017-08-31 23:05:31.571494 7f2f3fb7ed00  0 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc), process (unknown), pid 7060
2017-08-31 23:05:31.571649 7f2f3fb7ed00 10 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) set_cache_shards 1
2017-08-31 23:05:31.589045 7f2f3fb7ed00 10 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) _set_csum csum_type crc32c
2017-08-31 23:05:31.590082 7f2f3fb7ed00  1 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) mkfs path /var/lib/ceph/tmp/mnt.nRchwF
2017-08-31 23:05:31.590118 7f2f3fb7ed00 20 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) _setup_block_symlink_or_file name block path  size 10737418240 create=1
2017-08-31 23:05:31.590340 7f2f3fb7ed00 20 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) _setup_block_symlink_or_file name block.wal path  size 100663296 create=0
2017-08-31 23:05:31.590346 7f2f3fb7ed00 20 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) _setup_block_symlink_or_file name block.db path  size 0 create=0
2017-08-31 23:05:31.590361 7f2f3fb7ed00  1 bdev create path /var/lib/ceph/tmp/mnt.nRchwF/block type kernel
2017-08-31 23:05:31.590366 7f2f3fb7ed00  1 bdev(0x7f2f4b73c800 /var/lib/ceph/tmp/mnt.nRchwF/block) open path /var/lib/ceph/tmp/mnt.nRchwF/block
2017-08-31 23:05:31.590737 7f2f3fb7ed00  1 bdev(0x7f2f4b73c800 /var/lib/ceph/tmp/mnt.nRchwF/block) open size 28291072 (0x1afb000, 27628 kB) block_size 4096 (4096 B) rotational
2017-08-31 23:05:31.590749 7f2f3fb7ed00 10 bluestore(/var/lib/ceph/tmp/mnt.nRchwF/block) _write_bdev_label path /var/lib/ceph/tmp/mnt.nRchwF/block label bdev(osd_uuid 55ffcfe9-cc63-49ef-9ef7-383999d8627b size 0x1afb000 btime 2017-08-31 23:05:31.590747 desc main)
2017-08-31 23:05:31.590795 7f2f3fb7ed00  1 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) _set_cache_sizes max 0.5 < ratio 0.99
2017-08-31 23:05:31.590812 7f2f3fb7ed00  1 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) _set_cache_sizes cache_size 1073741824 meta 0.5 kv 0.5 data 0
2017-08-31 23:05:31.590818 7f2f3fb7ed00 10 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) _open_db kv_backend = rocksdb
2017-08-31 23:05:31.590820 7f2f3fb7ed00 10 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) _open_db do_bluefs = 1
2017-08-31 23:05:31.590820 7f2f3fb7ed00 10 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) _open_db initializing bluefs
2017-08-31 23:05:31.590836 7f2f3fb7ed00  1 bdev create path /var/lib/ceph/tmp/mnt.nRchwF/block type kernel
2017-08-31 23:05:31.590838 7f2f3fb7ed00  1 bdev(0x7f2f4b9cd000 /var/lib/ceph/tmp/mnt.nRchwF/block) open path /var/lib/ceph/tmp/mnt.nRchwF/block
2017-08-31 23:05:31.590929 7f2f3fb7ed00  1 bdev(0x7f2f4b9cd000 /var/lib/ceph/tmp/mnt.nRchwF/block) open size 28291072 (0x1afb000, 27628 kB) block_size 4096 (4096 B) rotational
2017-08-31 23:05:31.590934 7f2f3fb7ed00  1 bluefs add_block_device bdev 1 path /var/lib/ceph/tmp/mnt.nRchwF/block size 27628 kB
2017-08-31 23:05:31.590937 7f2f3fb7ed00  1 bluefs add_block_extent bdev 1 0x7fffffffe0d00000~40000000
2017-08-31 23:05:31.593142 7f2f3fb7ed00 -1 /home/jenkins-build/build/workspace/ceph-build/ARCH/x86_64/AVAILABLE_ARCH/x86_64/AVAILABLE_DIST/centos7/DIST/centos7/MACHINE_SIZE/huge/release/12.2.0/rpm/el7/BUILD/ceph-12.2.0/src/os/bluestore/BlueFS.cc: In function 'void BlueFS::add_block_extent(unsigned int, uint64_t, uint64_t)' thread 7f2f3fb7ed00 time 2017-08-31 23:05:31.590939
/home/jenkins-build/build/workspace/ceph-build/ARCH/x86_64/AVAILABLE_ARCH/x86_64/AVAILABLE_DIST/centos7/DIST/centos7/MACHINE_SIZE/huge/release/12.2.0/rpm/el7/BUILD/ceph-12.2.0/src/os/bluestore/BlueFS.cc: 172: FAILED assert(bdev[id]->get_size() >= offset + length)

 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc)
 1: (ceph::__ceph_assert_fail(char const*, char const*, int, char const*)+0x110) [0x7f2f405fb510]
 2: (BlueFS::add_block_extent(unsigned int, unsigned long, unsigned long)+0x4d8) [0x7f2f40580f88]
 3: (BlueStore::_open_db(bool)+0xc4f) [0x7f2f404a497f]
 4: (BlueStore::mkfs()+0xd0d) [0x7f2f404ae99d]
 5: (OSD::mkfs(CephContext*, ObjectStore*, std::string const&, uuid_d, int)+0x29b) [0x7f2f40065f1b]
 6: (main()+0xf42) [0x7f2f3ffa5972]
 7: (__libc_start_main()+0xf5) [0x7f2f3c1deb35]
 8: (()+0x4acb56) [0x7f2f40045b56]
 NOTE: a copy of the executable, or `objdump -rdS <executable>` is needed to interpret this.

--- begin dump of recent events ---
   -63> 2017-08-31 23:05:31.563828 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command perfcounters_dump hook 0x7f2f4b6fa190
   -62> 2017-08-31 23:05:31.563841 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command 1 hook 0x7f2f4b6fa190
   -61> 2017-08-31 23:05:31.563843 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command perf dump hook 0x7f2f4b6fa190
   -60> 2017-08-31 23:05:31.563845 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command perfcounters_schema hook 0x7f2f4b6fa190
   -59> 2017-08-31 23:05:31.563852 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command perf histogram dump hook 0x7f2f4b6fa190
   -58> 2017-08-31 23:05:31.563855 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command 2 hook 0x7f2f4b6fa190
   -57> 2017-08-31 23:05:31.563857 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command perf schema hook 0x7f2f4b6fa190
   -56> 2017-08-31 23:05:31.563858 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command perf histogram schema hook 0x7f2f4b6fa190
   -55> 2017-08-31 23:05:31.563860 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command perf reset hook 0x7f2f4b6fa190
   -54> 2017-08-31 23:05:31.563861 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command config show hook 0x7f2f4b6fa190
   -53> 2017-08-31 23:05:31.563863 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command config help hook 0x7f2f4b6fa190
   -52> 2017-08-31 23:05:31.563865 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command config set hook 0x7f2f4b6fa190
   -51> 2017-08-31 23:05:31.563867 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command config get hook 0x7f2f4b6fa190
   -50> 2017-08-31 23:05:31.563877 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command config diff hook 0x7f2f4b6fa190
   -49> 2017-08-31 23:05:31.563880 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command config diff get hook 0x7f2f4b6fa190
   -48> 2017-08-31 23:05:31.563882 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command log flush hook 0x7f2f4b6fa190
   -47> 2017-08-31 23:05:31.563883 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command log dump hook 0x7f2f4b6fa190
   -46> 2017-08-31 23:05:31.563885 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command log reopen hook 0x7f2f4b6fa190
   -45> 2017-08-31 23:05:31.563890 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command dump_mempools hook 0x7f2f4b8d1b08
   -44> 2017-08-31 23:05:31.571475 7f2f3fb7ed00  0 set uid:gid to 1001:1001 (ceph:ceph)
   -43> 2017-08-31 23:05:31.571494 7f2f3fb7ed00  0 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc), process (unknown), pid 7060
   -42> 2017-08-31 23:05:31.571539 7f2f3fb7ed00  5 object store type is bluestore
   -41> 2017-08-31 23:05:31.571649 7f2f3fb7ed00 10 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) set_cache_shards 1
   -40> 2017-08-31 23:05:31.589045 7f2f3fb7ed00 10 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) _set_csum csum_type crc32c
   -39> 2017-08-31 23:05:31.589059 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) init /var/run/ceph/ceph-osd.0.asok
   -38> 2017-08-31 23:05:31.589077 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) bind_and_listen /var/run/ceph/ceph-osd.0.asok
   -37> 2017-08-31 23:05:31.589378 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command 0 hook 0x7f2f4b6f6180
   -36> 2017-08-31 23:05:31.589383 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command version hook 0x7f2f4b6f6180
   -35> 2017-08-31 23:05:31.589386 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command git_version hook 0x7f2f4b6f6180
   -34> 2017-08-31 23:05:31.589388 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command help hook 0x7f2f4b6fa290
   -33> 2017-08-31 23:05:31.589389 7f2f3fb7ed00  5 asok(0x7f2f4b7521c0) register_command get_command_descriptions hook 0x7f2f4b6fa2a0
   -32> 2017-08-31 23:05:31.589432 7f2f3fb7ed00 10 monclient: build_initial_monmap
   -31> 2017-08-31 23:05:31.589507 7f2f3fb7ed00 10 monclient: get_monmap_privately
   -30> 2017-08-31 23:05:31.589819 7f2f3975c700  5 asok(0x7f2f4b7521c0) entry start
   -29> 2017-08-31 23:05:31.589835 7f2f38f5b700  2 Event(0x7f2f4b73cc80 nevent=5000 time_id=1).set_owner idx=0 owner=139840795817728
   -28> 2017-08-31 23:05:31.589865 7f2f3875a700  2 Event(0x7f2f4b73d480 nevent=5000 time_id=1).set_owner idx=1 owner=139840787425024
   -27> 2017-08-31 23:05:31.589877 7f2f37f59700  2 Event(0x7f2f4b73ce80 nevent=5000 time_id=1).set_owner idx=2 owner=139840779032320
   -26> 2017-08-31 23:05:31.589905 7f2f3fb7ed00  1  Processor -- start
   -25> 2017-08-31 23:05:31.589944 7f2f3fb7ed00  1 -- - start start
   -24> 2017-08-31 23:05:31.589947 7f2f3fb7ed00 10 monclient: have 1 fsid cbc93c9d-f4ee-4039-b738-c09cb52bff9c
   -23> 2017-08-31 23:05:31.589960 7f2f3fb7ed00  1 -- - shutdown_connections 
   -22> 2017-08-31 23:05:31.590027 7f2f3fb7ed00  1 -- - shutdown_connections 
   -21> 2017-08-31 23:05:31.590042 7f2f3fb7ed00  1 -- - wait complete.
   -20> 2017-08-31 23:05:31.590046 7f2f3fb7ed00  1 -- - >> - conn(0x7f2f4ba9e000 :-1 s=STATE_NONE pgs=0 cs=0 l=0).mark_down
   -19> 2017-08-31 23:05:31.590053 7f2f3fb7ed00  2 -- - >> - conn(0x7f2f4ba9e000 :-1 s=STATE_NONE pgs=0 cs=0 l=0)._stop
   -18> 2017-08-31 23:05:31.590082 7f2f3fb7ed00  1 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) mkfs path /var/lib/ceph/tmp/mnt.nRchwF
   -17> 2017-08-31 23:05:31.590118 7f2f3fb7ed00 20 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) _setup_block_symlink_or_file name block path  size 10737418240 create=1
   -16> 2017-08-31 23:05:31.590340 7f2f3fb7ed00 20 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) _setup_block_symlink_or_file name block.wal path  size 100663296 create=0
   -15> 2017-08-31 23:05:31.590346 7f2f3fb7ed00 20 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) _setup_block_symlink_or_file name block.db path  size 0 create=0
   -14> 2017-08-31 23:05:31.590361 7f2f3fb7ed00  1 bdev create path /var/lib/ceph/tmp/mnt.nRchwF/block type kernel
   -13> 2017-08-31 23:05:31.590366 7f2f3fb7ed00  1 bdev(0x7f2f4b73c800 /var/lib/ceph/tmp/mnt.nRchwF/block) open path /var/lib/ceph/tmp/mnt.nRchwF/block
   -12> 2017-08-31 23:05:31.590737 7f2f3fb7ed00  1 bdev(0x7f2f4b73c800 /var/lib/ceph/tmp/mnt.nRchwF/block) open size 28291072 (0x1afb000, 27628 kB) block_size 4096 (4096 B) rotational
   -11> 2017-08-31 23:05:31.590749 7f2f3fb7ed00 10 bluestore(/var/lib/ceph/tmp/mnt.nRchwF/block) _write_bdev_label path /var/lib/ceph/tmp/mnt.nRchwF/block label bdev(osd_uuid 55ffcfe9-cc63-49ef-9ef7-383999d8627b size 0x1afb000 btime 2017-08-31 23:05:31.590747 desc main)
   -10> 2017-08-31 23:05:31.590795 7f2f3fb7ed00  1 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) _set_cache_sizes max 0.5 < ratio 0.99
    -9> 2017-08-31 23:05:31.590812 7f2f3fb7ed00  1 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) _set_cache_sizes cache_size 1073741824 meta 0.5 kv 0.5 data 0
    -8> 2017-08-31 23:05:31.590818 7f2f3fb7ed00 10 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) _open_db kv_backend = rocksdb
    -7> 2017-08-31 23:05:31.590820 7f2f3fb7ed00 10 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) _open_db do_bluefs = 1
    -6> 2017-08-31 23:05:31.590820 7f2f3fb7ed00 10 bluestore(/var/lib/ceph/tmp/mnt.nRchwF) _open_db initializing bluefs
    -5> 2017-08-31 23:05:31.590836 7f2f3fb7ed00  1 bdev create path /var/lib/ceph/tmp/mnt.nRchwF/block type kernel
    -4> 2017-08-31 23:05:31.590838 7f2f3fb7ed00  1 bdev(0x7f2f4b9cd000 /var/lib/ceph/tmp/mnt.nRchwF/block) open path /var/lib/ceph/tmp/mnt.nRchwF/block
    -3> 2017-08-31 23:05:31.590929 7f2f3fb7ed00  1 bdev(0x7f2f4b9cd000 /var/lib/ceph/tmp/mnt.nRchwF/block) open size 28291072 (0x1afb000, 27628 kB) block_size 4096 (4096 B) rotational
    -2> 2017-08-31 23:05:31.590934 7f2f3fb7ed00  1 bluefs add_block_device bdev 1 path /var/lib/ceph/tmp/mnt.nRchwF/block size 27628 kB
    -1> 2017-08-31 23:05:31.590937 7f2f3fb7ed00  1 bluefs add_block_extent bdev 1 0x7fffffffe0d00000~40000000
     0> 2017-08-31 23:05:31.593142 7f2f3fb7ed00 -1 /home/jenkins-build/build/workspace/ceph-build/ARCH/x86_64/AVAILABLE_ARCH/x86_64/AVAILABLE_DIST/centos7/DIST/centos7/MACHINE_SIZE/huge/release/12.2.0/rpm/el7/BUILD/ceph-12.2.0/src/os/bluestore/BlueFS.cc: In function 'void BlueFS::add_block_extent(unsigned int, uint64_t, uint64_t)' thread 7f2f3fb7ed00 time 2017-08-31 23:05:31.590939
/home/jenkins-build/build/workspace/ceph-build/ARCH/x86_64/AVAILABLE_ARCH/x86_64/AVAILABLE_DIST/centos7/DIST/centos7/MACHINE_SIZE/huge/release/12.2.0/rpm/el7/BUILD/ceph-12.2.0/src/os/bluestore/BlueFS.cc: 172: FAILED assert(bdev[id]->get_size() >= offset + length)

 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc)
 1: (ceph::__ceph_assert_fail(char const*, char const*, int, char const*)+0x110) [0x7f2f405fb510]
 2: (BlueFS::add_block_extent(unsigned int, unsigned long, unsigned long)+0x4d8) [0x7f2f40580f88]
 3: (BlueStore::_open_db(bool)+0xc4f) [0x7f2f404a497f]
 4: (BlueStore::mkfs()+0xd0d) [0x7f2f404ae99d]
 5: (OSD::mkfs(CephContext*, ObjectStore*, std::string const&, uuid_d, int)+0x29b) [0x7f2f40065f1b]
 6: (main()+0xf42) [0x7f2f3ffa5972]
 7: (__libc_start_main()+0xf5) [0x7f2f3c1deb35]
 8: (()+0x4acb56) [0x7f2f40045b56]
 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_mirror
   0/ 5 rbd_replay
   0/ 5 journaler
   0/ 5 objectcacher
   0/ 5 client
   1/ 5 osd
   0/ 5 optracker
   0/ 5 objclass
   1/ 3 filestore
   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
   1/ 5 compressor
  20/20 bluestore
   1/ 5 bluefs
   1/ 3 bdev
   1/ 5 kstore
   4/ 5 rocksdb
   4/ 5 leveldb
   4/ 5 memdb
   1/ 5 kinetic
   1/ 5 fuse
   1/ 5 mgr
   1/ 5 mgrc
   1/ 5 dpdk
   1/ 5 eventtrace
  -2/-2 (syslog threshold)
  -1/-1 (stderr threshold)
  max_recent     10000
  max_new         1000
  log_file /var/log/ceph/ceph-osd.0.log
--- end dump of recent events ---
2017-08-31 23:05:31.595501 7f2f3fb7ed00 -1 *** Caught signal (Aborted) **
 in thread 7f2f3fb7ed00 thread_name:ceph-osd

 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc)
 1: (()+0xa23b21) [0x7f2f405bcb21]
 2: (()+0xf370) [0x7f2f3d1c8370]
 3: (gsignal()+0x37) [0x7f2f3c1f21d7]
 4: (abort()+0x148) [0x7f2f3c1f38c8]
 5: (ceph::__ceph_assert_fail(char const*, char const*, int, char const*)+0x284) [0x7f2f405fb684]
 6: (BlueFS::add_block_extent(unsigned int, unsigned long, unsigned long)+0x4d8) [0x7f2f40580f88]
 7: (BlueStore::_open_db(bool)+0xc4f) [0x7f2f404a497f]
 8: (BlueStore::mkfs()+0xd0d) [0x7f2f404ae99d]
 9: (OSD::mkfs(CephContext*, ObjectStore*, std::string const&, uuid_d, int)+0x29b) [0x7f2f40065f1b]
 10: (main()+0xf42) [0x7f2f3ffa5972]
 11: (__libc_start_main()+0xf5) [0x7f2f3c1deb35]
 12: (()+0x4acb56) [0x7f2f40045b56]
 NOTE: a copy of the executable, or `objdump -rdS <executable>` is needed to interpret this.

--- begin dump of recent events ---
     0> 2017-08-31 23:05:31.595501 7f2f3fb7ed00 -1 *** Caught signal (Aborted) **
 in thread 7f2f3fb7ed00 thread_name:ceph-osd

 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc)
 1: (()+0xa23b21) [0x7f2f405bcb21]
 2: (()+0xf370) [0x7f2f3d1c8370]
 3: (gsignal()+0x37) [0x7f2f3c1f21d7]
 4: (abort()+0x148) [0x7f2f3c1f38c8]
 5: (ceph::__ceph_assert_fail(char const*, char const*, int, char const*)+0x284) [0x7f2f405fb684]
 6: (BlueFS::add_block_extent(unsigned int, unsigned long, unsigned long)+0x4d8) [0x7f2f40580f88]
 7: (BlueStore::_open_db(bool)+0xc4f) [0x7f2f404a497f]
 8: (BlueStore::mkfs()+0xd0d) [0x7f2f404ae99d]
 9: (OSD::mkfs(CephContext*, ObjectStore*, std::string const&, uuid_d, int)+0x29b) [0x7f2f40065f1b]
 10: (main()+0xf42) [0x7f2f3ffa5972]
 11: (__libc_start_main()+0xf5) [0x7f2f3c1deb35]
 12: (()+0x4acb56) [0x7f2f40045b56]
 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_mirror
   0/ 5 rbd_replay
   0/ 5 journaler
   0/ 5 objectcacher
   0/ 5 client
   1/ 5 osd
   0/ 5 optracker
   0/ 5 objclass
   1/ 3 filestore
   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
   1/ 5 compressor
  20/20 bluestore
   1/ 5 bluefs
   1/ 3 bdev
   1/ 5 kstore
   4/ 5 rocksdb
   4/ 5 leveldb
   4/ 5 memdb
   1/ 5 kinetic
   1/ 5 fuse
   1/ 5 mgr
   1/ 5 mgrc
   1/ 5 dpdk
   1/ 5 eventtrace
  -2/-2 (syslog threshold)
  -1/-1 (stderr threshold)
  max_recent     10000
  max_new         1000
  log_file /var/log/ceph/ceph-osd.0.log
--- end dump of recent events ---
2017-08-31 23:05:32.168964 7f46398e5d00  0 set uid:gid to 1001:1001 (ceph:ceph)
2017-08-31 23:05:32.168980 7f46398e5d00  0 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc), process (unknown), pid 7136
2017-08-31 23:05:32.169171 7f46398e5d00 10 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) set_cache_shards 1
2017-08-31 23:05:32.186251 7f46398e5d00 10 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) _set_csum csum_type crc32c
2017-08-31 23:05:32.187466 7f46398e5d00  1 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) mkfs path /var/lib/ceph/tmp/mnt.Nsg_MB
2017-08-31 23:05:32.187504 7f46398e5d00 20 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) _setup_block_symlink_or_file name block path  size 10737418240 create=1
2017-08-31 23:05:32.187638 7f46398e5d00 20 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) _setup_block_symlink_or_file name block.wal path  size 100663296 create=0
2017-08-31 23:05:32.187650 7f46398e5d00 20 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) _setup_block_symlink_or_file name block.db path  size 0 create=0
2017-08-31 23:05:32.187694 7f46398e5d00  1 bdev create path /var/lib/ceph/tmp/mnt.Nsg_MB/block type kernel
2017-08-31 23:05:32.187699 7f46398e5d00  1 bdev(0x7f4643ce0400 /var/lib/ceph/tmp/mnt.Nsg_MB/block) open path /var/lib/ceph/tmp/mnt.Nsg_MB/block
2017-08-31 23:05:32.187955 7f46398e5d00  1 bdev(0x7f4643ce0400 /var/lib/ceph/tmp/mnt.Nsg_MB/block) open size 28291072 (0x1afb000, 27628 kB) block_size 4096 (4096 B) rotational
2017-08-31 23:05:32.187968 7f46398e5d00 10 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB/block) _write_bdev_label path /var/lib/ceph/tmp/mnt.Nsg_MB/block label bdev(osd_uuid 55ffcfe9-cc63-49ef-9ef7-383999d8627b size 0x1afb000 btime 2017-08-31 23:05:32.187967 desc main)
2017-08-31 23:05:32.188018 7f46398e5d00  1 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) _set_cache_sizes max 0.5 < ratio 0.99
2017-08-31 23:05:32.188037 7f46398e5d00  1 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) _set_cache_sizes cache_size 1073741824 meta 0.5 kv 0.5 data 0
2017-08-31 23:05:32.188044 7f46398e5d00 10 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) _open_db kv_backend = rocksdb
2017-08-31 23:05:32.188045 7f46398e5d00 10 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) _open_db do_bluefs = 1
2017-08-31 23:05:32.188046 7f46398e5d00 10 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) _open_db initializing bluefs
2017-08-31 23:05:32.188061 7f46398e5d00  1 bdev create path /var/lib/ceph/tmp/mnt.Nsg_MB/block type kernel
2017-08-31 23:05:32.188063 7f46398e5d00  1 bdev(0x7f4643f71000 /var/lib/ceph/tmp/mnt.Nsg_MB/block) open path /var/lib/ceph/tmp/mnt.Nsg_MB/block
2017-08-31 23:05:32.188203 7f46398e5d00  1 bdev(0x7f4643f71000 /var/lib/ceph/tmp/mnt.Nsg_MB/block) open size 28291072 (0x1afb000, 27628 kB) block_size 4096 (4096 B) rotational
2017-08-31 23:05:32.188208 7f46398e5d00  1 bluefs add_block_device bdev 1 path /var/lib/ceph/tmp/mnt.Nsg_MB/block size 27628 kB
2017-08-31 23:05:32.188211 7f46398e5d00  1 bluefs add_block_extent bdev 1 0x7fffffffe0d00000~40000000
2017-08-31 23:05:32.190431 7f46398e5d00 -1 /home/jenkins-build/build/workspace/ceph-build/ARCH/x86_64/AVAILABLE_ARCH/x86_64/AVAILABLE_DIST/centos7/DIST/centos7/MACHINE_SIZE/huge/release/12.2.0/rpm/el7/BUILD/ceph-12.2.0/src/os/bluestore/BlueFS.cc: In function 'void BlueFS::add_block_extent(unsigned int, uint64_t, uint64_t)' thread 7f46398e5d00 time 2017-08-31 23:05:32.188213
/home/jenkins-build/build/workspace/ceph-build/ARCH/x86_64/AVAILABLE_ARCH/x86_64/AVAILABLE_DIST/centos7/DIST/centos7/MACHINE_SIZE/huge/release/12.2.0/rpm/el7/BUILD/ceph-12.2.0/src/os/bluestore/BlueFS.cc: 172: FAILED assert(bdev[id]->get_size() >= offset + length)

 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc)
 1: (ceph::__ceph_assert_fail(char const*, char const*, int, char const*)+0x110) [0x7f463a362510]
 2: (BlueFS::add_block_extent(unsigned int, unsigned long, unsigned long)+0x4d8) [0x7f463a2e7f88]
 3: (BlueStore::_open_db(bool)+0xc4f) [0x7f463a20b97f]
 4: (BlueStore::mkfs()+0xd0d) [0x7f463a21599d]
 5: (OSD::mkfs(CephContext*, ObjectStore*, std::string const&, uuid_d, int)+0x29b) [0x7f4639dccf1b]
 6: (main()+0xf42) [0x7f4639d0c972]
 7: (__libc_start_main()+0xf5) [0x7f4635f45b35]
 8: (()+0x4acb56) [0x7f4639dacb56]
 NOTE: a copy of the executable, or `objdump -rdS <executable>` is needed to interpret this.

--- begin dump of recent events ---
   -63> 2017-08-31 23:05:32.162260 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command perfcounters_dump hook 0x7f4643c9e190
   -62> 2017-08-31 23:05:32.162273 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command 1 hook 0x7f4643c9e190
   -61> 2017-08-31 23:05:32.162276 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command perf dump hook 0x7f4643c9e190
   -60> 2017-08-31 23:05:32.162277 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command perfcounters_schema hook 0x7f4643c9e190
   -59> 2017-08-31 23:05:32.162279 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command perf histogram dump hook 0x7f4643c9e190
   -58> 2017-08-31 23:05:32.162280 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command 2 hook 0x7f4643c9e190
   -57> 2017-08-31 23:05:32.162282 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command perf schema hook 0x7f4643c9e190
   -56> 2017-08-31 23:05:32.162283 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command perf histogram schema hook 0x7f4643c9e190
   -55> 2017-08-31 23:05:32.162285 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command perf reset hook 0x7f4643c9e190
   -54> 2017-08-31 23:05:32.162286 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command config show hook 0x7f4643c9e190
   -53> 2017-08-31 23:05:32.162287 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command config help hook 0x7f4643c9e190
   -52> 2017-08-31 23:05:32.162289 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command config set hook 0x7f4643c9e190
   -51> 2017-08-31 23:05:32.162291 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command config get hook 0x7f4643c9e190
   -50> 2017-08-31 23:05:32.162297 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command config diff hook 0x7f4643c9e190
   -49> 2017-08-31 23:05:32.162300 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command config diff get hook 0x7f4643c9e190
   -48> 2017-08-31 23:05:32.162301 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command log flush hook 0x7f4643c9e190
   -47> 2017-08-31 23:05:32.162303 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command log dump hook 0x7f4643c9e190
   -46> 2017-08-31 23:05:32.162304 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command log reopen hook 0x7f4643c9e190
   -45> 2017-08-31 23:05:32.162310 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command dump_mempools hook 0x7f4643e75b08
   -44> 2017-08-31 23:05:32.168964 7f46398e5d00  0 set uid:gid to 1001:1001 (ceph:ceph)
   -43> 2017-08-31 23:05:32.168980 7f46398e5d00  0 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc), process (unknown), pid 7136
   -42> 2017-08-31 23:05:32.169060 7f46398e5d00  5 object store type is bluestore
   -41> 2017-08-31 23:05:32.169171 7f46398e5d00 10 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) set_cache_shards 1
   -40> 2017-08-31 23:05:32.186251 7f46398e5d00 10 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) _set_csum csum_type crc32c
   -39> 2017-08-31 23:05:32.186264 7f46398e5d00  5 asok(0x7f4643cf61c0) init /var/run/ceph/ceph-osd.0.asok
   -38> 2017-08-31 23:05:32.186279 7f46398e5d00  5 asok(0x7f4643cf61c0) bind_and_listen /var/run/ceph/ceph-osd.0.asok
   -37> 2017-08-31 23:05:32.186728 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command 0 hook 0x7f4643c9a180
   -36> 2017-08-31 23:05:32.186735 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command version hook 0x7f4643c9a180
   -35> 2017-08-31 23:05:32.186737 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command git_version hook 0x7f4643c9a180
   -34> 2017-08-31 23:05:32.186739 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command help hook 0x7f4643c9e290
   -33> 2017-08-31 23:05:32.186741 7f46398e5d00  5 asok(0x7f4643cf61c0) register_command get_command_descriptions hook 0x7f4643c9e2a0
   -32> 2017-08-31 23:05:32.186825 7f46398e5d00 10 monclient: build_initial_monmap
   -31> 2017-08-31 23:05:32.186878 7f46398e5d00 10 monclient: get_monmap_privately
   -30> 2017-08-31 23:05:32.187205 7f46334c3700  5 asok(0x7f4643cf61c0) entry start
   -29> 2017-08-31 23:05:32.187222 7f4632cc2700  2 Event(0x7f4643ce0e80 nevent=5000 time_id=1).set_owner idx=0 owner=139939476678400
   -28> 2017-08-31 23:05:32.187249 7f46324c1700  2 Event(0x7f4643ce1480 nevent=5000 time_id=1).set_owner idx=1 owner=139939468285696
   -27> 2017-08-31 23:05:32.187261 7f4631cc0700  2 Event(0x7f4643ce0c80 nevent=5000 time_id=1).set_owner idx=2 owner=139939459892992
   -26> 2017-08-31 23:05:32.187288 7f46398e5d00  1  Processor -- start
   -25> 2017-08-31 23:05:32.187317 7f46398e5d00  1 -- - start start
   -24> 2017-08-31 23:05:32.187320 7f46398e5d00 10 monclient: have 1 fsid cbc93c9d-f4ee-4039-b738-c09cb52bff9c
   -23> 2017-08-31 23:05:32.187339 7f46398e5d00  1 -- - shutdown_connections 
   -22> 2017-08-31 23:05:32.187409 7f46398e5d00  1 -- - shutdown_connections 
   -21> 2017-08-31 23:05:32.187424 7f46398e5d00  1 -- - wait complete.
   -20> 2017-08-31 23:05:32.187428 7f46398e5d00  1 -- - >> - conn(0x7f4644042000 :-1 s=STATE_NONE pgs=0 cs=0 l=0).mark_down
   -19> 2017-08-31 23:05:32.187435 7f46398e5d00  2 -- - >> - conn(0x7f4644042000 :-1 s=STATE_NONE pgs=0 cs=0 l=0)._stop
   -18> 2017-08-31 23:05:32.187466 7f46398e5d00  1 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) mkfs path /var/lib/ceph/tmp/mnt.Nsg_MB
   -17> 2017-08-31 23:05:32.187504 7f46398e5d00 20 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) _setup_block_symlink_or_file name block path  size 10737418240 create=1
   -16> 2017-08-31 23:05:32.187638 7f46398e5d00 20 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) _setup_block_symlink_or_file name block.wal path  size 100663296 create=0
   -15> 2017-08-31 23:05:32.187650 7f46398e5d00 20 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) _setup_block_symlink_or_file name block.db path  size 0 create=0
   -14> 2017-08-31 23:05:32.187694 7f46398e5d00  1 bdev create path /var/lib/ceph/tmp/mnt.Nsg_MB/block type kernel
   -13> 2017-08-31 23:05:32.187699 7f46398e5d00  1 bdev(0x7f4643ce0400 /var/lib/ceph/tmp/mnt.Nsg_MB/block) open path /var/lib/ceph/tmp/mnt.Nsg_MB/block
   -12> 2017-08-31 23:05:32.187955 7f46398e5d00  1 bdev(0x7f4643ce0400 /var/lib/ceph/tmp/mnt.Nsg_MB/block) open size 28291072 (0x1afb000, 27628 kB) block_size 4096 (4096 B) rotational
   -11> 2017-08-31 23:05:32.187968 7f46398e5d00 10 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB/block) _write_bdev_label path /var/lib/ceph/tmp/mnt.Nsg_MB/block label bdev(osd_uuid 55ffcfe9-cc63-49ef-9ef7-383999d8627b size 0x1afb000 btime 2017-08-31 23:05:32.187967 desc main)
   -10> 2017-08-31 23:05:32.188018 7f46398e5d00  1 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) _set_cache_sizes max 0.5 < ratio 0.99
    -9> 2017-08-31 23:05:32.188037 7f46398e5d00  1 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) _set_cache_sizes cache_size 1073741824 meta 0.5 kv 0.5 data 0
    -8> 2017-08-31 23:05:32.188044 7f46398e5d00 10 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) _open_db kv_backend = rocksdb
    -7> 2017-08-31 23:05:32.188045 7f46398e5d00 10 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) _open_db do_bluefs = 1
    -6> 2017-08-31 23:05:32.188046 7f46398e5d00 10 bluestore(/var/lib/ceph/tmp/mnt.Nsg_MB) _open_db initializing bluefs
    -5> 2017-08-31 23:05:32.188061 7f46398e5d00  1 bdev create path /var/lib/ceph/tmp/mnt.Nsg_MB/block type kernel
    -4> 2017-08-31 23:05:32.188063 7f46398e5d00  1 bdev(0x7f4643f71000 /var/lib/ceph/tmp/mnt.Nsg_MB/block) open path /var/lib/ceph/tmp/mnt.Nsg_MB/block
    -3> 2017-08-31 23:05:32.188203 7f46398e5d00  1 bdev(0x7f4643f71000 /var/lib/ceph/tmp/mnt.Nsg_MB/block) open size 28291072 (0x1afb000, 27628 kB) block_size 4096 (4096 B) rotational
    -2> 2017-08-31 23:05:32.188208 7f46398e5d00  1 bluefs add_block_device bdev 1 path /var/lib/ceph/tmp/mnt.Nsg_MB/block size 27628 kB
    -1> 2017-08-31 23:05:32.188211 7f46398e5d00  1 bluefs add_block_extent bdev 1 0x7fffffffe0d00000~40000000
     0> 2017-08-31 23:05:32.190431 7f46398e5d00 -1 /home/jenkins-build/build/workspace/ceph-build/ARCH/x86_64/AVAILABLE_ARCH/x86_64/AVAILABLE_DIST/centos7/DIST/centos7/MACHINE_SIZE/huge/release/12.2.0/rpm/el7/BUILD/ceph-12.2.0/src/os/bluestore/BlueFS.cc: In function 'void BlueFS::add_block_extent(unsigned int, uint64_t, uint64_t)' thread 7f46398e5d00 time 2017-08-31 23:05:32.188213
/home/jenkins-build/build/workspace/ceph-build/ARCH/x86_64/AVAILABLE_ARCH/x86_64/AVAILABLE_DIST/centos7/DIST/centos7/MACHINE_SIZE/huge/release/12.2.0/rpm/el7/BUILD/ceph-12.2.0/src/os/bluestore/BlueFS.cc: 172: FAILED assert(bdev[id]->get_size() >= offset + length)

 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc)
 1: (ceph::__ceph_assert_fail(char const*, char const*, int, char const*)+0x110) [0x7f463a362510]
 2: (BlueFS::add_block_extent(unsigned int, unsigned long, unsigned long)+0x4d8) [0x7f463a2e7f88]
 3: (BlueStore::_open_db(bool)+0xc4f) [0x7f463a20b97f]
 4: (BlueStore::mkfs()+0xd0d) [0x7f463a21599d]
 5: (OSD::mkfs(CephContext*, ObjectStore*, std::string const&, uuid_d, int)+0x29b) [0x7f4639dccf1b]
 6: (main()+0xf42) [0x7f4639d0c972]
 7: (__libc_start_main()+0xf5) [0x7f4635f45b35]
 8: (()+0x4acb56) [0x7f4639dacb56]
 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_mirror
   0/ 5 rbd_replay
   0/ 5 journaler
   0/ 5 objectcacher
   0/ 5 client
   1/ 5 osd
   0/ 5 optracker
   0/ 5 objclass
   1/ 3 filestore
   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
   1/ 5 compressor
  20/20 bluestore
   1/ 5 bluefs
   1/ 3 bdev
   1/ 5 kstore
   4/ 5 rocksdb
   4/ 5 leveldb
   4/ 5 memdb
   1/ 5 kinetic
   1/ 5 fuse
   1/ 5 mgr
   1/ 5 mgrc
   1/ 5 dpdk
   1/ 5 eventtrace
  -2/-2 (syslog threshold)
  -1/-1 (stderr threshold)
  max_recent     10000
  max_new         1000
  log_file /var/log/ceph/ceph-osd.0.log
--- end dump of recent events ---
2017-08-31 23:05:32.192789 7f46398e5d00 -1 *** Caught signal (Aborted) **
 in thread 7f46398e5d00 thread_name:ceph-osd

 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc)
 1: (()+0xa23b21) [0x7f463a323b21]
 2: (()+0xf370) [0x7f4636f2f370]
 3: (gsignal()+0x37) [0x7f4635f591d7]
 4: (abort()+0x148) [0x7f4635f5a8c8]
 5: (ceph::__ceph_assert_fail(char const*, char const*, int, char const*)+0x284) [0x7f463a362684]
 6: (BlueFS::add_block_extent(unsigned int, unsigned long, unsigned long)+0x4d8) [0x7f463a2e7f88]
 7: (BlueStore::_open_db(bool)+0xc4f) [0x7f463a20b97f]
 8: (BlueStore::mkfs()+0xd0d) [0x7f463a21599d]
 9: (OSD::mkfs(CephContext*, ObjectStore*, std::string const&, uuid_d, int)+0x29b) [0x7f4639dccf1b]
 10: (main()+0xf42) [0x7f4639d0c972]
 11: (__libc_start_main()+0xf5) [0x7f4635f45b35]
 12: (()+0x4acb56) [0x7f4639dacb56]
 NOTE: a copy of the executable, or `objdump -rdS <executable>` is needed to interpret this.

--- begin dump of recent events ---
     0> 2017-08-31 23:05:32.192789 7f46398e5d00 -1 *** Caught signal (Aborted) **
 in thread 7f46398e5d00 thread_name:ceph-osd

 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc)
 1: (()+0xa23b21) [0x7f463a323b21]
 2: (()+0xf370) [0x7f4636f2f370]
 3: (gsignal()+0x37) [0x7f4635f591d7]
 4: (abort()+0x148) [0x7f4635f5a8c8]
 5: (ceph::__ceph_assert_fail(char const*, char const*, int, char const*)+0x284) [0x7f463a362684]
 6: (BlueFS::add_block_extent(unsigned int, unsigned long, unsigned long)+0x4d8) [0x7f463a2e7f88]
 7: (BlueStore::_open_db(bool)+0xc4f) [0x7f463a20b97f]
 8: (BlueStore::mkfs()+0xd0d) [0x7f463a21599d]
 9: (OSD::mkfs(CephContext*, ObjectStore*, std::string const&, uuid_d, int)+0x29b) [0x7f4639dccf1b]
 10: (main()+0xf42) [0x7f4639d0c972]
 11: (__libc_start_main()+0xf5) [0x7f4635f45b35]
 12: (()+0x4acb56) [0x7f4639dacb56]
 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_mirror
   0/ 5 rbd_replay
   0/ 5 journaler
   0/ 5 objectcacher
   0/ 5 client
   1/ 5 osd
   0/ 5 optracker
   0/ 5 objclass
   1/ 3 filestore
   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
   1/ 5 compressor
  20/20 bluestore
   1/ 5 bluefs
   1/ 3 bdev
   1/ 5 kstore
   4/ 5 rocksdb
   4/ 5 leveldb
   4/ 5 memdb
   1/ 5 kinetic
   1/ 5 fuse
   1/ 5 mgr
   1/ 5 mgrc
   1/ 5 dpdk
   1/ 5 eventtrace
  -2/-2 (syslog threshold)
  -1/-1 (stderr threshold)
  max_recent     10000
  max_new         1000
  log_file /var/log/ceph/ceph-osd.0.log
--- end dump of recent events ---
2017-08-31 23:05:32.579207 7f0bcf556d00  0 set uid:gid to 1001:1001 (ceph:ceph)
2017-08-31 23:05:32.579223 7f0bcf556d00  0 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc), process (unknown), pid 7193
2017-08-31 23:05:32.579366 7f0bcf556d00 10 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) set_cache_shards 1
2017-08-31 23:05:32.596184 7f0bcf556d00 10 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) _set_csum csum_type crc32c
2017-08-31 23:05:32.597060 7f0bcf556d00  1 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) mkfs path /var/lib/ceph/tmp/mnt.7MmJ48
2017-08-31 23:05:32.597097 7f0bcf556d00 20 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) _setup_block_symlink_or_file name block path  size 10737418240 create=1
2017-08-31 23:05:32.597182 7f0bcf556d00 20 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) _setup_block_symlink_or_file name block.wal path  size 100663296 create=0
2017-08-31 23:05:32.597186 7f0bcf556d00 20 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) _setup_block_symlink_or_file name block.db path  size 0 create=0
2017-08-31 23:05:32.597198 7f0bcf556d00  1 bdev create path /var/lib/ceph/tmp/mnt.7MmJ48/block type kernel
2017-08-31 23:05:32.597202 7f0bcf556d00  1 bdev(0x7f0bdb258800 /var/lib/ceph/tmp/mnt.7MmJ48/block) open path /var/lib/ceph/tmp/mnt.7MmJ48/block
2017-08-31 23:05:32.597420 7f0bcf556d00  1 bdev(0x7f0bdb258800 /var/lib/ceph/tmp/mnt.7MmJ48/block) open size 28291072 (0x1afb000, 27628 kB) block_size 4096 (4096 B) rotational
2017-08-31 23:05:32.597431 7f0bcf556d00 10 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48/block) _write_bdev_label path /var/lib/ceph/tmp/mnt.7MmJ48/block label bdev(osd_uuid 55ffcfe9-cc63-49ef-9ef7-383999d8627b size 0x1afb000 btime 2017-08-31 23:05:32.597430 desc main)
2017-08-31 23:05:32.597477 7f0bcf556d00  1 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) _set_cache_sizes max 0.5 < ratio 0.99
2017-08-31 23:05:32.597495 7f0bcf556d00  1 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) _set_cache_sizes cache_size 1073741824 meta 0.5 kv 0.5 data 0
2017-08-31 23:05:32.597502 7f0bcf556d00 10 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) _open_db kv_backend = rocksdb
2017-08-31 23:05:32.597503 7f0bcf556d00 10 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) _open_db do_bluefs = 1
2017-08-31 23:05:32.597503 7f0bcf556d00 10 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) _open_db initializing bluefs
2017-08-31 23:05:32.597520 7f0bcf556d00  1 bdev create path /var/lib/ceph/tmp/mnt.7MmJ48/block type kernel
2017-08-31 23:05:32.597521 7f0bcf556d00  1 bdev(0x7f0bdb4e9000 /var/lib/ceph/tmp/mnt.7MmJ48/block) open path /var/lib/ceph/tmp/mnt.7MmJ48/block
2017-08-31 23:05:32.597608 7f0bcf556d00  1 bdev(0x7f0bdb4e9000 /var/lib/ceph/tmp/mnt.7MmJ48/block) open size 28291072 (0x1afb000, 27628 kB) block_size 4096 (4096 B) rotational
2017-08-31 23:05:32.597612 7f0bcf556d00  1 bluefs add_block_device bdev 1 path /var/lib/ceph/tmp/mnt.7MmJ48/block size 27628 kB
2017-08-31 23:05:32.597616 7f0bcf556d00  1 bluefs add_block_extent bdev 1 0x7fffffffe0d00000~40000000
2017-08-31 23:05:32.599925 7f0bcf556d00 -1 /home/jenkins-build/build/workspace/ceph-build/ARCH/x86_64/AVAILABLE_ARCH/x86_64/AVAILABLE_DIST/centos7/DIST/centos7/MACHINE_SIZE/huge/release/12.2.0/rpm/el7/BUILD/ceph-12.2.0/src/os/bluestore/BlueFS.cc: In function 'void BlueFS::add_block_extent(unsigned int, uint64_t, uint64_t)' thread 7f0bcf556d00 time 2017-08-31 23:05:32.597617
/home/jenkins-build/build/workspace/ceph-build/ARCH/x86_64/AVAILABLE_ARCH/x86_64/AVAILABLE_DIST/centos7/DIST/centos7/MACHINE_SIZE/huge/release/12.2.0/rpm/el7/BUILD/ceph-12.2.0/src/os/bluestore/BlueFS.cc: 172: FAILED assert(bdev[id]->get_size() >= offset + length)

 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc)
 1: (ceph::__ceph_assert_fail(char const*, char const*, int, char const*)+0x110) [0x7f0bcffd3510]
 2: (BlueFS::add_block_extent(unsigned int, unsigned long, unsigned long)+0x4d8) [0x7f0bcff58f88]
 3: (BlueStore::_open_db(bool)+0xc4f) [0x7f0bcfe7c97f]
 4: (BlueStore::mkfs()+0xd0d) [0x7f0bcfe8699d]
 5: (OSD::mkfs(CephContext*, ObjectStore*, std::string const&, uuid_d, int)+0x29b) [0x7f0bcfa3df1b]
 6: (main()+0xf42) [0x7f0bcf97d972]
 7: (__libc_start_main()+0xf5) [0x7f0bcbbb6b35]
 8: (()+0x4acb56) [0x7f0bcfa1db56]
 NOTE: a copy of the executable, or `objdump -rdS <executable>` is needed to interpret this.

--- begin dump of recent events ---
   -63> 2017-08-31 23:05:32.572491 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command perfcounters_dump hook 0x7f0bdb216190
   -62> 2017-08-31 23:05:32.572504 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command 1 hook 0x7f0bdb216190
   -61> 2017-08-31 23:05:32.572507 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command perf dump hook 0x7f0bdb216190
   -60> 2017-08-31 23:05:32.572508 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command perfcounters_schema hook 0x7f0bdb216190
   -59> 2017-08-31 23:05:32.572510 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command perf histogram dump hook 0x7f0bdb216190
   -58> 2017-08-31 23:05:32.572511 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command 2 hook 0x7f0bdb216190
   -57> 2017-08-31 23:05:32.572512 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command perf schema hook 0x7f0bdb216190
   -56> 2017-08-31 23:05:32.572514 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command perf histogram schema hook 0x7f0bdb216190
   -55> 2017-08-31 23:05:32.572515 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command perf reset hook 0x7f0bdb216190
   -54> 2017-08-31 23:05:32.572517 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command config show hook 0x7f0bdb216190
   -53> 2017-08-31 23:05:32.572518 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command config help hook 0x7f0bdb216190
   -52> 2017-08-31 23:05:32.572520 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command config set hook 0x7f0bdb216190
   -51> 2017-08-31 23:05:32.572522 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command config get hook 0x7f0bdb216190
   -50> 2017-08-31 23:05:32.572528 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command config diff hook 0x7f0bdb216190
   -49> 2017-08-31 23:05:32.572531 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command config diff get hook 0x7f0bdb216190
   -48> 2017-08-31 23:05:32.572533 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command log flush hook 0x7f0bdb216190
   -47> 2017-08-31 23:05:32.572534 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command log dump hook 0x7f0bdb216190
   -46> 2017-08-31 23:05:32.572536 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command log reopen hook 0x7f0bdb216190
   -45> 2017-08-31 23:05:32.572541 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command dump_mempools hook 0x7f0bdb3edb08
   -44> 2017-08-31 23:05:32.579207 7f0bcf556d00  0 set uid:gid to 1001:1001 (ceph:ceph)
   -43> 2017-08-31 23:05:32.579223 7f0bcf556d00  0 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc), process (unknown), pid 7193
   -42> 2017-08-31 23:05:32.579263 7f0bcf556d00  5 object store type is bluestore
   -41> 2017-08-31 23:05:32.579366 7f0bcf556d00 10 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) set_cache_shards 1
   -40> 2017-08-31 23:05:32.596184 7f0bcf556d00 10 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) _set_csum csum_type crc32c
   -39> 2017-08-31 23:05:32.596196 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) init /var/run/ceph/ceph-osd.0.asok
   -38> 2017-08-31 23:05:32.596210 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) bind_and_listen /var/run/ceph/ceph-osd.0.asok
   -37> 2017-08-31 23:05:32.596348 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command 0 hook 0x7f0bdb212180
   -36> 2017-08-31 23:05:32.596353 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command version hook 0x7f0bdb212180
   -35> 2017-08-31 23:05:32.596355 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command git_version hook 0x7f0bdb212180
   -34> 2017-08-31 23:05:32.596357 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command help hook 0x7f0bdb216290
   -33> 2017-08-31 23:05:32.596359 7f0bcf556d00  5 asok(0x7f0bdb26e1c0) register_command get_command_descriptions hook 0x7f0bdb2162a0
   -32> 2017-08-31 23:05:32.596395 7f0bcf556d00 10 monclient: build_initial_monmap
   -31> 2017-08-31 23:05:32.596438 7f0bcf556d00 10 monclient: get_monmap_privately
   -30> 2017-08-31 23:05:32.596772 7f0bc9134700  5 asok(0x7f0bdb26e1c0) entry start
   -29> 2017-08-31 23:05:32.596789 7f0bc8933700  2 Event(0x7f0bdb258e80 nevent=5000 time_id=1).set_owner idx=0 owner=139688586458880
   -28> 2017-08-31 23:05:32.596815 7f0bc8132700  2 Event(0x7f0bdb259480 nevent=5000 time_id=1).set_owner idx=1 owner=139688578066176
   -27> 2017-08-31 23:05:32.596828 7f0bc7931700  2 Event(0x7f0bdb258c80 nevent=5000 time_id=1).set_owner idx=2 owner=139688569673472
   -26> 2017-08-31 23:05:32.596855 7f0bcf556d00  1  Processor -- start
   -25> 2017-08-31 23:05:32.596883 7f0bcf556d00  1 -- - start start
   -24> 2017-08-31 23:05:32.596886 7f0bcf556d00 10 monclient: have 1 fsid cbc93c9d-f4ee-4039-b738-c09cb52bff9c
   -23> 2017-08-31 23:05:32.596904 7f0bcf556d00  1 -- - shutdown_connections 
   -22> 2017-08-31 23:05:32.596985 7f0bcf556d00  1 -- - shutdown_connections 
   -21> 2017-08-31 23:05:32.597016 7f0bcf556d00  1 -- - wait complete.
   -20> 2017-08-31 23:05:32.597021 7f0bcf556d00  1 -- - >> - conn(0x7f0bdb5ba000 :-1 s=STATE_NONE pgs=0 cs=0 l=0).mark_down
   -19> 2017-08-31 23:05:32.597028 7f0bcf556d00  2 -- - >> - conn(0x7f0bdb5ba000 :-1 s=STATE_NONE pgs=0 cs=0 l=0)._stop
   -18> 2017-08-31 23:05:32.597060 7f0bcf556d00  1 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) mkfs path /var/lib/ceph/tmp/mnt.7MmJ48
   -17> 2017-08-31 23:05:32.597097 7f0bcf556d00 20 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) _setup_block_symlink_or_file name block path  size 10737418240 create=1
   -16> 2017-08-31 23:05:32.597182 7f0bcf556d00 20 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) _setup_block_symlink_or_file name block.wal path  size 100663296 create=0
   -15> 2017-08-31 23:05:32.597186 7f0bcf556d00 20 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) _setup_block_symlink_or_file name block.db path  size 0 create=0
   -14> 2017-08-31 23:05:32.597198 7f0bcf556d00  1 bdev create path /var/lib/ceph/tmp/mnt.7MmJ48/block type kernel
   -13> 2017-08-31 23:05:32.597202 7f0bcf556d00  1 bdev(0x7f0bdb258800 /var/lib/ceph/tmp/mnt.7MmJ48/block) open path /var/lib/ceph/tmp/mnt.7MmJ48/block
   -12> 2017-08-31 23:05:32.597420 7f0bcf556d00  1 bdev(0x7f0bdb258800 /var/lib/ceph/tmp/mnt.7MmJ48/block) open size 28291072 (0x1afb000, 27628 kB) block_size 4096 (4096 B) rotational
   -11> 2017-08-31 23:05:32.597431 7f0bcf556d00 10 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48/block) _write_bdev_label path /var/lib/ceph/tmp/mnt.7MmJ48/block label bdev(osd_uuid 55ffcfe9-cc63-49ef-9ef7-383999d8627b size 0x1afb000 btime 2017-08-31 23:05:32.597430 desc main)
   -10> 2017-08-31 23:05:32.597477 7f0bcf556d00  1 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) _set_cache_sizes max 0.5 < ratio 0.99
    -9> 2017-08-31 23:05:32.597495 7f0bcf556d00  1 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) _set_cache_sizes cache_size 1073741824 meta 0.5 kv 0.5 data 0
    -8> 2017-08-31 23:05:32.597502 7f0bcf556d00 10 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) _open_db kv_backend = rocksdb
    -7> 2017-08-31 23:05:32.597503 7f0bcf556d00 10 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) _open_db do_bluefs = 1
    -6> 2017-08-31 23:05:32.597503 7f0bcf556d00 10 bluestore(/var/lib/ceph/tmp/mnt.7MmJ48) _open_db initializing bluefs
    -5> 2017-08-31 23:05:32.597520 7f0bcf556d00  1 bdev create path /var/lib/ceph/tmp/mnt.7MmJ48/block type kernel
    -4> 2017-08-31 23:05:32.597521 7f0bcf556d00  1 bdev(0x7f0bdb4e9000 /var/lib/ceph/tmp/mnt.7MmJ48/block) open path /var/lib/ceph/tmp/mnt.7MmJ48/block
    -3> 2017-08-31 23:05:32.597608 7f0bcf556d00  1 bdev(0x7f0bdb4e9000 /var/lib/ceph/tmp/mnt.7MmJ48/block) open size 28291072 (0x1afb000, 27628 kB) block_size 4096 (4096 B) rotational
    -2> 2017-08-31 23:05:32.597612 7f0bcf556d00  1 bluefs add_block_device bdev 1 path /var/lib/ceph/tmp/mnt.7MmJ48/block size 27628 kB
    -1> 2017-08-31 23:05:32.597616 7f0bcf556d00  1 bluefs add_block_extent bdev 1 0x7fffffffe0d00000~40000000
     0> 2017-08-31 23:05:32.599925 7f0bcf556d00 -1 /home/jenkins-build/build/workspace/ceph-build/ARCH/x86_64/AVAILABLE_ARCH/x86_64/AVAILABLE_DIST/centos7/DIST/centos7/MACHINE_SIZE/huge/release/12.2.0/rpm/el7/BUILD/ceph-12.2.0/src/os/bluestore/BlueFS.cc: In function 'void BlueFS::add_block_extent(unsigned int, uint64_t, uint64_t)' thread 7f0bcf556d00 time 2017-08-31 23:05:32.597617
/home/jenkins-build/build/workspace/ceph-build/ARCH/x86_64/AVAILABLE_ARCH/x86_64/AVAILABLE_DIST/centos7/DIST/centos7/MACHINE_SIZE/huge/release/12.2.0/rpm/el7/BUILD/ceph-12.2.0/src/os/bluestore/BlueFS.cc: 172: FAILED assert(bdev[id]->get_size() >= offset + length)

 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc)
 1: (ceph::__ceph_assert_fail(char const*, char const*, int, char const*)+0x110) [0x7f0bcffd3510]
 2: (BlueFS::add_block_extent(unsigned int, unsigned long, unsigned long)+0x4d8) [0x7f0bcff58f88]
 3: (BlueStore::_open_db(bool)+0xc4f) [0x7f0bcfe7c97f]
 4: (BlueStore::mkfs()+0xd0d) [0x7f0bcfe8699d]
 5: (OSD::mkfs(CephContext*, ObjectStore*, std::string const&, uuid_d, int)+0x29b) [0x7f0bcfa3df1b]
 6: (main()+0xf42) [0x7f0bcf97d972]
 7: (__libc_start_main()+0xf5) [0x7f0bcbbb6b35]
 8: (()+0x4acb56) [0x7f0bcfa1db56]
 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_mirror
   0/ 5 rbd_replay
   0/ 5 journaler
   0/ 5 objectcacher
   0/ 5 client
   1/ 5 osd
   0/ 5 optracker
   0/ 5 objclass
   1/ 3 filestore
   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
   1/ 5 compressor
  20/20 bluestore
   1/ 5 bluefs
   1/ 3 bdev
   1/ 5 kstore
   4/ 5 rocksdb
   4/ 5 leveldb
   4/ 5 memdb
   1/ 5 kinetic
   1/ 5 fuse
   1/ 5 mgr
   1/ 5 mgrc
   1/ 5 dpdk
   1/ 5 eventtrace
  -2/-2 (syslog threshold)
  -1/-1 (stderr threshold)
  max_recent     10000
  max_new         1000
  log_file /var/log/ceph/ceph-osd.0.log
--- end dump of recent events ---
2017-08-31 23:05:32.602290 7f0bcf556d00 -1 *** Caught signal (Aborted) **
 in thread 7f0bcf556d00 thread_name:ceph-osd

 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc)
 1: (()+0xa23b21) [0x7f0bcff94b21]
 2: (()+0xf370) [0x7f0bccba0370]
 3: (gsignal()+0x37) [0x7f0bcbbca1d7]
 4: (abort()+0x148) [0x7f0bcbbcb8c8]
 5: (ceph::__ceph_assert_fail(char const*, char const*, int, char const*)+0x284) [0x7f0bcffd3684]
 6: (BlueFS::add_block_extent(unsigned int, unsigned long, unsigned long)+0x4d8) [0x7f0bcff58f88]
 7: (BlueStore::_open_db(bool)+0xc4f) [0x7f0bcfe7c97f]
 8: (BlueStore::mkfs()+0xd0d) [0x7f0bcfe8699d]
 9: (OSD::mkfs(CephContext*, ObjectStore*, std::string const&, uuid_d, int)+0x29b) [0x7f0bcfa3df1b]
 10: (main()+0xf42) [0x7f0bcf97d972]
 11: (__libc_start_main()+0xf5) [0x7f0bcbbb6b35]
 12: (()+0x4acb56) [0x7f0bcfa1db56]
 NOTE: a copy of the executable, or `objdump -rdS <executable>` is needed to interpret this.

--- begin dump of recent events ---
     0> 2017-08-31 23:05:32.602290 7f0bcf556d00 -1 *** Caught signal (Aborted) **
 in thread 7f0bcf556d00 thread_name:ceph-osd

 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc)
 1: (()+0xa23b21) [0x7f0bcff94b21]
 2: (()+0xf370) [0x7f0bccba0370]
 3: (gsignal()+0x37) [0x7f0bcbbca1d7]
 4: (abort()+0x148) [0x7f0bcbbcb8c8]
 5: (ceph::__ceph_assert_fail(char const*, char const*, int, char const*)+0x284) [0x7f0bcffd3684]
 6: (BlueFS::add_block_extent(unsigned int, unsigned long, unsigned long)+0x4d8) [0x7f0bcff58f88]
 7: (BlueStore::_open_db(bool)+0xc4f) [0x7f0bcfe7c97f]
 8: (BlueStore::mkfs()+0xd0d) [0x7f0bcfe8699d]
 9: (OSD::mkfs(CephContext*, ObjectStore*, std::string const&, uuid_d, int)+0x29b) [0x7f0bcfa3df1b]
 10: (main()+0xf42) [0x7f0bcf97d972]
 11: (__libc_start_main()+0xf5) [0x7f0bcbbb6b35]
 12: (()+0x4acb56) [0x7f0bcfa1db56]
 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_mirror
   0/ 5 rbd_replay
   0/ 5 journaler
   0/ 5 objectcacher
   0/ 5 client
   1/ 5 osd
   0/ 5 optracker
   0/ 5 objclass
   1/ 3 filestore
   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
   1/ 5 compressor
  20/20 bluestore
   1/ 5 bluefs
   1/ 3 bdev
   1/ 5 kstore
   4/ 5 rocksdb
   4/ 5 leveldb
   4/ 5 memdb
   1/ 5 kinetic
   1/ 5 fuse
   1/ 5 mgr
   1/ 5 mgrc
   1/ 5 dpdk
   1/ 5 eventtrace
  -2/-2 (syslog threshold)
  -1/-1 (stderr threshold)
  max_recent     10000
  max_new         1000
  log_file /var/log/ceph/ceph-osd.0.log
--- end dump of recent events ---
2017-08-31 23:06:03.224263 7fc53c812d00  0 set uid:gid to 1001:1001 (ceph:ceph)
2017-08-31 23:06:03.224281 7fc53c812d00  0 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc), process (unknown), pid 7361
2017-08-31 23:06:03.224474 7fc53c812d00 10 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) set_cache_shards 1
2017-08-31 23:06:03.242816 7fc53c812d00 10 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) _set_csum csum_type crc32c
2017-08-31 23:06:03.244989 7fc53c812d00  1 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) mkfs path /var/lib/ceph/tmp/mnt.3x9YTJ
2017-08-31 23:06:03.245053 7fc53c812d00 20 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) _setup_block_symlink_or_file name block path  size 10737418240 create=1
2017-08-31 23:06:03.245488 7fc53c812d00 20 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) _setup_block_symlink_or_file name block.wal path  size 100663296 create=0
2017-08-31 23:06:03.245505 7fc53c812d00 20 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) _setup_block_symlink_or_file name block.db path  size 0 create=0
2017-08-31 23:06:03.245540 7fc53c812d00  1 bdev create path /var/lib/ceph/tmp/mnt.3x9YTJ/block type kernel
2017-08-31 23:06:03.245550 7fc53c812d00  1 bdev(0x7fc547c40800 /var/lib/ceph/tmp/mnt.3x9YTJ/block) open path /var/lib/ceph/tmp/mnt.3x9YTJ/block
2017-08-31 23:06:03.246052 7fc53c812d00  1 bdev(0x7fc547c40800 /var/lib/ceph/tmp/mnt.3x9YTJ/block) open size 28291072 (0x1afb000, 27628 kB) block_size 4096 (4096 B) rotational
2017-08-31 23:06:03.246073 7fc53c812d00 10 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ/block) _write_bdev_label path /var/lib/ceph/tmp/mnt.3x9YTJ/block label bdev(osd_uuid 55ffcfe9-cc63-49ef-9ef7-383999d8627b size 0x1afb000 btime 2017-08-31 23:06:03.246071 desc main)
2017-08-31 23:06:03.246160 7fc53c812d00  1 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) _set_cache_sizes max 0.5 < ratio 0.99
2017-08-31 23:06:03.246180 7fc53c812d00  1 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) _set_cache_sizes cache_size 1073741824 meta 0.5 kv 0.5 data 0
2017-08-31 23:06:03.246188 7fc53c812d00 10 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) _open_db kv_backend = rocksdb
2017-08-31 23:06:03.246188 7fc53c812d00 10 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) _open_db do_bluefs = 1
2017-08-31 23:06:03.246189 7fc53c812d00 10 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) _open_db initializing bluefs
2017-08-31 23:06:03.246208 7fc53c812d00  1 bdev create path /var/lib/ceph/tmp/mnt.3x9YTJ/block type kernel
2017-08-31 23:06:03.246210 7fc53c812d00  1 bdev(0x7fc547ed1000 /var/lib/ceph/tmp/mnt.3x9YTJ/block) open path /var/lib/ceph/tmp/mnt.3x9YTJ/block
2017-08-31 23:06:03.246309 7fc53c812d00  1 bdev(0x7fc547ed1000 /var/lib/ceph/tmp/mnt.3x9YTJ/block) open size 28291072 (0x1afb000, 27628 kB) block_size 4096 (4096 B) rotational
2017-08-31 23:06:03.246314 7fc53c812d00  1 bluefs add_block_device bdev 1 path /var/lib/ceph/tmp/mnt.3x9YTJ/block size 27628 kB
2017-08-31 23:06:03.246318 7fc53c812d00  1 bluefs add_block_extent bdev 1 0x7fffffffe0d00000~40000000
2017-08-31 23:06:03.248558 7fc53c812d00 -1 /home/jenkins-build/build/workspace/ceph-build/ARCH/x86_64/AVAILABLE_ARCH/x86_64/AVAILABLE_DIST/centos7/DIST/centos7/MACHINE_SIZE/huge/release/12.2.0/rpm/el7/BUILD/ceph-12.2.0/src/os/bluestore/BlueFS.cc: In function 'void BlueFS::add_block_extent(unsigned int, uint64_t, uint64_t)' thread 7fc53c812d00 time 2017-08-31 23:06:03.246319
/home/jenkins-build/build/workspace/ceph-build/ARCH/x86_64/AVAILABLE_ARCH/x86_64/AVAILABLE_DIST/centos7/DIST/centos7/MACHINE_SIZE/huge/release/12.2.0/rpm/el7/BUILD/ceph-12.2.0/src/os/bluestore/BlueFS.cc: 172: FAILED assert(bdev[id]->get_size() >= offset + length)

 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc)
 1: (ceph::__ceph_assert_fail(char const*, char const*, int, char const*)+0x110) [0x7fc53d28f510]
 2: (BlueFS::add_block_extent(unsigned int, unsigned long, unsigned long)+0x4d8) [0x7fc53d214f88]
 3: (BlueStore::_open_db(bool)+0xc4f) [0x7fc53d13897f]
 4: (BlueStore::mkfs()+0xd0d) [0x7fc53d14299d]
 5: (OSD::mkfs(CephContext*, ObjectStore*, std::string const&, uuid_d, int)+0x29b) [0x7fc53ccf9f1b]
 6: (main()+0xf42) [0x7fc53cc39972]
 7: (__libc_start_main()+0xf5) [0x7fc538e72b35]
 8: (()+0x4acb56) [0x7fc53ccd9b56]
 NOTE: a copy of the executable, or `objdump -rdS <executable>` is needed to interpret this.

--- begin dump of recent events ---
   -63> 2017-08-31 23:06:03.217026 7fc53c812d00  5 asok(0x7fc547c561c0) register_command perfcounters_dump hook 0x7fc547bfe190
   -62> 2017-08-31 23:06:03.217040 7fc53c812d00  5 asok(0x7fc547c561c0) register_command 1 hook 0x7fc547bfe190
   -61> 2017-08-31 23:06:03.217042 7fc53c812d00  5 asok(0x7fc547c561c0) register_command perf dump hook 0x7fc547bfe190
   -60> 2017-08-31 23:06:03.217044 7fc53c812d00  5 asok(0x7fc547c561c0) register_command perfcounters_schema hook 0x7fc547bfe190
   -59> 2017-08-31 23:06:03.217045 7fc53c812d00  5 asok(0x7fc547c561c0) register_command perf histogram dump hook 0x7fc547bfe190
   -58> 2017-08-31 23:06:03.217047 7fc53c812d00  5 asok(0x7fc547c561c0) register_command 2 hook 0x7fc547bfe190
   -57> 2017-08-31 23:06:03.217048 7fc53c812d00  5 asok(0x7fc547c561c0) register_command perf schema hook 0x7fc547bfe190
   -56> 2017-08-31 23:06:03.217050 7fc53c812d00  5 asok(0x7fc547c561c0) register_command perf histogram schema hook 0x7fc547bfe190
   -55> 2017-08-31 23:06:03.217051 7fc53c812d00  5 asok(0x7fc547c561c0) register_command perf reset hook 0x7fc547bfe190
   -54> 2017-08-31 23:06:03.217053 7fc53c812d00  5 asok(0x7fc547c561c0) register_command config show hook 0x7fc547bfe190
   -53> 2017-08-31 23:06:03.217054 7fc53c812d00  5 asok(0x7fc547c561c0) register_command config help hook 0x7fc547bfe190
   -52> 2017-08-31 23:06:03.217056 7fc53c812d00  5 asok(0x7fc547c561c0) register_command config set hook 0x7fc547bfe190
   -51> 2017-08-31 23:06:03.217058 7fc53c812d00  5 asok(0x7fc547c561c0) register_command config get hook 0x7fc547bfe190
   -50> 2017-08-31 23:06:03.217059 7fc53c812d00  5 asok(0x7fc547c561c0) register_command config diff hook 0x7fc547bfe190
   -49> 2017-08-31 23:06:03.217067 7fc53c812d00  5 asok(0x7fc547c561c0) register_command config diff get hook 0x7fc547bfe190
   -48> 2017-08-31 23:06:03.217069 7fc53c812d00  5 asok(0x7fc547c561c0) register_command log flush hook 0x7fc547bfe190
   -47> 2017-08-31 23:06:03.217070 7fc53c812d00  5 asok(0x7fc547c561c0) register_command log dump hook 0x7fc547bfe190
   -46> 2017-08-31 23:06:03.217071 7fc53c812d00  5 asok(0x7fc547c561c0) register_command log reopen hook 0x7fc547bfe190
   -45> 2017-08-31 23:06:03.217077 7fc53c812d00  5 asok(0x7fc547c561c0) register_command dump_mempools hook 0x7fc547dd5b08
   -44> 2017-08-31 23:06:03.224263 7fc53c812d00  0 set uid:gid to 1001:1001 (ceph:ceph)
   -43> 2017-08-31 23:06:03.224281 7fc53c812d00  0 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc), process (unknown), pid 7361
   -42> 2017-08-31 23:06:03.224323 7fc53c812d00  5 object store type is bluestore
   -41> 2017-08-31 23:06:03.224474 7fc53c812d00 10 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) set_cache_shards 1
   -40> 2017-08-31 23:06:03.242816 7fc53c812d00 10 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) _set_csum csum_type crc32c
   -39> 2017-08-31 23:06:03.242834 7fc53c812d00  5 asok(0x7fc547c561c0) init /var/run/ceph/ceph-osd.0.asok
   -38> 2017-08-31 23:06:03.242854 7fc53c812d00  5 asok(0x7fc547c561c0) bind_and_listen /var/run/ceph/ceph-osd.0.asok
   -37> 2017-08-31 23:06:03.243320 7fc53c812d00  5 asok(0x7fc547c561c0) register_command 0 hook 0x7fc547bfa180
   -36> 2017-08-31 23:06:03.243325 7fc53c812d00  5 asok(0x7fc547c561c0) register_command version hook 0x7fc547bfa180
   -35> 2017-08-31 23:06:03.243327 7fc53c812d00  5 asok(0x7fc547c561c0) register_command git_version hook 0x7fc547bfa180
   -34> 2017-08-31 23:06:03.243329 7fc53c812d00  5 asok(0x7fc547c561c0) register_command help hook 0x7fc547bfe290
   -33> 2017-08-31 23:06:03.243331 7fc53c812d00  5 asok(0x7fc547c561c0) register_command get_command_descriptions hook 0x7fc547bfe2a0
   -32> 2017-08-31 23:06:03.243383 7fc53c812d00 10 monclient: build_initial_monmap
   -31> 2017-08-31 23:06:03.243428 7fc53c812d00 10 monclient: get_monmap_privately
   -30> 2017-08-31 23:06:03.244203 7fc5353ee700  2 Event(0x7fc547c41480 nevent=5000 time_id=1).set_owner idx=1 owner=140484978599680
   -29> 2017-08-31 23:06:03.244261 7fc534bed700  2 Event(0x7fc547c40c80 nevent=5000 time_id=1).set_owner idx=2 owner=140484970206976
   -28> 2017-08-31 23:06:03.244277 7fc5363f0700  5 asok(0x7fc547c561c0) entry start
   -27> 2017-08-31 23:06:03.244450 7fc535bef700  2 Event(0x7fc547c40e80 nevent=5000 time_id=1).set_owner idx=0 owner=140484986992384
   -26> 2017-08-31 23:06:03.244512 7fc53c812d00  1  Processor -- start
   -25> 2017-08-31 23:06:03.244568 7fc53c812d00  1 -- - start start
   -24> 2017-08-31 23:06:03.244573 7fc53c812d00 10 monclient: have 1 fsid cbc93c9d-f4ee-4039-b738-c09cb52bff9c
   -23> 2017-08-31 23:06:03.244701 7fc53c812d00  1 -- - shutdown_connections 
   -22> 2017-08-31 23:06:03.244892 7fc53c812d00  1 -- - shutdown_connections 
   -21> 2017-08-31 23:06:03.244920 7fc53c812d00  1 -- - wait complete.
   -20> 2017-08-31 23:06:03.244927 7fc53c812d00  1 -- - >> - conn(0x7fc547fa2000 :-1 s=STATE_NONE pgs=0 cs=0 l=0).mark_down
   -19> 2017-08-31 23:06:03.244940 7fc53c812d00  2 -- - >> - conn(0x7fc547fa2000 :-1 s=STATE_NONE pgs=0 cs=0 l=0)._stop
   -18> 2017-08-31 23:06:03.244989 7fc53c812d00  1 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) mkfs path /var/lib/ceph/tmp/mnt.3x9YTJ
   -17> 2017-08-31 23:06:03.245053 7fc53c812d00 20 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) _setup_block_symlink_or_file name block path  size 10737418240 create=1
   -16> 2017-08-31 23:06:03.245488 7fc53c812d00 20 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) _setup_block_symlink_or_file name block.wal path  size 100663296 create=0
   -15> 2017-08-31 23:06:03.245505 7fc53c812d00 20 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) _setup_block_symlink_or_file name block.db path  size 0 create=0
   -14> 2017-08-31 23:06:03.245540 7fc53c812d00  1 bdev create path /var/lib/ceph/tmp/mnt.3x9YTJ/block type kernel
   -13> 2017-08-31 23:06:03.245550 7fc53c812d00  1 bdev(0x7fc547c40800 /var/lib/ceph/tmp/mnt.3x9YTJ/block) open path /var/lib/ceph/tmp/mnt.3x9YTJ/block
   -12> 2017-08-31 23:06:03.246052 7fc53c812d00  1 bdev(0x7fc547c40800 /var/lib/ceph/tmp/mnt.3x9YTJ/block) open size 28291072 (0x1afb000, 27628 kB) block_size 4096 (4096 B) rotational
   -11> 2017-08-31 23:06:03.246073 7fc53c812d00 10 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ/block) _write_bdev_label path /var/lib/ceph/tmp/mnt.3x9YTJ/block label bdev(osd_uuid 55ffcfe9-cc63-49ef-9ef7-383999d8627b size 0x1afb000 btime 2017-08-31 23:06:03.246071 desc main)
   -10> 2017-08-31 23:06:03.246160 7fc53c812d00  1 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) _set_cache_sizes max 0.5 < ratio 0.99
    -9> 2017-08-31 23:06:03.246180 7fc53c812d00  1 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) _set_cache_sizes cache_size 1073741824 meta 0.5 kv 0.5 data 0
    -8> 2017-08-31 23:06:03.246188 7fc53c812d00 10 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) _open_db kv_backend = rocksdb
    -7> 2017-08-31 23:06:03.246188 7fc53c812d00 10 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) _open_db do_bluefs = 1
    -6> 2017-08-31 23:06:03.246189 7fc53c812d00 10 bluestore(/var/lib/ceph/tmp/mnt.3x9YTJ) _open_db initializing bluefs
    -5> 2017-08-31 23:06:03.246208 7fc53c812d00  1 bdev create path /var/lib/ceph/tmp/mnt.3x9YTJ/block type kernel
    -4> 2017-08-31 23:06:03.246210 7fc53c812d00  1 bdev(0x7fc547ed1000 /var/lib/ceph/tmp/mnt.3x9YTJ/block) open path /var/lib/ceph/tmp/mnt.3x9YTJ/block
    -3> 2017-08-31 23:06:03.246309 7fc53c812d00  1 bdev(0x7fc547ed1000 /var/lib/ceph/tmp/mnt.3x9YTJ/block) open size 28291072 (0x1afb000, 27628 kB) block_size 4096 (4096 B) rotational
    -2> 2017-08-31 23:06:03.246314 7fc53c812d00  1 bluefs add_block_device bdev 1 path /var/lib/ceph/tmp/mnt.3x9YTJ/block size 27628 kB
    -1> 2017-08-31 23:06:03.246318 7fc53c812d00  1 bluefs add_block_extent bdev 1 0x7fffffffe0d00000~40000000
     0> 2017-08-31 23:06:03.248558 7fc53c812d00 -1 /home/jenkins-build/build/workspace/ceph-build/ARCH/x86_64/AVAILABLE_ARCH/x86_64/AVAILABLE_DIST/centos7/DIST/centos7/MACHINE_SIZE/huge/release/12.2.0/rpm/el7/BUILD/ceph-12.2.0/src/os/bluestore/BlueFS.cc: In function 'void BlueFS::add_block_extent(unsigned int, uint64_t, uint64_t)' thread 7fc53c812d00 time 2017-08-31 23:06:03.246319
/home/jenkins-build/build/workspace/ceph-build/ARCH/x86_64/AVAILABLE_ARCH/x86_64/AVAILABLE_DIST/centos7/DIST/centos7/MACHINE_SIZE/huge/release/12.2.0/rpm/el7/BUILD/ceph-12.2.0/src/os/bluestore/BlueFS.cc: 172: FAILED assert(bdev[id]->get_size() >= offset + length)

 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc)
 1: (ceph::__ceph_assert_fail(char const*, char const*, int, char const*)+0x110) [0x7fc53d28f510]
 2: (BlueFS::add_block_extent(unsigned int, unsigned long, unsigned long)+0x4d8) [0x7fc53d214f88]
 3: (BlueStore::_open_db(bool)+0xc4f) [0x7fc53d13897f]
 4: (BlueStore::mkfs()+0xd0d) [0x7fc53d14299d]
 5: (OSD::mkfs(CephContext*, ObjectStore*, std::string const&, uuid_d, int)+0x29b) [0x7fc53ccf9f1b]
 6: (main()+0xf42) [0x7fc53cc39972]
 7: (__libc_start_main()+0xf5) [0x7fc538e72b35]
 8: (()+0x4acb56) [0x7fc53ccd9b56]
 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_mirror
   0/ 5 rbd_replay
   0/ 5 journaler
   0/ 5 objectcacher
   0/ 5 client
   1/ 5 osd
   0/ 5 optracker
   0/ 5 objclass
   1/ 3 filestore
   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
   1/ 5 compressor
  20/20 bluestore
   1/ 5 bluefs
   1/ 3 bdev
   1/ 5 kstore
   4/ 5 rocksdb
   4/ 5 leveldb
   4/ 5 memdb
   1/ 5 kinetic
   1/ 5 fuse
   1/ 5 mgr
   1/ 5 mgrc
   1/ 5 dpdk
   1/ 5 eventtrace
  -2/-2 (syslog threshold)
  -1/-1 (stderr threshold)
  max_recent     10000
  max_new         1000
  log_file /var/log/ceph/ceph-osd.0.log
--- end dump of recent events ---
2017-08-31 23:06:03.250951 7fc53c812d00 -1 *** Caught signal (Aborted) **
 in thread 7fc53c812d00 thread_name:ceph-osd

 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc)
 1: (()+0xa23b21) [0x7fc53d250b21]
 2: (()+0xf370) [0x7fc539e5c370]
 3: (gsignal()+0x37) [0x7fc538e861d7]
 4: (abort()+0x148) [0x7fc538e878c8]
 5: (ceph::__ceph_assert_fail(char const*, char const*, int, char const*)+0x284) [0x7fc53d28f684]
 6: (BlueFS::add_block_extent(unsigned int, unsigned long, unsigned long)+0x4d8) [0x7fc53d214f88]
 7: (BlueStore::_open_db(bool)+0xc4f) [0x7fc53d13897f]
 8: (BlueStore::mkfs()+0xd0d) [0x7fc53d14299d]
 9: (OSD::mkfs(CephContext*, ObjectStore*, std::string const&, uuid_d, int)+0x29b) [0x7fc53ccf9f1b]
 10: (main()+0xf42) [0x7fc53cc39972]
 11: (__libc_start_main()+0xf5) [0x7fc538e72b35]
 12: (()+0x4acb56) [0x7fc53ccd9b56]
 NOTE: a copy of the executable, or `objdump -rdS <executable>` is needed to interpret this.

--- begin dump of recent events ---
     0> 2017-08-31 23:06:03.250951 7fc53c812d00 -1 *** Caught signal (Aborted) **
 in thread 7fc53c812d00 thread_name:ceph-osd

 ceph version 12.2.0 (32ce2a3ae5239ee33d6150705cdb24d43bab910c) luminous (rc)
 1: (()+0xa23b21) [0x7fc53d250b21]
 2: (()+0xf370) [0x7fc539e5c370]
 3: (gsignal()+0x37) [0x7fc538e861d7]
 4: (abort()+0x148) [0x7fc538e878c8]
 5: (ceph::__ceph_assert_fail(char const*, char const*, int, char const*)+0x284) [0x7fc53d28f684]
 6: (BlueFS::add_block_extent(unsigned int, unsigned long, unsigned long)+0x4d8) [0x7fc53d214f88]
 7: (BlueStore::_open_db(bool)+0xc4f) [0x7fc53d13897f]
 8: (BlueStore::mkfs()+0xd0d) [0x7fc53d14299d]
 9: (OSD::mkfs(CephContext*, ObjectStore*, std::string const&, uuid_d, int)+0x29b) [0x7fc53ccf9f1b]
 10: (main()+0xf42) [0x7fc53cc39972]
 11: (__libc_start_main()+0xf5) [0x7fc538e72b35]
 12: (()+0x4acb56) [0x7fc53ccd9b56]
 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_mirror
   0/ 5 rbd_replay
   0/ 5 journaler
   0/ 5 objectcacher
   0/ 5 client
   1/ 5 osd
   0/ 5 optracker
   0/ 5 objclass
   1/ 3 filestore
   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
   1/ 5 compressor
  20/20 bluestore
   1/ 5 bluefs
   1/ 3 bdev
   1/ 5 kstore
   4/ 5 rocksdb
   4/ 5 leveldb
   4/ 5 memdb
   1/ 5 kinetic
   1/ 5 fuse
   1/ 5 mgr
   1/ 5 mgrc
   1/ 5 dpdk
   1/ 5 eventtrace
  -2/-2 (syslog threshold)
  -1/-1 (stderr threshold)
  max_recent     10000
  max_new         1000
  log_file /var/log/ceph/ceph-osd.0.log
--- end dump of recent events ---
_______________________________________________
ceph-users mailing list
ceph-users@xxxxxxxxxxxxxx
http://lists.ceph.com/listinfo.cgi/ceph-users-ceph.com

[Index of Archives]     [Information on CEPH]     [Linux Filesystem Development]     [Ceph Development]     [Ceph Large]     [Linux USB Development]     [Video for Linux]     [Linux Audio Users]     [Yosemite News]     [Linux Kernel]     [Linux SCSI]     [xfs]


  Powered by Linux