[ 15.681164][ C0] [ 15.681306][ C0] ================================ [ 15.681518][ C0] WARNING: inconsistent lock state [ 15.681728][ C0] 6.15.0-rc7-virtme #1 Not tainted [ 15.681931][ C0] -------------------------------- [ 15.682134][ C0] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 15.682388][ C0] swapper/0/0 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 15.682647][ C0] ffffffffb41bff78 (pin_fs_lock){+.?.}-{3:3}, at: simple_pin_fs+0x24/0x150 [ 15.683012][ C0] {SOFTIRQ-ON-W} state was registered at: [ 15.683219][ C0] __lock_acquire+0x3eb/0x9d0 [ 15.683432][ C0] lock_acquire.part.0+0xb6/0x240 [ 15.683639][ C0] _raw_spin_lock+0x33/0x40 [ 15.683848][ C0] simple_pin_fs+0x24/0x150 [ 15.684052][ C0] start_creating.part.0+0x3f/0x2f0 [ 15.684273][ C0] debugfs_create_dir+0x6a/0x540 [ 15.684481][ C0] component_debug_init+0x17/0x30 [ 15.684693][ C0] do_one_initcall+0x8f/0x1e0 [ 15.684903][ C0] do_initcalls+0x176/0x280 [ 15.685110][ C0] kernel_init_freeable+0x22d/0x300 [ 15.685317][ C0] kernel_init+0x20/0x200 [ 15.685525][ C0] ret_from_fork+0x31/0x70 [ 15.685734][ C0] ret_from_fork_asm+0x1a/0x30 [ 15.685940][ C0] irq event stamp: 451046 [ 15.686096][ C0] hardirqs last enabled at (451046): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.686508][ C0] hardirqs last disabled at (451045): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 15.686916][ C0] softirqs last enabled at (448942): [] handle_softirqs+0x358/0x620 [ 15.687278][ C0] softirqs last disabled at (448973): [] __irq_exit_rcu+0xfa/0x160 [ 15.687637][ C0] [ 15.687637][ C0] other info that might help us debug this: [ 15.687939][ C0] Possible unsafe locking scenario: [ 15.687939][ C0] [ 15.688239][ C0] CPU0 [ 15.688393][ C0] ---- [ 15.688547][ C0] lock(pin_fs_lock); [ 15.688706][ C0] [ 15.688860][ C0] lock(pin_fs_lock); [ 15.689016][ C0] [ 15.689016][ C0] *** DEADLOCK *** [ 15.689016][ C0] [ 15.689324][ C0] 1 lock held by swapper/0/0: [ 15.689533][ C0] #0: ffffffffb3f749c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 15.689908][ C0] [ 15.689908][ C0] stack backtrace: [ 15.690166][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 6.15.0-rc7-virtme #1 PREEMPT(full) [ 15.690170][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.690173][ C0] Call Trace: [ 15.690175][ C0] [ 15.690176][ C0] dump_stack_lvl+0x82/0xd0 [ 15.690183][ C0] print_usage_bug.part.0+0x25f/0x360 [ 15.690188][ C0] mark_lock_irq+0x343/0x400 [ 15.690192][ C0] ? is_bpf_text_address+0x67/0x120 [ 15.690198][ C0] ? __lock_release+0x5d/0x170 [ 15.690201][ C0] ? save_trace+0x52/0x170 [ 15.690206][ C0] mark_lock+0x174/0x2f0 [ 15.690210][ C0] mark_usage+0x46/0x150 [ 15.690214][ C0] __lock_acquire+0x3eb/0x9d0 [ 15.690219][ C0] lock_acquire.part.0+0xb6/0x240 [ 15.690222][ C0] ? simple_pin_fs+0x24/0x150 [ 15.690225][ C0] ? rcu_is_watching+0x12/0xc0 [ 15.690230][ C0] ? lock_acquire+0x10c/0x170 [ 15.690232][ C0] ? simple_pin_fs+0x24/0x150 [ 15.690236][ C0] _raw_spin_lock+0x33/0x40 [ 15.690239][ C0] ? simple_pin_fs+0x24/0x150 [ 15.690242][ C0] simple_pin_fs+0x24/0x150 [ 15.690245][ C0] debugfs_remove+0x35/0x70 [ 15.690248][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 15.690253][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 15.690256][ C0] ? __sk_destruct+0x383/0x780 [ 15.690262][ C0] ? rcu_do_batch+0x34f/0xf20 [ 15.690265][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 15.690268][ C0] ? irq_exit_rcu+0xe/0x30 [ 15.690271][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.690275][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.690279][ C0] ? pv_native_safe_halt+0xf/0x20 [ 15.690282][ C0] ? default_idle+0x9/0x10 [ 15.690284][ C0] ? default_idle_call+0x6d/0xb0 [ 15.690286][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 15.690290][ C0] ? do_idle+0xf6/0x160 [ 15.690293][ C0] ? cpu_startup_entry+0x54/0x60 [ 15.690296][ C0] ? rest_init+0x14b/0x260 [ 15.690299][ C0] ? start_kernel+0x350/0x410 [ 15.690304][ C0] __put_net+0x19/0x60 [ 15.690308][ C0] __sk_destruct+0x58a/0x780 [ 15.690312][ C0] ? rcu_do_batch+0x34a/0xf20 [ 15.690315][ C0] rcu_do_batch+0x34f/0xf20 [ 15.690319][ C0] ? find_held_lock+0x2b/0x80 [ 15.690323][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 15.690327][ C0] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.690331][ C0] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.690335][ C0] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 15.690339][ C0] rcu_core+0x2bb/0x500 [ 15.690343][ C0] handle_softirqs+0x218/0x620 [ 15.690347][ C0] __irq_exit_rcu+0xfa/0x160 [ 15.690350][ C0] irq_exit_rcu+0xe/0x30 [ 15.690352][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.690356][ C0] [ 15.690357][ C0] [ 15.690358][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.690361][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 15.690365][ C0] 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.690368][ C0] RSP: 0018:ffffffffb3c07df8 EFLAGS: 00000242 [ 15.690371][ C0] RAX: 000000000006d9cb RBX: 1ffffffff6780fc3 RCX: ffffffffb2f5ba19 [ 15.690373][ C0] RDX: 0000000000000000 RSI: ffffffffb3a87785 RDI: ffffffffb3251260 [ 15.690375][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c0667a [ 15.690377][ C0] R10: ffff8880360333d3 R11: 0000000000000000 R12: 0000000000000000 [ 15.690378][ C0] R13: ffffffffb3c1f240 R14: dffffc0000000000 R15: 0000000000014770 [ 15.690382][ C0] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 15.690387][ C0] default_idle+0x9/0x10 [ 15.690389][ C0] default_idle_call+0x6d/0xb0 [ 15.690392][ C0] cpuidle_idle_call+0x26f/0x3a0 [ 15.690395][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 15.690400][ C0] ? tsc_verify_tsc_adjust+0x98/0x300 [ 15.690406][ C0] do_idle+0xf6/0x160 [ 15.690410][ C0] cpu_startup_entry+0x54/0x60 [ 15.690414][ C0] rest_init+0x14b/0x260 [ 15.690417][ C0] start_kernel+0x350/0x410 [ 15.690421][ C0] x86_64_start_reservations+0x18/0x30 [ 15.690426][ C0] x86_64_start_kernel+0xba/0x110 [ 15.690430][ C0] common_startup_64+0x13e/0x148 [ 15.690438][ C0] [ 15.708313][ C0] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 15.708653][ C0] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/0 [ 15.709115][ C0] preempt_count: 101, expected: 0 [ 15.709307][ C0] RCU nest depth: 0, expected: 0 [ 15.709499][ C0] INFO: lockdep is turned off. [ 15.709693][ C0] Preemption disabled at: [ 15.709695][ C0] [] schedule_preempt_disabled+0x22/0x30 [ 15.710130][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 6.15.0-rc7-virtme #1 PREEMPT(full) [ 15.710135][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.710136][ C0] Call Trace: [ 15.710138][ C0] [ 15.710139][ C0] dump_stack_lvl+0xb0/0xd0 [ 15.710145][ C0] __might_resched+0x360/0x5a0 [ 15.710151][ C0] down_write+0x72/0x210 [ 15.710155][ C0] ? __pfx_down_write+0x10/0x10 [ 15.710157][ C0] ? simple_recursive_removal+0x3a/0x860 [ 15.710162][ C0] ? rcu_is_watching+0x12/0xc0 [ 15.710167][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 15.710172][ C0] simple_recursive_removal+0x166/0x860 [ 15.710175][ C0] ? __pfx_remove_one+0x10/0x10 [ 15.710179][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 15.710183][ C0] debugfs_remove+0x44/0x70 [ 15.710186][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 15.710191][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 15.710194][ C0] ? __sk_destruct+0x383/0x780 [ 15.710199][ C0] ? rcu_do_batch+0x34f/0xf20 [ 15.710202][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 15.710205][ C0] ? irq_exit_rcu+0xe/0x30 [ 15.710209][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.710213][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.710216][ C0] ? pv_native_safe_halt+0xf/0x20 [ 15.710220][ C0] ? default_idle+0x9/0x10 [ 15.710222][ C0] ? default_idle_call+0x6d/0xb0 [ 15.710225][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 15.710229][ C0] ? do_idle+0xf6/0x160 [ 15.710232][ C0] ? cpu_startup_entry+0x54/0x60 [ 15.710235][ C0] ? rest_init+0x14b/0x260 [ 15.710238][ C0] ? start_kernel+0x350/0x410 [ 15.710245][ C0] __put_net+0x19/0x60 [ 15.710249][ C0] __sk_destruct+0x58a/0x780 [ 15.710252][ C0] ? rcu_do_batch+0x34a/0xf20 [ 15.710255][ C0] rcu_do_batch+0x34f/0xf20 [ 15.710259][ C0] ? find_held_lock+0x2b/0x80 [ 15.710264][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 15.710268][ C0] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 15.710272][ C0] ? lockdep_hardirqs_on+0x7c/0x110 [ 15.710276][ C0] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 15.710280][ C0] rcu_core+0x2bb/0x500 [ 15.710284][ C0] handle_softirqs+0x218/0x620 [ 15.710289][ C0] __irq_exit_rcu+0xfa/0x160 [ 15.710291][ C0] irq_exit_rcu+0xe/0x30 [ 15.710294][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 15.710297][ C0] [ 15.710298][ C0] [ 15.710300][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.710303][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 15.710307][ C0] 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.710310][ C0] RSP: 0018:ffffffffb3c07df8 EFLAGS: 00000242 [ 15.710313][ C0] RAX: 000000000006d9cb RBX: 1ffffffff6780fc3 RCX: ffffffffb2f5ba19 [ 15.710315][ C0] RDX: 0000000000000000 RSI: ffffffffb3a87785 RDI: ffffffffb3251260 [ 15.710317][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c0667a [ 15.710319][ C0] R10: ffff8880360333d3 R11: 0000000000000000 R12: 0000000000000000 [ 15.710321][ C0] R13: ffffffffb3c1f240 R14: dffffc0000000000 R15: 0000000000014770 [ 15.710325][ C0] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 15.710329][ C0] default_idle+0x9/0x10 [ 15.710331][ C0] default_idle_call+0x6d/0xb0 [ 15.710334][ C0] cpuidle_idle_call+0x26f/0x3a0 [ 15.710338][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 15.710342][ C0] ? tsc_verify_tsc_adjust+0x98/0x300 [ 15.710349][ C0] do_idle+0xf6/0x160 [ 15.710353][ C0] cpu_startup_entry+0x54/0x60 [ 15.710357][ C0] rest_init+0x14b/0x260 [ 15.710360][ C0] start_kernel+0x350/0x410 [ 15.710364][ C0] x86_64_start_reservations+0x18/0x30 [ 15.710369][ C0] x86_64_start_kernel+0xba/0x110 [ 15.710372][ C0] common_startup_64+0x13e/0x148 [ 15.710381][ C0] [ 17.838804][ C0] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 17.839185][ C0] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/0 [ 17.839521][ C0] preempt_count: 101, expected: 0 [ 17.839728][ C0] RCU nest depth: 0, expected: 0 [ 17.839918][ C0] INFO: lockdep is turned off. [ 17.840109][ C0] Preemption disabled at: [ 17.840111][ C0] [] schedule_preempt_disabled+0x22/0x30 [ 17.840553][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 6.15.0-rc7-virtme #1 PREEMPT(full) [ 17.840558][ C0] Tainted: [W]=WARN [ 17.840559][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 17.840561][ C0] Call Trace: [ 17.840563][ C0] [ 17.840565][ C0] dump_stack_lvl+0xb0/0xd0 [ 17.840571][ C0] __might_resched+0x360/0x5a0 [ 17.840577][ C0] down_write+0x72/0x210 [ 17.840581][ C0] ? __pfx_down_write+0x10/0x10 [ 17.840584][ C0] ? simple_recursive_removal+0x3a/0x860 [ 17.840590][ C0] ? rcu_is_watching+0x12/0xc0 [ 17.840596][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 17.840601][ C0] simple_recursive_removal+0x166/0x860 [ 17.840604][ C0] ? __pfx_remove_one+0x10/0x10 [ 17.840608][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 17.840613][ C0] debugfs_remove+0x44/0x70 [ 17.840616][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 17.840621][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 17.840625][ C0] ? __sk_destruct+0x383/0x780 [ 17.840630][ C0] ? rcu_do_batch+0x34f/0xf20 [ 17.840634][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 17.840637][ C0] ? irq_exit_rcu+0xe/0x30 [ 17.840641][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 17.840646][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.840650][ C0] ? pv_native_safe_halt+0xf/0x20 [ 17.840653][ C0] ? default_idle+0x9/0x10 [ 17.840655][ C0] ? default_idle_call+0x6d/0xb0 [ 17.840658][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 17.840662][ C0] ? do_idle+0xf6/0x160 [ 17.840665][ C0] ? cpu_startup_entry+0x54/0x60 [ 17.840668][ C0] ? rest_init+0x14b/0x260 [ 17.840671][ C0] ? start_kernel+0x350/0x410 [ 17.840677][ C0] ? bpf_sk_storage_free+0x9f/0x1c0 [ 17.840681][ C0] ? rcu_is_watching+0x12/0xc0 [ 17.840686][ C0] __put_net+0x19/0x60 [ 17.840689][ C0] __sk_destruct+0x58a/0x780 [ 17.840693][ C0] ? rcu_do_batch+0x34a/0xf20 [ 17.840696][ C0] rcu_do_batch+0x34f/0xf20 [ 17.840701][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 17.840706][ C0] ? rcu_is_watching+0x12/0xc0 [ 17.840711][ C0] rcu_core+0x2bb/0x500 [ 17.840715][ C0] handle_softirqs+0x218/0x620 [ 17.840720][ C0] __irq_exit_rcu+0xfa/0x160 [ 17.840723][ C0] irq_exit_rcu+0xe/0x30 [ 17.840725][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 17.840729][ C0] [ 17.840730][ C0] [ 17.840731][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.840734][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 17.840738][ C0] 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.840741][ C0] RSP: 0018:ffffffffb3c07df8 EFLAGS: 00000246 [ 17.840745][ C0] RAX: 0000000000000000 RBX: 1ffffffff6780fc3 RCX: ffffffffb2f5ba19 [ 17.840747][ C0] RDX: ffffed1006c0667b RSI: ffffffffb32511e0 RDI: ffffffffb078633f [ 17.840749][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: ffffed1006c0667a [ 17.840751][ C0] R10: ffff8880360333d3 R11: ffff888001bdcb58 R12: 0000000000000000 [ 17.840753][ C0] R13: ffffffffb3c1f240 R14: dffffc0000000000 R15: 0000000000014770 [ 17.840757][ C0] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 17.840760][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 17.840764][ C0] default_idle+0x9/0x10 [ 17.840767][ C0] default_idle_call+0x6d/0xb0 [ 17.840769][ C0] cpuidle_idle_call+0x26f/0x3a0 [ 17.840773][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 17.840777][ C0] ? tsc_verify_tsc_adjust+0x98/0x300 [ 17.840783][ C0] do_idle+0xf6/0x160 [ 17.840787][ C0] cpu_startup_entry+0x54/0x60 [ 17.840791][ C0] rest_init+0x14b/0x260 [ 17.840795][ C0] start_kernel+0x350/0x410 [ 17.840799][ C0] x86_64_start_reservations+0x18/0x30 [ 17.840803][ C0] x86_64_start_kernel+0xba/0x110 [ 17.840807][ C0] common_startup_64+0x13e/0x148 [ 17.840815][ C0]