[ 15.229530][ C1] [ 15.229659][ C1] ================================ [ 15.229836][ C1] WARNING: inconsistent lock state [ 15.230011][ C1] 6.15.0-virtme #1 Not tainted [ 15.230186][ C1] -------------------------------- [ 15.230362][ C1] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 15.230581][ C1] ksoftirqd/1/22 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 15.230804][ C1] ffffffff8adc5af8 (pin_fs_lock){+.?.}-{3:3}, at: simple_pin_fs+0x24/0x150 [ 15.231119][ C1] {SOFTIRQ-ON-W} state was registered at: [ 15.231292][ C1] __lock_acquire+0x20b/0x7e0 [ 15.231473][ C1] lock_acquire.part.0+0xb6/0x240 [ 15.231646][ C1] _raw_spin_lock+0x33/0x40 [ 15.231824][ C1] simple_pin_fs+0x24/0x150 [ 15.231998][ C1] start_creating.part.0+0x52/0x310 [ 15.232175][ C1] debugfs_create_dir+0x6a/0x540 [ 15.232346][ C1] component_debug_init+0x17/0x30 [ 15.232525][ C1] do_one_initcall+0x8f/0x1e0 [ 15.232702][ C1] do_initcalls+0x176/0x280 [ 15.232878][ C1] kernel_init_freeable+0x22d/0x300 [ 15.233054][ C1] kernel_init+0x20/0x200 [ 15.233228][ C1] ret_from_fork+0x240/0x320 [ 15.233402][ C1] ret_from_fork_asm+0x1a/0x30 [ 15.233578][ C1] irq event stamp: 312776 [ 15.233708][ C1] hardirqs last enabled at (312776): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.234056][ C1] hardirqs last disabled at (312775): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 15.234409][ C1] softirqs last enabled at (312256): [] handle_softirqs+0x358/0x620 [ 15.234711][ C1] softirqs last disabled at (312261): [] run_ksoftirqd+0x3f/0x70 [ 15.235017][ C1] [ 15.235017][ C1] other info that might help us debug this: [ 15.235274][ C1] Possible unsafe locking scenario: [ 15.235274][ C1] [ 15.235528][ C1] CPU0 [ 15.235659][ C1] ---- [ 15.235786][ C1] lock(pin_fs_lock); [ 15.235918][ C1] [ 15.236049][ C1] lock(pin_fs_lock); [ 15.236182][ C1] [ 15.236182][ C1] *** DEADLOCK *** [ 15.236182][ C1] [ 15.236440][ C1] 1 lock held by ksoftirqd/1/22: [ 15.236615][ C1] #0: ffffffff8ab774c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 15.236932][ C1] [ 15.236932][ C1] stack backtrace: [ 15.237149][ C1] CPU: 1 UID: 0 PID: 22 Comm: ksoftirqd/1 Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 15.237153][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.237155][ C1] Call Trace: [ 15.237157][ C1] [ 15.237160][ C1] dump_stack_lvl+0x82/0xd0 [ 15.237166][ C1] print_usage_bug.part.0+0x25f/0x360 [ 15.237171][ C1] mark_lock_irq+0x343/0x400 [ 15.237175][ C1] ? __pfx_unwind_next_frame+0x10/0x10 [ 15.237179][ C1] ? save_trace+0x52/0x170 [ 15.237186][ C1] mark_lock+0x174/0x2f0 [ 15.237189][ C1] mark_usage+0x46/0x150 [ 15.237192][ C1] __lock_acquire+0x20b/0x7e0 [ 15.237195][ C1] ? __lock_acquire+0x44d/0x7e0 [ 15.237199][ C1] lock_acquire.part.0+0xb6/0x240 [ 15.237202][ C1] ? simple_pin_fs+0x24/0x150 [ 15.237207][ C1] ? rcu_is_watching+0x12/0xc0 [ 15.237211][ C1] ? lock_acquire+0x10c/0x170 [ 15.237213][ C1] ? simple_pin_fs+0x24/0x150 [ 15.237218][ C1] _raw_spin_lock+0x33/0x40 [ 15.237221][ C1] ? simple_pin_fs+0x24/0x150 [ 15.237224][ C1] simple_pin_fs+0x24/0x150 [ 15.237228][ C1] debugfs_remove+0x35/0x70 [ 15.237231][ C1] ref_tracker_dir_exit+0xcf/0x740 [ 15.237237][ C1] ? __pfx_ref_tracker_free+0x10/0x10 [ 15.237240][ C1] ? __sk_destruct+0x383/0x780 [ 15.237246][ C1] ? rcu_do_batch+0x34c/0xf20 [ 15.237248][ C1] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 15.237252][ C1] ? smpboot_thread_fn+0x30a/0x960 [ 15.237256][ C1] ? kthread+0x37e/0x600 [ 15.237259][ C1] ? ret_from_fork+0x240/0x320 [ 15.237262][ C1] ? ret_from_fork_asm+0x1a/0x30 [ 15.237265][ C1] ? migrate_enable+0x1f2/0x270 [ 15.237269][ C1] ? __pfx_migrate_enable+0x10/0x10 [ 15.237275][ C1] __put_net+0x19/0x60 [ 15.237279][ C1] __sk_destruct+0x58a/0x780 [ 15.237283][ C1] ? rcu_do_batch+0x34a/0xf20 [ 15.237285][ C1] rcu_do_batch+0x34c/0xf20 [ 15.237290][ C1] ? __pfx_rcu_do_batch+0x10/0x10 [ 15.237293][ C1] ? rcu_is_watching+0x12/0xc0 [ 15.237296][ C1] ? note_gp_changes+0x182/0x1e0 [ 15.237299][ C1] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.237303][ C1] rcu_core+0x2bb/0x500 [ 15.237307][ C1] handle_softirqs+0x218/0x620 [ 15.237311][ C1] ? __pfx_run_ksoftirqd+0x10/0x10 [ 15.237315][ C1] run_ksoftirqd+0x3f/0x70 [ 15.237317][ C1] smpboot_thread_fn+0x30a/0x960 [ 15.237321][ C1] ? __pfx_smpboot_thread_fn+0x10/0x10 [ 15.237325][ C1] kthread+0x37e/0x600 [ 15.237328][ C1] ? __pfx_kthread+0x10/0x10 [ 15.237330][ C1] ? ret_from_fork+0x1b/0x320 [ 15.237332][ C1] ? __lock_release+0x5d/0x170 [ 15.237336][ C1] ? rcu_is_watching+0x12/0xc0 [ 15.237339][ C1] ? __pfx_kthread+0x10/0x10 [ 15.237342][ C1] ret_from_fork+0x240/0x320 [ 15.237345][ C1] ? __pfx_kthread+0x10/0x10 [ 15.237347][ C1] ret_from_fork_asm+0x1a/0x30 [ 15.237354][ C1] [ 15.247086][ C1] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 15.247367][ C1] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 22, name: ksoftirqd/1 [ 15.247648][ C1] preempt_count: 100, expected: 0 [ 15.247813][ C1] RCU nest depth: 0, expected: 0 [ 15.247986][ C1] INFO: lockdep is turned off. [ 15.248148][ C1] Preemption disabled at: [ 15.248150][ C1] [] handle_softirqs+0xe5/0x620 [ 15.248475][ C1] CPU: 1 UID: 0 PID: 22 Comm: ksoftirqd/1 Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 15.248479][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.248481][ C1] Call Trace: [ 15.248482][ C1] [ 15.248484][ C1] dump_stack_lvl+0xb0/0xd0 [ 15.248490][ C1] __might_resched+0x360/0x5a0 [ 15.248496][ C1] down_write+0x72/0x210 [ 15.248500][ C1] ? __pfx_down_write+0x10/0x10 [ 15.248503][ C1] ? simple_recursive_removal+0x33/0x610 [ 15.248506][ C1] ? rcu_is_watching+0x12/0xc0 [ 15.248510][ C1] ? do_raw_spin_unlock+0x58/0x220 [ 15.248515][ C1] simple_recursive_removal+0x6a/0x610 [ 15.248518][ C1] ? do_raw_spin_unlock+0x58/0x220 [ 15.248521][ C1] ? __pfx_remove_one+0x10/0x10 [ 15.248526][ C1] debugfs_remove+0x44/0x70 [ 15.248529][ C1] ref_tracker_dir_exit+0xcf/0x740 [ 15.248534][ C1] ? __pfx_ref_tracker_free+0x10/0x10 [ 15.248537][ C1] ? __sk_destruct+0x383/0x780 [ 15.248542][ C1] ? rcu_do_batch+0x34c/0xf20 [ 15.248544][ C1] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 15.248548][ C1] ? smpboot_thread_fn+0x30a/0x960 [ 15.248551][ C1] ? kthread+0x37e/0x600 [ 15.248553][ C1] ? ret_from_fork+0x240/0x320 [ 15.248556][ C1] ? ret_from_fork_asm+0x1a/0x30 [ 15.248560][ C1] ? migrate_enable+0x1f2/0x270 [ 15.248563][ C1] ? __pfx_migrate_enable+0x10/0x10 [ 15.248568][ C1] __put_net+0x19/0x60 [ 15.248571][ C1] __sk_destruct+0x58a/0x780 [ 15.248575][ C1] ? rcu_do_batch+0x34a/0xf20 [ 15.248578][ C1] rcu_do_batch+0x34c/0xf20 [ 15.248583][ C1] ? __pfx_rcu_do_batch+0x10/0x10 [ 15.248586][ C1] ? rcu_is_watching+0x12/0xc0 [ 15.248589][ C1] ? note_gp_changes+0x182/0x1e0 [ 15.248592][ C1] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.248596][ C1] rcu_core+0x2bb/0x500 [ 15.248600][ C1] handle_softirqs+0x218/0x620 [ 15.248604][ C1] ? __pfx_run_ksoftirqd+0x10/0x10 [ 15.248607][ C1] run_ksoftirqd+0x3f/0x70 [ 15.248610][ C1] smpboot_thread_fn+0x30a/0x960 [ 15.248614][ C1] ? __pfx_smpboot_thread_fn+0x10/0x10 [ 15.248618][ C1] kthread+0x37e/0x600 [ 15.248620][ C1] ? __pfx_kthread+0x10/0x10 [ 15.248622][ C1] ? ret_from_fork+0x1b/0x320 [ 15.248625][ C1] ? __lock_release+0x5d/0x170 [ 15.248628][ C1] ? rcu_is_watching+0x12/0xc0 [ 15.248631][ C1] ? __pfx_kthread+0x10/0x10 [ 15.248634][ C1] ret_from_fork+0x240/0x320 [ 15.248637][ C1] ? __pfx_kthread+0x10/0x10 [ 15.248639][ C1] ret_from_fork_asm+0x1a/0x30 [ 15.248646][ C1] [ 16.934109][ C2] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 16.934538][ C2] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/2 [ 16.934894][ C2] preempt_count: 101, expected: 0 [ 16.935107][ C2] RCU nest depth: 0, expected: 0 [ 16.935315][ C2] INFO: lockdep is turned off. [ 16.935531][ C2] Preemption disabled at: [ 16.935533][ C2] [<0000000000000000>] 0x0 [ 16.935916][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 6.15.0-virtme #1 PREEMPT(full) [ 16.935922][ C2] Tainted: [W]=WARN [ 16.935924][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 16.935926][ C2] Call Trace: [ 16.935929][ C2] [ 16.935931][ C2] dump_stack_lvl+0xb0/0xd0 [ 16.935944][ C2] __might_resched+0x360/0x5a0 [ 16.935953][ C2] down_write+0x72/0x210 [ 16.935959][ C2] ? __pfx_down_write+0x10/0x10 [ 16.935962][ C2] ? simple_recursive_removal+0x33/0x610 [ 16.935967][ C2] ? rcu_is_watching+0x12/0xc0 [ 16.935973][ C2] ? do_raw_spin_unlock+0x58/0x220 [ 16.935981][ C2] simple_recursive_removal+0x6a/0x610 [ 16.935983][ C2] ? do_raw_spin_unlock+0x58/0x220 [ 16.935987][ C2] ? __pfx_remove_one+0x10/0x10 [ 16.935993][ C2] debugfs_remove+0x44/0x70 [ 16.935996][ C2] ref_tracker_dir_exit+0xcf/0x740 [ 16.936004][ C2] ? __pfx_ref_tracker_free+0x10/0x10 [ 16.936007][ C2] ? __sk_destruct+0x383/0x780 [ 16.936014][ C2] ? rcu_do_batch+0x34c/0xf20 [ 16.936019][ C2] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 16.936022][ C2] ? irq_exit_rcu+0xe/0x30 [ 16.936029][ C2] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 16.936035][ C2] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 16.936040][ C2] ? pv_native_safe_halt+0xf/0x20 [ 16.936043][ C2] ? default_idle+0x9/0x10 [ 16.936046][ C2] ? default_idle_call+0x6d/0xb0 [ 16.936049][ C2] ? cpuidle_idle_call+0x26f/0x3a0 [ 16.936053][ C2] ? do_idle+0xf6/0x160 [ 16.936055][ C2] ? cpu_startup_entry+0x54/0x60 [ 16.936058][ C2] ? start_secondary+0x213/0x2a0 [ 16.936062][ C2] ? common_startup_64+0x13e/0x148 [ 16.936069][ C2] ? bpf_sk_storage_free+0x9f/0x1c0 [ 16.936074][ C2] ? rcu_is_watching+0x12/0xc0 [ 16.936079][ C2] __put_net+0x19/0x60 [ 16.936083][ C2] __sk_destruct+0x58a/0x780 [ 16.936087][ C2] ? rcu_do_batch+0x34a/0xf20 [ 16.936089][ C2] rcu_do_batch+0x34c/0xf20 [ 16.936094][ C2] ? __pfx_rcu_do_batch+0x10/0x10 [ 16.936098][ C2] ? trace_irq_enable.constprop.0+0xd4/0x130 [ 16.936105][ C2] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 16.936112][ C2] rcu_core+0x2bb/0x500 [ 16.936117][ C2] handle_softirqs+0x218/0x620 [ 16.936123][ C2] __irq_exit_rcu+0xfa/0x160 [ 16.936126][ C2] irq_exit_rcu+0xe/0x30 [ 16.936129][ C2] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 16.936133][ C2] [ 16.936134][ C2] [ 16.936136][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 16.936139][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 16.936144][ C2] Code: a2 b5 00 c3 cc cc cc cc 0f 1f 00 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 f3 0f 1e fa 66 90 0f 00 2d 83 47 10 00 fb f4 fc 54 02 00 66 2e 0f 1f 84 00 00 00 00 00 66 90 90 90 90 90 90 [ 16.936146][ C2] RSP: 0018:ffffc90000147de8 EFLAGS: 00000246 [ 16.936150][ C2] RAX: 0000000000000002 RBX: 1ffff92000028fc1 RCX: ffffffff89b8f5d9 [ 16.936152][ C2] RDX: ffffed1006c266fb RSI: ffffffff89e53b60 RDI: ffffffff8738d18f [ 16.936154][ C2] RBP: 0000000000000000 R08: 0000000000000000 R09: ffffed1006c266fa [ 16.936156][ C2] R10: ffff8880361337d3 R11: ffffffff8d44b7c0 R12: 0000000000000000 [ 16.936158][ C2] R13: ffff888001bf2300 R14: dffffc0000000000 R15: 0000000000000000 [ 16.936162][ C2] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 16.936165][ C2] ? cpuidle_idle_call+0x26f/0x3a0 [ 16.936169][ C2] default_idle+0x9/0x10 [ 16.936172][ C2] default_idle_call+0x6d/0xb0 [ 16.936174][ C2] cpuidle_idle_call+0x26f/0x3a0 [ 16.936177][ C2] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 16.936181][ C2] ? tsc_verify_tsc_adjust+0x98/0x310 [ 16.936186][ C2] do_idle+0xf6/0x160 [ 16.936189][ C2] cpu_startup_entry+0x54/0x60 [ 16.936192][ C2] start_secondary+0x213/0x2a0 [ 16.936195][ C2] ? __pfx_start_secondary+0x10/0x10 [ 16.936200][ C2] common_startup_64+0x13e/0x148 [ 16.936207][ C2]