[ 14.698207][ T225] packetdrill (225) used greatest stack depth: 24584 bytes left [ 14.707985][ C2] [ 14.708114][ C2] ================================ [ 14.708317][ C2] WARNING: inconsistent lock state [ 14.708526][ C2] 6.15.0-virtme #1 Not tainted [ 14.708727][ C2] -------------------------------- [ 14.708930][ C2] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 14.709182][ C2] swapper/2/0 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 14.709437][ C2] ffffffff96b8d218 (&xa->xa_lock#8){+.?.}-{3:3}, at: xa_set_mark+0x73/0x120 [ 14.709798][ C2] {SOFTIRQ-ON-W} state was registered at: [ 14.709998][ C2] __lock_acquire+0x20b/0x7e0 [ 14.710201][ C2] lock_acquire.part.0+0xb6/0x240 [ 14.710404][ C2] _raw_spin_lock+0x33/0x40 [ 14.710603][ C2] xa_store+0x1c/0x50 [ 14.710751][ C2] ref_tracker_dir_debugfs+0x168/0x1b0 [ 14.710949][ C2] init_net_debugfs+0x15/0x70 [ 14.711148][ C2] do_one_initcall+0x8c/0x1e0 [ 14.711338][ C2] do_initcalls+0x176/0x280 [ 14.711537][ C2] kernel_init_freeable+0x22d/0x300 [ 14.711736][ C2] kernel_init+0x20/0x200 [ 14.711931][ C2] ret_from_fork+0x240/0x320 [ 14.712135][ C2] ret_from_fork_asm+0x1a/0x30 [ 14.712332][ C2] irq event stamp: 259728 [ 14.712494][ C2] hardirqs last enabled at (259728): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 14.712887][ C2] hardirqs last disabled at (259727): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 14.713288][ C2] softirqs last enabled at (257806): [] handle_softirqs+0x358/0x620 [ 14.713665][ C2] softirqs last disabled at (257813): [] __irq_exit_rcu+0xfa/0x160 [ 14.714019][ C2] [ 14.714019][ C2] other info that might help us debug this: [ 14.714314][ C2] Possible unsafe locking scenario: [ 14.714314][ C2] [ 14.714610][ C2] CPU0 [ 14.714765][ C2] ---- [ 14.714917][ C2] lock(&xa->xa_lock#8); [ 14.715071][ C2] [ 14.715227][ C2] lock(&xa->xa_lock#8); [ 14.715430][ C2] [ 14.715430][ C2] *** DEADLOCK *** [ 14.715430][ C2] [ 14.715730][ C2] 1 lock held by swapper/2/0: [ 14.715932][ C2] #0: ffffffff941793c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 14.716287][ C2] [ 14.716287][ C2] stack backtrace: [ 14.716538][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 14.716543][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.716545][ C2] Call Trace: [ 14.716547][ C2] [ 14.716549][ C2] dump_stack_lvl+0x82/0xd0 [ 14.716555][ C2] print_usage_bug.part.0+0x25f/0x360 [ 14.716560][ C2] mark_lock_irq+0x343/0x400 [ 14.716567][ C2] mark_lock+0x174/0x2f0 [ 14.716571][ C2] mark_usage+0x46/0x150 [ 14.716575][ C2] __lock_acquire+0x20b/0x7e0 [ 14.716579][ C2] ? unwind_next_frame+0x4f8/0x1e10 [ 14.716584][ C2] ? start_secondary+0x213/0x2a0 [ 14.716591][ C2] lock_acquire.part.0+0xb6/0x240 [ 14.716595][ C2] ? xa_set_mark+0x73/0x120 [ 14.716598][ C2] ? rcu_is_watching+0x12/0xc0 [ 14.716603][ C2] ? lock_acquire+0x10c/0x170 [ 14.716606][ C2] ? xa_set_mark+0x73/0x120 [ 14.716610][ C2] _raw_spin_lock+0x33/0x40 [ 14.716613][ C2] ? xa_set_mark+0x73/0x120 [ 14.716615][ C2] xa_set_mark+0x73/0x120 [ 14.716618][ C2] ? __pfx_xa_set_mark+0x10/0x10 [ 14.716621][ C2] ? __lock_acquire+0x44d/0x7e0 [ 14.716626][ C2] ? find_held_lock+0x2b/0x80 [ 14.716630][ C2] ref_tracker_dir_exit+0xb2/0x740 [ 14.716635][ C2] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 14.716638][ C2] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 14.716642][ C2] ? ref_tracker_free+0x35d/0x900 [ 14.716645][ C2] ? __lock_acquire+0x44d/0x7e0 [ 14.716649][ C2] ? __pfx_ref_tracker_free+0x10/0x10 [ 14.716652][ C2] ? __sk_destruct+0x383/0x780 [ 14.716656][ C2] ? rcu_do_batch+0x34f/0xf20 [ 14.716659][ C2] ? rcu_core+0x2bb/0x500 [ 14.716661][ C2] ? handle_softirqs+0x21b/0x620 [ 14.716666][ C2] __put_net+0x83/0x140 [ 14.716670][ C2] ? do_idle+0xf6/0x160 [ 14.716676][ C2] ? __pfx___put_net+0x10/0x10 [ 14.716680][ C2] ? bpf_sk_storage_free+0x9f/0x1c0 [ 14.716685][ C2] __sk_destruct+0x58a/0x780 [ 14.716688][ C2] ? rcu_do_batch+0x34a/0xf20 [ 14.716691][ C2] rcu_do_batch+0x34f/0xf20 [ 14.716695][ C2] ? find_held_lock+0x2b/0x80 [ 14.716698][ C2] ? __pfx_rcu_do_batch+0x10/0x10 [ 14.716702][ C2] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 14.716705][ C2] ? lockdep_hardirqs_on+0x7c/0x110 [ 14.716709][ C2] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 14.716714][ C2] rcu_core+0x2bb/0x500 [ 14.716717][ C2] handle_softirqs+0x21b/0x620 [ 14.716723][ C2] __irq_exit_rcu+0xfa/0x160 [ 14.716726][ C2] irq_exit_rcu+0xe/0x30 [ 14.716729][ C2] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 14.716733][ C2] [ 14.716734][ C2] [ 14.716736][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.716740][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 14.716744][ C2] Code: 64 b3 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 53 a7 0c 00 fb f4 cc 58 02 00 66 2e 0f 1f 84 00 00 00 00 00 66 90 90 90 90 90 90 [ 14.716747][ C2] RSP: 0018:ffffc90000147de8 EFLAGS: 00000242 [ 14.716750][ C2] RAX: 000000000003ef13 RBX: 1ffff92000028fc1 RCX: ffffffff931ca3c9 [ 14.716752][ C2] RDX: 0000000000000000 RSI: ffffffff93ca57e9 RDI: ffffffff9345a220 [ 14.716753][ C2] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c26702 [ 14.716755][ C2] R10: ffff888036133813 R11: ffffffff93e11288 R12: 0000000000000000 [ 14.716757][ C2] R13: ffff888001bf2300 R14: dffffc0000000000 R15: 0000000000000000 [ 14.716760][ C2] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 14.716766][ C2] default_idle+0x9/0x10 [ 14.716769][ C2] default_idle_call+0x6d/0xb0 [ 14.716771][ C2] cpuidle_idle_call+0x26f/0x3a0 [ 14.716775][ C2] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 14.716779][ C2] ? tsc_verify_tsc_adjust+0x98/0x310 [ 14.716784][ C2] do_idle+0xf6/0x160 [ 14.716788][ C2] cpu_startup_entry+0x54/0x60 [ 14.716791][ C2] start_secondary+0x213/0x2a0 [ 14.716794][ C2] ? __pfx_start_secondary+0x10/0x10 [ 14.716799][ C2] common_startup_64+0x13e/0x148 [ 14.716806][ C2] [ 16.317464][ T256] packetdrill (256) used greatest stack depth: 24568 bytes left