[ 16.064438][ C2] [ 16.064636][ C2] ================================ [ 16.064809][ C2] WARNING: inconsistent lock state [ 16.064986][ C2] 6.15.0-virtme #1 Not tainted [ 16.065158][ C2] -------------------------------- [ 16.065327][ C2] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 16.065537][ C2] ksoftirqd/2/27 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 16.065751][ C2] ffffffff92dc5af8 (pin_fs_lock){+.?.}-{3:3}, at: simple_pin_fs+0x24/0x150 [ 16.066056][ C2] {SOFTIRQ-ON-W} state was registered at: [ 16.066223][ C2] __lock_acquire+0x20b/0x7e0 [ 16.066397][ C2] lock_acquire.part.0+0xb6/0x240 [ 16.066567][ C2] _raw_spin_lock+0x33/0x40 [ 16.066737][ C2] simple_pin_fs+0x24/0x150 [ 16.066906][ C2] start_creating.part.0+0x52/0x310 [ 16.067077][ C2] debugfs_create_dir+0x6a/0x540 [ 16.067245][ C2] component_debug_init+0x17/0x30 [ 16.067416][ C2] do_one_initcall+0x8f/0x1e0 [ 16.067589][ C2] do_initcalls+0x176/0x280 [ 16.067762][ C2] kernel_init_freeable+0x22d/0x300 [ 16.067932][ C2] kernel_init+0x20/0x200 [ 16.068104][ C2] ret_from_fork+0x240/0x320 [ 16.068277][ C2] ret_from_fork_asm+0x1a/0x30 [ 16.068450][ C2] irq event stamp: 196754 [ 16.068578][ C2] hardirqs last enabled at (196754): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 16.068916][ C2] hardirqs last disabled at (196753): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 16.069255][ C2] softirqs last enabled at (195408): [] handle_softirqs+0x358/0x620 [ 16.069553][ C2] softirqs last disabled at (195419): [] run_ksoftirqd+0x3f/0x70 [ 16.069852][ C2] [ 16.069852][ C2] other info that might help us debug this: [ 16.070104][ C2] Possible unsafe locking scenario: [ 16.070104][ C2] [ 16.070354][ C2] CPU0 [ 16.070484][ C2] ---- [ 16.070614][ C2] lock(pin_fs_lock); [ 16.070748][ C2] [ 16.070879][ C2] lock(pin_fs_lock); [ 16.071008][ C2] [ 16.071008][ C2] *** DEADLOCK *** [ 16.071008][ C2] [ 16.071274][ C2] 1 lock held by ksoftirqd/2/27: [ 16.071452][ C2] #0: ffffffff92b774c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 16.071772][ C2] [ 16.071772][ C2] stack backtrace: [ 16.071995][ C2] CPU: 2 UID: 0 PID: 27 Comm: ksoftirqd/2 Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 16.072000][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 16.072002][ C2] Call Trace: [ 16.072004][ C2] [ 16.072006][ C2] dump_stack_lvl+0x82/0xd0 [ 16.072012][ C2] print_usage_bug.part.0+0x25f/0x360 [ 16.072017][ C2] mark_lock_irq+0x343/0x400 [ 16.072021][ C2] ? __pfx_unwind_next_frame+0x10/0x10 [ 16.072026][ C2] ? save_trace+0x52/0x170 [ 16.072033][ C2] mark_lock+0x174/0x2f0 [ 16.072036][ C2] mark_usage+0x46/0x150 [ 16.072039][ C2] __lock_acquire+0x20b/0x7e0 [ 16.072043][ C2] ? __lock_acquire+0x44d/0x7e0 [ 16.072047][ C2] lock_acquire.part.0+0xb6/0x240 [ 16.072050][ C2] ? simple_pin_fs+0x24/0x150 [ 16.072054][ C2] ? rcu_is_watching+0x12/0xc0 [ 16.072058][ C2] ? lock_acquire+0x10c/0x170 [ 16.072060][ C2] ? simple_pin_fs+0x24/0x150 [ 16.072065][ C2] _raw_spin_lock+0x33/0x40 [ 16.072068][ C2] ? simple_pin_fs+0x24/0x150 [ 16.072071][ C2] simple_pin_fs+0x24/0x150 [ 16.072076][ C2] debugfs_remove+0x35/0x70 [ 16.072079][ C2] ref_tracker_dir_exit+0xcf/0x740 [ 16.072085][ C2] ? __pfx_ref_tracker_free+0x10/0x10 [ 16.072089][ C2] ? __sk_destruct+0x383/0x780 [ 16.072094][ C2] ? rcu_do_batch+0x34c/0xf20 [ 16.072097][ C2] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 16.072100][ C2] ? smpboot_thread_fn+0x30a/0x960 [ 16.072105][ C2] ? kthread+0x37e/0x600 [ 16.072107][ C2] ? ret_from_fork+0x240/0x320 [ 16.072110][ C2] ? ret_from_fork_asm+0x1a/0x30 [ 16.072113][ C2] ? migrate_enable+0x1f2/0x270 [ 16.072117][ C2] ? __pfx_migrate_enable+0x10/0x10 [ 16.072123][ C2] __put_net+0x19/0x60 [ 16.072126][ C2] __sk_destruct+0x58a/0x780 [ 16.072130][ C2] ? rcu_do_batch+0x34a/0xf20 [ 16.072133][ C2] rcu_do_batch+0x34c/0xf20 [ 16.072138][ C2] ? __pfx_rcu_do_batch+0x10/0x10 [ 16.072141][ C2] ? rcu_is_watching+0x12/0xc0 [ 16.072144][ C2] ? note_gp_changes+0x182/0x1e0 [ 16.072147][ C2] ? lockdep_hardirqs_on+0x7c/0x110 [ 16.072151][ C2] rcu_core+0x2bb/0x500 [ 16.072155][ C2] handle_softirqs+0x218/0x620 [ 16.072159][ C2] ? __pfx_run_ksoftirqd+0x10/0x10 [ 16.072163][ C2] run_ksoftirqd+0x3f/0x70 [ 16.072166][ C2] smpboot_thread_fn+0x30a/0x960 [ 16.072169][ C2] ? __pfx_smpboot_thread_fn+0x10/0x10 [ 16.072173][ C2] kthread+0x37e/0x600 [ 16.072176][ C2] ? __pfx_kthread+0x10/0x10 [ 16.072178][ C2] ? ret_from_fork+0x1b/0x320 [ 16.072180][ C2] ? __lock_release+0x5d/0x170 [ 16.072184][ C2] ? rcu_is_watching+0x12/0xc0 [ 16.072187][ C2] ? __pfx_kthread+0x10/0x10 [ 16.072190][ C2] ret_from_fork+0x240/0x320 [ 16.072192][ C2] ? __pfx_kthread+0x10/0x10 [ 16.072195][ C2] ret_from_fork_asm+0x1a/0x30 [ 16.072202][ C2] [ 16.082175][ C2] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 16.082493][ C2] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 27, name: ksoftirqd/2 [ 16.082788][ C2] preempt_count: 100, expected: 0 [ 16.082963][ C2] RCU nest depth: 0, expected: 0 [ 16.083140][ C2] INFO: lockdep is turned off. [ 16.083337][ C2] Preemption disabled at: [ 16.083339][ C2] [] handle_softirqs+0xe5/0x620 [ 16.083702][ C2] CPU: 2 UID: 0 PID: 27 Comm: ksoftirqd/2 Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 16.083706][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 16.083708][ C2] Call Trace: [ 16.083710][ C2] [ 16.083712][ C2] dump_stack_lvl+0xb0/0xd0 [ 16.083718][ C2] __might_resched+0x360/0x5a0 [ 16.083725][ C2] down_write+0x72/0x210 [ 16.083729][ C2] ? __pfx_down_write+0x10/0x10 [ 16.083733][ C2] ? simple_recursive_removal+0x33/0x610 [ 16.083736][ C2] ? rcu_is_watching+0x12/0xc0 [ 16.083741][ C2] ? do_raw_spin_unlock+0x58/0x220 [ 16.083746][ C2] simple_recursive_removal+0x6a/0x610 [ 16.083749][ C2] ? do_raw_spin_unlock+0x58/0x220 [ 16.083752][ C2] ? __pfx_remove_one+0x10/0x10 [ 16.083757][ C2] debugfs_remove+0x44/0x70 [ 16.083760][ C2] ref_tracker_dir_exit+0xcf/0x740 [ 16.083765][ C2] ? __pfx_ref_tracker_free+0x10/0x10 [ 16.083769][ C2] ? __sk_destruct+0x383/0x780 [ 16.083773][ C2] ? rcu_do_batch+0x34c/0xf20 [ 16.083776][ C2] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 16.083779][ C2] ? smpboot_thread_fn+0x30a/0x960 [ 16.083783][ C2] ? kthread+0x37e/0x600 [ 16.083786][ C2] ? ret_from_fork+0x240/0x320 [ 16.083789][ C2] ? ret_from_fork_asm+0x1a/0x30 [ 16.083794][ C2] ? migrate_enable+0x1f2/0x270 [ 16.083798][ C2] ? __pfx_migrate_enable+0x10/0x10 [ 16.083803][ C2] __put_net+0x19/0x60 [ 16.083806][ C2] __sk_destruct+0x58a/0x780 [ 16.083810][ C2] ? rcu_do_batch+0x34a/0xf20 [ 16.083812][ C2] rcu_do_batch+0x34c/0xf20 [ 16.083817][ C2] ? __pfx_rcu_do_batch+0x10/0x10 [ 16.083821][ C2] ? rcu_is_watching+0x12/0xc0 [ 16.083823][ C2] ? note_gp_changes+0x182/0x1e0 [ 16.083826][ C2] ? lockdep_hardirqs_on+0x7c/0x110 [ 16.083830][ C2] rcu_core+0x2bb/0x500 [ 16.083834][ C2] handle_softirqs+0x218/0x620 [ 16.083838][ C2] ? __pfx_run_ksoftirqd+0x10/0x10 [ 16.083842][ C2] run_ksoftirqd+0x3f/0x70 [ 16.083845][ C2] smpboot_thread_fn+0x30a/0x960 [ 16.083848][ C2] ? __pfx_smpboot_thread_fn+0x10/0x10 [ 16.083853][ C2] kthread+0x37e/0x600 [ 16.083855][ C2] ? __pfx_kthread+0x10/0x10 [ 16.083857][ C2] ? ret_from_fork+0x1b/0x320 [ 16.083860][ C2] ? __lock_release+0x5d/0x170 [ 16.083864][ C2] ? rcu_is_watching+0x12/0xc0 [ 16.083867][ C2] ? __pfx_kthread+0x10/0x10 [ 16.083870][ C2] ret_from_fork+0x240/0x320 [ 16.083873][ C2] ? __pfx_kthread+0x10/0x10 [ 16.083875][ C2] ret_from_fork_asm+0x1a/0x30 [ 16.083883][ C2] [ 18.399728][ C3] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 18.400193][ C3] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 214, name: sh [ 18.400510][ C3] preempt_count: 100, expected: 0 [ 18.400716][ C3] RCU nest depth: 1, expected: 0 [ 18.400921][ C3] INFO: lockdep is turned off. [ 18.401125][ C3] Preemption disabled at: [ 18.401126][ C3] [] handle_softirqs+0xe5/0x620 [ 18.401551][ C3] CPU: 3 UID: 0 PID: 214 Comm: sh Tainted: G W 6.15.0-virtme #1 PREEMPT(full) [ 18.401557][ C3] Tainted: [W]=WARN [ 18.401558][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 18.401560][ C3] Call Trace: [ 18.401562][ C3] [ 18.401564][ C3] dump_stack_lvl+0xb0/0xd0 [ 18.401571][ C3] __might_resched+0x360/0x5a0 [ 18.401578][ C3] down_write+0x72/0x210 [ 18.401582][ C3] ? __pfx_down_write+0x10/0x10 [ 18.401585][ C3] ? simple_recursive_removal+0x33/0x610 [ 18.401590][ C3] ? rcu_is_watching+0x12/0xc0 [ 18.401595][ C3] ? do_raw_spin_unlock+0x58/0x220 [ 18.401601][ C3] simple_recursive_removal+0x6a/0x610 [ 18.401603][ C3] ? do_raw_spin_unlock+0x58/0x220 [ 18.401606][ C3] ? __pfx_remove_one+0x10/0x10 [ 18.401612][ C3] debugfs_remove+0x44/0x70 [ 18.401615][ C3] ref_tracker_dir_exit+0xcf/0x740 [ 18.401621][ C3] ? __pfx_ref_tracker_free+0x10/0x10 [ 18.401625][ C3] ? __sk_destruct+0x383/0x780 [ 18.401630][ C3] ? rcu_do_batch+0x34c/0xf20 [ 18.401634][ C3] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 18.401637][ C3] ? irq_exit_rcu+0xe/0x30 [ 18.401640][ C3] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 18.401645][ C3] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 18.401648][ C3] ? __pfx___rcu_read_unlock+0x10/0x10 [ 18.401651][ C3] ? unwind_next_frame+0x4f8/0x1e10 [ 18.401655][ C3] ? __unwind_start+0x52b/0x800 [ 18.401657][ C3] ? arch_stack_walk+0x67/0xf0 [ 18.401663][ C3] ? stack_trace_save+0x93/0xd0 [ 18.401665][ C3] ? kasan_save_stack+0x24/0x50 [ 18.401670][ C3] ? kasan_save_track+0x14/0x30 [ 18.401673][ C3] ? kasan_save_free_info+0x3b/0x60 [ 18.401677][ C3] ? bpf_sk_storage_free+0x9f/0x1c0 [ 18.401681][ C3] ? rcu_is_watching+0x12/0xc0 [ 18.401685][ C3] __put_net+0x19/0x60 [ 18.401689][ C3] __sk_destruct+0x58a/0x780 [ 18.401694][ C3] ? rcu_do_batch+0x34a/0xf20 [ 18.401696][ C3] rcu_do_batch+0x34c/0xf20 [ 18.401700][ C3] ? __pfx_rcu_do_batch+0x10/0x10 [ 18.401704][ C3] ? rcu_is_watching+0x12/0xc0 [ 18.401707][ C3] ? trace_irq_enable.constprop.0+0xd4/0x130 [ 18.401714][ C3] rcu_core+0x2bb/0x500 [ 18.401718][ C3] handle_softirqs+0x218/0x620 [ 18.401723][ C3] __irq_exit_rcu+0xfa/0x160 [ 18.401726][ C3] irq_exit_rcu+0xe/0x30 [ 18.401729][ C3] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 18.401733][ C3] [ 18.401734][ C3] [ 18.401735][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 18.401738][ C3] RIP: 0010:__rcu_read_unlock+0x0/0x160 [ 18.401742][ C3] Code: 00 00 00 4c 89 e7 e8 6f f3 68 00 e9 6f fe ff ff 66 2e 0f 1f 84 00 00 00 00 00 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 0f 1e fa 0f 1f 44 00 00 41 54 55 65 48 8b 2d a4 f7 09 05 53 48 [ 18.401744][ C3] RSP: 0018:ffffc900005f75b0 EFLAGS: 00000246 [ 18.401748][ C3] RAX: 0000000000000001 RBX: 1ffff920000beec0 RCX: ffffc900005f8001 [ 18.401750][ C3] RDX: 0000000000000000 RSI: ffffffff91e53b60 RDI: ffffffff926e7e38 [ 18.401752][ C3] RBP: ffffc900005f7708 R08: 0000000000000000 R09: ffffc900005f7749 [ 18.401753][ C3] R10: ffffffff8f212687 R11: ffffc900005f7748 R12: ffffc900005f7701 [ 18.401755][ C3] R13: ffffc900005f7708 R14: ffffc900005f0000 R15: ffffc900005f7700 [ 18.401758][ C3] ? unwind_next_frame+0x147/0x1e10 [ 18.401763][ C3] unwind_next_frame+0x4f8/0x1e10 [ 18.401766][ C3] ? __unwind_start+0x5a7/0x800 [ 18.401770][ C3] ? __pfx_unwind_next_frame+0x10/0x10 [ 18.401773][ C3] ? rcu_is_watching+0x12/0xc0 [ 18.401776][ C3] ? is_bpf_text_address+0x67/0x120 [ 18.401780][ C3] ? rcu_is_watching+0x12/0xc0 [ 18.401783][ C3] ? trace_lock_release+0x2a/0xd0 [ 18.401788][ C3] ? get_stack_info_noinstr+0x18/0x120 [ 18.401793][ C3] __unwind_start+0x52b/0x800 [ 18.401796][ C3] ? unwind_get_return_address+0x5e/0xa0 [ 18.401799][ C3] ? __pfx_stack_trace_consume_entry+0x10/0x10 [ 18.401802][ C3] arch_stack_walk+0x67/0xf0 [ 18.401808][ C3] ? arch_stack_walk+0x67/0xf0 [ 18.401812][ C3] stack_trace_save+0x93/0xd0 [ 18.401815][ C3] ? __pfx_stack_trace_save+0x10/0x10 [ 18.401817][ C3] ? stack_depot_save_flags+0x15a/0x7a0 [ 18.401822][ C3] ? kasan_save_stack+0x34/0x50 [ 18.401825][ C3] ? kasan_save_stack+0x24/0x50 [ 18.401828][ C3] kasan_save_stack+0x24/0x50 [ 18.401830][ C3] ? unlink_anon_vmas+0x167/0x920 [ 18.401834][ C3] ? free_pgtables+0xbd/0x6e0 [ 18.401838][ C3] ? exit_mmap+0x30d/0x800 [ 18.401842][ C3] ? mmput+0xb8/0x3f0 [ 18.401845][ C3] ? exit_mm+0x146/0x1d0 [ 18.401849][ C3] ? do_exit+0x433/0xc20 [ 18.401852][ C3] ? do_group_exit+0xb8/0x260 [ 18.401855][ C3] ? __x64_sys_exit_group+0x3e/0x50 [ 18.401858][ C3] ? x64_sys_call+0xf76/0x18a0 [ 18.401864][ C3] ? do_raw_spin_lock+0x130/0x270 [ 18.401868][ C3] ? __pfx_do_raw_spin_lock+0x10/0x10 [ 18.401871][ C3] ? rcu_is_watching+0x12/0xc0 [ 18.401875][ C3] ? rcu_is_watching+0x12/0xc0 [ 18.401878][ C3] ? trace_irq_enable.constprop.0+0xd4/0x130 [ 18.401882][ C3] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 18.401887][ C3] ? __debug_check_no_obj_freed+0x252/0x520 [ 18.401892][ C3] ? __pfx___debug_check_no_obj_freed+0x10/0x10 [ 18.401896][ C3] ? trace_rcu_segcb_stats+0x106/0x220 [ 18.401901][ C3] ? rcu_is_watching+0x12/0xc0 [ 18.401904][ C3] ? trace_irq_enable.constprop.0+0xd4/0x130 [ 18.401908][ C3] kasan_save_track+0x14/0x30 [ 18.401911][ C3] kasan_save_free_info+0x3b/0x60 [ 18.401913][ C3] __kasan_slab_free+0x38/0x50 [ 18.401917][ C3] kmem_cache_free+0x149/0x330 [ 18.401922][ C3] ? __rb_erase_color+0x38a/0xd90 [ 18.401925][ C3] ? __pfx___anon_vma_interval_tree_augment_rotate+0x10/0x10 [ 18.401928][ C3] ? unlink_anon_vmas+0x167/0x920 [ 18.401932][ C3] unlink_anon_vmas+0x167/0x920 [ 18.401935][ C3] ? rcu_is_watching+0x12/0xc0 [ 18.401939][ C3] free_pgtables+0xbd/0x6e0 [ 18.401944][ C3] ? __pfx_free_pgtables+0x10/0x10 [ 18.401947][ C3] ? lock_acquire+0x10c/0x170 [ 18.401950][ C3] ? exit_mmap+0x190/0x800 [ 18.401954][ C3] ? down_write+0x152/0x210 [ 18.401957][ C3] ? __pfx_down_write+0x10/0x10 [ 18.401960][ C3] ? rcu_is_watching+0x12/0xc0 [ 18.401963][ C3] ? trace_lock_release+0x2a/0xd0 [ 18.401967][ C3] exit_mmap+0x30d/0x800 [ 18.401972][ C3] ? __pfx_exit_mmap+0x10/0x10 [ 18.401976][ C3] ? __mutex_lock+0x19c/0xcd0 [ 18.401980][ C3] ? lock_release+0x13/0xc0 [ 18.401983][ C3] ? __mutex_unlock_slowpath+0x144/0x400 [ 18.401991][ C3] mmput+0xb8/0x3f0 [ 18.401994][ C3] exit_mm+0x146/0x1d0 [ 18.401998][ C3] do_exit+0x433/0xc20 [ 18.402002][ C3] do_group_exit+0xb8/0x260 [ 18.402006][ C3] __x64_sys_exit_group+0x3e/0x50 [ 18.402010][ C3] x64_sys_call+0xf76/0x18a0 [ 18.402013][ C3] do_syscall_64+0xc1/0x380 [ 18.402016][ C3] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 18.402019][ C3] RIP: 0033:0x7f11561cfabd [ 18.402022][ C3] Code: Unable to access opcode bytes at 0x7f11561cfa93. [ 18.402023][ C3] RSP: 002b:00007ffcb22acd48 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 18.402026][ C3] RAX: ffffffffffffffda RBX: 00007f11562ac9c0 RCX: 00007f11561cfabd [ 18.402028][ C3] RDX: 00000000000000e7 RSI: ffffffffffffff80 RDI: 0000000000000000 [ 18.402030][ C3] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000030 [ 18.402031][ C3] R10: 00007ffcb22acbd0 R11: 0000000000000246 R12: 00007f11562ac9c0 [ 18.402033][ C3] R13: 00007f11562b1ee0 R14: 0000000000000001 R15: 00007f11562b1ec8 [ 18.402038][ C3]