[ 20.193756][ C3] [ 20.194036][ C3] ================================ [ 20.194404][ C3] WARNING: inconsistent lock state [ 20.194768][ C3] 6.15.0-virtme #1 Not tainted [ 20.195132][ C3] -------------------------------- [ 20.195496][ C3] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 20.195959][ C3] packetdrill/228 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 20.196422][ C3] ffffffffb1d8d218 (&xa->xa_lock#8){+.?.}-{3:3}, at: xa_set_mark+0x73/0x120 [ 20.197069][ C3] {SOFTIRQ-ON-W} state was registered at: [ 20.197430][ C3] __lock_acquire+0x20b/0x7e0 [ 20.197806][ C3] lock_acquire.part.0+0xb6/0x240 [ 20.198177][ C3] _raw_spin_lock+0x33/0x40 [ 20.198543][ C3] xa_store+0x1c/0x50 [ 20.198816][ C3] ref_tracker_dir_debugfs+0x168/0x1b0 [ 20.199183][ C3] init_net_debugfs+0x15/0x70 [ 20.199558][ C3] do_one_initcall+0x8c/0x1e0 [ 20.199929][ C3] do_initcalls+0x176/0x280 [ 20.200303][ C3] kernel_init_freeable+0x22d/0x300 [ 20.200770][ C3] kernel_init+0x20/0x200 [ 20.201142][ C3] ret_from_fork+0x240/0x320 [ 20.201519][ C3] ret_from_fork_asm+0x1a/0x30 [ 20.201875][ C3] irq event stamp: 1564188 [ 20.202244][ C3] hardirqs last enabled at (1564188): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 20.202981][ C3] hardirqs last disabled at (1564187): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 20.203717][ C3] softirqs last enabled at (1563606): [] handle_softirqs+0x358/0x620 [ 20.204358][ C3] softirqs last disabled at (1563629): [] __irq_exit_rcu+0xfa/0x160 [ 20.204998][ C3] [ 20.204998][ C3] other info that might help us debug this: [ 20.205535][ C3] Possible unsafe locking scenario: [ 20.205535][ C3] [ 20.206073][ C3] CPU0 [ 20.206350][ C3] ---- [ 20.206626][ C3] lock(&xa->xa_lock#8); [ 20.206908][ C3] [ 20.207182][ C3] lock(&xa->xa_lock#8); [ 20.207555][ C3] [ 20.207555][ C3] *** DEADLOCK *** [ 20.207555][ C3] [ 20.208103][ C3] 2 locks held by packetdrill/228: [ 20.208473][ C3] #0: ffffffffaf581e90 (remove_cache_srcu){.+.+}-{0:0}, at: kasan_quarantine_reduce+0x88/0x1e0 [ 20.209225][ C3] #1: ffffffffaf3793c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 20.209877][ C3] [ 20.209877][ C3] stack backtrace: [ 20.210327][ C3] CPU: 3 UID: 0 PID: 228 Comm: packetdrill Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 20.210336][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 20.210340][ C3] Call Trace: [ 20.210343][ C3] [ 20.210347][ C3] dump_stack_lvl+0x82/0xd0 [ 20.210358][ C3] print_usage_bug.part.0+0x25f/0x360 [ 20.210368][ C3] mark_lock_irq+0x343/0x400 [ 20.210381][ C3] mark_lock+0x174/0x2f0 [ 20.210388][ C3] mark_usage+0x46/0x150 [ 20.210394][ C3] __lock_acquire+0x20b/0x7e0 [ 20.210400][ C3] ? unwind_next_frame+0x4f8/0x1e10 [ 20.210408][ C3] ? fuse_file_put+0x170/0x1f0 [ 20.210418][ C3] lock_acquire.part.0+0xb6/0x240 [ 20.210424][ C3] ? xa_set_mark+0x73/0x120 [ 20.210431][ C3] ? rcu_is_watching+0x12/0xc0 [ 20.210440][ C3] ? lock_acquire+0x10c/0x170 [ 20.210444][ C3] ? xa_set_mark+0x73/0x120 [ 20.210452][ C3] _raw_spin_lock+0x33/0x40 [ 20.210457][ C3] ? xa_set_mark+0x73/0x120 [ 20.210461][ C3] xa_set_mark+0x73/0x120 [ 20.210466][ C3] ? __pfx_xa_set_mark+0x10/0x10 [ 20.210471][ C3] ? __lock_acquire+0x44d/0x7e0 [ 20.210481][ C3] ? find_held_lock+0x2b/0x80 [ 20.210488][ C3] ref_tracker_dir_exit+0xb2/0x740 [ 20.210495][ C3] ? mark_held_locks+0x49/0x80 [ 20.210501][ C3] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 20.210506][ C3] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 20.210513][ C3] ? ref_tracker_free+0x35d/0x900 [ 20.210518][ C3] ? __lock_acquire+0x44d/0x7e0 [ 20.210524][ C3] ? __pfx_ref_tracker_free+0x10/0x10 [ 20.210529][ C3] ? __sk_destruct+0x383/0x780 [ 20.210537][ C3] ? rcu_do_batch+0x34f/0xf20 [ 20.210543][ C3] ? rcu_core+0x2bb/0x500 [ 20.210547][ C3] ? handle_softirqs+0x21b/0x620 [ 20.210557][ C3] __put_net+0x83/0x140 [ 20.210564][ C3] ? fuse_request_alloc+0x1e/0x210 [ 20.210570][ C3] ? __pfx___put_net+0x10/0x10 [ 20.210577][ C3] ? bpf_sk_storage_free+0x9f/0x1c0 [ 20.210585][ C3] __sk_destruct+0x58a/0x780 [ 20.210591][ C3] ? rcu_do_batch+0x34a/0xf20 [ 20.210596][ C3] rcu_do_batch+0x34f/0xf20 [ 20.210603][ C3] ? find_held_lock+0x2b/0x80 [ 20.210609][ C3] ? __pfx_rcu_do_batch+0x10/0x10 [ 20.210616][ C3] ? mark_held_locks+0x49/0x80 [ 20.210621][ C3] ? note_gp_changes+0x182/0x1e0 [ 20.210626][ C3] ? lockdep_hardirqs_on+0x7c/0x110 [ 20.210635][ C3] rcu_core+0x2bb/0x500 [ 20.210640][ C3] handle_softirqs+0x21b/0x620 [ 20.210650][ C3] __irq_exit_rcu+0xfa/0x160 [ 20.210656][ C3] irq_exit_rcu+0xe/0x30 [ 20.210661][ C3] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 20.210667][ C3] [ 20.210669][ C3] [ 20.210672][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 20.210678][ C3] RIP: 0010:qlist_free_all+0x8b/0x120 [ 20.210685][ C3] Code: ae 70 ff 48 c1 e8 0c 48 c1 e0 06 48 03 05 8d 16 bd 02 48 8b 48 08 48 89 c2 f6 c1 01 0f 85 89 00 00 00 66 90 31 c0 80 7a 33 f5 <48> 0f 45 d0 48 8b 6a 08 eb 88 48 83 7d 48 00 75 9e f7 45 08 04 02 [ 20.210689][ C3] RSP: 0018:ffffc90000a17b70 EFLAGS: 00000246 [ 20.210695][ C3] RAX: 0000000000000000 RBX: ffff88800259f250 RCX: ffffea0000096781 [ 20.210698][ C3] RDX: ffffea0000096780 RSI: ffffffffaeea57e9 RDI: ffff88800259f250 [ 20.210700][ C3] RBP: 0000000000000000 R08: 0000000000000001 R09: 0000000000000001 [ 20.210703][ C3] R10: ffffffffafdf61d7 R11: ffff88800104f458 R12: ffff88800259f250 [ 20.210706][ C3] R13: 0000000000000000 R14: ffffc90000a17ba8 R15: ffff88800976d868 [ 20.210718][ C3] kasan_quarantine_reduce+0x195/0x1e0 [ 20.210724][ C3] __kasan_slab_alloc+0x49/0x70 [ 20.210732][ C3] kmem_cache_alloc_noprof+0x10b/0x330 [ 20.210741][ C3] fuse_request_alloc+0x1e/0x210 [ 20.210747][ C3] __fuse_simple_request+0x4ca/0xb50 [ 20.210755][ C3] fuse_file_put+0x170/0x1f0 [ 20.210761][ C3] fuse_release+0x134/0x1c0 [ 20.210768][ C3] __fput+0x35c/0xa80 [ 20.210777][ C3] ? _raw_spin_unlock_irq+0x28/0x50 [ 20.210785][ C3] task_work_run+0x134/0x220 [ 20.210795][ C3] ? __pfx_task_work_run+0x10/0x10 [ 20.210801][ C3] ? kmem_cache_free+0x149/0x330 [ 20.210806][ C3] ? refcount_dec_and_lock+0x17/0x80 [ 20.210814][ C3] ? do_exit+0x58f/0xe90 [ 20.210821][ C3] do_exit+0x594/0xe90 [ 20.210826][ C3] ? __pfx_do_exit+0x10/0x10 [ 20.210831][ C3] ? do_group_exit+0x183/0x260 [ 20.210835][ C3] ? __lock_release+0x5d/0x170 [ 20.210842][ C3] ? rcu_is_watching+0x12/0xc0 [ 20.210849][ C3] do_group_exit+0xb8/0x260 [ 20.210856][ C3] __x64_sys_exit_group+0x3e/0x50 [ 20.210861][ C3] x64_sys_call+0xf76/0x18a0 [ 20.210867][ C3] do_syscall_64+0xc1/0x380 [ 20.210872][ C3] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 20.210877][ C3] RIP: 0033:0x48991d [ 20.210882][ C3] Code: Unable to access opcode bytes at 0x4898f3. [ 20.210885][ C3] RSP: 002b:00007ffe18dc2a38 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 20.210890][ C3] RAX: ffffffffffffffda RBX: 00000000005564b0 RCX: 000000000048991d [ 20.210893][ C3] RDX: 00000000000000e7 RSI: ffffffffffffffa8 RDI: 0000000000000000 [ 20.210896][ C3] RBP: 0000000000000000 R08: 0000000020d878a0 R09: 0000000000000000 [ 20.210899][ C3] R10: 0000000020d87320 R11: 0000000000000246 R12: 00000000005564b0 [ 20.210902][ C3] R13: 0000000000000000 R14: 0000000000556f60 R15: 000000000042d8e0 [ 20.210913][ C3]