[ 14.563688][ C3] [ 14.563993][ C3] ================================ [ 14.564184][ C3] WARNING: inconsistent lock state [ 14.564376][ C3] 6.15.0-virtme #1 Not tainted [ 14.564570][ C3] -------------------------------- [ 14.564759][ C3] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 14.565004][ C3] swapper/3/0 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 14.565245][ C3] ffffffffbc5c5af8 (pin_fs_lock){+.?.}-{3:3}, at: simple_pin_fs+0x24/0x150 [ 14.565588][ C3] {SOFTIRQ-ON-W} state was registered at: [ 14.565779][ C3] __lock_acquire+0x20b/0x7e0 [ 14.565978][ C3] lock_acquire.part.0+0xb6/0x240 [ 14.566170][ C3] _raw_spin_lock+0x33/0x40 [ 14.566374][ C3] simple_pin_fs+0x24/0x150 [ 14.566565][ C3] start_creating.part.0+0x52/0x310 [ 14.566755][ C3] debugfs_create_dir+0x6a/0x540 [ 14.566950][ C3] component_debug_init+0x17/0x30 [ 14.567152][ C3] do_one_initcall+0x8f/0x1e0 [ 14.567341][ C3] do_initcalls+0x176/0x280 [ 14.567534][ C3] kernel_init_freeable+0x22d/0x300 [ 14.567724][ C3] kernel_init+0x20/0x200 [ 14.567919][ C3] ret_from_fork+0x240/0x320 [ 14.568111][ C3] ret_from_fork_asm+0x1a/0x30 [ 14.568302][ C3] irq event stamp: 227444 [ 14.568449][ C3] hardirqs last enabled at (227444): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 14.568833][ C3] hardirqs last disabled at (227443): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 14.569218][ C3] softirqs last enabled at (227400): [] handle_softirqs+0x358/0x620 [ 14.569553][ C3] softirqs last disabled at (227407): [] __irq_exit_rcu+0xfa/0x160 [ 14.569882][ C3] [ 14.569882][ C3] other info that might help us debug this: [ 14.570164][ C3] Possible unsafe locking scenario: [ 14.570164][ C3] [ 14.570444][ C3] CPU0 [ 14.570587][ C3] ---- [ 14.570726][ C3] lock(pin_fs_lock); [ 14.570872][ C3] [ 14.571015][ C3] lock(pin_fs_lock); [ 14.571159][ C3] [ 14.571159][ C3] *** DEADLOCK *** [ 14.571159][ C3] [ 14.571439][ C3] 1 lock held by swapper/3/0: [ 14.571633][ C3] #0: ffffffffbc3774c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 14.571974][ C3] [ 14.571974][ C3] stack backtrace: [ 14.572211][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 14.572215][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.572217][ C3] Call Trace: [ 14.572219][ C3] [ 14.572221][ C3] dump_stack_lvl+0x82/0xd0 [ 14.572227][ C3] print_usage_bug.part.0+0x25f/0x360 [ 14.572232][ C3] mark_lock_irq+0x343/0x400 [ 14.572236][ C3] ? __pfx_unwind_next_frame+0x10/0x10 [ 14.572241][ C3] ? save_trace+0x52/0x170 [ 14.572246][ C3] mark_lock+0x174/0x2f0 [ 14.572250][ C3] mark_usage+0x46/0x150 [ 14.572253][ C3] __lock_acquire+0x20b/0x7e0 [ 14.572256][ C3] ? __lock_acquire+0x44d/0x7e0 [ 14.572260][ C3] lock_acquire.part.0+0xb6/0x240 [ 14.572263][ C3] ? simple_pin_fs+0x24/0x150 [ 14.572267][ C3] ? rcu_is_watching+0x12/0xc0 [ 14.572271][ C3] ? lock_acquire+0x10c/0x170 [ 14.572274][ C3] ? simple_pin_fs+0x24/0x150 [ 14.572278][ C3] _raw_spin_lock+0x33/0x40 [ 14.572282][ C3] ? simple_pin_fs+0x24/0x150 [ 14.572285][ C3] simple_pin_fs+0x24/0x150 [ 14.572289][ C3] debugfs_remove+0x35/0x70 [ 14.572292][ C3] ref_tracker_dir_exit+0xcf/0x740 [ 14.572297][ C3] ? __pfx_ref_tracker_free+0x10/0x10 [ 14.572301][ C3] ? __sk_destruct+0x383/0x780 [ 14.572306][ C3] ? rcu_do_batch+0x34c/0xf20 [ 14.572309][ C3] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 14.572312][ C3] ? irq_exit_rcu+0xe/0x30 [ 14.572316][ C3] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 14.572321][ C3] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.572325][ C3] ? pv_native_safe_halt+0xf/0x20 [ 14.572328][ C3] ? default_idle+0x9/0x10 [ 14.572330][ C3] ? default_idle_call+0x6d/0xb0 [ 14.572333][ C3] ? cpuidle_idle_call+0x26f/0x3a0 [ 14.572336][ C3] ? do_idle+0xf6/0x160 [ 14.572338][ C3] ? cpu_startup_entry+0x54/0x60 [ 14.572341][ C3] ? start_secondary+0x213/0x2a0 [ 14.572344][ C3] ? common_startup_64+0x13e/0x148 [ 14.572352][ C3] __put_net+0x19/0x60 [ 14.572355][ C3] __sk_destruct+0x58a/0x780 [ 14.572359][ C3] ? rcu_do_batch+0x34a/0xf20 [ 14.572362][ C3] rcu_do_batch+0x34c/0xf20 [ 14.572365][ C3] ? find_held_lock+0x2b/0x80 [ 14.572369][ C3] ? __pfx_rcu_do_batch+0x10/0x10 [ 14.572372][ C3] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 14.572376][ C3] ? lockdep_hardirqs_on+0x7c/0x110 [ 14.572379][ C3] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 14.572384][ C3] rcu_core+0x2bb/0x500 [ 14.572388][ C3] handle_softirqs+0x218/0x620 [ 14.572394][ C3] __irq_exit_rcu+0xfa/0x160 [ 14.572397][ C3] irq_exit_rcu+0xe/0x30 [ 14.572399][ C3] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 14.572403][ C3] [ 14.572404][ C3] [ 14.572406][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.572408][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 14.572412][ C3] Code: a2 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 47 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 [ 14.572415][ C3] RSP: 0018:ffffc90000157de8 EFLAGS: 00000246 [ 14.572418][ C3] RAX: 000000000003784d RBX: 1ffff9200002afc1 RCX: ffffffffbb38f5d9 [ 14.572420][ C3] RDX: 0000000000000000 RSI: ffffffffbbe8f4e4 RDI: ffffffffbb653be0 [ 14.572422][ C3] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c366fa [ 14.572423][ C3] R10: ffff8880361b37d3 R11: ffffffffbc011288 R12: 0000000000000000 [ 14.572425][ C3] R13: ffff888001bf45c0 R14: dffffc0000000000 R15: 0000000000000000 [ 14.572429][ C3] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 14.572434][ C3] default_idle+0x9/0x10 [ 14.572436][ C3] default_idle_call+0x6d/0xb0 [ 14.572439][ C3] cpuidle_idle_call+0x26f/0x3a0 [ 14.572442][ C3] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 14.572446][ C3] ? tsc_verify_tsc_adjust+0x98/0x310 [ 14.572450][ C3] do_idle+0xf6/0x160 [ 14.572453][ C3] cpu_startup_entry+0x54/0x60 [ 14.572456][ C3] start_secondary+0x213/0x2a0 [ 14.572459][ C3] ? __pfx_start_secondary+0x10/0x10 [ 14.572464][ C3] common_startup_64+0x13e/0x148 [ 14.572471][ C3] [ 14.588548][ C3] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 14.588868][ C3] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/3 [ 14.589173][ C3] preempt_count: 101, expected: 0 [ 14.589355][ C3] RCU nest depth: 0, expected: 0 [ 14.589535][ C3] INFO: lockdep is turned off. [ 14.589836][ C3] Preemption disabled at: [ 14.589838][ C3] [<0000000000000000>] 0x0 [ 14.590159][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 14.590163][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.590164][ C3] Call Trace: [ 14.590166][ C3] [ 14.590167][ C3] dump_stack_lvl+0xb0/0xd0 [ 14.590174][ C3] __might_resched+0x360/0x5a0 [ 14.590180][ C3] down_write+0x72/0x210 [ 14.590184][ C3] ? __pfx_down_write+0x10/0x10 [ 14.590187][ C3] ? simple_recursive_removal+0x33/0x610 [ 14.590190][ C3] ? rcu_is_watching+0x12/0xc0 [ 14.590195][ C3] ? do_raw_spin_unlock+0x58/0x220 [ 14.590200][ C3] simple_recursive_removal+0x6a/0x610 [ 14.590202][ C3] ? do_raw_spin_unlock+0x58/0x220 [ 14.590206][ C3] ? __pfx_remove_one+0x10/0x10 [ 14.590210][ C3] debugfs_remove+0x44/0x70 [ 14.590213][ C3] ref_tracker_dir_exit+0xcf/0x740 [ 14.590218][ C3] ? __pfx_ref_tracker_free+0x10/0x10 [ 14.590221][ C3] ? __sk_destruct+0x383/0x780 [ 14.590226][ C3] ? rcu_do_batch+0x34c/0xf20 [ 14.590229][ C3] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 14.590232][ C3] ? irq_exit_rcu+0xe/0x30 [ 14.590235][ C3] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 14.590239][ C3] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.590242][ C3] ? pv_native_safe_halt+0xf/0x20 [ 14.590246][ C3] ? default_idle+0x9/0x10 [ 14.590248][ C3] ? default_idle_call+0x6d/0xb0 [ 14.590251][ C3] ? cpuidle_idle_call+0x26f/0x3a0 [ 14.590254][ C3] ? do_idle+0xf6/0x160 [ 14.590256][ C3] ? cpu_startup_entry+0x54/0x60 [ 14.590258][ C3] ? start_secondary+0x213/0x2a0 [ 14.590261][ C3] ? common_startup_64+0x13e/0x148 [ 14.590268][ C3] __put_net+0x19/0x60 [ 14.590270][ C3] __sk_destruct+0x58a/0x780 [ 14.590274][ C3] ? rcu_do_batch+0x34a/0xf20 [ 14.590277][ C3] rcu_do_batch+0x34c/0xf20 [ 14.590280][ C3] ? find_held_lock+0x2b/0x80 [ 14.590286][ C3] ? __pfx_rcu_do_batch+0x10/0x10 [ 14.590289][ C3] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 14.590293][ C3] ? lockdep_hardirqs_on+0x7c/0x110 [ 14.590295][ C3] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 14.590300][ C3] rcu_core+0x2bb/0x500 [ 14.590304][ C3] handle_softirqs+0x218/0x620 [ 14.590309][ C3] __irq_exit_rcu+0xfa/0x160 [ 14.590312][ C3] irq_exit_rcu+0xe/0x30 [ 14.590315][ C3] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 14.590318][ C3] [ 14.590319][ C3] [ 14.590321][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.590323][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 14.590327][ C3] Code: a2 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 47 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 [ 14.590329][ C3] RSP: 0018:ffffc90000157de8 EFLAGS: 00000246 [ 14.590332][ C3] RAX: 000000000003784d RBX: 1ffff9200002afc1 RCX: ffffffffbb38f5d9 [ 14.590334][ C3] RDX: 0000000000000000 RSI: ffffffffbbe8f4e4 RDI: ffffffffbb653be0 [ 14.590336][ C3] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c366fa [ 14.590337][ C3] R10: ffff8880361b37d3 R11: ffffffffbc011288 R12: 0000000000000000 [ 14.590339][ C3] R13: ffff888001bf45c0 R14: dffffc0000000000 R15: 0000000000000000 [ 14.590342][ C3] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 14.590347][ C3] default_idle+0x9/0x10 [ 14.590349][ C3] default_idle_call+0x6d/0xb0 [ 14.590352][ C3] cpuidle_idle_call+0x26f/0x3a0 [ 14.590355][ C3] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 14.590358][ C3] ? tsc_verify_tsc_adjust+0x98/0x310 [ 14.590363][ C3] do_idle+0xf6/0x160 [ 14.590366][ C3] cpu_startup_entry+0x54/0x60 [ 14.590368][ C3] start_secondary+0x213/0x2a0 [ 14.590371][ C3] ? __pfx_start_secondary+0x10/0x10 [ 14.590376][ C3] common_startup_64+0x13e/0x148 [ 14.590382][ C3] [ 16.249953][ C0] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 16.250435][ C0] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/0 [ 16.250818][ C0] preempt_count: 101, expected: 0 [ 16.251040][ C0] RCU nest depth: 0, expected: 0 [ 16.251244][ C0] INFO: lockdep is turned off. [ 16.251456][ C0] Preemption disabled at: [ 16.251458][ C0] [] schedule_preempt_disabled+0x22/0x30 [ 16.251950][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 6.15.0-virtme #1 PREEMPT(full) [ 16.251957][ C0] Tainted: [W]=WARN [ 16.251958][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 16.251961][ C0] Call Trace: [ 16.251964][ C0] [ 16.251966][ C0] dump_stack_lvl+0xb0/0xd0 [ 16.251973][ C0] __might_resched+0x360/0x5a0 [ 16.251983][ C0] down_write+0x72/0x210 [ 16.251988][ C0] ? __pfx_down_write+0x10/0x10 [ 16.251991][ C0] ? simple_recursive_removal+0x33/0x610 [ 16.251996][ C0] ? rcu_is_watching+0x12/0xc0 [ 16.252002][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 16.252009][ C0] simple_recursive_removal+0x6a/0x610 [ 16.252012][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 16.252016][ C0] ? __pfx_remove_one+0x10/0x10 [ 16.252022][ C0] debugfs_remove+0x44/0x70 [ 16.252025][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 16.252032][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 16.252036][ C0] ? __sk_destruct+0x383/0x780 [ 16.252043][ C0] ? rcu_do_batch+0x34c/0xf20 [ 16.252047][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 16.252050][ C0] ? irq_exit_rcu+0xe/0x30 [ 16.252057][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 16.252063][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 16.252067][ C0] ? pv_native_safe_halt+0xf/0x20 [ 16.252071][ C0] ? default_idle+0x9/0x10 [ 16.252073][ C0] ? default_idle_call+0x6d/0xb0 [ 16.252076][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 16.252080][ C0] ? do_idle+0xf6/0x160 [ 16.252083][ C0] ? cpu_startup_entry+0x54/0x60 [ 16.252085][ C0] ? rest_init+0x14b/0x260 [ 16.252089][ C0] ? start_kernel+0x350/0x410 [ 16.252095][ C0] ? bpf_sk_storage_free+0x9f/0x1c0 [ 16.252100][ C0] ? rcu_is_watching+0x12/0xc0 [ 16.252105][ C0] __put_net+0x19/0x60 [ 16.252109][ C0] __sk_destruct+0x58a/0x780 [ 16.252113][ C0] ? rcu_do_batch+0x34a/0xf20 [ 16.252115][ C0] rcu_do_batch+0x34c/0xf20 [ 16.252120][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 16.252123][ C0] ? trace_irq_enable.constprop.0+0xd4/0x130 [ 16.252131][ C0] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 16.252138][ C0] rcu_core+0x2bb/0x500 [ 16.252143][ C0] handle_softirqs+0x218/0x620 [ 16.252148][ C0] __irq_exit_rcu+0xfa/0x160 [ 16.252151][ C0] irq_exit_rcu+0xe/0x30 [ 16.252154][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 16.252158][ C0] [ 16.252159][ C0] [ 16.252161][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 16.252163][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 16.252168][ C0] Code: a2 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 47 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 [ 16.252170][ C0] RSP: 0018:ffffffffbc007df8 EFLAGS: 00000246 [ 16.252174][ C0] RAX: 0000000000000000 RBX: 1ffffffff7800fc3 RCX: ffffffffbb38f5d9 [ 16.252176][ C0] RDX: ffffed1006c066fb RSI: ffffffffbb653b60 RDI: ffffffffb8b8d18f [ 16.252178][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: ffffed1006c066fa [ 16.252180][ C0] R10: ffff8880360337d3 R11: ffff888001becad8 R12: 0000000000000000 [ 16.252182][ C0] R13: ffffffffbc01f240 R14: dffffc0000000000 R15: 0000000000014770 [ 16.252186][ C0] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 16.252189][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 16.252193][ C0] default_idle+0x9/0x10 [ 16.252196][ C0] default_idle_call+0x6d/0xb0 [ 16.252198][ C0] cpuidle_idle_call+0x26f/0x3a0 [ 16.252202][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 16.252205][ C0] ? tsc_verify_tsc_adjust+0x98/0x310 [ 16.252212][ C0] do_idle+0xf6/0x160 [ 16.252215][ C0] cpu_startup_entry+0x54/0x60 [ 16.252218][ C0] rest_init+0x14b/0x260 [ 16.252221][ C0] start_kernel+0x350/0x410 [ 16.252225][ C0] x86_64_start_reservations+0x18/0x30 [ 16.252230][ C0] x86_64_start_kernel+0xf8/0x150 [ 16.252234][ C0] common_startup_64+0x13e/0x148 [ 16.252245][ C0]