[ 13.026924][ C0] [ 13.027088][ C0] ================================ [ 13.027325][ C0] WARNING: inconsistent lock state [ 13.027566][ C0] 6.15.0-rc7-virtme #1 Not tainted [ 13.027809][ C0] -------------------------------- [ 13.028055][ C0] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 13.028359][ C0] swapper/0/0 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 13.028665][ C0] ffffffffaa7bff78 (pin_fs_lock){+.?.}-{3:3}, at: simple_pin_fs+0x24/0x150 [ 13.029103][ C0] {SOFTIRQ-ON-W} state was registered at: [ 13.029347][ C0] __lock_acquire+0x3eb/0x9d0 [ 13.029605][ C0] lock_acquire.part.0+0xb6/0x240 [ 13.029854][ C0] _raw_spin_lock+0x33/0x40 [ 13.030104][ C0] simple_pin_fs+0x24/0x150 [ 13.030343][ C0] start_creating.part.0+0x3f/0x2f0 [ 13.030580][ C0] debugfs_create_dir+0x6a/0x540 [ 13.030816][ C0] component_debug_init+0x17/0x30 [ 13.031051][ C0] do_one_initcall+0x8f/0x1e0 [ 13.031290][ C0] do_initcalls+0x176/0x280 [ 13.031532][ C0] kernel_init_freeable+0x22d/0x300 [ 13.031764][ C0] kernel_init+0x20/0x200 [ 13.032000][ C0] ret_from_fork+0x31/0x70 [ 13.032237][ C0] ret_from_fork_asm+0x1a/0x30 [ 13.032475][ C0] irq event stamp: 416650 [ 13.032651][ C0] hardirqs last enabled at (416650): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 13.033115][ C0] hardirqs last disabled at (416649): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 13.033583][ C0] softirqs last enabled at (416472): [] handle_softirqs+0x358/0x620 [ 13.033994][ C0] softirqs last disabled at (416479): [] __irq_exit_rcu+0xfa/0x160 [ 13.034407][ C0] [ 13.034407][ C0] other info that might help us debug this: [ 13.034754][ C0] Possible unsafe locking scenario: [ 13.034754][ C0] [ 13.035096][ C0] CPU0 [ 13.035270][ C0] ---- [ 13.035441][ C0] lock(pin_fs_lock); [ 13.035621][ C0] [ 13.035795][ C0] lock(pin_fs_lock); [ 13.035971][ C0] [ 13.035971][ C0] *** DEADLOCK *** [ 13.035971][ C0] [ 13.036317][ C0] 1 lock held by swapper/0/0: [ 13.036561][ C0] #0: ffffffffaa5749c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 13.036990][ C0] [ 13.036990][ C0] stack backtrace: [ 13.037281][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 6.15.0-rc7-virtme #1 PREEMPT(full) [ 13.037285][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.037287][ C0] Call Trace: [ 13.037289][ C0] [ 13.037291][ C0] dump_stack_lvl+0x82/0xd0 [ 13.037299][ C0] print_usage_bug.part.0+0x25f/0x360 [ 13.037303][ C0] mark_lock_irq+0x343/0x400 [ 13.037306][ C0] ? is_bpf_text_address+0x67/0x120 [ 13.037311][ C0] ? __lock_release+0x5d/0x170 [ 13.037315][ C0] ? save_trace+0x52/0x170 [ 13.037322][ C0] mark_lock+0x174/0x2f0 [ 13.037325][ C0] mark_usage+0x46/0x150 [ 13.037328][ C0] __lock_acquire+0x3eb/0x9d0 [ 13.037333][ C0] lock_acquire.part.0+0xb6/0x240 [ 13.037336][ C0] ? simple_pin_fs+0x24/0x150 [ 13.037340][ C0] ? rcu_is_watching+0x12/0xc0 [ 13.037343][ C0] ? lock_acquire+0x10c/0x170 [ 13.037346][ C0] ? simple_pin_fs+0x24/0x150 [ 13.037349][ C0] _raw_spin_lock+0x33/0x40 [ 13.037352][ C0] ? simple_pin_fs+0x24/0x150 [ 13.037355][ C0] simple_pin_fs+0x24/0x150 [ 13.037358][ C0] debugfs_remove+0x35/0x70 [ 13.037362][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 13.037369][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 13.037373][ C0] ? __sk_destruct+0x383/0x780 [ 13.037380][ C0] ? rcu_do_batch+0x34f/0xf20 [ 13.037383][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 13.037387][ C0] ? irq_exit_rcu+0xe/0x30 [ 13.037389][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 13.037394][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.037397][ C0] ? pv_native_safe_halt+0xf/0x20 [ 13.037400][ C0] ? default_idle+0x9/0x10 [ 13.037403][ C0] ? default_idle_call+0x6d/0xb0 [ 13.037405][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 13.037410][ C0] ? do_idle+0xf6/0x160 [ 13.037412][ C0] ? cpu_startup_entry+0x54/0x60 [ 13.037414][ C0] ? rest_init+0x14b/0x260 [ 13.037417][ C0] ? start_kernel+0x350/0x410 [ 13.037424][ C0] __put_net+0x19/0x60 [ 13.037428][ C0] __sk_destruct+0x58a/0x780 [ 13.037432][ C0] ? rcu_do_batch+0x34a/0xf20 [ 13.037436][ C0] rcu_do_batch+0x34f/0xf20 [ 13.037440][ C0] ? find_held_lock+0x2b/0x80 [ 13.037445][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 13.037449][ C0] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 13.037452][ C0] ? lockdep_hardirqs_on+0x7c/0x110 [ 13.037455][ C0] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 13.037460][ C0] rcu_core+0x2bb/0x500 [ 13.037464][ C0] handle_softirqs+0x218/0x620 [ 13.037469][ C0] __irq_exit_rcu+0xfa/0x160 [ 13.037471][ C0] irq_exit_rcu+0xe/0x30 [ 13.037474][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 13.037477][ C0] [ 13.037478][ C0] [ 13.037480][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.037483][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 13.037486][ C0] Code: 50 b7 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 45 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.037490][ C0] RSP: 0018:ffffffffaa207df8 EFLAGS: 00000246 [ 13.037493][ C0] RAX: 0000000000065add RBX: 1ffffffff5440fc3 RCX: ffffffffa956ea19 [ 13.037495][ C0] RDX: 0000000000000000 RSI: ffffffffaa089a45 RDI: ffffffffa98513a0 [ 13.037497][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c0667a [ 13.037499][ C0] R10: ffff8880360333d3 R11: 0000000000000000 R12: 0000000000000000 [ 13.037501][ C0] R13: ffffffffaa21f240 R14: dffffc0000000000 R15: 0000000000014770 [ 13.037505][ C0] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 13.037510][ C0] default_idle+0x9/0x10 [ 13.037513][ C0] default_idle_call+0x6d/0xb0 [ 13.037515][ C0] cpuidle_idle_call+0x26f/0x3a0 [ 13.037518][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 13.037521][ C0] ? tsc_verify_tsc_adjust+0x98/0x300 [ 13.037528][ C0] do_idle+0xf6/0x160 [ 13.037531][ C0] cpu_startup_entry+0x54/0x60 [ 13.037533][ C0] rest_init+0x14b/0x260 [ 13.037536][ C0] start_kernel+0x350/0x410 [ 13.037541][ C0] x86_64_start_reservations+0x18/0x30 [ 13.037547][ C0] x86_64_start_kernel+0xba/0x110 [ 13.037550][ C0] common_startup_64+0x13e/0x148 [ 13.037559][ C0] [ 13.058584][ C0] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 13.058985][ C0] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/0 [ 13.059377][ C0] preempt_count: 101, expected: 0 [ 13.059604][ C0] RCU nest depth: 0, expected: 0 [ 13.059836][ C0] INFO: lockdep is turned off. [ 13.060316][ C0] Preemption disabled at: [ 13.060318][ C0] [] schedule_preempt_disabled+0x22/0x30 [ 13.060828][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 6.15.0-rc7-virtme #1 PREEMPT(full) [ 13.060833][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.060834][ C0] Call Trace: [ 13.060836][ C0] [ 13.060838][ C0] dump_stack_lvl+0xb0/0xd0 [ 13.060843][ C0] __might_resched+0x360/0x5a0 [ 13.060851][ C0] down_write+0x72/0x210 [ 13.060855][ C0] ? __pfx_down_write+0x10/0x10 [ 13.060857][ C0] ? simple_recursive_removal+0x3a/0x860 [ 13.060862][ C0] ? rcu_is_watching+0x12/0xc0 [ 13.060866][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 13.060871][ C0] simple_recursive_removal+0x166/0x860 [ 13.060874][ C0] ? __pfx_remove_one+0x10/0x10 [ 13.060878][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 13.060883][ C0] debugfs_remove+0x44/0x70 [ 13.060886][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 13.060891][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 13.060895][ C0] ? __sk_destruct+0x383/0x780 [ 13.060898][ C0] ? rcu_do_batch+0x34f/0xf20 [ 13.060902][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 13.060906][ C0] ? irq_exit_rcu+0xe/0x30 [ 13.060909][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 13.060913][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.060916][ C0] ? pv_native_safe_halt+0xf/0x20 [ 13.060919][ C0] ? default_idle+0x9/0x10 [ 13.060922][ C0] ? default_idle_call+0x6d/0xb0 [ 13.060924][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 13.060927][ C0] ? do_idle+0xf6/0x160 [ 13.060929][ C0] ? cpu_startup_entry+0x54/0x60 [ 13.060931][ C0] ? rest_init+0x14b/0x260 [ 13.060933][ C0] ? start_kernel+0x350/0x410 [ 13.060941][ C0] __put_net+0x19/0x60 [ 13.060944][ C0] __sk_destruct+0x58a/0x780 [ 13.060948][ C0] ? rcu_do_batch+0x34a/0xf20 [ 13.060951][ C0] rcu_do_batch+0x34f/0xf20 [ 13.060956][ C0] ? find_held_lock+0x2b/0x80 [ 13.060960][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 13.060965][ C0] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 13.060969][ C0] ? lockdep_hardirqs_on+0x7c/0x110 [ 13.060973][ C0] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 13.060977][ C0] rcu_core+0x2bb/0x500 [ 13.060981][ C0] handle_softirqs+0x218/0x620 [ 13.060986][ C0] __irq_exit_rcu+0xfa/0x160 [ 13.060989][ C0] irq_exit_rcu+0xe/0x30 [ 13.060991][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 13.060995][ C0] [ 13.060996][ C0] [ 13.060997][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.061000][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 13.061003][ C0] Code: 50 b7 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 45 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.061006][ C0] RSP: 0018:ffffffffaa207df8 EFLAGS: 00000246 [ 13.061009][ C0] RAX: 0000000000065add RBX: 1ffffffff5440fc3 RCX: ffffffffa956ea19 [ 13.061011][ C0] RDX: 0000000000000000 RSI: ffffffffaa089a45 RDI: ffffffffa98513a0 [ 13.061013][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c0667a [ 13.061015][ C0] R10: ffff8880360333d3 R11: 0000000000000000 R12: 0000000000000000 [ 13.061017][ C0] R13: ffffffffaa21f240 R14: dffffc0000000000 R15: 0000000000014770 [ 13.061021][ C0] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 13.061026][ C0] default_idle+0x9/0x10 [ 13.061028][ C0] default_idle_call+0x6d/0xb0 [ 13.061031][ C0] cpuidle_idle_call+0x26f/0x3a0 [ 13.061034][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 13.061037][ C0] ? tsc_verify_tsc_adjust+0x98/0x300 [ 13.061042][ C0] do_idle+0xf6/0x160 [ 13.061045][ C0] cpu_startup_entry+0x54/0x60 [ 13.061048][ C0] rest_init+0x14b/0x260 [ 13.061051][ C0] start_kernel+0x350/0x410 [ 13.061055][ C0] x86_64_start_reservations+0x18/0x30 [ 13.061059][ C0] x86_64_start_kernel+0xba/0x110 [ 13.061062][ C0] common_startup_64+0x13e/0x148 [ 13.061070][ C0] [ 15.056639][ T228] TCP: AO key ifindex 200 != sk bound ifindex 3 [ 15.057670][ T228] TCP: AO key ifindex 200 != sk bound ifindex 3 [ 15.058557][ T228] TCP: AO key ifindex 200 != sk bound ifindex 3 [ 15.059427][ T228] TCP: AO key ifindex 200 != sk bound ifindex 3 [ 15.060243][ T228] TCP: AO key ifindex 200 != sk bound ifindex 3