[ 15.372873][ C2] [ 15.373011][ C2] ================================ [ 15.373208][ C2] WARNING: inconsistent lock state [ 15.373396][ C2] 6.15.0-rc7-virtme #1 Not tainted [ 15.373582][ C2] -------------------------------- [ 15.373770][ C2] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 15.374002][ C2] swapper/2/0 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 15.374236][ C2] ffffffffb71bff78 (pin_fs_lock){+.?.}-{3:3}, at: simple_pin_fs+0x24/0x150 [ 15.374573][ C2] {SOFTIRQ-ON-W} state was registered at: [ 15.374762][ C2] __lock_acquire+0x3eb/0x9d0 [ 15.374967][ C2] lock_acquire.part.0+0xb6/0x240 [ 15.375164][ C2] _raw_spin_lock+0x33/0x40 [ 15.375357][ C2] simple_pin_fs+0x24/0x150 [ 15.375546][ C2] start_creating.part.0+0x3f/0x2f0 [ 15.375737][ C2] debugfs_create_dir+0x6a/0x540 [ 15.375930][ C2] component_debug_init+0x17/0x30 [ 15.376121][ C2] do_one_initcall+0x8f/0x1e0 [ 15.376313][ C2] do_initcalls+0x176/0x280 [ 15.376506][ C2] kernel_init_freeable+0x22d/0x300 [ 15.376697][ C2] kernel_init+0x20/0x200 [ 15.376887][ C2] ret_from_fork+0x31/0x70 [ 15.377076][ C2] ret_from_fork_asm+0x1a/0x30 [ 15.377263][ C2] irq event stamp: 325074 [ 15.377409][ C2] hardirqs last enabled at (325074): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.377787][ C2] hardirqs last disabled at (325073): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 15.378180][ C2] softirqs last enabled at (323002): [] handle_softirqs+0x358/0x620 [ 15.378533][ C2] softirqs last disabled at (323009): [] __irq_exit_rcu+0xfa/0x160 [ 15.378887][ C2] [ 15.378887][ C2] other info that might help us debug this: [ 15.379183][ C2] Possible unsafe locking scenario: [ 15.379183][ C2] [ 15.379476][ C2] CPU0 [ 15.379625][ C2] ---- [ 15.379790][ C2] lock(pin_fs_lock); [ 15.379944][ C2] [ 15.380175][ C2] lock(pin_fs_lock); [ 15.380325][ C2] [ 15.380325][ C2] *** DEADLOCK *** [ 15.380325][ C2] [ 15.380598][ C2] 1 lock held by swapper/2/0: [ 15.380791][ C2] #0: ffffffffb6f749c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 15.381130][ C2] [ 15.381130][ C2] stack backtrace: [ 15.381365][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Not tainted 6.15.0-rc7-virtme #1 PREEMPT(full) [ 15.381370][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.381372][ C2] Call Trace: [ 15.381374][ C2] [ 15.381377][ C2] dump_stack_lvl+0x82/0xd0 [ 15.381383][ C2] print_usage_bug.part.0+0x25f/0x360 [ 15.381388][ C2] mark_lock_irq+0x343/0x400 [ 15.381393][ C2] ? __pfx_unwind_next_frame+0x10/0x10 [ 15.381399][ C2] ? save_trace+0x52/0x170 [ 15.381403][ C2] mark_lock+0x174/0x2f0 [ 15.381408][ C2] mark_usage+0x46/0x150 [ 15.381411][ C2] __lock_acquire+0x3eb/0x9d0 [ 15.381417][ C2] lock_acquire.part.0+0xb6/0x240 [ 15.381419][ C2] ? simple_pin_fs+0x24/0x150 [ 15.381423][ C2] ? rcu_is_watching+0x12/0xc0 [ 15.381429][ C2] ? lock_acquire+0x10c/0x170 [ 15.381431][ C2] ? simple_pin_fs+0x24/0x150 [ 15.381435][ C2] _raw_spin_lock+0x33/0x40 [ 15.381438][ C2] ? simple_pin_fs+0x24/0x150 [ 15.381441][ C2] simple_pin_fs+0x24/0x150 [ 15.381444][ C2] debugfs_remove+0x35/0x70 [ 15.381447][ C2] ref_tracker_dir_exit+0xcf/0x740 [ 15.381453][ C2] ? __pfx_ref_tracker_free+0x10/0x10 [ 15.381456][ C2] ? __sk_destruct+0x383/0x780 [ 15.381462][ C2] ? rcu_do_batch+0x34f/0xf20 [ 15.381465][ C2] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 15.381468][ C2] ? irq_exit_rcu+0xe/0x30 [ 15.381470][ C2] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.381474][ C2] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.381477][ C2] ? pv_native_safe_halt+0xf/0x20 [ 15.381480][ C2] ? default_idle+0x9/0x10 [ 15.381482][ C2] ? default_idle_call+0x6d/0xb0 [ 15.381484][ C2] ? cpuidle_idle_call+0x26f/0x3a0 [ 15.381489][ C2] ? do_idle+0xf6/0x160 [ 15.381492][ C2] ? cpu_startup_entry+0x54/0x60 [ 15.381495][ C2] ? start_secondary+0x213/0x2a0 [ 15.381500][ C2] ? common_startup_64+0x13e/0x148 [ 15.381507][ C2] __put_net+0x19/0x60 [ 15.381510][ C2] __sk_destruct+0x58a/0x780 [ 15.381514][ C2] ? rcu_do_batch+0x34a/0xf20 [ 15.381517][ C2] rcu_do_batch+0x34f/0xf20 [ 15.381521][ C2] ? find_held_lock+0x2b/0x80 [ 15.381525][ C2] ? __pfx_rcu_do_batch+0x10/0x10 [ 15.381529][ C2] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.381532][ C2] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.381536][ C2] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 15.381541][ C2] rcu_core+0x2bb/0x500 [ 15.381545][ C2] handle_softirqs+0x218/0x620 [ 15.381549][ C2] __irq_exit_rcu+0xfa/0x160 [ 15.381552][ C2] irq_exit_rcu+0xe/0x30 [ 15.381554][ C2] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.381558][ C2] [ 15.381559][ C2] [ 15.381560][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.381563][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 15.381567][ 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.381570][ C2] RSP: 0018:ffffc90000147de8 EFLAGS: 00000242 [ 15.381573][ C2] RAX: 000000000004edbf RBX: 1ffff92000028fc1 RCX: ffffffffb5f5ba19 [ 15.381575][ C2] RDX: 0000000000000000 RSI: ffffffffb6a87785 RDI: ffffffffb6251260 [ 15.381577][ C2] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c2667a [ 15.381578][ C2] R10: ffff8880361333d3 R11: 0000000000000000 R12: 0000000000000000 [ 15.381580][ C2] R13: ffff888001bf2340 R14: dffffc0000000000 R15: 0000000000000000 [ 15.381584][ C2] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 15.381589][ C2] default_idle+0x9/0x10 [ 15.381591][ C2] default_idle_call+0x6d/0xb0 [ 15.381594][ C2] cpuidle_idle_call+0x26f/0x3a0 [ 15.381598][ C2] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 15.381602][ C2] ? tsc_verify_tsc_adjust+0x98/0x300 [ 15.381607][ C2] do_idle+0xf6/0x160 [ 15.381611][ C2] cpu_startup_entry+0x54/0x60 [ 15.381614][ C2] start_secondary+0x213/0x2a0 [ 15.381618][ C2] ? __pfx_start_secondary+0x10/0x10 [ 15.381623][ C2] common_startup_64+0x13e/0x148 [ 15.381630][ C2] [ 15.396426][ C2] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 15.396747][ C2] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/2 [ 15.397072][ C2] preempt_count: 101, expected: 0 [ 15.397385][ C2] RCU nest depth: 0, expected: 0 [ 15.397573][ C2] INFO: lockdep is turned off. [ 15.397756][ C2] Preemption disabled at: [ 15.397758][ C2] [<0000000000000000>] 0x0 [ 15.398207][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Not tainted 6.15.0-rc7-virtme #1 PREEMPT(full) [ 15.398212][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.398214][ C2] Call Trace: [ 15.398215][ C2] [ 15.398218][ C2] dump_stack_lvl+0xb0/0xd0 [ 15.398224][ C2] __might_resched+0x360/0x5a0 [ 15.398231][ C2] down_write+0x72/0x210 [ 15.398234][ C2] ? __pfx_down_write+0x10/0x10 [ 15.398238][ C2] ? simple_recursive_removal+0x3a/0x860 [ 15.398242][ C2] ? rcu_is_watching+0x12/0xc0 [ 15.398247][ C2] ? do_raw_spin_unlock+0x58/0x220 [ 15.398252][ C2] simple_recursive_removal+0x166/0x860 [ 15.398255][ C2] ? __pfx_remove_one+0x10/0x10 [ 15.398259][ C2] ? do_raw_spin_unlock+0x58/0x220 [ 15.398264][ C2] debugfs_remove+0x44/0x70 [ 15.398267][ C2] ref_tracker_dir_exit+0xcf/0x740 [ 15.398271][ C2] ? __pfx_ref_tracker_free+0x10/0x10 [ 15.398275][ C2] ? __sk_destruct+0x383/0x780 [ 15.398279][ C2] ? rcu_do_batch+0x34f/0xf20 [ 15.398284][ C2] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 15.398287][ C2] ? irq_exit_rcu+0xe/0x30 [ 15.398291][ C2] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.398295][ C2] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.398299][ C2] ? pv_native_safe_halt+0xf/0x20 [ 15.398302][ C2] ? default_idle+0x9/0x10 [ 15.398304][ C2] ? default_idle_call+0x6d/0xb0 [ 15.398306][ C2] ? cpuidle_idle_call+0x26f/0x3a0 [ 15.398311][ C2] ? do_idle+0xf6/0x160 [ 15.398314][ C2] ? cpu_startup_entry+0x54/0x60 [ 15.398317][ C2] ? start_secondary+0x213/0x2a0 [ 15.398321][ C2] ? common_startup_64+0x13e/0x148 [ 15.398327][ C2] __put_net+0x19/0x60 [ 15.398331][ C2] __sk_destruct+0x58a/0x780 [ 15.398335][ C2] ? rcu_do_batch+0x34a/0xf20 [ 15.398338][ C2] rcu_do_batch+0x34f/0xf20 [ 15.398342][ C2] ? find_held_lock+0x2b/0x80 [ 15.398347][ C2] ? __pfx_rcu_do_batch+0x10/0x10 [ 15.398350][ C2] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.398354][ C2] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.398358][ C2] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 15.398363][ C2] rcu_core+0x2bb/0x500 [ 15.398366][ C2] handle_softirqs+0x218/0x620 [ 15.398371][ C2] __irq_exit_rcu+0xfa/0x160 [ 15.398373][ C2] irq_exit_rcu+0xe/0x30 [ 15.398376][ C2] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.398379][ C2] [ 15.398380][ C2] [ 15.398382][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.398385][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 15.398389][ 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.398392][ C2] RSP: 0018:ffffc90000147de8 EFLAGS: 00000242 [ 15.398395][ C2] RAX: 000000000004edbf RBX: 1ffff92000028fc1 RCX: ffffffffb5f5ba19 [ 15.398398][ C2] RDX: 0000000000000000 RSI: ffffffffb6a87785 RDI: ffffffffb6251260 [ 15.398400][ C2] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c2667a [ 15.398401][ C2] R10: ffff8880361333d3 R11: 0000000000000000 R12: 0000000000000000 [ 15.398403][ C2] R13: ffff888001bf2340 R14: dffffc0000000000 R15: 0000000000000000 [ 15.398407][ C2] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 15.398412][ C2] default_idle+0x9/0x10 [ 15.398414][ C2] default_idle_call+0x6d/0xb0 [ 15.398416][ C2] cpuidle_idle_call+0x26f/0x3a0 [ 15.398420][ C2] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 15.398424][ C2] ? tsc_verify_tsc_adjust+0x98/0x300 [ 15.398429][ C2] do_idle+0xf6/0x160 [ 15.398433][ C2] cpu_startup_entry+0x54/0x60 [ 15.398437][ C2] start_secondary+0x213/0x2a0 [ 15.398440][ C2] ? __pfx_start_secondary+0x10/0x10 [ 15.398445][ C2] common_startup_64+0x13e/0x148 [ 15.398452][ C2] [ 17.094401][ T258] packetdrill (258) used greatest stack depth: 24584 bytes left [ 17.107250][ C3] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 17.107573][ C3] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/3 [ 17.107873][ C3] preempt_count: 101, expected: 0 [ 17.108054][ C3] RCU nest depth: 0, expected: 0 [ 17.108225][ C3] INFO: lockdep is turned off. [ 17.108395][ C3] Preemption disabled at: [ 17.108396][ C3] [<0000000000000000>] 0x0 [ 17.108702][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 6.15.0-rc7-virtme #1 PREEMPT(full) [ 17.108707][ C3] Tainted: [W]=WARN [ 17.108709][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 17.108710][ C3] Call Trace: [ 17.108713][ C3] [ 17.108715][ C3] dump_stack_lvl+0xb0/0xd0 [ 17.108722][ C3] __might_resched+0x360/0x5a0 [ 17.108729][ C3] down_write+0x72/0x210 [ 17.108733][ C3] ? __pfx_down_write+0x10/0x10 [ 17.108736][ C3] ? simple_recursive_removal+0x3a/0x860 [ 17.108741][ C3] ? rcu_is_watching+0x12/0xc0 [ 17.108748][ C3] ? do_raw_spin_unlock+0x58/0x220 [ 17.108753][ C3] simple_recursive_removal+0x166/0x860 [ 17.108756][ C3] ? __pfx_remove_one+0x10/0x10 [ 17.108761][ C3] ? do_raw_spin_unlock+0x58/0x220 [ 17.108766][ C3] debugfs_remove+0x44/0x70 [ 17.108769][ C3] ref_tracker_dir_exit+0xcf/0x740 [ 17.108773][ C3] ? __pfx_ref_tracker_free+0x10/0x10 [ 17.108776][ C3] ? __sk_destruct+0x383/0x780 [ 17.108782][ C3] ? rcu_do_batch+0x34f/0xf20 [ 17.108786][ C3] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 17.108789][ C3] ? irq_exit_rcu+0xe/0x30 [ 17.108794][ C3] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 17.108798][ C3] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.108802][ C3] ? pv_native_safe_halt+0xf/0x20 [ 17.108805][ C3] ? default_idle+0x9/0x10 [ 17.108807][ C3] ? default_idle_call+0x6d/0xb0 [ 17.108810][ C3] ? cpuidle_idle_call+0x26f/0x3a0 [ 17.108814][ C3] ? do_idle+0xf6/0x160 [ 17.108817][ C3] ? cpu_startup_entry+0x54/0x60 [ 17.108820][ C3] ? start_secondary+0x213/0x2a0 [ 17.108825][ C3] ? common_startup_64+0x13e/0x148 [ 17.108829][ C3] ? bpf_sk_storage_free+0x9f/0x1c0 [ 17.108833][ C3] ? rcu_is_watching+0x12/0xc0 [ 17.108838][ C3] __put_net+0x19/0x60 [ 17.108841][ C3] __sk_destruct+0x58a/0x780 [ 17.108845][ C3] ? rcu_do_batch+0x34a/0xf20 [ 17.108848][ C3] rcu_do_batch+0x34f/0xf20 [ 17.108853][ C3] ? __pfx_rcu_do_batch+0x10/0x10 [ 17.108858][ C3] ? rcu_is_watching+0x12/0xc0 [ 17.108863][ C3] rcu_core+0x2bb/0x500 [ 17.108867][ C3] handle_softirqs+0x218/0x620 [ 17.108872][ C3] __irq_exit_rcu+0xfa/0x160 [ 17.108874][ C3] irq_exit_rcu+0xe/0x30 [ 17.108877][ C3] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 17.108880][ C3] [ 17.108881][ C3] [ 17.108883][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.108886][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 17.108890][ 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.108893][ C3] RSP: 0018:ffffc90000157de8 EFLAGS: 00000246 [ 17.108896][ C3] RAX: 0000000000000003 RBX: 1ffff9200002afc1 RCX: ffffffffb5f5ba19 [ 17.108898][ C3] RDX: ffffed1006c3667b RSI: ffffffffb62511e0 RDI: ffffffffb378633f [ 17.108900][ C3] RBP: 0000000000000000 R08: 0000000000000000 R09: ffffed1006c3667a [ 17.108902][ C3] R10: ffff8880361b33d3 R11: ffff888001bdcb58 R12: 0000000000000000 [ 17.108904][ C3] R13: ffff888001bf4640 R14: dffffc0000000000 R15: 0000000000000000 [ 17.108907][ C3] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 17.108911][ C3] ? cpuidle_idle_call+0x26f/0x3a0 [ 17.108915][ C3] default_idle+0x9/0x10 [ 17.108917][ C3] default_idle_call+0x6d/0xb0 [ 17.108920][ C3] cpuidle_idle_call+0x26f/0x3a0 [ 17.108924][ C3] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 17.108928][ C3] ? tsc_verify_tsc_adjust+0x98/0x300 [ 17.108933][ C3] do_idle+0xf6/0x160 [ 17.108937][ C3] cpu_startup_entry+0x54/0x60 [ 17.108941][ C3] start_secondary+0x213/0x2a0 [ 17.108945][ C3] ? __pfx_start_secondary+0x10/0x10 [ 17.108950][ C3] common_startup_64+0x13e/0x148 [ 17.108956][ C3]