[ 14.240745][ C2] [ 14.240904][ C2] ================================ [ 14.241110][ C2] WARNING: inconsistent lock state [ 14.241310][ C2] 6.15.0-virtme #1 Not tainted [ 14.241514][ C2] -------------------------------- [ 14.241712][ C2] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 14.241961][ C2] (udev-worker)/233 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 14.242230][ C2] ffffffff8a7c5af8 (pin_fs_lock){+.?.}-{3:3}, at: simple_pin_fs+0x24/0x150 [ 14.242611][ C2] {SOFTIRQ-ON-W} state was registered at: [ 14.242813][ C2] __lock_acquire+0x20b/0x7e0 [ 14.243023][ C2] lock_acquire.part.0+0xb6/0x240 [ 14.243232][ C2] _raw_spin_lock+0x33/0x40 [ 14.243434][ C2] simple_pin_fs+0x24/0x150 [ 14.243637][ C2] start_creating.part.0+0x52/0x310 [ 14.243843][ C2] debugfs_create_dir+0x6a/0x540 [ 14.244053][ C2] component_debug_init+0x17/0x30 [ 14.244265][ C2] do_one_initcall+0x8f/0x1e0 [ 14.244475][ C2] do_initcalls+0x176/0x280 [ 14.244695][ C2] kernel_init_freeable+0x22d/0x300 [ 14.244911][ C2] kernel_init+0x20/0x200 [ 14.245128][ C2] ret_from_fork+0x240/0x320 [ 14.245341][ C2] ret_from_fork_asm+0x1a/0x30 [ 14.245565][ C2] irq event stamp: 2676 [ 14.245739][ C2] hardirqs last enabled at (2676): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 14.246179][ C2] hardirqs last disabled at (2675): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 14.246541][ C2] softirqs last enabled at (1910): [] handle_softirqs+0x358/0x620 [ 14.246899][ C2] softirqs last disabled at (2265): [] __irq_exit_rcu+0xfa/0x160 [ 14.247260][ C2] [ 14.247260][ C2] other info that might help us debug this: [ 14.247584][ C2] Possible unsafe locking scenario: [ 14.247584][ C2] [ 14.247883][ C2] CPU0 [ 14.248039][ C2] ---- [ 14.248196][ C2] lock(pin_fs_lock); [ 14.248350][ C2] [ 14.248507][ C2] lock(pin_fs_lock); [ 14.248662][ C2] [ 14.248662][ C2] *** DEADLOCK *** [ 14.248662][ C2] [ 14.248952][ C2] 4 locks held by (udev-worker)/233: [ 14.249159][ C2] #0: ffff8880090aa0c8 (vm_lock){++++}-{0:0}, at: do_user_addr_fault+0x461/0xe00 [ 14.249523][ C2] #1: ffffffff8a5775e0 (rcu_read_lock){....}-{1:3}, at: ___pte_offset_map+0x2c/0x2a0 [ 14.249888][ C2] #2: ffff8880050bc230 (ptlock_ptr(ptdesc)#2){+.+.}-{3:3}, at: __pte_offset_map_lock+0xfa/0x280 [ 14.250298][ C2] #3: ffffffff8a5774c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 14.250688][ C2] [ 14.250688][ C2] stack backtrace: [ 14.250945][ C2] CPU: 2 UID: 0 PID: 233 Comm: (udev-worker) Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 14.250951][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.250953][ C2] Call Trace: [ 14.250955][ C2] [ 14.250956][ C2] dump_stack_lvl+0x82/0xd0 [ 14.250963][ C2] print_usage_bug.part.0+0x25f/0x360 [ 14.250968][ C2] mark_lock_irq+0x343/0x400 [ 14.250972][ C2] ? __pfx_unwind_next_frame+0x10/0x10 [ 14.250978][ C2] ? save_trace+0x52/0x170 [ 14.250982][ C2] mark_lock+0x174/0x2f0 [ 14.250987][ C2] mark_usage+0x46/0x150 [ 14.250990][ C2] __lock_acquire+0x20b/0x7e0 [ 14.250994][ C2] ? __lock_acquire+0x44d/0x7e0 [ 14.250998][ C2] lock_acquire.part.0+0xb6/0x240 [ 14.251001][ C2] ? simple_pin_fs+0x24/0x150 [ 14.251005][ C2] ? rcu_is_watching+0x12/0xc0 [ 14.251010][ C2] ? lock_acquire+0x10c/0x170 [ 14.251013][ C2] ? simple_pin_fs+0x24/0x150 [ 14.251017][ C2] _raw_spin_lock+0x33/0x40 [ 14.251020][ C2] ? simple_pin_fs+0x24/0x150 [ 14.251023][ C2] simple_pin_fs+0x24/0x150 [ 14.251026][ C2] debugfs_remove+0x35/0x70 [ 14.251029][ C2] ref_tracker_dir_exit+0xcf/0x740 [ 14.251034][ C2] ? __pfx_ref_tracker_free+0x10/0x10 [ 14.251036][ C2] ? __sk_destruct+0x383/0x780 [ 14.251041][ C2] ? rcu_do_batch+0x34c/0xf20 [ 14.251045][ C2] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 14.251047][ C2] ? irq_exit_rcu+0xe/0x30 [ 14.251051][ C2] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 14.251055][ C2] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.251059][ C2] ? flush_tlb_mm_range+0xd5/0x600 [ 14.251062][ C2] ? ptep_clear_flush+0xea/0x120 [ 14.251065][ C2] ? wp_page_copy+0x550/0x11e0 [ 14.251070][ C2] ? handle_pte_fault+0x3ff/0x690 [ 14.251072][ C2] ? __handle_mm_fault+0x3fc/0x5e0 [ 14.251075][ C2] ? handle_mm_fault+0x200/0x420 [ 14.251077][ C2] ? do_user_addr_fault+0x576/0xe00 [ 14.251080][ C2] ? exc_page_fault+0x5d/0xc0 [ 14.251085][ C2] __put_net+0x19/0x60 [ 14.251089][ C2] __sk_destruct+0x58a/0x780 [ 14.251093][ C2] ? rcu_do_batch+0x34a/0xf20 [ 14.251096][ C2] rcu_do_batch+0x34c/0xf20 [ 14.251099][ C2] ? find_held_lock+0x2b/0x80 [ 14.251103][ C2] ? __pfx_rcu_do_batch+0x10/0x10 [ 14.251107][ C2] ? mark_held_locks+0x49/0x80 [ 14.251110][ C2] ? note_gp_changes+0x182/0x1e0 [ 14.251113][ C2] ? lockdep_hardirqs_on+0x7c/0x110 [ 14.251118][ C2] rcu_core+0x2bb/0x500 [ 14.251122][ C2] handle_softirqs+0x218/0x620 [ 14.251128][ C2] __irq_exit_rcu+0xfa/0x160 [ 14.251131][ C2] irq_exit_rcu+0xe/0x30 [ 14.251134][ C2] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 14.251138][ C2] [ 14.251139][ C2] [ 14.251140][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.251143][ C2] RIP: 0010:flush_tlb_mm_range+0xd5/0x600 [ 14.251146][ C2] Code: 08 84 d2 0f 85 cd 04 00 00 0f b7 85 90 08 00 00 8d 50 ff 66 83 fa 04 0f 86 50 03 00 00 66 85 c0 74 6b 4c 89 ff e8 6b d6 ff ff <65> ff 0d cc 6a 30 05 bf 01 00 00 00 e8 ca bf 0f 00 65 8b 05 e3 2d [ 14.251149][ C2] RSP: 0000:ffffc900004c7aa8 EFLAGS: 00000206 [ 14.251152][ C2] RAX: 00000000000008d7 RBX: 0000000000000002 RCX: 0000000000000040 [ 14.251154][ C2] RDX: 0000000000000000 RSI: ffffffff8a09175c RDI: ffffffff89853ca0 [ 14.251156][ C2] RBP: ffff88800ae36940 R08: 0000000000000001 R09: 0000000000000001 [ 14.251158][ C2] R10: ffffffff8afe7cd7 R11: ffff8880050bc230 R12: 000056501e646000 [ 14.251159][ C2] R13: 000056501e647000 R14: ffff88800ae372c0 R15: ffff88802f537c80 [ 14.251165][ C2] ? flush_tlb_mm_range+0x412/0x600 [ 14.251169][ C2] ptep_clear_flush+0xea/0x120 [ 14.251173][ C2] wp_page_copy+0x550/0x11e0 [ 14.251179][ C2] ? __pfx_wp_page_copy+0x10/0x10 [ 14.251182][ C2] ? __lock_release+0x5d/0x170 [ 14.251186][ C2] ? rcu_read_unlock+0x18/0x70 [ 14.251190][ C2] ? do_wp_page+0x876/0x1170 [ 14.251195][ C2] handle_pte_fault+0x3ff/0x690 [ 14.251198][ C2] ? __pfx_handle_pte_fault+0x10/0x10 [ 14.251202][ C2] ? reacquire_held_locks+0xd1/0x200 [ 14.251206][ C2] ? do_user_addr_fault+0x461/0xe00 [ 14.251210][ C2] __handle_mm_fault+0x3fc/0x5e0 [ 14.251213][ C2] ? __pfx___handle_mm_fault+0x10/0x10 [ 14.251215][ C2] ? __lock_release+0xa8/0x170 [ 14.251222][ C2] ? __pfx_lock_vma_under_rcu+0x10/0x10 [ 14.251226][ C2] handle_mm_fault+0x200/0x420 [ 14.251229][ C2] ? __pfx_handle_mm_fault+0x10/0x10 [ 14.251232][ C2] ? exc_page_fault+0x5d/0xc0 [ 14.251235][ C2] ? __lock_release+0x5d/0x170 [ 14.251240][ C2] do_user_addr_fault+0x576/0xe00 [ 14.251244][ C2] ? rcu_is_watching+0x12/0xc0 [ 14.251248][ C2] exc_page_fault+0x5d/0xc0 [ 14.251252][ C2] asm_exc_page_fault+0x26/0x30 [ 14.251254][ C2] RIP: 0033:0x564ff94247ac [ 14.251259][ C2] Code: 78 03 45 89 37 48 8b 44 24 08 45 31 f6 49 89 df 4c 8b 60 38 4d 85 e4 0f 84 c3 00 00 00 48 8b 4c 24 08 4c 89 e0 4d 8b 64 24 18 <48> 89 41 30 0f b6 00 83 e8 0c 3c 04 0f 87 c2 00 00 00 45 84 f6 0f [ 14.251261][ C2] RSP: 002b:00007ffcd4f7d8f0 EFLAGS: 00010206 [ 14.251264][ C2] RAX: 000056501e646d00 RBX: 000056501e66f6d0 RCX: 000056501e646ca0 [ 14.251265][ C2] RDX: 000056501e644710 RSI: 00007ffcd4f7d968 RDI: 0000000000000000 [ 14.251267][ C2] RBP: 000056501e636e30 R08: 0000000000000000 R09: 0000000000000000 [ 14.251268][ C2] R10: f070d8f38684c6f4 R11: 00007ffcd4f758b8 R12: 000056501e646d30 [ 14.251270][ C2] R13: 0000000000000009 R14: 0000000000000000 R15: 000056501e66f6d0 [ 14.251276][ C2] [ 14.274353][ C2] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 14.274823][ C2] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 233, name: (udev-worker) [ 14.275174][ C2] preempt_count: 102, expected: 0 [ 14.275421][ C2] RCU nest depth: 1, expected: 0 [ 14.275649][ C2] INFO: lockdep is turned off. [ 14.275871][ C2] Preemption disabled at: [ 14.275873][ C2] [<0000000000000000>] 0x0 [ 14.276534][ C2] CPU: 2 UID: 0 PID: 233 Comm: (udev-worker) Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 14.276539][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.276541][ C2] Call Trace: [ 14.276543][ C2] [ 14.276545][ C2] dump_stack_lvl+0xb0/0xd0 [ 14.276553][ C2] __might_resched+0x360/0x5a0 [ 14.276561][ C2] down_write+0x72/0x210 [ 14.276565][ C2] ? __pfx_down_write+0x10/0x10 [ 14.276568][ C2] ? simple_recursive_removal+0x33/0x610 [ 14.276573][ C2] ? rcu_is_watching+0x12/0xc0 [ 14.276579][ C2] ? do_raw_spin_unlock+0x58/0x220 [ 14.276583][ C2] simple_recursive_removal+0x6a/0x610 [ 14.276587][ C2] ? do_raw_spin_unlock+0x58/0x220 [ 14.276589][ C2] ? __pfx_remove_one+0x10/0x10 [ 14.276595][ C2] debugfs_remove+0x44/0x70 [ 14.276598][ C2] ref_tracker_dir_exit+0xcf/0x740 [ 14.276603][ C2] ? __pfx_ref_tracker_free+0x10/0x10 [ 14.276606][ C2] ? __sk_destruct+0x383/0x780 [ 14.276611][ C2] ? rcu_do_batch+0x34c/0xf20 [ 14.276615][ C2] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 14.276617][ C2] ? irq_exit_rcu+0xe/0x30 [ 14.276623][ C2] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 14.276627][ C2] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.276631][ C2] ? flush_tlb_mm_range+0xd5/0x600 [ 14.276634][ C2] ? ptep_clear_flush+0xea/0x120 [ 14.276640][ C2] ? wp_page_copy+0x550/0x11e0 [ 14.276645][ C2] ? handle_pte_fault+0x3ff/0x690 [ 14.276649][ C2] ? __handle_mm_fault+0x3fc/0x5e0 [ 14.276652][ C2] ? handle_mm_fault+0x200/0x420 [ 14.276655][ C2] ? do_user_addr_fault+0x576/0xe00 [ 14.276660][ C2] ? exc_page_fault+0x5d/0xc0 [ 14.276667][ C2] __put_net+0x19/0x60 [ 14.276672][ C2] __sk_destruct+0x58a/0x780 [ 14.276676][ C2] ? rcu_do_batch+0x34a/0xf20 [ 14.276679][ C2] rcu_do_batch+0x34c/0xf20 [ 14.276682][ C2] ? find_held_lock+0x2b/0x80 [ 14.276687][ C2] ? __pfx_rcu_do_batch+0x10/0x10 [ 14.276690][ C2] ? mark_held_locks+0x49/0x80 [ 14.276695][ C2] ? note_gp_changes+0x182/0x1e0 [ 14.276698][ C2] ? lockdep_hardirqs_on+0x7c/0x110 [ 14.276703][ C2] rcu_core+0x2bb/0x500 [ 14.276708][ C2] handle_softirqs+0x218/0x620 [ 14.276713][ C2] __irq_exit_rcu+0xfa/0x160 [ 14.276717][ C2] irq_exit_rcu+0xe/0x30 [ 14.276720][ C2] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 14.276723][ C2] [ 14.276724][ C2] [ 14.276726][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.276729][ C2] RIP: 0010:flush_tlb_mm_range+0xd5/0x600 [ 14.276733][ C2] Code: 08 84 d2 0f 85 cd 04 00 00 0f b7 85 90 08 00 00 8d 50 ff 66 83 fa 04 0f 86 50 03 00 00 66 85 c0 74 6b 4c 89 ff e8 6b d6 ff ff <65> ff 0d cc 6a 30 05 bf 01 00 00 00 e8 ca bf 0f 00 65 8b 05 e3 2d [ 14.276735][ C2] RSP: 0000:ffffc900004c7aa8 EFLAGS: 00000206 [ 14.276739][ C2] RAX: 00000000000008d7 RBX: 0000000000000002 RCX: 0000000000000040 [ 14.276741][ C2] RDX: 0000000000000000 RSI: ffffffff8a09175c RDI: ffffffff89853ca0 [ 14.276743][ C2] RBP: ffff88800ae36940 R08: 0000000000000001 R09: 0000000000000001 [ 14.276744][ C2] R10: ffffffff8afe7cd7 R11: ffff8880050bc230 R12: 000056501e646000 [ 14.276746][ C2] R13: 000056501e647000 R14: ffff88800ae372c0 R15: ffff88802f537c80 [ 14.276752][ C2] ? flush_tlb_mm_range+0x412/0x600 [ 14.276756][ C2] ptep_clear_flush+0xea/0x120 [ 14.276760][ C2] wp_page_copy+0x550/0x11e0 [ 14.276766][ C2] ? __pfx_wp_page_copy+0x10/0x10 [ 14.276769][ C2] ? __lock_release+0x5d/0x170 [ 14.276773][ C2] ? rcu_read_unlock+0x18/0x70 [ 14.276778][ C2] ? do_wp_page+0x876/0x1170 [ 14.276782][ C2] handle_pte_fault+0x3ff/0x690 [ 14.276786][ C2] ? __pfx_handle_pte_fault+0x10/0x10 [ 14.276790][ C2] ? reacquire_held_locks+0xd1/0x200 [ 14.276793][ C2] ? do_user_addr_fault+0x461/0xe00 [ 14.276797][ C2] __handle_mm_fault+0x3fc/0x5e0 [ 14.276800][ C2] ? __pfx___handle_mm_fault+0x10/0x10 [ 14.276803][ C2] ? __lock_release+0xa8/0x170 [ 14.276810][ C2] ? __pfx_lock_vma_under_rcu+0x10/0x10 [ 14.276813][ C2] handle_mm_fault+0x200/0x420 [ 14.276816][ C2] ? __pfx_handle_mm_fault+0x10/0x10 [ 14.276819][ C2] ? exc_page_fault+0x5d/0xc0 [ 14.276822][ C2] ? __lock_release+0x5d/0x170 [ 14.276827][ C2] do_user_addr_fault+0x576/0xe00 [ 14.276831][ C2] ? rcu_is_watching+0x12/0xc0 [ 14.276836][ C2] exc_page_fault+0x5d/0xc0 [ 14.276840][ C2] asm_exc_page_fault+0x26/0x30 [ 14.276842][ C2] RIP: 0033:0x564ff94247ac [ 14.276846][ C2] Code: 78 03 45 89 37 48 8b 44 24 08 45 31 f6 49 89 df 4c 8b 60 38 4d 85 e4 0f 84 c3 00 00 00 48 8b 4c 24 08 4c 89 e0 4d 8b 64 24 18 <48> 89 41 30 0f b6 00 83 e8 0c 3c 04 0f 87 c2 00 00 00 45 84 f6 0f [ 14.276848][ C2] RSP: 002b:00007ffcd4f7d8f0 EFLAGS: 00010206 [ 14.276850][ C2] RAX: 000056501e646d00 RBX: 000056501e66f6d0 RCX: 000056501e646ca0 [ 14.276852][ C2] RDX: 000056501e644710 RSI: 00007ffcd4f7d968 RDI: 0000000000000000 [ 14.276854][ C2] RBP: 000056501e636e30 R08: 0000000000000000 R09: 0000000000000000 [ 14.276855][ C2] R10: f070d8f38684c6f4 R11: 00007ffcd4f758b8 R12: 000056501e646d30 [ 14.276857][ C2] R13: 0000000000000009 R14: 0000000000000000 R15: 000056501e66f6d0 [ 14.276862][ C2] [ 14.817369][ C0] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 15.829592][ C0] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 15.831257][ C0] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 16.853514][ C0] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 16.855266][ C0] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 17.877589][ C0] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 17.879398][ C0] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 18.901518][ C0] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 18.903045][ C0] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 19.925499][ C0] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 19.927150][ C0] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 20.949557][ C0] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 22.116198][ T229] connect-deny_ip (229) used greatest stack depth: 24384 bytes left