[ 16.290358][ T228] packetdrill (228) used greatest stack depth: 24496 bytes left [ 16.296616][ C0] [ 16.296722][ C0] ================================ [ 16.296891][ C0] WARNING: inconsistent lock state [ 16.297063][ C0] 6.15.0-virtme #1 Not tainted [ 16.297237][ C0] -------------------------------- [ 16.297416][ C0] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 16.297629][ C0] ksoftirqd/0/14 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 16.297840][ C0] ffffffff93b8d218 (&xa->xa_lock#8){+.?.}-{3:3}, at: xa_set_mark+0x73/0x120 [ 16.298148][ C0] {SOFTIRQ-ON-W} state was registered at: [ 16.298317][ C0] __lock_acquire+0x20b/0x7e0 [ 16.298492][ C0] lock_acquire.part.0+0xb6/0x240 [ 16.298665][ C0] _raw_spin_lock+0x33/0x40 [ 16.298836][ C0] xa_store+0x1c/0x50 [ 16.298966][ C0] ref_tracker_dir_debugfs+0x168/0x1b0 [ 16.299138][ C0] init_net_debugfs+0x15/0x70 [ 16.299311][ C0] do_one_initcall+0x8c/0x1e0 [ 16.299480][ C0] do_initcalls+0x176/0x280 [ 16.299651][ C0] kernel_init_freeable+0x22d/0x300 [ 16.299822][ C0] kernel_init+0x20/0x200 [ 16.299993][ C0] ret_from_fork+0x240/0x320 [ 16.300169][ C0] ret_from_fork_asm+0x1a/0x30 [ 16.300338][ C0] irq event stamp: 135396 [ 16.300470][ C0] hardirqs last enabled at (135396): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 16.300808][ C0] hardirqs last disabled at (135395): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 16.301145][ C0] softirqs last enabled at (134184): [] handle_softirqs+0x358/0x620 [ 16.301439][ C0] softirqs last disabled at (134187): [] run_ksoftirqd+0x3f/0x70 [ 16.301737][ C0] [ 16.301737][ C0] other info that might help us debug this: [ 16.301986][ C0] Possible unsafe locking scenario: [ 16.301986][ C0] [ 16.302235][ C0] CPU0 [ 16.302362][ C0] ---- [ 16.302489][ C0] lock(&xa->xa_lock#8); [ 16.302619][ C0] [ 16.302746][ C0] lock(&xa->xa_lock#8); [ 16.302915][ C0] [ 16.302915][ C0] *** DEADLOCK *** [ 16.302915][ C0] [ 16.303165][ C0] 1 lock held by ksoftirqd/0/14: [ 16.303335][ C0] #0: ffffffff911793c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 16.303641][ C0] [ 16.303641][ C0] stack backtrace: [ 16.303854][ C0] CPU: 0 UID: 0 PID: 14 Comm: ksoftirqd/0 Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 16.303858][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 16.303860][ C0] Call Trace: [ 16.303862][ C0] [ 16.303864][ C0] dump_stack_lvl+0x82/0xd0 [ 16.303870][ C0] print_usage_bug.part.0+0x25f/0x360 [ 16.303874][ C0] mark_lock_irq+0x343/0x400 [ 16.303882][ C0] mark_lock+0x174/0x2f0 [ 16.303886][ C0] mark_usage+0x46/0x150 [ 16.303889][ C0] __lock_acquire+0x20b/0x7e0 [ 16.303893][ C0] ? unwind_next_frame+0x4f8/0x1e10 [ 16.303897][ C0] ? ret_from_fork_asm+0x1a/0x30 [ 16.303901][ C0] lock_acquire.part.0+0xb6/0x240 [ 16.303904][ C0] ? xa_set_mark+0x73/0x120 [ 16.303908][ C0] ? rcu_is_watching+0x12/0xc0 [ 16.303913][ C0] ? lock_acquire+0x10c/0x170 [ 16.303916][ C0] ? xa_set_mark+0x73/0x120 [ 16.303919][ C0] _raw_spin_lock+0x33/0x40 [ 16.303922][ C0] ? xa_set_mark+0x73/0x120 [ 16.303925][ C0] xa_set_mark+0x73/0x120 [ 16.303927][ C0] ? __pfx_xa_set_mark+0x10/0x10 [ 16.303930][ C0] ? __lock_acquire+0x44d/0x7e0 [ 16.303935][ C0] ? find_held_lock+0x2b/0x80 [ 16.303940][ C0] ref_tracker_dir_exit+0xb2/0x740 [ 16.303944][ C0] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 16.303947][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 16.303951][ C0] ? ref_tracker_free+0x35d/0x900 [ 16.303954][ C0] ? __lock_acquire+0x44d/0x7e0 [ 16.303958][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 16.303961][ C0] ? __sk_destruct+0x383/0x780 [ 16.303965][ C0] ? rcu_do_batch+0x34f/0xf20 [ 16.303968][ C0] ? rcu_core+0x2bb/0x500 [ 16.303970][ C0] ? handle_softirqs+0x21b/0x620 [ 16.303975][ C0] __put_net+0x83/0x140 [ 16.303980][ C0] ? __pfx_migrate_enable+0x10/0x10 [ 16.303984][ C0] ? __pfx___put_net+0x10/0x10 [ 16.303988][ C0] ? bpf_sk_storage_free+0x9f/0x1c0 [ 16.303993][ C0] __sk_destruct+0x58a/0x780 [ 16.303996][ C0] ? rcu_do_batch+0x34a/0xf20 [ 16.303999][ C0] rcu_do_batch+0x34f/0xf20 [ 16.304004][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 16.304008][ C0] ? rcu_is_watching+0x12/0xc0 [ 16.304011][ C0] ? note_gp_changes+0x182/0x1e0 [ 16.304015][ C0] ? lockdep_hardirqs_on+0x7c/0x110 [ 16.304020][ C0] rcu_core+0x2bb/0x500 [ 16.304022][ C0] handle_softirqs+0x21b/0x620 [ 16.304027][ C0] ? __pfx_run_ksoftirqd+0x10/0x10 [ 16.304031][ C0] run_ksoftirqd+0x3f/0x70 [ 16.304034][ C0] smpboot_thread_fn+0x307/0x960 [ 16.304038][ C0] ? __pfx_smpboot_thread_fn+0x10/0x10 [ 16.304041][ C0] kthread+0x37b/0x600 [ 16.304045][ C0] ? __pfx_kthread+0x10/0x10 [ 16.304048][ C0] ? ret_from_fork+0x1b/0x320 [ 16.304051][ C0] ? __lock_release+0x5d/0x170 [ 16.304055][ C0] ? rcu_is_watching+0x12/0xc0 [ 16.304058][ C0] ? __pfx_kthread+0x10/0x10 [ 16.304061][ C0] ret_from_fork+0x240/0x320 [ 16.304064][ C0] ? __pfx_kthread+0x10/0x10 [ 16.304067][ C0] ret_from_fork_asm+0x1a/0x30 [ 16.304073][ C0]