[ 11.927655][ C0] clocksource: Watchdog remote CPU 2 read timed out [ 11.927698][ C0] [ 11.927700][ C0] ======================================================== [ 11.927701][ C0] WARNING: possible irq lock inversion dependency detected [ 11.927703][ C0] 7.2.0-virtme #1 Tainted: G W [ 11.927705][ C0] -------------------------------------------------------- [ 11.927705][ C0] make/158 just changed the state of lock: [ 11.927706][ C0] ffffffff86689760 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.927719][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 11.927720][ C0] (fs_reclaim){+.+.}-{0:0} [ 11.927722][ C0] [ 11.927722][ C0] [ 11.927722][ C0] and interrupts could create inverse lock ordering between them. [ 11.927722][ C0] [ 11.927723][ C0] [ 11.927723][ C0] other info that might help us debug this: [ 11.927723][ C0] Possible interrupt unsafe locking scenario: [ 11.927723][ C0] [ 11.927724][ C0] CPU0 CPU1 [ 11.927724][ C0] ---- ---- [ 11.927725][ C0] lock(fs_reclaim); [ 11.927726][ C0] local_irq_disable(); [ 11.927726][ C0] lock(console_owner); [ 11.927727][ C0] lock(fs_reclaim); [ 11.927728][ C0] [ 11.927728][ C0] lock(console_owner); [ 11.927729][ C0] [ 11.927729][ C0] *** DEADLOCK *** [ 11.927729][ C0] [ 11.927730][ C0] locks held by make/158: 4, last CPU#0: [ 11.927731][ C0] #0: ffa0000000007c90 ((&watchdog_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 11.927737][ C0] #1: ffffffff867fe9f8 (watchdog_lock){+.-.}-{3:3}, at: clocksource_watchdog+0x15/0x30 [ 11.927741][ C0] #2: ffffffff86799dc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.927745][ C0] #3: ffffffff86799e38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.927749][ C0] [ 11.927749][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 11.927753][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 11.927755][ C0] HARDIRQ-ON-W at: [ 11.927757][ C0] __lock_acquire+0x388/0xc20 [ 11.927760][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.927761][ C0] fs_reclaim_acquire+0xd5/0x120 [ 11.927765][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 11.927768][ C0] kthread_create_worker_on_node+0xea/0x210 [ 11.927771][ C0] workqueue_init+0x2a/0x680 [ 11.927774][ C0] kernel_init_freeable+0x2fe/0x630 [ 11.927777][ C0] kernel_init+0x21/0x150 [ 11.927780][ C0] ret_from_fork+0x474/0x6b0 [ 11.927783][ C0] ret_from_fork_asm+0x11/0x20 [ 11.927786][ C0] SOFTIRQ-ON-W at: [ 11.927787][ C0] __lock_acquire+0x388/0xc20 [ 11.927789][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.927790][ C0] fs_reclaim_acquire+0xd5/0x120 [ 11.927791][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 11.927793][ C0] kthread_create_worker_on_node+0xea/0x210 [ 11.927794][ C0] workqueue_init+0x2a/0x680 [ 11.927796][ C0] kernel_init_freeable+0x2fe/0x630 [ 11.927797][ C0] kernel_init+0x21/0x150 [ 11.927798][ C0] ret_from_fork+0x474/0x6b0 [ 11.927799][ C0] ret_from_fork_asm+0x11/0x20 [ 11.927801][ C0] INITIAL USE at: [ 11.927802][ C0] __lock_acquire+0x388/0xc20 [ 11.927803][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.927804][ C0] fs_reclaim_acquire+0xd5/0x120 [ 11.927806][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 11.927807][ C0] kthread_create_worker_on_node+0xea/0x210 [ 11.927809][ C0] workqueue_init+0x2a/0x680 [ 11.927810][ C0] kernel_init_freeable+0x2fe/0x630 [ 11.927811][ C0] kernel_init+0x21/0x150 [ 11.927812][ C0] ret_from_fork+0x474/0x6b0 [ 11.927813][ C0] ret_from_fork_asm+0x11/0x20 [ 11.927815][ C0] } [ 11.927815][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 11.927819][ C0] ... acquired at: [ 11.927820][ C0] __lock_acquire+0x518/0xc20 [ 11.927822][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.927823][ C0] fs_reclaim_acquire+0xd5/0x120 [ 11.927824][ C0] __kmalloc_noprof+0xd3/0x760 [ 11.927826][ C0] alloc_buf.isra.0+0x4b/0x260 [ 11.927830][ C0] put_chars+0x1e1/0x2f0 [ 11.927832][ C0] hvc_console_print+0x292/0x780 [ 11.927835][ C0] console_emit_next_record+0x252/0x4f0 [ 11.927837][ C0] console_flush_one_record+0x46f/0x710 [ 11.927838][ C0] console_unlock+0xee/0x1f0 [ 11.927840][ C0] vprintk_emit+0x37c/0x3e0 [ 11.927842][ C0] _printk+0xc7/0x100 [ 11.927845][ C0] ppp_init+0x16/0x100 [ 11.927847][ C0] do_one_initcall+0x124/0x4f0 [ 11.927848][ C0] kernel_init_freeable+0x596/0x630 [ 11.927850][ C0] kernel_init+0x21/0x150 [ 11.927851][ C0] ret_from_fork+0x474/0x6b0 [ 11.927852][ C0] ret_from_fork_asm+0x11/0x20 [ 11.927853][ C0] [ 11.927854][ C0] -> (console_owner){..-.}-{0:0} { [ 11.927856][ C0] IN-SOFTIRQ-W at: [ 11.927856][ C0] __lock_acquire+0x388/0xc20 [ 11.927858][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.927859][ C0] console_lock_spinning_enable+0x5c/0x60 [ 11.927861][ C0] console_emit_next_record+0x1f4/0x4f0 [ 11.927863][ C0] console_flush_one_record+0x46f/0x710 [ 11.927864][ C0] console_unlock+0xee/0x1f0 [ 11.927866][ C0] vprintk_emit+0x37c/0x3e0 [ 11.927867][ C0] _printk+0xc7/0x100 [ 11.927869][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 11.927871][ C0] call_timer_fn+0x160/0x4d0 [ 11.927873][ C0] __run_timers+0x68f/0xaa0 [ 11.927874][ C0] run_timer_softirq+0xf0/0x160 [ 11.927876][ C0] handle_softirqs+0x1d3/0x900 [ 11.927879][ C0] __irq_exit_rcu+0x145/0x1c0 [ 11.927880][ C0] irq_exit_rcu+0xe/0x30 [ 11.927881][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.927884][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.927886][ C0] _raw_spin_unlock_irqrestore+0x36/0x80 [ 11.927888][ C0] get_from_partial_node+0x21d/0x500 [ 11.927890][ C0] ___slab_alloc+0x71/0x2f0 [ 11.927892][ C0] kmem_cache_alloc_noprof+0x2fc/0x5c0 [ 11.927893][ C0] do_getname.isra.0+0x32/0x240 [ 11.927896][ C0] __x64_sys_chdir+0x9b/0x220 [ 11.927898][ C0] do_syscall_64+0xff/0x530 [ 11.927900][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.927901][ C0] INITIAL USE at: [ 11.927902][ C0] } [ 11.927903][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 11.927906][ C0] ... acquired at: [ 11.927906][ C0] mark_lock+0x1d7/0xa00 [ 11.927908][ C0] mark_usage+0x42/0x170 [ 11.927909][ C0] __lock_acquire+0x388/0xc20 [ 11.927910][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.927912][ C0] console_lock_spinning_enable+0x5c/0x60 [ 11.927913][ C0] console_emit_next_record+0x1f4/0x4f0 [ 11.927915][ C0] console_flush_one_record+0x46f/0x710 [ 11.927916][ C0] console_unlock+0xee/0x1f0 [ 11.927918][ C0] vprintk_emit+0x37c/0x3e0 [ 11.927920][ C0] _printk+0xc7/0x100 [ 11.927921][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 11.927922][ C0] call_timer_fn+0x160/0x4d0 [ 11.927924][ C0] __run_timers+0x68f/0xaa0 [ 11.927925][ C0] run_timer_softirq+0xf0/0x160 [ 11.927927][ C0] handle_softirqs+0x1d3/0x900 [ 11.927928][ C0] __irq_exit_rcu+0x145/0x1c0 [ 11.927929][ C0] irq_exit_rcu+0xe/0x30 [ 11.927930][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.927932][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.927933][ C0] _raw_spin_unlock_irqrestore+0x36/0x80 [ 11.927935][ C0] get_from_partial_node+0x21d/0x500 [ 11.927936][ C0] ___slab_alloc+0x71/0x2f0 [ 11.927938][ C0] kmem_cache_alloc_noprof+0x2fc/0x5c0 [ 11.927939][ C0] do_getname.isra.0+0x32/0x240 [ 11.927941][ C0] __x64_sys_chdir+0x9b/0x220 [ 11.927942][ C0] do_syscall_64+0xff/0x530 [ 11.927943][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.927945][ C0] [ 11.927945][ C0] [ 11.927945][ C0] stack backtrace: [ 11.927948][ C0] CPU: 0 UID: 0 PID: 158 Comm: make Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.927951][ C0] Tainted: [W]=WARN [ 11.927952][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.927953][ C0] Call Trace: [ 11.927955][ C0] [ 11.927956][ C0] dump_stack_lvl+0x6f/0xa0 [ 11.927960][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 11.927962][ C0] mark_lock_irq+0x989/0x9c0 [ 11.927964][ C0] ? add_lock_to_list+0x2c/0x1a0 [ 11.927967][ C0] mark_lock+0x1d7/0xa00 [ 11.927969][ C0] mark_usage+0x42/0x170 [ 11.927971][ C0] __lock_acquire+0x388/0xc20 [ 11.927973][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.927975][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 11.927977][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.927980][ C0] ? lock_acquire+0x13c/0x160 [ 11.927982][ C0] console_lock_spinning_enable+0x5c/0x60 [ 11.927984][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 11.927986][ C0] console_emit_next_record+0x1f4/0x4f0 [ 11.927988][ C0] ? devkmsg_read+0x4e0/0x4e0 [ 11.927990][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.927992][ C0] ? lock_acquire+0x13c/0x160 [ 11.927994][ C0] console_flush_one_record+0x46f/0x710 [ 11.927996][ C0] ? console_emit_next_record+0x4f0/0x4f0 [ 11.927998][ C0] ? __lock_acquire+0x518/0xc20 [ 11.928000][ C0] console_unlock+0xee/0x1f0 [ 11.928002][ C0] ? console_flush_one_record+0x710/0x710 [ 11.928004][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.928006][ C0] ? lock_acquire+0xa0/0x160 [ 11.928008][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.928010][ C0] ? vprintk_emit+0x320/0x3e0 [ 11.928012][ C0] vprintk_emit+0x37c/0x3e0 [ 11.928014][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 11.928017][ C0] ? clocksource_watchdog.part.0+0x4d0/0x540 [ 11.928018][ C0] _printk+0xc7/0x100 [ 11.928020][ C0] ? snapshot_read.cold+0x21/0x21 [ 11.928022][ C0] ? clocksource_watchdog.part.0+0x4d0/0x540 [ 11.928024][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.928026][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 11.928028][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.928029][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.928031][ C0] call_timer_fn+0x160/0x4d0 [ 11.928033][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 11.928035][ C0] ? debug_object_active_state+0x430/0x430 [ 11.928038][ C0] ? find_held_lock+0x2b/0x80 [ 11.928041][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.928042][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.928045][ C0] __run_timers+0x68f/0xaa0 [ 11.928046][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.928049][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 11.928051][ C0] ? __lock_acquire+0x518/0xc20 [ 11.928053][ C0] ? __rwlock_init+0x150/0x150 [ 11.928056][ C0] run_timer_softirq+0xf0/0x160 [ 11.928058][ C0] ? __run_timers+0xaa0/0xaa0 [ 11.928060][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.928063][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.928065][ C0] handle_softirqs+0x1d3/0x900 [ 11.928067][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.928068][ C0] ? _local_bh_enable+0xc0/0xc0 [ 11.928070][ C0] __irq_exit_rcu+0x145/0x1c0 [ 11.928072][ C0] irq_exit_rcu+0xe/0x30 [ 11.928074][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.928075][ C0] [ 11.928076][ C0] [ 11.928077][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.928079][ C0] RIP: 0010:_raw_spin_unlock_irqrestore+0x36/0x80 [ 11.928081][ C0] Code: f5 53 48 8b 74 24 10 48 89 fb 48 83 c7 18 e8 81 6b a3 fd 48 89 df e8 89 c1 a3 fd f7 c5 00 02 00 00 75 1f 9c 58 f6 c4 02 75 2f 01 00 00 00 e8 10 8b 95 fd 65 48 83 3d af ab 63 02 00 74 12 5b [ 11.928083][ C0] RSP: 0018:ffa00000007f7cf8 EFLAGS: 00000246 [ 11.928085][ C0] RAX: 0000000000000096 RBX: ff11000001950180 RCX: ffffffff85322483 [ 11.928086][ C0] RDX: ff1100000cc00040 RSI: ffffffff85cad54f RDI: ffffffff856913e0 [ 11.928087][ C0] RBP: 0000000000000246 R08: 0000000000000000 R09: 0000000000000000 [ 11.928088][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: ff11000001950180 [ 11.928089][ C0] R13: ffd4000000250c90 R14: ffd4000000250c80 R15: ff11000009433cc0 [ 11.928091][ C0] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 11.928093][ C0] get_from_partial_node+0x21d/0x500 [ 11.928096][ C0] ___slab_alloc+0x71/0x2f0 [ 11.928098][ C0] ? __pcs_replace_empty_main+0x42f/0x6a0 [ 11.928101][ C0] kmem_cache_alloc_noprof+0x2fc/0x5c0 [ 11.928102][ C0] ? do_getname.isra.0+0x32/0x240 [ 11.928105][ C0] do_getname.isra.0+0x32/0x240 [ 11.928106][ C0] __x64_sys_chdir+0x9b/0x220 [ 11.928108][ C0] ? finish_open+0xc0/0xc0 [ 11.928110][ C0] ? fpregs_restore_userregs+0x14b/0x300 [ 11.928112][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.928114][ C0] do_syscall_64+0xff/0x530 [ 11.928117][ C0] ? exc_page_fault+0xee/0x100 [ 11.928120][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.928123][ C0] RIP: 0033:0x7f8eda53b43b [ 11.928126][ C0] Code: 77 05 c3 0f 1f 40 00 48 8b 15 b9 a9 10 00 f7 d8 64 89 02 b8 ff ff ff ff c3 66 0f 1f 44 00 00 f3 0f 1e fa b8 50 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 8d a9 10 00 f7 d8 64 89 01 48 [ 11.928128][ C0] RSP: 002b:00007ffcaaf3a218 EFLAGS: 00000206 ORIG_RAX: 0000000000000050 [ 11.928130][ C0] RAX: ffffffffffffffda RBX: 00005625b07e1410 RCX: 00007f8eda53b43b [ 11.928132][ C0] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 00005625b07d3590 [ 11.928133][ C0] RBP: 00007ffcaaf3a230 R08: 0000000000000000 R09: 0000000000000000 [ 11.928134][ C0] R10: 0000000000000000 R11: 0000000000000206 R12: 0000000000000000 [ 11.928136][ C0] R13: 00007ffcaaf3bd58 R14: 0000000000000000 R15: 0000000000000001 [ 11.928139][ C0] [ 11.928143][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.928144][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 158, name: make [ 11.928146][ C0] preempt_count: 103, expected: 0 [ 11.928147][ C0] RCU nest depth: 0, expected: 0 [ 11.928147][ C0] INFO: lockdep is turned off. [ 11.928148][ C0] irq event stamp: 42147 [ 11.928148][ C0] hardirqs last enabled at (42146): [] __down_trylock_console_sem+0x86/0xa0 [ 11.928151][ C0] hardirqs last disabled at (42147): [] console_emit_next_record+0x3f8/0x4f0 [ 11.928153][ C0] softirqs last enabled at (42110): [] handle_softirqs+0x67c/0x900 [ 11.928154][ C0] softirqs last disabled at (42133): [] __irq_exit_rcu+0x145/0x1c0 [ 11.928156][ C0] Preemption disabled at: [ 11.928156][ C0] [<0000000000000000>] 0x0 [ 11.928159][ C0] CPU: 0 UID: 0 PID: 158 Comm: make Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.928161][ C0] Tainted: [W]=WARN [ 11.928161][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.928162][ C0] Call Trace: [ 11.928163][ C0] [ 11.928163][ C0] dump_stack_lvl+0x6f/0xa0 [ 11.928166][ C0] __might_resched.cold+0x1fe/0x2c1 [ 11.928169][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.928172][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.928174][ C0] __kmalloc_noprof+0x443/0x760 [ 11.928176][ C0] ? __rwlock_init+0x150/0x150 [ 11.928177][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 11.928180][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 11.928182][ C0] alloc_buf.isra.0+0x4b/0x260 [ 11.928184][ C0] put_chars+0x1e1/0x2f0 [ 11.928187][ C0] ? __send_to_port+0x420/0x420 [ 11.928190][ C0] hvc_console_print+0x292/0x780 [ 11.928192][ C0] ? mark_usage+0x42/0x170 [ 11.928193][ C0] ? __lock_acquire+0x388/0xc20 [ 11.928196][ C0] ? hvc_write+0x3a0/0x3a0 [ 11.928197][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 11.928199][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.928201][ C0] ? lock_acquire+0x13c/0x160 [ 11.928203][ C0] console_emit_next_record+0x252/0x4f0 [ 11.928205][ C0] ? devkmsg_read+0x4e0/0x4e0 [ 11.928208][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.928210][ C0] ? lock_acquire+0x13c/0x160 [ 11.928212][ C0] console_flush_one_record+0x46f/0x710 [ 11.928214][ C0] ? console_emit_next_record+0x4f0/0x4f0 [ 11.928216][ C0] ? __lock_acquire+0x518/0xc20 [ 11.928218][ C0] console_unlock+0xee/0x1f0 [ 11.928220][ C0] ? console_flush_one_record+0x710/0x710 [ 11.928222][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.928223][ C0] ? lock_acquire+0xa0/0x160 [ 11.928225][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.928227][ C0] ? vprintk_emit+0x320/0x3e0 [ 11.928229][ C0] vprintk_emit+0x37c/0x3e0 [ 11.928231][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 11.928234][ C0] ? clocksource_watchdog.part.0+0x4d0/0x540 [ 11.928236][ C0] _printk+0xc7/0x100 [ 11.928237][ C0] ? snapshot_read.cold+0x21/0x21 [ 11.928239][ C0] ? clocksource_watchdog.part.0+0x4d0/0x540 [ 11.928241][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.928243][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 11.928245][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.928246][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.928248][ C0] call_timer_fn+0x160/0x4d0 [ 11.928250][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 11.928252][ C0] ? debug_object_active_state+0x430/0x430 [ 11.928253][ C0] ? find_held_lock+0x2b/0x80 [ 11.928255][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.928257][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.928259][ C0] __run_timers+0x68f/0xaa0 [ 11.928261][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.928263][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 11.928265][ C0] ? __lock_acquire+0x518/0xc20 [ 11.928268][ C0] ? __rwlock_init+0x150/0x150 [ 11.928270][ C0] run_timer_softirq+0xf0/0x160 [ 11.928272][ C0] ? __run_timers+0xaa0/0xaa0 [ 11.928274][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.928275][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.928277][ C0] handle_softirqs+0x1d3/0x900 [ 11.928279][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.928281][ C0] ? _local_bh_enable+0xc0/0xc0 [ 11.928283][ C0] __irq_exit_rcu+0x145/0x1c0 [ 11.928284][ C0] irq_exit_rcu+0xe/0x30 [ 11.928286][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.928288][ C0] [ 11.928288][ C0] [ 11.928289][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.928290][ C0] RIP: 0010:_raw_spin_unlock_irqrestore+0x36/0x80 [ 11.928292][ C0] Code: f5 53 48 8b 74 24 10 48 89 fb 48 83 c7 18 e8 81 6b a3 fd 48 89 df e8 89 c1 a3 fd f7 c5 00 02 00 00 75 1f 9c 58 f6 c4 02 75 2f 01 00 00 00 e8 10 8b 95 fd 65 48 83 3d af ab 63 02 00 74 12 5b [ 11.928293][ C0] RSP: 0018:ffa00000007f7cf8 EFLAGS: 00000246 [ 11.928294][ C0] RAX: 0000000000000096 RBX: ff11000001950180 RCX: ffffffff85322483 [ 11.928295][ C0] RDX: ff1100000cc00040 RSI: ffffffff85cad54f RDI: ffffffff856913e0 [ 11.928296][ C0] RBP: 0000000000000246 R08: 0000000000000000 R09: 0000000000000000 [ 11.928297][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: ff11000001950180 [ 11.928297][ C0] R13: ffd4000000250c90 R14: ffd4000000250c80 R15: ff11000009433cc0 [ 11.928299][ C0] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 11.928302][ C0] get_from_partial_node+0x21d/0x500 [ 11.928304][ C0] ___slab_alloc+0x71/0x2f0 [ 11.928306][ C0] ? __pcs_replace_empty_main+0x42f/0x6a0 [ 11.928309][ C0] kmem_cache_alloc_noprof+0x2fc/0x5c0 [ 11.928311][ C0] ? do_getname.isra.0+0x32/0x240 [ 11.928313][ C0] do_getname.isra.0+0x32/0x240 [ 11.928315][ C0] __x64_sys_chdir+0x9b/0x220 [ 11.928317][ C0] ? finish_open+0xc0/0xc0 [ 11.928319][ C0] ? fpregs_restore_userregs+0x14b/0x300 [ 11.928320][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.928322][ C0] do_syscall_64+0xff/0x530 [ 11.928324][ C0] ? exc_page_fault+0xee/0x100 [ 11.928326][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.928327][ C0] RIP: 0033:0x7f8eda53b43b [ 11.928328][ C0] Code: 77 05 c3 0f 1f 40 00 48 8b 15 b9 a9 10 00 f7 d8 64 89 02 b8 ff ff ff ff c3 66 0f 1f 44 00 00 f3 0f 1e fa b8 50 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 8d a9 10 00 f7 d8 64 89 01 48 [ 11.928329][ C0] RSP: 002b:00007ffcaaf3a218 EFLAGS: 00000206 ORIG_RAX: 0000000000000050 [ 11.928330][ C0] RAX: ffffffffffffffda RBX: 00005625b07e1410 RCX: 00007f8eda53b43b [ 11.928331][ C0] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 00005625b07d3590 [ 11.928332][ C0] RBP: 00007ffcaaf3a230 R08: 0000000000000000 R09: 0000000000000000 [ 11.928332][ C0] R10: 0000000000000000 R11: 0000000000000206 R12: 0000000000000000 [ 11.928333][ C0] R13: 00007ffcaaf3bd58 R14: 0000000000000000 R15: 0000000000000001 [ 11.928335][ C0] [ 13.040457][ T86] (udev-worker) (86) used greatest stack depth: 22696 bytes left [ 13.040472][ T86] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.040475][ T86] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 86, name: (udev-worker) [ 13.040477][ T86] preempt_count: 2, expected: 0 [ 13.040478][ T86] RCU nest depth: 0, expected: 0 [ 13.040479][ T86] INFO: lockdep is turned off. [ 13.040480][ T86] irq event stamp: 395026 [ 13.040481][ T86] hardirqs last enabled at (395025): [] _raw_spin_unlock_irq+0x28/0x50 [ 13.040490][ T86] hardirqs last disabled at (395026): [] __schedule+0x1246/0x20e0 [ 13.040493][ T86] softirqs last enabled at (394960): [] unix_release_sock+0x446/0xe50 [ 13.040496][ T86] softirqs last disabled at (394958): [] unix_release_sock+0x39f/0xe50 [ 13.040498][ T86] Preemption disabled at: [ 13.040499][ T86] [<0000000000000000>] 0x0 [ 13.040508][ T86] CPU: 2 UID: 0 PID: 86 Comm: (udev-worker) Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.040512][ T86] Tainted: [W]=WARN [ 13.040513][ T86] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.040515][ T86] Call Trace: [ 13.040516][ T86] [ 13.040518][ T86] dump_stack_lvl+0x6f/0xa0 [ 13.040524][ T86] __might_resched.cold+0x1fe/0x2c1 [ 13.040528][ T86] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.040533][ T86] ? rcu_is_watching+0x16/0xd0 [ 13.040537][ T86] __kmalloc_noprof+0x443/0x760 [ 13.040541][ T86] ? __rwlock_init+0x150/0x150 [ 13.040544][ T86] ? alloc_buf.isra.0+0x4b/0x260 [ 13.040549][ T86] ? do_raw_spin_unlock+0x59/0x250 [ 13.040551][ T86] alloc_buf.isra.0+0x4b/0x260 [ 13.040554][ T86] put_chars+0x1e1/0x2f0 [ 13.040556][ T86] ? __send_to_port+0x420/0x420 [ 13.040558][ T86] ? printk_get_next_message+0x2fe/0x7d0 [ 13.040562][ T86] ? console_prepend_replay+0x20/0x20 [ 13.040564][ T86] ? desc_read+0x219/0x2f0 [ 13.040566][ T86] hvc_console_print+0x292/0x780 [ 13.040571][ T86] ? hvc_write+0x3a0/0x3a0 [ 13.040573][ T86] ? __rwlock_init+0x150/0x150 [ 13.040575][ T86] ? rcu_is_watching+0x16/0xd0 [ 13.040576][ T86] ? rcu_is_watching+0x16/0xd0 [ 13.040578][ T86] ? lock_acquire+0x13c/0x160 [ 13.040581][ T86] console_emit_next_record+0x252/0x4f0 [ 13.040583][ T86] ? devkmsg_read+0x4e0/0x4e0 [ 13.040585][ T86] ? _prb_read_valid+0x6e0/0x6e0 [ 13.040587][ T86] ? __asan_memmove+0x3c/0x60 [ 13.040590][ T86] ? rcu_is_watching+0x16/0xd0 [ 13.040592][ T86] ? rcu_is_watching+0x16/0xd0 [ 13.040593][ T86] ? rcu_is_watching+0x16/0xd0 [ 13.040595][ T86] ? lock_acquire+0x13c/0x160 [ 13.040597][ T86] ? console_flush_one_record+0x111/0x710 [ 13.040599][ T86] console_flush_one_record+0x46f/0x710 [ 13.040602][ T86] ? console_emit_next_record+0x4f0/0x4f0 [ 13.040605][ T86] console_unlock+0xee/0x1f0 [ 13.040606][ T86] ? lock_acquire+0x13c/0x160 [ 13.040608][ T86] ? console_flush_one_record+0x710/0x710 [ 13.040610][ T86] ? rcu_is_watching+0x16/0xd0 [ 13.040612][ T86] ? lock_release+0x184/0x1f0 [ 13.040613][ T86] ? lock_acquire+0xa0/0x160 [ 13.040615][ T86] ? sync_exp_reset_tree_hotplug+0x3e0/0x3f0 [ 13.040618][ T86] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.040619][ T86] ? vprintk_emit+0x320/0x3e0 [ 13.040622][ T86] vprintk_emit+0x37c/0x3e0 [ 13.040625][ T86] ? wake_up_klogd_work_func+0x90/0x90 [ 13.040627][ T86] ? do_raw_read_unlock+0x70/0x70 [ 13.040629][ T86] ? forget_original_parent+0x5c/0xdb0 [ 13.040632][ T86] _printk+0xc7/0x100 [ 13.040635][ T86] ? snapshot_read.cold+0x21/0x21 [ 13.040637][ T86] ? do_raw_spin_lock+0x131/0x280 [ 13.040638][ T86] ? do_raw_spin_lock+0x131/0x280 [ 13.040640][ T86] ? __rwlock_init+0x150/0x150 [ 13.040643][ T86] ? do_raw_spin_lock+0x131/0x280 [ 13.040645][ T86] do_exit.cold+0x82/0x9c [ 13.040648][ T86] ? exit_notify+0x890/0x890 [ 13.040649][ T86] ? posixtimer_sig_unignore.isra.0+0x5f0/0x5f0 [ 13.040652][ T86] ? rcu_is_watching+0x16/0xd0 [ 13.040655][ T86] do_group_exit+0xb8/0x370 [ 13.040656][ T86] __x64_sys_exit_group+0x3c/0x50 [ 13.040658][ T86] x64_sys_call+0x1567/0x1570 [ 13.040660][ T86] do_syscall_64+0xff/0x530 [ 13.040663][ T86] ? exc_page_fault+0xee/0x100 [ 13.040665][ T86] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 13.040667][ T86] RIP: 0033:0x7fe5182e71b8 [ 13.040669][ T86] Code: Unable to access opcode bytes at 0x7fe5182e718e. [ 13.040671][ T86] RSP: 002b:00007ffef84cc828 EFLAGS: 00000256 ORIG_RAX: 00000000000000e7 [ 13.040674][ T86] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007fe5182e71b8 [ 13.040676][ T86] RDX: 0000000000000000 RSI: fffffffffffffe90 RDI: 0000000000000000 [ 13.040677][ T86] RBP: 00007ffef84cc9b0 R08: 000055828e19e048 R09: 0000000000000000 [ 13.040678][ T86] R10: 0000000000000000 R11: 0000000000000256 R12: 0000000000000000 [ 13.040679][ T86] R13: 00007fe517b45050 R14: 00007fe518818d9e R15: 000055828e03b190 [ 13.040681][ T86]