[ 18.114915][ C0] [ 18.115170][ C0] ================================ [ 18.115521][ C0] WARNING: inconsistent lock state [ 18.115871][ C0] 6.15.0-rc7-virtme #1 Not tainted [ 18.116225][ C0] -------------------------------- [ 18.116588][ C0] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 18.117029][ C0] swapper/0/0 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 18.117473][ C0] ffffffff93dbff78 (pin_fs_lock){+.?.}-{3:3}, at: simple_pin_fs+0x24/0x150 [ 18.118105][ C0] {SOFTIRQ-ON-W} state was registered at: [ 18.118449][ C0] __lock_acquire+0x3eb/0x9d0 [ 18.118809][ C0] lock_acquire.part.0+0xb6/0x240 [ 18.119164][ C0] _raw_spin_lock+0x33/0x40 [ 18.119521][ C0] simple_pin_fs+0x24/0x150 [ 18.119877][ C0] start_creating.part.0+0x3f/0x2f0 [ 18.120231][ C0] debugfs_create_dir+0x6a/0x540 [ 18.120582][ C0] component_debug_init+0x17/0x30 [ 18.120939][ C0] do_one_initcall+0x8f/0x1e0 [ 18.121298][ C0] do_initcalls+0x176/0x280 [ 18.121655][ C0] kernel_init_freeable+0x22d/0x300 [ 18.121910][ C0] kernel_init+0x20/0x200 [ 18.122114][ C0] ret_from_fork+0x31/0x70 [ 18.122419][ C0] ret_from_fork_asm+0x1a/0x30 [ 18.122715][ C0] irq event stamp: 451420 [ 18.122978][ C0] hardirqs last enabled at (451420): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 18.123565][ C0] hardirqs last disabled at (451419): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 18.124247][ C0] softirqs last enabled at (450782): [] handle_softirqs+0x358/0x620 [ 18.124862][ C0] softirqs last disabled at (450837): [] __irq_exit_rcu+0xfa/0x160 [ 18.125474][ C0] [ 18.125474][ C0] other info that might help us debug this: [ 18.125984][ C0] Possible unsafe locking scenario: [ 18.125984][ C0] [ 18.126503][ C0] CPU0 [ 18.126773][ C0] ---- [ 18.127039][ C0] lock(pin_fs_lock); [ 18.127305][ C0] [ 18.127570][ C0] lock(pin_fs_lock); [ 18.127845][ C0] [ 18.127845][ C0] *** DEADLOCK *** [ 18.127845][ C0] [ 18.128370][ C0] 1 lock held by swapper/0/0: [ 18.128715][ C0] #0: ffffffff93b749c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 18.129342][ C0] [ 18.129342][ C0] stack backtrace: [ 18.129778][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 6.15.0-rc7-virtme #1 PREEMPT(full) [ 18.129786][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 18.129790][ C0] Call Trace: [ 18.129793][ C0] [ 18.129796][ C0] dump_stack_lvl+0x82/0xd0 [ 18.129805][ C0] print_usage_bug.part.0+0x25f/0x360 [ 18.129815][ C0] mark_lock_irq+0x343/0x400 [ 18.129821][ C0] ? is_bpf_text_address+0x67/0x120 [ 18.129829][ C0] ? __lock_release+0x5d/0x170 [ 18.129836][ C0] ? save_trace+0x52/0x170 [ 18.129844][ C0] mark_lock+0x174/0x2f0 [ 18.129851][ C0] mark_usage+0x46/0x150 [ 18.129858][ C0] __lock_acquire+0x3eb/0x9d0 [ 18.129867][ C0] lock_acquire.part.0+0xb6/0x240 [ 18.129871][ C0] ? simple_pin_fs+0x24/0x150 [ 18.129877][ C0] ? rcu_is_watching+0x12/0xc0 [ 18.129884][ C0] ? lock_acquire+0x10c/0x170 [ 18.129888][ C0] ? simple_pin_fs+0x24/0x150 [ 18.129895][ C0] _raw_spin_lock+0x33/0x40 [ 18.129901][ C0] ? simple_pin_fs+0x24/0x150 [ 18.129906][ C0] simple_pin_fs+0x24/0x150 [ 18.129911][ C0] debugfs_remove+0x35/0x70 [ 18.129917][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 18.129925][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 18.129930][ C0] ? __sk_destruct+0x383/0x780 [ 18.129937][ C0] ? rcu_do_batch+0x34f/0xf20 [ 18.129944][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 18.129948][ C0] ? irq_exit_rcu+0xe/0x30 [ 18.129953][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 18.129959][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 18.129966][ C0] ? pv_native_safe_halt+0xf/0x20 [ 18.129971][ C0] ? default_idle+0x9/0x10 [ 18.129975][ C0] ? default_idle_call+0x6d/0xb0 [ 18.129979][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 18.129986][ C0] ? do_idle+0xf6/0x160 [ 18.129991][ C0] ? cpu_startup_entry+0x54/0x60 [ 18.129995][ C0] ? rest_init+0x14b/0x260 [ 18.130000][ C0] ? start_kernel+0x350/0x410 [ 18.130011][ C0] __put_net+0x19/0x60 [ 18.130017][ C0] __sk_destruct+0x58a/0x780 [ 18.130024][ C0] ? rcu_do_batch+0x34a/0xf20 [ 18.130028][ C0] rcu_do_batch+0x34f/0xf20 [ 18.130034][ C0] ? find_held_lock+0x2b/0x80 [ 18.130040][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 18.130046][ C0] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 18.130052][ C0] ? lockdep_hardirqs_on+0x7c/0x110 [ 18.130059][ C0] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 18.130067][ C0] rcu_core+0x2bb/0x500 [ 18.130073][ C0] handle_softirqs+0x218/0x620 [ 18.130083][ C0] __irq_exit_rcu+0xfa/0x160 [ 18.130087][ C0] irq_exit_rcu+0xe/0x30 [ 18.130091][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 18.130097][ C0] [ 18.130099][ C0] [ 18.130102][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 18.130107][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 18.130113][ C0] Code: 60 b8 00 e9 c3 57 02 00 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 c3 75 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 [ 18.130118][ C0] RSP: 0018:ffffffff93807df8 EFLAGS: 00000242 [ 18.130123][ C0] RAX: 000000000006e113 RBX: 1ffffffff2700fc3 RCX: ffffffff92b5ba19 [ 18.130127][ C0] RDX: 0000000000000000 RSI: ffffffff93687785 RDI: ffffffff92e51260 [ 18.130130][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c0667a [ 18.130133][ C0] R10: ffff8880360333d3 R11: 0000000000000000 R12: 0000000000000000 [ 18.130136][ C0] R13: ffffffff9381f240 R14: dffffc0000000000 R15: 0000000000014770 [ 18.130144][ C0] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 18.130154][ C0] default_idle+0x9/0x10 [ 18.130158][ C0] default_idle_call+0x6d/0xb0 [ 18.130162][ C0] cpuidle_idle_call+0x26f/0x3a0 [ 18.130169][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 18.130176][ C0] ? tsc_verify_tsc_adjust+0x98/0x300 [ 18.130187][ C0] do_idle+0xf6/0x160 [ 18.130193][ C0] cpu_startup_entry+0x54/0x60 [ 18.130200][ C0] rest_init+0x14b/0x260 [ 18.130205][ C0] start_kernel+0x350/0x410 [ 18.130212][ C0] x86_64_start_reservations+0x18/0x30 [ 18.130219][ C0] x86_64_start_kernel+0xba/0x110 [ 18.130226][ C0] common_startup_64+0x13e/0x148 [ 18.130241][ C0] [ 18.158652][ C0] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 18.159127][ C0] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/0 [ 18.159504][ C0] preempt_count: 101, expected: 0 [ 18.159713][ C0] RCU nest depth: 0, expected: 0 [ 18.160001][ C0] INFO: lockdep is turned off. [ 18.160319][ C0] Preemption disabled at: [ 18.160323][ C0] [] schedule_preempt_disabled+0x22/0x30 [ 18.160881][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 6.15.0-rc7-virtme #1 PREEMPT(full) [ 18.160886][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 18.160888][ C0] Call Trace: [ 18.160890][ C0] [ 18.160892][ C0] dump_stack_lvl+0xb0/0xd0 [ 18.160898][ C0] __might_resched+0x360/0x5a0 [ 18.160904][ C0] down_write+0x72/0x210 [ 18.160908][ C0] ? __pfx_down_write+0x10/0x10 [ 18.160911][ C0] ? simple_recursive_removal+0x3a/0x860 [ 18.160916][ C0] ? rcu_is_watching+0x12/0xc0 [ 18.160923][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 18.160927][ C0] simple_recursive_removal+0x166/0x860 [ 18.160930][ C0] ? __pfx_remove_one+0x10/0x10 [ 18.160935][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 18.160939][ C0] debugfs_remove+0x44/0x70 [ 18.160942][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 18.160948][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 18.160951][ C0] ? __sk_destruct+0x383/0x780 [ 18.160956][ C0] ? rcu_do_batch+0x34f/0xf20 [ 18.160961][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 18.160963][ C0] ? irq_exit_rcu+0xe/0x30 [ 18.160967][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 18.160972][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 18.160976][ C0] ? pv_native_safe_halt+0xf/0x20 [ 18.160979][ C0] ? default_idle+0x9/0x10 [ 18.160981][ C0] ? default_idle_call+0x6d/0xb0 [ 18.160984][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 18.160988][ C0] ? do_idle+0xf6/0x160 [ 18.160991][ C0] ? cpu_startup_entry+0x54/0x60 [ 18.160995][ C0] ? rest_init+0x14b/0x260 [ 18.160998][ C0] ? start_kernel+0x350/0x410 [ 18.161005][ C0] __put_net+0x19/0x60 [ 18.161009][ C0] __sk_destruct+0x58a/0x780 [ 18.161013][ C0] ? rcu_do_batch+0x34a/0xf20 [ 18.161016][ C0] rcu_do_batch+0x34f/0xf20 [ 18.161020][ C0] ? find_held_lock+0x2b/0x80 [ 18.161025][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 18.161029][ C0] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 18.161033][ C0] ? lockdep_hardirqs_on+0x7c/0x110 [ 18.161037][ C0] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 18.161042][ C0] rcu_core+0x2bb/0x500 [ 18.161046][ C0] handle_softirqs+0x218/0x620 [ 18.161050][ C0] __irq_exit_rcu+0xfa/0x160 [ 18.161053][ C0] irq_exit_rcu+0xe/0x30 [ 18.161056][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 18.161061][ C0] [ 18.161062][ C0] [ 18.161065][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 18.161069][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 18.161075][ C0] Code: 60 b8 00 e9 c3 57 02 00 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 c3 75 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 [ 18.161079][ C0] RSP: 0018:ffffffff93807df8 EFLAGS: 00000242 [ 18.161084][ C0] RAX: 000000000006e113 RBX: 1ffffffff2700fc3 RCX: ffffffff92b5ba19 [ 18.161089][ C0] RDX: 0000000000000000 RSI: ffffffff93687785 RDI: ffffffff92e51260 [ 18.161092][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c0667a [ 18.161095][ C0] R10: ffff8880360333d3 R11: 0000000000000000 R12: 0000000000000000 [ 18.161098][ C0] R13: ffffffff9381f240 R14: dffffc0000000000 R15: 0000000000014770 [ 18.161107][ C0] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 18.161115][ C0] default_idle+0x9/0x10 [ 18.161119][ C0] default_idle_call+0x6d/0xb0 [ 18.161123][ C0] cpuidle_idle_call+0x26f/0x3a0 [ 18.161129][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 18.161136][ C0] ? tsc_verify_tsc_adjust+0x98/0x300 [ 18.161146][ C0] do_idle+0xf6/0x160 [ 18.161153][ C0] cpu_startup_entry+0x54/0x60 [ 18.161159][ C0] rest_init+0x14b/0x260 [ 18.161166][ C0] start_kernel+0x350/0x410 [ 18.161173][ C0] x86_64_start_reservations+0x18/0x30 [ 18.161180][ C0] x86_64_start_kernel+0xba/0x110 [ 18.161187][ C0] common_startup_64+0x13e/0x148 [ 18.161203][ C0] [ 20.756795][ C0] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 20.757111][ C0] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 14, name: ksoftirqd/0 [ 20.757431][ C0] preempt_count: 100, expected: 0 [ 20.757602][ C0] RCU nest depth: 0, expected: 0 [ 20.757763][ C0] INFO: lockdep is turned off. [ 20.757918][ C0] Preemption disabled at: [ 20.757920][ C0] [] handle_softirqs+0xe5/0x620 [ 20.758240][ C0] CPU: 0 UID: 0 PID: 14 Comm: ksoftirqd/0 Tainted: G W 6.15.0-rc7-virtme #1 PREEMPT(full) [ 20.758245][ C0] Tainted: [W]=WARN [ 20.758247][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 20.758249][ C0] Call Trace: [ 20.758251][ C0] [ 20.758253][ C0] dump_stack_lvl+0xb0/0xd0 [ 20.758260][ C0] __might_resched+0x360/0x5a0 [ 20.758266][ C0] down_write+0x72/0x210 [ 20.758270][ C0] ? __pfx_down_write+0x10/0x10 [ 20.758273][ C0] ? simple_recursive_removal+0x3a/0x860 [ 20.758278][ C0] ? rcu_is_watching+0x12/0xc0 [ 20.758284][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 20.758289][ C0] simple_recursive_removal+0x166/0x860 [ 20.758292][ C0] ? __pfx_remove_one+0x10/0x10 [ 20.758296][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 20.758301][ C0] debugfs_remove+0x44/0x70 [ 20.758304][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 20.758310][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 20.758313][ C0] ? __sk_destruct+0x383/0x780 [ 20.758318][ C0] ? rcu_do_batch+0x34f/0xf20 [ 20.758322][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 20.758325][ C0] ? smpboot_thread_fn+0x307/0x960 [ 20.758329][ C0] ? kthread+0x37b/0x600 [ 20.758334][ C0] ? ret_from_fork+0x31/0x70 [ 20.758337][ C0] ? ret_from_fork_asm+0x1a/0x30 [ 20.758341][ C0] ? migrate_enable+0x1f2/0x270 [ 20.758346][ C0] ? __pfx_migrate_enable+0x10/0x10 [ 20.758350][ C0] ? bpf_sk_storage_free+0x9f/0x1c0 [ 20.758355][ C0] ? rcu_is_watching+0x12/0xc0 [ 20.758360][ C0] __put_net+0x19/0x60 [ 20.758364][ C0] __sk_destruct+0x58a/0x780 [ 20.758367][ C0] ? rcu_do_batch+0x34a/0xf20 [ 20.758371][ C0] rcu_do_batch+0x34f/0xf20 [ 20.758376][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 20.758380][ C0] ? rcu_is_watching+0x12/0xc0 [ 20.758383][ C0] ? trace_irq_enable.constprop.0+0xd4/0x130 [ 20.758389][ C0] rcu_core+0x2bb/0x500 [ 20.758393][ C0] handle_softirqs+0x218/0x620 [ 20.758397][ C0] ? __pfx_run_ksoftirqd+0x10/0x10 [ 20.758400][ C0] run_ksoftirqd+0x3f/0x70 [ 20.758402][ C0] smpboot_thread_fn+0x307/0x960 [ 20.758405][ C0] ? __pfx_smpboot_thread_fn+0x10/0x10 [ 20.758409][ C0] kthread+0x37b/0x600 [ 20.758412][ C0] ? __pfx_kthread+0x10/0x10 [ 20.758415][ C0] ? ret_from_fork+0x1b/0x70 [ 20.758417][ C0] ? __lock_release+0x5d/0x170 [ 20.758420][ C0] ? rcu_is_watching+0x12/0xc0 [ 20.758424][ C0] ? __pfx_kthread+0x10/0x10 [ 20.758427][ C0] ret_from_fork+0x31/0x70 [ 20.758430][ C0] ? __pfx_kthread+0x10/0x10 [ 20.758433][ C0] ret_from_fork_asm+0x1a/0x30 [ 20.758439][ C0]