[ 15.139798][ C3] [ 15.139934][ C3] ================================ [ 15.140125][ C3] WARNING: inconsistent lock state [ 15.140318][ C3] 6.15.0-rc5-virtme #1 Not tainted [ 15.140499][ C3] -------------------------------- [ 15.140689][ C3] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 15.140916][ C3] swapper/3/0 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 15.141141][ C3] ffffffffa2bbf978 (pin_fs_lock){+.?.}-{3:3}, at: simple_pin_fs+0x24/0x150 [ 15.141469][ C3] {SOFTIRQ-ON-W} state was registered at: [ 15.141647][ C3] __lock_acquire+0x3eb/0x9d0 [ 15.141830][ C3] lock_acquire.part.0+0xb6/0x240 [ 15.142010][ C3] _raw_spin_lock+0x33/0x40 [ 15.142194][ C3] simple_pin_fs+0x24/0x150 [ 15.142370][ C3] start_creating.part.0+0x3f/0x2f0 [ 15.142553][ C3] debugfs_create_dir+0x6a/0x540 [ 15.142732][ C3] component_debug_init+0x17/0x30 [ 15.142915][ C3] do_one_initcall+0x8c/0x1e0 [ 15.143095][ C3] do_initcalls+0x176/0x280 [ 15.143274][ C3] kernel_init_freeable+0x22d/0x300 [ 15.143463][ C3] kernel_init+0x20/0x200 [ 15.143642][ C3] ret_from_fork+0x31/0x70 [ 15.143821][ C3] ret_from_fork_asm+0x1a/0x30 [ 15.143999][ C3] irq event stamp: 295184 [ 15.144139][ C3] hardirqs last enabled at (295184): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.144496][ C3] hardirqs last disabled at (295183): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 15.144873][ C3] softirqs last enabled at (293846): [] handle_softirqs+0x358/0x620 [ 15.145187][ C3] softirqs last disabled at (293877): [] __irq_exit_rcu+0xfa/0x160 [ 15.145514][ C3] [ 15.145514][ C3] other info that might help us debug this: [ 15.145787][ C3] Possible unsafe locking scenario: [ 15.145787][ C3] [ 15.146077][ C3] CPU0 [ 15.146216][ C3] ---- [ 15.146356][ C3] lock(pin_fs_lock); [ 15.146498][ C3] [ 15.146640][ C3] lock(pin_fs_lock); [ 15.146782][ C3] [ 15.146782][ C3] *** DEADLOCK *** [ 15.146782][ C3] [ 15.147055][ C3] 1 lock held by swapper/3/0: [ 15.147239][ C3] #0: ffffffffa2974480 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 15.147576][ C3] [ 15.147576][ C3] stack backtrace: [ 15.147805][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Not tainted 6.15.0-rc5-virtme #1 PREEMPT(full) [ 15.147811][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.147814][ C3] Call Trace: [ 15.147817][ C3] [ 15.147819][ C3] dump_stack_lvl+0x82/0xd0 [ 15.147826][ C3] print_usage_bug.part.0+0x25f/0x360 [ 15.147832][ C3] mark_lock_irq+0x343/0x400 [ 15.147837][ C3] ? __pfx_unwind_next_frame+0x10/0x10 [ 15.147842][ C3] ? save_trace+0x52/0x170 [ 15.147846][ C3] mark_lock+0x174/0x2f0 [ 15.147850][ C3] mark_usage+0x46/0x150 [ 15.147854][ C3] __lock_acquire+0x3eb/0x9d0 [ 15.147859][ C3] lock_acquire.part.0+0xb6/0x240 [ 15.147863][ C3] ? simple_pin_fs+0x24/0x150 [ 15.147868][ C3] ? rcu_is_watching+0x12/0xc0 [ 15.147874][ C3] ? lock_acquire+0x10c/0x170 [ 15.147877][ C3] ? simple_pin_fs+0x24/0x150 [ 15.147881][ C3] _raw_spin_lock+0x33/0x40 [ 15.147885][ C3] ? simple_pin_fs+0x24/0x150 [ 15.147888][ C3] simple_pin_fs+0x24/0x150 [ 15.147893][ C3] debugfs_remove+0x35/0x70 [ 15.147897][ C3] ref_tracker_dir_exit+0xcf/0x740 [ 15.147903][ C3] ? __pfx_ref_tracker_free+0x10/0x10 [ 15.147906][ C3] ? __sk_destruct+0x383/0x780 [ 15.147911][ C3] ? rcu_do_batch+0x34c/0xf20 [ 15.147914][ C3] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 15.147917][ C3] ? irq_exit_rcu+0xe/0x30 [ 15.147919][ C3] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.147923][ C3] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.147927][ C3] ? pv_native_safe_halt+0xf/0x20 [ 15.147930][ C3] ? default_idle+0x9/0x10 [ 15.147932][ C3] ? default_idle_call+0x6d/0xb0 [ 15.147934][ C3] ? cpuidle_idle_call+0x26f/0x3a0 [ 15.147939][ C3] ? do_idle+0xf6/0x160 [ 15.147942][ C3] ? cpu_startup_entry+0x54/0x60 [ 15.147945][ C3] ? start_secondary+0x213/0x2a0 [ 15.147950][ C3] ? common_startup_64+0x13e/0x148 [ 15.147958][ C3] __put_net+0x19/0x60 [ 15.147962][ C3] __sk_destruct+0x58a/0x780 [ 15.147967][ C3] ? rcu_do_batch+0x34a/0xf20 [ 15.147970][ C3] rcu_do_batch+0x34c/0xf20 [ 15.147974][ C3] ? find_held_lock+0x2b/0x80 [ 15.147978][ C3] ? __pfx_rcu_do_batch+0x10/0x10 [ 15.147981][ C3] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.147985][ C3] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.147988][ C3] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 15.147993][ C3] rcu_core+0x2bb/0x500 [ 15.147996][ C3] handle_softirqs+0x218/0x620 [ 15.148001][ C3] __irq_exit_rcu+0xfa/0x160 [ 15.148003][ C3] irq_exit_rcu+0xe/0x30 [ 15.148005][ C3] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.148009][ C3] [ 15.148010][ C3] [ 15.148011][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.148014][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 15.148018][ C3] Code: b0 b8 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 a3 d0 13 00 fb f4 cc cc cc cc 66 2e 0f 1f 84 00 00 00 00 00 66 90 90 90 90 90 90 [ 15.148021][ C3] RSP: 0018:ffffc90000157de8 EFLAGS: 00000246 [ 15.148025][ C3] RAX: 0000000000047bf3 RBX: 1ffff9200002afc1 RCX: ffffffffa1955a19 [ 15.148027][ C3] RDX: 0000000000000000 RSI: ffffffffa2485f31 RDI: ffffffffa1c50ce0 [ 15.148028][ C3] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c3667a [ 15.148030][ C3] R10: ffff8880361b33d3 R11: 0000000000000000 R12: 0000000000000000 [ 15.148032][ C3] R13: ffff888001bb4640 R14: dffffc0000000000 R15: 0000000000000000 [ 15.148035][ C3] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 15.148041][ C3] default_idle+0x9/0x10 [ 15.148043][ C3] default_idle_call+0x6d/0xb0 [ 15.148045][ C3] cpuidle_idle_call+0x26f/0x3a0 [ 15.148049][ C3] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 15.148053][ C3] ? tsc_verify_tsc_adjust+0x98/0x300 [ 15.148058][ C3] do_idle+0xf6/0x160 [ 15.148062][ C3] cpu_startup_entry+0x54/0x60 [ 15.148065][ C3] start_secondary+0x213/0x2a0 [ 15.148069][ C3] ? __pfx_start_secondary+0x10/0x10 [ 15.148074][ C3] common_startup_64+0x13e/0x148 [ 15.148080][ C3] [ 15.162866][ C3] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 15.163165][ C3] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/3 [ 15.163554][ C3] preempt_count: 101, expected: 0 [ 15.163726][ C3] RCU nest depth: 0, expected: 0 [ 15.163995][ C3] INFO: lockdep is turned off. [ 15.164267][ C3] Preemption disabled at: [ 15.164269][ C3] [<0000000000000000>] 0x0 [ 15.164569][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Not tainted 6.15.0-rc5-virtme #1 PREEMPT(full) [ 15.164574][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.164576][ C3] Call Trace: [ 15.164578][ C3] [ 15.164580][ C3] dump_stack_lvl+0xb0/0xd0 [ 15.164591][ C3] __might_resched+0x360/0x5a0 [ 15.164597][ C3] down_write+0x72/0x210 [ 15.164600][ C3] ? __pfx_down_write+0x10/0x10 [ 15.164603][ C3] ? simple_recursive_removal+0x3a/0x860 [ 15.164607][ C3] ? rcu_is_watching+0x12/0xc0 [ 15.164613][ C3] ? do_raw_spin_unlock+0x58/0x220 [ 15.164617][ C3] simple_recursive_removal+0x166/0x860 [ 15.164620][ C3] ? __pfx_remove_one+0x10/0x10 [ 15.164624][ C3] ? do_raw_spin_unlock+0x58/0x220 [ 15.164628][ C3] debugfs_remove+0x44/0x70 [ 15.164631][ C3] ref_tracker_dir_exit+0xcf/0x740 [ 15.164636][ C3] ? __pfx_ref_tracker_free+0x10/0x10 [ 15.164639][ C3] ? __sk_destruct+0x383/0x780 [ 15.164644][ C3] ? rcu_do_batch+0x34c/0xf20 [ 15.164648][ C3] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 15.164651][ C3] ? irq_exit_rcu+0xe/0x30 [ 15.164655][ C3] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.164660][ C3] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.164664][ C3] ? pv_native_safe_halt+0xf/0x20 [ 15.164667][ C3] ? default_idle+0x9/0x10 [ 15.164669][ C3] ? default_idle_call+0x6d/0xb0 [ 15.164671][ C3] ? cpuidle_idle_call+0x26f/0x3a0 [ 15.164676][ C3] ? do_idle+0xf6/0x160 [ 15.164679][ C3] ? cpu_startup_entry+0x54/0x60 [ 15.164682][ C3] ? start_secondary+0x213/0x2a0 [ 15.164687][ C3] ? common_startup_64+0x13e/0x148 [ 15.164693][ C3] __put_net+0x19/0x60 [ 15.164696][ C3] __sk_destruct+0x58a/0x780 [ 15.164700][ C3] ? rcu_do_batch+0x34a/0xf20 [ 15.164703][ C3] rcu_do_batch+0x34c/0xf20 [ 15.164707][ C3] ? find_held_lock+0x2b/0x80 [ 15.164711][ C3] ? __pfx_rcu_do_batch+0x10/0x10 [ 15.164715][ C3] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.164720][ C3] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.164723][ C3] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 15.164728][ C3] rcu_core+0x2bb/0x500 [ 15.164731][ C3] handle_softirqs+0x218/0x620 [ 15.164735][ C3] __irq_exit_rcu+0xfa/0x160 [ 15.164738][ C3] irq_exit_rcu+0xe/0x30 [ 15.164740][ C3] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.164743][ C3] [ 15.164744][ C3] [ 15.164745][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.164748][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 15.164752][ C3] Code: b0 b8 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 a3 d0 13 00 fb f4 cc cc cc cc 66 2e 0f 1f 84 00 00 00 00 00 66 90 90 90 90 90 90 [ 15.164755][ C3] RSP: 0018:ffffc90000157de8 EFLAGS: 00000246 [ 15.164758][ C3] RAX: 0000000000047bf3 RBX: 1ffff9200002afc1 RCX: ffffffffa1955a19 [ 15.164760][ C3] RDX: 0000000000000000 RSI: ffffffffa2485f31 RDI: ffffffffa1c50ce0 [ 15.164762][ C3] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c3667a [ 15.164763][ C3] R10: ffff8880361b33d3 R11: 0000000000000000 R12: 0000000000000000 [ 15.164765][ C3] R13: ffff888001bb4640 R14: dffffc0000000000 R15: 0000000000000000 [ 15.164769][ C3] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 15.164774][ C3] default_idle+0x9/0x10 [ 15.164777][ C3] default_idle_call+0x6d/0xb0 [ 15.164779][ C3] cpuidle_idle_call+0x26f/0x3a0 [ 15.164783][ C3] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 15.164787][ C3] ? tsc_verify_tsc_adjust+0x98/0x300 [ 15.164792][ C3] do_idle+0xf6/0x160 [ 15.164795][ C3] cpu_startup_entry+0x54/0x60 [ 15.164799][ C3] start_secondary+0x213/0x2a0 [ 15.164802][ C3] ? __pfx_start_secondary+0x10/0x10 [ 15.164808][ C3] common_startup_64+0x13e/0x148 [ 15.164814][ C3] [ 16.979565][ C1] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 16.979879][ C1] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 22, name: ksoftirqd/1 [ 16.980143][ C1] preempt_count: 100, expected: 0 [ 16.980296][ C1] RCU nest depth: 0, expected: 0 [ 16.980447][ C1] INFO: lockdep is turned off. [ 16.980604][ C1] Preemption disabled at: [ 16.980606][ C1] [] handle_softirqs+0xe5/0x620 [ 16.980915][ C1] CPU: 1 UID: 0 PID: 22 Comm: ksoftirqd/1 Tainted: G W 6.15.0-rc5-virtme #1 PREEMPT(full) [ 16.980921][ C1] Tainted: [W]=WARN [ 16.980922][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 16.980924][ C1] Call Trace: [ 16.980926][ C1] [ 16.980928][ C1] dump_stack_lvl+0xb0/0xd0 [ 16.980935][ C1] __might_resched+0x360/0x5a0 [ 16.980940][ C1] down_write+0x72/0x210 [ 16.980944][ C1] ? __pfx_down_write+0x10/0x10 [ 16.980947][ C1] ? simple_recursive_removal+0x3a/0x860 [ 16.980951][ C1] ? rcu_is_watching+0x12/0xc0 [ 16.980957][ C1] ? do_raw_spin_unlock+0x58/0x220 [ 16.980961][ C1] simple_recursive_removal+0x166/0x860 [ 16.980964][ C1] ? __pfx_remove_one+0x10/0x10 [ 16.980968][ C1] ? do_raw_spin_unlock+0x58/0x220 [ 16.980973][ C1] debugfs_remove+0x44/0x70 [ 16.980975][ C1] ref_tracker_dir_exit+0xcf/0x740 [ 16.980981][ C1] ? __pfx_ref_tracker_free+0x10/0x10 [ 16.980984][ C1] ? __sk_destruct+0x383/0x780 [ 16.980989][ C1] ? rcu_do_batch+0x34c/0xf20 [ 16.980993][ C1] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 16.980996][ C1] ? smpboot_thread_fn+0x307/0x960 [ 16.981000][ C1] ? kthread+0x37b/0x600 [ 16.981004][ C1] ? ret_from_fork+0x31/0x70 [ 16.981009][ C1] ? ret_from_fork_asm+0x1a/0x30 [ 16.981013][ C1] ? migrate_enable+0x1f2/0x270 [ 16.981018][ C1] ? __pfx_migrate_enable+0x10/0x10 [ 16.981022][ C1] ? bpf_sk_storage_free+0x9f/0x1c0 [ 16.981026][ C1] ? rcu_is_watching+0x12/0xc0 [ 16.981030][ C1] __put_net+0x19/0x60 [ 16.981034][ C1] __sk_destruct+0x58a/0x780 [ 16.981037][ C1] ? rcu_do_batch+0x34a/0xf20 [ 16.981040][ C1] rcu_do_batch+0x34c/0xf20 [ 16.981045][ C1] ? __pfx_rcu_do_batch+0x10/0x10 [ 16.981049][ C1] ? rcu_is_watching+0x12/0xc0 [ 16.981053][ C1] ? trace_irq_enable.constprop.0+0xd4/0x130 [ 16.981059][ C1] rcu_core+0x2bb/0x500 [ 16.981062][ C1] handle_softirqs+0x218/0x620 [ 16.981065][ C1] ? __pfx_run_ksoftirqd+0x10/0x10 [ 16.981069][ C1] run_ksoftirqd+0x3f/0x70 [ 16.981071][ C1] smpboot_thread_fn+0x307/0x960 [ 16.981074][ C1] ? __pfx_smpboot_thread_fn+0x10/0x10 [ 16.981077][ C1] kthread+0x37b/0x600 [ 16.981081][ C1] ? __pfx_kthread+0x10/0x10 [ 16.981083][ C1] ? ret_from_fork+0x1b/0x70 [ 16.981086][ C1] ? __lock_release+0x5d/0x170 [ 16.981091][ C1] ? rcu_is_watching+0x12/0xc0 [ 16.981095][ C1] ? __pfx_kthread+0x10/0x10 [ 16.981098][ C1] ret_from_fork+0x31/0x70 [ 16.981101][ C1] ? __pfx_kthread+0x10/0x10 [ 16.981104][ C1] ret_from_fork_asm+0x1a/0x30 [ 16.981111][ C1]