[ 15.192384][ C2] [ 15.192579][ C2] ================================ [ 15.192768][ C2] WARNING: inconsistent lock state [ 15.192942][ C2] 6.15.0-rc7-virtme #1 Not tainted [ 15.193113][ C2] -------------------------------- [ 15.193281][ C2] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 15.193492][ C2] ksoftirqd/2/27 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 15.193718][ C2] ffffffffa93bff78 (pin_fs_lock){+.?.}-{3:3}, at: simple_pin_fs+0x24/0x150 [ 15.194027][ C2] {SOFTIRQ-ON-W} state was registered at: [ 15.194195][ C2] __lock_acquire+0x3eb/0x9d0 [ 15.194384][ C2] lock_acquire.part.0+0xb6/0x240 [ 15.194554][ C2] _raw_spin_lock+0x33/0x40 [ 15.194729][ C2] simple_pin_fs+0x24/0x150 [ 15.194898][ C2] start_creating.part.0+0x3f/0x2f0 [ 15.195069][ C2] debugfs_create_dir+0x6a/0x540 [ 15.195242][ C2] component_debug_init+0x17/0x30 [ 15.195416][ C2] do_one_initcall+0x8f/0x1e0 [ 15.195590][ C2] do_initcalls+0x176/0x280 [ 15.195765][ C2] kernel_init_freeable+0x22d/0x300 [ 15.195939][ C2] kernel_init+0x20/0x200 [ 15.196111][ C2] ret_from_fork+0x31/0x70 [ 15.196281][ C2] ret_from_fork_asm+0x1a/0x30 [ 15.196450][ C2] irq event stamp: 224884 [ 15.196579][ C2] hardirqs last enabled at (224884): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.196923][ C2] hardirqs last disabled at (224883): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 15.197262][ C2] softirqs last enabled at (223816): [] handle_softirqs+0x358/0x620 [ 15.197561][ C2] softirqs last disabled at (223819): [] run_ksoftirqd+0x3f/0x70 [ 15.197856][ C2] [ 15.197856][ C2] other info that might help us debug this: [ 15.198109][ C2] Possible unsafe locking scenario: [ 15.198109][ C2] [ 15.198359][ C2] CPU0 [ 15.198484][ C2] ---- [ 15.198612][ C2] lock(pin_fs_lock); [ 15.198743][ C2] [ 15.198870][ C2] lock(pin_fs_lock); [ 15.198998][ C2] [ 15.198998][ C2] *** DEADLOCK *** [ 15.198998][ C2] [ 15.199248][ C2] 1 lock held by ksoftirqd/2/27: [ 15.199422][ C2] #0: ffffffffa91749c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 15.199736][ C2] [ 15.199736][ C2] stack backtrace: [ 15.199948][ C2] CPU: 2 UID: 0 PID: 27 Comm: ksoftirqd/2 Not tainted 6.15.0-rc7-virtme #1 PREEMPT(full) [ 15.199953][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.199955][ C2] Call Trace: [ 15.199957][ C2] [ 15.199959][ C2] dump_stack_lvl+0x82/0xd0 [ 15.199966][ C2] print_usage_bug.part.0+0x25f/0x360 [ 15.199971][ C2] mark_lock_irq+0x343/0x400 [ 15.199976][ C2] ? __pfx_unwind_next_frame+0x10/0x10 [ 15.199983][ C2] ? save_trace+0x52/0x170 [ 15.199988][ C2] mark_lock+0x174/0x2f0 [ 15.199992][ C2] mark_usage+0x46/0x150 [ 15.199996][ C2] __lock_acquire+0x3eb/0x9d0 [ 15.200002][ C2] lock_acquire.part.0+0xb6/0x240 [ 15.200004][ C2] ? simple_pin_fs+0x24/0x150 [ 15.200007][ C2] ? rcu_is_watching+0x12/0xc0 [ 15.200015][ C2] ? lock_acquire+0x10c/0x170 [ 15.200017][ C2] ? simple_pin_fs+0x24/0x150 [ 15.200021][ C2] _raw_spin_lock+0x33/0x40 [ 15.200024][ C2] ? simple_pin_fs+0x24/0x150 [ 15.200026][ C2] simple_pin_fs+0x24/0x150 [ 15.200029][ C2] debugfs_remove+0x35/0x70 [ 15.200032][ C2] ref_tracker_dir_exit+0xcf/0x740 [ 15.200039][ C2] ? __pfx_ref_tracker_free+0x10/0x10 [ 15.200042][ C2] ? __sk_destruct+0x383/0x780 [ 15.200049][ C2] ? rcu_do_batch+0x34f/0xf20 [ 15.200053][ C2] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 15.200055][ C2] ? smpboot_thread_fn+0x307/0x960 [ 15.200061][ C2] ? kthread+0x37b/0x600 [ 15.200067][ C2] ? ret_from_fork+0x31/0x70 [ 15.200069][ C2] ? ret_from_fork_asm+0x1a/0x30 [ 15.200072][ C2] ? migrate_enable+0x1f2/0x270 [ 15.200076][ C2] ? __pfx_migrate_enable+0x10/0x10 [ 15.200082][ C2] __put_net+0x19/0x60 [ 15.200086][ C2] __sk_destruct+0x58a/0x780 [ 15.200091][ C2] ? rcu_do_batch+0x34a/0xf20 [ 15.200094][ C2] rcu_do_batch+0x34f/0xf20 [ 15.200099][ C2] ? __pfx_rcu_do_batch+0x10/0x10 [ 15.200103][ C2] ? rcu_is_watching+0x12/0xc0 [ 15.200106][ C2] ? note_gp_changes+0x182/0x1e0 [ 15.200110][ C2] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.200116][ C2] rcu_core+0x2bb/0x500 [ 15.200119][ C2] handle_softirqs+0x218/0x620 [ 15.200123][ C2] ? __pfx_run_ksoftirqd+0x10/0x10 [ 15.200126][ C2] run_ksoftirqd+0x3f/0x70 [ 15.200128][ C2] smpboot_thread_fn+0x307/0x960 [ 15.200132][ C2] ? __pfx_smpboot_thread_fn+0x10/0x10 [ 15.200135][ C2] kthread+0x37b/0x600 [ 15.200139][ C2] ? __pfx_kthread+0x10/0x10 [ 15.200142][ C2] ? ret_from_fork+0x1b/0x70 [ 15.200144][ C2] ? __lock_release+0x5d/0x170 [ 15.200146][ C2] ? rcu_is_watching+0x12/0xc0 [ 15.200150][ C2] ? __pfx_kthread+0x10/0x10 [ 15.200154][ C2] ret_from_fork+0x31/0x70 [ 15.200156][ C2] ? __pfx_kthread+0x10/0x10 [ 15.200159][ C2] ret_from_fork_asm+0x1a/0x30 [ 15.200166][ C2] [ 15.209748][ C2] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 15.210044][ C2] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 27, name: ksoftirqd/2 [ 15.210333][ C2] preempt_count: 100, expected: 0 [ 15.210506][ C2] RCU nest depth: 0, expected: 0 [ 15.210680][ C2] INFO: lockdep is turned off. [ 15.210864][ C2] Preemption disabled at: [ 15.210866][ C2] [] handle_softirqs+0xe5/0x620 [ 15.211213][ C2] CPU: 2 UID: 0 PID: 27 Comm: ksoftirqd/2 Not tainted 6.15.0-rc7-virtme #1 PREEMPT(full) [ 15.211218][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.211219][ C2] Call Trace: [ 15.211221][ C2] [ 15.211223][ C2] dump_stack_lvl+0xb0/0xd0 [ 15.211228][ C2] __might_resched+0x360/0x5a0 [ 15.211235][ C2] down_write+0x72/0x210 [ 15.211239][ C2] ? __pfx_down_write+0x10/0x10 [ 15.211242][ C2] ? simple_recursive_removal+0x3a/0x860 [ 15.211246][ C2] ? rcu_is_watching+0x12/0xc0 [ 15.211252][ C2] ? do_raw_spin_unlock+0x58/0x220 [ 15.211257][ C2] simple_recursive_removal+0x166/0x860 [ 15.211260][ C2] ? __pfx_remove_one+0x10/0x10 [ 15.211263][ C2] ? do_raw_spin_unlock+0x58/0x220 [ 15.211268][ C2] debugfs_remove+0x44/0x70 [ 15.211271][ C2] ref_tracker_dir_exit+0xcf/0x740 [ 15.211275][ C2] ? __pfx_ref_tracker_free+0x10/0x10 [ 15.211278][ C2] ? __sk_destruct+0x383/0x780 [ 15.211283][ C2] ? rcu_do_batch+0x34f/0xf20 [ 15.211286][ C2] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 15.211289][ C2] ? smpboot_thread_fn+0x307/0x960 [ 15.211292][ C2] ? kthread+0x37b/0x600 [ 15.211296][ C2] ? ret_from_fork+0x31/0x70 [ 15.211299][ C2] ? ret_from_fork_asm+0x1a/0x30 [ 15.211302][ C2] ? migrate_enable+0x1f2/0x270 [ 15.211307][ C2] ? __pfx_migrate_enable+0x10/0x10 [ 15.211312][ C2] __put_net+0x19/0x60 [ 15.211316][ C2] __sk_destruct+0x58a/0x780 [ 15.211319][ C2] ? rcu_do_batch+0x34a/0xf20 [ 15.211323][ C2] rcu_do_batch+0x34f/0xf20 [ 15.211328][ C2] ? __pfx_rcu_do_batch+0x10/0x10 [ 15.211332][ C2] ? rcu_is_watching+0x12/0xc0 [ 15.211335][ C2] ? note_gp_changes+0x182/0x1e0 [ 15.211339][ C2] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.211345][ C2] rcu_core+0x2bb/0x500 [ 15.211348][ C2] handle_softirqs+0x218/0x620 [ 15.211351][ C2] ? __pfx_run_ksoftirqd+0x10/0x10 [ 15.211355][ C2] run_ksoftirqd+0x3f/0x70 [ 15.211357][ C2] smpboot_thread_fn+0x307/0x960 [ 15.211360][ C2] ? __pfx_smpboot_thread_fn+0x10/0x10 [ 15.211364][ C2] kthread+0x37b/0x600 [ 15.211367][ C2] ? __pfx_kthread+0x10/0x10 [ 15.211370][ C2] ? ret_from_fork+0x1b/0x70 [ 15.211372][ C2] ? __lock_release+0x5d/0x170 [ 15.211375][ C2] ? rcu_is_watching+0x12/0xc0 [ 15.211379][ C2] ? __pfx_kthread+0x10/0x10 [ 15.211382][ C2] ret_from_fork+0x31/0x70 [ 15.211384][ C2] ? __pfx_kthread+0x10/0x10 [ 15.211387][ C2] ret_from_fork_asm+0x1a/0x30 [ 15.211394][ C2] [ 16.877458][ C3] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 16.877830][ C3] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 218, name: timeout [ 16.878139][ C3] preempt_count: 101, expected: 0 [ 16.878314][ C3] RCU nest depth: 0, expected: 0 [ 16.878489][ C3] INFO: lockdep is turned off. [ 16.878662][ C3] Preemption disabled at: [ 16.878664][ C3] [] copy_fpstate_to_sigframe+0x257/0x540 [ 16.879077][ C3] CPU: 3 UID: 0 PID: 218 Comm: timeout Tainted: G W 6.15.0-rc7-virtme #1 PREEMPT(full) [ 16.879083][ C3] Tainted: [W]=WARN [ 16.879084][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 16.879086][ C3] Call Trace: [ 16.879088][ C3] [ 16.879090][ C3] dump_stack_lvl+0xb0/0xd0 [ 16.879097][ C3] __might_resched+0x360/0x5a0 [ 16.879103][ C3] down_write+0x72/0x210 [ 16.879107][ C3] ? __pfx_down_write+0x10/0x10 [ 16.879111][ C3] ? simple_recursive_removal+0x3a/0x860 [ 16.879115][ C3] ? rcu_is_watching+0x12/0xc0 [ 16.879121][ C3] ? do_raw_spin_unlock+0x58/0x220 [ 16.879127][ C3] simple_recursive_removal+0x166/0x860 [ 16.879130][ C3] ? __pfx_remove_one+0x10/0x10 [ 16.879135][ C3] ? do_raw_spin_unlock+0x58/0x220 [ 16.879139][ C3] debugfs_remove+0x44/0x70 [ 16.879143][ C3] ref_tracker_dir_exit+0xcf/0x740 [ 16.879147][ C3] ? __pfx_ref_tracker_free+0x10/0x10 [ 16.879150][ C3] ? __sk_destruct+0x383/0x780 [ 16.879155][ C3] ? rcu_do_batch+0x34f/0xf20 [ 16.879160][ C3] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 16.879163][ C3] ? __local_bh_enable_ip+0x105/0x130 [ 16.879166][ C3] ? copy_fpstate_to_sigframe+0x1e1/0x540 [ 16.879170][ C3] ? get_sigframe+0x283/0xa60 [ 16.879176][ C3] ? x64_setup_rt_frame+0xfa/0x1110 [ 16.879179][ C3] ? handle_signal+0x291/0x370 [ 16.879182][ C3] ? arch_do_signal_or_restart+0x299/0x2f0 [ 16.879185][ C3] ? syscall_exit_to_user_mode+0x136/0x1f0 [ 16.879190][ C3] ? do_syscall_64+0xce/0x1d0 [ 16.879193][ C3] ? entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 16.879198][ C3] ? bpf_sk_storage_free+0x9f/0x1c0 [ 16.879203][ C3] ? rcu_is_watching+0x12/0xc0 [ 16.879208][ C3] __put_net+0x19/0x60 [ 16.879212][ C3] __sk_destruct+0x58a/0x780 [ 16.879216][ C3] ? rcu_do_batch+0x34a/0xf20 [ 16.879219][ C3] rcu_do_batch+0x34f/0xf20 [ 16.879224][ C3] ? __pfx_rcu_do_batch+0x10/0x10 [ 16.879228][ C3] ? rcu_is_watching+0x12/0xc0 [ 16.879231][ C3] ? trace_irq_enable.constprop.0+0xd4/0x130 [ 16.879237][ C3] rcu_core+0x2bb/0x500 [ 16.879241][ C3] handle_softirqs+0x218/0x620 [ 16.879245][ C3] ? copy_fpstate_to_sigframe+0x1dc/0x540 [ 16.879249][ C3] do_softirq+0xb1/0xe0 [ 16.879251][ C3] [ 16.879253][ C3] [ 16.879254][ C3] __local_bh_enable_ip+0x105/0x130 [ 16.879257][ C3] copy_fpstate_to_sigframe+0x1e1/0x540 [ 16.879263][ C3] get_sigframe+0x283/0xa60 [ 16.879265][ C3] ? trace_irq_enable.constprop.0+0xd4/0x130 [ 16.879269][ C3] ? __pfx_get_sigframe+0x10/0x10 [ 16.879273][ C3] ? rcu_is_watching+0x12/0xc0 [ 16.879277][ C3] ? trace_rseq_update+0xd2/0x130 [ 16.879286][ C3] x64_setup_rt_frame+0xfa/0x1110 [ 16.879290][ C3] ? __pfx___rseq_handle_notify_resume+0x10/0x10 [ 16.879294][ C3] ? __pfx_x64_setup_rt_frame+0x10/0x10 [ 16.879298][ C3] ? __pfx___schedule+0x10/0x10 [ 16.879304][ C3] handle_signal+0x291/0x370 [ 16.879308][ C3] arch_do_signal_or_restart+0x299/0x2f0 [ 16.879311][ C3] ? __pfx_arch_do_signal_or_restart+0x10/0x10 [ 16.879317][ C3] ? __x64_sys_rt_sigsuspend+0xbd/0x120 [ 16.879323][ C3] ? rcu_is_watching+0x12/0xc0 [ 16.879328][ C3] syscall_exit_to_user_mode+0x136/0x1f0 [ 16.879332][ C3] do_syscall_64+0xce/0x1d0 [ 16.879336][ C3] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 16.879338][ C3] RIP: 0033:0x7f26d9c3106c [ 16.879345][ C3] Code: Unable to access opcode bytes at 0x7f26d9c31042. [ 16.879347][ C3] RSP: 002b:00007ffccd571288 EFLAGS: 00000246 ORIG_RAX: 0000000000000082 [ 16.879350][ C3] RAX: fffffffffffffffc RBX: 00007ffccd5712c8 RCX: 00007f26d9c3106c [ 16.879353][ C3] RDX: 0000000000000001 RSI: 0000000000000008 RDI: 00007ffccd5712f0 [ 16.879354][ C3] RBP: 00007ffccd571370 R08: 00007ffccd571370 R09: 0000000000000000 [ 16.879356][ C3] R10: 0000000000000000 R11: 0000000000000246 R12: 00007ffccd5712f0 [ 16.879358][ C3] R13: 4056800000000000 R14: 000000000000000f R15: 00007f26d9e24000 [ 16.879364][ C3]