[ 15.323900][ C0] [ 15.324045][ C0] ================================ [ 15.324256][ C0] WARNING: inconsistent lock state [ 15.324464][ C0] 6.15.0-virtme #1 Not tainted [ 15.324672][ C0] -------------------------------- [ 15.324877][ C0] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 15.325131][ C0] swapper/0/0 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 15.325386][ C0] ffffffff87bc5af8 (pin_fs_lock){+.?.}-{3:3}, at: simple_pin_fs+0x24/0x150 [ 15.325756][ C0] {SOFTIRQ-ON-W} state was registered at: [ 15.325962][ C0] __lock_acquire+0x20b/0x7e0 [ 15.326171][ C0] lock_acquire.part.0+0xb6/0x240 [ 15.326380][ C0] _raw_spin_lock+0x33/0x40 [ 15.326587][ C0] simple_pin_fs+0x24/0x150 [ 15.326794][ C0] start_creating.part.0+0x52/0x310 [ 15.327001][ C0] debugfs_create_dir+0x6a/0x540 [ 15.327206][ C0] component_debug_init+0x17/0x30 [ 15.327413][ C0] do_one_initcall+0x8f/0x1e0 [ 15.327619][ C0] do_initcalls+0x176/0x280 [ 15.327824][ C0] kernel_init_freeable+0x22d/0x300 [ 15.328031][ C0] kernel_init+0x20/0x200 [ 15.328234][ C0] ret_from_fork+0x240/0x320 [ 15.328439][ C0] ret_from_fork_asm+0x1a/0x30 [ 15.328642][ C0] irq event stamp: 456902 [ 15.328799][ C0] hardirqs last enabled at (456902): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.329206][ C0] hardirqs last disabled at (456901): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 15.329611][ C0] softirqs last enabled at (454820): [] handle_softirqs+0x358/0x620 [ 15.329967][ C0] softirqs last disabled at (454851): [] __irq_exit_rcu+0xfa/0x160 [ 15.330327][ C0] [ 15.330327][ C0] other info that might help us debug this: [ 15.330624][ C0] Possible unsafe locking scenario: [ 15.330624][ C0] [ 15.330929][ C0] CPU0 [ 15.331083][ C0] ---- [ 15.331237][ C0] lock(pin_fs_lock); [ 15.331395][ C0] [ 15.331548][ C0] lock(pin_fs_lock); [ 15.331706][ C0] [ 15.331706][ C0] *** DEADLOCK *** [ 15.331706][ C0] [ 15.332006][ C0] 1 lock held by swapper/0/0: [ 15.332215][ C0] #0: ffffffff879774c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 15.332581][ C0] [ 15.332581][ C0] stack backtrace: [ 15.332835][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 15.332839][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.332841][ C0] Call Trace: [ 15.332843][ C0] [ 15.332845][ C0] dump_stack_lvl+0x82/0xd0 [ 15.332851][ C0] print_usage_bug.part.0+0x25f/0x360 [ 15.332855][ C0] mark_lock_irq+0x343/0x400 [ 15.332859][ C0] ? is_bpf_text_address+0x67/0x120 [ 15.332864][ C0] ? __lock_release+0x5d/0x170 [ 15.332869][ C0] ? save_trace+0x52/0x170 [ 15.332875][ C0] mark_lock+0x174/0x2f0 [ 15.332878][ C0] mark_usage+0x46/0x150 [ 15.332881][ C0] __lock_acquire+0x20b/0x7e0 [ 15.332884][ C0] ? __lock_acquire+0x44d/0x7e0 [ 15.332888][ C0] lock_acquire.part.0+0xb6/0x240 [ 15.332891][ C0] ? simple_pin_fs+0x24/0x150 [ 15.332895][ C0] ? rcu_is_watching+0x12/0xc0 [ 15.332900][ C0] ? lock_acquire+0x10c/0x170 [ 15.332902][ C0] ? simple_pin_fs+0x24/0x150 [ 15.332907][ C0] _raw_spin_lock+0x33/0x40 [ 15.332910][ C0] ? simple_pin_fs+0x24/0x150 [ 15.332914][ C0] simple_pin_fs+0x24/0x150 [ 15.332918][ C0] debugfs_remove+0x35/0x70 [ 15.332921][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 15.332927][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 15.332931][ C0] ? __sk_destruct+0x383/0x780 [ 15.332936][ C0] ? rcu_do_batch+0x34c/0xf20 [ 15.332939][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 15.332942][ C0] ? irq_exit_rcu+0xe/0x30 [ 15.332945][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.332949][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.332953][ C0] ? pv_native_safe_halt+0xf/0x20 [ 15.332956][ C0] ? default_idle+0x9/0x10 [ 15.332959][ C0] ? default_idle_call+0x6d/0xb0 [ 15.332961][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 15.332964][ C0] ? do_idle+0xf6/0x160 [ 15.332966][ C0] ? cpu_startup_entry+0x54/0x60 [ 15.332969][ C0] ? rest_init+0x14b/0x260 [ 15.332972][ C0] ? start_kernel+0x350/0x410 [ 15.332977][ C0] __put_net+0x19/0x60 [ 15.332980][ C0] __sk_destruct+0x58a/0x780 [ 15.332984][ C0] ? rcu_do_batch+0x34a/0xf20 [ 15.332986][ C0] rcu_do_batch+0x34c/0xf20 [ 15.332990][ C0] ? find_held_lock+0x2b/0x80 [ 15.332994][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 15.332997][ C0] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.333001][ C0] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.333003][ C0] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 15.333008][ C0] rcu_core+0x2bb/0x500 [ 15.333012][ C0] handle_softirqs+0x218/0x620 [ 15.333017][ C0] __irq_exit_rcu+0xfa/0x160 [ 15.333020][ C0] irq_exit_rcu+0xe/0x30 [ 15.333023][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.333026][ C0] [ 15.333027][ C0] [ 15.333029][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.333032][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 15.333036][ C0] Code: 92 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 37 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 [ 15.333038][ C0] RSP: 0018:ffffffff87607df8 EFLAGS: 00000242 [ 15.333041][ C0] RAX: 000000000006f0c1 RBX: 1ffffffff0ec0fc3 RCX: ffffffff869905d9 [ 15.333043][ C0] RDX: 0000000000000000 RSI: ffffffff8748f4e4 RDI: ffffffff86c53be0 [ 15.333045][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1005e866fa [ 15.333047][ C0] R10: ffff88802f4337d3 R11: ffffffff87611288 R12: 0000000000000000 [ 15.333048][ C0] R13: ffffffff8761f240 R14: dffffc0000000000 R15: 0000000000014770 [ 15.333052][ C0] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 15.333057][ C0] default_idle+0x9/0x10 [ 15.333060][ C0] default_idle_call+0x6d/0xb0 [ 15.333062][ C0] cpuidle_idle_call+0x26f/0x3a0 [ 15.333065][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 15.333069][ C0] ? tsc_verify_tsc_adjust+0x98/0x310 [ 15.333074][ C0] do_idle+0xf6/0x160 [ 15.333077][ C0] cpu_startup_entry+0x54/0x60 [ 15.333080][ C0] rest_init+0x14b/0x260 [ 15.333083][ C0] start_kernel+0x350/0x410 [ 15.333087][ C0] x86_64_start_reservations+0x18/0x30 [ 15.333092][ C0] x86_64_start_kernel+0xf8/0x150 [ 15.333096][ C0] common_startup_64+0x13e/0x148 [ 15.333105][ C0] [ 15.350833][ C0] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 15.351304][ C0] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/0 [ 15.351637][ C0] preempt_count: 101, expected: 0 [ 15.351951][ C0] RCU nest depth: 0, expected: 0 [ 15.352143][ C0] INFO: lockdep is turned off. [ 15.352341][ C0] Preemption disabled at: [ 15.352342][ C0] [] schedule_preempt_disabled+0x22/0x30 [ 15.352904][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 15.352908][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.352909][ C0] Call Trace: [ 15.352911][ C0] [ 15.352913][ C0] dump_stack_lvl+0xb0/0xd0 [ 15.352918][ C0] __might_resched+0x360/0x5a0 [ 15.352924][ C0] down_write+0x72/0x210 [ 15.352928][ C0] ? __pfx_down_write+0x10/0x10 [ 15.352931][ C0] ? simple_recursive_removal+0x33/0x610 [ 15.352935][ C0] ? rcu_is_watching+0x12/0xc0 [ 15.352940][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 15.352946][ C0] simple_recursive_removal+0x6a/0x610 [ 15.352949][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 15.352952][ C0] ? __pfx_remove_one+0x10/0x10 [ 15.352958][ C0] debugfs_remove+0x44/0x70 [ 15.352961][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 15.352967][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 15.352970][ C0] ? __sk_destruct+0x383/0x780 [ 15.352975][ C0] ? rcu_do_batch+0x34c/0xf20 [ 15.352978][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 15.352981][ C0] ? irq_exit_rcu+0xe/0x30 [ 15.352986][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.352990][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.352994][ C0] ? pv_native_safe_halt+0xf/0x20 [ 15.352997][ C0] ? default_idle+0x9/0x10 [ 15.353000][ C0] ? default_idle_call+0x6d/0xb0 [ 15.353002][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 15.353005][ C0] ? do_idle+0xf6/0x160 [ 15.353008][ C0] ? cpu_startup_entry+0x54/0x60 [ 15.353010][ C0] ? rest_init+0x14b/0x260 [ 15.353013][ C0] ? start_kernel+0x350/0x410 [ 15.353020][ C0] __put_net+0x19/0x60 [ 15.353023][ C0] __sk_destruct+0x58a/0x780 [ 15.353027][ C0] ? rcu_do_batch+0x34a/0xf20 [ 15.353030][ C0] rcu_do_batch+0x34c/0xf20 [ 15.353033][ C0] ? find_held_lock+0x2b/0x80 [ 15.353038][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 15.353041][ C0] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.353045][ C0] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.353048][ C0] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 15.353053][ C0] rcu_core+0x2bb/0x500 [ 15.353057][ C0] handle_softirqs+0x218/0x620 [ 15.353062][ C0] __irq_exit_rcu+0xfa/0x160 [ 15.353066][ C0] irq_exit_rcu+0xe/0x30 [ 15.353068][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.353072][ C0] [ 15.353073][ C0] [ 15.353074][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.353077][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 15.353081][ C0] Code: 92 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 37 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 [ 15.353083][ C0] RSP: 0018:ffffffff87607df8 EFLAGS: 00000242 [ 15.353086][ C0] RAX: 000000000006f0c1 RBX: 1ffffffff0ec0fc3 RCX: ffffffff869905d9 [ 15.353088][ C0] RDX: 0000000000000000 RSI: ffffffff8748f4e4 RDI: ffffffff86c53be0 [ 15.353090][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1005e866fa [ 15.353092][ C0] R10: ffff88802f4337d3 R11: ffffffff87611288 R12: 0000000000000000 [ 15.353093][ C0] R13: ffffffff8761f240 R14: dffffc0000000000 R15: 0000000000014770 [ 15.353097][ C0] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 15.353102][ C0] default_idle+0x9/0x10 [ 15.353105][ C0] default_idle_call+0x6d/0xb0 [ 15.353107][ C0] cpuidle_idle_call+0x26f/0x3a0 [ 15.353110][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 15.353114][ C0] ? tsc_verify_tsc_adjust+0x98/0x310 [ 15.353119][ C0] do_idle+0xf6/0x160 [ 15.353122][ C0] cpu_startup_entry+0x54/0x60 [ 15.353125][ C0] rest_init+0x14b/0x260 [ 15.353128][ C0] start_kernel+0x350/0x410 [ 15.353132][ C0] x86_64_start_reservations+0x18/0x30 [ 15.353137][ C0] x86_64_start_kernel+0xf8/0x150 [ 15.353141][ C0] common_startup_64+0x13e/0x148 [ 15.353149][ C0] [ 17.235402][ C1] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 17.235818][ C1] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 22, name: ksoftirqd/1 [ 17.236101][ C1] preempt_count: 100, expected: 0 [ 17.236257][ C1] RCU nest depth: 0, expected: 0 [ 17.236422][ C1] INFO: lockdep is turned off. [ 17.236580][ C1] Preemption disabled at: [ 17.236582][ C1] [] handle_softirqs+0xe5/0x620 [ 17.236907][ C1] CPU: 1 UID: 0 PID: 22 Comm: ksoftirqd/1 Tainted: G W 6.15.0-virtme #1 PREEMPT(full) [ 17.236913][ C1] Tainted: [W]=WARN [ 17.236914][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 17.236917][ C1] Call Trace: [ 17.236919][ C1] [ 17.236921][ C1] dump_stack_lvl+0xb0/0xd0 [ 17.236928][ C1] __might_resched+0x360/0x5a0 [ 17.236935][ C1] down_write+0x72/0x210 [ 17.236939][ C1] ? __pfx_down_write+0x10/0x10 [ 17.236942][ C1] ? simple_recursive_removal+0x33/0x610 [ 17.236947][ C1] ? rcu_is_watching+0x12/0xc0 [ 17.236952][ C1] ? do_raw_spin_unlock+0x58/0x220 [ 17.236958][ C1] simple_recursive_removal+0x6a/0x610 [ 17.236961][ C1] ? do_raw_spin_unlock+0x58/0x220 [ 17.236964][ C1] ? __pfx_remove_one+0x10/0x10 [ 17.236970][ C1] debugfs_remove+0x44/0x70 [ 17.236973][ C1] ref_tracker_dir_exit+0xcf/0x740 [ 17.236979][ C1] ? __pfx_ref_tracker_free+0x10/0x10 [ 17.236982][ C1] ? __sk_destruct+0x383/0x780 [ 17.236988][ C1] ? rcu_do_batch+0x34c/0xf20 [ 17.236991][ C1] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 17.236994][ C1] ? smpboot_thread_fn+0x30a/0x960 [ 17.236999][ C1] ? kthread+0x37e/0x600 [ 17.237002][ C1] ? ret_from_fork+0x240/0x320 [ 17.237006][ C1] ? ret_from_fork_asm+0x1a/0x30 [ 17.237011][ C1] ? migrate_enable+0x1f2/0x270 [ 17.237015][ C1] ? __pfx_migrate_enable+0x10/0x10 [ 17.237018][ C1] ? bpf_sk_storage_free+0x9f/0x1c0 [ 17.237022][ C1] ? rcu_is_watching+0x12/0xc0 [ 17.237027][ C1] __put_net+0x19/0x60 [ 17.237030][ C1] __sk_destruct+0x58a/0x780 [ 17.237034][ C1] ? rcu_do_batch+0x34a/0xf20 [ 17.237037][ C1] rcu_do_batch+0x34c/0xf20 [ 17.237041][ C1] ? __pfx_rcu_do_batch+0x10/0x10 [ 17.237045][ C1] ? rcu_is_watching+0x12/0xc0 [ 17.237048][ C1] ? trace_irq_enable.constprop.0+0xd4/0x130 [ 17.237055][ C1] rcu_core+0x2bb/0x500 [ 17.237059][ C1] handle_softirqs+0x218/0x620 [ 17.237063][ C1] ? __pfx_run_ksoftirqd+0x10/0x10 [ 17.237067][ C1] run_ksoftirqd+0x3f/0x70 [ 17.237070][ C1] smpboot_thread_fn+0x30a/0x960 [ 17.237074][ C1] ? __pfx_smpboot_thread_fn+0x10/0x10 [ 17.237078][ C1] kthread+0x37e/0x600 [ 17.237081][ C1] ? __pfx_kthread+0x10/0x10 [ 17.237083][ C1] ? ret_from_fork+0x1b/0x320 [ 17.237086][ C1] ? __lock_release+0x5d/0x170 [ 17.237090][ C1] ? rcu_is_watching+0x12/0xc0 [ 17.237093][ C1] ? __pfx_kthread+0x10/0x10 [ 17.237096][ C1] ret_from_fork+0x240/0x320 [ 17.237098][ C1] ? __pfx_kthread+0x10/0x10 [ 17.237101][ C1] ret_from_fork_asm+0x1a/0x30 [ 17.237108][ C1]