cachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 561.930580][T16865] hole in alloc btree missing in freespace btree [ 561.930600][T16865] device 0 buckets 39-41, fixing [ 561.958237][T17120] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 561.980038][T16865] hole in alloc btree missing in freespace btree [ 561.980057][T16865] device 0 buckets 43-120, fixing [ 562.010604][T16865] done [ 562.017751][T16865] bcachefs (loop4): check_lrus... [ 562.026307][T16865] incorrect lru entry: lru fragmentation time 134217728 [ 562.026326][T16865] u64s 5 type set 18446462598867058688:34:0 len 0 ver 0 [ 562.026337][T16865] for u64s 13 type alloc_v4 0:34:0 len 0 ver 0: [ 562.026347][T16865] gen 1 oldest_gen 0 data_type free [ 562.026357][T16865] journal_seq_nonempty 5 [ 562.026366][T16865] journal_seq_empty 134217728 [ 562.026375][T16865] need_discard 0 [ 562.026384][T16865] need_inc_gen 0 [ 562.026395][T16865] dirty_sectors 0 [ 562.026404][T16865] stripe_sectors 0 [ 562.026414][T16865] cached_sectors 0 [ 562.026423][T16865] stripe 0 [ 562.026432][T16865] stripe_redundancy 0 [ 562.026442][T16865] io_time[READ] 1 [ 562.026462][T16865] io_time[WRITE] 512 [ 562.026472][T16865] fragmentation 0 [ 562.026482][T16865] bp_start 8 [ 562.026492][T16865] , fixing [ 562.034864][T17114] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 562.034933][T17114] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 562.037875][T17123] loop0: detected capacity change from 0 to 32768 [ 562.238357][T16865] done [ 562.241811][T17111] bcachefs: bch2_fs_get_tree() error: EINVAL [ 562.245552][T17123] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 562.268098][T17120] bcachefs: bch2_fs_get_tree() error: EINVAL [ 562.312344][T16865] bcachefs (loop4): check_btree_backpointers... done [ 562.359962][T17123] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 562.378862][T16865] bcachefs (loop4): check_backpointers_to_extents... done [ 562.425274][T16865] bcachefs (loop4): check_extents_to_backpointers... [ 562.426913][T16865] bcachefs (loop4): scanning for missing backpointers in 3/128 buckets [ 562.454877][T17114] bcachefs: bch2_fs_get_tree() error: EINVAL [ 562.514640][T16865] done [ 562.550468][T16865] bcachefs (loop4): check_alloc_to_lru_refs... [ 562.551895][T16865] missing fragmentation lru entry [ 562.551911][T16865] u64s 13 type alloc_v4 0:32:0 len 0 ver 0: [ 562.551921][T16865] gen 0 oldest_gen 0 data_type btree [ 562.551931][T16865] journal_seq_nonempty 1 [ 562.551941][T16865] journal_seq_empty 0 [ 562.551950][T16865] need_discard 1 [ 562.551958][T16865] need_inc_gen 1 [ 562.551968][T16865] dirty_sectors 32 [ 562.551977][T16865] stripe_sectors 0 [ 562.551987][T16865] cached_sectors 0 [ 562.551997][T16865] stripe 0 [ 562.552007][T16865] stripe_redundancy 0 [ 562.552017][T16865] io_time[READ] 1 [ 562.552026][T16865] io_time[WRITE] 1 [ 562.552035][T16865] fragmentation 268435456 [ 562.552045][T16865] bp_start 8 [ 562.552055][T16865] , fixing [ 562.681701][T16865] missing fragmentation lru entry [ 562.681720][T16865] u64s 13 type alloc_v4 0:35:0 len 0 ver 0: executing program [ 562.681731][T16865] gen 0 oldest_gen 0 data_type btree executing program [ 562.681740][T16865] journal_seq_nonempty 0 [ 562.681750][T16865] journal_seq_empty 0 [ 562.681759][T16865] need_discard 0 [ 562.681768][T16865] need_inc_gen 0 [ 562.681777][T16865] dirty_sectors 32 [ 562.681787][T16865] stripe_sectors 0 [ 562.681798][T16865] cached_sectors 0 [ 562.681808][T16865] stripe 0 [ 562.681818][T16865] stripe_redundancy 0 executing program [ 562.681828][T16865] io_time[READ] 0 [ 562.681837][T16865] io_time[WRITE] 0 [ 562.681847][T16865] fragmentation 268435456 [ 562.681856][T16865] bp_start 8 [ 562.681865][T16865] , fixing [ 562.839312][T17123] bcachefs: bch2_fs_get_tree() error: EINVAL [ 562.958251][T16865] missing fragmentation lru entry [ 562.958270][T16865] u64s 13 type alloc_v4 0:42:0 len 0 ver 0: [ 562.958281][T16865] gen 0 oldest_gen 0 data_type btree [ 562.958292][T16865] journal_seq_nonempty 7 [ 562.958303][T16865] journal_seq_empty 0 [ 562.958314][T16865] need_discard 1 [ 562.958325][T16865] need_inc_gen 1 [ 562.958335][T16865] dirty_sectors 32 [ 562.958346][T16865] stripe_sectors 0 [ 562.958357][T16865] cached_sectors 0 [ 562.958378][T16865] stripe 0 [ 562.958388][T16865] stripe_redundancy 0 executing program [ 562.958399][T16865] io_time[READ] 1 [ 562.958409][T16865] io_time[WRITE] 1280 [ 562.958420][T16865] fragmentation 268435456 [ 562.958431][T16865] bp_start 8 [ 562.958441][T16865] , fixing [ 563.264505][T16865] done [ 563.285598][T16865] bcachefs (loop4): bucket_gens_init... done [ 563.345448][T16865] bcachefs (loop4): check_snapshot_trees... done [ 563.397466][T16865] bcachefs (loop4): check_snapshots... [ 563.397925][T16865] snapshot points to missing/incorrect tree: [ 563.397943][T16865] u64s 8 type snapshot 0:4294967295:0 len 0 ver 0: is_subvol 1 deleted 0 parent 0 children 0 0 subvol 1 tree 0, fixing [ 563.479958][ T1299] ieee802154 phy0 wpan0: encryption failed: -22 [ 563.480010][ T1299] ieee802154 phy1 wpan1: encryption failed: -22 [ 563.544675][T16865] snapshot points to missing/incorrect tree: [ 563.544692][T16865] u64s 8 type snapshot 0:4294967295:0 len 0 ver 0: is_subvol 1 deleted 0 parent 0 children 0 0 subvol 1 tree 0, fixing [ 563.644294][T16865] done [ 563.665816][T16865] bcachefs (loop4): check_subvols... done [ 563.709889][T16865] bcachefs (loop4): check_subvol_children... done [ 563.765316][T16865] bcachefs (loop4): delete_dead_snapshots... done [ 563.773741][T17178] loop1: detected capacity change from 0 to 32768 [ 563.822567][T16865] bcachefs (loop4): check_inodes... done [ 563.844939][T17175] loop3: detected capacity change from 0 to 32768 [ 563.875437][T16865] bcachefs (loop4): check_extents... done [ 563.904607][T16865] bcachefs (loop4): check_indirect_extents... done [ 563.937924][T17178] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 563.974179][T16865] bcachefs (loop4): check_dirents... done [ 563.985868][T17181] loop2: detected capacity change from 0 to 32768 [ 564.012369][T17178] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 564.021001][T17175] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 564.034297][T16865] bcachefs (loop4): check_xattrs... done [ 564.050481][T17175] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 564.060869][T16865] bcachefs (loop4): check_root... done [ 564.094987][T16865] bcachefs (loop4): check_unreachable_inodes... done [ 564.123635][T17181] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 564.133448][T17181] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 564.144360][T16865] bcachefs (loop4): check_subvolume_structure... done [ 564.176560][T16865] bcachefs (loop4): check_directory_structure... done [ 564.225460][T16865] bcachefs (loop4): check_nlinks... done [ 564.293550][T16865] bcachefs (loop4): resume_logged_ops... done [ 564.341043][T16865] bcachefs (loop4): delete_dead_inodes... done [ 564.365951][T17181] bcachefs: bch2_fs_get_tree() error: EINVAL [ 564.373867][T16865] bcachefs (loop4): set_fs_needs_rebalance... [ 564.374506][T17178] bcachefs: bch2_fs_get_tree() error: EINVAL [ 564.374681][T16865] done [ 564.446061][T17175] bcachefs: bch2_fs_get_tree() error: EINVAL [ 564.452508][T16865] bcachefs (loop4): Fixed errors, running fsck a second time to verify fs is clean [ 564.494736][T17188] loop0: detected capacity change from 0 to 32768 [ 564.514182][T16865] bcachefs (loop4): check_alloc_info... done [ 564.532144][T16865] bcachefs (loop4): check_lrus... done [ 564.572935][T16865] bcachefs (loop4): check_btree_backpointers... done executing program [ 564.649804][T16865] bcachefs (loop4): check_backpointers_to_extents... done [ 564.664102][T16865] bcachefs (loop4): check_extents_to_backpointers... done [ 564.672975][T16865] bcachefs (loop4): check_alloc_to_lru_refs... done [ 564.681617][T16865] bcachefs (loop4): bucket_gens_init... done [ 564.720619][T17188] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 564.758152][T16865] bcachefs (loop4): check_snapshot_trees... done [ 564.792465][T16865] bcachefs (loop4): check_snapshots... done [ 564.798862][T17188] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 564.821955][T16865] bcachefs (loop4): check_subvols... done [ 564.838664][T16865] bcachefs (loop4): check_subvol_children... done [ 564.865923][T16865] bcachefs (loop4): delete_dead_snapshots... done [ 564.883940][T16865] bcachefs (loop4): check_inodes... done [ 564.904800][T16865] bcachefs (loop4): check_extents... done executing program executing program [ 564.930636][T16865] bcachefs (loop4): check_indirect_extents... done [ 564.955129][T16865] bcachefs (loop4): check_dirents... done [ 564.961179][T16865] bcachefs (loop4): check_xattrs... done [ 565.034372][T16865] bcachefs (loop4): check_root... done [ 565.040015][T16865] bcachefs (loop4): check_unreachable_inodes... done [ 565.067690][T16865] bcachefs (loop4): check_subvolume_structure... done [ 565.084060][T16865] bcachefs (loop4): check_directory_structure... done [ 565.091115][T16865] bcachefs (loop4): check_nlinks... done [ 565.140534][T16865] bcachefs (loop4): resume_logged_ops... done [ 565.157446][T16865] bcachefs (loop4): delete_dead_inodes... done [ 565.157601][T17188] bcachefs: bch2_fs_get_tree() error: EINVAL [ 565.189238][T16865] bcachefs (loop4): set_fs_needs_rebalance... done [ 565.209397][T16865] bcachefs (loop4): bch2_copygc_start(): error creating copygc thread EINTR [ 565.228901][T16865] bcachefs (loop4): error starting copygc thread [ 565.249159][T16865] bcachefs (loop4): bch2_fs_start(): error starting filesystem EINTR [ 565.269429][T16865] bcachefs (loop4): shutting down [ 565.288098][T16865] bcachefs (loop4): going read-only [ 565.324232][T16865] bcachefs (loop4): finished waiting for writes to stop [ 565.351859][T16865] bcachefs (loop4): flushing journal and stopping allocators, journal seq 35 [ 565.402917][T16865] bcachefs (loop4): flushing journal and stopping allocators complete, journal seq 35 [ 565.444647][T16865] bcachefs (loop4): clean shutdown complete, journal seq 36 [ 565.453276][T16865] bcachefs (loop4): marking filesystem clean executing program [ 565.533872][T17239] loop2: detected capacity change from 0 to 32768 [ 565.567411][T16865] bcachefs (loop4): shutdown complete [ 565.965506][T17246] loop1: detected capacity change from 0 to 32768 [ 566.041160][T17248] loop3: detected capacity change from 0 to 32768 [ 566.126267][T17257] loop0: detected capacity change from 0 to 32768 [ 566.277957][T17239] bcachefs (loop2): starting version 1.7: mi_btree_bitmap opts=errors=continue,metadata_checksum=none,data_checksum=none,compression=lz4,nojournal_transaction_names [ 566.298038][T17239] bcachefs (loop2): recovering from clean shutdown, journal seq 10 [ 566.306833][T17239] bcachefs (loop2): Version upgrade required: [ 566.306833][T17239] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete [ 566.306833][T17239] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.20: directory_size [ 566.306833][T17239] running recovery passes: check_allocations,check_alloc_info,check_lrus,check_btree_backpointers,check_backpointers_to_extents,check_extents_to_backpointers,check_alloc_to_lru_refs,bucket_gens_init,check_snapshot_trees,check_snapshots,check_subvols,check_subvol_children,delete_dead_snapshots,check_inodes,check_extents,check_indirect_extents,check_dirents,check_xattrs,check_root,check_unreachable_inodes,check_subvolume_structure,check_directory_structure,check_nlinks,set_fs_needs_rebalance [ 566.396773][T17248] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 566.419091][T17248] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 566.429124][T17239] bcachefs (loop2): error validating btree node on loop2 at btree extents level 0/0 [ 566.429144][T17239] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key POS_MIN durability: 1 ptr: 0:27:0 gen 0 [ 566.429158][T17239] node offset 0/16: incorrect min_key: got 0:36028797018963968:0 should be POS_MIN [ 566.445420][T17257] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 566.445490][T17257] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 566.454278][T17246] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 566.454360][T17246] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 566.604350][T16865] bcachefs: bch2_fs_get_tree() error: EINTR [ 566.692728][T17239] bcachefs (loop2): running explicit recovery pass check_topology (2), currently at recovery_pass_empty (0) [ 566.760412][T17239] bcachefs (loop2): flagging btree extents lost data [ 566.803898][T17257] bcachefs: bch2_fs_get_tree() error: EINVAL [ 566.811028][T17239] bcachefs (loop2): running explicit recovery pass scan_for_btree_nodes (1), currently at recovery_pass_empty (0) [ 566.846093][T17246] bcachefs: bch2_fs_get_tree() error: EINVAL [ 566.894067][T17248] bcachefs: bch2_fs_get_tree() error: EINVAL [ 566.901348][T17239] error reading btree root btree=extents level=0: btree_node_read_error, fixing [ 566.953555][T17239] bcachefs (loop2): error validating btree node at btree inodes level 0/0 executing program [ 566.953575][T17239] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0 [ 566.953589][T17239] node offset 16/24 bset u64s 110 bset byte offset 152: keys out of order: u64s 16 type inode_v3 134217728:4096:U32_MAX len 0 ver 0 > u64s 18 type inode_v3 0:4098:U32_MAX len 0 ver 0, fixing [ 567.107319][T17239] invalid bkey in btree_node btree=inodes level=0: u64s 16 type inode_v3 134217728:4096:U32_MAX len 0 ver 0: [ 567.107342][T17239] mode=40755 [ 567.107352][T17239] flags=(16300000) [ 567.107361][T17239] journal_seq=0 [ 567.107370][T17239] hash_seed=28e4f092a4fc58ee [ 567.107379][T17239] hash_type=siphash [ 567.107388][T17239] bi_size=0 [ 567.107397][T17239] bi_sectors=0 [ 567.107406][T17239] bi_version=0 [ 567.107414][T17239] bi_atime=200535484 [ 567.107423][T17239] bi_ctime=2780562352 executing program executing program [ 567.107432][T17239] bi_mtime=2780562352 [ 567.107441][T17239] bi_otime=200535484 [ 567.107450][T17239] bi_uid=0 [ 567.107459][T17239] bi_gid=0 executing program [ 567.107467][T17239] bi_nlink=2 [ 567.107476][T17239] bi_generation=0 [ 567.107485][T17239] bi_dev=0 [ 567.107493][T17239] bi_data_checksum=0 [ 567.107503][T17239] bi_compression=0 [ 567.107510][T17239] bi_project=0 [ 567.107517][T17239] bi_background_compression=0 [ 567.107525][T17239] bi_data_replicas=0 [ 567.107532][T17239] bi_promote_target=0 [ 567.107540][T17239] bi_foreground_target=0 [ 567.107547][T17239] bi_background_target=0 [ 567.107555][T17239] bi_erasure_code=0 [ 567.107562][T17239] bi_fields_set=0 [ 567.107569][T17239] bi_dir=0 [ 567.107576][T17239] bi_dir_offset=0 [ 567.107583][T17239] bi_subvol=1 [ 567.107591][T17239] bi_parent_subvol=0 [ 567.107598][T17239] bi_nocow=0 [ 567.107605][T17239] bi_depth=0 [ 567.107612][T17239] bi_inodes_32bit=0 [ 567.107619][T17239] nonzero k.p.inode: delete?, fixing [ 567.678264][T17239] bcachefs (loop2): btree_node_read_work: rewriting btree node at due to error [ 567.678264][T17239] btree=inodes level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0 [ 567.744335][T17239] bcachefs (loop2): error validating btree node on loop2 at btree dirents level 0/0 [ 567.744359][T17239] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0 [ 567.744374][T17239] node offset 16/24: btree node data missing: expected 24 sectors, found 16, fixing [ 567.869631][T17239] bcachefs (loop2): btree_node_read_work: rewriting btree node at due to error [ 567.869631][T17239] btree=dirents level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0 [ 567.930636][T17239] bcachefs (loop2): error validating btree node on loop2 at btree xattrs level 0/0 [ 567.930658][T17239] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 2285c34bed0abe32 written 16 min_key POS_MIN durability: 1 ptr: 0:31:0 gen 0 [ 567.930672][T17239] node offset 0/16 bset u64s 0: incorrect btree id [ 568.061721][T17239] bcachefs (loop2): flagging btree xattrs lost data [ 568.092551][T17239] error reading btree root btree=xattrs level=0: btree_node_read_error, fixing [ 568.113456][T17239] bcachefs (loop2): error validating btree node at btree alloc level 0/0 [ 568.113476][T17239] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0 [ 568.113491][T17239] node offset 8/24 bset u64s 375 bset byte offset 184: keys out of order: u64s 11 type alloc_v4 0:32:0 len 0 ver 0 > u64s 11 type alloc_v4 0:2:0 len 0 ver 0, fixing [ 568.255444][T17314] loop4: detected capacity change from 0 to 32768 [ 568.314417][T17239] bcachefs (loop2): btree_node_read_work: rewriting btree node at due to error [ 568.314417][T17239] btree=alloc level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0 [ 568.402302][T17322] loop1: detected capacity change from 0 to 32768 [ 568.424174][T17323] loop0: detected capacity change from 0 to 32768 [ 568.433209][T17324] loop3: detected capacity change from 0 to 32768 [ 568.447393][T17239] bcachefs (loop2): error validating btree node on loop2 at btree freespace level 0/0 [ 568.447415][T17239] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq e81e1ed936acf3df written 32 min_key POS_MIN durability: 1 ptr: 0:29:0 gen 0 [ 568.447429][T17239] node offset 0/32 bset u64s 0: invalid bkey format: incorrect number of fields: got 0, should be 6 [ 568.447440][T17239] u64s 5 fields 64:0, 64:0, 32:0, 0:0, 0:0, 0:0 [ 568.520280][T17239] bcachefs (loop2): flagging btree freespace lost data [ 568.540677][T17239] error reading btree root btree=freespace level=0: btree_node_read_error, fixing [ 568.551354][T17314] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 568.570043][T17314] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 568.577191][T17239] bcachefs (loop2): scan_for_btree_nodes... [ 568.650255][T17373] invalid bkey in btree_node btree=stripes level=0: u64s 7 type xattr 536870912:3798421620223919902:U32_MAX len 0 ver 0: user.xattr2:xattr2 [ 568.650281][T17373] nonzero snapshot: delete?, fixing [ 568.683533][T17373] bcachefs (loop2): flagging btree stripes lost data [ 568.726936][T17322] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 568.762135][T17322] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 568.762416][T17323] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 568.784595][T17323] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 568.792993][T17324] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 568.834233][T17324] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 568.857423][T17314] bcachefs: bch2_fs_get_tree() error: EINVAL [ 569.128275][T17323] bcachefs: bch2_fs_get_tree() error: EINVAL [ 569.151963][T17322] bcachefs: bch2_fs_get_tree() error: EINVAL executing program [ 569.184549][T17324] bcachefs: bch2_fs_get_tree() error: EINVAL executing program executing program executing program [ 569.550037][T17239] bcachefs (loop2): btree node scan found 6 nodes after overwrites [ 569.579632][T17239] done [ 569.609403][T17239] bcachefs (loop2): check_topology... [ 569.610365][T17239] bcachefs (loop2): btree root extents unreadable, must recover from scan [ 569.674383][T17239] bcachefs (loop2): bch2_get_scanned_nodes(): recovery btree=extents level=0 POS_MIN - SPOS_MAX [ 569.717588][T17239] bcachefs (loop2): bch2_get_scanned_nodes(): recovering u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 [ 569.804519][T15862] bcachefs (loop2): error validating btree node on loop2 at btree extents level 0/0 [ 569.804549][T15862] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 [ 569.804565][T15862] node offset 8/32 bset u64s 2097: bset past end of btree node (offset 8 len 40 but written 32), fixing [ 569.846302][T15862] bcachefs (loop2): error validating btree node on loop2 at btree extents level 0/0 [ 569.846322][T15862] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 [ 569.846336][T15862] node offset 8/32 bset u64s 0: empty bset, fixing [ 569.881631][T15862] bcachefs (loop2): btree_node_read_work: rewriting btree node at due to error [ 569.881631][T15862] btree=extents level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 [ 569.910383][T17239] bcachefs (loop2): bch2_get_scanned_nodes(): recovery btree=extents level=0 POS_MIN - 0:36028797018963967:U32_MAX [ 569.923229][T17239] btree node with incorrect min_key at btree=extents level=1: [ 569.923247][T17239] parent: u64s 5 type btree_ptr SPOS_MAX len 0 ver 0 [ 569.923257][T17239] next: u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0, fixing [ 569.955158][T17239] bcachefs (loop2): set_node_min(): u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 -> POS_MIN [ 569.994086][T17239] bcachefs (loop2): btree root xattrs unreadable, must recover from scan [ 570.012810][T17239] no nodes found for btree xattrs, continuing [ 570.023069][T17239] done [ 570.046803][T17239] bcachefs (loop2): accounting_read... done [ 570.104523][T17239] bcachefs (loop2): alloc_read... done [ 570.110491][T17239] bcachefs (loop2): stripes_read... done [ 570.137131][T17239] bcachefs (loop2): snapshots_read... done [ 570.143123][T17239] bcachefs (loop2): check_allocations... [ 570.187587][T17239] bucket 0:26 data type btree ptr gen 0 missing in alloc btree [ 570.187613][T17239] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0, fixing [ 570.358423][T17239] bucket 0:38 data type btree ptr gen 0 missing in alloc btree [ 570.358445][T17239] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0, fixing [ 570.476561][T17239] bucket 0:41 data type btree ptr gen 0 missing in alloc btree [ 570.476583][T17239] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0, fixing [ 570.496336][T17396] loop4: detected capacity change from 0 to 32768 [ 570.574432][T17239] bucket 0:35 data type btree ptr gen 0 missing in alloc btree [ 570.574455][T17239] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c0bef60d07ceb940 written 16 min_key POS_MIN durability: 1 ptr: 0:35:0 gen 0, fixing [ 570.622332][T17396] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 570.622428][T17396] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 570.695152][T17401] loop3: detected capacity change from 0 to 32768 [ 570.716189][T17402] loop0: detected capacity change from 0 to 32768 [ 570.769508][T17239] bucket 0:1 gen 0 has wrong data_type: got free, should be sb, fixing [ 570.804427][T17239] bucket 0:1 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 570.837053][T17401] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 570.837145][T17401] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 570.863892][T17402] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 570.892430][T17239] bucket 0:2 gen 0 has wrong data_type: got free, should be sb, fixing [ 570.901094][T17402] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 570.913175][T17405] loop1: detected capacity change from 0 to 32768 [ 570.985333][T17239] bucket 0:2 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 571.003646][T17239] bucket 0:3 gen 0 has wrong data_type: got free, should be sb, fixing [ 571.057778][T17239] bucket 0:3 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 571.075761][T17401] bcachefs: bch2_fs_get_tree() error: EINVAL [ 571.094707][T17396] bcachefs: bch2_fs_get_tree() error: EINVAL [ 571.159609][T17405] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 571.159692][T17405] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 571.265341][T17402] bcachefs: bch2_fs_get_tree() error: EINVAL [ 571.351646][T17239] bucket 0:4 gen 0 has wrong data_type: got free, should be sb, fixing [ 571.376268][T17239] bucket 0:4 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 571.404539][T17239] bucket 0:5 gen 0 has wrong data_type: got free, should be sb, fixing [ 571.413002][T17239] bucket 0:5 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing executing program [ 571.456896][T17239] bucket 0:6 gen 0 has wrong data_type: got free, should be sb, fixing [ 571.470181][T17239] bucket 0:6 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing executing program [ 571.512838][T17239] bucket 0:7 gen 0 has wrong data_type: got free, should be sb, fixing [ 571.554118][T17239] bucket 0:7 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing executing program [ 571.597301][T17405] bcachefs: bch2_fs_get_tree() error: EINVAL [ 571.627715][T17239] bucket 0:8 gen 0 has wrong data_type: got free, should be sb, fixing [ 571.670323][T17239] bucket 0:8 gen 0 data type sb has wrong dirty_sectors: got 0, should be 8, fixing [ 571.715175][T17239] bucket 0:9 gen 0 has wrong data_type: got free, should be journal, fixing [ 571.734851][T17239] bucket 0:9 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 571.764392][T17239] bucket 0:10 gen 0 has wrong data_type: got free, should be journal, fixing [ 571.773270][T17239] bucket 0:10 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 571.834329][T17239] bucket 0:11 gen 0 has wrong data_type: got free, should be journal, fixing [ 571.875196][T17239] bucket 0:11 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 571.914861][T17239] bucket 0:12 gen 0 has wrong data_type: got free, should be journal, fixing executing program [ 571.944463][T17239] bucket 0:12 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 571.974615][T17239] bucket 0:13 gen 0 has wrong data_type: got free, should be journal, fixing [ 572.003300][T17239] bucket 0:13 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 572.034490][T17239] bucket 0:14 gen 0 has wrong data_type: got free, should be journal, fixing [ 572.043366][T17239] bucket 0:14 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 572.094282][T17239] bucket 0:15 gen 0 has wrong data_type: got free, should be journal, fixing [ 572.113877][T17239] bucket 0:15 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 572.144353][T17239] bucket 0:16 gen 0 has wrong data_type: got free, should be sb, fixing [ 572.173411][T17239] bucket 0:16 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 572.204145][T17239] bucket 0:17 gen 0 has wrong data_type: got free, should be sb, fixing [ 572.231781][T17239] bucket 0:17 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 572.273802][T17239] bucket 0:18 gen 0 has wrong data_type: got free, should be sb, fixing [ 572.302968][T17239] bucket 0:18 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 572.354371][T17239] bucket 0:19 gen 0 has wrong data_type: got free, should be sb, fixing [ 572.383658][T17239] bucket 0:19 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 572.421845][T17239] bucket 0:20 gen 0 has wrong data_type: got free, should be sb, fixing [ 572.444669][T17239] bucket 0:20 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 572.514367][T17239] bucket 0:21 gen 0 has wrong data_type: got free, should be sb, fixing [ 572.522992][T17239] bucket 0:21 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 572.585842][T17462] loop3: detected capacity change from 0 to 32768 [ 572.644392][T17239] bucket 0:22 gen 0 has wrong data_type: got free, should be sb, fixing [ 572.677146][T17465] loop4: detected capacity change from 0 to 32768 [ 572.734840][T17239] bucket 0:22 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 572.768385][T17239] bucket 0:23 gen 0 has wrong data_type: got free, should be sb, fixing [ 572.804437][T17239] bucket 0:23 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 572.815756][T17239] bucket 0:24 gen 0 has wrong data_type: got free, should be journal, fixing [ 572.817140][T17465] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 572.847496][T17239] bucket 0:24 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 572.868516][T17462] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 572.868589][T17462] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 572.879537][T17465] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 572.890039][T17468] loop0: detected capacity change from 0 to 32768 [ 572.950765][T17239] bucket 0:26 gen 0 has wrong data_type: got free, should be btree, fixing [ 572.961016][T17239] bucket 0:26 gen 0 data type btree has wrong dirty_sectors: got 0, should be 32, fixing [ 572.971592][T17239] bucket 0:27 gen 0 data type btree has wrong dirty_sectors: got 256, should be 32, fixing [ 572.982732][T17239] bucket 0:28 gen 0 data type btree has wrong dirty_sectors: got 256, should be 32, fixing [ 573.012452][T17239] bucket 0:31 gen 0 has wrong data_type: got btree, should be need_discard, fixing [ 573.064275][T17239] bucket 0:31 gen 0 data type need_discard has wrong dirty_sectors: got 256, should be 0, fixing [ 573.095724][T17468] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 573.095814][T17468] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 573.152812][T17474] loop1: detected capacity change from 0 to 32768 [ 573.202737][T17462] bcachefs: bch2_fs_get_tree() error: EINVAL [ 573.252264][T17239] bucket 0:32 gen 0 has wrong data_type: got sb, should be btree, fixing [ 573.273231][T17465] bcachefs: bch2_fs_get_tree() error: EINVAL [ 573.317081][T17474] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 573.355067][T17474] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 573.364670][T17239] bucket 0:32 gen 0 data type btree has wrong dirty_sectors: got 256, should be 32, fixing [ 573.385328][T17468] bcachefs: bch2_fs_get_tree() error: EINVAL [ 573.425544][T17239] bucket 0:34 gen 0 has wrong data_type: got user, should be need_discard, fixing [ 573.466871][T17239] bucket 0:34 gen 0 data type need_discard has wrong dirty_sectors: got 16, should be 0, fixing [ 573.514482][T17239] bucket 0:35 gen 0 has wrong data_type: got free, should be btree, fixing [ 573.534446][T17239] bucket 0:35 gen 0 data type btree has wrong dirty_sectors: got 0, should be 32, fixing [ 573.564765][T17239] bucket 0:37 gen 0 data type btree has wrong dirty_sectors: got 256, should be 32, fixing executing program [ 573.613074][T17239] bucket 0:38 gen 0 has wrong data_type: got free, should be btree, fixing [ 573.635134][T17239] bucket 0:38 gen 0 data type btree has wrong dirty_sectors: got 0, should be 32, fixing [ 573.654370][T17239] bucket 0:41 gen 0 has wrong data_type: got free, should be btree, fixing executing program [ 573.705173][T17239] bucket 0:41 gen 0 data type btree has wrong dirty_sectors: got 0, should be 32, fixing executing program [ 573.757211][T17474] bcachefs: bch2_fs_get_tree() error: EINVAL [ 573.795302][T17239] bucket 0:42 gen 0 data type btree has wrong dirty_sectors: got 256, should be 32, fixing [ 573.843850][T17239] bucket 0:120 gen 0 has wrong data_type: got free, should be sb, fixing [ 573.874393][T17239] bucket 0:120 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 573.934430][T17239] bucket 0:121 gen 0 has wrong data_type: got free, should be sb, fixing [ 573.943233][T17239] bucket 0:121 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 573.993767][T17239] bucket 0:122 gen 0 has wrong data_type: got free, should be sb, fixing [ 574.021845][T17239] bucket 0:122 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing executing program [ 574.057448][T17239] bucket 0:123 gen 0 has wrong data_type: got free, should be sb, fixing [ 574.089388][T17239] bucket 0:123 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 574.140370][T17239] bucket 0:124 gen 0 has wrong data_type: got free, should be sb, fixing [ 574.174098][T17239] bucket 0:124 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 574.214277][T17239] bucket 0:125 gen 0 has wrong data_type: got free, should be sb, fixing [ 574.233347][T17239] bucket 0:125 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 574.273892][T17239] bucket 0:126 gen 0 has wrong data_type: got free, should be sb, fixing [ 574.304156][T17239] bucket 0:126 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 574.343551][T17239] bucket 0:127 gen 0 has wrong data_type: got free, should be sb, fixing [ 574.382943][T17239] bucket 0:127 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 574.454988][T17239] done [ 574.480772][T17239] bcachefs (loop2): going read-write [ 574.534258][T17239] bcachefs (loop2): journal_replay... [ 574.630184][ T36] bucket incorrectly unset in freespace btree [ 574.630218][ T36] u64s 5 type deleted 0:25:0 len 0 ver 0, , continuing [ 574.739281][ T36] bucket incorrectly unset in freespace btree [ 574.739303][ T36] u64s 5 type deleted 0:29:0 len 0 ver 0, , continuing [ 574.917669][ T53] bucket incorrectly unset in freespace btree [ 574.917690][ T53] u64s 5 type deleted 0:30:0 len 0 ver 0, , continuing [ 574.978059][T17533] loop4: detected capacity change from 0 to 32768 [ 574.990652][T17239] done [ 574.994917][T17239] bcachefs (loop2): check_alloc_info... [ 574.996836][T17239] bucket incorrectly unset in need_discard btree [ 574.996856][T17239] u64s 13 type alloc_v4 0:31:0 len 0 ver 0: [ 574.996868][T17239] gen 0 oldest_gen 0 data_type need_discard [ 574.996880][T17239] journal_seq_nonempty 4 [ 574.996890][T17239] journal_seq_empty 0 [ 574.996901][T17239] need_discard 1 [ 574.996910][T17239] need_inc_gen 1 [ 574.996921][T17239] dirty_sectors 0 [ 574.996931][T17239] stripe_sectors 0 [ 574.996941][T17239] cached_sectors 0 [ 574.996952][T17239] stripe 0 [ 574.996962][T17239] stripe_redundancy 0 [ 574.996972][T17239] io_time[READ] 1 [ 574.996982][T17239] io_time[WRITE] 512 [ 574.996993][T17239] fragmentation 0 [ 574.997003][T17239] bp_start 8 [ 574.997013][T17239] , fixing [ 575.099130][T17536] loop0: detected capacity change from 0 to 32768 [ 575.190785][T17533] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 575.190877][T17533] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 575.248360][T17542] loop1: detected capacity change from 0 to 32768 [ 575.262218][T17538] loop3: detected capacity change from 0 to 32768 [ 575.293391][T17239] bucket incorrectly unset in need_discard btree [ 575.293412][T17239] u64s 13 type alloc_v4 0:31:0 len 0 ver 0: [ 575.293423][T17239] gen 0 oldest_gen 0 data_type need_discard [ 575.293530][T17239] journal_seq_nonempty 4 [ 575.293541][T17239] journal_seq_empty 0 [ 575.293550][T17239] need_discard 1 [ 575.293558][T17239] need_inc_gen 1 [ 575.293566][T17239] dirty_sectors 0 [ 575.293575][T17239] stripe_sectors 0 [ 575.293583][T17239] cached_sectors 0 [ 575.293696][T17239] stripe 0 [ 575.293709][T17239] stripe_redundancy 0 [ 575.293718][T17239] io_time[READ] 1 [ 575.293727][T17239] io_time[WRITE] 512 [ 575.293735][T17239] fragmentation 0 [ 575.293744][T17239] bp_start 8 [ 575.293753][T17239] , fixing [ 575.319970][T17536] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 575.320061][T17536] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 575.498972][T17538] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open executing program [ 575.499064][T17538] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 575.538429][T17536] bcachefs: bch2_fs_get_tree() error: EINVAL [ 575.554402][T17533] bcachefs: bch2_fs_get_tree() error: EINVAL [ 575.625441][T17542] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 575.625534][T17542] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 575.743411][T17538] bcachefs: bch2_fs_get_tree() error: EINVAL executing program [ 575.966729][T17239] bucket incorrectly unset in need_discard btree [ 575.966750][T17239] u64s 13 type alloc_v4 0:31:0 len 0 ver 0: [ 575.966761][T17239] gen 0 oldest_gen 0 data_type need_discard [ 575.966773][T17239] journal_seq_nonempty 4 [ 575.966783][T17239] journal_seq_empty 0 [ 575.966794][T17239] need_discard 1 executing program [ 575.966805][T17239] need_inc_gen 1 [ 575.966815][T17239] dirty_sectors 0 [ 575.966826][T17239] stripe_sectors 0 [ 575.966837][T17239] cached_sectors 0 [ 575.966847][T17239] stripe 0 [ 575.966855][T17239] stripe_redundancy 0 [ 575.966863][T17239] io_time[READ] 1 [ 575.966872][T17239] io_time[WRITE] 512 [ 575.966881][T17239] fragmentation 0 [ 575.966890][T17239] bp_start 8 [ 575.966899][T17239] , fixing [ 576.014230][T17542] bcachefs: bch2_fs_get_tree() error: EINVAL [ 576.308895][T17239] hole in alloc btree missing in freespace btree [ 576.308917][T17239] device 0 buckets 33-34, fixing executing program [ 576.364609][T17239] hole in alloc btree missing in freespace btree [ 576.364631][T17239] device 0 buckets 33-34, fixing [ 576.394763][T17239] bucket incorrectly unset in need_discard btree [ 576.394783][T17239] u64s 13 type alloc_v4 0:34:0 len 0 ver 0: [ 576.394793][T17239] gen 0 oldest_gen 0 data_type need_discard [ 576.394804][T17239] journal_seq_nonempty 5 [ 576.394813][T17239] journal_seq_empty 134217728 [ 576.394823][T17239] need_discard 1 [ 576.394832][T17239] need_inc_gen 1 [ 576.394841][T17239] dirty_sectors 0 [ 576.394850][T17239] stripe_sectors 0 [ 576.394860][T17239] cached_sectors 0 [ 576.394869][T17239] stripe 0 [ 576.394878][T17239] stripe_redundancy 0 [ 576.394888][T17239] io_time[READ] 1 [ 576.394898][T17239] io_time[WRITE] 512 [ 576.394907][T17239] fragmentation 0 [ 576.394916][T17239] bp_start 8 [ 576.394925][T17239] , fixing [ 576.680354][T17239] bucket incorrectly unset in need_discard btree [ 576.680374][T17239] u64s 13 type alloc_v4 0:34:0 len 0 ver 0: [ 576.680387][T17239] gen 0 oldest_gen 0 data_type need_discard [ 576.680398][T17239] journal_seq_nonempty 5 [ 576.680409][T17239] journal_seq_empty 134217728 [ 576.680420][T17239] need_discard 1 [ 576.680431][T17239] need_inc_gen 1 [ 576.680441][T17239] dirty_sectors 0 [ 576.680452][T17239] stripe_sectors 0 [ 576.680462][T17239] cached_sectors 0 [ 576.680473][T17239] stripe 0 [ 576.680483][T17239] stripe_redundancy 0 [ 576.680494][T17239] io_time[READ] 1 [ 576.680504][T17239] io_time[WRITE] 512 [ 576.680515][T17239] fragmentation 0 [ 576.680525][T17239] bp_start 8 [ 576.680535][T17239] , fixing [ 576.897544][T17239] hole in alloc btree missing in freespace btree [ 576.897564][T17239] device 0 buckets 36-37, fixing [ 576.930614][T17239] hole in alloc btree missing in freespace btree [ 576.930636][T17239] device 0 buckets 39-41, fixing [ 576.965774][T17239] hole in alloc btree missing in freespace btree [ 576.965794][T17239] device 0 buckets 39-41, fixing [ 576.973371][T17592] loop0: detected capacity change from 0 to 32768 [ 577.054395][T17239] hole in alloc btree missing in freespace btree [ 577.054416][T17239] device 0 buckets 43-120, fixing [ 577.144253][T17592] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 577.144363][T17592] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 577.206456][T17597] loop4: detected capacity change from 0 to 32768 [ 577.312955][T17239] done [ 577.358700][T17239] bcachefs (loop2): check_lrus... [ 577.361887][T17239] incorrect lru entry: lru fragmentation time 134217728 [ 577.361909][T17239] u64s 5 type set 18446462598867058688:34:0 len 0 ver 0 [ 577.361921][T17239] for u64s 13 type alloc_v4 0:34:0 len 0 ver 0: [ 577.361933][T17239] gen 1 oldest_gen 0 data_type free [ 577.361944][T17239] journal_seq_nonempty 5 [ 577.361954][T17239] journal_seq_empty 134217728 [ 577.361964][T17239] need_discard 0 [ 577.361983][T17239] need_inc_gen 0 [ 577.361994][T17239] dirty_sectors 0 [ 577.362004][T17239] stripe_sectors 0 [ 577.362015][T17239] cached_sectors 0 [ 577.362026][T17239] stripe 0 [ 577.362036][T17239] stripe_redundancy 0 [ 577.362047][T17239] io_time[READ] 1 [ 577.362057][T17239] io_time[WRITE] 512 [ 577.362068][T17239] fragmentation 0 [ 577.362077][T17239] bp_start 8 [ 577.362087][T17239] , fixing [ 577.392560][T17597] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 577.392644][T17597] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 577.618352][T17600] loop3: detected capacity change from 0 to 32768 [ 577.666116][T17592] bcachefs: bch2_fs_get_tree() error: EINVAL executing program [ 577.774868][T17597] bcachefs: bch2_fs_get_tree() error: EINVAL [ 577.782983][T17600] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 577.783072][T17600] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 577.811330][T17605] loop1: detected capacity change from 0 to 32768 [ 578.027480][T17239] done executing program [ 578.059672][T17239] bcachefs (loop2): check_btree_backpointers... done [ 578.068325][T17239] bcachefs (loop2): check_backpointers_to_extents... done [ 578.109905][T17600] bcachefs: bch2_fs_get_tree() error: EINVAL [ 578.150782][T17605] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 578.172565][T17605] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 578.195495][T17239] bcachefs (loop2): check_extents_to_backpointers... [ 578.197265][T17239] bcachefs (loop2): scanning for missing backpointers in 3/128 buckets [ 578.225272][T17239] done [ 578.242124][T17239] bcachefs (loop2): check_alloc_to_lru_refs... [ 578.243555][T17239] missing fragmentation lru entry [ 578.243574][T17239] u64s 13 type alloc_v4 0:32:0 len 0 ver 0: [ 578.243585][T17239] gen 0 oldest_gen 0 data_type btree [ 578.243596][T17239] journal_seq_nonempty 1 [ 578.243606][T17239] journal_seq_empty 0 [ 578.243615][T17239] need_discard 1 [ 578.243624][T17239] need_inc_gen 1 [ 578.243633][T17239] dirty_sectors 32 [ 578.243642][T17239] stripe_sectors 0 [ 578.243651][T17239] cached_sectors 0 [ 578.243660][T17239] stripe 0 [ 578.243669][T17239] stripe_redundancy 0 [ 578.243678][T17239] io_time[READ] 1 [ 578.243687][T17239] io_time[WRITE] 1 [ 578.243696][T17239] fragmentation 268435456 [ 578.243706][T17239] bp_start 8 [ 578.243716][T17239] , fixing [ 578.375227][T17239] missing fragmentation lru entry [ 578.375246][T17239] u64s 13 type alloc_v4 0:35:0 len 0 ver 0: executing program [ 578.375258][T17239] gen 0 oldest_gen 0 data_type btree [ 578.375270][T17239] journal_seq_nonempty 0 [ 578.375280][T17239] journal_seq_empty 0 [ 578.375291][T17239] need_discard 0 [ 578.375302][T17239] need_inc_gen 0 [ 578.375313][T17239] dirty_sectors 32 [ 578.375323][T17239] stripe_sectors 0 [ 578.375334][T17239] cached_sectors 0 [ 578.375344][T17239] stripe 0 [ 578.375355][T17239] stripe_redundancy 0 [ 578.375365][T17239] io_time[READ] 0 [ 578.375376][T17239] io_time[WRITE] 0 [ 578.375387][T17239] fragmentation 268435456 [ 578.375398][T17239] bp_start 8 [ 578.375409][T17239] , fixing [ 578.576254][T17605] bcachefs: bch2_fs_get_tree() error: EINVAL [ 578.661696][T17239] missing fragmentation lru entry [ 578.661715][T17239] u64s 13 type alloc_v4 0:42:0 len 0 ver 0: [ 578.661726][T17239] gen 0 oldest_gen 0 data_type btree [ 578.661736][T17239] journal_seq_nonempty 7 [ 578.661746][T17239] journal_seq_empty 0 [ 578.661756][T17239] need_discard 1 [ 578.661765][T17239] need_inc_gen 1 [ 578.661774][T17239] dirty_sectors 32 [ 578.661783][T17239] stripe_sectors 0 [ 578.661793][T17239] cached_sectors 0 [ 578.661803][T17239] stripe 0 [ 578.661812][T17239] stripe_redundancy 0 [ 578.661822][T17239] io_time[READ] 1 [ 578.661831][T17239] io_time[WRITE] 1280 executing program [ 578.661841][T17239] fragmentation 268435456 [ 578.661850][T17239] bp_start 8 [ 578.661859][T17239] , fixing [ 578.989427][T17239] done [ 579.035992][T17239] bcachefs (loop2): bucket_gens_init... done [ 579.085093][T17239] bcachefs (loop2): check_snapshot_trees... done [ 579.112333][T17239] bcachefs (loop2): check_snapshots... [ 579.112789][T17239] snapshot points to missing/incorrect tree: [ 579.112814][T17239] u64s 8 type snapshot 0:4294967295:0 len 0 ver 0: is_subvol 1 deleted 0 parent 0 children 0 0 subvol 1 tree 0, fixing [ 579.195131][T17671] loop4: detected capacity change from 0 to 32768 [ 579.246748][T17239] snapshot points to missing/incorrect tree: [ 579.246770][T17239] u64s 8 type snapshot 0:4294967295:0 len 0 ver 0: is_subvol 1 deleted 0 parent 0 children 0 0 subvol 1 tree 0, fixing [ 579.305541][T17671] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 579.331326][T17668] loop0: detected capacity change from 0 to 32768 [ 579.346849][T17239] done [ 579.352489][T17671] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 579.367425][T17239] bcachefs (loop2): check_subvols... done [ 579.382508][T17239] bcachefs (loop2): check_subvol_children... done [ 579.421845][T17239] bcachefs (loop2): delete_dead_snapshots... done [ 579.447895][T17239] bcachefs (loop2): check_inodes... done [ 579.507682][T17668] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 579.543616][T17239] bcachefs (loop2): check_extents... [ 579.543690][T17668] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 579.543702][T17239] done [ 579.574162][T17239] bcachefs (loop2): check_indirect_extents... done [ 579.586083][T17239] bcachefs (loop2): check_dirents... done [ 579.614506][T17239] bcachefs (loop2): check_xattrs... done [ 579.619818][T17679] loop3: detected capacity change from 0 to 32768 [ 579.621702][T17239] bcachefs (loop2): check_root... done [ 579.665613][T17239] bcachefs (loop2): check_unreachable_inodes... done [ 579.689932][T17689] loop1: detected capacity change from 0 to 32768 [ 579.690209][T17239] bcachefs (loop2): check_subvolume_structure... done [ 579.734389][T17671] bcachefs: bch2_fs_get_tree() error: EINVAL [ 579.741683][T17239] bcachefs (loop2): check_directory_structure... done [ 579.821635][T17239] bcachefs (loop2): check_nlinks... done [ 579.840683][T17679] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 579.858498][T17239] bcachefs (loop2): resume_logged_ops... done [ 579.865742][T17679] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 579.877488][T17689] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 579.897374][T17239] bcachefs (loop2): delete_dead_inodes... done [ 579.911843][T17239] bcachefs (loop2): set_fs_needs_rebalance... done [ 579.927878][T17668] bcachefs: bch2_fs_get_tree() error: EINVAL [ 579.933769][T17689] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 580.076822][T17239] bcachefs (loop2): Fixed errors, running fsck a second time to verify fs is clean [ 580.104688][T17239] bcachefs (loop2): check_alloc_info... done [ 580.118372][T17239] bcachefs (loop2): check_lrus... done executing program executing program [ 580.126687][T17239] bcachefs (loop2): check_btree_backpointers... done [ 580.178628][T17239] bcachefs (loop2): check_backpointers_to_extents... done [ 580.207737][T17239] bcachefs (loop2): check_extents_to_backpointers... done [ 580.226514][T17239] bcachefs (loop2): check_alloc_to_lru_refs... done [ 580.245210][T17239] bcachefs (loop2): bucket_gens_init... done [ 580.270371][T17239] bcachefs (loop2): check_snapshot_trees... done [ 580.284502][T17239] bcachefs (loop2): check_snapshots... done [ 580.309911][T17239] bcachefs (loop2): check_subvols... done [ 580.324163][T17239] bcachefs (loop2): check_subvol_children... done [ 580.324872][T17679] bcachefs: bch2_fs_get_tree() error: EINVAL [ 580.336880][T17239] bcachefs (loop2): delete_dead_snapshots... done [ 580.364834][T17689] bcachefs: bch2_fs_get_tree() error: EINVAL [ 580.384951][T17239] bcachefs (loop2): check_inodes... done [ 580.433426][T17239] bcachefs (loop2): check_extents... done [ 580.484427][T17239] bcachefs (loop2): check_indirect_extents... done [ 580.491181][T17239] bcachefs (loop2): check_dirents... done executing program [ 580.525139][T17239] bcachefs (loop2): check_xattrs... done [ 580.541280][T17239] bcachefs (loop2): check_root... done [ 580.551383][T17239] bcachefs (loop2): check_unreachable_inodes... done [ 580.599218][T17239] bcachefs (loop2): check_subvolume_structure... done [ 580.623929][T17239] bcachefs (loop2): check_directory_structure... done [ 580.631775][T17239] bcachefs (loop2): check_nlinks... done [ 580.644145][T17239] bcachefs (loop2): resume_logged_ops... done [ 580.660785][T17239] bcachefs (loop2): delete_dead_inodes... done [ 580.679069][T17239] bcachefs (loop2): set_fs_needs_rebalance... done executing program [ 580.713171][T17239] bcachefs (loop2): bch2_copygc_start(): error creating copygc thread EINTR [ 580.729231][T17239] bcachefs (loop2): error starting copygc thread [ 580.748371][T17239] bcachefs (loop2): bch2_fs_start(): error starting filesystem EINTR [ 580.774164][T17239] bcachefs (loop2): shutting down [ 580.795556][T17239] bcachefs (loop2): going read-only [ 580.820027][T17239] bcachefs (loop2): finished waiting for writes to stop [ 580.844308][T17239] bcachefs (loop2): flushing journal and stopping allocators, journal seq 34 [ 580.871873][T17239] bcachefs (loop2): flushing journal and stopping allocators complete, journal seq 34 [ 580.896216][T17239] bcachefs (loop2): clean shutdown complete, journal seq 35 [ 580.905355][T17239] bcachefs (loop2): marking filesystem clean [ 580.948016][T17239] bcachefs (loop2): shutdown complete [ 581.217026][T17719] loop4: detected capacity change from 0 to 32768 [ 581.230212][T17721] loop0: detected capacity change from 0 to 32768 [ 581.414155][T17726] loop3: detected capacity change from 0 to 32768 [ 581.446179][T17723] loop1: detected capacity change from 0 to 32768 [ 581.882221][T17721] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 581.894483][T17723] bcachefs (loop1): starting version 1.7: mi_btree_bitmap opts=errors=continue,metadata_checksum=none,data_checksum=none,compression=lz4,nojournal_transaction_names [ 581.930461][T17726] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 581.930482][T17721] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 581.948748][T17723] bcachefs (loop1): recovering from clean shutdown, journal seq 10 [ 581.957704][T17726] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 581.965611][T17719] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 581.983452][T17719] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 582.004166][T17723] bcachefs (loop1): Version upgrade required: [ 582.004166][T17723] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete [ 582.004166][T17723] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.20: directory_size [ 582.004166][T17723] running recovery passes: check_allocations,check_alloc_info,check_lrus,check_btree_backpointers,check_backpointers_to_extents,check_extents_to_backpointers,check_alloc_to_lru_refs,bucket_gens_init,check_snapshot_trees,check_snapshots,check_subvols,check_subvol_children,delete_dead_snapshots,check_inodes,check_extents,check_indirect_extents,check_dirents,check_xattrs,check_root,check_unreachable_inodes,check_subvolume_structure,check_directory_structure,check_nlinks,set_fs_needs_rebalance [ 582.114279][T17239] bcachefs: bch2_fs_get_tree() error: EINTR [ 582.120470][T17723] bcachefs (loop1): error validating btree node on loop1 at btree extents level 0/0 [ 582.120495][T17723] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key POS_MIN durability: 1 ptr: 0:27:0 gen 0 [ 582.120510][T17723] node offset 0/16: incorrect min_key: got 0:36028797018963968:0 should be POS_MIN [ 582.246711][T17721] bcachefs: bch2_fs_get_tree() error: EINVAL [ 582.300061][T17723] bcachefs (loop1): running explicit recovery pass check_topology (2), currently at recovery_pass_empty (0) [ 582.344752][T17723] bcachefs (loop1): flagging btree extents lost data [ 582.375962][T17723] bcachefs (loop1): running explicit recovery pass scan_for_btree_nodes (1), currently at recovery_pass_empty (0) [ 582.398762][T17726] bcachefs: bch2_fs_get_tree() error: EINVAL [ 582.423954][T17723] error reading btree root btree=extents level=0: btree_node_read_error, fixing [ 582.437350][T17719] bcachefs: bch2_fs_get_tree() error: EINVAL [ 582.506362][T17723] bcachefs (loop1): error validating btree node at btree inodes level 0/0 executing program [ 582.506383][T17723] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0 [ 582.506398][T17723] node offset 16/24 bset u64s 110 bset byte offset 152: keys out of order: u64s 16 type inode_v3 134217728:4096:U32_MAX len 0 ver 0 > u64s 18 type inode_v3 0:4098:U32_MAX len 0 ver 0, fixing [ 582.664510][T17723] invalid bkey in btree_node btree=inodes level=0: u64s 16 type inode_v3 134217728:4096:U32_MAX len 0 ver 0: executing program [ 582.664533][T17723] mode=40755 [ 582.664544][T17723] flags=(16300000) [ 582.664554][T17723] journal_seq=0 [ 582.664564][T17723] hash_seed=28e4f092a4fc58ee [ 582.664574][T17723] hash_type=siphash executing program [ 582.664584][T17723] bi_size=0 [ 582.664594][T17723] bi_sectors=0 [ 582.664604][T17723] bi_version=0 executing program [ 582.664613][T17723] bi_atime=200535484 [ 582.664622][T17723] bi_ctime=2780562352 [ 582.664633][T17723] bi_mtime=2780562352 [ 582.664644][T17723] bi_otime=200535484 [ 582.664654][T17723] bi_uid=0 [ 582.664663][T17723] bi_gid=0 [ 582.664672][T17723] bi_nlink=2 [ 582.664682][T17723] bi_generation=0 [ 582.664692][T17723] bi_dev=0 [ 582.664703][T17723] bi_data_checksum=0 [ 582.664725][T17723] bi_compression=0 [ 582.664735][T17723] bi_project=0 [ 582.664745][T17723] bi_background_compression=0 [ 582.664755][T17723] bi_data_replicas=0 [ 582.664766][T17723] bi_promote_target=0 [ 582.664776][T17723] bi_foreground_target=0 [ 582.664786][T17723] bi_background_target=0 [ 582.664796][T17723] bi_erasure_code=0 [ 582.664806][T17723] bi_fields_set=0 [ 582.664817][T17723] bi_dir=0 [ 582.664827][T17723] bi_dir_offset=0 [ 582.664836][T17723] bi_subvol=1 [ 582.664846][T17723] bi_parent_subvol=0 [ 582.664856][T17723] bi_nocow=0 [ 582.664865][T17723] bi_depth=0 [ 582.664874][T17723] bi_inodes_32bit=0 [ 582.664884][T17723] nonzero k.p.inode: delete?, fixing [ 583.283001][T17723] bcachefs (loop1): btree_node_read_work: rewriting btree node at due to error [ 583.283001][T17723] btree=inodes level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0 [ 583.370014][T17723] bcachefs (loop1): error validating btree node on loop1 at btree dirents level 0/0 [ 583.370035][T17723] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0 [ 583.370049][T17723] node offset 16/24: btree node data missing: expected 24 sectors, found 16, fixing [ 583.511860][T17723] bcachefs (loop1): btree_node_read_work: rewriting btree node at due to error [ 583.511860][T17723] btree=dirents level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0 [ 583.585118][T17723] bcachefs (loop1): error validating btree node on loop1 at btree xattrs level 0/0 [ 583.585139][T17723] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 2285c34bed0abe32 written 16 min_key POS_MIN durability: 1 ptr: 0:31:0 gen 0 [ 583.585154][T17723] node offset 0/16 bset u64s 0: incorrect btree id [ 583.679143][T17723] bcachefs (loop1): flagging btree xattrs lost data [ 583.707426][T17773] loop2: detected capacity change from 0 to 32768 [ 583.719925][T17777] loop0: detected capacity change from 0 to 32768 [ 583.727288][T17723] error reading btree root btree=xattrs level=0: btree_node_read_error, fixing [ 583.759264][T17723] bcachefs (loop1): error validating btree node at btree alloc level 0/0 [ 583.759287][T17723] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0 [ 583.759303][T17723] node offset 8/24 bset u64s 375 bset byte offset 184: keys out of order: u64s 11 type alloc_v4 0:32:0 len 0 ver 0 > u64s 11 type alloc_v4 0:2:0 len 0 ver 0, fixing [ 583.816772][T17781] loop3: detected capacity change from 0 to 32768 [ 583.819688][T17723] bcachefs (loop1): btree_node_read_work: rewriting btree node at due to error [ 583.819688][T17723] btree=alloc level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0 [ 583.852420][T17723] bcachefs (loop1): error validating btree node on loop1 at btree freespace level 0/0 [ 583.852442][T17723] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq e81e1ed936acf3df written 32 min_key POS_MIN durability: 1 ptr: 0:29:0 gen 0 [ 583.852457][T17723] node offset 0/32 bset u64s 0: invalid bkey format: incorrect number of fields: got 0, should be 6 [ 583.852469][T17723] u64s 5 fields 64:0, 64:0, 32:0, 0:0, 0:0, 0:0 [ 583.938508][T17723] bcachefs (loop1): flagging btree freespace lost data [ 583.938799][T17783] loop4: detected capacity change from 0 to 32768 [ 583.952189][T17723] error reading btree root btree=freespace level=0: btree_node_read_error, fixing [ 583.965137][T17723] bcachefs (loop1): scan_for_btree_nodes... [ 583.987665][T17773] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 584.003419][T17773] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 584.033333][T17781] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 584.049263][T17781] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 584.057519][T17777] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 584.069076][T17777] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 584.103791][T17783] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 584.171307][T17816] invalid bkey in btree_node btree=stripes level=0: u64s 7 type xattr 536870912:3798421620223919902:U32_MAX len 0 ver 0: user.xattr2:xattr2 [ 584.171331][T17816] nonzero snapshot: delete?, fixing [ 584.175111][T17781] bcachefs: bch2_fs_get_tree() error: EINVAL [ 584.196781][T17783] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 584.274665][T17816] bcachefs (loop1): flagging btree stripes lost data [ 584.368214][T17773] bcachefs: bch2_fs_get_tree() error: EINVAL [ 584.411217][T17777] bcachefs: bch2_fs_get_tree() error: EINVAL executing program [ 584.570007][T17783] bcachefs: bch2_fs_get_tree() error: EINVAL executing program executing program [ 584.916834][T17723] bcachefs (loop1): btree node scan found 6 nodes after overwrites [ 584.933555][T17723] done [ 584.942294][T17723] bcachefs (loop1): check_topology... [ 584.943103][T17723] bcachefs (loop1): btree root extents unreadable, must recover from scan executing program [ 584.977610][T17723] bcachefs (loop1): bch2_get_scanned_nodes(): recovery btree=extents level=0 POS_MIN - SPOS_MAX [ 585.004391][T17723] bcachefs (loop1): bch2_get_scanned_nodes(): recovering u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 [ 585.085570][T15862] bcachefs (loop1): error validating btree node on loop1 at btree extents level 0/0 [ 585.085600][T15862] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 [ 585.085617][T15862] node offset 8/32 bset u64s 2097: bset past end of btree node (offset 8 len 40 but written 32), fixing [ 585.125938][T15862] bcachefs (loop1): error validating btree node on loop1 at btree extents level 0/0 [ 585.125960][T15862] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 [ 585.125975][T15862] node offset 8/32 bset u64s 0: empty bset, fixing [ 585.161045][T15862] bcachefs (loop1): btree_node_read_work: rewriting btree node at due to error [ 585.161045][T15862] btree=extents level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 [ 585.194445][T17723] bcachefs (loop1): bch2_get_scanned_nodes(): recovery btree=extents level=0 POS_MIN - 0:36028797018963967:U32_MAX [ 585.242076][T17723] btree node with incorrect min_key at btree=extents level=1: [ 585.242095][T17723] parent: u64s 5 type btree_ptr SPOS_MAX len 0 ver 0 [ 585.242106][T17723] next: u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0, fixing [ 585.394315][T17723] bcachefs (loop1): set_node_min(): u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 -> POS_MIN [ 585.484443][T17723] bcachefs (loop1): btree root xattrs unreadable, must recover from scan [ 585.493058][T17723] no nodes found for btree xattrs, continuing [ 585.518019][T17723] done [ 585.521759][T17723] bcachefs (loop1): accounting_read... done [ 585.554211][T17723] bcachefs (loop1): alloc_read... done [ 585.563248][T17723] bcachefs (loop1): stripes_read... done [ 585.594148][T17723] bcachefs (loop1): snapshots_read... done [ 585.611153][T17723] bcachefs (loop1): check_allocations... [ 585.634583][T17723] bucket 0:26 data type btree ptr gen 0 missing in alloc btree [ 585.634607][T17723] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0, fixing [ 585.719382][T17840] loop2: detected capacity change from 0 to 32768 [ 585.749461][T17723] bucket 0:38 data type btree ptr gen 0 missing in alloc btree [ 585.749483][T17723] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0, fixing [ 585.751927][T17834] loop3: detected capacity change from 0 to 32768 [ 585.795870][T17723] bucket 0:41 data type btree ptr gen 0 missing in alloc btree [ 585.795892][T17723] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0, fixing [ 585.891363][T17837] loop0: detected capacity change from 0 to 32768 [ 585.906487][T17723] bucket 0:35 data type btree ptr gen 0 missing in alloc btree [ 585.906509][T17723] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c0bef60d07ceb940 written 16 min_key POS_MIN durability: 1 ptr: 0:35:0 gen 0, fixing [ 585.933738][T17840] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 585.933819][T17840] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 585.962564][T17843] loop4: detected capacity change from 0 to 32768 [ 585.965204][T17834] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 585.965270][T17834] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 586.104941][T17723] bucket 0:1 gen 0 has wrong data_type: got free, should be sb, fixing [ 586.131012][T17843] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 586.131083][T17843] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 586.136198][T17837] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 586.136289][T17837] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 586.242720][T17834] bcachefs: bch2_fs_get_tree() error: EINVAL [ 586.319133][T17840] bcachefs: bch2_fs_get_tree() error: EINVAL [ 586.410389][T17723] bucket 0:1 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 586.445188][T17723] bucket 0:2 gen 0 has wrong data_type: got free, should be sb, fixing [ 586.465905][T17723] bucket 0:2 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 586.485572][T17837] bcachefs: bch2_fs_get_tree() error: EINVAL [ 586.529547][T17843] bcachefs: bch2_fs_get_tree() error: EINVAL executing program [ 586.570928][T17723] bucket 0:3 gen 0 has wrong data_type: got free, should be sb, fixing [ 586.585691][T17723] bucket 0:3 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing executing program [ 586.644334][T17723] bucket 0:4 gen 0 has wrong data_type: got free, should be sb, fixing [ 586.669980][T17723] bucket 0:4 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 586.714592][T17723] bucket 0:5 gen 0 has wrong data_type: got free, should be sb, fixing [ 586.745785][T17723] bucket 0:5 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing executing program [ 586.776225][T17723] bucket 0:6 gen 0 has wrong data_type: got free, should be sb, fixing [ 586.794110][T17723] bucket 0:6 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 586.839177][T17723] bucket 0:7 gen 0 has wrong data_type: got free, should be sb, fixing [ 586.874115][T17723] bucket 0:7 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing executing program [ 586.932107][T17723] bucket 0:8 gen 0 has wrong data_type: got free, should be sb, fixing [ 586.971355][T17723] bucket 0:8 gen 0 data type sb has wrong dirty_sectors: got 0, should be 8, fixing [ 587.012823][T17723] bucket 0:9 gen 0 has wrong data_type: got free, should be journal, fixing [ 587.054204][T17723] bucket 0:9 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 587.078848][T17723] bucket 0:10 gen 0 has wrong data_type: got free, should be journal, fixing [ 587.124115][T17723] bucket 0:10 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 587.152837][T17723] bucket 0:11 gen 0 has wrong data_type: got free, should be journal, fixing [ 587.194252][T17723] bucket 0:11 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 587.205084][T17723] bucket 0:12 gen 0 has wrong data_type: got free, should be journal, fixing [ 587.214896][T17723] bucket 0:12 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 587.225699][T17723] bucket 0:13 gen 0 has wrong data_type: got free, should be journal, fixing [ 587.244120][T17723] bucket 0:13 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 587.255030][T17723] bucket 0:14 gen 0 has wrong data_type: got free, should be journal, fixing [ 587.292506][T17723] bucket 0:14 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 587.314450][T17723] bucket 0:15 gen 0 has wrong data_type: got free, should be journal, fixing [ 587.337648][T17723] bucket 0:15 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 587.368039][T17723] bucket 0:16 gen 0 has wrong data_type: got free, should be sb, fixing [ 587.386907][T17723] bucket 0:16 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 587.425267][T17723] bucket 0:17 gen 0 has wrong data_type: got free, should be sb, fixing [ 587.444704][T17723] bucket 0:17 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 587.464462][T17723] bucket 0:18 gen 0 has wrong data_type: got free, should be sb, fixing [ 587.494488][T17723] bucket 0:18 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 587.524340][T17723] bucket 0:19 gen 0 has wrong data_type: got free, should be sb, fixing [ 587.568927][T17723] bucket 0:19 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 587.594479][T17723] bucket 0:20 gen 0 has wrong data_type: got free, should be sb, fixing [ 587.603012][T17723] bucket 0:20 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 587.676761][T17723] bucket 0:21 gen 0 has wrong data_type: got free, should be sb, fixing [ 587.724913][T17723] bucket 0:21 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 587.757407][T17889] loop0: detected capacity change from 0 to 32768 [ 587.774426][T17723] bucket 0:22 gen 0 has wrong data_type: got free, should be sb, fixing [ 587.783032][T17723] bucket 0:22 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 587.828574][T17723] bucket 0:23 gen 0 has wrong data_type: got free, should be sb, fixing [ 587.853323][T17886] loop2: detected capacity change from 0 to 32768 [ 587.855758][T17889] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 587.855828][T17889] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 587.885826][T17884] loop3: detected capacity change from 0 to 32768 [ 587.915274][T17892] loop4: detected capacity change from 0 to 32768 [ 587.998293][T17723] bucket 0:23 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 588.009138][T17723] bucket 0:24 gen 0 has wrong data_type: got free, should be journal, fixing [ 588.018855][T17723] bucket 0:24 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 588.029938][T17723] bucket 0:26 gen 0 has wrong data_type: got free, should be btree, fixing [ 588.039463][T17723] bucket 0:26 gen 0 data type btree has wrong dirty_sectors: got 0, should be 32, fixing [ 588.050914][T17723] bucket 0:27 gen 0 data type btree has wrong dirty_sectors: got 256, should be 32, fixing [ 588.061631][T17723] bucket 0:28 gen 0 data type btree has wrong dirty_sectors: got 256, should be 32, fixing [ 588.073726][T17723] bucket 0:31 gen 0 has wrong data_type: got btree, should be need_discard, fixing [ 588.093056][T17723] bucket 0:31 gen 0 data type need_discard has wrong dirty_sectors: got 256, should be 0, fixing [ 588.116719][T17723] bucket 0:32 gen 0 has wrong data_type: got sb, should be btree, fixing [ 588.127247][T17723] bucket 0:32 gen 0 data type btree has wrong dirty_sectors: got 256, should be 32, fixing [ 588.137954][T17723] bucket 0:34 gen 0 has wrong data_type: got user, should be need_discard, fixing [ 588.148956][T17723] bucket 0:34 gen 0 data type need_discard has wrong dirty_sectors: got 16, should be 0, fixing [ 588.160223][T17723] bucket 0:35 gen 0 has wrong data_type: got free, should be btree, fixing [ 588.169360][T17723] bucket 0:35 gen 0 data type btree has wrong dirty_sectors: got 0, should be 32, fixing [ 588.170470][T17889] bcachefs: bch2_fs_get_tree() error: EINVAL [ 588.188990][T17723] bucket 0:37 gen 0 data type btree has wrong dirty_sectors: got 256, should be 32, fixing [ 588.202097][T17892] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 588.202164][T17892] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 588.218830][T17886] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 588.218895][T17886] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 588.308250][T17884] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 588.308317][T17884] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 588.474559][T17892] bcachefs: bch2_fs_get_tree() error: EINVAL [ 588.477299][T17886] bcachefs: bch2_fs_get_tree() error: EINVAL [ 588.520851][T17723] bucket 0:38 gen 0 has wrong data_type: got free, should be btree, fixing [ 588.567446][T17723] bucket 0:38 gen 0 data type btree has wrong dirty_sectors: got 0, should be 32, fixing executing program [ 588.639028][T17723] bucket 0:41 gen 0 has wrong data_type: got free, should be btree, fixing [ 588.648253][T17884] bcachefs: bch2_fs_get_tree() error: EINVAL [ 588.700138][T17723] bucket 0:41 gen 0 data type btree has wrong dirty_sectors: got 0, should be 32, fixing [ 588.768590][T17723] bucket 0:42 gen 0 data type btree has wrong dirty_sectors: got 256, should be 32, fixing [ 588.805148][T17723] bucket 0:120 gen 0 has wrong data_type: got free, should be sb, fixing executing program [ 588.824445][T17723] bucket 0:120 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 588.854439][T17723] bucket 0:121 gen 0 has wrong data_type: got free, should be sb, fixing executing program [ 588.876718][T17723] bucket 0:121 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 588.919982][T17723] bucket 0:122 gen 0 has wrong data_type: got free, should be sb, fixing [ 588.954136][T17723] bucket 0:122 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 588.994414][T17723] bucket 0:123 gen 0 has wrong data_type: got free, should be sb, fixing [ 589.002961][T17723] bucket 0:123 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing executing program [ 589.063682][T17723] bucket 0:124 gen 0 has wrong data_type: got free, should be sb, fixing [ 589.104181][T17723] bucket 0:124 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 589.144298][T17723] bucket 0:125 gen 0 has wrong data_type: got free, should be sb, fixing [ 589.173435][T17723] bucket 0:125 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 589.204127][T17723] bucket 0:126 gen 0 has wrong data_type: got free, should be sb, fixing [ 589.212777][T17723] bucket 0:126 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 589.243724][T17723] bucket 0:127 gen 0 has wrong data_type: got free, should be sb, fixing [ 589.281031][T17723] bucket 0:127 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 589.320495][T17723] done [ 589.404824][T17723] bcachefs (loop1): going read-write [ 589.421257][T17723] bcachefs (loop1): journal_replay... [ 589.447365][ T53] bucket incorrectly unset in freespace btree [ 589.447398][ T53] u64s 5 type deleted 0:25:0 len 0 ver 0, , continuing [ 589.602577][ T53] bucket incorrectly unset in freespace btree [ 589.602610][ T53] u64s 5 type deleted 0:29:0 len 0 ver 0, , continuing [ 589.755540][T17723] done [ 589.760672][T17723] bcachefs (loop1): check_alloc_info... [ 589.762881][T17723] hole in alloc btree missing in freespace btree [ 589.762902][T17723] device 0 buckets 30-31, fixing [ 589.772583][T17935] loop0: detected capacity change from 0 to 32768 [ 589.915628][T17723] bucket incorrectly unset in need_discard btree [ 589.915647][T17723] u64s 13 type alloc_v4 0:31:0 len 0 ver 0: [ 589.915659][T17723] gen 0 oldest_gen 0 data_type need_discard [ 589.915670][T17723] journal_seq_nonempty 4 [ 589.915680][T17723] journal_seq_empty 0 [ 589.915691][T17723] need_discard 1 [ 589.915701][T17723] need_inc_gen 1 [ 589.915712][T17723] dirty_sectors 0 [ 589.915722][T17723] stripe_sectors 0 [ 589.915732][T17723] cached_sectors 0 [ 589.915743][T17723] stripe 0 [ 589.915753][T17723] stripe_redundancy 0 [ 589.915762][T17723] io_time[READ] 1 [ 589.915772][T17723] io_time[WRITE] 512 [ 589.915783][T17723] fragmentation 0 [ 589.915792][T17723] bp_start 8 [ 589.915802][T17723] , fixing [ 589.980862][T17935] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 589.980931][T17935] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 590.009128][T17943] loop2: detected capacity change from 0 to 32768 [ 590.093301][T17939] loop4: detected capacity change from 0 to 32768 [ 590.230661][T17945] loop3: detected capacity change from 0 to 32768 [ 590.237716][T17935] bcachefs: bch2_fs_get_tree() error: EINVAL [ 590.274763][T17943] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 590.354318][T17723] hole in alloc btree missing in freespace btree [ 590.354340][T17723] device 0 buckets 33-34, fixing [ 590.414246][T17943] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 590.425290][T17939] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 590.425363][T17939] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 590.476350][T17723] bucket incorrectly unset in need_discard btree [ 590.476370][T17723] u64s 13 type alloc_v4 0:34:0 len 0 ver 0: [ 590.476382][T17723] gen 0 oldest_gen 0 data_type need_discard [ 590.476393][T17723] journal_seq_nonempty 5 [ 590.476404][T17723] journal_seq_empty 134217728 [ 590.476415][T17723] need_discard 1 [ 590.476425][T17723] need_inc_gen 1 [ 590.476435][T17723] dirty_sectors 0 [ 590.476444][T17723] stripe_sectors 0 [ 590.476455][T17723] cached_sectors 0 [ 590.476465][T17723] stripe 0 [ 590.476475][T17723] stripe_redundancy 0 executing program [ 590.476484][T17723] io_time[READ] 1 [ 590.476495][T17723] io_time[WRITE] 512 [ 590.476505][T17723] fragmentation 0 [ 590.476515][T17723] bp_start 8 [ 590.476525][T17723] , fixing [ 590.581239][T17945] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 590.581310][T17945] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 590.755437][T17723] hole in alloc btree missing in freespace btree [ 590.755456][T17723] device 0 buckets 36-37, fixing [ 590.791680][T17723] hole in alloc btree missing in freespace btree [ 590.791700][T17723] device 0 buckets 39-41, fixing [ 590.805967][T17943] bcachefs: bch2_fs_get_tree() error: EINVAL [ 590.812989][T17939] bcachefs: bch2_fs_get_tree() error: EINVAL [ 590.865929][T17723] hole in alloc btree missing in freespace btree [ 590.865950][T17723] device 0 buckets 39-41, fixing [ 590.876101][T17945] bcachefs: bch2_fs_get_tree() error: EINVAL [ 590.989436][T17723] hole in alloc btree missing in freespace btree executing program [ 590.989459][T17723] device 0 buckets 39-41, fixing [ 591.107161][T17723] hole in alloc btree missing in freespace btree [ 591.107181][T17723] device 0 buckets 43-120, fixing [ 591.176499][T17723] hole in alloc btree missing in freespace btree [ 591.176520][T17723] device 0 buckets 43-120, fixing [ 591.191873][T17723] done executing program [ 591.223655][T17723] bcachefs (loop1): check_lrus... [ 591.226721][T17723] incorrect lru entry: lru fragmentation time 134217728 [ 591.226741][T17723] u64s 5 type set 18446462598867058688:34:0 len 0 ver 0 executing program [ 591.226752][T17723] for u64s 13 type alloc_v4 0:34:0 len 0 ver 0: [ 591.226763][T17723] gen 1 oldest_gen 0 data_type free [ 591.226772][T17723] journal_seq_nonempty 5 [ 591.226782][T17723] journal_seq_empty 134217728 [ 591.226792][T17723] need_discard 0 [ 591.226801][T17723] need_inc_gen 0 [ 591.226811][T17723] dirty_sectors 0 [ 591.226820][T17723] stripe_sectors 0 [ 591.226829][T17723] cached_sectors 0 [ 591.226839][T17723] stripe 0 [ 591.226848][T17723] stripe_redundancy 0 [ 591.226858][T17723] io_time[READ] 1 [ 591.226867][T17723] io_time[WRITE] 512 [ 591.226877][T17723] fragmentation 0 [ 591.226899][T17723] bp_start 8 [ 591.226908][T17723] , fixing [ 591.554656][T17723] done [ 591.568015][T17723] bcachefs (loop1): check_btree_backpointers... done [ 591.585565][T17723] bcachefs (loop1): check_backpointers_to_extents... done [ 591.616915][T17723] bcachefs (loop1): check_extents_to_backpointers... [ 591.618580][T17723] bcachefs (loop1): scanning for missing backpointers in 3/128 buckets [ 591.708948][T18003] loop0: detected capacity change from 0 to 32768 [ 591.724568][T17723] done [ 591.754366][T17723] bcachefs (loop1): check_alloc_to_lru_refs... [ 591.755907][T17723] missing fragmentation lru entry [ 591.755927][T17723] u64s 13 type alloc_v4 0:32:0 len 0 ver 0: [ 591.755938][T17723] gen 0 oldest_gen 0 data_type btree [ 591.755949][T17723] journal_seq_nonempty 1 [ 591.755959][T17723] journal_seq_empty 0 [ 591.755970][T17723] need_discard 1 [ 591.755980][T17723] need_inc_gen 1 [ 591.755990][T17723] dirty_sectors 32 [ 591.756001][T17723] stripe_sectors 0 [ 591.756011][T17723] cached_sectors 0 [ 591.756021][T17723] stripe 0 [ 591.756032][T17723] stripe_redundancy 0 [ 591.756042][T17723] io_time[READ] 1 [ 591.756052][T17723] io_time[WRITE] 1 [ 591.756062][T17723] fragmentation 268435456 [ 591.756073][T17723] bp_start 8 [ 591.756083][T17723] , fixing [ 591.887287][T18003] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 591.887357][T18003] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 592.244587][T17723] missing fragmentation lru entry [ 592.244607][T17723] u64s 13 type alloc_v4 0:35:0 len 0 ver 0: [ 592.244619][T17723] gen 0 oldest_gen 0 data_type btree [ 592.244630][T17723] journal_seq_nonempty 0 [ 592.244641][T17723] journal_seq_empty 0 [ 592.244651][T17723] need_discard 0 [ 592.244661][T17723] need_inc_gen 0 [ 592.244671][T17723] dirty_sectors 32 [ 592.244681][T17723] stripe_sectors 0 [ 592.244691][T17723] cached_sectors 0 [ 592.244702][T17723] stripe 0 [ 592.244712][T17723] stripe_redundancy 0 [ 592.244722][T17723] io_time[READ] 0 [ 592.244732][T17723] io_time[WRITE] 0 [ 592.244742][T17723] fragmentation 268435456 [ 592.244753][T17723] bp_start 8 [ 592.244763][T17723] , fixing [ 592.273821][T18003] bcachefs: bch2_fs_get_tree() error: EINVAL [ 592.500663][T18017] loop4: detected capacity change from 0 to 32768 [ 592.545952][T18012] loop3: detected capacity change from 0 to 32768 [ 592.553293][T18016] loop2: detected capacity change from 0 to 32768 [ 592.625990][T17723] missing fragmentation lru entry [ 592.626011][T17723] u64s 13 type alloc_v4 0:42:0 len 0 ver 0: [ 592.626023][T17723] gen 0 oldest_gen 0 data_type btree [ 592.626034][T17723] journal_seq_nonempty 7 executing program [ 592.626045][T17723] journal_seq_empty 0 [ 592.626054][T17723] need_discard 1 [ 592.626063][T17723] need_inc_gen 1 [ 592.626072][T17723] dirty_sectors 32 [ 592.626081][T17723] stripe_sectors 0 [ 592.626090][T17723] cached_sectors 0 [ 592.626099][T17723] stripe 0 [ 592.626107][T17723] stripe_redundancy 0 [ 592.626115][T17723] io_time[READ] 1 [ 592.626124][T17723] io_time[WRITE] 1280 [ 592.626134][T17723] fragmentation 268435456 [ 592.626143][T17723] bp_start 8 [ 592.626152][T17723] , fixing [ 592.690730][T18017] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 592.724287][T17723] done [ 592.725169][T18017] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 592.752029][T17723] bcachefs (loop1): bucket_gens_init... done [ 592.777709][T18016] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 592.804349][T17723] bcachefs (loop1): check_snapshot_trees... done [ 592.821424][T18016] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 592.829768][T18012] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 592.854753][T17723] bcachefs (loop1): check_snapshots... [ 592.854855][T18012] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 592.868904][T17723] snapshot points to missing/incorrect tree: [ 592.868921][T17723] u64s 8 type snapshot 0:4294967295:0 len 0 ver 0: is_subvol 1 deleted 0 parent 0 children 0 0 subvol 1 tree 0, fixing [ 592.919171][T17723] snapshot points to missing/incorrect tree: [ 592.919191][T17723] u64s 8 type snapshot 0:4294967295:0 len 0 ver 0: is_subvol 1 deleted 0 parent 0 children 0 0 subvol 1 tree 0, fixing [ 592.994382][T17723] done [ 593.024113][T17723] bcachefs (loop1): check_subvols... done [ 593.078302][T18017] bcachefs: bch2_fs_get_tree() error: EINVAL [ 593.134480][T17723] bcachefs (loop1): check_subvol_children... done [ 593.144827][T18016] bcachefs: bch2_fs_get_tree() error: EINVAL [ 593.180310][T17723] bcachefs (loop1): delete_dead_snapshots... done [ 593.201272][T18012] bcachefs: bch2_fs_get_tree() error: EINVAL [ 593.231722][T17723] bcachefs (loop1): check_inodes... done [ 593.284376][T17723] bcachefs (loop1): check_extents... done [ 593.301930][T17723] bcachefs (loop1): check_indirect_extents... done executing program [ 593.377424][T17723] bcachefs (loop1): check_dirents... done executing program [ 593.452788][T17723] bcachefs (loop1): check_xattrs... done [ 593.484336][T17723] bcachefs (loop1): check_root... done [ 593.516957][T17723] bcachefs (loop1): check_unreachable_inodes... done [ 593.564380][T17723] bcachefs (loop1): check_subvolume_structure... done executing program [ 593.619119][T17723] bcachefs (loop1): check_directory_structure... done [ 593.659288][T17723] bcachefs (loop1): check_nlinks... done [ 593.669678][T18068] loop0: detected capacity change from 0 to 32768 [ 593.697425][T17723] bcachefs (loop1): resume_logged_ops... done [ 593.703635][T17723] bcachefs (loop1): delete_dead_inodes... done [ 593.733673][T17723] bcachefs (loop1): set_fs_needs_rebalance... done [ 593.823560][T18068] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 593.876204][T18068] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 593.911136][T17723] bcachefs (loop1): Fixed errors, running fsck a second time to verify fs is clean [ 593.934059][T17723] bcachefs (loop1): check_alloc_info... done [ 593.954100][T17723] bcachefs (loop1): check_lrus... done [ 593.960120][T17723] bcachefs (loop1): check_btree_backpointers... done [ 593.986023][T17723] bcachefs (loop1): check_backpointers_to_extents... done [ 594.032901][T17723] bcachefs (loop1): check_extents_to_backpointers... done [ 594.071762][T17723] bcachefs (loop1): check_alloc_to_lru_refs... done [ 594.084404][T17723] bcachefs (loop1): bucket_gens_init... done [ 594.114835][T17723] bcachefs (loop1): check_snapshot_trees... done [ 594.121648][T17723] bcachefs (loop1): check_snapshots... done [ 594.174113][T17723] bcachefs (loop1): check_subvols... done [ 594.180042][T17723] bcachefs (loop1): check_subvol_children... done [ 594.237613][T17723] bcachefs (loop1): delete_dead_snapshots... done [ 594.277673][T17723] bcachefs (loop1): check_inodes... done [ 594.283669][T17723] bcachefs (loop1): check_extents... done [ 594.310739][T17723] bcachefs (loop1): check_indirect_extents... done [ 594.321379][T18068] bcachefs: bch2_fs_get_tree() error: EINVAL [ 594.324247][T17723] bcachefs (loop1): check_dirents... done [ 594.355160][T17723] bcachefs (loop1): check_xattrs... done [ 594.360920][T17723] bcachefs (loop1): check_root... done [ 594.382852][T17723] bcachefs (loop1): check_unreachable_inodes... done [ 594.414216][T17723] bcachefs (loop1): check_subvolume_structure... done [ 594.441544][T17723] bcachefs (loop1): check_directory_structure... done [ 594.449950][T18081] loop2: detected capacity change from 0 to 32768 [ 594.457361][T18079] loop4: detected capacity change from 0 to 32768 [ 594.484138][T17723] bcachefs (loop1): check_nlinks... done [ 594.490050][T17723] bcachefs (loop1): resume_logged_ops... done [ 594.515434][T17723] bcachefs (loop1): delete_dead_inodes... done [ 594.569368][T17723] bcachefs (loop1): set_fs_needs_rebalance... done [ 594.607981][T17723] bcachefs (loop1): bch2_copygc_start(): error creating copygc thread EINTR [ 594.634670][T17723] bcachefs (loop1): error starting copygc thread [ 594.639942][T18085] loop3: detected capacity change from 0 to 32768 [ 594.641050][T17723] bcachefs (loop1): bch2_fs_start(): error starting filesystem EINTR [ 594.648939][T18081] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 594.684081][T17723] bcachefs (loop1): shutting down [ 594.689161][T17723] bcachefs (loop1): going read-only [ 594.699336][T17723] bcachefs (loop1): finished waiting for writes to stop [ 594.707662][T17723] bcachefs (loop1): flushing journal and stopping allocators, journal seq 43 [ 594.714216][T18081] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 594.716756][T17723] bcachefs (loop1): flushing journal and stopping allocators complete, journal seq 43 executing program [ 594.728011][T18079] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 594.754247][T17723] bcachefs (loop1): clean shutdown complete, journal seq 44 [ 594.762866][T17723] bcachefs (loop1): marking filesystem clean [ 594.764555][T18079] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 594.816183][T17723] bcachefs (loop1): shutdown complete [ 595.173496][T18085] bcachefs (loop3): starting version 1.7: mi_btree_bitmap opts=errors=continue,metadata_checksum=none,data_checksum=none,compression=lz4,nojournal_transaction_names [ 595.198326][T18081] bcachefs: bch2_fs_get_tree() error: EINVAL [ 595.198521][T17723] bcachefs: bch2_fs_get_tree() error: EINTR [ 595.224694][T18085] bcachefs (loop3): recovering from clean shutdown, journal seq 10 [ 595.232993][T18085] bcachefs (loop3): Version upgrade required: [ 595.232993][T18085] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete [ 595.232993][T18085] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.20: directory_size [ 595.232993][T18085] running recovery passes: check_allocations,check_alloc_info,check_lrus,check_btree_backpointers,check_backpointers_to_extents,check_extents_to_backpointers,check_alloc_to_lru_refs,bucket_gens_init,check_snapshot_trees,check_snapshots,check_subvols,check_subvol_children,delete_dead_snapshots,check_inodes,check_extents,check_indirect_extents,check_dirents,check_xattrs,check_root,check_unreachable_inodes,check_subvolume_structure,check_directory_structure,check_nlinks,set_fs_needs_rebalance [ 595.377037][T18085] bcachefs (loop3): error validating btree node on loop3 at btree extents level 0/0 [ 595.377059][T18085] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key POS_MIN durability: 1 ptr: 0:27:0 gen 0 [ 595.377075][T18085] node offset 0/16: incorrect min_key: got 0:36028797018963968:0 should be POS_MIN [ 595.504152][T18085] bcachefs (loop3): running explicit recovery pass check_topology (2), currently at recovery_pass_empty (0) [ 595.548584][T18085] bcachefs (loop3): flagging btree extents lost data [ 595.557614][T18079] bcachefs: bch2_fs_get_tree() error: EINVAL [ 595.563905][T18085] bcachefs (loop3): running explicit recovery pass scan_for_btree_nodes (1), currently at recovery_pass_empty (0) [ 595.581172][T18125] loop0: detected capacity change from 0 to 32768 executing program [ 595.634710][T18085] error reading btree root btree=extents level=0: btree_node_read_error, fixing [ 595.687485][T18085] bcachefs (loop3): error validating btree node at btree inodes level 0/0 executing program [ 595.687508][T18085] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0 [ 595.687524][T18085] node offset 16/24 bset u64s 110 bset byte offset 152: keys out of order: u64s 16 type inode_v3 134217728:4096:U32_MAX len 0 ver 0 > u64s 18 type inode_v3 0:4098:U32_MAX len 0 ver 0, fixing [ 595.793184][T18125] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 595.793258][T18125] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete executing program [ 595.973315][T18085] invalid bkey in btree_node btree=inodes level=0: u64s 16 type inode_v3 134217728:4096:U32_MAX len 0 ver 0: [ 595.973337][T18085] mode=40755 [ 595.973347][T18085] flags=(16300000) [ 595.973356][T18085] journal_seq=0 [ 595.973367][T18085] hash_seed=28e4f092a4fc58ee [ 595.973377][T18085] hash_type=siphash [ 595.973387][T18085] bi_size=0 [ 595.973396][T18085] bi_sectors=0 [ 595.973407][T18085] bi_version=0 [ 595.973416][T18085] bi_atime=200535484 [ 595.973425][T18085] bi_ctime=2780562352 [ 595.973433][T18085] bi_mtime=2780562352 [ 595.973443][T18085] bi_otime=200535484 [ 595.973453][T18085] bi_uid=0 [ 595.973463][T18085] bi_gid=0 [ 595.973472][T18085] bi_nlink=2 [ 595.973482][T18085] bi_generation=0 [ 595.973491][T18085] bi_dev=0 [ 595.973501][T18085] bi_data_checksum=0 [ 595.973511][T18085] bi_compression=0 [ 595.973521][T18085] bi_project=0 [ 595.973531][T18085] bi_background_compression=0 [ 595.973541][T18085] bi_data_replicas=0 [ 595.973551][T18085] bi_promote_target=0 executing program [ 595.973561][T18085] bi_foreground_target=0 [ 595.973572][T18085] bi_background_target=0 [ 595.973582][T18085] bi_erasure_code=0 [ 595.973592][T18085] bi_fields_set=0 [ 595.973602][T18085] bi_dir=0 [ 595.973612][T18085] bi_dir_offset=0 [ 595.973621][T18085] bi_subvol=1 [ 595.973631][T18085] bi_parent_subvol=0 [ 595.973641][T18085] bi_nocow=0 [ 595.973651][T18085] bi_depth=0 [ 595.973660][T18085] bi_inodes_32bit=0 [ 595.973670][T18085] nonzero k.p.inode: delete?, fixing [ 596.154965][T18125] bcachefs: bch2_fs_get_tree() error: EINVAL [ 596.664217][T18085] bcachefs (loop3): btree_node_read_work: rewriting btree node at due to error [ 596.664217][T18085] btree=inodes level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0 [ 596.733528][T18153] loop1: detected capacity change from 0 to 32768 [ 596.745011][T18085] bcachefs (loop3): error validating btree node on loop3 at btree dirents level 0/0 [ 596.745032][T18085] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0 [ 596.745048][T18085] node offset 16/24: btree node data missing: expected 24 sectors, found 16, fixing [ 596.869993][T18085] bcachefs (loop3): btree_node_read_work: rewriting btree node at due to error [ 596.869993][T18085] btree=dirents level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0 [ 596.933484][T18149] loop2: detected capacity change from 0 to 32768 [ 596.985759][T18153] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 597.015105][T18085] bcachefs (loop3): error validating btree node on loop3 at btree xattrs level 0/0 [ 597.015126][T18085] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 2285c34bed0abe32 written 16 min_key POS_MIN durability: 1 ptr: 0:31:0 gen 0 [ 597.015140][T18085] node offset 0/16 bset u64s 0: incorrect btree id [ 597.043484][T18153] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 597.171204][T18158] loop4: detected capacity change from 0 to 32768 [ 597.190877][T18085] bcachefs (loop3): flagging btree xattrs lost data [ 597.226821][T18149] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 597.236353][T18085] error reading btree root btree=xattrs level=0: btree_node_read_error, fixing [ 597.236623][T18149] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 597.275992][T18085] bcachefs (loop3): error validating btree node at btree alloc level 0/0 [ 597.276036][T18085] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0 [ 597.276050][T18085] node offset 8/24 bset u64s 375 bset byte offset 184: keys out of order: u64s 11 type alloc_v4 0:32:0 len 0 ver 0 > u64s 11 type alloc_v4 0:2:0 len 0 ver 0, fixing [ 597.429347][T18158] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 597.429417][T18158] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 597.450571][T18153] bcachefs: bch2_fs_get_tree() error: EINVAL [ 597.540765][T18085] bcachefs (loop3): btree_node_read_work: rewriting btree node at due to error [ 597.540765][T18085] btree=alloc level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0 [ 597.632822][T18149] bcachefs: bch2_fs_get_tree() error: EINVAL [ 597.646155][T18168] loop0: detected capacity change from 0 to 32768 [ 597.666561][T18085] bcachefs (loop3): error validating btree node on loop3 at btree freespace level 0/0 [ 597.666582][T18085] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq e81e1ed936acf3df written 32 min_key POS_MIN durability: 1 ptr: 0:29:0 gen 0 executing program [ 597.666596][T18085] node offset 0/32 bset u64s 0: invalid bkey format: incorrect number of fields: got 0, should be 6 [ 597.666610][T18085] u64s 5 fields 64:0, 64:0, 32:0, 0:0, 0:0, 0:0 [ 597.794429][T18168] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 597.794505][T18168] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 597.808438][T18158] bcachefs: bch2_fs_get_tree() error: EINVAL [ 598.063188][T18085] bcachefs (loop3): flagging btree freespace lost data executing program [ 598.080096][T18085] error reading btree root btree=freespace level=0: btree_node_read_error, fixing [ 598.098534][T18168] bcachefs: bch2_fs_get_tree() error: EINVAL executing program [ 598.178561][T18085] bcachefs (loop3): scan_for_btree_nodes... [ 598.178634][T18085] bcachefs (loop3): error starting kthread: -4 [ 598.245168][T18085] bcachefs (loop3): bch2_fs_recovery(): error EINTR [ 598.272427][T18085] bcachefs (loop3): bch2_fs_start(): error starting filesystem EINTR [ 598.324848][T18085] bcachefs (loop3): shutting down [ 598.357049][T18085] bcachefs (loop3): shutdown complete executing program [ 598.961011][T18230] loop4: detected capacity change from 0 to 32768 [ 598.975485][T18223] loop1: detected capacity change from 0 to 32768 [ 599.148729][T18229] loop2: detected capacity change from 0 to 32768 [ 599.178900][T18235] loop0: detected capacity change from 0 to 32768 [ 599.545591][T18229] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 599.555323][T18223] bcachefs (loop1): starting version 1.7: mi_btree_bitmap opts=errors=continue,metadata_checksum=none,data_checksum=none,compression=lz4,nojournal_transaction_names [ 599.574248][T18229] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 599.591736][T18235] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 599.610315][T18235] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 599.610538][T18230] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 599.619391][T18223] bcachefs (loop1): recovering from clean shutdown, journal seq 10 [ 599.628385][T18085] bcachefs: bch2_fs_get_tree() error: EINTR [ 599.666948][T18230] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 599.673783][T18223] bcachefs (loop1): Version upgrade required: [ 599.673783][T18223] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete [ 599.673783][T18223] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.20: directory_size [ 599.673783][T18223] running recovery passes: check_allocations,check_alloc_info,check_lrus,check_btree_backpointers,check_backpointers_to_extents,check_extents_to_backpointers,check_alloc_to_lru_refs,bucket_gens_init,check_snapshot_trees,check_snapshots,check_subvols,check_subvol_children,delete_dead_snapshots,check_inodes,check_extents,check_indirect_extents,check_dirents,check_xattrs,check_root,check_unreachable_inodes,check_subvolume_structure,check_directory_structure,check_nlinks,set_fs_needs_rebalance executing program [ 599.902259][T18223] bcachefs (loop1): error validating btree node on loop1 at btree extents level 0/0 [ 599.902281][T18223] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key POS_MIN durability: 1 ptr: 0:27:0 gen 0 [ 599.902295][T18223] node offset 0/16: incorrect min_key: got 0:36028797018963968:0 should be POS_MIN [ 599.994481][T18229] bcachefs: bch2_fs_get_tree() error: EINVAL [ 600.036025][T18235] bcachefs: bch2_fs_get_tree() error: EINVAL [ 600.101996][T18223] bcachefs (loop1): running explicit recovery pass check_topology (2), currently at recovery_pass_empty (0) [ 600.114351][T18230] bcachefs: bch2_fs_get_tree() error: EINVAL [ 600.124297][T18223] bcachefs (loop1): flagging btree extents lost data [ 600.131106][T18223] bcachefs (loop1): running explicit recovery pass scan_for_btree_nodes (1), currently at recovery_pass_empty (0) [ 600.246600][T18223] error reading btree root btree=extents level=0: btree_node_read_error, fixing [ 600.291133][T18223] bcachefs (loop1): error validating btree node at btree inodes level 0/0 [ 600.291154][T18223] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0 executing program [ 600.291169][T18223] node offset 16/24 bset u64s 110 bset byte offset 152: keys out of order: u64s 16 type inode_v3 134217728:4096:U32_MAX len 0 ver 0 > u64s 18 type inode_v3 0:4098:U32_MAX len 0 ver 0, fixing executing program [ 600.432327][T18223] invalid bkey in btree_node btree=inodes level=0: u64s 16 type inode_v3 134217728:4096:U32_MAX len 0 ver 0: executing program [ 600.432348][T18223] mode=40755 [ 600.432360][T18223] flags=(16300000) [ 600.432370][T18223] journal_seq=0 [ 600.432381][T18223] hash_seed=28e4f092a4fc58ee [ 600.432391][T18223] hash_type=siphash [ 600.432402][T18223] bi_size=0 [ 600.432411][T18223] bi_sectors=0 [ 600.432421][T18223] bi_version=0 [ 600.432432][T18223] bi_atime=200535484 [ 600.432442][T18223] bi_ctime=2780562352 [ 600.432452][T18223] bi_mtime=2780562352 [ 600.432462][T18223] bi_otime=200535484 [ 600.432472][T18223] bi_uid=0 [ 600.432481][T18223] bi_gid=0 [ 600.432492][T18223] bi_nlink=2 [ 600.432502][T18223] bi_generation=0 [ 600.432512][T18223] bi_dev=0 [ 600.432522][T18223] bi_data_checksum=0 [ 600.432531][T18223] bi_compression=0 [ 600.432541][T18223] bi_project=0 [ 600.432552][T18223] bi_background_compression=0 [ 600.432562][T18223] bi_data_replicas=0 [ 600.432572][T18223] bi_promote_target=0 [ 600.432583][T18223] bi_foreground_target=0 [ 600.432594][T18223] bi_background_target=0 [ 600.432604][T18223] bi_erasure_code=0 [ 600.432614][T18223] bi_fields_set=0 [ 600.432624][T18223] bi_dir=0 [ 600.432633][T18223] bi_dir_offset=0 [ 600.432643][T18223] bi_subvol=1 [ 600.432653][T18223] bi_parent_subvol=0 [ 600.432663][T18223] bi_nocow=0 [ 600.432672][T18223] bi_depth=0 [ 600.432682][T18223] bi_inodes_32bit=0 [ 600.432692][T18223] nonzero k.p.inode: delete?, fixing [ 601.045020][T18223] bcachefs (loop1): btree_node_read_work: rewriting btree node at due to error [ 601.045020][T18223] btree=inodes level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0 [ 601.094354][T18294] loop3: detected capacity change from 0 to 32768 [ 601.128189][T18223] bcachefs (loop1): error validating btree node on loop1 at btree dirents level 0/0 [ 601.128212][T18223] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0 [ 601.128228][T18223] node offset 16/24: btree node data missing: expected 24 sectors, found 16, fixing [ 601.242643][T18294] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 601.242725][T18294] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 601.352473][T18223] bcachefs (loop1): btree_node_read_work: rewriting btree node at due to error [ 601.352473][T18223] btree=dirents level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0 [ 601.393309][T18302] loop0: detected capacity change from 0 to 32768 [ 601.457381][T18223] bcachefs (loop1): error validating btree node on loop1 at btree xattrs level 0/0 [ 601.457402][T18223] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 2285c34bed0abe32 written 16 min_key POS_MIN durability: 1 ptr: 0:31:0 gen 0 [ 601.457416][T18223] node offset 0/16 bset u64s 0: incorrect btree id [ 601.488847][T18300] loop2: detected capacity change from 0 to 32768 [ 601.561395][T18306] loop4: detected capacity change from 0 to 32768 [ 601.612412][T18294] bcachefs: bch2_fs_get_tree() error: EINVAL [ 601.619524][T18302] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 601.619596][T18302] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 601.630854][T18300] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 601.630926][T18300] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 601.702633][T18306] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 601.702706][T18306] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 601.823042][T18223] bcachefs (loop1): flagging btree xattrs lost data [ 601.835949][T18223] error reading btree root btree=xattrs level=0: btree_node_read_error, fixing [ 601.867089][T18223] bcachefs (loop1): error validating btree node at btree alloc level 0/0 [ 601.867112][T18223] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0 [ 601.867128][T18223] node offset 8/24 bset u64s 375 bset byte offset 184: keys out of order: u64s 11 type alloc_v4 0:32:0 len 0 ver 0 > u64s 11 type alloc_v4 0:2:0 len 0 ver 0, fixing [ 601.965297][T18223] bcachefs (loop1): btree_node_read_work: rewriting btree node at due to error [ 601.965297][T18223] btree=alloc level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0 executing program [ 602.024516][T18302] bcachefs: bch2_fs_get_tree() error: EINVAL [ 602.036638][T18300] bcachefs: bch2_fs_get_tree() error: EINVAL [ 602.075988][T18306] bcachefs: bch2_fs_get_tree() error: EINVAL [ 602.094403][T18223] bcachefs (loop1): error validating btree node on loop1 at btree freespace level 0/0 [ 602.094426][T18223] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq e81e1ed936acf3df written 32 min_key POS_MIN durability: 1 ptr: 0:29:0 gen 0 [ 602.094440][T18223] node offset 0/32 bset u64s 0: invalid bkey format: incorrect number of fields: got 0, should be 6 [ 602.094453][T18223] u64s 5 fields 64:0, 64:0, 32:0, 0:0, 0:0, 0:0 [ 602.321986][T18223] bcachefs (loop1): flagging btree freespace lost data [ 602.365836][T18223] error reading btree root btree=freespace level=0: btree_node_read_error, fixing executing program executing program executing program [ 602.455118][T18223] bcachefs (loop1): scan_for_btree_nodes... [ 602.455191][T18223] bcachefs (loop1): error starting kthread: -4 [ 602.519926][T18223] bcachefs (loop1): bch2_fs_recovery(): error EINTR [ 602.540193][T18223] bcachefs (loop1): bch2_fs_start(): error starting filesystem EINTR [ 602.593076][T18223] bcachefs (loop1): shutting down [ 602.639958][T18223] bcachefs (loop1): shutdown complete [ 603.150505][T18356] loop3: detected capacity change from 0 to 32768 [ 603.315767][T18365] loop0: detected capacity change from 0 to 32768 [ 603.386957][T18367] loop2: detected capacity change from 0 to 32768 [ 603.406467][T18366] loop4: detected capacity change from 0 to 32768 [ 603.690916][T18365] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 603.700786][T18356] bcachefs (loop3): starting version 1.7: mi_btree_bitmap opts=errors=continue,metadata_checksum=none,data_checksum=none,compression=lz4,nojournal_transaction_names [ 603.721854][T18365] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 603.740599][T18356] bcachefs (loop3): recovering from clean shutdown, journal seq 10 [ 603.750329][T18367] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 603.760003][T18356] bcachefs (loop3): Version upgrade required: [ 603.760003][T18356] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete [ 603.760003][T18356] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.20: directory_size [ 603.760003][T18356] running recovery passes: check_allocations,check_alloc_info,check_lrus,check_btree_backpointers,check_backpointers_to_extents,check_extents_to_backpointers,check_alloc_to_lru_refs,bucket_gens_init,check_snapshot_trees,check_snapshots,check_subvols,check_subvol_children,delete_dead_snapshots,check_inodes,check_extents,check_indirect_extents,check_dirents,check_xattrs,check_root,check_unreachable_inodes,check_subvolume_structure,check_directory_structure,check_nlinks,set_fs_needs_rebalance [ 603.834315][T18367] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 603.861129][T18366] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 603.879675][T18366] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 603.916095][T18356] bcachefs (loop3): error validating btree node on loop3 at btree extents level 0/0 [ 603.916117][T18356] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key POS_MIN durability: 1 ptr: 0:27:0 gen 0 [ 603.916131][T18356] node offset 0/16: incorrect min_key: got 0:36028797018963968:0 should be POS_MIN [ 604.033780][T18356] bcachefs (loop3): running explicit recovery pass check_topology (2), currently at recovery_pass_empty (0) [ 604.063471][T18223] bcachefs: bch2_fs_get_tree() error: EINTR [ 604.076211][T18356] bcachefs (loop3): flagging btree extents lost data [ 604.122982][T18356] bcachefs (loop3): running explicit recovery pass scan_for_btree_nodes (1), currently at recovery_pass_empty (0) [ 604.145807][T18365] bcachefs: bch2_fs_get_tree() error: EINVAL [ 604.175876][T18367] bcachefs: bch2_fs_get_tree() error: EINVAL [ 604.210444][T18356] error reading btree root btree=extents level=0: btree_node_read_error, fixing [ 604.273084][T18366] bcachefs: bch2_fs_get_tree() error: EINVAL [ 604.348463][T18356] bcachefs (loop3): error validating btree node at btree inodes level 0/0 [ 604.348486][T18356] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0 executing program [ 604.348501][T18356] node offset 16/24 bset u64s 110 bset byte offset 152: keys out of order: u64s 16 type inode_v3 134217728:4096:U32_MAX len 0 ver 0 > u64s 18 type inode_v3 0:4098:U32_MAX len 0 ver 0, fixing executing program [ 604.558409][T18356] invalid bkey in btree_node btree=inodes level=0: u64s 16 type inode_v3 134217728:4096:U32_MAX len 0 ver 0: executing program [ 604.558431][T18356] mode=40755 [ 604.558440][T18356] flags=(16300000) [ 604.558451][T18356] journal_seq=0 executing program [ 604.558460][T18356] hash_seed=28e4f092a4fc58ee [ 604.558470][T18356] hash_type=siphash [ 604.558480][T18356] bi_size=0 [ 604.558490][T18356] bi_sectors=0 [ 604.558499][T18356] bi_version=0 [ 604.558509][T18356] bi_atime=200535484 [ 604.558519][T18356] bi_ctime=2780562352 [ 604.558529][T18356] bi_mtime=2780562352 [ 604.558538][T18356] bi_otime=200535484 [ 604.558547][T18356] bi_uid=0 [ 604.558555][T18356] bi_gid=0 [ 604.558563][T18356] bi_nlink=2 [ 604.558571][T18356] bi_generation=0 [ 604.558580][T18356] bi_dev=0 [ 604.558588][T18356] bi_data_checksum=0 [ 604.558596][T18356] bi_compression=0 [ 604.558604][T18356] bi_project=0 [ 604.558613][T18356] bi_background_compression=0 [ 604.558623][T18356] bi_data_replicas=0 [ 604.558631][T18356] bi_promote_target=0 [ 604.558640][T18356] bi_foreground_target=0 [ 604.558650][T18356] bi_background_target=0 [ 604.558660][T18356] bi_erasure_code=0 [ 604.558669][T18356] bi_fields_set=0 [ 604.558679][T18356] bi_dir=0 [ 604.558687][T18356] bi_dir_offset=0 [ 604.558696][T18356] bi_subvol=1 [ 604.558705][T18356] bi_parent_subvol=0 [ 604.558713][T18356] bi_nocow=0 [ 604.558721][T18356] bi_depth=0 [ 604.558730][T18356] bi_inodes_32bit=0 [ 604.558739][T18356] nonzero k.p.inode: delete?, fixing [ 605.194319][T18356] bcachefs (loop3): btree_node_read_work: rewriting btree node at due to error [ 605.194319][T18356] btree=inodes level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0 [ 605.272611][T18356] bcachefs (loop3): error validating btree node on loop3 at btree dirents level 0/0 [ 605.272634][T18356] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0 [ 605.272649][T18356] node offset 16/24: btree node data missing: expected 24 sectors, found 16, fixing [ 605.385111][T18356] bcachefs (loop3): btree_node_read_work: rewriting btree node at due to error [ 605.385111][T18356] btree=dirents level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0 [ 605.460966][T18356] bcachefs (loop3): error validating btree node on loop3 at btree xattrs level 0/0 [ 605.460988][T18356] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 2285c34bed0abe32 written 16 min_key POS_MIN durability: 1 ptr: 0:31:0 gen 0 [ 605.461002][T18356] node offset 0/16 bset u64s 0: incorrect btree id [ 605.578345][T18356] bcachefs (loop3): flagging btree xattrs lost data [ 605.590859][T18430] loop1: detected capacity change from 0 to 32768 [ 605.603870][T18434] loop2: detected capacity change from 0 to 32768 [ 605.619209][T18356] error reading btree root btree=xattrs level=0: btree_node_read_error, fixing [ 605.668466][T18433] loop0: detected capacity change from 0 to 32768 [ 605.681378][T18356] bcachefs (loop3): error validating btree node at btree alloc level 0/0 [ 605.681401][T18356] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0 [ 605.681416][T18356] node offset 8/24 bset u64s 375 bset byte offset 184: keys out of order: u64s 11 type alloc_v4 0:32:0 len 0 ver 0 > u64s 11 type alloc_v4 0:2:0 len 0 ver 0, fixing [ 605.742467][T18439] loop4: detected capacity change from 0 to 32768 [ 605.766420][T18356] bcachefs (loop3): btree_node_read_work: rewriting btree node at due to error [ 605.766420][T18356] btree=alloc level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0 [ 605.800696][T18356] bcachefs (loop3): error validating btree node on loop3 at btree freespace level 0/0 [ 605.800717][T18356] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq e81e1ed936acf3df written 32 min_key POS_MIN durability: 1 ptr: 0:29:0 gen 0 [ 605.800731][T18356] node offset 0/32 bset u64s 0: invalid bkey format: incorrect number of fields: got 0, should be 6 [ 605.800743][T18356] u64s 5 fields 64:0, 64:0, 32:0, 0:0, 0:0, 0:0 [ 605.880153][T18356] bcachefs (loop3): flagging btree freespace lost data [ 605.889291][T18356] error reading btree root btree=freespace level=0: btree_node_read_error, fixing [ 605.892467][T18434] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 605.906441][T18356] bcachefs (loop3): scan_for_btree_nodes... [ 605.909211][T18430] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 605.932620][T18430] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 605.941045][T18434] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 605.996785][T18439] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 606.024574][T18439] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 606.036540][T18433] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 606.046069][T18481] invalid bkey in btree_node btree=stripes level=0: u64s 7 type xattr 536870912:3798421620223919902:U32_MAX len 0 ver 0: user.xattr2:xattr2 [ 606.046089][T18481] nonzero snapshot: delete?, fixing [ 606.076684][T18433] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 606.102300][T18481] bcachefs (loop3): flagging btree stripes lost data [ 606.278701][T18356] bcachefs (loop3): btree node scan found 6 nodes after overwrites [ 606.294494][T18356] done [ 606.299829][T18356] bcachefs (loop3): check_topology... [ 606.307687][T18356] bcachefs (loop3): btree root extents unreadable, must recover from scan [ 606.339141][T18430] bcachefs: bch2_fs_get_tree() error: EINVAL [ 606.355089][T18356] bcachefs (loop3): bch2_get_scanned_nodes(): recovery btree=extents level=0 POS_MIN - SPOS_MAX [ 606.394301][T18356] bcachefs (loop3): bch2_get_scanned_nodes(): recovering u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 [ 606.421931][T18434] bcachefs: bch2_fs_get_tree() error: EINVAL [ 606.469400][T18433] bcachefs: bch2_fs_get_tree() error: EINVAL [ 606.476019][ T43] bcachefs (loop3): error validating btree node on loop3 at btree extents level 0/0 [ 606.476047][ T43] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 [ 606.476063][ T43] node offset 8/32 bset u64s 2097: bset past end of btree node (offset 8 len 40 but written 32), fixing [ 606.516414][ T43] bcachefs (loop3): error validating btree node on loop3 at btree extents level 0/0 [ 606.516433][ T43] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 [ 606.516446][ T43] node offset 8/32 bset u64s 0: empty bset, fixing [ 606.551510][ T43] bcachefs (loop3): btree_node_read_work: rewriting btree node at due to error [ 606.551510][ T43] btree=extents level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 [ 606.578561][T18439] bcachefs: bch2_fs_get_tree() error: EINVAL [ 606.585107][T18356] bcachefs (loop3): bch2_get_scanned_nodes(): recovery btree=extents level=0 POS_MIN - 0:36028797018963967:U32_MAX [ 606.673814][T18356] btree node with incorrect min_key at btree=extents level=1: executing program [ 606.673839][T18356] parent: u64s 5 type btree_ptr SPOS_MAX len 0 ver 0 [ 606.673851][T18356] next: u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0, fixing executing program [ 606.834295][T18356] bcachefs (loop3): set_node_min(): u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 -> POS_MIN executing program executing program [ 606.915997][T18356] bcachefs (loop3): btree root xattrs unreadable, must recover from scan [ 606.974265][T18356] no nodes found for btree xattrs, continuing [ 607.003393][T18356] done [ 607.035533][T18356] bcachefs (loop3): accounting_read... done [ 607.050093][T18356] bcachefs (loop3): alloc_read... done [ 607.104302][T18356] bcachefs (loop3): stripes_read... done [ 607.110087][T18356] bcachefs (loop3): snapshots_read... done [ 607.154385][T18356] bcachefs (loop3): check_allocations... [ 607.205702][T18356] bucket 0:26 data type btree ptr gen 0 missing in alloc btree [ 607.205726][T18356] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0, fixing [ 607.357639][T18356] bucket 0:38 data type btree ptr gen 0 missing in alloc btree [ 607.357664][T18356] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0, fixing [ 607.435739][T18356] bucket 0:41 data type btree ptr gen 0 missing in alloc btree [ 607.435761][T18356] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0, fixing [ 607.546517][T18356] bucket 0:35 data type btree ptr gen 0 missing in alloc btree [ 607.546540][T18356] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c0bef60d07ceb940 written 16 min_key POS_MIN durability: 1 ptr: 0:35:0 gen 0, fixing [ 607.637210][T18356] bucket 0:1 gen 0 has wrong data_type: got free, should be sb, fixing [ 607.654402][T18356] bucket 0:1 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 607.685753][T18356] bucket 0:2 gen 0 has wrong data_type: got free, should be sb, fixing [ 607.714160][T18356] bucket 0:2 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 607.730980][T18493] loop4: detected capacity change from 0 to 32768 [ 607.750273][T18356] bucket 0:3 gen 0 has wrong data_type: got free, should be sb, fixing [ 607.803232][T18356] bucket 0:3 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 607.824439][T18356] bucket 0:4 gen 0 has wrong data_type: got free, should be sb, fixing [ 607.832923][T18356] bucket 0:4 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 607.847245][T18356] bucket 0:5 gen 0 has wrong data_type: got free, should be sb, fixing [ 607.848085][T18493] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 607.866764][T18356] bucket 0:5 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 607.887465][T18356] bucket 0:6 gen 0 has wrong data_type: got free, should be sb, fixing [ 607.904449][T18356] bucket 0:6 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 607.909800][T18493] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 607.925513][T18497] loop1: detected capacity change from 0 to 32768 [ 607.934336][T18356] bucket 0:7 gen 0 has wrong data_type: got free, should be sb, fixing [ 607.942686][T18356] bucket 0:7 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 607.976872][T18356] bucket 0:8 gen 0 has wrong data_type: got free, should be sb, fixing [ 607.985912][T18356] bucket 0:8 gen 0 data type sb has wrong dirty_sectors: got 0, should be 8, fixing [ 607.998001][T18356] bucket 0:9 gen 0 has wrong data_type: got free, should be journal, fixing [ 608.018602][T18499] loop0: detected capacity change from 0 to 32768 [ 608.054519][T18356] bucket 0:9 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 608.075637][T18497] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 608.075705][T18497] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 608.149605][T18501] loop2: detected capacity change from 0 to 32768 [ 608.183813][T18356] bucket 0:10 gen 0 has wrong data_type: got free, should be journal, fixing [ 608.191711][T18499] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 608.202265][T18499] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 608.212105][T18356] bucket 0:10 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 608.222853][T18356] bucket 0:11 gen 0 has wrong data_type: got free, should be journal, fixing [ 608.244849][T18356] bucket 0:11 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 608.292551][T18356] bucket 0:12 gen 0 has wrong data_type: got free, should be journal, fixing [ 608.292712][T18493] bcachefs: bch2_fs_get_tree() error: EINVAL [ 608.324146][T18356] bucket 0:12 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 608.340154][T18501] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 608.340222][T18501] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 608.370799][T18356] bucket 0:13 gen 0 has wrong data_type: got free, should be journal, fixing [ 608.379938][T18356] bucket 0:13 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 608.390567][T18497] bcachefs: bch2_fs_get_tree() error: EINVAL [ 608.405398][T18356] bucket 0:14 gen 0 has wrong data_type: got free, should be journal, fixing [ 608.414546][T18356] bucket 0:14 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 608.425078][T18356] bucket 0:15 gen 0 has wrong data_type: got free, should be journal, fixing [ 608.456499][T18356] bucket 0:15 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 608.468888][T18356] bucket 0:16 gen 0 has wrong data_type: got free, should be sb, fixing [ 608.504112][T18356] bucket 0:16 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 608.516785][T18356] bucket 0:17 gen 0 has wrong data_type: got free, should be sb, fixing [ 608.530711][T18356] bucket 0:17 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 608.541029][T18356] bucket 0:18 gen 0 has wrong data_type: got free, should be sb, fixing [ 608.584207][T18356] bucket 0:18 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 608.605253][T18356] bucket 0:19 gen 0 has wrong data_type: got free, should be sb, fixing [ 608.613711][T18356] bucket 0:19 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 608.651495][T18499] bcachefs: bch2_fs_get_tree() error: EINVAL [ 608.714348][T18356] bucket 0:20 gen 0 has wrong data_type: got free, should be sb, fixing [ 608.722787][T18356] bucket 0:20 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing executing program [ 608.764538][T18501] bcachefs: bch2_fs_get_tree() error: EINVAL [ 608.798432][T18356] bucket 0:21 gen 0 has wrong data_type: got free, should be sb, fixing [ 608.847701][T18356] bucket 0:21 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing executing program [ 608.893804][T18356] bucket 0:22 gen 0 has wrong data_type: got free, should be sb, fixing [ 608.928087][T18356] bucket 0:22 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 608.973684][T18356] bucket 0:23 gen 0 has wrong data_type: got free, should be sb, fixing executing program [ 609.020252][T18356] bucket 0:23 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing executing program [ 609.063348][T18356] bucket 0:24 gen 0 has wrong data_type: got free, should be journal, fixing [ 609.094825][T18356] bucket 0:24 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 609.152974][T18356] bucket 0:26 gen 0 has wrong data_type: got free, should be btree, fixing [ 609.179086][T18356] bucket 0:26 gen 0 data type btree has wrong dirty_sectors: got 0, should be 32, fixing [ 609.217915][T18356] bucket 0:27 gen 0 data type btree has wrong dirty_sectors: got 256, should be 32, fixing [ 609.251800][T18356] bucket 0:28 gen 0 data type btree has wrong dirty_sectors: got 256, should be 32, fixing [ 609.313394][T18356] bucket 0:31 gen 0 has wrong data_type: got btree, should be need_discard, fixing [ 609.353726][T18356] bucket 0:31 gen 0 data type need_discard has wrong dirty_sectors: got 256, should be 0, fixing [ 609.394391][T18356] bucket 0:32 gen 0 has wrong data_type: got sb, should be btree, fixing [ 609.423866][T18356] bucket 0:32 gen 0 data type btree has wrong dirty_sectors: got 256, should be 32, fixing [ 609.474622][T18356] bucket 0:34 gen 0 has wrong data_type: got user, should be need_discard, fixing [ 609.500434][T18356] bucket 0:34 gen 0 data type need_discard has wrong dirty_sectors: got 16, should be 0, fixing [ 609.535337][T18356] bucket 0:35 gen 0 has wrong data_type: got free, should be btree, fixing [ 609.568975][T18356] bucket 0:35 gen 0 data type btree has wrong dirty_sectors: got 0, should be 32, fixing [ 609.602636][T18356] bucket 0:37 gen 0 data type btree has wrong dirty_sectors: got 256, should be 32, fixing [ 609.644759][T18356] bucket 0:38 gen 0 has wrong data_type: got free, should be btree, fixing [ 609.674179][T18356] bucket 0:38 gen 0 data type btree has wrong dirty_sectors: got 0, should be 32, fixing [ 609.708106][T18356] bucket 0:41 gen 0 has wrong data_type: got free, should be btree, fixing [ 609.737298][T18356] bucket 0:41 gen 0 data type btree has wrong dirty_sectors: got 0, should be 32, fixing [ 609.769331][T18356] bucket 0:42 gen 0 data type btree has wrong dirty_sectors: got 256, should be 32, fixing [ 609.826457][T18356] bucket 0:120 gen 0 has wrong data_type: got free, should be sb, fixing [ 609.847346][T18356] bucket 0:120 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 609.878644][T18356] bucket 0:121 gen 0 has wrong data_type: got free, should be sb, fixing [ 609.911749][T18356] bucket 0:121 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 609.922779][T18552] loop4: detected capacity change from 0 to 32768 [ 609.973814][T18356] bucket 0:122 gen 0 has wrong data_type: got free, should be sb, fixing [ 610.005383][T18356] bucket 0:122 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 610.044393][T18356] bucket 0:123 gen 0 has wrong data_type: got free, should be sb, fixing [ 610.052922][T18356] bucket 0:123 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 610.055703][T18566] loop2: detected capacity change from 0 to 32768 [ 610.096594][T18552] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 610.106322][T18356] bucket 0:124 gen 0 has wrong data_type: got free, should be sb, fixing [ 610.116595][T18554] loop1: detected capacity change from 0 to 32768 [ 610.141201][T18552] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 610.172911][T18356] bucket 0:124 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 610.194394][T18356] bucket 0:125 gen 0 has wrong data_type: got free, should be sb, fixing [ 610.223823][T18356] bucket 0:125 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 610.243100][T18566] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 610.243165][T18566] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 610.302283][T18356] bucket 0:126 gen 0 has wrong data_type: got free, should be sb, fixing [ 610.312235][T18561] loop0: detected capacity change from 0 to 32768 [ 610.351010][T18554] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 610.351092][T18554] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 610.372039][T18356] bucket 0:126 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 610.383005][T18356] bucket 0:127 gen 0 has wrong data_type: got free, should be sb, fixing [ 610.392926][T18356] bucket 0:127 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 610.409184][T18356] done [ 610.429171][T18356] bcachefs (loop3): going read-write [ 610.459383][T18561] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 610.473725][T18356] bcachefs (loop3): journal_replay... [ 610.484744][T18561] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 610.485977][T18552] bcachefs: bch2_fs_get_tree() error: EINVAL [ 610.529439][ T53] bucket incorrectly unset in freespace btree [ 610.529468][ T53] u64s 5 type deleted 0:25:0 len 0 ver 0, , continuing [ 610.706281][ T53] bucket incorrectly unset in freespace btree [ 610.706310][ T53] u64s 5 type deleted 0:29:0 len 0 ver 0, , continuing [ 610.725473][T18566] bcachefs: bch2_fs_get_tree() error: EINVAL [ 610.734112][T18554] bcachefs: bch2_fs_get_tree() error: EINVAL [ 610.834552][T18561] bcachefs: bch2_fs_get_tree() error: EINVAL [ 610.866037][ T36] bucket incorrectly unset in freespace btree [ 610.866058][ T36] u64s 5 type deleted 0:30:0 len 0 ver 0, , continuing [ 610.948328][T18356] done executing program [ 610.974990][T18356] bcachefs (loop3): check_alloc_info... [ 610.976976][T18356] bucket incorrectly unset in need_discard btree [ 610.976997][T18356] u64s 13 type alloc_v4 0:31:0 len 0 ver 0: [ 610.977010][T18356] gen 0 oldest_gen 0 data_type need_discard [ 610.977022][T18356] journal_seq_nonempty 4 [ 610.977033][T18356] journal_seq_empty 0 [ 610.977043][T18356] need_discard 1 [ 610.977054][T18356] need_inc_gen 1 [ 610.977065][T18356] dirty_sectors 0 [ 610.977076][T18356] stripe_sectors 0 [ 610.977095][T18356] cached_sectors 0 [ 610.977106][T18356] stripe 0 [ 610.977120][T18356] stripe_redundancy 0 executing program executing program executing program [ 610.977131][T18356] io_time[READ] 1 [ 610.977142][T18356] io_time[WRITE] 512 [ 610.977153][T18356] fragmentation 0 [ 610.977163][T18356] bp_start 8 [ 610.977172][T18356] , fixing [ 611.355588][T18356] bucket incorrectly unset in need_discard btree [ 611.355609][T18356] u64s 13 type alloc_v4 0:31:0 len 0 ver 0: [ 611.355622][T18356] gen 0 oldest_gen 0 data_type need_discard [ 611.355633][T18356] journal_seq_nonempty 4 [ 611.355644][T18356] journal_seq_empty 0 [ 611.355654][T18356] need_discard 1 [ 611.355665][T18356] need_inc_gen 1 [ 611.355675][T18356] dirty_sectors 0 [ 611.355685][T18356] stripe_sectors 0 [ 611.355693][T18356] cached_sectors 0 [ 611.355703][T18356] stripe 0 [ 611.355713][T18356] stripe_redundancy 0 [ 611.355723][T18356] io_time[READ] 1 [ 611.355734][T18356] io_time[WRITE] 512 [ 611.355744][T18356] fragmentation 0 [ 611.355754][T18356] bp_start 8 [ 611.355764][T18356] , fixing [ 611.642634][T18356] hole in alloc btree missing in freespace btree [ 611.642656][T18356] device 0 buckets 33-34, fixing [ 611.686116][T18356] bucket incorrectly unset in need_discard btree [ 611.686137][T18356] u64s 13 type alloc_v4 0:34:0 len 0 ver 0: [ 611.686149][T18356] gen 0 oldest_gen 0 data_type need_discard [ 611.686161][T18356] journal_seq_nonempty 5 [ 611.686171][T18356] journal_seq_empty 134217728 [ 611.686182][T18356] need_discard 1 [ 611.686193][T18356] need_inc_gen 1 [ 611.686203][T18356] dirty_sectors 0 [ 611.686214][T18356] stripe_sectors 0 [ 611.686224][T18356] cached_sectors 0 [ 611.686235][T18356] stripe 0 [ 611.686245][T18356] stripe_redundancy 0 [ 611.686256][T18356] io_time[READ] 1 [ 611.686267][T18356] io_time[WRITE] 512 [ 611.686277][T18356] fragmentation 0 [ 611.686288][T18356] bp_start 8 [ 611.686298][T18356] , fixing [ 611.917691][T18356] hole in alloc btree missing in freespace btree [ 611.917712][T18356] device 0 buckets 36-37, fixing [ 611.958059][T18356] hole in alloc btree missing in freespace btree [ 611.958080][T18356] device 0 buckets 39-41, fixing [ 611.980448][T18624] loop4: detected capacity change from 0 to 32768 [ 612.024975][T18356] hole in alloc btree missing in freespace btree [ 612.024995][T18356] device 0 buckets 39-41, fixing [ 612.057157][T18356] hole in alloc btree missing in freespace btree [ 612.057178][T18356] device 0 buckets 39-41, fixing [ 612.070401][T18356] hole in alloc btree missing in freespace btree [ 612.070421][T18356] device 0 buckets 43-120, fixing [ 612.130648][T18356] done [ 612.176277][T18356] bcachefs (loop3): check_lrus... [ 612.179544][T18356] incorrect lru entry: lru fragmentation time 134217728 [ 612.179565][T18356] u64s 5 type set 18446462598867058688:34:0 len 0 ver 0 [ 612.179577][T18356] for u64s 13 type alloc_v4 0:34:0 len 0 ver 0: [ 612.179588][T18356] gen 1 oldest_gen 0 data_type free [ 612.179599][T18356] journal_seq_nonempty 5 [ 612.179632][T18356] journal_seq_empty 134217728 [ 612.179643][T18356] need_discard 0 [ 612.179654][T18356] need_inc_gen 0 [ 612.179664][T18356] dirty_sectors 0 [ 612.179675][T18356] stripe_sectors 0 [ 612.179685][T18356] cached_sectors 0 [ 612.179695][T18356] stripe 0 [ 612.179706][T18356] stripe_redundancy 0 [ 612.179716][T18356] io_time[READ] 1 [ 612.179727][T18356] io_time[WRITE] 512 [ 612.179737][T18356] fragmentation 0 [ 612.179747][T18356] bp_start 8 [ 612.179757][T18356] , fixing [ 612.193614][T18624] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 612.193686][T18624] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 612.286826][T18631] loop0: detected capacity change from 0 to 32768 [ 612.399350][T18632] loop1: detected capacity change from 0 to 32768 [ 612.413283][T18628] loop2: detected capacity change from 0 to 32768 [ 612.502096][T18631] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 612.502169][T18631] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 612.588351][T18632] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 612.602584][T18356] done [ 612.635974][T18624] bcachefs: bch2_fs_get_tree() error: EINVAL [ 612.645520][T18632] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 612.658446][T18628] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 612.678308][T18356] bcachefs (loop3): check_btree_backpointers... done [ 612.714784][T18628] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 612.725883][T18356] bcachefs (loop3): check_backpointers_to_extents... done [ 612.802585][T18356] bcachefs (loop3): check_extents_to_backpointers... [ 612.804348][T18356] bcachefs (loop3): scanning for missing backpointers in 3/128 buckets executing program [ 612.855522][T18356] done [ 612.884652][T18356] bcachefs (loop3): check_alloc_to_lru_refs... [ 612.886149][T18356] missing fragmentation lru entry [ 612.886168][T18356] u64s 13 type alloc_v4 0:32:0 len 0 ver 0: [ 612.886181][T18356] gen 0 oldest_gen 0 data_type btree [ 612.886191][T18356] journal_seq_nonempty 1 [ 612.886202][T18356] journal_seq_empty 0 [ 612.886212][T18356] need_discard 1 [ 612.886223][T18356] need_inc_gen 1 [ 612.886233][T18356] dirty_sectors 32 [ 612.886243][T18356] stripe_sectors 0 [ 612.886254][T18356] cached_sectors 0 [ 612.886264][T18356] stripe 0 [ 612.886274][T18356] stripe_redundancy 0 [ 612.886285][T18356] io_time[READ] 1 [ 612.886296][T18356] io_time[WRITE] 1 [ 612.886305][T18356] fragmentation 268435456 [ 612.886316][T18356] bp_start 8 [ 612.886326][T18356] , fixing [ 613.023178][T18632] bcachefs: bch2_fs_get_tree() error: EINVAL [ 613.071167][T18356] missing fragmentation lru entry [ 613.071185][T18356] u64s 13 type alloc_v4 0:35:0 len 0 ver 0: [ 613.071195][T18356] gen 0 oldest_gen 0 data_type btree [ 613.071205][T18356] journal_seq_nonempty 0 [ 613.071213][T18356] journal_seq_empty 0 [ 613.071223][T18356] need_discard 0 [ 613.071231][T18356] need_inc_gen 0 [ 613.071240][T18356] dirty_sectors 32 [ 613.071248][T18356] stripe_sectors 0 [ 613.071256][T18356] cached_sectors 0 [ 613.071265][T18356] stripe 0 [ 613.071273][T18356] stripe_redundancy 0 [ 613.071283][T18356] io_time[READ] 0 [ 613.071292][T18356] io_time[WRITE] 0 [ 613.071301][T18356] fragmentation 268435456 [ 613.071310][T18356] bp_start 8 [ 613.071319][T18356] , fixing [ 613.138622][T18631] bcachefs: bch2_fs_get_tree() error: EINVAL [ 613.231645][T18628] bcachefs: bch2_fs_get_tree() error: EINVAL [ 613.274323][T18356] missing fragmentation lru entry [ 613.274342][T18356] u64s 13 type alloc_v4 0:42:0 len 0 ver 0: [ 613.274353][T18356] gen 0 oldest_gen 0 data_type btree [ 613.274363][T18356] journal_seq_nonempty 7 [ 613.274372][T18356] journal_seq_empty 0 [ 613.274381][T18356] need_discard 1 [ 613.274391][T18356] need_inc_gen 1 [ 613.274401][T18356] dirty_sectors 32 [ 613.274411][T18356] stripe_sectors 0 [ 613.274420][T18356] cached_sectors 0 executing program [ 613.274430][T18356] stripe 0 [ 613.274440][T18356] stripe_redundancy 0 [ 613.274450][T18356] io_time[READ] 1 [ 613.274460][T18356] io_time[WRITE] 1280 [ 613.274486][T18356] fragmentation 268435456 [ 613.274497][T18356] bp_start 8 [ 613.274540][T18356] , fixing [ 613.588108][T18356] done executing program [ 613.605683][T18356] bcachefs (loop3): bucket_gens_init... done [ 613.658642][T18356] bcachefs (loop3): check_snapshot_trees... done [ 613.694617][T18356] bcachefs (loop3): check_snapshots... [ 613.695067][T18356] snapshot points to missing/incorrect tree: [ 613.695085][T18356] u64s 8 type snapshot 0:4294967295:0 len 0 ver 0: is_subvol 1 deleted 0 parent 0 children 0 0 subvol 1 tree 0, fixing executing program [ 613.804763][T18356] snapshot points to missing/incorrect tree: [ 613.804781][T18356] u64s 8 type snapshot 0:4294967295:0 len 0 ver 0: is_subvol 1 deleted 0 parent 0 children 0 0 subvol 1 tree 0, fixing [ 613.882279][T18356] done [ 613.896292][T18356] bcachefs (loop3): check_subvols... done [ 613.924430][T18356] bcachefs (loop3): check_subvol_children... done [ 613.976925][T18356] bcachefs (loop3): delete_dead_snapshots... done [ 614.001031][T18356] bcachefs (loop3): check_inodes... done [ 614.042777][T18356] bcachefs (loop3): check_extents... done [ 614.055737][T18688] loop4: detected capacity change from 0 to 32768 [ 614.087573][T18356] bcachefs (loop3): check_indirect_extents... done [ 614.095983][T18356] bcachefs (loop3): check_dirents... done [ 614.116461][T18356] bcachefs (loop3): check_xattrs... done [ 614.154245][T18356] bcachefs (loop3): check_root... done [ 614.186372][T18356] bcachefs (loop3): check_unreachable_inodes... done [ 614.244652][T18356] bcachefs (loop3): check_subvolume_structure... done [ 614.255311][T18688] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 614.292163][T18688] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 614.293393][T18356] bcachefs (loop3): check_directory_structure... done [ 614.374711][T18356] bcachefs (loop3): check_nlinks... done [ 614.416303][T18356] bcachefs (loop3): resume_logged_ops... done [ 614.422596][T18356] bcachefs (loop3): delete_dead_inodes... [ 614.423492][T18704] loop2: detected capacity change from 0 to 32768 [ 614.437906][T18356] done [ 614.440722][T18356] bcachefs (loop3): set_fs_needs_rebalance... done [ 614.502232][T18356] bcachefs (loop3): Fixed errors, running fsck a second time to verify fs is clean [ 614.530029][T18356] bcachefs (loop3): check_alloc_info... done [ 614.541900][T18356] bcachefs (loop3): check_lrus... done [ 614.548396][T18356] bcachefs (loop3): check_btree_backpointers... done [ 614.556145][T18356] bcachefs (loop3): check_backpointers_to_extents... done [ 614.564471][T18356] bcachefs (loop3): check_extents_to_backpointers... done [ 614.572610][T18356] bcachefs (loop3): check_alloc_to_lru_refs... done [ 614.580897][T18356] bcachefs (loop3): bucket_gens_init... done [ 614.591589][T18704] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 614.601314][T18704] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 614.612118][T18356] bcachefs (loop3): check_snapshot_trees... done [ 614.625437][T18688] bcachefs: bch2_fs_get_tree() error: EINVAL [ 614.637898][T18356] bcachefs (loop3): check_snapshots... done [ 614.684782][T18356] bcachefs (loop3): check_subvols... done [ 614.718750][T18356] bcachefs (loop3): check_subvol_children... done [ 614.762796][T18356] bcachefs (loop3): delete_dead_snapshots... done [ 614.784134][T18356] bcachefs (loop3): check_inodes... done [ 614.790126][T18356] bcachefs (loop3): check_extents... done [ 614.834100][T18356] bcachefs (loop3): check_indirect_extents... done [ 614.842068][T18695] loop0: detected capacity change from 0 to 32768 [ 614.851133][T18356] bcachefs (loop3): check_dirents... done [ 614.869507][T18356] bcachefs (loop3): check_xattrs... done [ 614.877169][T18702] loop1: detected capacity change from 0 to 32768 [ 614.890037][T18356] bcachefs (loop3): check_root... done [ 614.907436][T18356] bcachefs (loop3): check_unreachable_inodes... done [ 614.928087][T18356] bcachefs (loop3): check_subvolume_structure... done [ 614.928203][T18704] bcachefs: bch2_fs_get_tree() error: EINVAL [ 614.992426][T18356] bcachefs (loop3): check_directory_structure... done [ 615.040989][T18695] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 615.046930][T18356] bcachefs (loop3): check_nlinks... done [ 615.063322][T18356] bcachefs (loop3): resume_logged_ops... done [ 615.072002][T18356] bcachefs (loop3): delete_dead_inodes... done [ 615.079829][T18356] bcachefs (loop3): set_fs_needs_rebalance... done [ 615.096443][T18695] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 615.126640][T18356] bcachefs (loop3): bch2_copygc_start(): error creating copygc thread EINTR executing program [ 615.160276][T18702] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 615.171773][T18702] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 615.178524][T18356] bcachefs (loop3): error starting copygc thread executing program [ 615.234122][T18356] bcachefs (loop3): bch2_fs_start(): error starting filesystem EINTR [ 615.267429][T18356] bcachefs (loop3): shutting down [ 615.272519][T18356] bcachefs (loop3): going read-only [ 615.327819][T18356] bcachefs (loop3): finished waiting for writes to stop [ 615.344208][T18356] bcachefs (loop3): flushing journal and stopping allocators, journal seq 35 [ 615.373581][T18356] bcachefs (loop3): flushing journal and stopping allocators complete, journal seq 35 [ 615.424839][T18356] bcachefs (loop3): clean shutdown complete, journal seq 36 [ 615.457912][T18695] bcachefs: bch2_fs_get_tree() error: EINVAL [ 615.465878][T18356] bcachefs (loop3): marking filesystem clean [ 615.564382][T18702] bcachefs: bch2_fs_get_tree() error: EINVAL [ 615.598043][T18356] bcachefs (loop3): shutdown complete executing program executing program [ 616.239782][T18753] loop2: detected capacity change from 0 to 32768 [ 616.264882][T18755] loop4: detected capacity change from 0 to 32768 [ 616.518180][T18764] loop0: detected capacity change from 0 to 32768 [ 616.824251][T18764] bcachefs (loop0): starting version 1.7: mi_btree_bitmap opts=errors=continue,metadata_checksum=none,data_checksum=none,compression=lz4,nojournal_transaction_names [ 616.832507][T18755] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 616.840867][T18764] bcachefs (loop0): recovering from clean shutdown, journal seq 10 [ 616.841030][T18764] bcachefs (loop0): Version upgrade required: [ 616.841030][T18764] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete [ 616.841030][T18764] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.20: directory_size [ 616.841030][T18764] running recovery passes: check_allocations,check_alloc_info,check_lrus,check_btree_backpointers,check_backpointers_to_extents,check_extents_to_backpointers,check_alloc_to_lru_refs,bucket_gens_init,check_snapshot_trees,check_snapshots,check_subvols,check_subvol_children,delete_dead_snapshots,check_inodes,check_extents,check_indirect_extents,check_dirents,check_xattrs,check_root,check_unreachable_inodes,check_subvolume_structure,check_directory_structure,check_nlinks,set_fs_needs_rebalance [ 616.934339][T18755] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 616.944224][T18753] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 616.957223][T18769] loop1: detected capacity change from 0 to 32768 [ 616.967631][T18753] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 617.000231][T18764] bcachefs (loop0): error validating btree node on loop0 at btree extents level 0/0 [ 617.000253][T18764] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key POS_MIN durability: 1 ptr: 0:27:0 gen 0 [ 617.000267][T18764] node offset 0/16: incorrect min_key: got 0:36028797018963968:0 should be POS_MIN [ 617.069365][T18764] bcachefs (loop0): running explicit recovery pass check_topology (2), currently at recovery_pass_empty (0) [ 617.083022][T18764] bcachefs (loop0): flagging btree extents lost data [ 617.090044][T18764] bcachefs (loop0): running explicit recovery pass scan_for_btree_nodes (1), currently at recovery_pass_empty (0) [ 617.124172][T18764] error reading btree root btree=extents level=0: btree_node_read_error, fixing [ 617.166183][T18764] bcachefs (loop0): error validating btree node at btree inodes level 0/0 [ 617.166205][T18764] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0 [ 617.166219][T18764] node offset 16/24 bset u64s 110 bset byte offset 152: keys out of order: u64s 16 type inode_v3 134217728:4096:U32_MAX len 0 ver 0 > u64s 18 type inode_v3 0:4098:U32_MAX len 0 ver 0, fixing [ 617.197794][T18356] bcachefs: bch2_fs_get_tree() error: EINTR [ 617.288256][T18764] invalid bkey in btree_node btree=inodes level=0: u64s 16 type inode_v3 134217728:4096:U32_MAX len 0 ver 0: [ 617.288279][T18764] mode=40755 [ 617.288290][T18764] flags=(16300000) [ 617.288300][T18764] journal_seq=0 [ 617.288310][T18764] hash_seed=28e4f092a4fc58ee [ 617.288320][T18764] hash_type=siphash [ 617.288330][T18764] bi_size=0 [ 617.288340][T18764] bi_sectors=0 [ 617.288350][T18764] bi_version=0 [ 617.288360][T18764] bi_atime=200535484 [ 617.288370][T18764] bi_ctime=2780562352 [ 617.288379][T18764] bi_mtime=2780562352 [ 617.288389][T18764] bi_otime=200535484 [ 617.288398][T18764] bi_uid=0 [ 617.288407][T18764] bi_gid=0 [ 617.288416][T18764] bi_nlink=2 [ 617.288426][T18764] bi_generation=0 [ 617.288435][T18764] bi_dev=0 [ 617.288445][T18764] bi_data_checksum=0 [ 617.288455][T18764] bi_compression=0 [ 617.288464][T18764] bi_project=0 [ 617.288474][T18764] bi_background_compression=0 [ 617.288484][T18764] bi_data_replicas=0 [ 617.288493][T18764] bi_promote_target=0 [ 617.288503][T18764] bi_foreground_target=0 [ 617.288513][T18764] bi_background_target=0 [ 617.288523][T18764] bi_erasure_code=0 [ 617.288532][T18764] bi_fields_set=0 [ 617.288543][T18764] bi_dir=0 [ 617.288553][T18764] bi_dir_offset=0 [ 617.288562][T18764] bi_subvol=1 [ 617.288572][T18764] bi_parent_subvol=0 [ 617.288582][T18764] bi_nocow=0 [ 617.288591][T18764] bi_depth=0 [ 617.288601][T18764] bi_inodes_32bit=0 [ 617.288611][T18764] nonzero k.p.inode: delete?, fixing [ 617.304609][T18769] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 617.304684][T18769] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 617.337037][T18753] bcachefs: bch2_fs_get_tree() error: EINVAL [ 617.340521][T18764] bcachefs (loop0): btree_node_read_work: rewriting btree node at due to error [ 617.340521][T18764] btree=inodes level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0 [ 617.464745][T18755] bcachefs: bch2_fs_get_tree() error: EINVAL [ 617.519617][T18764] bcachefs (loop0): error validating btree node on loop0 at btree dirents level 0/0 [ 617.519639][T18764] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0 executing program [ 617.519653][T18764] node offset 16/24: btree node data missing: expected 24 sectors, found 16, fixing [ 617.634607][T18764] bcachefs (loop0): btree_node_read_work: rewriting btree node at due to error [ 617.634607][T18764] btree=dirents level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0 [ 617.696675][T18769] bcachefs: bch2_fs_get_tree() error: EINVAL executing program [ 617.754441][T18764] bcachefs (loop0): error validating btree node on loop0 at btree xattrs level 0/0 [ 617.754462][T18764] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 2285c34bed0abe32 written 16 min_key POS_MIN durability: 1 ptr: 0:31:0 gen 0 [ 617.754481][T18764] node offset 0/16 bset u64s 0: incorrect btree id [ 617.894645][T18764] bcachefs (loop0): flagging btree xattrs lost data executing program [ 617.944491][T18764] error reading btree root btree=xattrs level=0: btree_node_read_error, fixing [ 617.997691][T18764] bcachefs (loop0): error validating btree node at btree alloc level 0/0 [ 617.997714][T18764] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0 executing program [ 617.997730][T18764] node offset 8/24 bset u64s 375 bset byte offset 184: keys out of order: u64s 11 type alloc_v4 0:32:0 len 0 ver 0 > u64s 11 type alloc_v4 0:2:0 len 0 ver 0, fixing [ 618.133135][T18764] bcachefs (loop0): btree_node_read_work: rewriting btree node at due to error [ 618.133135][T18764] btree=alloc level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0 [ 618.255682][T18764] bcachefs (loop0): error validating btree node on loop0 at btree freespace level 0/0 [ 618.255704][T18764] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq e81e1ed936acf3df written 32 min_key POS_MIN durability: 1 ptr: 0:29:0 gen 0 [ 618.255720][T18764] node offset 0/32 bset u64s 0: invalid bkey format: incorrect number of fields: got 0, should be 6 [ 618.255732][T18764] u64s 5 fields 64:0, 64:0, 32:0, 0:0, 0:0, 0:0 [ 618.384277][T18764] bcachefs (loop0): flagging btree freespace lost data [ 618.424246][T18764] error reading btree root btree=freespace level=0: btree_node_read_error, fixing [ 618.496215][T18764] bcachefs (loop0): scan_for_btree_nodes... [ 618.606862][T18859] invalid bkey in btree_node btree=stripes level=0: u64s 7 type xattr 536870912:3798421620223919902:U32_MAX len 0 ver 0: user.xattr2:xattr2 [ 618.606887][T18859] nonzero snapshot: delete?, fixing [ 618.700506][T18859] bcachefs (loop0): flagging btree stripes lost data [ 618.767481][T18844] loop3: detected capacity change from 0 to 32768 [ 618.906162][T18847] loop2: detected capacity change from 0 to 32768 [ 618.920071][T18844] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 618.986563][T18844] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 619.025040][T18850] loop4: detected capacity change from 0 to 32768 [ 619.035234][T18764] bcachefs (loop0): btree node scan found 6 nodes after overwrites [ 619.048216][T18853] loop1: detected capacity change from 0 to 32768 [ 619.053717][T18764] done [ 619.080580][T18764] bcachefs (loop0): check_topology... [ 619.085879][T18764] bcachefs (loop0): btree root extents unreadable, must recover from scan [ 619.123045][T18764] bcachefs (loop0): bch2_get_scanned_nodes(): recovery btree=extents level=0 POS_MIN - SPOS_MAX [ 619.154810][T18764] bcachefs (loop0): bch2_get_scanned_nodes(): recovering u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 [ 619.187544][ T43] bcachefs (loop0): error validating btree node on loop0 at btree extents level 0/0 [ 619.187575][ T43] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 [ 619.187590][ T43] node offset 8/32 bset u64s 2097: bset past end of btree node (offset 8 len 40 but written 32), fixing [ 619.243048][T18847] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 619.243114][T18847] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 619.264854][ T43] bcachefs (loop0): error validating btree node on loop0 at btree extents level 0/0 [ 619.264874][ T43] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 [ 619.264889][ T43] node offset 8/32 bset u64s 0: empty bset, fixing [ 619.298009][ T43] bcachefs (loop0): btree_node_read_work: rewriting btree node at due to error [ 619.298009][ T43] btree=extents level=0 u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 [ 619.328018][T18764] bcachefs (loop0): bch2_get_scanned_nodes(): recovery btree=extents level=0 POS_MIN - 0:36028797018963967:U32_MAX [ 619.341445][T18764] btree node with incorrect min_key at btree=extents level=1: [ 619.341465][T18764] parent: u64s 5 type btree_ptr SPOS_MAX len 0 ver 0 [ 619.341477][T18764] next: u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0, fixing [ 619.365654][T18844] bcachefs: bch2_fs_get_tree() error: EINVAL [ 619.492419][T18850] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 619.492490][T18850] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 619.497662][T18847] bcachefs: bch2_fs_get_tree() error: EINVAL [ 619.515321][T18853] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 619.574290][T18764] bcachefs (loop0): set_node_min(): u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 32 min_key 0:36028797018963968:0 durability: 1 ptr: 0:27:0 gen 0 -> POS_MIN [ 619.624831][T18853] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 619.676473][T18764] bcachefs (loop0): btree root xattrs unreadable, must recover from scan [ 619.714523][T18764] no nodes found for btree xattrs, continuing [ 619.720872][T18764] done [ 619.764753][T18764] bcachefs (loop0): accounting_read... done [ 619.778170][T18764] bcachefs (loop0): alloc_read... done [ 619.794665][T18764] bcachefs (loop0): stripes_read... done executing program executing program [ 619.823155][T18764] bcachefs (loop0): snapshots_read... done [ 619.869801][T18764] bcachefs (loop0): check_allocations... [ 619.879719][T18764] bucket 0:26 data type btree ptr gen 0 missing in alloc btree [ 619.879743][T18764] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0, fixing [ 619.925606][T18853] bcachefs: bch2_fs_get_tree() error: EINVAL [ 619.935686][T18850] bcachefs: bch2_fs_get_tree() error: EINVAL [ 620.193385][T18764] bucket 0:38 data type btree ptr gen 0 missing in alloc btree [ 620.193407][T18764] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0, fixing executing program executing program [ 620.331214][T18764] bucket 0:41 data type btree ptr gen 0 missing in alloc btree [ 620.331238][T18764] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0, fixing [ 620.445432][T18764] bucket 0:35 data type btree ptr gen 0 missing in alloc btree [ 620.445455][T18764] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c0bef60d07ceb940 written 16 min_key POS_MIN durability: 1 ptr: 0:35:0 gen 0, fixing