[ 17.012509][ C0] [ 17.012657][ C0] ================================ [ 17.012946][ C0] WARNING: inconsistent lock state [ 17.013274][ C0] 6.15.0-rc7-virtme #1 Not tainted [ 17.013594][ C0] -------------------------------- [ 17.013913][ C0] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 17.014310][ C0] ksft_runner.sh/257 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 17.014706][ C0] ffffffffb31bff78 (pin_fs_lock){+.?.}-{3:3}, at: simple_pin_fs+0x24/0x150 [ 17.015278][ C0] {SOFTIRQ-ON-W} state was registered at: [ 17.015599][ C0] __lock_acquire+0x3eb/0x9d0 [ 17.015934][ C0] lock_acquire.part.0+0xb6/0x240 [ 17.016257][ C0] _raw_spin_lock+0x33/0x40 [ 17.016580][ C0] simple_pin_fs+0x24/0x150 [ 17.016899][ C0] start_creating.part.0+0x3f/0x2f0 [ 17.017226][ C0] debugfs_create_dir+0x6a/0x540 [ 17.017546][ C0] component_debug_init+0x17/0x30 [ 17.017877][ C0] do_one_initcall+0x8f/0x1e0 [ 17.018205][ C0] do_initcalls+0x176/0x280 [ 17.018531][ C0] kernel_init_freeable+0x22d/0x300 [ 17.018854][ C0] kernel_init+0x20/0x200 [ 17.019175][ C0] ret_from_fork+0x31/0x70 [ 17.019495][ C0] ret_from_fork_asm+0x1a/0x30 [ 17.019818][ C0] irq event stamp: 2090 [ 17.020064][ C0] hardirqs last enabled at (2090): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 17.020717][ C0] hardirqs last disabled at (2089): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 17.021277][ C0] softirqs last enabled at (1166): [] handle_softirqs+0x358/0x620 [ 17.021836][ C0] softirqs last disabled at (1531): [] __irq_exit_rcu+0xfa/0x160 [ 17.022403][ C0] [ 17.022403][ C0] other info that might help us debug this: [ 17.022872][ C0] Possible unsafe locking scenario: [ 17.022872][ C0] [ 17.023350][ C0] CPU0 [ 17.023590][ C0] ---- [ 17.023830][ C0] lock(pin_fs_lock); [ 17.024076][ C0] [ 17.024316][ C0] lock(pin_fs_lock); [ 17.024561][ C0] [ 17.024561][ C0] *** DEADLOCK *** [ 17.024561][ C0] [ 17.025034][ C0] 2 locks held by ksft_runner.sh/257: [ 17.025361][ C0] #0: ffff8880096440c8 (vm_lock){++++}-{0:0}, at: do_user_addr_fault+0x461/0xe00 [ 17.025937][ C0] #1: ffffffffb2f749c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 17.026522][ C0] [ 17.026522][ C0] stack backtrace: [ 17.026920][ C0] CPU: 0 UID: 0 PID: 257 Comm: ksft_runner.sh Not tainted 6.15.0-rc7-virtme #1 PREEMPT(full) [ 17.026927][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 17.026930][ C0] Call Trace: [ 17.026933][ C0] [ 17.026936][ C0] dump_stack_lvl+0x82/0xd0 [ 17.026945][ C0] print_usage_bug.part.0+0x25f/0x360 [ 17.026954][ C0] mark_lock_irq+0x343/0x400 [ 17.026963][ C0] ? __pfx_unwind_next_frame+0x10/0x10 [ 17.026971][ C0] ? save_trace+0x52/0x170 [ 17.026979][ C0] mark_lock+0x174/0x2f0 [ 17.026986][ C0] mark_usage+0x46/0x150 [ 17.026992][ C0] __lock_acquire+0x3eb/0x9d0 [ 17.027002][ C0] lock_acquire.part.0+0xb6/0x240 [ 17.027007][ C0] ? simple_pin_fs+0x24/0x150 [ 17.027013][ C0] ? rcu_is_watching+0x12/0xc0 [ 17.027021][ C0] ? lock_acquire+0x10c/0x170 [ 17.027025][ C0] ? simple_pin_fs+0x24/0x150 [ 17.027032][ C0] _raw_spin_lock+0x33/0x40 [ 17.027037][ C0] ? simple_pin_fs+0x24/0x150 [ 17.027041][ C0] simple_pin_fs+0x24/0x150 [ 17.027047][ C0] debugfs_remove+0x35/0x70 [ 17.027053][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 17.027060][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 17.027065][ C0] ? __sk_destruct+0x383/0x780 [ 17.027072][ C0] ? rcu_do_batch+0x34f/0xf20 [ 17.027077][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 17.027080][ C0] ? irq_exit_rcu+0xe/0x30 [ 17.027082][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 17.027087][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.027091][ C0] ? copy_mc_enhanced_fast_string+0x6/0xf [ 17.027094][ C0] ? __wp_page_copy_user+0xf1/0x480 [ 17.027100][ C0] ? wp_page_copy+0x215/0x11e0 [ 17.027103][ C0] ? handle_pte_fault+0x3ff/0x690 [ 17.027106][ C0] ? __handle_mm_fault+0x3fc/0x5e0 [ 17.027109][ C0] ? handle_mm_fault+0x200/0x420 [ 17.027111][ C0] ? do_user_addr_fault+0x576/0xe00 [ 17.027114][ C0] ? exc_page_fault+0x5e/0xd0 [ 17.027119][ C0] __put_net+0x19/0x60 [ 17.027123][ C0] __sk_destruct+0x58a/0x780 [ 17.027127][ C0] ? rcu_do_batch+0x34a/0xf20 [ 17.027130][ C0] rcu_do_batch+0x34f/0xf20 [ 17.027134][ C0] ? find_held_lock+0x2b/0x80 [ 17.027138][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 17.027141][ C0] ? mark_held_locks+0x49/0x80 [ 17.027145][ C0] ? note_gp_changes+0x182/0x1e0 [ 17.027148][ C0] ? lockdep_hardirqs_on+0x7c/0x110 [ 17.027153][ C0] rcu_core+0x2bb/0x500 [ 17.027156][ C0] handle_softirqs+0x218/0x620 [ 17.027161][ C0] __irq_exit_rcu+0xfa/0x160 [ 17.027163][ C0] irq_exit_rcu+0xe/0x30 [ 17.027166][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 17.027169][ C0] [ 17.027170][ C0] [ 17.027172][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.027175][ C0] RIP: 0010:copy_mc_enhanced_fast_string+0x6/0xf [ 17.027178][ C0] Code: 89 ca e9 7d fe ff ff 66 66 2e 0f 1f 84 00 00 00 00 00 66 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 48 89 f8 48 89 d1 a4 31 c0 c3 cc cc cc cc 48 89 c8 c3 cc cc cc cc 66 0f 1f 84 00 [ 17.027181][ C0] RSP: 0000:ffffc90000a27ad8 EFLAGS: 00010246 [ 17.027184][ C0] RAX: ffff8880146a2000 RBX: ffffc90000a27d30 RCX: 0000000000000d00 [ 17.027186][ C0] RDX: 0000000000001000 RSI: ffff88800c716300 RDI: ffff8880146a2300 [ 17.027188][ C0] RBP: ffff8880146a2000 R08: 0000000000000000 R09: ffffed10018e2dff [ 17.027190][ C0] R10: ffff88800c716fff R11: 0000000000000000 R12: ffff888009794640 [ 17.027192][ C0] R13: 00007f0e90040000 R14: ffffea0000000000 R15: ffff888009794640 [ 17.027198][ C0] __wp_page_copy_user+0xf1/0x480 [ 17.027202][ C0] wp_page_copy+0x215/0x11e0 [ 17.027207][ C0] ? __pfx_wp_page_copy+0x10/0x10 [ 17.027211][ C0] ? __lock_release+0x5d/0x170 [ 17.027214][ C0] ? rcu_read_unlock+0x18/0x70 [ 17.027218][ C0] ? do_wp_page+0x876/0x1170 [ 17.027222][ C0] handle_pte_fault+0x3ff/0x690 [ 17.027227][ C0] ? __pfx_handle_pte_fault+0x10/0x10 [ 17.027231][ C0] ? reacquire_held_locks+0xd1/0x200 [ 17.027234][ C0] ? do_user_addr_fault+0x461/0xe00 [ 17.027239][ C0] __handle_mm_fault+0x3fc/0x5e0 [ 17.027242][ C0] ? __pfx___handle_mm_fault+0x10/0x10 [ 17.027244][ C0] ? __lock_release+0xa8/0x170 [ 17.027250][ C0] ? __pfx_lock_vma_under_rcu+0x10/0x10 [ 17.027255][ C0] handle_mm_fault+0x200/0x420 [ 17.027258][ C0] ? __pfx_handle_mm_fault+0x10/0x10 [ 17.027261][ C0] ? exc_page_fault+0x5e/0xd0 [ 17.027264][ C0] ? __lock_release+0x5d/0x170 [ 17.027268][ C0] do_user_addr_fault+0x576/0xe00 [ 17.027272][ C0] ? rcu_is_watching+0x12/0xc0 [ 17.027276][ C0] exc_page_fault+0x5e/0xd0 [ 17.027280][ C0] asm_exc_page_fault+0x26/0x30 [ 17.027283][ C0] RIP: 0033:0x7f0e8fed0c68 [ 17.027287][ C0] Code: 54 55 53 8b 07 48 89 fb 25 00 80 00 00 75 34 64 48 8b 2c 25 10 00 00 00 48 8b bf 88 00 00 00 48 39 6f 08 74 1a ba 01 00 00 00 0f b1 17 0f 85 8e 00 00 00 48 8b bb 88 00 00 00 48 89 6f 08 83 [ 17.027290][ C0] RSP: 002b:00007ffd4537ab50 EFLAGS: 00010287 [ 17.027292][ C0] RAX: 0000000000000000 RBX: 00007f0e9003f760 RCX: 00007f0e8ff8382b [ 17.027293][ C0] RDX: 0000000000000001 RSI: 00005655216684d0 RDI: 00007f0e90040a50 [ 17.027295][ C0] RBP: 00007f0e8fe42740 R08: 0000000000000006 R09: 0000000000000020 [ 17.027297][ C0] R10: 00000000000001b6 R11: 0000000000000246 R12: 0000000000000000 [ 17.027298][ C0] R13: 0000000000000001 R14: 00005655216684d0 R15: 0000000000000001 [ 17.027304][ C0] [ 17.059932][ C0] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 17.060259][ C0] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 257, name: ksft_runner.sh [ 17.060583][ C0] preempt_count: 100, expected: 0 [ 17.060765][ C0] RCU nest depth: 0, expected: 0 [ 17.060958][ C0] INFO: lockdep is turned off. [ 17.061140][ C0] Preemption disabled at: [ 17.061141][ C0] [] handle_softirqs+0xe5/0x620 [ 17.061520][ C0] CPU: 0 UID: 0 PID: 257 Comm: ksft_runner.sh Not tainted 6.15.0-rc7-virtme #1 PREEMPT(full) [ 17.061527][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 17.061530][ C0] Call Trace: [ 17.061533][ C0] [ 17.061536][ C0] dump_stack_lvl+0xb0/0xd0 [ 17.061543][ C0] __might_resched+0x360/0x5a0 [ 17.061549][ C0] down_write+0x72/0x210 [ 17.061553][ C0] ? __pfx_down_write+0x10/0x10 [ 17.061556][ C0] ? simple_recursive_removal+0x3a/0x860 [ 17.061561][ C0] ? rcu_is_watching+0x12/0xc0 [ 17.061567][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 17.061572][ C0] simple_recursive_removal+0x166/0x860 [ 17.061575][ C0] ? __pfx_remove_one+0x10/0x10 [ 17.061579][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 17.061584][ C0] debugfs_remove+0x44/0x70 [ 17.061587][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 17.061592][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 17.061595][ C0] ? __sk_destruct+0x383/0x780 [ 17.061600][ C0] ? rcu_do_batch+0x34f/0xf20 [ 17.061605][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 17.061608][ C0] ? irq_exit_rcu+0xe/0x30 [ 17.061610][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 17.061615][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.061619][ C0] ? copy_mc_enhanced_fast_string+0x6/0xf [ 17.061623][ C0] ? __wp_page_copy_user+0xf1/0x480 [ 17.061628][ C0] ? wp_page_copy+0x215/0x11e0 [ 17.061632][ C0] ? handle_pte_fault+0x3ff/0x690 [ 17.061635][ C0] ? __handle_mm_fault+0x3fc/0x5e0 [ 17.061638][ C0] ? handle_mm_fault+0x200/0x420 [ 17.061640][ C0] ? do_user_addr_fault+0x576/0xe00 [ 17.061645][ C0] ? exc_page_fault+0x5e/0xd0 [ 17.061650][ C0] __put_net+0x19/0x60 [ 17.061654][ C0] __sk_destruct+0x58a/0x780 [ 17.061658][ C0] ? rcu_do_batch+0x34a/0xf20 [ 17.061661][ C0] rcu_do_batch+0x34f/0xf20 [ 17.061665][ C0] ? find_held_lock+0x2b/0x80 [ 17.061669][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 17.061673][ C0] ? mark_held_locks+0x49/0x80 [ 17.061677][ C0] ? note_gp_changes+0x182/0x1e0 [ 17.061680][ C0] ? lockdep_hardirqs_on+0x7c/0x110 [ 17.061685][ C0] rcu_core+0x2bb/0x500 [ 17.061689][ C0] handle_softirqs+0x218/0x620 [ 17.061693][ C0] __irq_exit_rcu+0xfa/0x160 [ 17.061696][ C0] irq_exit_rcu+0xe/0x30 [ 17.061698][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 17.061702][ C0] [ 17.061703][ C0] [ 17.061705][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.061707][ C0] RIP: 0010:copy_mc_enhanced_fast_string+0x6/0xf [ 17.061712][ C0] Code: 89 ca e9 7d fe ff ff 66 66 2e 0f 1f 84 00 00 00 00 00 66 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 48 89 f8 48 89 d1 a4 31 c0 c3 cc cc cc cc 48 89 c8 c3 cc cc cc cc 66 0f 1f 84 00 [ 17.061714][ C0] RSP: 0000:ffffc90000a27ad8 EFLAGS: 00010246 [ 17.061718][ C0] RAX: ffff8880146a2000 RBX: ffffc90000a27d30 RCX: 0000000000000d00 [ 17.061720][ C0] RDX: 0000000000001000 RSI: ffff88800c716300 RDI: ffff8880146a2300 [ 17.061722][ C0] RBP: ffff8880146a2000 R08: 0000000000000000 R09: ffffed10018e2dff [ 17.061724][ C0] R10: ffff88800c716fff R11: 0000000000000000 R12: ffff888009794640 [ 17.061726][ C0] R13: 00007f0e90040000 R14: ffffea0000000000 R15: ffff888009794640 [ 17.061732][ C0] __wp_page_copy_user+0xf1/0x480 [ 17.061736][ C0] wp_page_copy+0x215/0x11e0 [ 17.061741][ C0] ? __pfx_wp_page_copy+0x10/0x10 [ 17.061745][ C0] ? __lock_release+0x5d/0x170 [ 17.061748][ C0] ? rcu_read_unlock+0x18/0x70 [ 17.061752][ C0] ? do_wp_page+0x876/0x1170 [ 17.061757][ C0] handle_pte_fault+0x3ff/0x690 [ 17.061761][ C0] ? __pfx_handle_pte_fault+0x10/0x10 [ 17.061765][ C0] ? reacquire_held_locks+0xd1/0x200 [ 17.061769][ C0] ? do_user_addr_fault+0x461/0xe00 [ 17.061774][ C0] __handle_mm_fault+0x3fc/0x5e0 [ 17.061777][ C0] ? __pfx___handle_mm_fault+0x10/0x10 [ 17.061779][ C0] ? __lock_release+0xa8/0x170 [ 17.061785][ C0] ? __pfx_lock_vma_under_rcu+0x10/0x10 [ 17.061790][ C0] handle_mm_fault+0x200/0x420 [ 17.061793][ C0] ? __pfx_handle_mm_fault+0x10/0x10 [ 17.061795][ C0] ? exc_page_fault+0x5e/0xd0 [ 17.061798][ C0] ? __lock_release+0x5d/0x170 [ 17.061802][ C0] do_user_addr_fault+0x576/0xe00 [ 17.061806][ C0] ? rcu_is_watching+0x12/0xc0 [ 17.061811][ C0] exc_page_fault+0x5e/0xd0 [ 17.061815][ C0] asm_exc_page_fault+0x26/0x30 [ 17.061818][ C0] RIP: 0033:0x7f0e8fed0c68 [ 17.061822][ C0] Code: 54 55 53 8b 07 48 89 fb 25 00 80 00 00 75 34 64 48 8b 2c 25 10 00 00 00 48 8b bf 88 00 00 00 48 39 6f 08 74 1a ba 01 00 00 00 0f b1 17 0f 85 8e 00 00 00 48 8b bb 88 00 00 00 48 89 6f 08 83 [ 17.061825][ C0] RSP: 002b:00007ffd4537ab50 EFLAGS: 00010287 [ 17.061827][ C0] RAX: 0000000000000000 RBX: 00007f0e9003f760 RCX: 00007f0e8ff8382b [ 17.061829][ C0] RDX: 0000000000000001 RSI: 00005655216684d0 RDI: 00007f0e90040a50 [ 17.061830][ C0] RBP: 00007f0e8fe42740 R08: 0000000000000006 R09: 0000000000000020 [ 17.061832][ C0] R10: 00000000000001b6 R11: 0000000000000246 R12: 0000000000000000 [ 17.061834][ C0] R13: 0000000000000001 R14: 00005655216684d0 R15: 0000000000000001 [ 17.061839][ C0] [ 19.521649][ C1] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 19.522026][ C1] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 22, name: ksoftirqd/1 [ 19.522350][ C1] preempt_count: 100, expected: 0 [ 19.522537][ C1] RCU nest depth: 0, expected: 0 [ 19.522713][ C1] INFO: lockdep is turned off. [ 19.522945][ C1] Preemption disabled at: [ 19.522947][ C1] [] handle_softirqs+0xe5/0x620 [ 19.523315][ C1] CPU: 1 UID: 0 PID: 22 Comm: ksoftirqd/1 Tainted: G W 6.15.0-rc7-virtme #1 PREEMPT(full) [ 19.523321][ C1] Tainted: [W]=WARN [ 19.523322][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 19.523324][ C1] Call Trace: [ 19.523326][ C1] [ 19.523328][ C1] dump_stack_lvl+0xb0/0xd0 [ 19.523336][ C1] __might_resched+0x360/0x5a0 [ 19.523343][ C1] down_write+0x72/0x210 [ 19.523347][ C1] ? __pfx_down_write+0x10/0x10 [ 19.523350][ C1] ? simple_recursive_removal+0x3a/0x860 [ 19.523355][ C1] ? rcu_is_watching+0x12/0xc0 [ 19.523362][ C1] ? do_raw_spin_unlock+0x58/0x220 [ 19.523366][ C1] simple_recursive_removal+0x166/0x860 [ 19.523369][ C1] ? __pfx_remove_one+0x10/0x10 [ 19.523374][ C1] ? do_raw_spin_unlock+0x58/0x220 [ 19.523378][ C1] debugfs_remove+0x44/0x70 [ 19.523381][ C1] ref_tracker_dir_exit+0xcf/0x740 [ 19.523386][ C1] ? __pfx_ref_tracker_free+0x10/0x10 [ 19.523389][ C1] ? __sk_destruct+0x383/0x780 [ 19.523395][ C1] ? rcu_do_batch+0x34f/0xf20 [ 19.523399][ C1] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 19.523402][ C1] ? smpboot_thread_fn+0x307/0x960 [ 19.523405][ C1] ? kthread+0x37b/0x600 [ 19.523409][ C1] ? ret_from_fork+0x31/0x70 [ 19.523412][ C1] ? ret_from_fork_asm+0x1a/0x30 [ 19.523417][ C1] ? migrate_enable+0x1f2/0x270 [ 19.523422][ C1] ? __pfx_migrate_enable+0x10/0x10 [ 19.523426][ C1] ? bpf_sk_storage_free+0x9f/0x1c0 [ 19.523430][ C1] ? rcu_is_watching+0x12/0xc0 [ 19.523435][ C1] __put_net+0x19/0x60 [ 19.523439][ C1] __sk_destruct+0x58a/0x780 [ 19.523442][ C1] ? rcu_do_batch+0x34a/0xf20 [ 19.523445][ C1] rcu_do_batch+0x34f/0xf20 [ 19.523451][ C1] ? __pfx_rcu_do_batch+0x10/0x10 [ 19.523455][ C1] ? rcu_is_watching+0x12/0xc0 [ 19.523459][ C1] ? trace_irq_enable.constprop.0+0xd4/0x130 [ 19.523465][ C1] rcu_core+0x2bb/0x500 [ 19.523468][ C1] handle_softirqs+0x218/0x620 [ 19.523472][ C1] ? __pfx_run_ksoftirqd+0x10/0x10 [ 19.523475][ C1] run_ksoftirqd+0x3f/0x70 [ 19.523477][ C1] smpboot_thread_fn+0x307/0x960 [ 19.523481][ C1] ? __pfx_smpboot_thread_fn+0x10/0x10 [ 19.523484][ C1] kthread+0x37b/0x600 [ 19.523488][ C1] ? __pfx_kthread+0x10/0x10 [ 19.523490][ C1] ? ret_from_fork+0x1b/0x70 [ 19.523492][ C1] ? __lock_release+0x5d/0x170 [ 19.523496][ C1] ? rcu_is_watching+0x12/0xc0 [ 19.523499][ C1] ? __pfx_kthread+0x10/0x10 [ 19.523503][ C1] ret_from_fork+0x31/0x70 [ 19.523505][ C1] ? __pfx_kthread+0x10/0x10 [ 19.523508][ C1] ret_from_fork_asm+0x1a/0x30 [ 19.523515][ C1]