[ 15.636964][ C2] [ 15.637138][ C2] ================================ [ 15.637361][ C2] WARNING: inconsistent lock state [ 15.637581][ C2] 6.15.0-rc7-virtme #1 Not tainted [ 15.637801][ C2] -------------------------------- [ 15.638017][ C2] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 15.638290][ C2] swapper/2/0 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 15.638563][ C2] ffffffffae5bff78 (pin_fs_lock){+.?.}-{3:3}, at: simple_pin_fs+0x24/0x150 [ 15.638950][ C2] {SOFTIRQ-ON-W} state was registered at: [ 15.639160][ C2] __lock_acquire+0x3eb/0x9d0 [ 15.639374][ C2] lock_acquire.part.0+0xb6/0x240 [ 15.639585][ C2] _raw_spin_lock+0x33/0x40 [ 15.639805][ C2] simple_pin_fs+0x24/0x150 [ 15.640012][ C2] start_creating.part.0+0x3f/0x2f0 [ 15.640219][ C2] debugfs_create_dir+0x6a/0x540 [ 15.640429][ C2] component_debug_init+0x17/0x30 [ 15.640640][ C2] do_one_initcall+0x8f/0x1e0 [ 15.640854][ C2] do_initcalls+0x176/0x280 [ 15.641067][ C2] kernel_init_freeable+0x22d/0x300 [ 15.641279][ C2] kernel_init+0x20/0x200 [ 15.641493][ C2] ret_from_fork+0x31/0x70 [ 15.641704][ C2] ret_from_fork_asm+0x1a/0x30 [ 15.641918][ C2] irq event stamp: 269366 [ 15.642078][ C2] hardirqs last enabled at (269366): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.642504][ C2] hardirqs last disabled at (269365): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 15.642924][ C2] softirqs last enabled at (269340): [] handle_softirqs+0x358/0x620 [ 15.643292][ C2] softirqs last disabled at (269347): [] __irq_exit_rcu+0xfa/0x160 [ 15.643662][ C2] [ 15.643662][ C2] other info that might help us debug this: [ 15.643973][ C2] Possible unsafe locking scenario: [ 15.643973][ C2] [ 15.644288][ C2] CPU0 [ 15.644442][ C2] ---- [ 15.644600][ C2] lock(pin_fs_lock); [ 15.644762][ C2] [ 15.644920][ C2] lock(pin_fs_lock); [ 15.645081][ C2] [ 15.645081][ C2] *** DEADLOCK *** [ 15.645081][ C2] [ 15.645395][ C2] 1 lock held by swapper/2/0: [ 15.645605][ C2] #0: ffffffffae3749c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 15.645983][ C2] [ 15.645983][ C2] stack backtrace: [ 15.646251][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Not tainted 6.15.0-rc7-virtme #1 PREEMPT(full) [ 15.646256][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.646258][ C2] Call Trace: [ 15.646260][ C2] [ 15.646262][ C2] dump_stack_lvl+0x82/0xd0 [ 15.646267][ C2] print_usage_bug.part.0+0x25f/0x360 [ 15.646272][ C2] mark_lock_irq+0x343/0x400 [ 15.646277][ C2] ? __pfx_unwind_next_frame+0x10/0x10 [ 15.646283][ C2] ? save_trace+0x52/0x170 [ 15.646288][ C2] mark_lock+0x174/0x2f0 [ 15.646292][ C2] mark_usage+0x46/0x150 [ 15.646296][ C2] __lock_acquire+0x3eb/0x9d0 [ 15.646301][ C2] lock_acquire.part.0+0xb6/0x240 [ 15.646304][ C2] ? simple_pin_fs+0x24/0x150 [ 15.646307][ C2] ? rcu_is_watching+0x12/0xc0 [ 15.646312][ C2] ? lock_acquire+0x10c/0x170 [ 15.646314][ C2] ? simple_pin_fs+0x24/0x150 [ 15.646318][ C2] _raw_spin_lock+0x33/0x40 [ 15.646321][ C2] ? simple_pin_fs+0x24/0x150 [ 15.646323][ C2] simple_pin_fs+0x24/0x150 [ 15.646326][ C2] debugfs_remove+0x35/0x70 [ 15.646329][ C2] ref_tracker_dir_exit+0xcf/0x740 [ 15.646335][ C2] ? __pfx_ref_tracker_free+0x10/0x10 [ 15.646338][ C2] ? __sk_destruct+0x383/0x780 [ 15.646343][ C2] ? rcu_do_batch+0x34f/0xf20 [ 15.646346][ C2] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 15.646349][ C2] ? irq_exit_rcu+0xe/0x30 [ 15.646351][ C2] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.646355][ C2] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.646358][ C2] ? pv_native_safe_halt+0xf/0x20 [ 15.646361][ C2] ? default_idle+0x9/0x10 [ 15.646363][ C2] ? default_idle_call+0x6d/0xb0 [ 15.646366][ C2] ? cpuidle_idle_call+0x26f/0x3a0 [ 15.646370][ C2] ? do_idle+0xf6/0x160 [ 15.646373][ C2] ? cpu_startup_entry+0x54/0x60 [ 15.646376][ C2] ? start_secondary+0x213/0x2a0 [ 15.646381][ C2] ? common_startup_64+0x13e/0x148 [ 15.646388][ C2] __put_net+0x19/0x60 [ 15.646391][ C2] __sk_destruct+0x58a/0x780 [ 15.646395][ C2] ? rcu_do_batch+0x34a/0xf20 [ 15.646398][ C2] rcu_do_batch+0x34f/0xf20 [ 15.646402][ C2] ? find_held_lock+0x2b/0x80 [ 15.646406][ C2] ? __pfx_rcu_do_batch+0x10/0x10 [ 15.646410][ C2] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.646414][ C2] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.646417][ C2] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 15.646422][ C2] rcu_core+0x2bb/0x500 [ 15.646425][ C2] handle_softirqs+0x218/0x620 [ 15.646430][ C2] __irq_exit_rcu+0xfa/0x160 [ 15.646433][ C2] irq_exit_rcu+0xe/0x30 [ 15.646435][ C2] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.646438][ C2] [ 15.646439][ C2] [ 15.646441][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.646444][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 15.646448][ C2] 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 [ 15.646451][ C2] RSP: 0018:ffffc90000147de8 EFLAGS: 00000246 [ 15.646454][ C2] RAX: 0000000000041c21 RBX: 1ffff92000028fc1 RCX: ffffffffad35ba19 [ 15.646456][ C2] RDX: 0000000000000000 RSI: ffffffffade87785 RDI: ffffffffad651260 [ 15.646458][ C2] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c2667a [ 15.646459][ C2] R10: ffff8880361333d3 R11: 0000000000000000 R12: 0000000000000000 [ 15.646461][ C2] R13: ffff888001bf2340 R14: dffffc0000000000 R15: 0000000000000000 [ 15.646465][ C2] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 15.646470][ C2] default_idle+0x9/0x10 [ 15.646472][ C2] default_idle_call+0x6d/0xb0 [ 15.646474][ C2] cpuidle_idle_call+0x26f/0x3a0 [ 15.646478][ C2] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 15.646482][ C2] ? tsc_verify_tsc_adjust+0x98/0x300 [ 15.646487][ C2] do_idle+0xf6/0x160 [ 15.646491][ C2] cpu_startup_entry+0x54/0x60 [ 15.646495][ C2] start_secondary+0x213/0x2a0 [ 15.646498][ C2] ? __pfx_start_secondary+0x10/0x10 [ 15.646504][ C2] common_startup_64+0x13e/0x148 [ 15.646510][ C2] [ 15.663788][ C2] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 15.664167][ C2] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/2 [ 15.664530][ C2] preempt_count: 101, expected: 0 [ 15.664750][ C2] RCU nest depth: 0, expected: 0 [ 15.665012][ C2] INFO: lockdep is turned off. [ 15.665230][ C2] Preemption disabled at: [ 15.665232][ C2] [<0000000000000000>] 0x0 [ 15.665729][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Not tainted 6.15.0-rc7-virtme #1 PREEMPT(full) [ 15.665734][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.665735][ C2] Call Trace: [ 15.665737][ C2] [ 15.665739][ C2] dump_stack_lvl+0xb0/0xd0 [ 15.665745][ C2] __might_resched+0x360/0x5a0 [ 15.665751][ C2] down_write+0x72/0x210 [ 15.665755][ C2] ? __pfx_down_write+0x10/0x10 [ 15.665758][ C2] ? simple_recursive_removal+0x3a/0x860 [ 15.665763][ C2] ? rcu_is_watching+0x12/0xc0 [ 15.665769][ C2] ? do_raw_spin_unlock+0x58/0x220 [ 15.665774][ C2] simple_recursive_removal+0x166/0x860 [ 15.665777][ C2] ? __pfx_remove_one+0x10/0x10 [ 15.665781][ C2] ? do_raw_spin_unlock+0x58/0x220 [ 15.665785][ C2] debugfs_remove+0x44/0x70 [ 15.665788][ C2] ref_tracker_dir_exit+0xcf/0x740 [ 15.665792][ C2] ? __pfx_ref_tracker_free+0x10/0x10 [ 15.665796][ C2] ? __sk_destruct+0x383/0x780 [ 15.665800][ C2] ? rcu_do_batch+0x34f/0xf20 [ 15.665805][ C2] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 15.665808][ C2] ? irq_exit_rcu+0xe/0x30 [ 15.665811][ C2] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.665816][ C2] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.665819][ C2] ? pv_native_safe_halt+0xf/0x20 [ 15.665822][ C2] ? default_idle+0x9/0x10 [ 15.665825][ C2] ? default_idle_call+0x6d/0xb0 [ 15.665827][ C2] ? cpuidle_idle_call+0x26f/0x3a0 [ 15.665831][ C2] ? do_idle+0xf6/0x160 [ 15.665834][ C2] ? cpu_startup_entry+0x54/0x60 [ 15.665837][ C2] ? start_secondary+0x213/0x2a0 [ 15.665841][ C2] ? common_startup_64+0x13e/0x148 [ 15.665847][ C2] __put_net+0x19/0x60 [ 15.665850][ C2] __sk_destruct+0x58a/0x780 [ 15.665854][ C2] ? rcu_do_batch+0x34a/0xf20 [ 15.665857][ C2] rcu_do_batch+0x34f/0xf20 [ 15.665861][ C2] ? find_held_lock+0x2b/0x80 [ 15.665866][ C2] ? __pfx_rcu_do_batch+0x10/0x10 [ 15.665870][ C2] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.665874][ C2] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.665877][ C2] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 15.665882][ C2] rcu_core+0x2bb/0x500 [ 15.665886][ C2] handle_softirqs+0x218/0x620 [ 15.665890][ C2] __irq_exit_rcu+0xfa/0x160 [ 15.665893][ C2] irq_exit_rcu+0xe/0x30 [ 15.665895][ C2] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.665899][ C2] [ 15.665900][ C2] [ 15.665902][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.665905][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 15.665908][ C2] 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 [ 15.665911][ C2] RSP: 0018:ffffc90000147de8 EFLAGS: 00000246 [ 15.665914][ C2] RAX: 0000000000041c21 RBX: 1ffff92000028fc1 RCX: ffffffffad35ba19 [ 15.665916][ C2] RDX: 0000000000000000 RSI: ffffffffade87785 RDI: ffffffffad651260 [ 15.665918][ C2] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c2667a [ 15.665920][ C2] R10: ffff8880361333d3 R11: 0000000000000000 R12: 0000000000000000 [ 15.665922][ C2] R13: ffff888001bf2340 R14: dffffc0000000000 R15: 0000000000000000 [ 15.665926][ C2] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 15.665933][ C2] default_idle+0x9/0x10 [ 15.665935][ C2] default_idle_call+0x6d/0xb0 [ 15.665938][ C2] cpuidle_idle_call+0x26f/0x3a0 [ 15.665942][ C2] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 15.665946][ C2] ? tsc_verify_tsc_adjust+0x98/0x300 [ 15.665951][ C2] do_idle+0xf6/0x160 [ 15.665955][ C2] cpu_startup_entry+0x54/0x60 [ 15.665958][ C2] start_secondary+0x213/0x2a0 [ 15.665962][ C2] ? __pfx_start_secondary+0x10/0x10 [ 15.665967][ C2] common_startup_64+0x13e/0x148 [ 15.665973][ C2] [ 17.289672][ T257] packetdrill (257) used greatest stack depth: 24568 bytes left [ 17.303219][ C3] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 17.303595][ C3] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/3 [ 17.303925][ C3] preempt_count: 101, expected: 0 [ 17.304134][ C3] RCU nest depth: 0, expected: 0 [ 17.304327][ C3] INFO: lockdep is turned off. [ 17.304519][ C3] Preemption disabled at: [ 17.304520][ C3] [<0000000000000000>] 0x0 [ 17.304863][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 6.15.0-rc7-virtme #1 PREEMPT(full) [ 17.304869][ C3] Tainted: [W]=WARN [ 17.304871][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 17.304873][ C3] Call Trace: [ 17.304875][ C3] [ 17.304878][ C3] dump_stack_lvl+0xb0/0xd0 [ 17.304888][ C3] __might_resched+0x360/0x5a0 [ 17.304896][ C3] down_write+0x72/0x210 [ 17.304902][ C3] ? __pfx_down_write+0x10/0x10 [ 17.304905][ C3] ? simple_recursive_removal+0x3a/0x860 [ 17.304911][ C3] ? rcu_is_watching+0x12/0xc0 [ 17.304919][ C3] ? do_raw_spin_unlock+0x58/0x220 [ 17.304925][ C3] simple_recursive_removal+0x166/0x860 [ 17.304931][ C3] ? __pfx_remove_one+0x10/0x10 [ 17.304936][ C3] ? do_raw_spin_unlock+0x58/0x220 [ 17.304941][ C3] debugfs_remove+0x44/0x70 [ 17.304944][ C3] ref_tracker_dir_exit+0xcf/0x740 [ 17.304950][ C3] ? __pfx_ref_tracker_free+0x10/0x10 [ 17.304954][ C3] ? __sk_destruct+0x383/0x780 [ 17.304961][ C3] ? rcu_do_batch+0x34f/0xf20 [ 17.304966][ C3] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 17.304969][ C3] ? irq_exit_rcu+0xe/0x30 [ 17.304974][ C3] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 17.304980][ C3] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.304984][ C3] ? pv_native_safe_halt+0xf/0x20 [ 17.304988][ C3] ? default_idle+0x9/0x10 [ 17.304990][ C3] ? default_idle_call+0x6d/0xb0 [ 17.304993][ C3] ? cpuidle_idle_call+0x26f/0x3a0 [ 17.304998][ C3] ? do_idle+0xf6/0x160 [ 17.305002][ C3] ? cpu_startup_entry+0x54/0x60 [ 17.305005][ C3] ? start_secondary+0x213/0x2a0 [ 17.305011][ C3] ? common_startup_64+0x13e/0x148 [ 17.305016][ C3] ? bpf_sk_storage_free+0x9f/0x1c0 [ 17.305022][ C3] ? rcu_is_watching+0x12/0xc0 [ 17.305026][ C3] __put_net+0x19/0x60 [ 17.305030][ C3] __sk_destruct+0x58a/0x780 [ 17.305034][ C3] ? rcu_do_batch+0x34a/0xf20 [ 17.305038][ C3] rcu_do_batch+0x34f/0xf20 [ 17.305043][ C3] ? __pfx_rcu_do_batch+0x10/0x10 [ 17.305047][ C3] ? trace_irq_enable.constprop.0+0xd4/0x130 [ 17.305053][ C3] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 17.305060][ C3] rcu_core+0x2bb/0x500 [ 17.305064][ C3] handle_softirqs+0x218/0x620 [ 17.305069][ C3] __irq_exit_rcu+0xfa/0x160 [ 17.305072][ C3] irq_exit_rcu+0xe/0x30 [ 17.305074][ C3] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 17.305078][ C3] [ 17.305079][ C3] [ 17.305080][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.305083][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 17.305088][ C3] 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 [ 17.305091][ C3] RSP: 0018:ffffc90000157de8 EFLAGS: 00000246 [ 17.305095][ C3] RAX: 0000000000000003 RBX: 1ffff9200002afc1 RCX: ffffffffad35ba19 [ 17.305097][ C3] RDX: ffffed1006c3667b RSI: ffffffffad6511e0 RDI: ffffffffaab8633f [ 17.305099][ C3] RBP: 0000000000000000 R08: 0000000000000000 R09: ffffed1006c3667a [ 17.305101][ C3] R10: ffff8880361b33d3 R11: ffff888001ef0558 R12: 0000000000000000 [ 17.305103][ C3] R13: ffff888001bf4640 R14: dffffc0000000000 R15: 0000000000000000 [ 17.305107][ C3] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 17.305110][ C3] ? cpuidle_idle_call+0x26f/0x3a0 [ 17.305114][ C3] default_idle+0x9/0x10 [ 17.305116][ C3] default_idle_call+0x6d/0xb0 [ 17.305119][ C3] cpuidle_idle_call+0x26f/0x3a0 [ 17.305123][ C3] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 17.305127][ C3] ? tsc_verify_tsc_adjust+0x98/0x300 [ 17.305133][ C3] do_idle+0xf6/0x160 [ 17.305137][ C3] cpu_startup_entry+0x54/0x60 [ 17.305140][ C3] start_secondary+0x213/0x2a0 [ 17.305144][ C3] ? __pfx_start_secondary+0x10/0x10 [ 17.305149][ C3] common_startup_64+0x13e/0x148 [ 17.305156][ C3]