[ 15.724755][ C0] [ 15.724913][ C0] ================================ [ 15.725146][ C0] WARNING: inconsistent lock state [ 15.725375][ C0] 6.15.0-virtme #1 Not tainted [ 15.725598][ C0] -------------------------------- [ 15.725823][ C0] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 15.726099][ C0] swapper/0/0 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 15.726376][ C0] ffffffffa73c5af8 (pin_fs_lock){+.?.}-{3:3}, at: simple_pin_fs+0x24/0x150 [ 15.726777][ C0] {SOFTIRQ-ON-W} state was registered at: [ 15.727007][ C0] __lock_acquire+0x20b/0x7e0 [ 15.727240][ C0] lock_acquire.part.0+0xb6/0x240 [ 15.727470][ C0] _raw_spin_lock+0x33/0x40 [ 15.727699][ C0] simple_pin_fs+0x24/0x150 [ 15.727924][ C0] start_creating.part.0+0x52/0x310 [ 15.728152][ C0] debugfs_create_dir+0x6a/0x540 [ 15.728380][ C0] component_debug_init+0x17/0x30 [ 15.728611][ C0] do_one_initcall+0x8f/0x1e0 [ 15.728841][ C0] do_initcalls+0x176/0x280 [ 15.729069][ C0] kernel_init_freeable+0x22d/0x300 [ 15.729298][ C0] kernel_init+0x20/0x200 [ 15.729525][ C0] ret_from_fork+0x240/0x320 [ 15.729756][ C0] ret_from_fork_asm+0x1a/0x30 [ 15.729980][ C0] irq event stamp: 470512 [ 15.730154][ C0] hardirqs last enabled at (470512): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.730601][ C0] hardirqs last disabled at (470511): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 15.731052][ C0] softirqs last enabled at (469910): [] handle_softirqs+0x358/0x620 [ 15.731448][ C0] softirqs last disabled at (469923): [] __irq_exit_rcu+0xfa/0x160 [ 15.731845][ C0] [ 15.731845][ C0] other info that might help us debug this: [ 15.732173][ C0] Possible unsafe locking scenario: [ 15.732173][ C0] [ 15.732504][ C0] CPU0 [ 15.732672][ C0] ---- [ 15.732844][ C0] lock(pin_fs_lock); [ 15.733023][ C0] [ 15.733190][ C0] lock(pin_fs_lock); [ 15.733367][ C0] [ 15.733367][ C0] *** DEADLOCK *** [ 15.733367][ C0] [ 15.733702][ C0] 1 lock held by swapper/0/0: [ 15.733932][ C0] #0: ffffffffa71774c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 15.734339][ C0] [ 15.734339][ C0] stack backtrace: [ 15.734617][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 15.734621][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.734623][ C0] Call Trace: [ 15.734625][ C0] [ 15.734627][ C0] dump_stack_lvl+0x82/0xd0 [ 15.734633][ C0] print_usage_bug.part.0+0x25f/0x360 [ 15.734638][ C0] mark_lock_irq+0x343/0x400 [ 15.734641][ C0] ? is_bpf_text_address+0x67/0x120 [ 15.734647][ C0] ? __lock_release+0x5d/0x170 [ 15.734651][ C0] ? save_trace+0x52/0x170 [ 15.734657][ C0] mark_lock+0x174/0x2f0 [ 15.734660][ C0] mark_usage+0x46/0x150 [ 15.734663][ C0] __lock_acquire+0x20b/0x7e0 [ 15.734666][ C0] ? __lock_acquire+0x44d/0x7e0 [ 15.734670][ C0] lock_acquire.part.0+0xb6/0x240 [ 15.734673][ C0] ? simple_pin_fs+0x24/0x150 [ 15.734677][ C0] ? rcu_is_watching+0x12/0xc0 [ 15.734681][ C0] ? lock_acquire+0x10c/0x170 [ 15.734684][ C0] ? simple_pin_fs+0x24/0x150 [ 15.734689][ C0] _raw_spin_lock+0x33/0x40 [ 15.734692][ C0] ? simple_pin_fs+0x24/0x150 [ 15.734696][ C0] simple_pin_fs+0x24/0x150 [ 15.734700][ C0] debugfs_remove+0x35/0x70 [ 15.734703][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 15.734709][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 15.734712][ C0] ? __sk_destruct+0x383/0x780 [ 15.734718][ C0] ? rcu_do_batch+0x34c/0xf20 [ 15.734721][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 15.734724][ C0] ? irq_exit_rcu+0xe/0x30 [ 15.734727][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.734731][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.734734][ C0] ? pv_native_safe_halt+0xf/0x20 [ 15.734737][ C0] ? default_idle+0x9/0x10 [ 15.734740][ C0] ? default_idle_call+0x6d/0xb0 [ 15.734742][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 15.734746][ C0] ? do_idle+0xf6/0x160 [ 15.734748][ C0] ? cpu_startup_entry+0x54/0x60 [ 15.734750][ C0] ? rest_init+0x14b/0x260 [ 15.734753][ C0] ? start_kernel+0x350/0x410 [ 15.734759][ C0] __put_net+0x19/0x60 [ 15.734763][ C0] __sk_destruct+0x58a/0x780 [ 15.734767][ C0] ? rcu_do_batch+0x34a/0xf20 [ 15.734769][ C0] rcu_do_batch+0x34c/0xf20 [ 15.734773][ C0] ? find_held_lock+0x2b/0x80 [ 15.734777][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 15.734780][ C0] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.734784][ C0] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.734786][ C0] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 15.734791][ C0] rcu_core+0x2bb/0x500 [ 15.734797][ C0] handle_softirqs+0x218/0x620 [ 15.734802][ C0] __irq_exit_rcu+0xfa/0x160 [ 15.734805][ C0] irq_exit_rcu+0xe/0x30 [ 15.734807][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.734811][ C0] [ 15.734812][ C0] [ 15.734814][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.734816][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 15.734820][ C0] Code: 92 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 37 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 [ 15.734823][ C0] RSP: 0018:ffffffffa6e07df8 EFLAGS: 00000242 [ 15.734826][ C0] RAX: 0000000000072ba1 RBX: 1ffffffff4dc0fc3 RCX: ffffffffa61905d9 [ 15.734828][ C0] RDX: 0000000000000000 RSI: ffffffffa6c8f4e4 RDI: ffffffffa6453be0 [ 15.734830][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1005ec66fa [ 15.734831][ C0] R10: ffff88802f6337d3 R11: ffffffffa6e11288 R12: 0000000000000000 [ 15.734833][ C0] R13: ffffffffa6e1f240 R14: dffffc0000000000 R15: 0000000000014770 [ 15.734837][ C0] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 15.734842][ C0] default_idle+0x9/0x10 [ 15.734845][ C0] default_idle_call+0x6d/0xb0 [ 15.734847][ C0] cpuidle_idle_call+0x26f/0x3a0 [ 15.734850][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 15.734854][ C0] ? tsc_verify_tsc_adjust+0x98/0x310 [ 15.734859][ C0] do_idle+0xf6/0x160 [ 15.734863][ C0] cpu_startup_entry+0x54/0x60 [ 15.734866][ C0] rest_init+0x14b/0x260 [ 15.734869][ C0] start_kernel+0x350/0x410 [ 15.734873][ C0] x86_64_start_reservations+0x18/0x30 [ 15.734877][ C0] x86_64_start_kernel+0xf8/0x150 [ 15.734881][ C0] common_startup_64+0x13e/0x148 [ 15.734890][ C0] [ 15.754154][ C0] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 15.754645][ C0] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/0 [ 15.755013][ C0] preempt_count: 101, expected: 0 [ 15.755353][ C0] RCU nest depth: 0, expected: 0 [ 15.755569][ C0] INFO: lockdep is turned off. [ 15.755780][ C0] Preemption disabled at: [ 15.755782][ C0] [] schedule_preempt_disabled+0x22/0x30 [ 15.756515][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 15.756519][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.756521][ C0] Call Trace: [ 15.756522][ C0] [ 15.756524][ C0] dump_stack_lvl+0xb0/0xd0 [ 15.756529][ C0] __might_resched+0x360/0x5a0 [ 15.756536][ C0] down_write+0x72/0x210 [ 15.756540][ C0] ? __pfx_down_write+0x10/0x10 [ 15.756543][ C0] ? simple_recursive_removal+0x33/0x610 [ 15.756546][ C0] ? rcu_is_watching+0x12/0xc0 [ 15.756551][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 15.756556][ C0] simple_recursive_removal+0x6a/0x610 [ 15.756559][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 15.756562][ C0] ? __pfx_remove_one+0x10/0x10 [ 15.756567][ C0] debugfs_remove+0x44/0x70 [ 15.756570][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 15.756576][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 15.756579][ C0] ? __sk_destruct+0x383/0x780 [ 15.756583][ C0] ? rcu_do_batch+0x34c/0xf20 [ 15.756586][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 15.756590][ C0] ? irq_exit_rcu+0xe/0x30 [ 15.756593][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.756598][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.756602][ C0] ? pv_native_safe_halt+0xf/0x20 [ 15.756605][ C0] ? default_idle+0x9/0x10 [ 15.756608][ C0] ? default_idle_call+0x6d/0xb0 [ 15.756611][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 15.756614][ C0] ? do_idle+0xf6/0x160 [ 15.756616][ C0] ? cpu_startup_entry+0x54/0x60 [ 15.756618][ C0] ? rest_init+0x14b/0x260 [ 15.756621][ C0] ? start_kernel+0x350/0x410 [ 15.756628][ C0] __put_net+0x19/0x60 [ 15.756632][ C0] __sk_destruct+0x58a/0x780 [ 15.756636][ C0] ? rcu_do_batch+0x34a/0xf20 [ 15.756638][ C0] rcu_do_batch+0x34c/0xf20 [ 15.756642][ C0] ? find_held_lock+0x2b/0x80 [ 15.756647][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 15.756650][ C0] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.756654][ C0] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.756657][ C0] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 15.756662][ C0] rcu_core+0x2bb/0x500 [ 15.756666][ C0] handle_softirqs+0x218/0x620 [ 15.756672][ C0] __irq_exit_rcu+0xfa/0x160 [ 15.756675][ C0] irq_exit_rcu+0xe/0x30 [ 15.756677][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.756681][ C0] [ 15.756682][ C0] [ 15.756684][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.756686][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 15.756690][ C0] Code: 92 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 37 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 [ 15.756693][ C0] RSP: 0018:ffffffffa6e07df8 EFLAGS: 00000242 [ 15.756695][ C0] RAX: 0000000000072ba1 RBX: 1ffffffff4dc0fc3 RCX: ffffffffa61905d9 [ 15.756697][ C0] RDX: 0000000000000000 RSI: ffffffffa6c8f4e4 RDI: ffffffffa6453be0 [ 15.756699][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1005ec66fa [ 15.756701][ C0] R10: ffff88802f6337d3 R11: ffffffffa6e11288 R12: 0000000000000000 [ 15.756702][ C0] R13: ffffffffa6e1f240 R14: dffffc0000000000 R15: 0000000000014770 [ 15.756706][ C0] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 15.756711][ C0] default_idle+0x9/0x10 [ 15.756714][ C0] default_idle_call+0x6d/0xb0 [ 15.756716][ C0] cpuidle_idle_call+0x26f/0x3a0 [ 15.756720][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 15.756723][ C0] ? tsc_verify_tsc_adjust+0x98/0x310 [ 15.756728][ C0] do_idle+0xf6/0x160 [ 15.756732][ C0] cpu_startup_entry+0x54/0x60 [ 15.756734][ C0] rest_init+0x14b/0x260 [ 15.756738][ C0] start_kernel+0x350/0x410 [ 15.756742][ C0] x86_64_start_reservations+0x18/0x30 [ 15.756746][ C0] x86_64_start_kernel+0xf8/0x150 [ 15.756749][ C0] common_startup_64+0x13e/0x148 [ 15.756757][ C0] [ 17.757585][ C1] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 17.757942][ C1] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 216, name: timeout [ 17.758286][ C1] preempt_count: 101, expected: 0 [ 17.758475][ C1] RCU nest depth: 0, expected: 0 [ 17.758656][ C1] INFO: lockdep is turned off. [ 17.758841][ C1] Preemption disabled at: [ 17.758843][ C1] [<0000000000000000>] 0x0 [ 17.759194][ C1] CPU: 1 UID: 0 PID: 216 Comm: timeout Tainted: G W 6.15.0-virtme #1 PREEMPT(full) [ 17.759200][ C1] Tainted: [W]=WARN [ 17.759202][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 17.759205][ C1] Call Trace: [ 17.759207][ C1] [ 17.759209][ C1] dump_stack_lvl+0xb0/0xd0 [ 17.759219][ C1] __might_resched+0x360/0x5a0 [ 17.759229][ C1] down_write+0x72/0x210 [ 17.759234][ C1] ? __pfx_down_write+0x10/0x10 [ 17.759237][ C1] ? simple_recursive_removal+0x33/0x610 [ 17.759243][ C1] ? rcu_is_watching+0x12/0xc0 [ 17.759249][ C1] ? do_raw_spin_unlock+0x58/0x220 [ 17.759256][ C1] simple_recursive_removal+0x6a/0x610 [ 17.759259][ C1] ? do_raw_spin_unlock+0x58/0x220 [ 17.759263][ C1] ? __pfx_remove_one+0x10/0x10 [ 17.759269][ C1] debugfs_remove+0x44/0x70 [ 17.759272][ C1] ref_tracker_dir_exit+0xcf/0x740 [ 17.759280][ C1] ? __pfx_ref_tracker_free+0x10/0x10 [ 17.759284][ C1] ? __sk_destruct+0x383/0x780 [ 17.759291][ C1] ? rcu_do_batch+0x34c/0xf20 [ 17.759295][ C1] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 17.759299][ C1] ? irq_exit_rcu+0xe/0x30 [ 17.759305][ C1] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 17.759312][ C1] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.759317][ C1] ? _raw_write_unlock_irq+0x2e/0x50 [ 17.759320][ C1] ? exit_notify+0x207/0x700 [ 17.759325][ C1] ? do_exit+0x51b/0xc20 [ 17.759328][ C1] ? do_group_exit+0xb8/0x260 [ 17.759331][ C1] ? __x64_sys_exit_group+0x3e/0x50 [ 17.759335][ C1] ? x64_sys_call+0xf76/0x18a0 [ 17.759342][ C1] ? do_syscall_64+0xc1/0x380 [ 17.759345][ C1] ? entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 17.759347][ C1] ? bpf_sk_storage_free+0x9f/0x1c0 [ 17.759352][ C1] ? rcu_is_watching+0x12/0xc0 [ 17.759356][ C1] __put_net+0x19/0x60 [ 17.759361][ C1] __sk_destruct+0x58a/0x780 [ 17.759365][ C1] ? rcu_do_batch+0x34a/0xf20 [ 17.759368][ C1] rcu_do_batch+0x34c/0xf20 [ 17.759373][ C1] ? __pfx_rcu_do_batch+0x10/0x10 [ 17.759376][ C1] ? rcu_is_watching+0x12/0xc0 [ 17.759380][ C1] ? trace_irq_enable.constprop.0+0xd4/0x130 [ 17.759388][ C1] rcu_core+0x2bb/0x500 [ 17.759393][ C1] handle_softirqs+0x218/0x620 [ 17.759398][ C1] __irq_exit_rcu+0xfa/0x160 [ 17.759402][ C1] irq_exit_rcu+0xe/0x30 [ 17.759405][ C1] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 17.759408][ C1] [ 17.759410][ C1] [ 17.759412][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.759415][ C1] RIP: 0010:_raw_write_unlock_irq+0x2e/0x50 [ 17.759418][ C1] Code: 0f 1f 44 00 00 55 48 8b 74 24 08 48 89 fd 48 83 c7 18 e8 75 16 83 fd 48 89 ef e8 6d 73 83 fd e8 68 21 a9 fd fb bf 01 00 00 00 bd 66 77 fd 65 8b 05 d6 64 97 02 85 c0 74 06 5d e9 7c 2c 00 00 [ 17.759421][ C1] RSP: 0018:ffffc90000a47de8 EFLAGS: 00000246 [ 17.759425][ C1] RAX: 0000000000000001 RBX: ffff8880093a6580 RCX: ffffffffa3c43b9f [ 17.759427][ C1] RDX: 0000000000000000 RSI: ffffffffa6453b60 RDI: 0000000000000001 [ 17.759429][ C1] RBP: ffffffffa6e0c080 R08: 0000000000000000 R09: 0000000000000000 [ 17.759431][ C1] R10: ffffffffa7be68d7 R11: 0000000000000010 R12: ffff8880093a6590 [ 17.759433][ C1] R13: ffff888004d04af0 R14: ffffc90000a47e30 R15: 1ffff92000148fc2 [ 17.759437][ C1] ? trace_irq_enable.constprop.0+0x2f/0x130 [ 17.759443][ C1] ? _raw_write_unlock_irq+0x28/0x50 [ 17.759445][ C1] exit_notify+0x207/0x700 [ 17.759450][ C1] ? __pfx_exit_notify+0x10/0x10 [ 17.759453][ C1] ? trace_irq_enable.constprop.0+0xd4/0x130 [ 17.759457][ C1] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 17.759463][ C1] ? exit_tasks_rcu_start+0x215/0x340 [ 17.759470][ C1] do_exit+0x51b/0xc20 [ 17.759475][ C1] do_group_exit+0xb8/0x260 [ 17.759479][ C1] __x64_sys_exit_group+0x3e/0x50 [ 17.759483][ C1] x64_sys_call+0xf76/0x18a0 [ 17.759486][ C1] do_syscall_64+0xc1/0x380 [ 17.759489][ C1] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 17.759492][ C1] RIP: 0033:0x7f21de50cabd [ 17.759494][ C1] Code: Unable to access opcode bytes at 0x7f21de50ca93. [ 17.759496][ C1] RSP: 002b:00007ffe01427848 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 17.759499][ C1] RAX: ffffffffffffffda RBX: 00007f21de5e99c0 RCX: 00007f21de50cabd [ 17.759501][ C1] RDX: 00000000000000e7 RSI: ffffffffffffff80 RDI: 0000000000000000 [ 17.759503][ C1] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000020 [ 17.759504][ C1] R10: 00007ffe014276f0 R11: 0000000000000246 R12: 00007f21de5e99c0 [ 17.759506][ C1] R13: 00007f21de5eeee0 R14: 0000000000000002 R15: 00007f21de5eeec8 [ 17.759512][ C1]