[ 11.163661][ C0] clocksource: Marking clocksource tsc unstable due to frequency skew [ 11.163706][ C0] [ 11.163708][ C0] ======================================================== [ 11.163709][ C0] WARNING: possible irq lock inversion dependency detected [ 11.163711][ C0] 7.2.0-virtme #1 Tainted: G W [ 11.163713][ C0] -------------------------------------------------------- [ 11.163713][ C0] kworker/0:0/9 just changed the state of lock: [ 11.163715][ C0] ffffffffb1c9d760 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.163728][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 11.163729][ C0] (fs_reclaim){+.+.}-{0:0} [ 11.163731][ C0] [ 11.163731][ C0] [ 11.163731][ C0] and interrupts could create inverse lock ordering between them. [ 11.163731][ C0] [ 11.163732][ C0] [ 11.163732][ C0] other info that might help us debug this: [ 11.163732][ C0] Possible interrupt unsafe locking scenario: [ 11.163732][ C0] [ 11.163733][ C0] CPU0 CPU1 [ 11.163733][ C0] ---- ---- [ 11.163734][ C0] lock(fs_reclaim); [ 11.163735][ C0] local_irq_disable(); [ 11.163735][ C0] lock(console_owner); [ 11.163737][ C0] lock(fs_reclaim); [ 11.163737][ C0] [ 11.163738][ C0] lock(console_owner); [ 11.163738][ C0] [ 11.163738][ C0] *** DEADLOCK *** [ 11.163738][ C0] [ 11.163739][ C0] locks held by kworker/0:0/9: 6, last CPU#0: [ 11.163740][ C0] #0: ffffffffb1fc5fb8 (remove_cache_srcu){.+.+}-{0:0}, at: kasan_quarantine_reduce+0x84/0x240 [ 11.163746][ C0] #1: ffffffffb1d94c00 (rcu_read_lock){....}-{1:3}, at: unwind_next_frame+0x17e/0x1ea0 [ 11.163751][ C0] #2: ffa0000000007c90 ((&watchdog_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 11.163756][ C0] #3: ffffffffb1de29f8 (watchdog_lock){+.-.}-{3:3}, at: clocksource_watchdog+0x15/0x30 [ 11.163760][ C0] #4: ffffffffb1d7ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.163763][ C0] #5: ffffffffb1d7de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.163766][ C0] [ 11.163766][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 11.163771][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 11.163773][ C0] HARDIRQ-ON-W at: [ 11.163774][ C0] __lock_acquire+0x388/0xc20 [ 11.163778][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.163779][ C0] fs_reclaim_acquire+0xd5/0x120 [ 11.163782][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 11.163784][ C0] kthread_create_worker_on_node+0xea/0x210 [ 11.163787][ C0] workqueue_init+0x2a/0x680 [ 11.163791][ C0] kernel_init_freeable+0x2fe/0x630 [ 11.163794][ C0] kernel_init+0x21/0x150 [ 11.163798][ C0] ret_from_fork+0x474/0x6b0 [ 11.163801][ C0] ret_from_fork_asm+0x11/0x20 [ 11.163804][ C0] SOFTIRQ-ON-W at: [ 11.163805][ C0] __lock_acquire+0x388/0xc20 [ 11.163806][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.163808][ C0] fs_reclaim_acquire+0xd5/0x120 [ 11.163809][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 11.163810][ C0] kthread_create_worker_on_node+0xea/0x210 [ 11.163812][ C0] workqueue_init+0x2a/0x680 [ 11.163814][ C0] kernel_init_freeable+0x2fe/0x630 [ 11.163815][ C0] kernel_init+0x21/0x150 [ 11.163816][ C0] ret_from_fork+0x474/0x6b0 [ 11.163818][ C0] ret_from_fork_asm+0x11/0x20 [ 11.163819][ C0] INITIAL USE at: [ 11.163820][ C0] __lock_acquire+0x388/0xc20 [ 11.163821][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.163823][ C0] fs_reclaim_acquire+0xd5/0x120 [ 11.163824][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 11.163825][ C0] kthread_create_worker_on_node+0xea/0x210 [ 11.163826][ C0] workqueue_init+0x2a/0x680 [ 11.163828][ C0] kernel_init_freeable+0x2fe/0x630 [ 11.163829][ C0] kernel_init+0x21/0x150 [ 11.163831][ C0] ret_from_fork+0x474/0x6b0 [ 11.163832][ C0] ret_from_fork_asm+0x11/0x20 [ 11.163833][ C0] } [ 11.163834][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 11.163838][ C0] ... acquired at: [ 11.163838][ C0] __lock_acquire+0x518/0xc20 [ 11.163840][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.163841][ C0] fs_reclaim_acquire+0xd5/0x120 [ 11.163843][ C0] __kmalloc_noprof+0xd3/0x760 [ 11.163844][ C0] alloc_buf.isra.0+0x4b/0x260 [ 11.163848][ C0] put_chars+0x1e1/0x2f0 [ 11.163849][ C0] hvc_console_print+0x292/0x780 [ 11.163852][ C0] console_emit_next_record+0x22f/0x4c0 [ 11.163854][ C0] console_flush_one_record+0x46f/0x710 [ 11.163855][ C0] console_unlock+0xee/0x1f0 [ 11.163857][ C0] vprintk_emit+0x37c/0x3e0 [ 11.163858][ C0] _printk+0xc7/0x100 [ 11.163861][ C0] i8042_pnp_init+0xf7/0x3c0 [ 11.163864][ C0] i8042_platform_init+0x3f9/0x460 [ 11.163865][ C0] i8042_init+0x45/0x130 [ 11.163867][ C0] do_one_initcall+0x124/0x4f0 [ 11.163868][ C0] kernel_init_freeable+0x596/0x630 [ 11.163869][ C0] kernel_init+0x21/0x150 [ 11.163871][ C0] ret_from_fork+0x474/0x6b0 [ 11.163872][ C0] ret_from_fork_asm+0x11/0x20 [ 11.163873][ C0] [ 11.163874][ C0] -> (console_owner){..-.}-{0:0} { [ 11.163875][ C0] IN-SOFTIRQ-W at: [ 11.163876][ C0] __lock_acquire+0x388/0xc20 [ 11.163878][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.163879][ C0] console_lock_spinning_enable+0x5c/0x60 [ 11.163881][ C0] console_emit_next_record+0x1d1/0x4c0 [ 11.163882][ C0] console_flush_one_record+0x46f/0x710 [ 11.163884][ C0] console_unlock+0xee/0x1f0 [ 11.163886][ C0] vprintk_emit+0x37c/0x3e0 [ 11.163887][ C0] _printk+0xc7/0x100 [ 11.163888][ C0] clocksource_watchdog.part.0.cold+0x32/0x1dd [ 11.163890][ C0] call_timer_fn+0x160/0x4d0 [ 11.163892][ C0] __run_timers+0x68f/0xaa0 [ 11.163893][ C0] run_timer_softirq+0xf0/0x160 [ 11.163895][ C0] handle_softirqs+0x1d3/0x900 [ 11.163897][ C0] __irq_exit_rcu+0x145/0x1c0 [ 11.163899][ C0] irq_exit_rcu+0xe/0x30 [ 11.163900][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.163902][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.163904][ C0] lock_acquire.part.0+0x112/0x280 [ 11.163905][ C0] unwind_next_frame+0x192/0x1ea0 [ 11.163906][ C0] arch_stack_walk+0xd7/0x130 [ 11.163908][ C0] stack_trace_save+0x93/0xc0 [ 11.163910][ C0] set_track_prepare+0x62/0x90 [ 11.163911][ C0] free_to_partial_list+0x1c6/0x310 [ 11.163913][ C0] qlist_free_all+0x5c/0x110 [ 11.163915][ C0] kasan_quarantine_reduce+0x196/0x240 [ 11.163916][ C0] __kasan_slab_alloc+0x4b/0x70 [ 11.163918][ C0] __kmalloc_cache_node_noprof+0x258/0x660 [ 11.163919][ C0] create_worker+0x122/0x770 [ 11.163922][ C0] worker_thread+0x765/0xd60 [ 11.163924][ C0] kthread+0x367/0x460 [ 11.163926][ C0] ret_from_fork+0x474/0x6b0 [ 11.163927][ C0] ret_from_fork_asm+0x11/0x20 [ 11.163928][ C0] INITIAL USE at: [ 11.163929][ C0] } [ 11.163930][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 11.163932][ C0] ... acquired at: [ 11.163932][ C0] mark_lock+0x1d7/0xa00 [ 11.163934][ C0] mark_usage+0x42/0x170 [ 11.163935][ C0] __lock_acquire+0x388/0xc20 [ 11.163936][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.163938][ C0] console_lock_spinning_enable+0x5c/0x60 [ 11.163939][ C0] console_emit_next_record+0x1d1/0x4c0 [ 11.163941][ C0] console_flush_one_record+0x46f/0x710 [ 11.163943][ C0] console_unlock+0xee/0x1f0 [ 11.163944][ C0] vprintk_emit+0x37c/0x3e0 [ 11.163945][ C0] _printk+0xc7/0x100 [ 11.163946][ C0] clocksource_watchdog.part.0.cold+0x32/0x1dd [ 11.163947][ C0] call_timer_fn+0x160/0x4d0 [ 11.163949][ C0] __run_timers+0x68f/0xaa0 [ 11.163950][ C0] run_timer_softirq+0xf0/0x160 [ 11.163952][ C0] handle_softirqs+0x1d3/0x900 [ 11.163953][ C0] __irq_exit_rcu+0x145/0x1c0 [ 11.163955][ C0] irq_exit_rcu+0xe/0x30 [ 11.163956][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.163957][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.163958][ C0] lock_acquire.part.0+0x112/0x280 [ 11.163960][ C0] unwind_next_frame+0x192/0x1ea0 [ 11.163961][ C0] arch_stack_walk+0xd7/0x130 [ 11.163962][ C0] stack_trace_save+0x93/0xc0 [ 11.163963][ C0] set_track_prepare+0x62/0x90 [ 11.163964][ C0] free_to_partial_list+0x1c6/0x310 [ 11.163966][ C0] qlist_free_all+0x5c/0x110 [ 11.163967][ C0] kasan_quarantine_reduce+0x196/0x240 [ 11.163968][ C0] __kasan_slab_alloc+0x4b/0x70 [ 11.163969][ C0] __kmalloc_cache_node_noprof+0x258/0x660 [ 11.163971][ C0] create_worker+0x122/0x770 [ 11.163972][ C0] worker_thread+0x765/0xd60 [ 11.163973][ C0] kthread+0x367/0x460 [ 11.163975][ C0] ret_from_fork+0x474/0x6b0 [ 11.163976][ C0] ret_from_fork_asm+0x11/0x20 [ 11.163977][ C0] [ 11.163978][ C0] [ 11.163978][ C0] stack backtrace: [ 11.163981][ C0] CPU: 0 UID: 0 PID: 9 Comm: kworker/0:0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.163984][ C0] Tainted: [W]=WARN [ 11.163985][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.163987][ C0] Workqueue: 0x0 (events) [ 11.163992][ C0] Call Trace: [ 11.163993][ C0] [ 11.163995][ C0] dump_stack_lvl+0x6f/0xa0 [ 11.164000][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 11.164002][ C0] mark_lock_irq+0x989/0x9c0 [ 11.164004][ C0] ? add_lock_to_list+0x2c/0x1a0 [ 11.164007][ C0] mark_lock+0x1d7/0xa00 [ 11.164009][ C0] mark_usage+0x42/0x170 [ 11.164011][ C0] __lock_acquire+0x388/0xc20 [ 11.164013][ C0] lock_acquire.part.0+0xd4/0x280 [ 11.164015][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 11.164017][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.164019][ C0] ? lock_acquire+0x13c/0x160 [ 11.164021][ C0] console_lock_spinning_enable+0x5c/0x60 [ 11.164023][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 11.164025][ C0] console_emit_next_record+0x1d1/0x4c0 [ 11.164027][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 11.164029][ C0] ? console_flush_one_record+0x106/0x710 [ 11.164031][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.164032][ C0] ? lock_acquire+0x13c/0x160 [ 11.164034][ C0] console_flush_one_record+0x46f/0x710 [ 11.164036][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 11.164038][ C0] ? __lock_acquire+0x518/0xc20 [ 11.164040][ C0] console_unlock+0xee/0x1f0 [ 11.164042][ C0] ? console_flush_one_record+0x710/0x710 [ 11.164044][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.164045][ C0] ? lock_acquire+0xe0/0x160 [ 11.164047][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.164049][ C0] ? vprintk_emit+0x320/0x3e0 [ 11.164050][ C0] vprintk_emit+0x37c/0x3e0 [ 11.164052][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 11.164053][ C0] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.164055][ C0] ? validate_chain+0x38b/0xc20 [ 11.164057][ C0] ? validate_chain+0x38b/0xc20 [ 11.164059][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 11.164060][ C0] _printk+0xc7/0x100 [ 11.164062][ C0] ? snapshot_read.cold+0x21/0x21 [ 11.164064][ C0] ? watchdog_check_freq+0x2d5/0x5c0 [ 11.164067][ C0] clocksource_watchdog.part.0.cold+0x32/0x1dd [ 11.164068][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.164070][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.164076][ C0] call_timer_fn+0x160/0x4d0 [ 11.164079][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 11.164080][ C0] ? debug_object_active_state+0x430/0x430 [ 11.164083][ C0] ? find_held_lock+0x2b/0x80 [ 11.164085][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.164087][ C0] ? mark_held_locks+0x40/0x70 [ 11.164089][ C0] __run_timers+0x68f/0xaa0 [ 11.164091][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.164093][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 11.164095][ C0] ? __lock_acquire+0x518/0xc20 [ 11.164098][ C0] ? __rwlock_init+0x150/0x150 [ 11.164100][ C0] run_timer_softirq+0xf0/0x160 [ 11.164102][ C0] ? __run_timers+0xaa0/0xaa0 [ 11.164104][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.164105][ C0] handle_softirqs+0x1d3/0x900 [ 11.164107][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.164109][ C0] ? _local_bh_enable+0xc0/0xc0 [ 11.164111][ C0] __irq_exit_rcu+0x145/0x1c0 [ 11.164113][ C0] irq_exit_rcu+0xe/0x30 [ 11.164114][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.164116][ C0] [ 11.164116][ C0] [ 11.164117][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.164118][ C0] RIP: 0010:lock_acquire.part.0+0x112/0x280 [ 11.164121][ C0] Code: ff 65 0f c1 05 7f 77 ed 04 83 f8 01 4c 8b 14 24 0f 85 35 01 00 00 9c 58 f6 c4 02 0f 85 52 01 00 00 4d 85 d2 0f 85 1b 01 00 00 <48> 8b 44 24 30 65 48 2b 05 51 32 ed 04 0f 85 48 01 00 00 48 83 c4 [ 11.164123][ C0] RSP: 0018:ffa0000000097840 EFLAGS: 00000206 [ 11.164125][ C0] RAX: 0000000000000046 RBX: 0000000000000000 RCX: d4373e0790ed7b28 [ 11.164126][ C0] RDX: 0000000000000000 RSI: ffffffffb12f9f03 RDI: ffffffffb0c949e0 [ 11.164127][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ff11000001b45278 [ 11.164128][ C0] R10: 0000000000000200 R11: 0000000000000001 R12: ffffffffb1d94c00 [ 11.164129][ C0] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000002 [ 11.164131][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.164133][ C0] ? lock_acquire+0x13c/0x160 [ 11.164135][ C0] unwind_next_frame+0x192/0x1ea0 [ 11.164136][ C0] ? unwind_next_frame+0x17e/0x1ea0 [ 11.164137][ C0] ? stack_trace_save+0x93/0xc0 [ 11.164140][ C0] ? stack_access_ok+0x1e0/0x1e0 [ 11.164141][ C0] ? __lock_acquire+0x518/0xc20 [ 11.164143][ C0] ? __unwind_start+0x42e/0x900 [ 11.164144][ C0] ? write_profile+0xf0/0xf0 [ 11.164146][ C0] arch_stack_walk+0xd7/0x130 [ 11.164148][ C0] ? stack_trace_save+0x93/0xc0 [ 11.164149][ C0] stack_trace_save+0x93/0xc0 [ 11.164151][ C0] ? filter_irq_stacks+0xd0/0xd0 [ 11.164153][ C0] set_track_prepare+0x62/0x90 [ 11.164156][ C0] free_to_partial_list+0x1c6/0x310 [ 11.164158][ C0] ? qlist_free_all+0x57/0x110 [ 11.164160][ C0] qlist_free_all+0x5c/0x110 [ 11.164162][ C0] kasan_quarantine_reduce+0x196/0x240 [ 11.164164][ C0] __kasan_slab_alloc+0x4b/0x70 [ 11.164165][ C0] __kmalloc_cache_node_noprof+0x258/0x660 [ 11.164167][ C0] ? create_worker+0x122/0x770 [ 11.164169][ C0] create_worker+0x122/0x770 [ 11.164171][ C0] ? worker_attach_to_pool+0x420/0x420 [ 11.164172][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 11.164174][ C0] ? add_timer_on+0x580/0x580 [ 11.164175][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.164177][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.164179][ C0] worker_thread+0x765/0xd60 [ 11.164182][ C0] ? rescuer_thread+0x1340/0x1340 [ 11.164183][ C0] kthread+0x367/0x460 [ 11.164185][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.164188][ C0] ? kthread_affine_preferred+0x4c0/0x4c0 [ 11.164190][ C0] ret_from_fork+0x474/0x6b0 [ 11.164191][ C0] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 11.164193][ C0] ? __switch_to+0x5a3/0xe00 [ 11.164196][ C0] ? kthread_affine_preferred+0x4c0/0x4c0 [ 11.164198][ C0] ret_from_fork_asm+0x11/0x20 [ 11.164201][ C0] [ 11.164206][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.164207][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 9, name: kworker/0:0 [ 11.164208][ C0] preempt_count: 102, expected: 0 [ 11.164209][ C0] RCU nest depth: 1, expected: 0 [ 11.164210][ C0] INFO: lockdep is turned off. [ 11.164211][ C0] irq event stamp: 691 [ 11.164211][ C0] hardirqs last enabled at (690): [] __down_trylock_console_sem+0x86/0xa0 [ 11.164214][ C0] hardirqs last disabled at (691): [] console_emit_next_record+0x3d4/0x4c0 [ 11.164216][ C0] softirqs last enabled at (0): [] copy_process+0x1d8f/0x62b0 [ 11.164218][ C0] softirqs last disabled at (663): [] __irq_exit_rcu+0x145/0x1c0 [ 11.164220][ C0] Preemption disabled at: [ 11.164220][ C0] [] handle_softirqs+0xf6/0x900 [ 11.164223][ C0] CPU: 0 UID: 0 PID: 9 Comm: kworker/0:0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.164225][ C0] Tainted: [W]=WARN [ 11.164226][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.164226][ C0] Workqueue: 0x0 (events) [ 11.164228][ C0] Call Trace: [ 11.164229][ C0] [ 11.164229][ C0] dump_stack_lvl+0x6f/0xa0 [ 11.164232][ C0] ? handle_softirqs+0xf6/0x900 [ 11.164233][ C0] __might_resched.cold+0x1fe/0x2c1 [ 11.164236][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.164239][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.164240][ C0] __kmalloc_noprof+0x443/0x760 [ 11.164242][ C0] ? __rwlock_init+0x150/0x150 [ 11.164243][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 11.164246][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 11.164247][ C0] alloc_buf.isra.0+0x4b/0x260 [ 11.164250][ C0] put_chars+0x1e1/0x2f0 [ 11.164251][ C0] ? __send_to_port+0x420/0x420 [ 11.164253][ C0] ? mark_lock+0x1d7/0xa00 [ 11.164255][ C0] hvc_console_print+0x292/0x780 [ 11.164258][ C0] ? hvc_write+0x3a0/0x3a0 [ 11.164260][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.164261][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.164263][ C0] console_emit_next_record+0x22f/0x4c0 [ 11.164265][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 11.164267][ C0] ? console_flush_one_record+0x106/0x710 [ 11.164269][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.164270][ C0] ? lock_acquire+0x13c/0x160 [ 11.164272][ C0] console_flush_one_record+0x46f/0x710 [ 11.164275][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 11.164276][ C0] ? __lock_acquire+0x518/0xc20 [ 11.164279][ C0] console_unlock+0xee/0x1f0 [ 11.164281][ C0] ? console_flush_one_record+0x710/0x710 [ 11.164282][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.164283][ C0] ? lock_acquire+0xe0/0x160 [ 11.164285][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.164287][ C0] ? vprintk_emit+0x320/0x3e0 [ 11.164288][ C0] vprintk_emit+0x37c/0x3e0 [ 11.164290][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 11.164291][ C0] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.164292][ C0] ? validate_chain+0x38b/0xc20 [ 11.164294][ C0] ? validate_chain+0x38b/0xc20 [ 11.164295][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 11.164297][ C0] _printk+0xc7/0x100 [ 11.164299][ C0] ? snapshot_read.cold+0x21/0x21 [ 11.164301][ C0] ? watchdog_check_freq+0x2d5/0x5c0 [ 11.164303][ C0] clocksource_watchdog.part.0.cold+0x32/0x1dd [ 11.164305][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.164306][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.164308][ C0] call_timer_fn+0x160/0x4d0 [ 11.164310][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 11.164312][ C0] ? debug_object_active_state+0x430/0x430 [ 11.164313][ C0] ? find_held_lock+0x2b/0x80 [ 11.164315][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.164317][ C0] ? mark_held_locks+0x40/0x70 [ 11.164319][ C0] __run_timers+0x68f/0xaa0 [ 11.164321][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 11.164323][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 11.164325][ C0] ? __lock_acquire+0x518/0xc20 [ 11.164327][ C0] ? __rwlock_init+0x150/0x150 [ 11.164330][ C0] run_timer_softirq+0xf0/0x160 [ 11.164332][ C0] ? __run_timers+0xaa0/0xaa0 [ 11.164334][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.164335][ C0] handle_softirqs+0x1d3/0x900 [ 11.164337][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.164338][ C0] ? _local_bh_enable+0xc0/0xc0 [ 11.164340][ C0] __irq_exit_rcu+0x145/0x1c0 [ 11.164342][ C0] irq_exit_rcu+0xe/0x30 [ 11.164343][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.164345][ C0] [ 11.164345][ C0] [ 11.164346][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.164347][ C0] RIP: 0010:lock_acquire.part.0+0x112/0x280 [ 11.164349][ C0] Code: ff 65 0f c1 05 7f 77 ed 04 83 f8 01 4c 8b 14 24 0f 85 35 01 00 00 9c 58 f6 c4 02 0f 85 52 01 00 00 4d 85 d2 0f 85 1b 01 00 00 <48> 8b 44 24 30 65 48 2b 05 51 32 ed 04 0f 85 48 01 00 00 48 83 c4 [ 11.164350][ C0] RSP: 0018:ffa0000000097840 EFLAGS: 00000206 [ 11.164351][ C0] RAX: 0000000000000046 RBX: 0000000000000000 RCX: d4373e0790ed7b28 [ 11.164352][ C0] RDX: 0000000000000000 RSI: ffffffffb12f9f03 RDI: ffffffffb0c949e0 [ 11.164353][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ff11000001b45278 [ 11.164353][ C0] R10: 0000000000000200 R11: 0000000000000001 R12: ffffffffb1d94c00 [ 11.164354][ C0] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000002 [ 11.164356][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.164357][ C0] ? lock_acquire+0x13c/0x160 [ 11.164359][ C0] unwind_next_frame+0x192/0x1ea0 [ 11.164361][ C0] ? unwind_next_frame+0x17e/0x1ea0 [ 11.164362][ C0] ? stack_trace_save+0x93/0xc0 [ 11.164364][ C0] ? stack_access_ok+0x1e0/0x1e0 [ 11.164365][ C0] ? __lock_acquire+0x518/0xc20 [ 11.164367][ C0] ? __unwind_start+0x42e/0x900 [ 11.164369][ C0] ? write_profile+0xf0/0xf0 [ 11.164370][ C0] arch_stack_walk+0xd7/0x130 [ 11.164372][ C0] ? stack_trace_save+0x93/0xc0 [ 11.164374][ C0] stack_trace_save+0x93/0xc0 [ 11.164375][ C0] ? filter_irq_stacks+0xd0/0xd0 [ 11.164377][ C0] set_track_prepare+0x62/0x90 [ 11.164380][ C0] free_to_partial_list+0x1c6/0x310 [ 11.164382][ C0] ? qlist_free_all+0x57/0x110 [ 11.164384][ C0] qlist_free_all+0x5c/0x110 [ 11.164386][ C0] kasan_quarantine_reduce+0x196/0x240 [ 11.164388][ C0] __kasan_slab_alloc+0x4b/0x70 [ 11.164389][ C0] __kmalloc_cache_node_noprof+0x258/0x660 [ 11.164391][ C0] ? create_worker+0x122/0x770 [ 11.164393][ C0] create_worker+0x122/0x770 [ 11.164395][ C0] ? worker_attach_to_pool+0x420/0x420 [ 11.164396][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 11.164398][ C0] ? add_timer_on+0x580/0x580 [ 11.164399][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 11.164401][ C0] ? rcu_is_watching+0x16/0xd0 [ 11.164402][ C0] worker_thread+0x765/0xd60 [ 11.164405][ C0] ? rescuer_thread+0x1340/0x1340 [ 11.164407][ C0] kthread+0x367/0x460 [ 11.164409][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.164410][ C0] ? kthread_affine_preferred+0x4c0/0x4c0 [ 11.164412][ C0] ret_from_fork+0x474/0x6b0 [ 11.164414][ C0] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 11.164415][ C0] ? __switch_to+0x5a3/0xe00 [ 11.164417][ C0] ? kthread_affine_preferred+0x4c0/0x4c0 [ 11.164419][ C0] ret_from_fork_asm+0x11/0x20 [ 11.164422][ C0] [ 11.234309][ C0] clocksource: Watchdog kvm-clock interval: 15100ns [ 11.234594][ C0] clocksource: Clocksource tsc interval: 14940ns [ 11.234878][ C0] tsc: Marking TSC unstable due to clocksource watchdog