[ 17.478839][ C3] [ 17.478982][ C3] ================================ [ 17.479178][ C3] WARNING: inconsistent lock state [ 17.479365][ C3] 6.15.0-virtme #1 Not tainted [ 17.479551][ C3] -------------------------------- [ 17.479752][ C3] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 17.480030][ C3] swapper/3/0 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 17.480265][ C3] ffffffff8b7c5af8 (pin_fs_lock){+.?.}-{3:3}, at: simple_pin_fs+0x24/0x150 [ 17.480651][ C3] {SOFTIRQ-ON-W} state was registered at: [ 17.480875][ C3] __lock_acquire+0x20b/0x7e0 [ 17.481117][ C3] lock_acquire.part.0+0xb6/0x240 [ 17.481341][ C3] _raw_spin_lock+0x33/0x40 [ 17.481537][ C3] simple_pin_fs+0x24/0x150 [ 17.481730][ C3] start_creating.part.0+0x52/0x310 [ 17.481919][ C3] debugfs_create_dir+0x6a/0x540 [ 17.482150][ C3] component_debug_init+0x17/0x30 [ 17.482371][ C3] do_one_initcall+0x8f/0x1e0 [ 17.482579][ C3] do_initcalls+0x176/0x280 [ 17.482788][ C3] kernel_init_freeable+0x22d/0x300 [ 17.482974][ C3] kernel_init+0x20/0x200 [ 17.483165][ C3] ret_from_fork+0x240/0x320 [ 17.483398][ C3] ret_from_fork_asm+0x1a/0x30 [ 17.483589][ C3] irq event stamp: 254852 [ 17.483732][ C3] hardirqs last enabled at (254852): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 17.484104][ C3] hardirqs last disabled at (254851): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 17.484478][ C3] softirqs last enabled at (253476): [] handle_softirqs+0x358/0x620 [ 17.484830][ C3] softirqs last disabled at (253507): [] __irq_exit_rcu+0xfa/0x160 [ 17.485161][ C3] [ 17.485161][ C3] other info that might help us debug this: [ 17.485437][ C3] Possible unsafe locking scenario: [ 17.485437][ C3] [ 17.485721][ C3] CPU0 [ 17.485862][ C3] ---- [ 17.486008][ C3] lock(pin_fs_lock); [ 17.486157][ C3] [ 17.486298][ C3] lock(pin_fs_lock); [ 17.486474][ C3] [ 17.486474][ C3] *** DEADLOCK *** [ 17.486474][ C3] [ 17.486765][ C3] 1 lock held by swapper/3/0: [ 17.486954][ C3] #0: ffffffff8b5774c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 17.487292][ C3] [ 17.487292][ C3] stack backtrace: [ 17.487583][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 17.487590][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 17.487593][ C3] Call Trace: [ 17.487596][ C3] [ 17.487599][ C3] dump_stack_lvl+0x82/0xd0 [ 17.487605][ C3] print_usage_bug.part.0+0x25f/0x360 [ 17.487610][ C3] mark_lock_irq+0x343/0x400 [ 17.487615][ C3] ? __pfx_unwind_next_frame+0x10/0x10 [ 17.487620][ C3] ? save_trace+0x52/0x170 [ 17.487625][ C3] mark_lock+0x174/0x2f0 [ 17.487629][ C3] mark_usage+0x46/0x150 [ 17.487632][ C3] __lock_acquire+0x20b/0x7e0 [ 17.487635][ C3] ? __lock_acquire+0x44d/0x7e0 [ 17.487639][ C3] lock_acquire.part.0+0xb6/0x240 [ 17.487642][ C3] ? simple_pin_fs+0x24/0x150 [ 17.487647][ C3] ? rcu_is_watching+0x12/0xc0 [ 17.487652][ C3] ? lock_acquire+0x10c/0x170 [ 17.487654][ C3] ? simple_pin_fs+0x24/0x150 [ 17.487659][ C3] _raw_spin_lock+0x33/0x40 [ 17.487664][ C3] ? simple_pin_fs+0x24/0x150 [ 17.487667][ C3] simple_pin_fs+0x24/0x150 [ 17.487671][ C3] debugfs_remove+0x35/0x70 [ 17.487674][ C3] ref_tracker_dir_exit+0xcf/0x740 [ 17.487681][ C3] ? __pfx_ref_tracker_free+0x10/0x10 [ 17.487684][ C3] ? __sk_destruct+0x383/0x780 [ 17.487690][ C3] ? rcu_do_batch+0x34c/0xf20 [ 17.487693][ C3] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 17.487696][ C3] ? irq_exit_rcu+0xe/0x30 [ 17.487700][ C3] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 17.487705][ C3] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.487709][ C3] ? pv_native_safe_halt+0xf/0x20 [ 17.487712][ C3] ? default_idle+0x9/0x10 [ 17.487715][ C3] ? default_idle_call+0x6d/0xb0 [ 17.487718][ C3] ? cpuidle_idle_call+0x26f/0x3a0 [ 17.487721][ C3] ? do_idle+0xf6/0x160 [ 17.487723][ C3] ? cpu_startup_entry+0x54/0x60 [ 17.487726][ C3] ? start_secondary+0x213/0x2a0 [ 17.487729][ C3] ? common_startup_64+0x13e/0x148 [ 17.487736][ C3] __put_net+0x19/0x60 [ 17.487740][ C3] __sk_destruct+0x58a/0x780 [ 17.487744][ C3] ? rcu_do_batch+0x34a/0xf20 [ 17.487746][ C3] rcu_do_batch+0x34c/0xf20 [ 17.487751][ C3] ? __pfx_rcu_do_batch+0x10/0x10 [ 17.487754][ C3] ? __lock_release+0x5d/0x170 [ 17.487758][ C3] ? rcu_is_watching+0x12/0xc0 [ 17.487760][ C3] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 17.487765][ C3] rcu_core+0x2bb/0x500 [ 17.487770][ C3] handle_softirqs+0x218/0x620 [ 17.487775][ C3] __irq_exit_rcu+0xfa/0x160 [ 17.487778][ C3] irq_exit_rcu+0xe/0x30 [ 17.487781][ C3] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 17.487785][ C3] [ 17.487786][ C3] [ 17.487787][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.487790][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 17.487794][ C3] Code: a2 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 47 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 [ 17.487797][ C3] RSP: 0018:ffffc90000157de8 EFLAGS: 00000246 [ 17.487800][ C3] RAX: 000000000003de41 RBX: 1ffff9200002afc1 RCX: ffffffff8a58f5d9 [ 17.487802][ C3] RDX: 0000000000000000 RSI: ffffffff8b08f4e4 RDI: ffffffff8a853be0 [ 17.487804][ C3] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c366fa [ 17.487806][ C3] R10: ffff8880361b37d3 R11: ffffffff8b211288 R12: 0000000000000000 [ 17.487807][ C3] R13: ffff888001bf45c0 R14: dffffc0000000000 R15: 0000000000000000 [ 17.487811][ C3] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 17.487816][ C3] default_idle+0x9/0x10 [ 17.487819][ C3] default_idle_call+0x6d/0xb0 [ 17.487821][ C3] cpuidle_idle_call+0x26f/0x3a0 [ 17.487824][ C3] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 17.487828][ C3] ? tsc_verify_tsc_adjust+0x98/0x310 [ 17.487832][ C3] do_idle+0xf6/0x160 [ 17.487836][ C3] cpu_startup_entry+0x54/0x60 [ 17.487838][ C3] start_secondary+0x213/0x2a0 [ 17.487842][ C3] ? __pfx_start_secondary+0x10/0x10 [ 17.487846][ C3] common_startup_64+0x13e/0x148 [ 17.487853][ C3] [ 17.505321][ C3] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 17.505742][ C3] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/3 [ 17.506206][ C3] preempt_count: 101, expected: 0 [ 17.506491][ C3] RCU nest depth: 0, expected: 0 [ 17.506790][ C3] INFO: lockdep is turned off. [ 17.507076][ C3] Preemption disabled at: [ 17.507079][ C3] [<0000000000000000>] 0x0 [ 17.507588][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 17.507595][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 17.507598][ C3] Call Trace: [ 17.507601][ C3] [ 17.507604][ C3] dump_stack_lvl+0xb0/0xd0 [ 17.507615][ C3] __might_resched+0x360/0x5a0 [ 17.507625][ C3] down_write+0x72/0x210 [ 17.507632][ C3] ? __pfx_down_write+0x10/0x10 [ 17.507636][ C3] ? simple_recursive_removal+0x33/0x610 [ 17.507641][ C3] ? rcu_is_watching+0x12/0xc0 [ 17.507648][ C3] ? do_raw_spin_unlock+0x58/0x220 [ 17.507656][ C3] simple_recursive_removal+0x6a/0x610 [ 17.507661][ C3] ? do_raw_spin_unlock+0x58/0x220 [ 17.507665][ C3] ? __pfx_remove_one+0x10/0x10 [ 17.507673][ C3] debugfs_remove+0x44/0x70 [ 17.507679][ C3] ref_tracker_dir_exit+0xcf/0x740 [ 17.507685][ C3] ? __pfx_ref_tracker_free+0x10/0x10 [ 17.507691][ C3] ? __sk_destruct+0x383/0x780 [ 17.507698][ C3] ? rcu_do_batch+0x34c/0xf20 [ 17.507703][ C3] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 17.507708][ C3] ? irq_exit_rcu+0xe/0x30 [ 17.507715][ C3] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 17.507722][ C3] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.507728][ C3] ? pv_native_safe_halt+0xf/0x20 [ 17.507733][ C3] ? default_idle+0x9/0x10 [ 17.507738][ C3] ? default_idle_call+0x6d/0xb0 [ 17.507742][ C3] ? cpuidle_idle_call+0x26f/0x3a0 [ 17.507747][ C3] ? do_idle+0xf6/0x160 [ 17.507751][ C3] ? cpu_startup_entry+0x54/0x60 [ 17.507756][ C3] ? start_secondary+0x213/0x2a0 [ 17.507761][ C3] ? common_startup_64+0x13e/0x148 [ 17.507773][ C3] __put_net+0x19/0x60 [ 17.507778][ C3] __sk_destruct+0x58a/0x780 [ 17.507785][ C3] ? rcu_do_batch+0x34a/0xf20 [ 17.507790][ C3] rcu_do_batch+0x34c/0xf20 [ 17.507799][ C3] ? __pfx_rcu_do_batch+0x10/0x10 [ 17.507805][ C3] ? __lock_release+0x5d/0x170 [ 17.507811][ C3] ? rcu_is_watching+0x12/0xc0 [ 17.507816][ C3] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 17.507825][ C3] rcu_core+0x2bb/0x500 [ 17.507832][ C3] handle_softirqs+0x218/0x620 [ 17.507842][ C3] __irq_exit_rcu+0xfa/0x160 [ 17.507848][ C3] irq_exit_rcu+0xe/0x30 [ 17.507852][ C3] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 17.507858][ C3] [ 17.507860][ C3] [ 17.507863][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.507867][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 17.507872][ C3] Code: a2 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 47 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 [ 17.507875][ C3] RSP: 0018:ffffc90000157de8 EFLAGS: 00000246 [ 17.507878][ C3] RAX: 000000000003de41 RBX: 1ffff9200002afc1 RCX: ffffffff8a58f5d9 [ 17.507880][ C3] RDX: 0000000000000000 RSI: ffffffff8b08f4e4 RDI: ffffffff8a853be0 [ 17.507882][ C3] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c366fa [ 17.507884][ C3] R10: ffff8880361b37d3 R11: ffffffff8b211288 R12: 0000000000000000 [ 17.507886][ C3] R13: ffff888001bf45c0 R14: dffffc0000000000 R15: 0000000000000000 [ 17.507889][ C3] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 17.507894][ C3] default_idle+0x9/0x10 [ 17.507897][ C3] default_idle_call+0x6d/0xb0 [ 17.507899][ C3] cpuidle_idle_call+0x26f/0x3a0 [ 17.507902][ C3] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 17.507906][ C3] ? tsc_verify_tsc_adjust+0x98/0x310 [ 17.507911][ C3] do_idle+0xf6/0x160 [ 17.507914][ C3] cpu_startup_entry+0x54/0x60 [ 17.507917][ C3] start_secondary+0x213/0x2a0 [ 17.507920][ C3] ? __pfx_start_secondary+0x10/0x10 [ 17.507924][ C3] common_startup_64+0x13e/0x148 [ 17.507932][ C3] [ 20.093098][ C1] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 20.093685][ C1] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 215, name: sh [ 20.093965][ C1] preempt_count: 100, expected: 0 [ 20.094153][ C1] RCU nest depth: 0, expected: 0 [ 20.094339][ C1] INFO: lockdep is turned off. [ 20.094526][ C1] Preemption disabled at: [ 20.094528][ C1] [] handle_softirqs+0xe5/0x620 [ 20.094936][ C1] CPU: 1 UID: 0 PID: 215 Comm: sh Tainted: G W 6.15.0-virtme #1 PREEMPT(full) [ 20.094942][ C1] Tainted: [W]=WARN [ 20.094943][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 20.094945][ C1] Call Trace: [ 20.094947][ C1] [ 20.094949][ C1] dump_stack_lvl+0xb0/0xd0 [ 20.094958][ C1] __might_resched+0x360/0x5a0 [ 20.094967][ C1] down_write+0x72/0x210 [ 20.094973][ C1] ? __pfx_down_write+0x10/0x10 [ 20.094977][ C1] ? simple_recursive_removal+0x33/0x610 [ 20.094983][ C1] ? rcu_is_watching+0x12/0xc0 [ 20.094990][ C1] ? do_raw_spin_unlock+0x58/0x220 [ 20.094997][ C1] simple_recursive_removal+0x6a/0x610 [ 20.095001][ C1] ? do_raw_spin_unlock+0x58/0x220 [ 20.095006][ C1] ? __pfx_remove_one+0x10/0x10 [ 20.095015][ C1] debugfs_remove+0x44/0x70 [ 20.095020][ C1] ref_tracker_dir_exit+0xcf/0x740 [ 20.095027][ C1] ? __pfx_ref_tracker_free+0x10/0x10 [ 20.095033][ C1] ? __sk_destruct+0x383/0x780 [ 20.095040][ C1] ? rcu_do_batch+0x34c/0xf20 [ 20.095045][ C1] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 20.095049][ C1] ? irq_exit_rcu+0xe/0x30 [ 20.095054][ C1] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 20.095060][ C1] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 20.095065][ C1] ? kasan_quarantine_put+0xa7/0x230 [ 20.095070][ C1] ? kmem_cache_free+0x149/0x330 [ 20.095076][ C1] ? unlink_anon_vmas+0x43e/0x920 [ 20.095081][ C1] ? free_pgtables+0x25b/0x6e0 [ 20.095086][ C1] ? exit_mmap+0x30d/0x800 [ 20.095091][ C1] ? mmput+0xb8/0x3f0 [ 20.095095][ C1] ? exit_mm+0x146/0x1d0 [ 20.095100][ C1] ? do_exit+0x433/0xc20 [ 20.095104][ C1] ? bpf_sk_storage_free+0x9f/0x1c0 [ 20.095109][ C1] ? rcu_is_watching+0x12/0xc0 [ 20.095116][ C1] __put_net+0x19/0x60 [ 20.095121][ C1] __sk_destruct+0x58a/0x780 [ 20.095127][ C1] ? rcu_do_batch+0x34a/0xf20 [ 20.095131][ C1] rcu_do_batch+0x34c/0xf20 [ 20.095140][ C1] ? __pfx_rcu_do_batch+0x10/0x10 [ 20.095146][ C1] ? rcu_is_watching+0x12/0xc0 [ 20.095150][ C1] ? trace_irq_enable.constprop.0+0xd4/0x130 [ 20.095160][ C1] rcu_core+0x2bb/0x500 [ 20.095166][ C1] handle_softirqs+0x218/0x620 [ 20.095175][ C1] __irq_exit_rcu+0xfa/0x160 [ 20.095180][ C1] irq_exit_rcu+0xe/0x30 [ 20.095184][ C1] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 20.095190][ C1] [ 20.095192][ C1] [ 20.095194][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 20.095198][ C1] RIP: 0010:kasan_quarantine_put+0xa7/0x230 [ 20.095203][ C1] Code: 10 48 81 fb 00 00 10 00 0f 87 84 00 00 00 4d 85 ed 75 78 9c 58 f6 c4 02 0f 85 2c 01 00 00 b8 01 00 00 00 4d 85 ed 74 01 fb 5b <5d> 41 5c 41 5d 41 5e e9 cd a6 09 02 e8 68 ad b2 ff 48 c7 c3 80 cf [ 20.095208][ C1] RSP: 0018:ffffc90000737a68 EFLAGS: 00000206 [ 20.095213][ C1] RAX: 0000000000000001 RBX: ffff888005d143c8 RCX: ffffffff88043b9f [ 20.095216][ C1] RDX: 0000000000000000 RSI: ffffffff8a853b60 RDI: ffffffff8851916d [ 20.095219][ C1] RBP: ffff888005d143c8 R08: 0000000000000000 R09: 0000000000000000 [ 20.095222][ C1] R10: ffffffff8bfe68d7 R11: ffffc90000737748 R12: ffff888001942040 [ 20.095225][ C1] R13: 0000000000000200 R14: 0000000000000000 R15: ffff888001942040 [ 20.095232][ C1] ? trace_irq_enable.constprop.0+0x2f/0x130 [ 20.095238][ C1] ? kasan_quarantine_put+0x10d/0x230 [ 20.095247][ C1] kmem_cache_free+0x149/0x330 [ 20.095252][ C1] ? unlink_anon_vmas+0x43e/0x920 [ 20.095259][ C1] unlink_anon_vmas+0x43e/0x920 [ 20.095264][ C1] ? rcu_is_watching+0x12/0xc0 [ 20.095271][ C1] free_pgtables+0x25b/0x6e0 [ 20.095280][ C1] ? __pfx_free_pgtables+0x10/0x10 [ 20.095284][ C1] ? lock_acquire+0x10c/0x170 [ 20.095287][ C1] ? exit_mmap+0x190/0x800 [ 20.095295][ C1] ? down_write+0x152/0x210 [ 20.095299][ C1] ? __pfx_down_write+0x10/0x10 [ 20.095304][ C1] ? rcu_is_watching+0x12/0xc0 [ 20.095309][ C1] ? trace_lock_release+0x2a/0xd0 [ 20.095317][ C1] exit_mmap+0x30d/0x800 [ 20.095325][ C1] ? __pfx_exit_mmap+0x10/0x10 [ 20.095330][ C1] ? __mutex_lock+0x19c/0xcd0 [ 20.095337][ C1] ? lock_release+0x13/0xc0 [ 20.095343][ C1] ? __mutex_unlock_slowpath+0x144/0x400 [ 20.095358][ C1] mmput+0xb8/0x3f0 [ 20.095364][ C1] exit_mm+0x146/0x1d0 [ 20.095369][ C1] do_exit+0x433/0xc20 [ 20.095376][ C1] do_group_exit+0xb8/0x260 [ 20.095383][ C1] __x64_sys_exit_group+0x3e/0x50 [ 20.095389][ C1] x64_sys_call+0xf76/0x18a0 [ 20.095396][ C1] do_syscall_64+0xc1/0x380 [ 20.095403][ C1] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 20.095407][ C1] RIP: 0033:0x7f9a33857abd [ 20.095412][ C1] Code: Unable to access opcode bytes at 0x7f9a33857a93. [ 20.095414][ C1] RSP: 002b:00007fff5e5de738 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 20.095419][ C1] RAX: ffffffffffffffda RBX: 00007f9a339349c0 RCX: 00007f9a33857abd [ 20.095422][ C1] RDX: 00000000000000e7 RSI: ffffffffffffff80 RDI: 0000000000000000 [ 20.095425][ C1] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000030 [ 20.095427][ C1] R10: 00007fff5e5de5c0 R11: 0000000000000246 R12: 00007f9a339349c0 [ 20.095430][ C1] R13: 00007f9a33939ee0 R14: 0000000000000001 R15: 00007f9a33939ec8 [ 20.095441][ C1]