Project

General

Profile

Actions

Bug #52259

closed

unittest-staged-fltree fails

Added by Kefu Chai over 2 years ago. Updated over 2 years ago.

Status:
Resolved
Priority:
Urgent
Assignee:
Category:
-
Target version:
-
% Done:

0%

Source:
Tags:
Backport:
Regression:
No
Severity:
3 - minor
Reviewed:
Affected Versions:
ceph-qa-suite:
Pull request ID:
Crash signature (v1):
Crash signature (v2):

Description

...
DEBUG 2021-08-14 02:38:09,351 [shard 0] seastore - BtreeLBAManager::get_root: reading root at paddr_t<0, 8192> depth 1
DEBUG 2021-08-14 02:38:09,351 [shard 0] seastore - get_lba_btree_extent: reading leaf at offset paddr_t<0, 8192>, depth 1
DEBUG 2021-08-14 02:38:09,351 [shard 0] seastore - get_lba_btree_extent: read leaf at offset paddr_t<0, 8192> CachedExtent(addr=0x601000a9c780, type=LADDR_LEAF, version=1, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 4096>), paddr=paddr_t<0, 8192>, state=DIRTY, last_committed_crc=326493981, refcount=4, size=1, meta=btree_node_meta_t(begin=0, end=18446744073709551615, depth=1)), parent CachedExtent(addr=0x601000176e00, type=ROOT, version=1, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 4096>), paddr=paddr_t<NULL_SEG, NULL_OFF>, state=DIRTY, last_committed_crc=0, refcount=7)
DEBUG 2021-08-14 02:38:09,351 [shard 0] seastore - LBALeafNode::lookup_pin 0
DEBUG 2021-08-14 02:38:09,351 [shard 0] seastore - BtreeLBAManager::get_mapping: got mapping LBAPin(0~16384->paddr_t<1, 8192>
DEBUG 2021-08-14 02:38:09,351 [shard 0] seastore - TransactionManager::pin_to_extent(0x601000858140): getting extent LBAPin(0~16384->paddr_t<1, 8192>
DEBUG 2021-08-14 02:38:09,351 [shard 0] seastore - TransactionManager::pin_to_extent(0x601000858140): got extent CachedExtent(addr=0x601000b56d00, type=ONODE_BLOCK_STAGED, version=1, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=DIRTY, last_committed_crc=850290427, refcount=3, laddr=0, pin=LBAPin(0~16384->paddr_t<1, 8192>, fltree_header=headerL0(is_level_tail=1, level=0))
DEBUG 2021-08-14 02:38:09,351 [shard 0] seastore - OTree::LeafNode::insert_value(0x601000858140): insert NodeL0@0x0+4000Lv0$ with insert_key=key_hobj(4,4,4; "ns7_..__/128B","oid7..__/13B"; 3,3), insert_value=ValueConf(TEST_EXTENDED, 989B), insert_pos(END, END, END), history=history(EQ, GT, --), mstat(-2) ...
DEBUG 2021-08-14 02:38:09,351 [shard 0] seastore - OTree::Seastore(0x601000858140): mutate CachedExtent(addr=0x601000b56d00, type=ONODE_BLOCK_STAGED, version=1, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=DIRTY, last_committed_crc=850290427, refcount=3, laddr=0, pin=LBAPin(0~16384->paddr_t<1, 8192>, fltree_header=headerL0(is_level_tail=1, level=0)) ...
DEBUG 2021-08-14 02:38:09,351 [shard 0] seastore - Cache::duplicate_for_write(0x601000858140): CachedExtent(addr=0x601000b56d00, type=ONODE_BLOCK_STAGED, version=1, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=DIRTY, last_committed_crc=850290427, refcount=6, laddr=0, pin=LBAPin(0~16384->paddr_t<1, 8192>, fltree_header=headerL0(is_level_tail=1, level=0)) -> CachedExtent(addr=0x6010009cdd00, type=ONODE_BLOCK_STAGED, version=2, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=MUTATION_PENDING, last_committed_crc=850290427, refcount=2, laddr=18446744073709551615, pin=empty, fltree_header=headerL0(is_level_tail=1, level=0))
DEBUG 2021-08-14 02:38:09,351 [shard 0] seastore - TransactionManager::get_mutable_extent(0x601000858140): duplicating CachedExtent(addr=0x601000b56d00, type=ONODE_BLOCK_STAGED, version=1, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=DIRTY, last_committed_crc=850290427, refcount=5, laddr=0, pin=LBAPin(0~16384->paddr_t<1, 8192>, fltree_header=headerL0(is_level_tail=1, level=0)) for write: CachedExtent(addr=0x6010009cdd00, type=ONODE_BLOCK_STAGED, version=2, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=MUTATION_PENDING, last_committed_crc=850290427, refcount=2, laddr=18446744073709551615, pin=empty, fltree_header=headerL0(is_level_tail=1, level=0))
DEBUG 2021-08-14 02:38:09,351 [shard 0] seastore - OTree::Layout::insert: begin at insert_pos(LAST, END, END), insert_stage=1, insert_size=1159B ...
DEBUG 2021-08-14 02:38:09,351 [shard 0] seastore - OTree::Extent::Replay: decoding INSERT ...
DEBUG 2021-08-14 02:38:09,351 [shard 0] seastore - OTree::Extent::Replay: apply key_hobj(4,4,4; "ns7_..__/128B","oid7..__/13B"; 3,3), ValueConf(TEST_EXTENDED, 989B), insert_pos(LAST, END, END), insert_stage=1, insert_size=1159B ...
DEBUG 2021-08-14 02:38:09,351 [shard 0] seastore - OTree::Layout::insert: done  at insert_pos(0, 1, 0), insert_stage=1, insert_size=1159B
DEBUG 2021-08-14 02:38:09,352 [shard 0] seastore - TransactionManager::submit_transaction(0x601000858140): about to await throttle
DEBUG 2021-08-14 02:38:09,352 [shard 0] seastore - SegmentCleaner::log_gc_state(await_hard_limits): total 1073741824, available 1065328640, unavailable 8413184, used 20480, reclaimable 0, reclaim_ratio 0.0, available_ratio 0.9921646118164062, should_block_on_gc false, gc_should_reclaim_space false, journal_head journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), journal_tail_target journal_seq_t(segment_seq=1, offset=paddr_t<1, 4096>), dirty_tail journal_seq_t(segment_seq=0, offset=paddr_t<1, 24576>), dirty_tail_limit journal_seq_t(segment_seq=0, offset=paddr_t<1, 24576>), gc_should_trim_journal false, 
DEBUG 2021-08-14 02:38:09,352 [shard 0] seastore - TransactionManager::submit_transaction_direct(0x601000858140): about to prepare
DEBUG 2021-08-14 02:38:09,352 [shard 0] seastore - Cache::prepare_record(0x601000858140): enter
DEBUG 2021-08-14 02:38:09,352 [shard 0] seastore - Cache::prepare_record(0x601000858140): read_set validated
DEBUG 2021-08-14 02:38:09,352 [shard 0] seastore - Cache::prepare_record(0x601000858140): mutating CachedExtent(addr=0x6010009cdd00, type=ONODE_BLOCK_STAGED, version=2, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=MUTATION_PENDING, last_committed_crc=850290427, refcount=1, laddr=0, pin=LBAPin(0~16384->paddr_t<1, 8192>, fltree_header=headerL0(is_level_tail=1, level=0))
DEBUG 2021-08-14 02:38:09,352 [shard 0] seastore - Cache::replace_extent: prev CachedExtent(addr=0x601000b56d00, type=ONODE_BLOCK_STAGED, version=1, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=DIRTY, last_committed_crc=850290427, refcount=3, laddr=0, pin=LBAPin(0~16384->paddr_t<1, 8192>, fltree_header=headerL0(is_level_tail=1, level=0)), next CachedExtent(addr=0x6010009cdd00, type=ONODE_BLOCK_STAGED, version=2, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=MUTATION_PENDING, last_committed_crc=850290427, refcount=2, laddr=0, pin=LBAPin(0~16384->paddr_t<1, 8192>, fltree_header=headerL0(is_level_tail=1, level=0))
DEBUG 2021-08-14 02:38:09,352 [shard 0] seastore - Cache::invalidate: invalidate begin -- extent CachedExtent(addr=0x601000b56d00, type=ONODE_BLOCK_STAGED, version=1, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=DIRTY, last_committed_crc=850290427, refcount=2, laddr=0, pin=LBAPin(0~16384->paddr_t<1, 8192>, fltree_header=headerL0(is_level_tail=1, level=0))
DEBUG 2021-08-14 02:38:09,352 [shard 0] seastore - Cache::invalidate: invalidate end
DEBUG 2021-08-14 02:38:09,352 [shard 0] seastore - TransactionManager::submit_transaction_direct(0x601000858140): about to submit to journal
DEBUG 2021-08-14 02:38:09,352 [shard 0] seastore - write_record, mdlength 4096, dlength 0, target 28672
DEBUG 2021-08-14 02:38:09,352 [shard 0] seastore - segment_write to segment 1 at offset 28672, physical offset 8417280, len 4096, crc 335995726
DEBUG 2021-08-14 02:38:09,376 [shard 0] seastore - write_record: commit target 28672
DEBUG 2021-08-14 02:38:09,376 [shard 0] seastore - TransactionManager::submit_transaction_direct(0x601000858140): journal commit to paddr_t<1, 32768> seq journal_seq_t(segment_seq=1, offset=paddr_t<1, 28672>)
DEBUG 2021-08-14 02:38:09,376 [shard 0] seastore - Cache::complete_commit(0x601000858140): enter
DEBUG 2021-08-14 02:38:09,376 [shard 0] seastore - Cache::complete_commit(0x601000858140): mutated CachedExtent(addr=0x6010009cdd00, type=ONODE_BLOCK_STAGED, version=2, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=MUTATION_PENDING, last_committed_crc=1625198013, refcount=2, laddr=0, pin=LBAPin(0~16384->paddr_t<1, 8192>, fltree_header=headerL0(is_level_tail=1, level=0))
DEBUG 2021-08-14 02:38:09,376 [shard 0] seastore - update_journal_tail_target: journal_seq_t(segment_seq=1, offset=paddr_t<1, 4096>)
DEBUG 2021-08-14 02:38:09,377 [shard 0] seastore - SegmentCleaner::log_gc_state(GCProcess::run_until_halt): total 1073741824, available 1065324544, unavailable 8417280, used 20480, reclaimable 0, reclaim_ratio 0.0, available_ratio 0.9921607971191406, should_block_on_gc false, gc_should_reclaim_space false, journal_head journal_seq_t(segment_seq=1, offset=paddr_t<1, 28672>), journal_tail_target journal_seq_t(segment_seq=1, offset=paddr_t<1, 4096>), dirty_tail journal_seq_t(segment_seq=0, offset=paddr_t<1, 28672>), dirty_tail_limit journal_seq_t(segment_seq=0, offset=paddr_t<1, 28672>), gc_should_trim_journal false, 
DEBUG 2021-08-14 02:38:09,377 [shard 0] seastore - Cache::create_transaction(0x601000858140): created source=MUTATE
DEBUG 2021-08-14 02:38:09,377 [shard 0] test - [2] insert key_hobj(7,7,7; "ns6_..__/255B","oid6..__/2048B"; 0,0) -> TestItem(#4, 992B)
DEBUG 2021-08-14 02:38:09,377 [shard 0] seastore - Cache::get_root(0x601000858140): waiting root CachedExtent(addr=0x601000176e00, type=ROOT, version=1, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 4096>), paddr=paddr_t<NULL_SEG, NULL_OFF>, state=DIRTY, last_committed_crc=0, refcount=3)
DEBUG 2021-08-14 02:38:09,377 [shard 0] seastore - Cache::get_root(0x601000858140): got root read CachedExtent(addr=0x601000176e00, type=ROOT, version=1, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 4096>), paddr=paddr_t<NULL_SEG, NULL_OFF>, state=DIRTY, last_committed_crc=0, refcount=4)
DEBUG 2021-08-14 02:38:09,377 [shard 0] seastore - BtreeLBAManager::get_mapping: 0
DEBUG 2021-08-14 02:38:09,377 [shard 0] seastore - Cache::get_root(0x601000858140): root already on transaction CachedExtent(addr=0x601000176e00, type=ROOT, version=1, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 4096>), paddr=paddr_t<NULL_SEG, NULL_OFF>, state=DIRTY, last_committed_crc=0, refcount=4)
DEBUG 2021-08-14 02:38:09,377 [shard 0] seastore - BtreeLBAManager::get_root: reading root at paddr_t<0, 8192> depth 1
DEBUG 2021-08-14 02:38:09,377 [shard 0] seastore - get_lba_btree_extent: reading leaf at offset paddr_t<0, 8192>, depth 1
DEBUG 2021-08-14 02:38:09,377 [shard 0] seastore - get_lba_btree_extent: read leaf at offset paddr_t<0, 8192> CachedExtent(addr=0x601000a9c780, type=LADDR_LEAF, version=1, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 4096>), paddr=paddr_t<0, 8192>, state=DIRTY, last_committed_crc=326493981, refcount=4, size=1, meta=btree_node_meta_t(begin=0, end=18446744073709551615, depth=1)), parent CachedExtent(addr=0x601000176e00, type=ROOT, version=1, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 4096>), paddr=paddr_t<NULL_SEG, NULL_OFF>, state=DIRTY, last_committed_crc=0, refcount=7)
DEBUG 2021-08-14 02:38:09,377 [shard 0] seastore - LBALeafNode::lookup_pin 0
DEBUG 2021-08-14 02:38:09,377 [shard 0] seastore - BtreeLBAManager::get_mapping: got mapping LBAPin(0~16384->paddr_t<1, 8192>
DEBUG 2021-08-14 02:38:09,377 [shard 0] seastore - TransactionManager::pin_to_extent(0x601000858140): getting extent LBAPin(0~16384->paddr_t<1, 8192>
DEBUG 2021-08-14 02:38:09,377 [shard 0] seastore - TransactionManager::pin_to_extent(0x601000858140): got extent CachedExtent(addr=0x6010009cdd00, type=ONODE_BLOCK_STAGED, version=2, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=DIRTY, last_committed_crc=1625198013, refcount=3, laddr=0, pin=LBAPin(0~16384->paddr_t<1, 8192>, fltree_header=headerL0(is_level_tail=1, level=0))
DEBUG 2021-08-14 02:38:09,377 [shard 0] seastore - OTree::LeafNode::insert_value(0x601000858140): insert NodeL0@0x0+4000Lv0$ with insert_key=key_hobj(7,7,7; "ns6_..__/255B","oid6..__/2048B"; 0,0), insert_value=ValueConf(TEST_EXTENDED, 989B), insert_pos(END, END, END), history=history(GT, --, --), mstat(-2) ...
DEBUG 2021-08-14 02:38:09,377 [shard 0] seastore - OTree::Seastore(0x601000858140): mutate CachedExtent(addr=0x6010009cdd00, type=ONODE_BLOCK_STAGED, version=2, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=DIRTY, last_committed_crc=1625198013, refcount=3, laddr=0, pin=LBAPin(0~16384->paddr_t<1, 8192>, fltree_header=headerL0(is_level_tail=1, level=0)) ...
DEBUG 2021-08-14 02:38:09,377 [shard 0] seastore - Cache::duplicate_for_write(0x601000858140): CachedExtent(addr=0x6010009cdd00, type=ONODE_BLOCK_STAGED, version=2, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=DIRTY, last_committed_crc=1625198013, refcount=6, laddr=0, pin=LBAPin(0~16384->paddr_t<1, 8192>, fltree_header=headerL0(is_level_tail=1, level=0)) -> CachedExtent(addr=0x601000b56c00, type=ONODE_BLOCK_STAGED, version=3, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=MUTATION_PENDING, last_committed_crc=1625198013, refcount=2, laddr=18446744073709551615, pin=empty, fltree_header=headerL0(is_level_tail=1, level=0))
DEBUG 2021-08-14 02:38:09,377 [shard 0] seastore - TransactionManager::get_mutable_extent(0x601000858140): duplicating CachedExtent(addr=0x6010009cdd00, type=ONODE_BLOCK_STAGED, version=2, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=DIRTY, last_committed_crc=1625198013, refcount=5, laddr=0, pin=LBAPin(0~16384->paddr_t<1, 8192>, fltree_header=headerL0(is_level_tail=1, level=0)) for write: CachedExtent(addr=0x601000b56c00, type=ONODE_BLOCK_STAGED, version=3, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=MUTATION_PENDING, last_committed_crc=1625198013, refcount=2, laddr=18446744073709551615, pin=empty, fltree_header=headerL0(is_level_tail=1, level=0))
DEBUG 2021-08-14 02:38:09,377 [shard 0] seastore - OTree::Layout::insert: begin at insert_pos(END, END, END), insert_stage=2, insert_size=3336B ...
DEBUG 2021-08-14 02:38:09,377 [shard 0] seastore - OTree::Extent::Replay: decoding INSERT ...
DEBUG 2021-08-14 02:38:09,378 [shard 0] seastore - OTree::Extent::Replay: apply key_hobj(7,7,7; "ns6_..__/255B","oid6..__/2048B"; 0,0), ValueConf(TEST_EXTENDED, 989B), insert_pos(END, END, END), insert_stage=2, insert_size=3336B ...
DEBUG 2021-08-14 02:38:09,378 [shard 0] seastore - OTree::Layout::insert: done  at insert_pos(1, 0, 0), insert_stage=2, insert_size=3336B
DEBUG 2021-08-14 02:38:09,378 [shard 0] seastore - TransactionManager::submit_transaction(0x601000858140): about to await throttle
DEBUG 2021-08-14 02:38:09,378 [shard 0] seastore - SegmentCleaner::log_gc_state(await_hard_limits): total 1073741824, available 1065324544, unavailable 8417280, used 20480, reclaimable 0, reclaim_ratio 0.0, available_ratio 0.9921607971191406, should_block_on_gc false, gc_should_reclaim_space false, journal_head journal_seq_t(segment_seq=1, offset=paddr_t<1, 28672>), journal_tail_target journal_seq_t(segment_seq=1, offset=paddr_t<1, 4096>), dirty_tail journal_seq_t(segment_seq=0, offset=paddr_t<1, 28672>), dirty_tail_limit journal_seq_t(segment_seq=0, offset=paddr_t<1, 28672>), gc_should_trim_journal false, 
DEBUG 2021-08-14 02:38:09,378 [shard 0] seastore - TransactionManager::submit_transaction_direct(0x601000858140): about to prepare
DEBUG 2021-08-14 02:38:09,378 [shard 0] seastore - Cache::prepare_record(0x601000858140): enter
DEBUG 2021-08-14 02:38:09,378 [shard 0] seastore - Cache::prepare_record(0x601000858140): read_set validated
DEBUG 2021-08-14 02:38:09,378 [shard 0] seastore - Cache::prepare_record(0x601000858140): mutating CachedExtent(addr=0x601000b56c00, type=ONODE_BLOCK_STAGED, version=3, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=MUTATION_PENDING, last_committed_crc=1625198013, refcount=1, laddr=0, pin=LBAPin(0~16384->paddr_t<1, 8192>, fltree_header=headerL0(is_level_tail=1, level=0))
DEBUG 2021-08-14 02:38:09,378 [shard 0] seastore - Cache::replace_extent: prev CachedExtent(addr=0x6010009cdd00, type=ONODE_BLOCK_STAGED, version=2, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=DIRTY, last_committed_crc=1625198013, refcount=3, laddr=0, pin=LBAPin(0~16384->paddr_t<1, 8192>, fltree_header=headerL0(is_level_tail=1, level=0)), next CachedExtent(addr=0x601000b56c00, type=ONODE_BLOCK_STAGED, version=3, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=MUTATION_PENDING, last_committed_crc=1625198013, refcount=2, laddr=0, pin=LBAPin(0~16384->paddr_t<1, 8192>, fltree_header=headerL0(is_level_tail=1, level=0))
DEBUG 2021-08-14 02:38:09,378 [shard 0] seastore - Cache::invalidate: invalidate begin -- extent CachedExtent(addr=0x6010009cdd00, type=ONODE_BLOCK_STAGED, version=2, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=DIRTY, last_committed_crc=1625198013, refcount=2, laddr=0, pin=LBAPin(0~16384->paddr_t<1, 8192>, fltree_header=headerL0(is_level_tail=1, level=0))
DEBUG 2021-08-14 02:38:09,378 [shard 0] seastore - Cache::invalidate: invalidate end
DEBUG 2021-08-14 02:38:09,378 [shard 0] seastore - TransactionManager::submit_transaction_direct(0x601000858140): about to submit to journal
DEBUG 2021-08-14 02:38:09,378 [shard 0] seastore - write_record, mdlength 4096, dlength 0, target 32768
DEBUG 2021-08-14 02:38:09,378 [shard 0] seastore - segment_write to segment 1 at offset 32768, physical offset 8421376, len 4096, crc 530964746
DEBUG 2021-08-14 02:38:09,379 [shard 0] seastore - write_record: commit target 32768
DEBUG 2021-08-14 02:38:09,379 [shard 0] seastore - TransactionManager::submit_transaction_direct(0x601000858140): journal commit to paddr_t<1, 36864> seq journal_seq_t(segment_seq=1, offset=paddr_t<1, 32768>)
DEBUG 2021-08-14 02:38:09,379 [shard 0] seastore - Cache::complete_commit(0x601000858140): enter
DEBUG 2021-08-14 02:38:09,379 [shard 0] seastore - Cache::complete_commit(0x601000858140): mutated CachedExtent(addr=0x601000b56c00, type=ONODE_BLOCK_STAGED, version=3, dirty_from_or_retired_at=journal_seq_t(segment_seq=1, offset=paddr_t<1, 24576>), paddr=paddr_t<1, 8192>, state=MUTATION_PENDING, last_committed_crc=1313456216, refcount=2, laddr=0, pin=LBAPin(0~16384->paddr_t<1, 8192>, fltree_header=headerL0(is_level_tail=1, level=0))
DEBUG 2021-08-14 02:38:09,379 [shard 0] seastore - update_journal_tail_target: journal_seq_t(segment_seq=1, offset=paddr_t<1, 4096>)
DEBUG 2021-08-14 02:38:09,379 [shard 0] seastore - SegmentCleaner::log_gc_state(GCProcess::run_until_halt): total 1073741824, available 1065320448, unavailable 8421376, used 20480, reclaimable 0, reclaim_ratio 0.0, available_ratio 0.992156982421875, should_block_on_gc false, gc_should_reclaim_space false, journal_head journal_seq_t(segment_seq=1, offset=paddr_t<1, 32768>), journal_tail_target journal_seq_t(segment_seq=1, offset=paddr_t<1, 4096>), dirty_tail journal_seq_t(segment_seq=0, offset=paddr_t<1, 32768>), dirty_tail_limit journal_seq_t(segment_seq=0, offset=paddr_t<1, 32768>), gc_should_trim_journal false, 
DEBUG 2021-08-14 02:38:09,380 [shard 0] seastore - Cache::create_transaction(0x601000858140): created source=MUTATE
DEBUG 2021-08-14 02:38:09,380 [shard 0] test - [3] insert key_hobj(1,1,1; "ns3_..__/255B","oid3____"; 2,2) -> TestItem(#3, 576B)
DEBUG 2021-08-14 02:38:09,380 [shard 0] seastore - OTree::Seastore(0x601000858140): get root: trigger eagain
unittest-staged-fltree: ../src/crimson/os/seastore/onode_manager/staged-fltree/node.cc:420: crimson::os::seastore::onode::Node::load_root(crimson::os::seastore::onode::context_t, crimson::os::seastore::onode::RootNodeTracker&)::<lambda(auto:115&&)> [with auto:115 = std::unique_ptr<crimson::os::seastore::onode::Super>]: Assertion `_super' failed.
Aborting on shard 0.
...

Files

consoleText.bz2 (388 KB) consoleText.bz2 Kefu Chai, 08/14/2021 04:11 AM

Related issues 1 (0 open1 closed)

Related to crimson - Bug #52275: Interruptive future is not workingResolvedXuehan Xu

Actions
Actions

Also available in: Atom PDF