[ 18.507709][ C0] [ 18.507868][ C0] ================================ [ 18.508078][ C0] WARNING: inconsistent lock state [ 18.508284][ C0] 6.15.0-rc7-virtme #1 Not tainted [ 18.508507][ C0] -------------------------------- [ 18.508747][ C0] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 18.509026][ C0] swapper/0/0 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 18.509290][ C0] ffffffffb31bff78 (pin_fs_lock){+.?.}-{3:3}, at: simple_pin_fs+0x24/0x150 [ 18.509683][ C0] {SOFTIRQ-ON-W} state was registered at: [ 18.509893][ C0] __lock_acquire+0x3eb/0x9d0 [ 18.510106][ C0] lock_acquire.part.0+0xb6/0x240 [ 18.510312][ C0] _raw_spin_lock+0x33/0x40 [ 18.510526][ C0] simple_pin_fs+0x24/0x150 [ 18.510759][ C0] start_creating.part.0+0x3f/0x2f0 [ 18.510968][ C0] debugfs_create_dir+0x6a/0x540 [ 18.511176][ C0] component_debug_init+0x17/0x30 [ 18.511386][ C0] do_one_initcall+0x8f/0x1e0 [ 18.511599][ C0] do_initcalls+0x176/0x280 [ 18.511809][ C0] kernel_init_freeable+0x22d/0x300 [ 18.512023][ C0] kernel_init+0x20/0x200 [ 18.512233][ C0] ret_from_fork+0x31/0x70 [ 18.512443][ C0] ret_from_fork_asm+0x1a/0x30 [ 18.512650][ C0] irq event stamp: 443050 [ 18.512809][ C0] hardirqs last enabled at (443050): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 18.513232][ C0] hardirqs last disabled at (443049): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 18.513674][ C0] softirqs last enabled at (440942): [] handle_softirqs+0x358/0x620 [ 18.514058][ C0] softirqs last disabled at (440985): [] __irq_exit_rcu+0xfa/0x160 [ 18.514429][ C0] [ 18.514429][ C0] other info that might help us debug this: [ 18.514760][ C0] Possible unsafe locking scenario: [ 18.514760][ C0] [ 18.515067][ C0] CPU0 [ 18.515225][ C0] ---- [ 18.515383][ C0] lock(pin_fs_lock); [ 18.515543][ C0] [ 18.515696][ C0] lock(pin_fs_lock); [ 18.515863][ C0] [ 18.515863][ C0] *** DEADLOCK *** [ 18.515863][ C0] [ 18.516188][ C0] 1 lock held by swapper/0/0: [ 18.516398][ C0] #0: ffffffffb2f749c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 18.516776][ C0] [ 18.516776][ C0] stack backtrace: [ 18.517044][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 6.15.0-rc7-virtme #1 PREEMPT(full) [ 18.517050][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 18.517053][ C0] Call Trace: [ 18.517055][ C0] [ 18.517057][ C0] dump_stack_lvl+0x82/0xd0 [ 18.517065][ C0] print_usage_bug.part.0+0x25f/0x360 [ 18.517072][ C0] mark_lock_irq+0x343/0x400 [ 18.517076][ C0] ? is_bpf_text_address+0x67/0x120 [ 18.517083][ C0] ? __lock_release+0x5d/0x170 [ 18.517087][ C0] ? save_trace+0x52/0x170 [ 18.517091][ C0] mark_lock+0x174/0x2f0 [ 18.517096][ C0] mark_usage+0x46/0x150 [ 18.517100][ C0] __lock_acquire+0x3eb/0x9d0 [ 18.517105][ C0] lock_acquire.part.0+0xb6/0x240 [ 18.517108][ C0] ? simple_pin_fs+0x24/0x150 [ 18.517113][ C0] ? rcu_is_watching+0x12/0xc0 [ 18.517119][ C0] ? lock_acquire+0x10c/0x170 [ 18.517122][ C0] ? simple_pin_fs+0x24/0x150 [ 18.517125][ C0] _raw_spin_lock+0x33/0x40 [ 18.517128][ C0] ? simple_pin_fs+0x24/0x150 [ 18.517131][ C0] simple_pin_fs+0x24/0x150 [ 18.517134][ C0] debugfs_remove+0x35/0x70 [ 18.517138][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 18.517144][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 18.517147][ C0] ? __sk_destruct+0x383/0x780 [ 18.517154][ C0] ? rcu_do_batch+0x34f/0xf20 [ 18.517157][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 18.517160][ C0] ? irq_exit_rcu+0xe/0x30 [ 18.517164][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 18.517169][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 18.517174][ C0] ? pv_native_safe_halt+0xf/0x20 [ 18.517177][ C0] ? default_idle+0x9/0x10 [ 18.517180][ C0] ? default_idle_call+0x6d/0xb0 [ 18.517183][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 18.517189][ C0] ? do_idle+0xf6/0x160 [ 18.517192][ C0] ? cpu_startup_entry+0x54/0x60 [ 18.517196][ C0] ? rest_init+0x14b/0x260 [ 18.517198][ C0] ? start_kernel+0x350/0x410 [ 18.517206][ C0] __put_net+0x19/0x60 [ 18.517211][ C0] __sk_destruct+0x58a/0x780 [ 18.517215][ C0] ? rcu_do_batch+0x34a/0xf20 [ 18.517218][ C0] rcu_do_batch+0x34f/0xf20 [ 18.517222][ C0] ? find_held_lock+0x2b/0x80 [ 18.517226][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 18.517231][ C0] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 18.517234][ C0] ? lockdep_hardirqs_on+0x7c/0x110 [ 18.517238][ C0] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 18.517243][ C0] rcu_core+0x2bb/0x500 [ 18.517247][ C0] handle_softirqs+0x218/0x620 [ 18.517252][ C0] __irq_exit_rcu+0xfa/0x160 [ 18.517255][ C0] irq_exit_rcu+0xe/0x30 [ 18.517257][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 18.517261][ C0] [ 18.517262][ C0] [ 18.517263][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 18.517266][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 18.517271][ 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.517274][ C0] RSP: 0018:ffffffffb2c07df8 EFLAGS: 00000242 [ 18.517277][ C0] RAX: 000000000006ba97 RBX: 1ffffffff6580fc3 RCX: ffffffffb1f5ba19 [ 18.517280][ C0] RDX: 0000000000000000 RSI: ffffffffb2a87785 RDI: ffffffffb2251260 [ 18.517282][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c0667a [ 18.517283][ C0] R10: ffff8880360333d3 R11: 0000000000000000 R12: 0000000000000000 [ 18.517285][ C0] R13: ffffffffb2c1f240 R14: dffffc0000000000 R15: 0000000000014770 [ 18.517289][ C0] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 18.517294][ C0] default_idle+0x9/0x10 [ 18.517296][ C0] default_idle_call+0x6d/0xb0 [ 18.517299][ C0] cpuidle_idle_call+0x26f/0x3a0 [ 18.517303][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 18.517307][ C0] ? tsc_verify_tsc_adjust+0x98/0x300 [ 18.517315][ C0] do_idle+0xf6/0x160 [ 18.517319][ C0] cpu_startup_entry+0x54/0x60 [ 18.517323][ C0] rest_init+0x14b/0x260 [ 18.517326][ C0] start_kernel+0x350/0x410 [ 18.517331][ C0] x86_64_start_reservations+0x18/0x30 [ 18.517336][ C0] x86_64_start_kernel+0xba/0x110 [ 18.517340][ C0] common_startup_64+0x13e/0x148 [ 18.517349][ C0] [ 18.535097][ C0] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 18.535452][ C0] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/0 [ 18.535787][ C0] preempt_count: 101, expected: 0 [ 18.535997][ C0] RCU nest depth: 0, expected: 0 [ 18.536188][ C0] INFO: lockdep is turned off. [ 18.536648][ C0] Preemption disabled at: [ 18.536650][ C0] [] schedule_preempt_disabled+0x22/0x30 [ 18.537240][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 6.15.0-rc7-virtme #1 PREEMPT(full) [ 18.537246][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 18.537248][ C0] Call Trace: [ 18.537250][ C0] [ 18.537253][ C0] dump_stack_lvl+0xb0/0xd0 [ 18.537260][ C0] __might_resched+0x360/0x5a0 [ 18.537268][ C0] down_write+0x72/0x210 [ 18.537273][ C0] ? __pfx_down_write+0x10/0x10 [ 18.537276][ C0] ? simple_recursive_removal+0x3a/0x860 [ 18.537282][ C0] ? rcu_is_watching+0x12/0xc0 [ 18.537290][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 18.537295][ C0] simple_recursive_removal+0x166/0x860 [ 18.537298][ C0] ? __pfx_remove_one+0x10/0x10 [ 18.537303][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 18.537307][ C0] debugfs_remove+0x44/0x70 [ 18.537310][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 18.537317][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 18.537320][ C0] ? __sk_destruct+0x383/0x780 [ 18.537327][ C0] ? rcu_do_batch+0x34f/0xf20 [ 18.537332][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 18.537335][ C0] ? irq_exit_rcu+0xe/0x30 [ 18.537339][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 18.537345][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 18.537350][ C0] ? pv_native_safe_halt+0xf/0x20 [ 18.537353][ C0] ? default_idle+0x9/0x10 [ 18.537355][ C0] ? default_idle_call+0x6d/0xb0 [ 18.537358][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 18.537364][ C0] ? do_idle+0xf6/0x160 [ 18.537367][ C0] ? cpu_startup_entry+0x54/0x60 [ 18.537370][ C0] ? rest_init+0x14b/0x260 [ 18.537373][ C0] ? start_kernel+0x350/0x410 [ 18.537383][ C0] __put_net+0x19/0x60 [ 18.537387][ C0] __sk_destruct+0x58a/0x780 [ 18.537391][ C0] ? rcu_do_batch+0x34a/0xf20 [ 18.537394][ C0] rcu_do_batch+0x34f/0xf20 [ 18.537398][ C0] ? find_held_lock+0x2b/0x80 [ 18.537405][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 18.537409][ C0] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 18.537414][ C0] ? lockdep_hardirqs_on+0x7c/0x110 [ 18.537418][ C0] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 18.537423][ C0] rcu_core+0x2bb/0x500 [ 18.537427][ C0] handle_softirqs+0x218/0x620 [ 18.537432][ C0] __irq_exit_rcu+0xfa/0x160 [ 18.537434][ C0] irq_exit_rcu+0xe/0x30 [ 18.537437][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 18.537440][ C0] [ 18.537442][ C0] [ 18.537444][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 18.537447][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 18.537451][ 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.537454][ C0] RSP: 0018:ffffffffb2c07df8 EFLAGS: 00000242 [ 18.537458][ C0] RAX: 000000000006ba97 RBX: 1ffffffff6580fc3 RCX: ffffffffb1f5ba19 [ 18.537461][ C0] RDX: 0000000000000000 RSI: ffffffffb2a87785 RDI: ffffffffb2251260 [ 18.537463][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c0667a [ 18.537464][ C0] R10: ffff8880360333d3 R11: 0000000000000000 R12: 0000000000000000 [ 18.537466][ C0] R13: ffffffffb2c1f240 R14: dffffc0000000000 R15: 0000000000014770 [ 18.537470][ C0] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 18.537475][ C0] default_idle+0x9/0x10 [ 18.537477][ C0] default_idle_call+0x6d/0xb0 [ 18.537480][ C0] cpuidle_idle_call+0x26f/0x3a0 [ 18.537483][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 18.537488][ C0] ? tsc_verify_tsc_adjust+0x98/0x300 [ 18.537495][ C0] do_idle+0xf6/0x160 [ 18.537499][ C0] cpu_startup_entry+0x54/0x60 [ 18.537503][ C0] rest_init+0x14b/0x260 [ 18.537506][ C0] start_kernel+0x350/0x410 [ 18.537510][ C0] x86_64_start_reservations+0x18/0x30 [ 18.537515][ C0] x86_64_start_kernel+0xba/0x110 [ 18.537519][ C0] common_startup_64+0x13e/0x148 [ 18.537528][ C0] [ 21.689426][ C0] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 21.689875][ C0] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/0 [ 21.690334][ C0] preempt_count: 101, expected: 0 [ 21.690589][ C0] RCU nest depth: 0, expected: 0 [ 21.690871][ C0] INFO: lockdep is turned off. [ 21.691164][ C0] Preemption disabled at: [ 21.691166][ C0] [] schedule_preempt_disabled+0x22/0x30 [ 21.691843][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 6.15.0-rc7-virtme #1 PREEMPT(full) [ 21.691852][ C0] Tainted: [W]=WARN [ 21.691854][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 21.691857][ C0] Call Trace: [ 21.691860][ C0] [ 21.691863][ C0] dump_stack_lvl+0xb0/0xd0 [ 21.691875][ C0] __might_resched+0x360/0x5a0 [ 21.691886][ C0] down_write+0x72/0x210 [ 21.691893][ C0] ? __pfx_down_write+0x10/0x10 [ 21.691898][ C0] ? simple_recursive_removal+0x3a/0x860 [ 21.691907][ C0] ? rcu_is_watching+0x12/0xc0 [ 21.691918][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 21.691926][ C0] simple_recursive_removal+0x166/0x860 [ 21.691931][ C0] ? __pfx_remove_one+0x10/0x10 [ 21.691939][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 21.691947][ C0] debugfs_remove+0x44/0x70 [ 21.691952][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 21.691963][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 21.691968][ C0] ? __sk_destruct+0x383/0x780 [ 21.691976][ C0] ? rcu_do_batch+0x34f/0xf20 [ 21.691982][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 21.691986][ C0] ? irq_exit_rcu+0xe/0x30 [ 21.691993][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 21.692001][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 21.692008][ C0] ? pv_native_safe_halt+0xf/0x20 [ 21.692013][ C0] ? default_idle+0x9/0x10 [ 21.692017][ C0] ? default_idle_call+0x6d/0xb0 [ 21.692022][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 21.692029][ C0] ? do_idle+0xf6/0x160 [ 21.692034][ C0] ? cpu_startup_entry+0x54/0x60 [ 21.692039][ C0] ? rest_init+0x14b/0x260 [ 21.692044][ C0] ? start_kernel+0x350/0x410 [ 21.692053][ C0] ? bpf_sk_storage_free+0x9f/0x1c0 [ 21.692060][ C0] ? rcu_is_watching+0x12/0xc0 [ 21.692069][ C0] __put_net+0x19/0x60 [ 21.692076][ C0] __sk_destruct+0x58a/0x780 [ 21.692082][ C0] ? rcu_do_batch+0x34a/0xf20 [ 21.692087][ C0] rcu_do_batch+0x34f/0xf20 [ 21.692097][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 21.692105][ C0] ? trace_irq_enable.constprop.0+0xd4/0x130 [ 21.692114][ C0] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 21.692124][ C0] rcu_core+0x2bb/0x500 [ 21.692131][ C0] handle_softirqs+0x218/0x620 [ 21.692141][ C0] __irq_exit_rcu+0xfa/0x160 [ 21.692146][ C0] irq_exit_rcu+0xe/0x30 [ 21.692150][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 21.692156][ C0] [ 21.692158][ C0] [ 21.692161][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 21.692166][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 21.692172][ 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 [ 21.692177][ C0] RSP: 0018:ffffffffb2c07df8 EFLAGS: 00000246 [ 21.692184][ C0] RAX: 0000000000000000 RBX: 1ffffffff6580fc3 RCX: ffffffffb1f5ba19 [ 21.692188][ C0] RDX: ffffed1006c0667b RSI: ffffffffb22511e0 RDI: ffffffffaf78633f [ 21.692191][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: ffffed1006c0667a [ 21.692194][ C0] R10: ffff8880360333d3 R11: ffff888001b50558 R12: 0000000000000000 [ 21.692198][ C0] R13: ffffffffb2c1f240 R14: dffffc0000000000 R15: 0000000000014770 [ 21.692205][ C0] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 21.692208][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 21.692213][ C0] default_idle+0x9/0x10 [ 21.692215][ C0] default_idle_call+0x6d/0xb0 [ 21.692218][ C0] cpuidle_idle_call+0x26f/0x3a0 [ 21.692222][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 21.692227][ C0] ? tsc_verify_tsc_adjust+0x98/0x300 [ 21.692235][ C0] do_idle+0xf6/0x160 [ 21.692239][ C0] cpu_startup_entry+0x54/0x60 [ 21.692243][ C0] rest_init+0x14b/0x260 [ 21.692247][ C0] start_kernel+0x350/0x410 [ 21.692251][ C0] x86_64_start_reservations+0x18/0x30 [ 21.692257][ C0] x86_64_start_kernel+0xba/0x110 [ 21.692261][ C0] common_startup_64+0x13e/0x148 [ 21.692271][ C0]