[ 9.978466][ T191] ip (191) used greatest stack depth: 23600 bytes left [ 9.978483][ T191] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 9.978486][ T191] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 191, name: ip [ 9.978487][ T191] preempt_count: 2, expected: 0 [ 9.978488][ T191] RCU nest depth: 0, expected: 0 [ 9.978489][ T191] locks held by ip/191: 5, last CPU#2: [ 9.978492][ T191] #0: ffffffffa28267b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 9.978504][ T191] #1: ffffffffa298dcc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 9.978510][ T191] #2: ffffffffa298dd38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 9.978514][ T191] #3: ffffffffa28ad660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 9.978518][ T191] #4: ffffffffa28ad560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 9.978522][ T191] irq event stamp: 27950 [ 9.978522][ T191] hardirqs last enabled at (27949): [] __down_trylock_console_sem+0x86/0xa0 [ 9.978525][ T191] hardirqs last disabled at (27950): [] console_emit_next_record+0x3d4/0x4c0 [ 9.978526][ T191] softirqs last enabled at (26380): [] handle_softirqs+0x67c/0x900 [ 9.978528][ T191] softirqs last disabled at (25005): [] __irq_exit_rcu+0x145/0x1c0 [ 9.978530][ T191] Preemption disabled at: [ 9.978531][ T191] [<0000000000000000>] 0x0 [ 9.978538][ T191] CPU: 2 UID: 0 PID: 191 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.978541][ T191] Tainted: [W]=WARN [ 9.978542][ T191] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.978545][ T191] Call Trace: [ 9.978546][ T191] [ 9.978548][ T191] dump_stack_lvl+0x6f/0xa0 [ 9.978554][ T191] __might_resched.cold+0x1fe/0x2c1 [ 9.978559][ T191] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 9.978563][ T191] ? __kmalloc_noprof+0xdb/0x760 [ 9.978567][ T191] __kmalloc_noprof+0x443/0x760 [ 9.978570][ T191] ? alloc_buf.isra.0+0x4b/0x260 [ 9.978576][ T191] ? do_raw_spin_unlock+0x59/0x250 [ 9.978579][ T191] alloc_buf.isra.0+0x4b/0x260 [ 9.978583][ T191] put_chars+0x1e1/0x2f0 [ 9.978586][ T191] ? __send_to_port+0x420/0x420 [ 9.978588][ T191] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 9.978592][ T191] ? validate_chain+0x38b/0xc20 [ 9.978598][ T191] hvc_console_print+0x292/0x780 [ 9.978605][ T191] ? hvc_write+0x3a0/0x3a0 [ 9.978608][ T191] ? rcu_is_watching+0x16/0xd0 [ 9.978610][ T191] ? lock_acquire+0x13c/0x160 [ 9.978614][ T191] console_emit_next_record+0x22f/0x4c0 [ 9.978618][ T191] ? devkmsg_read+0x4b0/0x4b0 [ 9.978620][ T191] ? console_flush_one_record+0x106/0x710 [ 9.978623][ T191] ? rcu_is_watching+0x16/0xd0 [ 9.978625][ T191] ? lock_acquire+0x13c/0x160 [ 9.978628][ T191] console_flush_one_record+0x46f/0x710 [ 9.978633][ T191] ? console_emit_next_record+0x4c0/0x4c0 [ 9.978635][ T191] ? __lock_acquire+0x518/0xc20 [ 9.978640][ T191] console_unlock+0xee/0x1f0 [ 9.978643][ T191] ? console_flush_one_record+0x710/0x710 [ 9.978644][ T191] ? rcu_is_watching+0x16/0xd0 [ 9.978646][ T191] ? lock_acquire+0x60/0x160 [ 9.978650][ T191] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.978652][ T191] ? vprintk_emit+0x320/0x3e0 [ 9.978655][ T191] vprintk_emit+0x37c/0x3e0 [ 9.978658][ T191] ? wake_up_klogd_work_func+0x90/0x90 [ 9.978662][ T191] ? __lock_acquire+0x518/0xc20 [ 9.978665][ T191] _printk+0xc7/0x100 [ 9.978669][ T191] ? snapshot_read.cold+0x21/0x21 [ 9.978672][ T191] ? do_raw_spin_lock+0x131/0x280 [ 9.978674][ T191] ? __rwlock_init+0x150/0x150 [ 9.978678][ T191] ? do_raw_spin_lock+0x131/0x280 [ 9.978680][ T191] do_exit.cold+0x82/0x9c [ 9.978684][ T191] ? exit_notify+0x890/0x890 [ 9.978686][ T191] ? __lock_release.isra.0+0x69/0x1a0 [ 9.978688][ T191] ? rcu_is_watching+0x16/0xd0 [ 9.978692][ T191] do_group_exit+0xb8/0x370 [ 9.978696][ T191] __x64_sys_exit_group+0x3c/0x50 [ 9.978698][ T191] x64_sys_call+0x1567/0x1570 [ 9.978700][ T191] do_syscall_64+0xff/0x530 [ 9.978704][ T191] ? exc_page_fault+0xee/0x100 [ 9.978707][ T191] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.978709][ T191] RIP: 0033:0x7fe26897f1b8 [ 9.978712][ T191] Code: Unable to access opcode bytes at 0x7fe26897f18e. [ 9.978713][ T191] RSP: 002b:00007fff2d390b38 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 9.978715][ T191] RAX: ffffffffffffffda RBX: 00007fe268aaff88 RCX: 00007fe26897f1b8 [ 9.978717][ T191] RDX: 00007fe2686c9fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 9.978718][ T191] RBP: 00007fff2d390b90 R08: 0000000000000000 R09: 0000000000000050 [ 9.978718][ T191] R10: 00007fff2d390950 R11: 0000000000000246 R12: 0000000000000001 [ 9.978719][ T191] R13: 0000000000000000 R14: 00007fe268aae680 R15: 00007fe268aaffa0 [ 9.978726][ T191] [ 117.973492][ C0] clocksource: Watchdog remote CPU 2 read timed out [ 117.973679][ C0] [ 117.973681][ C0] ======================================================== [ 117.973682][ C0] WARNING: possible irq lock inversion dependency detected [ 117.973685][ C0] 7.2.0-virtme #1 Tainted: G W [ 117.973687][ C0] -------------------------------------------------------- [ 117.973688][ C0] ksoftirqd/0/14 just changed the state of lock: [ 117.973690][ C0] ffffffffa28ad660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 117.973706][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 117.973708][ C0] (fs_reclaim){+.+.}-{0:0} [ 117.973710][ C0] [ 117.973710][ C0] [ 117.973710][ C0] and interrupts could create inverse lock ordering between them. [ 117.973710][ C0] [ 117.973711][ C0] [ 117.973711][ C0] other info that might help us debug this: [ 117.973713][ C0] Possible interrupt unsafe locking scenario: [ 117.973713][ C0] [ 117.973714][ C0] CPU0 CPU1 [ 117.973715][ C0] ---- ---- [ 117.973716][ C0] lock(fs_reclaim); [ 117.973718][ C0] local_irq_disable(); [ 117.973718][ C0] lock(console_owner); [ 117.973720][ C0] lock(fs_reclaim); [ 117.973722][ C0] [ 117.973723][ C0] lock(console_owner); [ 117.973724][ C0] [ 117.973724][ C0] *** DEADLOCK *** [ 117.973724][ C0] [ 117.973725][ C0] locks held by ksoftirqd/0/14: 4, last CPU#0: [ 117.973727][ C0] #0: ffa00000000e7ab8 ((&watchdog_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 117.973735][ C0] #1: ffffffffa29f28b8 (watchdog_lock){+.-.}-{3:3}, at: clocksource_watchdog+0x15/0x30 [ 117.973742][ C0] #2: ffffffffa298dcc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 117.973747][ C0] #3: ffffffffa298dd38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 117.973753][ C0] [ 117.973753][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 117.973757][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 117.973761][ C0] HARDIRQ-ON-W at: [ 117.973763][ C0] __lock_acquire+0x388/0xc20 [ 117.973767][ C0] lock_acquire.part.0+0xd4/0x280 [ 117.973769][ C0] fs_reclaim_acquire+0xd5/0x120 [ 117.973773][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 117.973776][ C0] kthread_create_worker_on_node+0xea/0x210 [ 117.973780][ C0] workqueue_init+0x2a/0x680 [ 117.973784][ C0] kernel_init_freeable+0x2fe/0x630 [ 117.973787][ C0] kernel_init+0x21/0x150 [ 117.973792][ C0] ret_from_fork+0x474/0x6b0 [ 117.973796][ C0] ret_from_fork_asm+0x11/0x20 [ 117.973800][ C0] SOFTIRQ-ON-W at: [ 117.973801][ C0] __lock_acquire+0x388/0xc20 [ 117.973803][ C0] lock_acquire.part.0+0xd4/0x280 [ 117.973805][ C0] fs_reclaim_acquire+0xd5/0x120 [ 117.973808][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 117.973810][ C0] kthread_create_worker_on_node+0xea/0x210 [ 117.973812][ C0] workqueue_init+0x2a/0x680 [ 117.973813][ C0] kernel_init_freeable+0x2fe/0x630 [ 117.973815][ C0] kernel_init+0x21/0x150 [ 117.973818][ C0] ret_from_fork+0x474/0x6b0 [ 117.973820][ C0] ret_from_fork_asm+0x11/0x20 [ 117.973822][ C0] INITIAL USE at: [ 117.973824][ C0] __lock_acquire+0x388/0xc20 [ 117.973825][ C0] lock_acquire.part.0+0xd4/0x280 [ 117.973827][ C0] fs_reclaim_acquire+0xd5/0x120 [ 117.973830][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 117.973832][ C0] kthread_create_worker_on_node+0xea/0x210 [ 117.973834][ C0] workqueue_init+0x2a/0x680 [ 117.973836][ C0] kernel_init_freeable+0x2fe/0x630 [ 117.973837][ C0] kernel_init+0x21/0x150 [ 117.973840][ C0] ret_from_fork+0x474/0x6b0 [ 117.973842][ C0] ret_from_fork_asm+0x11/0x20 [ 117.973844][ C0] } [ 117.973845][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 117.973849][ C0] ... acquired at: [ 117.973851][ C0] __lock_acquire+0x518/0xc20 [ 117.973852][ C0] lock_acquire.part.0+0xd4/0x280 [ 117.973854][ C0] fs_reclaim_acquire+0xd5/0x120 [ 117.973857][ C0] __kmalloc_noprof+0xd3/0x760 [ 117.973859][ C0] alloc_buf.isra.0+0x4b/0x260 [ 117.973863][ C0] put_chars+0x1e1/0x2f0 [ 117.973865][ C0] hvc_console_print+0x292/0x780 [ 117.973869][ C0] console_emit_next_record+0x22f/0x4c0 [ 117.973872][ C0] console_flush_one_record+0x46f/0x710 [ 117.973874][ C0] console_unlock+0xee/0x1f0 [ 117.973876][ C0] vprintk_emit+0x37c/0x3e0 [ 117.973878][ C0] dev_vprintk_emit+0x27f/0x2c0 [ 117.973882][ C0] dev_printk_emit+0xb9/0xee [ 117.973884][ C0] _dev_info+0xe2/0x116 [ 117.973887][ C0] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 117.973890][ C0] cmos_do_probe+0x73b/0x98a [ 117.973891][ C0] platform_probe+0xfe/0x1f0 [ 117.973895][ C0] call_driver_probe+0x61/0x1c0 [ 117.973897][ C0] really_probe+0x199/0x760 [ 117.973899][ C0] __driver_probe_device+0x24f/0x440 [ 117.973901][ C0] driver_probe_device+0x4a/0xf0 [ 117.973903][ C0] __driver_attach+0x1b8/0x540 [ 117.973905][ C0] bus_for_each_dev+0x130/0x1e0 [ 117.973907][ C0] bus_add_driver+0x2c8/0x530 [ 117.973909][ C0] driver_register+0x1a3/0x390 [ 117.973911][ C0] __platform_driver_probe+0x13f/0x270 [ 117.973913][ C0] cmos_init+0x31/0x40 [ 117.973917][ C0] do_one_initcall+0x124/0x4f0 [ 117.973919][ C0] kernel_init_freeable+0x596/0x630 [ 117.973921][ C0] kernel_init+0x21/0x150 [ 117.973923][ C0] ret_from_fork+0x474/0x6b0 [ 117.973925][ C0] ret_from_fork_asm+0x11/0x20 [ 117.973927][ C0] [ 117.973928][ C0] -> (console_owner){..-.}-{0:0} { [ 117.973931][ C0] IN-SOFTIRQ-W at: [ 117.973933][ C0] __lock_acquire+0x388/0xc20 [ 117.973934][ C0] lock_acquire.part.0+0xd4/0x280 [ 117.973936][ C0] console_lock_spinning_enable+0x5c/0x60 [ 117.973939][ C0] console_emit_next_record+0x1d1/0x4c0 [ 117.973941][ C0] console_flush_one_record+0x46f/0x710 [ 117.973943][ C0] console_unlock+0xee/0x1f0 [ 117.973945][ C0] vprintk_emit+0x37c/0x3e0 [ 117.973947][ C0] _printk+0xc7/0x100 [ 117.973951][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 117.973954][ C0] call_timer_fn+0x160/0x4d0 [ 117.973957][ C0] __run_timers+0x68f/0xaa0 [ 117.973959][ C0] run_timer_softirq+0xf0/0x160 [ 117.973961][ C0] handle_softirqs+0x1d3/0x900 [ 117.973964][ C0] run_ksoftirqd+0x39/0x60 [ 117.973965][ C0] smpboot_thread_fn+0x2fb/0x9b0 [ 117.973968][ C0] kthread+0x367/0x460 [ 117.973970][ C0] ret_from_fork+0x474/0x6b0 [ 117.973972][ C0] ret_from_fork_asm+0x11/0x20 [ 117.973974][ C0] INITIAL USE at: [ 117.973976][ C0] } [ 117.973976][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 117.973980][ C0] ... acquired at: [ 117.973981][ C0] mark_lock+0x1d7/0xa00 [ 117.973983][ C0] mark_usage+0x42/0x170 [ 117.973985][ C0] __lock_acquire+0x388/0xc20 [ 117.973987][ C0] lock_acquire.part.0+0xd4/0x280 [ 117.973989][ C0] console_lock_spinning_enable+0x5c/0x60 [ 117.973991][ C0] console_emit_next_record+0x1d1/0x4c0 [ 117.973993][ C0] console_flush_one_record+0x46f/0x710 [ 117.973995][ C0] console_unlock+0xee/0x1f0 [ 117.973997][ C0] vprintk_emit+0x37c/0x3e0 [ 117.973999][ C0] _printk+0xc7/0x100 [ 117.974002][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 117.974004][ C0] call_timer_fn+0x160/0x4d0 [ 117.974006][ C0] __run_timers+0x68f/0xaa0 [ 117.974008][ C0] run_timer_softirq+0xf0/0x160 [ 117.974010][ C0] handle_softirqs+0x1d3/0x900 [ 117.974012][ C0] run_ksoftirqd+0x39/0x60 [ 117.974013][ C0] smpboot_thread_fn+0x2fb/0x9b0 [ 117.974015][ C0] kthread+0x367/0x460 [ 117.974017][ C0] ret_from_fork+0x474/0x6b0 [ 117.974019][ C0] ret_from_fork_asm+0x11/0x20 [ 117.974021][ C0] [ 117.974022][ C0] [ 117.974022][ C0] stack backtrace: [ 117.974026][ C0] CPU: 0 UID: 0 PID: 14 Comm: ksoftirqd/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 117.974030][ C0] Tainted: [W]=WARN [ 117.974031][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 117.974033][ C0] Call Trace: [ 117.974035][ C0] [ 117.974037][ C0] dump_stack_lvl+0x6f/0xa0 [ 117.974042][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 117.974046][ C0] mark_lock_irq+0x989/0x9c0 [ 117.974050][ C0] mark_lock+0x1d7/0xa00 [ 117.974053][ C0] mark_usage+0x42/0x170 [ 117.974055][ C0] __lock_acquire+0x388/0xc20 [ 117.974058][ C0] lock_acquire.part.0+0xd4/0x280 [ 117.974061][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 117.974064][ C0] ? rcu_is_watching+0x16/0xd0 [ 117.974068][ C0] ? lock_acquire+0x13c/0x160 [ 117.974071][ C0] console_lock_spinning_enable+0x5c/0x60 [ 117.974073][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 117.974075][ C0] console_emit_next_record+0x1d1/0x4c0 [ 117.974079][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 117.974081][ C0] ? console_flush_one_record+0x106/0x710 [ 117.974084][ C0] ? rcu_is_watching+0x16/0xd0 [ 117.974086][ C0] ? lock_acquire+0x13c/0x160 [ 117.974089][ C0] console_flush_one_record+0x46f/0x710 [ 117.974093][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 117.974095][ C0] ? __lock_acquire+0x518/0xc20 [ 117.974099][ C0] console_unlock+0xee/0x1f0 [ 117.974101][ C0] ? console_flush_one_record+0x710/0x710 [ 117.974104][ C0] ? rcu_is_watching+0x16/0xd0 [ 117.974106][ C0] ? lock_acquire+0x60/0x160 [ 117.974112][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 117.974114][ C0] ? vprintk_emit+0x320/0x3e0 [ 117.974117][ C0] vprintk_emit+0x37c/0x3e0 [ 117.974120][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 117.974124][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 117.974126][ C0] _printk+0xc7/0x100 [ 117.974129][ C0] ? snapshot_read.cold+0x21/0x21 [ 117.974132][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 117.974134][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 117.974138][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 117.974141][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 117.974143][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 117.974145][ C0] call_timer_fn+0x160/0x4d0 [ 117.974148][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 117.974151][ C0] ? find_held_lock+0x2b/0x80 [ 117.974155][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 117.974157][ C0] ? rcu_is_watching+0x16/0xd0 [ 117.974161][ C0] __run_timers+0x68f/0xaa0 [ 117.974163][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 117.974166][ C0] ? rcu_read_lock_sched_held+0x3c/0x60 [ 117.974169][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 117.974172][ C0] ? __lock_acquire+0x518/0xc20 [ 117.974174][ C0] ? mutex_init_lockdep+0xf6/0x120 [ 117.974179][ C0] ? __rwlock_init+0x150/0x150 [ 117.974182][ C0] run_timer_softirq+0xf0/0x160 [ 117.974185][ C0] ? io_schedule_timeout+0x140/0x140 [ 117.974188][ C0] ? __run_timers+0xaa0/0xaa0 [ 117.974190][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 117.974194][ C0] ? rcu_is_watching+0x16/0xd0 [ 117.974197][ C0] handle_softirqs+0x1d3/0x900 [ 117.974200][ C0] ? _local_bh_enable+0xc0/0xc0 [ 117.974202][ C0] ? preempt_schedule_thunk+0x16/0x30 [ 117.974205][ C0] ? rcu_is_watching+0x16/0xd0 [ 117.974208][ C0] run_ksoftirqd+0x39/0x60 [ 117.974210][ C0] smpboot_thread_fn+0x2fb/0x9b0 [ 117.974213][ C0] ? sort_range+0x20/0x20 [ 117.974215][ C0] kthread+0x367/0x460 [ 117.974217][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 117.974220][ C0] ? kthread_affine_preferred+0x4c0/0x4c0 [ 117.974223][ C0] ret_from_fork+0x474/0x6b0 [ 117.974226][ C0] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 117.974229][ C0] ? __switch_to+0x5a3/0xe00 [ 117.974233][ C0] ? kthread_affine_preferred+0x4c0/0x4c0 [ 117.974235][ C0] ret_from_fork_asm+0x11/0x20 [ 117.974240][ C0] [ 117.974245][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 117.974247][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 14, name: ksoftirqd/0 [ 117.974249][ C0] preempt_count: 102, expected: 0 [ 117.974250][ C0] RCU nest depth: 0, expected: 0 [ 117.974251][ C0] INFO: lockdep is turned off. [ 117.974252][ C0] irq event stamp: 3370853 [ 117.974253][ C0] hardirqs last enabled at (3370852): [] __down_trylock_console_sem+0x86/0xa0 [ 117.974256][ C0] hardirqs last disabled at (3370853): [] console_emit_next_record+0x3d4/0x4c0 [ 117.974259][ C0] softirqs last enabled at (3370834): [] handle_softirqs+0x67c/0x900 [ 117.974261][ C0] softirqs last disabled at (3370839): [] run_ksoftirqd+0x39/0x60 [ 117.974264][ C0] Preemption disabled at: [ 117.974265][ C0] [] handle_softirqs+0xf6/0x900 [ 117.974268][ C0] CPU: 0 UID: 0 PID: 14 Comm: ksoftirqd/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 117.974271][ C0] Tainted: [W]=WARN [ 117.974272][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 117.974274][ C0] Call Trace: [ 117.974275][ C0] [ 117.974276][ C0] dump_stack_lvl+0x6f/0xa0 [ 117.974279][ C0] ? handle_softirqs+0xf6/0x900 [ 117.974281][ C0] __might_resched.cold+0x1fe/0x2c1 [ 117.974285][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 117.974288][ C0] ? nbcon_get_cpu_emergency_nesting+0xa/0x30 [ 117.974291][ C0] ? rcu_is_watching+0x16/0xd0 [ 117.974294][ C0] __kmalloc_noprof+0x443/0x760 [ 117.974297][ C0] ? __rwlock_init+0x150/0x150 [ 117.974299][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 117.974303][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 117.974305][ C0] alloc_buf.isra.0+0x4b/0x260 [ 117.974309][ C0] put_chars+0x1e1/0x2f0 [ 117.974312][ C0] ? __send_to_port+0x420/0x420 [ 117.974315][ C0] ? mark_lock+0x1d7/0xa00 [ 117.974318][ C0] hvc_console_print+0x292/0x780 [ 117.974323][ C0] ? hvc_write+0x3a0/0x3a0 [ 117.974326][ C0] ? lock_acquire+0x13c/0x160 [ 117.974329][ C0] console_emit_next_record+0x22f/0x4c0 [ 117.974333][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 117.974335][ C0] ? console_flush_one_record+0x106/0x710 [ 117.974338][ C0] ? rcu_is_watching+0x16/0xd0 [ 117.974340][ C0] ? lock_acquire+0x13c/0x160 [ 117.974343][ C0] console_flush_one_record+0x46f/0x710 [ 117.974347][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 117.974349][ C0] ? __lock_acquire+0x518/0xc20 [ 117.974352][ C0] console_unlock+0xee/0x1f0 [ 117.974355][ C0] ? console_flush_one_record+0x710/0x710 [ 117.974357][ C0] ? rcu_is_watching+0x16/0xd0 [ 117.974360][ C0] ? lock_acquire+0x60/0x160 [ 117.974363][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 117.974365][ C0] ? vprintk_emit+0x320/0x3e0 [ 117.974368][ C0] vprintk_emit+0x37c/0x3e0 [ 117.974371][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 117.974375][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 117.974377][ C0] _printk+0xc7/0x100 [ 117.974380][ C0] ? snapshot_read.cold+0x21/0x21 [ 117.974382][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 117.974385][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 117.974388][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 117.974391][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 117.974393][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 117.974395][ C0] call_timer_fn+0x160/0x4d0 [ 117.974398][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 117.974401][ C0] ? find_held_lock+0x2b/0x80 [ 117.974404][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 117.974407][ C0] ? rcu_is_watching+0x16/0xd0 [ 117.974410][ C0] __run_timers+0x68f/0xaa0 [ 117.974412][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 117.974415][ C0] ? rcu_read_lock_sched_held+0x3c/0x60 [ 117.974418][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 117.974420][ C0] ? __lock_acquire+0x518/0xc20 [ 117.974423][ C0] ? mutex_init_lockdep+0xf6/0x120 [ 117.974427][ C0] ? __rwlock_init+0x150/0x150 [ 117.974430][ C0] run_timer_softirq+0xf0/0x160 [ 117.974433][ C0] ? io_schedule_timeout+0x140/0x140 [ 117.974435][ C0] ? __run_timers+0xaa0/0xaa0 [ 117.974437][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 117.974440][ C0] ? rcu_is_watching+0x16/0xd0 [ 117.974443][ C0] handle_softirqs+0x1d3/0x900 [ 117.974446][ C0] ? _local_bh_enable+0xc0/0xc0 [ 117.974452][ C0] ? preempt_schedule_thunk+0x16/0x30 [ 117.974454][ C0] ? rcu_is_watching+0x16/0xd0 [ 117.974457][ C0] run_ksoftirqd+0x39/0x60 [ 117.974459][ C0] smpboot_thread_fn+0x2fb/0x9b0 [ 117.974461][ C0] ? sort_range+0x20/0x20 [ 117.974463][ C0] kthread+0x367/0x460 [ 117.974465][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 117.974468][ C0] ? kthread_affine_preferred+0x4c0/0x4c0 [ 117.974470][ C0] ret_from_fork+0x474/0x6b0 [ 117.974473][ C0] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 117.974476][ C0] ? __switch_to+0x5a3/0xe00 [ 117.974478][ C0] ? kthread_affine_preferred+0x4c0/0x4c0 [ 117.974481][ C0] ret_from_fork_asm+0x11/0x20 [ 117.974485][ C0]