Warning: Permanently added '10.128.0.30' (ED25519) to the list of known hosts.
2025/06/12 21:54:31 ignoring optional flag "sandboxArg"="0"
[ 133.083157][ T1302] ieee802154 phy0 wpan0: encryption failed: -22
[ 133.089972][ T1302] ieee802154 phy1 wpan1: encryption failed: -22
2025/06/12 21:54:32 parsed 1 programs
[ 138.654866][ T6321] Adding 124996k swap on ./swap-file. Priority:0 extents:1 across:124996k
[ 143.251086][ T5143] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1
[ 143.260065][ T5143] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9
[ 143.267938][ T5143] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9
[ 143.276973][ T5143] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4
[ 143.285718][ T5143] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2
[ 145.005476][ T6389] chnl_net:caif_netlink_parms(): no params data found
[ 145.086422][ T6389] bridge0: port 1(bridge_slave_0) entered blocking state
[ 145.093666][ T6389] bridge0: port 1(bridge_slave_0) entered disabled state
[ 145.101066][ T6389] bridge_slave_0: entered allmulticast mode
[ 145.108330][ T6389] bridge_slave_0: entered promiscuous mode
[ 145.116532][ T6389] bridge0: port 2(bridge_slave_1) entered blocking state
[ 145.123867][ T6389] bridge0: port 2(bridge_slave_1) entered disabled state
[ 145.131535][ T6389] bridge_slave_1: entered allmulticast mode
[ 145.138784][ T6389] bridge_slave_1: entered promiscuous mode
[ 145.172177][ T6389] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link
[ 145.184091][ T6389] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link
[ 145.221253][ T6389] team0: Port device team_slave_0 added
[ 145.229462][ T6389] team0: Port device team_slave_1 added
[ 145.259910][ T6389] batman_adv: batadv0: Adding interface: batadv_slave_0
[ 145.266921][ T6389] batman_adv: batadv0: The MTU of interface batadv_slave_0 is too small (1500) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Setting the MTU to 1560 would solve the problem.
[ 145.293240][ T6389] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active
[ 145.305454][ T6389] batman_adv: batadv0: Adding interface: batadv_slave_1
[ 145.312489][ T6389] batman_adv: batadv0: The MTU of interface batadv_slave_1 is too small (1500) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Setting the MTU to 1560 would solve the problem.
[ 145.338472][ T6389] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active
[ 145.388674][ T6389] hsr_slave_0: entered promiscuous mode
[ 145.395244][ T6389] hsr_slave_1: entered promiscuous mode
[ 146.012033][ T6389] netdevsim netdevsim0 netdevsim0: renamed from eth0
[ 146.025608][ T6389] netdevsim netdevsim0 netdevsim1: renamed from eth1
[ 146.036047][ T6389] netdevsim netdevsim0 netdevsim2: renamed from eth2
[ 146.049100][ T6389] netdevsim netdevsim0 netdevsim3: renamed from eth3
[ 146.164931][ T6389] 8021q: adding VLAN 0 to HW filter on device bond0
[ 146.195642][ T6389] 8021q: adding VLAN 0 to HW filter on device team0
[ 146.209113][ T3455] bridge0: port 1(bridge_slave_0) entered blocking state
[ 146.216387][ T3455] bridge0: port 1(bridge_slave_0) entered forwarding state
[ 146.235419][ T3455] bridge0: port 2(bridge_slave_1) entered blocking state
[ 146.242787][ T3455] bridge0: port 2(bridge_slave_1) entered forwarding state
[ 146.551942][ T6389] 8021q: adding VLAN 0 to HW filter on device batadv0
[ 146.624811][ T6389] veth0_vlan: entered promiscuous mode
[ 146.642037][ T6389] veth1_vlan: entered promiscuous mode
[ 146.681341][ T6389] veth0_macvtap: entered promiscuous mode
[ 146.696877][ T6389] veth1_macvtap: entered promiscuous mode
[ 146.723156][ T6389] batman_adv: batadv0: Interface activated: batadv_slave_0
[ 146.742820][ T6389] batman_adv: batadv0: Interface activated: batadv_slave_1
[ 146.758589][ T6389] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0
[ 146.771176][ T6389] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0
[ 146.781307][ T6389] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0
[ 146.791355][ T6389] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0
[ 147.002425][ T13] netdevsim netdevsim0 netdevsim3 (unregistering): unset [1, 0] type 2 family 0 port 6081 - 0
[ 147.098895][ T13] netdevsim netdevsim0 netdevsim2 (unregistering): unset [1, 0] type 2 family 0 port 6081 - 0
[ 147.225013][ T13] netdevsim netdevsim0 netdevsim1 (unregistering): unset [1, 0] type 2 family 0 port 6081 - 0
[ 147.253421][ T36] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50
[ 147.276455][ T36] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50
[ 147.315651][ T13] netdevsim netdevsim0 netdevsim0 (unregistering): unset [1, 0] type 2 family 0 port 6081 - 0
[ 147.360907][ T4528] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50
[ 147.368796][ T4528] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50
2025/06/12 21:54:47 executed programs: 0
[ 148.245387][ T5143] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1
[ 148.254467][ T5143] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9
[ 148.265553][ T5143] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9
[ 148.276654][ T5143] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4
[ 148.288140][ T5143] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2
[ 148.586764][ T6482] chnl_net:caif_netlink_parms(): no params data found
[ 148.780096][ T6482] bridge0: port 1(bridge_slave_0) entered blocking state
[ 148.787364][ T6482] bridge0: port 1(bridge_slave_0) entered disabled state
[ 148.819723][ T6482] bridge_slave_0: entered allmulticast mode
[ 148.839896][ T6482] bridge_slave_0: entered promiscuous mode
[ 148.861843][ T6482] bridge0: port 2(bridge_slave_1) entered blocking state
[ 148.869058][ T6482] bridge0: port 2(bridge_slave_1) entered disabled state
[ 148.890734][ T6482] bridge_slave_1: entered allmulticast mode
[ 148.898669][ T6482] bridge_slave_1: entered promiscuous mode
[ 149.000412][ T6482] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link
[ 149.023553][ T6482] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link
[ 149.115632][ T6482] team0: Port device team_slave_0 added
[ 149.134327][ T6482] team0: Port device team_slave_1 added
[ 149.192753][ T6482] batman_adv: batadv0: Adding interface: batadv_slave_0
[ 149.199832][ T6482] batman_adv: batadv0: The MTU of interface batadv_slave_0 is too small (1500) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Setting the MTU to 1560 would solve the problem.
[ 149.227221][ T6482] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active
[ 149.251619][ T6482] batman_adv: batadv0: Adding interface: batadv_slave_1
[ 149.258646][ T6482] batman_adv: batadv0: The MTU of interface batadv_slave_1 is too small (1500) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Setting the MTU to 1560 would solve the problem.
[ 149.293201][ T6482] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active
[ 149.468764][ T6482] hsr_slave_0: entered promiscuous mode
[ 149.476526][ T6482] hsr_slave_1: entered promiscuous mode
[ 149.484107][ T6482] debugfs: Directory 'hsr0' with parent 'hsr' already present!
[ 149.492154][ T6482] Cannot create hsr debugfs directory
[ 149.498001][ T13] bridge_slave_1: left allmulticast mode
[ 149.504786][ T13] bridge_slave_1: left promiscuous mode
[ 149.511411][ T13] bridge0: port 2(bridge_slave_1) entered disabled state
[ 149.523357][ T13] bridge_slave_0: left allmulticast mode
[ 149.529084][ T13] bridge_slave_0: left promiscuous mode
[ 149.536425][ T13] bridge0: port 1(bridge_slave_0) entered disabled state
[ 149.888302][ T13] bond0 (unregistering): (slave bond_slave_0): Releasing backup interface
[ 149.901750][ T13] bond0 (unregistering): (slave bond_slave_1): Releasing backup interface
[ 149.913812][ T13] bond0 (unregistering): Released all slaves
[ 150.072746][ T13] hsr_slave_0: left promiscuous mode
[ 150.096637][ T13] hsr_slave_1: left promiscuous mode
[ 150.104566][ T13] batman_adv: batadv0: Interface deactivated: batadv_slave_0
[ 150.115435][ T13] batman_adv: batadv0: Removing interface: batadv_slave_0
[ 150.131447][ T13] batman_adv: batadv0: Interface deactivated: batadv_slave_1
[ 150.138908][ T13] batman_adv: batadv0: Removing interface: batadv_slave_1
[ 150.174831][ T13] veth1_macvtap: left promiscuous mode
[ 150.199916][ T13] veth0_macvtap: left promiscuous mode
[ 150.205676][ T13] veth1_vlan: left promiscuous mode
[ 150.219628][ T13] veth0_vlan: left promiscuous mode
[ 150.376509][ T51] Bluetooth: hci0: command tx timeout
[ 150.683202][ T13] team0 (unregistering): Port device team_slave_1 removed
[ 150.716704][ T13] team0 (unregistering): Port device team_slave_0 removed
[ 151.627526][ T6482] netdevsim netdevsim0 netdevsim0: renamed from eth0
[ 151.669303][ T6482] netdevsim netdevsim0 netdevsim1: renamed from eth1
[ 151.685004][ T6482] netdevsim netdevsim0 netdevsim2: renamed from eth2
[ 151.703159][ T6482] netdevsim netdevsim0 netdevsim3: renamed from eth3
[ 151.907343][ T6482] 8021q: adding VLAN 0 to HW filter on device bond0
[ 151.953073][ T6482] 8021q: adding VLAN 0 to HW filter on device team0
[ 152.004094][ T3455] bridge0: port 1(bridge_slave_0) entered blocking state
[ 152.011371][ T3455] bridge0: port 1(bridge_slave_0) entered forwarding state
[ 152.023839][ T3455] bridge0: port 2(bridge_slave_1) entered blocking state
[ 152.031096][ T3455] bridge0: port 2(bridge_slave_1) entered forwarding state
[ 152.340483][ T6482] 8021q: adding VLAN 0 to HW filter on device batadv0
[ 152.406973][ T6482] veth0_vlan: entered promiscuous mode
[ 152.425177][ T6482] veth1_vlan: entered promiscuous mode
[ 152.440530][ T51] Bluetooth: hci0: command tx timeout
[ 152.476708][ T6482] veth0_macvtap: entered promiscuous mode
[ 152.489229][ T6482] veth1_macvtap: entered promiscuous mode
[ 152.516436][ T6482] batman_adv: batadv0: Interface activated: batadv_slave_0
[ 152.538499][ T6482] batman_adv: batadv0: Interface activated: batadv_slave_1
[ 152.556061][ T6482] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0
[ 152.567456][ T6482] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0
[ 152.578435][ T6482] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0
[ 152.588327][ T6482] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0
[ 152.680679][ T3455] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50
[ 152.688577][ T3455] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50
[ 152.728828][ T3455] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50
[ 152.736989][ T3455] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50
[ 153.118386][ T6586] loop0: detected capacity change from 0 to 32768
[ 153.209022][ T6586] bcachefs (loop0): starting version 1.7: mi_btree_bitmap opts=errors=continue,metadata_checksum=none,data_checksum=none,compression=lz4,nojournal_transaction_names
[ 153.209022][ T6586] allowing incompatible features above 0.0: (unknown version)
[ 153.209022][ T6586] features: lz4,new_siphash,inline_data,new_extent_overwrite,btree_ptr_v2,new_varint,journal_no_flush,alloc_v2,extents_across_btree_nodes
[ 153.256994][ T6586] bcachefs (loop0): Using encoding defined by superblock: utf8-12.1.0
[ 153.270809][ T6586] bcachefs (loop0): recovering from clean shutdown, journal seq 10
[ 153.279266][ T6586] bcachefs (loop0): Version upgrade required:
[ 153.279266][ T6586] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete
[ 153.279266][ T6586] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.28: inode_has_case_insensitive
[ 153.279266][ T6586] 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,check_rebalance_work,set_fs_needs_rebalance
[ 153.373441][ T6586] bcachefs (loop0): invalid btree id 255 (max 63), fixing
[ 153.413680][ T6586] bcachefs (loop0): error reading btree root btree=inodes level=0: btree_node_read_error, fixing
[ 153.433170][ T6586] bcachefs (loop0): btree node read error at btree freespace level 0/0
[ 153.433199][ T6586] 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
[ 153.433216][ T6586] loop0 node offset 0/32 bset u64s 0: incorrect max key 18446744073692775423:U64_MAX:U32_MAX
[ 153.433230][ T6586] flagging btree freespace lost data
[ 153.433241][ T6586] ret btree_node_read_validate_error
[ 153.488496][ T6586] bcachefs (loop0): error reading btree root btree=freespace level=0: btree_node_read_error, fixing
[ 153.503282][ T6586] bcachefs (loop0): scan_for_btree_nodes...
[ 153.540843][ T6602] bcachefs (loop0): invalid bkey in btree_node btree=inodes level=0: u64s 14 type inode_v3 0:4097:U32_MAX len 0 ver 0: (unpack error)
[ 153.540878][ T6602] invalid variable length fields, deleting
[ 153.666777][ T6586] bcachefs (loop0): btree node scan found 7 nodes after overwrites
[ 153.675964][ T6586] done
[ 153.678806][ T6586] bcachefs (loop0): check_topology...
[ 153.679039][ T6586] bcachefs (loop0): btree root inodes unreadable, must recover from scan
[ 153.696061][ T6586] bcachefs (loop0): bch2_get_scanned_nodes(): recovery btree=inodes level=0 POS_MIN - SPOS_MAX
[ 153.707943][ T6586] bcachefs (loop0): bch2_get_scanned_nodes(): recovering 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
[ 153.738670][ T6586] bcachefs (loop0): empty interior btree node at btree=inodes level=1
[ 153.738699][ T6586] u64s 5 type btree_ptr SPOS_MAX len 0 ver 0, fixing
[ 153.756022][ T6586] bcachefs (loop0): empty btree root inodes
[ 153.764956][ T6586] done
[ 153.767794][ T6586] bcachefs (loop0): scan_for_btree_nodes... done
[ 153.775202][ T6586] bcachefs (loop0): accounting_read... done
[ 153.784202][ T6586] bcachefs (loop0): alloc_read... done
[ 153.791039][ T6586] bcachefs (loop0): snapshots_read... done
[ 153.817517][ T6586] bcachefs (loop0): check_allocations...
[ 153.824199][ T6586] bcachefs (loop0): bucket 0:31 data type btree ptr gen 0 missing in alloc btree
[ 153.824232][ T6586] while marking 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, fixing
[ 153.863165][ T6586] bcachefs (loop0): bucket 0:35 data type btree ptr gen 0 missing in alloc btree
[ 153.863188][ T6586] 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
[ 153.897049][ T6586] bcachefs (loop0): bucket 0:32 data type btree ptr gen 0 missing in alloc btree
[ 153.897071][ T6586] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ebb8d5a9e3463bdb written 16 min_key POS_MIN durability: 1 ptr: 0:32:0 gen 0, fixing
[ 153.925450][ T6586] bcachefs (loop0): bucket 0:28 data type btree ptr gen 0 missing in alloc btree
[ 153.925472][ T6586] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 28f61e078e70b95c written 16 min_key POS_MIN durability: 1 ptr: 0:28:0 gen 0, fixing
[ 153.954813][ T6586] bcachefs (loop0): bucket 0:37 data type btree ptr gen 0 missing in alloc btree
[ 153.954836][ T6586] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 4a8b0fa43a9980a6 written 24 min_key POS_MIN durability: 1 ptr: 0:37:0 gen 0, fixing
[ 153.992089][ T6586] bcachefs (loop0): bucket 0:42 data type btree ptr gen 0 missing in alloc btree
[ 153.992120][ T6586] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 1db8f60c84bb244c written 8 min_key POS_MIN durability: 1 ptr: 0:42:0 gen 0, fixing
[ 154.020840][ T6586] bcachefs (loop0): bucket 0:0 gen 0 has wrong data_type: got free, should be sb, fixing
[ 154.033018][ T6586] bcachefs (loop0): bucket 0:0 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing
[ 154.048559][ T6586] bcachefs (loop0): bucket 0:1 gen 0 has wrong data_type: got free, should be sb, fixing
[ 154.059669][ T6586] bcachefs (loop0): bucket 0:1 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing
[ 154.072596][ T6586] bcachefs (loop0): bucket 0:2 gen 0 has wrong data_type: got free, should be sb, fixing
[ 154.083252][ T6586] bcachefs (loop0): bucket 0:2 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing
[ 154.095946][ T6586] bcachefs (loop0): bucket 0:3 gen 0 has wrong data_type: got free, should be sb, fixing
[ 154.106526][ T6586] bcachefs (loop0): bucket 0:3 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing
[ 154.121102][ T6586] bcachefs (loop0): bucket 0:4 gen 0 has wrong data_type: got free, should be sb, fixing
[ 154.132460][ T6586] bcachefs (loop0): bucket 0:4 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing
[ 154.146977][ T6586] bcachefs (loop0): bucket 0:5 gen 0 has wrong data_type: got free, should be sb, fixing
[ 154.158279][ T6586] bcachefs (loop0): bucket 0:5 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing
[ 154.170993][ T6586] bcachefs (loop0): bucket 0:6 gen 0 has wrong data_type: got free, should be sb, fixing
[ 154.181394][ T6586] bcachefs (loop0): bucket 0:6 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing
[ 154.194213][ T6586] bcachefs (loop0): bucket 0:7 gen 0 has wrong data_type: got free, should be sb, fixing
[ 154.205852][ T6586] bcachefs (loop0): bucket 0:7 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing
[ 154.218835][ T6586] bcachefs (loop0): bucket 0:8 gen 0 has wrong data_type: got free, should be sb, fixing
[ 154.229280][ T6586] bcachefs (loop0): bucket 0:8 gen 0 data type sb has wrong dirty_sectors: got 0, should be 8, fixing
[ 154.242767][ T6586] bcachefs (loop0): bucket 0:9 gen 0 has wrong data_type: got free, should be journal, fixing
[ 154.255441][ T6586] bcachefs (loop0): bucket 0:9 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing
[ 154.268760][ T6586] bcachefs (loop0): bucket 0:10 gen 0 has wrong data_type: got free, should be journal, fixing
[ 154.268781][ T6586] Ratelimiting new instances of previous error
[ 154.287349][ T6586] bcachefs (loop0): bucket 0:10 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing
[ 154.287372][ T6586] Ratelimiting new instances of previous error
[ 154.326213][ T6586] done
[ 154.332315][ T6586] bcachefs (loop0): going read-write
[ 154.394686][ T6630] ODEBUG: object ffffc900039ffb90 is on stack ffffc900039f8000, but NOT annotated.
[ 154.395469][ T6630]
[ 154.395479][ T6630] ======================================================
[ 154.395488][ T6630] WARNING: possible circular locking dependency detected
[ 154.395509][ T6630] 6.16.0-rc1-syzkaller-00101-g27605c8c0f69 #0 Not tainted
[ 154.395521][ T6630] ------------------------------------------------------
[ 154.395529][ T6630] bch-copygc/loop/6630 is trying to acquire lock:
[ 154.395540][ T6630] ffffffff8e132fc0 (console_owner){....}-{0:0}, at: console_flush_all+0x13a/0xc40
[ 154.395592][ T6630]
[ 154.395592][ T6630] but task is already holding lock:
[ 154.395599][ T6630] ffffffff99d26940 (&obj_hash[i].lock){-.-.}-{2:2}, at: __debug_object_init+0x85/0x3c0
[ 154.395645][ T6630]
[ 154.395645][ T6630] which lock already depends on the new lock.
[ 154.395645][ T6630]
[ 154.395652][ T6630]
[ 154.395652][ T6630] the existing dependency chain (in reverse order) is:
[ 154.395660][ T6630]
[ 154.395660][ T6630] -> #4 (&obj_hash[i].lock){-.-.}-{2:2}:
[ 154.395687][ T6630] lock_acquire+0x120/0x360
[ 154.395712][ T6630] _raw_spin_lock_irqsave+0xa7/0xf0
[ 154.395739][ T6630] debug_object_activate+0xbb/0x420
[ 154.395759][ T6630] insert_work+0x35/0x330
[ 154.395784][ T6630] __queue_work+0xcfc/0xfe0
[ 154.395812][ T6630] queue_work_on+0x181/0x270
[ 154.395839][ T6630] start_poll_synchronize_rcu_expedited+0xfc/0x140
[ 154.395862][ T6630] rcu_init+0x108/0x160
[ 154.395880][ T6630] start_kernel+0x1fb/0x500
[ 154.395904][ T6630] x86_64_start_reservations+0x24/0x30
[ 154.395923][ T6630] x86_64_start_kernel+0x143/0x1c0
[ 154.395941][ T6630] common_startup_64+0x13e/0x147
[ 154.395959][ T6630]
[ 154.395959][ T6630] -> #3 (&pool->lock){-.-.}-{2:2}:
[ 154.395985][ T6630] lock_acquire+0x120/0x360
[ 154.396008][ T6630] _raw_spin_lock+0x2e/0x40
[ 154.396032][ T6630] __queue_work+0x7b0/0xfe0
[ 154.396060][ T6630] queue_work_on+0x181/0x270
[ 154.396086][ T6630] rpm_suspend+0xe54/0x1720
[ 154.396103][ T6630] __pm_runtime_idle+0x12f/0x1a0
[ 154.396121][ T6630] __device_attach+0x342/0x400
[ 154.396141][ T6630] bus_probe_device+0x185/0x260
[ 154.396169][ T6630] device_add+0x7b6/0xb50
[ 154.396186][ T6630] serial_base_port_add+0x2f2/0x430
[ 154.396210][ T6630] serial_core_register_port+0x367/0x2700
[ 154.396239][ T6630] serial8250_register_8250_port+0x16db/0x2050
[ 154.396268][ T6630] serial_pnp_probe+0x527/0x790
[ 154.396304][ T6630] pnp_device_probe+0x30b/0x4c0
[ 154.396333][ T6630] really_probe+0x26a/0x9a0
[ 154.396355][ T6630] __driver_probe_device+0x18c/0x2f0
[ 154.396376][ T6630] driver_probe_device+0x4f/0x430
[ 154.396398][ T6630] __driver_attach+0x452/0x700
[ 154.396418][ T6630] bus_for_each_dev+0x230/0x2b0
[ 154.396445][ T6630] bus_add_driver+0x345/0x640
[ 154.396473][ T6630] driver_register+0x23a/0x320
[ 154.396496][ T6630] serial8250_init+0xc2/0x1c0
[ 154.396525][ T6630] do_one_initcall+0x233/0x820
[ 154.396542][ T6630] do_initcall_level+0x137/0x1f0
[ 154.396569][ T6630] do_initcalls+0x69/0xd0
[ 154.396595][ T6630] kernel_init_freeable+0x3d9/0x570
[ 154.396621][ T6630] kernel_init+0x1d/0x1d0
[ 154.396642][ T6630] ret_from_fork+0x3fc/0x770
[ 154.396667][ T6630] ret_from_fork_asm+0x1a/0x30
[ 154.396685][ T6630]
[ 154.396685][ T6630] -> #2 (&dev->power.lock){-.-.}-{3:3}:
[ 154.396714][ T6630] lock_acquire+0x120/0x360
[ 154.396738][ T6630] _raw_spin_lock_irqsave+0xa7/0xf0
[ 154.396764][ T6630] __pm_runtime_resume+0x10f/0x180
[ 154.396783][ T6630] __uart_start+0x171/0x440
[ 154.396812][ T6630] uart_write+0xdc/0x130
[ 154.396827][ T6630] n_tty_write+0xd35/0x11d0
[ 154.396851][ T6630] file_tty_write+0x500/0x990
[ 154.396880][ T6630] vfs_write+0x54b/0xa90
[ 154.396900][ T6630] ksys_write+0x145/0x250
[ 154.396920][ T6630] do_syscall_64+0xfa/0x3b0
[ 154.396936][ T6630] entry_SYSCALL_64_after_hwframe+0x77/0x7f
[ 154.396954][ T6630]
[ 154.396954][ T6630] -> #1 (&port_lock_key){-.-.}-{3:3}:
[ 154.396982][ T6630] lock_acquire+0x120/0x360
[ 154.397006][ T6630] _raw_spin_lock_irqsave+0xa7/0xf0
[ 154.397031][ T6630] serial8250_console_write+0x17e/0x1ba0
[ 154.397051][ T6630] console_flush_all+0x728/0xc40
[ 154.397070][ T6630] console_unlock+0xc4/0x270
[ 154.397099][ T6630] vprintk_emit+0x5b7/0x7a0
[ 154.397128][ T6630] _printk+0xcf/0x120
[ 154.397144][ T6630] register_console+0xa8b/0xf90
[ 154.397163][ T6630] univ8250_console_init+0x52/0x90
[ 154.397191][ T6630] console_init+0x1a1/0x670
[ 154.397221][ T6630] start_kernel+0x2cc/0x500
[ 154.397245][ T6630] x86_64_start_reservations+0x24/0x30
[ 154.397263][ T6630] x86_64_start_kernel+0x143/0x1c0
[ 154.397280][ T6630] common_startup_64+0x13e/0x147
[ 154.397307][ T6630]
[ 154.397307][ T6630] -> #0 (console_owner){....}-{0:0}:
[ 154.397335][ T6630] validate_chain+0xb9b/0x2140
[ 154.397364][ T6630] __lock_acquire+0xab9/0xd20
[ 154.397388][ T6630] lock_acquire+0x120/0x360
[ 154.397411][ T6630] console_flush_all+0x6d2/0xc40
[ 154.397429][ T6630] console_unlock+0xc4/0x270
[ 154.397457][ T6630] vprintk_emit+0x5b7/0x7a0
[ 154.397486][ T6630] _printk+0xcf/0x120
[ 154.397503][ T6630] __debug_object_init+0x2c8/0x3c0
[ 154.397522][ T6630] rhashtable_init_noprof+0x7c0/0xbb0
[ 154.397552][ T6630] bch2_copygc_thread+0x116/0xdc0
[ 154.397573][ T6630] kthread+0x70e/0x8a0
[ 154.397590][ T6630] ret_from_fork+0x3fc/0x770
[ 154.397614][ T6630] ret_from_fork_asm+0x1a/0x30
[ 154.397633][ T6630]
[ 154.397633][ T6630] other info that might help us debug this:
[ 154.397633][ T6630]
[ 154.397640][ T6630] Chain exists of:
[ 154.397640][ T6630] console_owner --> &pool->lock --> &obj_hash[i].lock
[ 154.397640][ T6630]
[ 154.397673][ T6630] Possible unsafe locking scenario:
[ 154.397673][ T6630]
[ 154.397679][ T6630] CPU0 CPU1
[ 154.397686][ T6630] ---- ----
[ 154.397692][ T6630] lock(&obj_hash[i].lock);
[ 154.397705][ T6630] lock(&pool->lock);
[ 154.397720][ T6630] lock(&obj_hash[i].lock);
[ 154.397735][ T6630] lock(console_owner);
[ 154.397749][ T6630]
[ 154.397749][ T6630] *** DEADLOCK ***
[ 154.397749][ T6630]
[ 154.397762][ T6630] 3 locks held by bch-copygc/loop/6630:
[ 154.397774][ T6630] #0: ffffffff99d26940 (&obj_hash[i].lock){-.-.}-{2:2}, at: __debug_object_init+0x85/0x3c0
[ 154.397824][ T6630] #1: ffffffff8e133020 (console_lock){+.+.}-{0:0}, at: _printk+0xcf/0x120
[ 154.397870][ T6630] #2: ffffffff8e01a8f0 (console_srcu){....}-{0:0}, at: console_flush_all+0x13a/0xc40
[ 154.397916][ T6630]
[ 154.397916][ T6630] stack backtrace:
[ 154.397936][ T6630] CPU: 1 UID: 0 PID: 6630 Comm: bch-copygc/loop Not tainted 6.16.0-rc1-syzkaller-00101-g27605c8c0f69 #0 PREEMPT(full)
[ 154.397960][ T6630] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 05/07/2025
[ 154.397977][ T6630] Call Trace:
[ 154.397989][ T6630]
[ 154.397998][ T6630] dump_stack_lvl+0x189/0x250
[ 154.398032][ T6630] ? __pfx_dump_stack_lvl+0x10/0x10
[ 154.398063][ T6630] ? __pfx__printk+0x10/0x10
[ 154.398084][ T6630] ? print_lock_name+0xde/0x100
[ 154.398119][ T6630] print_circular_bug+0x2ee/0x310
[ 154.398153][ T6630] check_noncircular+0x134/0x160
[ 154.398188][ T6630] validate_chain+0xb9b/0x2140
[ 154.398230][ T6630] __lock_acquire+0xab9/0xd20
[ 154.398260][ T6630] ? console_flush_all+0x13a/0xc40
[ 154.398280][ T6630] lock_acquire+0x120/0x360
[ 154.398311][ T6630] ? console_flush_all+0x13a/0xc40
[ 154.398335][ T6630] ? do_raw_spin_unlock+0x122/0x240
[ 154.398357][ T6630] ? console_flush_all+0x13a/0xc40
[ 154.398378][ T6630] console_flush_all+0x6d2/0xc40
[ 154.398398][ T6630] ? console_flush_all+0x13a/0xc40
[ 154.398420][ T6630] ? console_flush_all+0x13a/0xc40
[ 154.398443][ T6630] ? __pfx_console_flush_all+0x10/0x10
[ 154.398469][ T6630] ? is_printk_cpu_sync_owner+0x32/0x40
[ 154.398494][ T6630] console_unlock+0xc4/0x270
[ 154.398527][ T6630] ? __pfx_console_unlock+0x10/0x10
[ 154.398560][ T6630] ? is_printk_cpu_sync_owner+0x32/0x40
[ 154.398586][ T6630] vprintk_emit+0x5b7/0x7a0
[ 154.398619][ T6630] ? __pfx_vprintk_emit+0x10/0x10
[ 154.398650][ T6630] ? __lock_acquire+0xab9/0xd20
[ 154.398680][ T6630] ? do_raw_spin_lock+0x121/0x290
[ 154.398704][ T6630] _printk+0xcf/0x120
[ 154.398726][ T6630] ? __pfx__printk+0x10/0x10
[ 154.398752][ T6630] __debug_object_init+0x2c8/0x3c0
[ 154.398775][ T6630] ? rhashtable_init_noprof+0x4ee/0xbb0
[ 154.398808][ T6630] rhashtable_init_noprof+0x7c0/0xbb0
[ 154.398842][ T6630] bch2_copygc_thread+0x116/0xdc0
[ 154.398867][ T6630] ? rcu_read_lock_sched_held+0x89/0x100
[ 154.398899][ T6630] ? __pfx_rcu_read_lock_sched_held+0x10/0x10
[ 154.398932][ T6630] ? arch_scale_cpu_capacity+0x18/0xb0
[ 154.398966][ T6630] ? __pfx_bch2_copygc_thread+0x10/0x10
[ 154.399010][ T6630] ? finish_task_switch+0x266/0x950
[ 154.399035][ T6630] ? lockdep_hardirqs_on+0x9c/0x150
[ 154.399075][ T6630] ? __pfx_rhashtable_jhash2+0x10/0x10
[ 154.399124][ T6630] ? __kthread_parkme+0x7b/0x200
[ 154.399155][ T6630] ? __kthread_parkme+0x1a1/0x200
[ 154.399189][ T6630] kthread+0x70e/0x8a0
[ 154.399210][ T6630] ? __pfx_bch2_copygc_thread+0x10/0x10
[ 154.399234][ T6630] ? __pfx_kthread+0x10/0x10
[ 154.399255][ T6630] ? _raw_spin_unlock_irq+0x23/0x50
[ 154.399283][ T6630] ? lockdep_hardirqs_on+0x9c/0x150
[ 154.399320][ T6630] ? __pfx_kthread+0x10/0x10
[ 154.399340][ T6630] ret_from_fork+0x3fc/0x770
[ 154.399366][ T6630] ? __pfx_ret_from_fork+0x10/0x10
[ 154.399394][ T6630] ? __switch_to_asm+0x39/0x70
[ 154.399412][ T6630] ? __switch_to_asm+0x33/0x70
[ 154.399430][ T6630] ? __pfx_kthread+0x10/0x10
[ 154.399451][ T6630] ret_from_fork_asm+0x1a/0x30
[ 154.399479][ T6630]
[ 155.356230][ T6630] ------------[ cut here ]------------
[ 155.361716][ T6630] WARNING: CPU: 1 PID: 6630 at lib/debugobjects.c:655 __debug_object_init+0x2c9/0x3c0
[ 155.371293][ T6630] Modules linked in:
[ 155.375217][ T6630] CPU: 1 UID: 0 PID: 6630 Comm: bch-copygc/loop Not tainted 6.16.0-rc1-syzkaller-00101-g27605c8c0f69 #0 PREEMPT(full)
[ 155.387665][ T6630] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 05/07/2025
[ 155.397744][ T6630] RIP: 0010:__debug_object_init+0x2c9/0x3c0
[ 155.403659][ T6630] Code: cc cc cc 41 ff c7 44 89 3d f4 2b 17 15 48 c7 c1 00 b8 e1 8b 48 c7 c7 60 b8 e1 8b 84 c0 48 0f 45 f9 48 89 de e8 28 3c 67 fc 90 <0f> 0b 90 e9 c0 fe ff ff e8 3a 1c 00 00 8b 05 0c 67 cb 09 3b 05 0a
[ 155.423290][ T6630] RSP: 0018:ffffc900039ff6e0 EFLAGS: 00010046
[ 155.429375][ T6630] RAX: 0000000000000050 RBX: ffffc900039ffb90 RCX: 28e80f28d7ec0b00
[ 155.437365][ T6630] RDX: 0000000000000000 RSI: 0000000080000001 RDI: 0000000000000000
[ 155.445349][ T6630] RBP: ffff88803092da20 R08: ffff8880b8724293 R09: 1ffff110170e4852
[ 155.453363][ T6630] R10: dffffc0000000000 R11: ffffed10170e4853 R12: 0000000000000040
[ 155.461348][ T6630] R13: ffff8880331b4700 R14: dffffc0000000000 R15: 0000000000000001
[ 155.469358][ T6630] FS: 0000000000000000(0000) GS:ffff888125d86000(0000) knlGS:0000000000000000
[ 155.478306][ T6630] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 155.484997][ T6630] CR2: 00007ffdac653c9c CR3: 0000000078e02000 CR4: 00000000003526f0
[ 155.493074][ T6630] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[ 155.501063][ T6630] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
[ 155.509073][ T6630] Call Trace:
[ 155.512550][ T6630]
[ 155.515516][ T6630] ? rhashtable_init_noprof+0x4ee/0xbb0
[ 155.521183][ T6630] rhashtable_init_noprof+0x7c0/0xbb0
[ 155.526583][ T6630] bch2_copygc_thread+0x116/0xdc0
[ 155.531628][ T6630] ? rcu_read_lock_sched_held+0x89/0x100
[ 155.537289][ T6630] ? __pfx_rcu_read_lock_sched_held+0x10/0x10
[ 155.543470][ T6630] ? arch_scale_cpu_capacity+0x18/0xb0
[ 155.548967][ T6630] ? __pfx_bch2_copygc_thread+0x10/0x10
[ 155.554551][ T6630] ? finish_task_switch+0x266/0x950
[ 155.559769][ T6630] ? lockdep_hardirqs_on+0x9c/0x150
[ 155.565007][ T6630] ? __pfx_rhashtable_jhash2+0x10/0x10
[ 155.570532][ T6630] ? __kthread_parkme+0x7b/0x200
[ 155.575507][ T6630] ? __kthread_parkme+0x1a1/0x200
[ 155.580566][ T6630] kthread+0x70e/0x8a0
[ 155.584664][ T6630] ? __pfx_bch2_copygc_thread+0x10/0x10
[ 155.590249][ T6630] ? __pfx_kthread+0x10/0x10
[ 155.594953][ T6630] ? _raw_spin_unlock_irq+0x23/0x50
[ 155.600178][ T6630] ? lockdep_hardirqs_on+0x9c/0x150
[ 155.605487][ T6630] ? __pfx_kthread+0x10/0x10
[ 155.610089][ T6630] ret_from_fork+0x3fc/0x770
[ 155.614703][ T6630] ? __pfx_ret_from_fork+0x10/0x10
[ 155.619846][ T6630] ? __switch_to_asm+0x39/0x70
[ 155.624622][ T6630] ? __switch_to_asm+0x33/0x70
[ 155.629402][ T6630] ? __pfx_kthread+0x10/0x10
[ 155.634004][ T6630] ret_from_fork_asm+0x1a/0x30
[ 155.638789][ T6630]
[ 155.641840][ T6630] Kernel panic - not syncing: kernel: panic_on_warn set ...
[ 155.649134][ T6630] CPU: 1 UID: 0 PID: 6630 Comm: bch-copygc/loop Not tainted 6.16.0-rc1-syzkaller-00101-g27605c8c0f69 #0 PREEMPT(full)
[ 155.661564][ T6630] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 05/07/2025
[ 155.671635][ T6630] Call Trace:
[ 155.675021][ T6630]
[ 155.677967][ T6630] dump_stack_lvl+0x99/0x250
[ 155.682586][ T6630] ? __asan_memcpy+0x40/0x70
[ 155.687207][ T6630] ? __pfx_dump_stack_lvl+0x10/0x10
[ 155.692426][ T6630] ? __pfx__printk+0x10/0x10
[ 155.697061][ T6630] panic+0x2db/0x790
[ 155.701001][ T6630] ? __pfx_panic+0x10/0x10
[ 155.705460][ T6630] ? show_trace_log_lvl+0x4fb/0x550
[ 155.710705][ T6630] ? ret_from_fork_asm+0x1a/0x30
[ 155.715790][ T6630] __warn+0x31b/0x4b0
[ 155.719826][ T6630] ? __debug_object_init+0x2c9/0x3c0
[ 155.725127][ T6630] ? __debug_object_init+0x2c9/0x3c0
[ 155.730430][ T6630] report_bug+0x2be/0x4f0
[ 155.734792][ T6630] ? __debug_object_init+0x2c9/0x3c0
[ 155.740095][ T6630] ? __debug_object_init+0x2c9/0x3c0
[ 155.745490][ T6630] ? __debug_object_init+0x2cb/0x3c0
[ 155.750870][ T6630] handle_bug+0x84/0x160
[ 155.755152][ T6630] exc_invalid_op+0x1a/0x50
[ 155.759672][ T6630] asm_exc_invalid_op+0x1a/0x20
[ 155.764538][ T6630] RIP: 0010:__debug_object_init+0x2c9/0x3c0
[ 155.770452][ T6630] Code: cc cc cc 41 ff c7 44 89 3d f4 2b 17 15 48 c7 c1 00 b8 e1 8b 48 c7 c7 60 b8 e1 8b 84 c0 48 0f 45 f9 48 89 de e8 28 3c 67 fc 90 <0f> 0b 90 e9 c0 fe ff ff e8 3a 1c 00 00 8b 05 0c 67 cb 09 3b 05 0a
[ 155.790081][ T6630] RSP: 0018:ffffc900039ff6e0 EFLAGS: 00010046
[ 155.796175][ T6630] RAX: 0000000000000050 RBX: ffffc900039ffb90 RCX: 28e80f28d7ec0b00
[ 155.804253][ T6630] RDX: 0000000000000000 RSI: 0000000080000001 RDI: 0000000000000000
[ 155.812240][ T6630] RBP: ffff88803092da20 R08: ffff8880b8724293 R09: 1ffff110170e4852
[ 155.820235][ T6630] R10: dffffc0000000000 R11: ffffed10170e4853 R12: 0000000000000040
[ 155.828329][ T6630] R13: ffff8880331b4700 R14: dffffc0000000000 R15: 0000000000000001
[ 155.836369][ T6630] ? rhashtable_init_noprof+0x4ee/0xbb0
[ 155.841971][ T6630] rhashtable_init_noprof+0x7c0/0xbb0
[ 155.847373][ T6630] bch2_copygc_thread+0x116/0xdc0
[ 155.852421][ T6630] ? rcu_read_lock_sched_held+0x89/0x100
[ 155.858079][ T6630] ? __pfx_rcu_read_lock_sched_held+0x10/0x10
[ 155.864178][ T6630] ? arch_scale_cpu_capacity+0x18/0xb0
[ 155.869665][ T6630] ? __pfx_bch2_copygc_thread+0x10/0x10
[ 155.875254][ T6630] ? finish_task_switch+0x266/0x950
[ 155.880479][ T6630] ? lockdep_hardirqs_on+0x9c/0x150
[ 155.885712][ T6630] ? __pfx_rhashtable_jhash2+0x10/0x10
[ 155.891249][ T6630] ? __kthread_parkme+0x7b/0x200
[ 155.896305][ T6630] ? __kthread_parkme+0x1a1/0x200
[ 155.901358][ T6630] kthread+0x70e/0x8a0
[ 155.905454][ T6630] ? __pfx_bch2_copygc_thread+0x10/0x10
[ 155.911029][ T6630] ? __pfx_kthread+0x10/0x10
[ 155.915636][ T6630] ? _raw_spin_unlock_irq+0x23/0x50
[ 155.920870][ T6630] ? lockdep_hardirqs_on+0x9c/0x150
[ 155.926137][ T6630] ? __pfx_kthread+0x10/0x10
[ 155.930743][ T6630] ret_from_fork+0x3fc/0x770
[ 155.935357][ T6630] ? __pfx_ret_from_fork+0x10/0x10
[ 155.940513][ T6630] ? __switch_to_asm+0x39/0x70
[ 155.945395][ T6630] ? __switch_to_asm+0x33/0x70
[ 155.950258][ T6630] ? __pfx_kthread+0x10/0x10
[ 155.954864][ T6630] ret_from_fork_asm+0x1a/0x30
[ 155.959649][ T6630]
[ 155.963061][ T6630] Kernel Offset: disabled
[ 155.967434][ T6630] Rebooting in 86400 seconds..