[ 13.652969][ C0] [ 13.653130][ C0] ================================ [ 13.653339][ C0] WARNING: inconsistent lock state [ 13.653553][ C0] 6.15.0-rc5-virtme #1 Not tainted [ 13.653761][ C0] -------------------------------- [ 13.653966][ C0] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 13.654237][ C0] swapper/0/0 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 13.654495][ C0] ffffffffa65bf978 (pin_fs_lock){+.?.}-{3:3}, at: simple_pin_fs+0x24/0x150 [ 13.654874][ C0] {SOFTIRQ-ON-W} state was registered at: [ 13.655118][ C0] __lock_acquire+0x3eb/0x9d0 [ 13.655349][ C0] lock_acquire.part.0+0xb6/0x240 [ 13.655569][ C0] _raw_spin_lock+0x33/0x40 [ 13.655798][ C0] simple_pin_fs+0x24/0x150 [ 13.656007][ C0] start_creating.part.0+0x3f/0x2f0 [ 13.656220][ C0] debugfs_create_dir+0x6a/0x540 [ 13.656432][ C0] component_debug_init+0x17/0x30 [ 13.656649][ C0] do_one_initcall+0x8c/0x1e0 [ 13.656865][ C0] do_initcalls+0x176/0x280 [ 13.657072][ C0] kernel_init_freeable+0x22d/0x300 [ 13.657277][ C0] kernel_init+0x20/0x200 [ 13.657499][ C0] ret_from_fork+0x31/0x70 [ 13.657738][ C0] ret_from_fork_asm+0x1a/0x30 [ 13.657969][ C0] irq event stamp: 405402 [ 13.658143][ C0] hardirqs last enabled at (405402): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 13.658623][ C0] hardirqs last disabled at (405401): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 13.659060][ C0] softirqs last enabled at (403530): [] handle_softirqs+0x358/0x620 [ 13.659437][ C0] softirqs last disabled at (403549): [] __irq_exit_rcu+0xfa/0x160 [ 13.659817][ C0] [ 13.659817][ C0] other info that might help us debug this: [ 13.660138][ C0] Possible unsafe locking scenario: [ 13.660138][ C0] [ 13.660470][ C0] CPU0 [ 13.660653][ C0] ---- [ 13.660818][ C0] lock(pin_fs_lock); [ 13.661001][ C0] [ 13.661156][ C0] lock(pin_fs_lock); [ 13.661331][ C0] [ 13.661331][ C0] *** DEADLOCK *** [ 13.661331][ C0] [ 13.661638][ C0] 1 lock held by swapper/0/0: [ 13.661841][ C0] #0: ffffffffa6374480 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 13.662209][ C0] [ 13.662209][ C0] stack backtrace: [ 13.662475][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 6.15.0-rc5-virtme #1 PREEMPT(full) [ 13.662482][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.662485][ C0] Call Trace: [ 13.662487][ C0] [ 13.662489][ C0] dump_stack_lvl+0x82/0xd0 [ 13.662497][ C0] print_usage_bug.part.0+0x25f/0x360 [ 13.662504][ C0] mark_lock_irq+0x343/0x400 [ 13.662507][ C0] ? is_bpf_text_address+0x67/0x120 [ 13.662511][ C0] ? __lock_release+0x5d/0x170 [ 13.662516][ C0] ? save_trace+0x52/0x170 [ 13.662522][ C0] mark_lock+0x174/0x2f0 [ 13.662525][ C0] mark_usage+0x46/0x150 [ 13.662528][ C0] __lock_acquire+0x3eb/0x9d0 [ 13.662533][ C0] lock_acquire.part.0+0xb6/0x240 [ 13.662536][ C0] ? simple_pin_fs+0x24/0x150 [ 13.662542][ C0] ? rcu_is_watching+0x12/0xc0 [ 13.662545][ C0] ? lock_acquire+0x10c/0x170 [ 13.662548][ C0] ? simple_pin_fs+0x24/0x150 [ 13.662552][ C0] _raw_spin_lock+0x33/0x40 [ 13.662557][ C0] ? simple_pin_fs+0x24/0x150 [ 13.662559][ C0] simple_pin_fs+0x24/0x150 [ 13.662563][ C0] debugfs_remove+0x35/0x70 [ 13.662569][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 13.662575][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 13.662579][ C0] ? __sk_destruct+0x383/0x780 [ 13.662586][ C0] ? rcu_do_batch+0x34c/0xf20 [ 13.662589][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 13.662593][ C0] ? irq_exit_rcu+0xe/0x30 [ 13.662597][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 13.662602][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.662606][ C0] ? pv_native_safe_halt+0xf/0x20 [ 13.662609][ C0] ? default_idle+0x9/0x10 [ 13.662613][ C0] ? default_idle_call+0x6d/0xb0 [ 13.662615][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 13.662619][ C0] ? do_idle+0xf6/0x160 [ 13.662621][ C0] ? cpu_startup_entry+0x54/0x60 [ 13.662624][ C0] ? rest_init+0x14b/0x260 [ 13.662627][ C0] ? start_kernel+0x350/0x410 [ 13.662635][ C0] __put_net+0x19/0x60 [ 13.662638][ C0] __sk_destruct+0x58a/0x780 [ 13.662642][ C0] ? rcu_do_batch+0x34a/0xf20 [ 13.662646][ C0] rcu_do_batch+0x34c/0xf20 [ 13.662650][ C0] ? find_held_lock+0x2b/0x80 [ 13.662654][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 13.662658][ C0] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 13.662662][ C0] ? lockdep_hardirqs_on+0x7c/0x110 [ 13.662666][ C0] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 13.662670][ C0] rcu_core+0x2bb/0x500 [ 13.662674][ C0] handle_softirqs+0x218/0x620 [ 13.662679][ C0] __irq_exit_rcu+0xfa/0x160 [ 13.662682][ C0] irq_exit_rcu+0xe/0x30 [ 13.662684][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 13.662688][ C0] [ 13.662689][ C0] [ 13.662690][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.662693][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 13.662698][ C0] Code: a0 b7 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 a0 12 00 fb f4 cc cc cc cc 66 2e 0f 1f 84 00 00 00 00 00 66 90 90 90 90 90 90 [ 13.662701][ C0] RSP: 0018:ffffffffa6007df8 EFLAGS: 00000242 [ 13.662705][ C0] RAX: 000000000006285b RBX: 1ffffffff4c00fc3 RCX: ffffffffa5368a19 [ 13.662707][ C0] RDX: 0000000000000000 RSI: ffffffffa5e881e1 RDI: ffffffffa5650e20 [ 13.662709][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c0667a [ 13.662711][ C0] R10: ffff8880360333d3 R11: 0000000000000000 R12: 0000000000000000 [ 13.662712][ C0] R13: ffffffffa601f240 R14: dffffc0000000000 R15: 0000000000014770 [ 13.662716][ C0] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 13.662721][ C0] default_idle+0x9/0x10 [ 13.662725][ C0] default_idle_call+0x6d/0xb0 [ 13.662727][ C0] cpuidle_idle_call+0x26f/0x3a0 [ 13.662730][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 13.662733][ C0] ? tsc_verify_tsc_adjust+0x98/0x300 [ 13.662738][ C0] do_idle+0xf6/0x160 [ 13.662741][ C0] cpu_startup_entry+0x54/0x60 [ 13.662744][ C0] rest_init+0x14b/0x260 [ 13.662747][ C0] start_kernel+0x350/0x410 [ 13.662751][ C0] x86_64_start_reservations+0x18/0x30 [ 13.662755][ C0] x86_64_start_kernel+0xba/0x110 [ 13.662759][ C0] common_startup_64+0x13e/0x148 [ 13.662768][ C0] [ 13.681873][ C0] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 13.682225][ C0] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/0 [ 13.682754][ C0] preempt_count: 101, expected: 0 [ 13.682951][ C0] RCU nest depth: 0, expected: 0 [ 13.683156][ C0] INFO: lockdep is turned off. [ 13.683366][ C0] Preemption disabled at: [ 13.683367][ C0] [] schedule_preempt_disabled+0x22/0x30 [ 13.683832][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 6.15.0-rc5-virtme #1 PREEMPT(full) [ 13.683838][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.683840][ C0] Call Trace: [ 13.683843][ C0] [ 13.683845][ C0] dump_stack_lvl+0xb0/0xd0 [ 13.683853][ C0] __might_resched+0x360/0x5a0 [ 13.683862][ C0] down_write+0x72/0x210 [ 13.683866][ C0] ? __pfx_down_write+0x10/0x10 [ 13.683868][ C0] ? simple_recursive_removal+0x3a/0x860 [ 13.683875][ C0] ? rcu_is_watching+0x12/0xc0 [ 13.683880][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 13.683886][ C0] simple_recursive_removal+0x166/0x860 [ 13.683890][ C0] ? __pfx_remove_one+0x10/0x10 [ 13.683898][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 13.683905][ C0] debugfs_remove+0x44/0x70 [ 13.683911][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 13.683919][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 13.683923][ C0] ? __sk_destruct+0x383/0x780 [ 13.683930][ C0] ? rcu_do_batch+0x34c/0xf20 [ 13.683936][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 13.683939][ C0] ? irq_exit_rcu+0xe/0x30 [ 13.683945][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 13.683950][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.683955][ C0] ? pv_native_safe_halt+0xf/0x20 [ 13.683958][ C0] ? default_idle+0x9/0x10 [ 13.683962][ C0] ? default_idle_call+0x6d/0xb0 [ 13.683964][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 13.683968][ C0] ? do_idle+0xf6/0x160 [ 13.683970][ C0] ? cpu_startup_entry+0x54/0x60 [ 13.683972][ C0] ? rest_init+0x14b/0x260 [ 13.683975][ C0] ? start_kernel+0x350/0x410 [ 13.683983][ C0] __put_net+0x19/0x60 [ 13.683987][ C0] __sk_destruct+0x58a/0x780 [ 13.683991][ C0] ? rcu_do_batch+0x34a/0xf20 [ 13.683995][ C0] rcu_do_batch+0x34c/0xf20 [ 13.683999][ C0] ? find_held_lock+0x2b/0x80 [ 13.684005][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 13.684009][ C0] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 13.684015][ C0] ? lockdep_hardirqs_on+0x7c/0x110 [ 13.684018][ C0] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 13.684023][ C0] rcu_core+0x2bb/0x500 [ 13.684027][ C0] handle_softirqs+0x218/0x620 [ 13.684032][ C0] __irq_exit_rcu+0xfa/0x160 [ 13.684034][ C0] irq_exit_rcu+0xe/0x30 [ 13.684037][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 13.684040][ C0] [ 13.684041][ C0] [ 13.684043][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.684045][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 13.684050][ C0] Code: a0 b7 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 a0 12 00 fb f4 cc cc cc cc 66 2e 0f 1f 84 00 00 00 00 00 66 90 90 90 90 90 90 [ 13.684053][ C0] RSP: 0018:ffffffffa6007df8 EFLAGS: 00000242 [ 13.684057][ C0] RAX: 000000000006285b RBX: 1ffffffff4c00fc3 RCX: ffffffffa5368a19 [ 13.684059][ C0] RDX: 0000000000000000 RSI: ffffffffa5e881e1 RDI: ffffffffa5650e20 [ 13.684061][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c0667a [ 13.684063][ C0] R10: ffff8880360333d3 R11: 0000000000000000 R12: 0000000000000000 [ 13.684064][ C0] R13: ffffffffa601f240 R14: dffffc0000000000 R15: 0000000000014770 [ 13.684068][ C0] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 13.684074][ C0] default_idle+0x9/0x10 [ 13.684077][ C0] default_idle_call+0x6d/0xb0 [ 13.684079][ C0] cpuidle_idle_call+0x26f/0x3a0 [ 13.684082][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 13.684085][ C0] ? tsc_verify_tsc_adjust+0x98/0x300 [ 13.684091][ C0] do_idle+0xf6/0x160 [ 13.684094][ C0] cpu_startup_entry+0x54/0x60 [ 13.684097][ C0] rest_init+0x14b/0x260 [ 13.684100][ C0] start_kernel+0x350/0x410 [ 13.684104][ C0] x86_64_start_reservations+0x18/0x30 [ 13.684109][ C0] x86_64_start_kernel+0xba/0x110 [ 13.684113][ C0] common_startup_64+0x13e/0x148 [ 13.684122][ C0] [ 15.963625][ T229] TCP: AO key ifindex 200 != sk bound ifindex 3 [ 15.964558][ T229] TCP: AO key ifindex 200 != sk bound ifindex 3 [ 15.965440][ T229] TCP: AO key ifindex 200 != sk bound ifindex 3 [ 15.966359][ T229] TCP: AO key ifindex 200 != sk bound ifindex 3 [ 15.967447][ T229] TCP: AO key ifindex 200 != sk bound ifindex 3