[ 15.808494][ C3] [ 15.808612][ C3] ================================ [ 15.808785][ C3] WARNING: inconsistent lock state [ 15.808954][ C3] 6.15.0-virtme #1 Not tainted [ 15.809124][ C3] -------------------------------- [ 15.809290][ C3] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 15.809505][ C3] ksoftirqd/3/32 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 15.809714][ C3] ffffffffa41c5af8 (pin_fs_lock){+.?.}-{3:3}, at: simple_pin_fs+0x24/0x150 [ 15.810021][ C3] {SOFTIRQ-ON-W} state was registered at: [ 15.810188][ C3] __lock_acquire+0x20b/0x7e0 [ 15.810364][ C3] lock_acquire.part.0+0xb6/0x240 [ 15.810534][ C3] _raw_spin_lock+0x33/0x40 [ 15.810705][ C3] simple_pin_fs+0x24/0x150 [ 15.810876][ C3] start_creating.part.0+0x52/0x310 [ 15.811047][ C3] debugfs_create_dir+0x6a/0x540 [ 15.811216][ C3] component_debug_init+0x17/0x30 [ 15.811388][ C3] do_one_initcall+0x8f/0x1e0 [ 15.811568][ C3] do_initcalls+0x176/0x280 [ 15.811738][ C3] kernel_init_freeable+0x22d/0x300 [ 15.811908][ C3] kernel_init+0x20/0x200 [ 15.812078][ C3] ret_from_fork+0x240/0x320 [ 15.812248][ C3] ret_from_fork_asm+0x1a/0x30 [ 15.812417][ C3] irq event stamp: 179314 [ 15.812548][ C3] hardirqs last enabled at (179314): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.812888][ C3] hardirqs last disabled at (179313): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 15.813229][ C3] softirqs last enabled at (178910): [] handle_softirqs+0x358/0x620 [ 15.813528][ C3] softirqs last disabled at (178915): [] run_ksoftirqd+0x3f/0x70 [ 15.813828][ C3] [ 15.813828][ C3] other info that might help us debug this: [ 15.814076][ C3] Possible unsafe locking scenario: [ 15.814076][ C3] [ 15.814324][ C3] CPU0 [ 15.814453][ C3] ---- [ 15.814579][ C3] lock(pin_fs_lock); [ 15.814710][ C3] [ 15.814838][ C3] lock(pin_fs_lock); [ 15.814970][ C3] [ 15.814970][ C3] *** DEADLOCK *** [ 15.814970][ C3] [ 15.815220][ C3] 1 lock held by ksoftirqd/3/32: [ 15.815392][ C3] #0: ffffffffa3f774c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 15.815704][ C3] [ 15.815704][ C3] stack backtrace: [ 15.815915][ C3] CPU: 3 UID: 0 PID: 32 Comm: ksoftirqd/3 Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 15.815919][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.815921][ C3] Call Trace: [ 15.815923][ C3] [ 15.815925][ C3] dump_stack_lvl+0x82/0xd0 [ 15.815931][ C3] print_usage_bug.part.0+0x25f/0x360 [ 15.815936][ C3] mark_lock_irq+0x343/0x400 [ 15.815940][ C3] ? __pfx_unwind_next_frame+0x10/0x10 [ 15.815945][ C3] ? save_trace+0x52/0x170 [ 15.815951][ C3] mark_lock+0x174/0x2f0 [ 15.815955][ C3] mark_usage+0x46/0x150 [ 15.815958][ C3] __lock_acquire+0x20b/0x7e0 [ 15.815961][ C3] ? __lock_acquire+0x44d/0x7e0 [ 15.815965][ C3] lock_acquire.part.0+0xb6/0x240 [ 15.815968][ C3] ? simple_pin_fs+0x24/0x150 [ 15.815972][ C3] ? rcu_is_watching+0x12/0xc0 [ 15.815976][ C3] ? lock_acquire+0x10c/0x170 [ 15.815979][ C3] ? simple_pin_fs+0x24/0x150 [ 15.815983][ C3] _raw_spin_lock+0x33/0x40 [ 15.815987][ C3] ? simple_pin_fs+0x24/0x150 [ 15.815990][ C3] simple_pin_fs+0x24/0x150 [ 15.815994][ C3] debugfs_remove+0x35/0x70 [ 15.815997][ C3] ref_tracker_dir_exit+0xcf/0x740 [ 15.816003][ C3] ? __pfx_ref_tracker_free+0x10/0x10 [ 15.816006][ C3] ? __sk_destruct+0x383/0x780 [ 15.816013][ C3] ? rcu_do_batch+0x34c/0xf20 [ 15.816015][ C3] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 15.816019][ C3] ? smpboot_thread_fn+0x30a/0x960 [ 15.816023][ C3] ? kthread+0x37e/0x600 [ 15.816025][ C3] ? ret_from_fork+0x240/0x320 [ 15.816028][ C3] ? ret_from_fork_asm+0x1a/0x30 [ 15.816031][ C3] ? migrate_enable+0x1f2/0x270 [ 15.816034][ C3] ? __pfx_migrate_enable+0x10/0x10 [ 15.816040][ C3] __put_net+0x19/0x60 [ 15.816044][ C3] __sk_destruct+0x58a/0x780 [ 15.816048][ C3] ? rcu_do_batch+0x34a/0xf20 [ 15.816050][ C3] rcu_do_batch+0x34c/0xf20 [ 15.816053][ C3] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.816057][ C3] ? __pfx_rcu_do_batch+0x10/0x10 [ 15.816059][ C3] ? __pfx_tmigr_handle_remote+0x10/0x10 [ 15.816064][ C3] ? rcu_is_watching+0x12/0xc0 [ 15.816066][ C3] ? note_gp_changes+0x182/0x1e0 [ 15.816069][ C3] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.816073][ C3] rcu_core+0x2bb/0x500 [ 15.816077][ C3] handle_softirqs+0x218/0x620 [ 15.816081][ C3] ? __pfx_run_ksoftirqd+0x10/0x10 [ 15.816085][ C3] run_ksoftirqd+0x3f/0x70 [ 15.816088][ C3] smpboot_thread_fn+0x30a/0x960 [ 15.816091][ C3] ? __pfx_smpboot_thread_fn+0x10/0x10 [ 15.816095][ C3] kthread+0x37e/0x600 [ 15.816098][ C3] ? __pfx_kthread+0x10/0x10 [ 15.816100][ C3] ? ret_from_fork+0x1b/0x320 [ 15.816102][ C3] ? __lock_release+0x5d/0x170 [ 15.816106][ C3] ? rcu_is_watching+0x12/0xc0 [ 15.816108][ C3] ? __pfx_kthread+0x10/0x10 [ 15.816111][ C3] ret_from_fork+0x240/0x320 [ 15.816114][ C3] ? __pfx_kthread+0x10/0x10 [ 15.816116][ C3] ret_from_fork_asm+0x1a/0x30 [ 15.816124][ C3] [ 15.826104][ C3] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 15.826387][ C3] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 32, name: ksoftirqd/3 [ 15.826661][ C3] preempt_count: 100, expected: 0 [ 15.826821][ C3] RCU nest depth: 0, expected: 0 [ 15.826981][ C3] INFO: lockdep is turned off. [ 15.827138][ C3] Preemption disabled at: [ 15.827139][ C3] [] handle_softirqs+0xe5/0x620 [ 15.827472][ C3] CPU: 3 UID: 0 PID: 32 Comm: ksoftirqd/3 Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 15.827476][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.827478][ C3] Call Trace: [ 15.827480][ C3] [ 15.827482][ C3] dump_stack_lvl+0xb0/0xd0 [ 15.827487][ C3] __might_resched+0x360/0x5a0 [ 15.827494][ C3] down_write+0x72/0x210 [ 15.827498][ C3] ? __pfx_down_write+0x10/0x10 [ 15.827501][ C3] ? simple_recursive_removal+0x33/0x610 [ 15.827504][ C3] ? rcu_is_watching+0x12/0xc0 [ 15.827508][ C3] ? do_raw_spin_unlock+0x58/0x220 [ 15.827513][ C3] simple_recursive_removal+0x6a/0x610 [ 15.827516][ C3] ? do_raw_spin_unlock+0x58/0x220 [ 15.827519][ C3] ? __pfx_remove_one+0x10/0x10 [ 15.827524][ C3] debugfs_remove+0x44/0x70 [ 15.827527][ C3] ref_tracker_dir_exit+0xcf/0x740 [ 15.827532][ C3] ? __pfx_ref_tracker_free+0x10/0x10 [ 15.827536][ C3] ? __sk_destruct+0x383/0x780 [ 15.827539][ C3] ? rcu_do_batch+0x34c/0xf20 [ 15.827542][ C3] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 15.827546][ C3] ? smpboot_thread_fn+0x30a/0x960 [ 15.827550][ C3] ? kthread+0x37e/0x600 [ 15.827552][ C3] ? ret_from_fork+0x240/0x320 [ 15.827555][ C3] ? ret_from_fork_asm+0x1a/0x30 [ 15.827559][ C3] ? migrate_enable+0x1f2/0x270 [ 15.827563][ C3] ? __pfx_migrate_enable+0x10/0x10 [ 15.827568][ C3] __put_net+0x19/0x60 [ 15.827572][ C3] __sk_destruct+0x58a/0x780 [ 15.827576][ C3] ? rcu_do_batch+0x34a/0xf20 [ 15.827578][ C3] rcu_do_batch+0x34c/0xf20 [ 15.827581][ C3] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.827585][ C3] ? __pfx_rcu_do_batch+0x10/0x10 [ 15.827588][ C3] ? __pfx_tmigr_handle_remote+0x10/0x10 [ 15.827592][ C3] ? rcu_is_watching+0x12/0xc0 [ 15.827594][ C3] ? note_gp_changes+0x182/0x1e0 [ 15.827597][ C3] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.827601][ C3] rcu_core+0x2bb/0x500 [ 15.827605][ C3] handle_softirqs+0x218/0x620 [ 15.827609][ C3] ? __pfx_run_ksoftirqd+0x10/0x10 [ 15.827613][ C3] run_ksoftirqd+0x3f/0x70 [ 15.827615][ C3] smpboot_thread_fn+0x30a/0x960 [ 15.827619][ C3] ? __pfx_smpboot_thread_fn+0x10/0x10 [ 15.827623][ C3] kthread+0x37e/0x600 [ 15.827626][ C3] ? __pfx_kthread+0x10/0x10 [ 15.827628][ C3] ? ret_from_fork+0x1b/0x320 [ 15.827630][ C3] ? __lock_release+0x5d/0x170 [ 15.827634][ C3] ? rcu_is_watching+0x12/0xc0 [ 15.827637][ C3] ? __pfx_kthread+0x10/0x10 [ 15.827640][ C3] ret_from_fork+0x240/0x320 [ 15.827642][ C3] ? __pfx_kthread+0x10/0x10 [ 15.827645][ C3] ret_from_fork_asm+0x1a/0x30 [ 15.827653][ C3] [ 18.051937][ C1] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 18.052271][ C1] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 22, name: ksoftirqd/1 [ 18.052577][ C1] preempt_count: 101, expected: 0 [ 18.052748][ C1] RCU nest depth: 0, expected: 0 [ 18.052917][ C1] INFO: lockdep is turned off. [ 18.053085][ C1] Preemption disabled at: [ 18.053087][ C1] [] schedule+0xdb/0x270 [ 18.053446][ C1] CPU: 1 UID: 0 PID: 22 Comm: ksoftirqd/1 Tainted: G W 6.15.0-virtme #1 PREEMPT(full) [ 18.053452][ C1] Tainted: [W]=WARN [ 18.053453][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 18.053455][ C1] Call Trace: [ 18.053457][ C1] [ 18.053459][ C1] dump_stack_lvl+0xb0/0xd0 [ 18.053466][ C1] __might_resched+0x360/0x5a0 [ 18.053473][ C1] down_write+0x72/0x210 [ 18.053477][ C1] ? __pfx_down_write+0x10/0x10 [ 18.053480][ C1] ? simple_recursive_removal+0x33/0x610 [ 18.053484][ C1] ? rcu_is_watching+0x12/0xc0 [ 18.053489][ C1] ? do_raw_spin_unlock+0x58/0x220 [ 18.053495][ C1] simple_recursive_removal+0x6a/0x610 [ 18.053498][ C1] ? do_raw_spin_unlock+0x58/0x220 [ 18.053501][ C1] ? __pfx_remove_one+0x10/0x10 [ 18.053506][ C1] debugfs_remove+0x44/0x70 [ 18.053509][ C1] ref_tracker_dir_exit+0xcf/0x740 [ 18.053515][ C1] ? __pfx_ref_tracker_free+0x10/0x10 [ 18.053519][ C1] ? __sk_destruct+0x383/0x780 [ 18.053524][ C1] ? rcu_do_batch+0x34c/0xf20 [ 18.053528][ C1] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 18.053531][ C1] ? irq_exit_rcu+0xe/0x30 [ 18.053536][ C1] ? sysvec_call_function_single+0xa8/0xc0 [ 18.053541][ C1] ? asm_sysvec_call_function_single+0x1a/0x20 [ 18.053546][ C1] ? finish_task_switch.isra.0+0x251/0x970 [ 18.053550][ C1] ? __schedule+0x86a/0x1b00 [ 18.053553][ C1] ? schedule+0xe2/0x270 [ 18.053556][ C1] ? smpboot_thread_fn+0x731/0x960 [ 18.053560][ C1] ? kthread+0x37e/0x600 [ 18.053563][ C1] ? ret_from_fork+0x240/0x320 [ 18.053567][ C1] ? ret_from_fork_asm+0x1a/0x30 [ 18.053572][ C1] ? bpf_sk_storage_free+0x9f/0x1c0 [ 18.053576][ C1] ? rcu_is_watching+0x12/0xc0 [ 18.053581][ C1] __put_net+0x19/0x60 [ 18.053585][ C1] __sk_destruct+0x58a/0x780 [ 18.053589][ C1] ? rcu_do_batch+0x34a/0xf20 [ 18.053591][ C1] rcu_do_batch+0x34c/0xf20 [ 18.053595][ C1] ? sched_ttwu_pending+0x336/0x540 [ 18.053600][ C1] ? __pfx_rcu_do_batch+0x10/0x10 [ 18.053603][ C1] ? rcu_is_watching+0x12/0xc0 [ 18.053606][ C1] ? trace_irq_enable.constprop.0+0xd4/0x130 [ 18.053614][ C1] rcu_core+0x2bb/0x500 [ 18.053618][ C1] handle_softirqs+0x218/0x620 [ 18.053624][ C1] __irq_exit_rcu+0xfa/0x160 [ 18.053627][ C1] irq_exit_rcu+0xe/0x30 [ 18.053629][ C1] sysvec_call_function_single+0xa8/0xc0 [ 18.053633][ C1] [ 18.053634][ C1] [ 18.053636][ C1] asm_sysvec_call_function_single+0x1a/0x20 [ 18.053638][ C1] RIP: 0010:finish_task_switch.isra.0+0x251/0x970 [ 18.053642][ C1] Code: 4c 89 ff 48 c7 03 00 00 00 00 e8 e3 fd ac 1f 4d 85 e4 75 ba 4c 89 ff e8 ad f4 87 02 e8 98 1f 31 00 fb 65 48 8b 1d f7 62 1f 05 <66> 90 48 83 7d d0 00 74 55 65 48 8b 1d e6 62 1f 05 48 8d bb 18 05 [ 18.053645][ C1] RSP: 0018:ffffc90000197c80 EFLAGS: 00000246 [ 18.053649][ C1] RAX: 0000000000000001 RBX: ffff888001ed0040 RCX: ffffffffa0a43b9f [ 18.053651][ C1] RDX: 0000000000000000 RSI: ffffffffa3253b60 RDI: ffffffffa0731d18 [ 18.053652][ C1] RBP: ffffc90000197cc0 R08: 0000000000000000 R09: 0000000000000000 [ 18.053654][ C1] R10: ffffffffa49e68d7 R11: ffff88800a5ca818 R12: ffff8880360b8dd8 [ 18.053656][ C1] R13: ffff88800a5ca300 R14: ffff8880360b9968 R15: ffff8880360b8dc0 [ 18.053660][ C1] ? trace_irq_enable.constprop.0+0x2f/0x130 [ 18.053663][ C1] ? finish_task_switch.isra.0+0x248/0x970 [ 18.053668][ C1] ? __switch_to+0x503/0xd60 [ 18.053674][ C1] __schedule+0x86a/0x1b00 [ 18.053679][ C1] ? __pfx___schedule+0x10/0x10 [ 18.053683][ C1] ? rcu_is_watching+0x12/0xc0 [ 18.053686][ C1] ? trace_irq_enable.constprop.0+0xd4/0x130 [ 18.053692][ C1] ? rcu_is_watching+0x12/0xc0 [ 18.053695][ C1] ? schedule+0x1ee/0x270 [ 18.053698][ C1] ? rcu_is_watching+0x12/0xc0 [ 18.053702][ C1] schedule+0xe2/0x270 [ 18.053706][ C1] ? __pfx_ksoftirqd_should_run+0x10/0x10 [ 18.053709][ C1] smpboot_thread_fn+0x731/0x960 [ 18.053713][ C1] ? __pfx_smpboot_thread_fn+0x10/0x10 [ 18.053717][ C1] kthread+0x37e/0x600 [ 18.053720][ C1] ? __pfx_kthread+0x10/0x10 [ 18.053722][ C1] ? ret_from_fork+0x1b/0x320 [ 18.053725][ C1] ? __lock_release+0x5d/0x170 [ 18.053728][ C1] ? rcu_is_watching+0x12/0xc0 [ 18.053731][ C1] ? __pfx_kthread+0x10/0x10 [ 18.053734][ C1] ret_from_fork+0x240/0x320 [ 18.053737][ C1] ? __pfx_kthread+0x10/0x10 [ 18.053739][ C1] ret_from_fork_asm+0x1a/0x30 [ 18.053746][ C1]