[ 11.697664][ T194] ip (194) used greatest stack depth: 24096 bytes left [ 11.697680][ T194] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.697682][ T194] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 194, name: ip [ 11.697683][ T194] preempt_count: 2, expected: 0 [ 11.697684][ T194] RCU nest depth: 0, expected: 0 [ 11.697685][ T194] locks held by ip/194: 5, last CPU#2: [ 11.697687][ T194] #0: ffffffffbbc127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 11.697698][ T194] #1: ffffffffbbd79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.697705][ T194] #2: ffffffffbbd79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.697708][ T194] #3: ffffffffbbc99660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.697712][ T194] #4: ffffffffbbc99560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.697716][ T194] irq event stamp: 24924 [ 11.697717][ T194] hardirqs last enabled at (24923): [] __down_trylock_console_sem+0x86/0xa0 [ 11.697719][ T194] hardirqs last disabled at (24924): [] console_emit_next_record+0x3d4/0x4c0 [ 11.697721][ T194] softirqs last enabled at (24350): [] handle_softirqs+0x67c/0x900 [ 11.697723][ T194] softirqs last disabled at (24343): [] __irq_exit_rcu+0x145/0x1c0 [ 11.697726][ T194] Preemption disabled at: [ 11.697726][ T194] [<0000000000000000>] 0x0 [ 11.697733][ T194] CPU: 2 UID: 0 PID: 194 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.697737][ T194] Tainted: [W]=WARN [ 11.697737][ T194] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.697739][ T194] Call Trace: [ 11.697741][ T194] [ 11.697742][ T194] dump_stack_lvl+0x6f/0xa0 [ 11.697748][ T194] __might_resched.cold+0x1fe/0x2c1 [ 11.697753][ T194] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.697757][ T194] ? __kmalloc_noprof+0xdb/0x760 [ 11.697762][ T194] __kmalloc_noprof+0x443/0x760 [ 11.697764][ T194] ? alloc_buf.isra.0+0x4b/0x260 [ 11.697770][ T194] ? do_raw_spin_unlock+0x59/0x250 [ 11.697773][ T194] alloc_buf.isra.0+0x4b/0x260 [ 11.697776][ T194] put_chars+0x1e1/0x2f0 [ 11.697779][ T194] ? __send_to_port+0x420/0x420 [ 11.697780][ T194] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.697788][ T194] ? validate_chain+0x38b/0xc20 [ 11.697793][ T194] hvc_console_print+0x292/0x780 [ 11.697800][ T194] ? hvc_write+0x3a0/0x3a0 [ 11.697802][ T194] ? rcu_is_watching+0x16/0xd0 [ 11.697805][ T194] ? lock_acquire+0x13c/0x160 [ 11.697809][ T194] console_emit_next_record+0x22f/0x4c0 [ 11.697812][ T194] ? devkmsg_read+0x4b0/0x4b0 [ 11.697814][ T194] ? console_flush_one_record+0x106/0x710 [ 11.697817][ T194] ? rcu_is_watching+0x16/0xd0 [ 11.697819][ T194] ? lock_acquire+0x13c/0x160 [ 11.697823][ T194] console_flush_one_record+0x46f/0x710 [ 11.697827][ T194] ? console_emit_next_record+0x4c0/0x4c0 [ 11.697829][ T194] ? __lock_acquire+0x518/0xc20 [ 11.697834][ T194] console_unlock+0xee/0x1f0 [ 11.697837][ T194] ? console_flush_one_record+0x710/0x710 [ 11.697838][ T194] ? rcu_is_watching+0x16/0xd0 [ 11.697841][ T194] ? lock_acquire+0x60/0x160 [ 11.697844][ T194] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.697846][ T194] ? vprintk_emit+0x320/0x3e0 [ 11.697849][ T194] vprintk_emit+0x37c/0x3e0 [ 11.697853][ T194] ? wake_up_klogd_work_func+0x90/0x90 [ 11.697856][ T194] ? __lock_acquire+0x518/0xc20 [ 11.697859][ T194] _printk+0xc7/0x100 [ 11.697863][ T194] ? snapshot_read.cold+0x21/0x21 [ 11.697866][ T194] ? do_raw_spin_lock+0x131/0x280 [ 11.697868][ T194] ? __rwlock_init+0x150/0x150 [ 11.697872][ T194] ? do_raw_spin_lock+0x131/0x280 [ 11.697875][ T194] do_exit.cold+0x82/0x9c [ 11.697879][ T194] ? exit_notify+0x890/0x890 [ 11.697880][ T194] ? __lock_release.isra.0+0x69/0x1a0 [ 11.697883][ T194] ? rcu_is_watching+0x16/0xd0 [ 11.697887][ T194] do_group_exit+0xb8/0x370 [ 11.697889][ T194] __x64_sys_exit_group+0x3c/0x50 [ 11.697891][ T194] x64_sys_call+0x1567/0x1570 [ 11.697894][ T194] do_syscall_64+0xff/0x530 [ 11.697898][ T194] ? exc_page_fault+0xee/0x100 [ 11.697901][ T194] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.697903][ T194] RIP: 0033:0x7fcaf08251b8 [ 11.697905][ T194] Code: Unable to access opcode bytes at 0x7fcaf082518e. [ 11.697906][ T194] RSP: 002b:00007ffdce219968 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 11.697909][ T194] RAX: ffffffffffffffda RBX: 00007fcaf0955f88 RCX: 00007fcaf08251b8 [ 11.697910][ T194] RDX: 00007fcaf056ffc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 11.697911][ T194] RBP: 00007ffdce2199c0 R08: 0000000000000000 R09: 0000000000008010 [ 11.697912][ T194] R10: 00007ffdce219780 R11: 0000000000000246 R12: 0000000000000001 [ 11.697913][ T194] R13: 0000000000000000 R14: 00007fcaf0954680 R15: 00007fcaf0955fa0 [ 11.697920][ T194] [ 13.891914][ C0] clocksource: Watchdog remote CPU 2 read timed out [ 13.892186][ C0] [ 13.892188][ C0] ======================================================== [ 13.892189][ C0] WARNING: possible irq lock inversion dependency detected [ 13.892191][ C0] 7.2.0-virtme #1 Tainted: G W [ 13.892193][ C0] -------------------------------------------------------- [ 13.892193][ C0] swapper/0/0 just changed the state of lock: [ 13.892194][ C0] ffffffffbbc99660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 13.892206][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 13.892207][ C0] (fs_reclaim){+.+.}-{0:0} [ 13.892208][ C0] [ 13.892208][ C0] [ 13.892208][ C0] and interrupts could create inverse lock ordering between them. [ 13.892208][ C0] [ 13.892209][ C0] [ 13.892209][ C0] other info that might help us debug this: [ 13.892210][ C0] Possible interrupt unsafe locking scenario: [ 13.892210][ C0] [ 13.892210][ C0] CPU0 CPU1 [ 13.892211][ C0] ---- ---- [ 13.892211][ C0] lock(fs_reclaim); [ 13.892212][ C0] local_irq_disable(); [ 13.892212][ C0] lock(console_owner); [ 13.892213][ C0] lock(fs_reclaim); [ 13.892214][ C0] [ 13.892214][ C0] lock(console_owner); [ 13.892215][ C0] [ 13.892215][ C0] *** DEADLOCK *** [ 13.892215][ C0] [ 13.892216][ C0] locks held by swapper/0/0: 4, last CPU#0: [ 13.892217][ C0] #0: ffa0000000007c90 ((&watchdog_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 13.892222][ C0] #1: ffffffffbbdde8b8 (watchdog_lock){+.-.}-{3:3}, at: clocksource_watchdog+0x15/0x30 [ 13.892226][ C0] #2: ffffffffbbd79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 13.892229][ C0] #3: ffffffffbbd79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 13.892233][ C0] [ 13.892233][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 13.892237][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 13.892239][ C0] HARDIRQ-ON-W at: [ 13.892240][ C0] __lock_acquire+0x388/0xc20 [ 13.892243][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.892245][ C0] fs_reclaim_acquire+0xd5/0x120 [ 13.892248][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 13.892250][ C0] kthread_create_worker_on_node+0xea/0x210 [ 13.892253][ C0] workqueue_init+0x2a/0x680 [ 13.892256][ C0] kernel_init_freeable+0x2fe/0x630 [ 13.892259][ C0] kernel_init+0x21/0x150 [ 13.892263][ C0] ret_from_fork+0x474/0x6b0 [ 13.892266][ C0] ret_from_fork_asm+0x11/0x20 [ 13.892268][ C0] SOFTIRQ-ON-W at: [ 13.892269][ C0] __lock_acquire+0x388/0xc20 [ 13.892270][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.892272][ C0] fs_reclaim_acquire+0xd5/0x120 [ 13.892273][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 13.892274][ C0] kthread_create_worker_on_node+0xea/0x210 [ 13.892275][ C0] workqueue_init+0x2a/0x680 [ 13.892277][ C0] kernel_init_freeable+0x2fe/0x630 [ 13.892278][ C0] kernel_init+0x21/0x150 [ 13.892279][ C0] ret_from_fork+0x474/0x6b0 [ 13.892281][ C0] ret_from_fork_asm+0x11/0x20 [ 13.892282][ C0] INITIAL USE at: [ 13.892282][ C0] __lock_acquire+0x388/0xc20 [ 13.892284][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.892285][ C0] fs_reclaim_acquire+0xd5/0x120 [ 13.892286][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 13.892287][ C0] kthread_create_worker_on_node+0xea/0x210 [ 13.892289][ C0] workqueue_init+0x2a/0x680 [ 13.892290][ C0] kernel_init_freeable+0x2fe/0x630 [ 13.892291][ C0] kernel_init+0x21/0x150 [ 13.892293][ C0] ret_from_fork+0x474/0x6b0 [ 13.892294][ C0] ret_from_fork_asm+0x11/0x20 [ 13.892295][ C0] } [ 13.892295][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 13.892299][ C0] ... acquired at: [ 13.892299][ C0] __lock_acquire+0x518/0xc20 [ 13.892301][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.892302][ C0] fs_reclaim_acquire+0xd5/0x120 [ 13.892303][ C0] __kmalloc_noprof+0xd3/0x760 [ 13.892304][ C0] alloc_buf.isra.0+0x4b/0x260 [ 13.892307][ C0] put_chars+0x1e1/0x2f0 [ 13.892309][ C0] hvc_console_print+0x292/0x780 [ 13.892312][ C0] console_emit_next_record+0x22f/0x4c0 [ 13.892313][ C0] console_flush_one_record+0x46f/0x710 [ 13.892315][ C0] console_unlock+0xee/0x1f0 [ 13.892316][ C0] vprintk_emit+0x37c/0x3e0 [ 13.892318][ C0] dev_vprintk_emit+0x27f/0x2c0 [ 13.892321][ C0] dev_printk_emit+0xb9/0xee [ 13.892323][ C0] _dev_info+0xe2/0x116 [ 13.892324][ C0] __devm_rtc_register_device.cold+0x338/0x3a8 [ 13.892327][ C0] cmos_do_probe+0x73b/0x98a [ 13.892328][ C0] platform_probe+0xfe/0x1f0 [ 13.892330][ C0] call_driver_probe+0x61/0x1c0 [ 13.892333][ C0] really_probe+0x199/0x760 [ 13.892334][ C0] __driver_probe_device+0x24f/0x440 [ 13.892336][ C0] driver_probe_device+0x4a/0xf0 [ 13.892337][ C0] __driver_attach+0x1b8/0x540 [ 13.892339][ C0] bus_for_each_dev+0x130/0x1e0 [ 13.892340][ C0] bus_add_driver+0x2c8/0x530 [ 13.892342][ C0] driver_register+0x1a3/0x390 [ 13.892343][ C0] __platform_driver_probe+0x13f/0x270 [ 13.892344][ C0] cmos_init+0x31/0x40 [ 13.892347][ C0] do_one_initcall+0x124/0x4f0 [ 13.892349][ C0] kernel_init_freeable+0x596/0x630 [ 13.892350][ C0] kernel_init+0x21/0x150 [ 13.892351][ C0] ret_from_fork+0x474/0x6b0 [ 13.892353][ C0] ret_from_fork_asm+0x11/0x20 [ 13.892354][ C0] [ 13.892354][ C0] -> (console_owner){..-.}-{0:0} { [ 13.892356][ C0] IN-SOFTIRQ-W at: [ 13.892357][ C0] __lock_acquire+0x388/0xc20 [ 13.892358][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.892359][ C0] console_lock_spinning_enable+0x5c/0x60 [ 13.892361][ C0] console_emit_next_record+0x1d1/0x4c0 [ 13.892363][ C0] console_flush_one_record+0x46f/0x710 [ 13.892364][ C0] console_unlock+0xee/0x1f0 [ 13.892366][ C0] vprintk_emit+0x37c/0x3e0 [ 13.892367][ C0] _printk+0xc7/0x100 [ 13.892370][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 13.892372][ C0] call_timer_fn+0x160/0x4d0 [ 13.892374][ C0] __run_timers+0x68f/0xaa0 [ 13.892375][ C0] run_timer_softirq+0xf0/0x160 [ 13.892377][ C0] handle_softirqs+0x1d3/0x900 [ 13.892379][ C0] __irq_exit_rcu+0x145/0x1c0 [ 13.892381][ C0] irq_exit_rcu+0xe/0x30 [ 13.892382][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 13.892383][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.892385][ C0] pv_native_safe_halt+0xf/0x10 [ 13.892386][ C0] default_idle+0x9/0x10 [ 13.892388][ C0] default_idle_call+0x6e/0xb0 [ 13.892389][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.892391][ C0] do_idle+0xd8/0x190 [ 13.892392][ C0] cpu_startup_entry+0x53/0x70 [ 13.892393][ C0] rest_init+0x279/0x280 [ 13.892395][ C0] start_kernel+0x3af/0x3b0 [ 13.892396][ C0] x86_64_start_reservations+0x24/0x30 [ 13.892398][ C0] x86_64_start_kernel+0x12b/0x130 [ 13.892400][ C0] common_startup_64+0x13e/0x148 [ 13.892402][ C0] INITIAL USE at: [ 13.892403][ C0] } [ 13.892403][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 13.892407][ C0] ... acquired at: [ 13.892407][ C0] mark_lock+0x1d7/0xa00 [ 13.892409][ C0] mark_usage+0x42/0x170 [ 13.892410][ C0] __lock_acquire+0x388/0xc20 [ 13.892411][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.892412][ C0] console_lock_spinning_enable+0x5c/0x60 [ 13.892414][ C0] console_emit_next_record+0x1d1/0x4c0 [ 13.892415][ C0] console_flush_one_record+0x46f/0x710 [ 13.892417][ C0] console_unlock+0xee/0x1f0 [ 13.892418][ C0] vprintk_emit+0x37c/0x3e0 [ 13.892420][ C0] _printk+0xc7/0x100 [ 13.892421][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 13.892422][ C0] call_timer_fn+0x160/0x4d0 [ 13.892424][ C0] __run_timers+0x68f/0xaa0 [ 13.892425][ C0] run_timer_softirq+0xf0/0x160 [ 13.892427][ C0] handle_softirqs+0x1d3/0x900 [ 13.892428][ C0] __irq_exit_rcu+0x145/0x1c0 [ 13.892429][ C0] irq_exit_rcu+0xe/0x30 [ 13.892430][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 13.892431][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.892432][ C0] pv_native_safe_halt+0xf/0x10 [ 13.892433][ C0] default_idle+0x9/0x10 [ 13.892434][ C0] default_idle_call+0x6e/0xb0 [ 13.892436][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.892437][ C0] do_idle+0xd8/0x190 [ 13.892438][ C0] cpu_startup_entry+0x53/0x70 [ 13.892439][ C0] rest_init+0x279/0x280 [ 13.892440][ C0] start_kernel+0x3af/0x3b0 [ 13.892442][ C0] x86_64_start_reservations+0x24/0x30 [ 13.892443][ C0] x86_64_start_kernel+0x12b/0x130 [ 13.892444][ C0] common_startup_64+0x13e/0x148 [ 13.892446][ C0] [ 13.892446][ C0] [ 13.892446][ C0] stack backtrace: [ 13.892449][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.892452][ C0] Tainted: [W]=WARN [ 13.892453][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.892454][ C0] Call Trace: [ 13.892456][ C0] [ 13.892457][ C0] dump_stack_lvl+0x6f/0xa0 [ 13.892461][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 13.892463][ C0] mark_lock_irq+0x989/0x9c0 [ 13.892464][ C0] ? add_lock_to_list+0x2c/0x1a0 [ 13.892468][ C0] mark_lock+0x1d7/0xa00 [ 13.892469][ C0] mark_usage+0x42/0x170 [ 13.892471][ C0] __lock_acquire+0x388/0xc20 [ 13.892473][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.892475][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 13.892477][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.892480][ C0] ? lock_acquire+0x13c/0x160 [ 13.892482][ C0] console_lock_spinning_enable+0x5c/0x60 [ 13.892483][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 13.892485][ C0] console_emit_next_record+0x1d1/0x4c0 [ 13.892487][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 13.892489][ C0] ? console_flush_one_record+0x106/0x710 [ 13.892496][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.892497][ C0] ? lock_acquire+0x13c/0x160 [ 13.892499][ C0] console_flush_one_record+0x46f/0x710 [ 13.892502][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 13.892503][ C0] ? __lock_acquire+0x518/0xc20 [ 13.892505][ C0] console_unlock+0xee/0x1f0 [ 13.892507][ C0] ? console_flush_one_record+0x710/0x710 [ 13.892509][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.892511][ C0] ? lock_acquire+0x60/0x160 [ 13.892512][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.892514][ C0] ? vprintk_emit+0x320/0x3e0 [ 13.892516][ C0] vprintk_emit+0x37c/0x3e0 [ 13.892518][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 13.892520][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 13.892522][ C0] _printk+0xc7/0x100 [ 13.892524][ C0] ? snapshot_read.cold+0x21/0x21 [ 13.892526][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 13.892527][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 13.892529][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 13.892531][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 13.892532][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 13.892534][ C0] call_timer_fn+0x160/0x4d0 [ 13.892536][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 13.892537][ C0] ? debug_object_active_state+0x430/0x430 [ 13.892541][ C0] ? find_held_lock+0x2b/0x80 [ 13.892542][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 13.892544][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.892546][ C0] __run_timers+0x68f/0xaa0 [ 13.892548][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 13.892550][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 13.892552][ C0] ? __lock_acquire+0x518/0xc20 [ 13.892554][ C0] ? __rwlock_init+0x150/0x150 [ 13.892557][ C0] run_timer_softirq+0xf0/0x160 [ 13.892558][ C0] ? __run_timers+0xaa0/0xaa0 [ 13.892560][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.892563][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.892564][ C0] handle_softirqs+0x1d3/0x900 [ 13.892566][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 13.892568][ C0] ? _local_bh_enable+0xc0/0xc0 [ 13.892570][ C0] __irq_exit_rcu+0x145/0x1c0 [ 13.892571][ C0] irq_exit_rcu+0xe/0x30 [ 13.892572][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 13.892574][ C0] [ 13.892574][ C0] [ 13.892575][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 13.892576][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.892578][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 13.892581][ C0] Code: 48 8b 3d 94 02 06 02 e8 1f 00 00 00 48 2b 05 58 03 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 17 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 13.892582][ C0] RSP: 0018:ffffffffbba07cf8 EFLAGS: 00000296 [ 13.892584][ C0] RAX: 000000000006937d RBX: ffffffffbba2c600 RCX: ffffffffb88fa307 [ 13.892586][ C0] RDX: ffffffffbba2c600 RSI: ffffffffbb878e68 RDI: ffffffffbb28dce0 [ 13.892586][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 13.892587][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff7740fa2 [ 13.892588][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 13.892590][ C0] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.892592][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 13.892593][ C0] default_idle+0x9/0x10 [ 13.892594][ C0] default_idle_call+0x6e/0xb0 [ 13.892596][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.892597][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 13.892599][ C0] ? mark_tsc_async_resets+0x30/0x30 [ 13.892601][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.892603][ C0] do_idle+0xd8/0x190 [ 13.892604][ C0] cpu_startup_entry+0x53/0x70 [ 13.892606][ C0] rest_init+0x279/0x280 [ 13.892607][ C0] ? __cpuidle_text_end+0x3b/0x3b [ 13.892610][ C0] ? rest_init+0x280/0x280 [ 13.892611][ C0] ? acpi_hw_set_mode+0x4a0/0x4a0 [ 13.892614][ C0] ? cpus_read_unlock+0x4f/0xc0 [ 13.892617][ C0] ? acpi_enable+0x1e4/0x330 [ 13.892619][ C0] start_kernel+0x3af/0x3b0 [ 13.892621][ C0] x86_64_start_reservations+0x24/0x30 [ 13.892623][ C0] x86_64_start_kernel+0x12b/0x130 [ 13.892625][ C0] common_startup_64+0x13e/0x148 [ 13.892628][ C0] [ 13.892632][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.892633][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/0 [ 13.892635][ C0] preempt_count: 103, expected: 0 [ 13.892635][ C0] RCU nest depth: 0, expected: 0 [ 13.892636][ C0] INFO: lockdep is turned off. [ 13.892636][ C0] irq event stamp: 430991 [ 13.892637][ C0] hardirqs last enabled at (430990): [] asm_sysvec_call_function_single+0x1a/0x20 [ 13.892639][ C0] hardirqs last disabled at (430991): [] console_emit_next_record+0x3d4/0x4c0 [ 13.892641][ C0] softirqs last enabled at (430912): [] handle_softirqs+0x67c/0x900 [ 13.892642][ C0] softirqs last disabled at (430975): [] __irq_exit_rcu+0x145/0x1c0 [ 13.892644][ C0] Preemption disabled at: [ 13.892645][ C0] [] schedule_preempt_disabled+0x22/0x30 [ 13.892648][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.892650][ C0] Tainted: [W]=WARN [ 13.892650][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.892651][ C0] Call Trace: [ 13.892651][ C0] [ 13.892652][ C0] dump_stack_lvl+0x6f/0xa0 [ 13.892654][ C0] ? schedule_preempt_disabled+0x22/0x30 [ 13.892656][ C0] __might_resched.cold+0x1fe/0x2c1 [ 13.892659][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.892662][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.892664][ C0] __kmalloc_noprof+0x443/0x760 [ 13.892665][ C0] ? __rwlock_init+0x150/0x150 [ 13.892667][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 13.892669][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 13.892670][ C0] alloc_buf.isra.0+0x4b/0x260 [ 13.892672][ C0] put_chars+0x1e1/0x2f0 [ 13.892674][ C0] ? __send_to_port+0x420/0x420 [ 13.892676][ C0] ? mark_lock+0x1d7/0xa00 [ 13.892678][ C0] hvc_console_print+0x292/0x780 [ 13.892681][ C0] ? hvc_write+0x3a0/0x3a0 [ 13.892682][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.892684][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.892686][ C0] console_emit_next_record+0x22f/0x4c0 [ 13.892688][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 13.892690][ C0] ? console_flush_one_record+0x106/0x710 [ 13.892692][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.892693][ C0] ? lock_acquire+0x13c/0x160 [ 13.892695][ C0] console_flush_one_record+0x46f/0x710 [ 13.892697][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 13.892699][ C0] ? __lock_acquire+0x518/0xc20 [ 13.892701][ C0] console_unlock+0xee/0x1f0 [ 13.892703][ C0] ? console_flush_one_record+0x710/0x710 [ 13.892705][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.892706][ C0] ? lock_acquire+0x60/0x160 [ 13.892708][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.892710][ C0] ? vprintk_emit+0x320/0x3e0 [ 13.892712][ C0] vprintk_emit+0x37c/0x3e0 [ 13.892714][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 13.892716][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 13.892718][ C0] _printk+0xc7/0x100 [ 13.892719][ C0] ? snapshot_read.cold+0x21/0x21 [ 13.892721][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 13.892722][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 13.892725][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 13.892726][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 13.892728][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 13.892729][ C0] call_timer_fn+0x160/0x4d0 [ 13.892731][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 13.892733][ C0] ? debug_object_active_state+0x430/0x430 [ 13.892734][ C0] ? find_held_lock+0x2b/0x80 [ 13.892736][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 13.892738][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.892740][ C0] __run_timers+0x68f/0xaa0 [ 13.892741][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 13.892744][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 13.892745][ C0] ? __lock_acquire+0x518/0xc20 [ 13.892748][ C0] ? __rwlock_init+0x150/0x150 [ 13.892750][ C0] run_timer_softirq+0xf0/0x160 [ 13.892752][ C0] ? __run_timers+0xaa0/0xaa0 [ 13.892754][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.892755][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.892757][ C0] handle_softirqs+0x1d3/0x900 [ 13.892758][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 13.892760][ C0] ? _local_bh_enable+0xc0/0xc0 [ 13.892762][ C0] __irq_exit_rcu+0x145/0x1c0 [ 13.892763][ C0] irq_exit_rcu+0xe/0x30 [ 13.892764][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 13.892766][ C0] [ 13.892766][ C0] [ 13.892767][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 13.892768][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.892770][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 13.892771][ C0] Code: 48 8b 3d 94 02 06 02 e8 1f 00 00 00 48 2b 05 58 03 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 17 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 13.892772][ C0] RSP: 0018:ffffffffbba07cf8 EFLAGS: 00000296 [ 13.892773][ C0] RAX: 000000000006937d RBX: ffffffffbba2c600 RCX: ffffffffb88fa307 [ 13.892774][ C0] RDX: ffffffffbba2c600 RSI: ffffffffbb878e68 RDI: ffffffffbb28dce0 [ 13.892775][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 13.892775][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff7740fa2 [ 13.892776][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 13.892777][ C0] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.892779][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 13.892781][ C0] default_idle+0x9/0x10 [ 13.892785][ C0] default_idle_call+0x6e/0xb0 [ 13.892786][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.892788][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 13.892789][ C0] ? mark_tsc_async_resets+0x30/0x30 [ 13.892791][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.892793][ C0] do_idle+0xd8/0x190 [ 13.892794][ C0] cpu_startup_entry+0x53/0x70 [ 13.892796][ C0] rest_init+0x279/0x280 [ 13.892797][ C0] ? __cpuidle_text_end+0x3b/0x3b [ 13.892799][ C0] ? rest_init+0x280/0x280 [ 13.892801][ C0] ? acpi_hw_set_mode+0x4a0/0x4a0 [ 13.892802][ C0] ? cpus_read_unlock+0x4f/0xc0 [ 13.892804][ C0] ? acpi_enable+0x1e4/0x330 [ 13.892806][ C0] start_kernel+0x3af/0x3b0 [ 13.892808][ C0] x86_64_start_reservations+0x24/0x30 [ 13.892810][ C0] x86_64_start_kernel+0x12b/0x130 [ 13.892811][ C0] common_startup_64+0x13e/0x148 [ 13.892814][ C0] [ 37.867062][ T233] RDS: shutdown called in state 1 [ 37.867080][ T233] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 37.867083][ T233] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 233, name: kworker/u16:3 [ 37.867084][ T233] preempt_count: 1, expected: 0 [ 37.867085][ T233] RCU nest depth: 0, expected: 0 [ 37.867086][ T233] INFO: lockdep is turned off. [ 37.867087][ T233] irq event stamp: 376 [ 37.867088][ T233] hardirqs last enabled at (375): [] _raw_spin_unlock_irq+0x28/0x50 [ 37.867097][ T233] hardirqs last disabled at (376): [] __schedule+0x1246/0x20e0 [ 37.867101][ T233] softirqs last enabled at (372): [] rds_send_xmit+0x1198/0x26e0 [ 37.867103][ T233] softirqs last disabled at (370): [] release_sock+0x21/0x240 [ 37.867107][ T233] Preemption disabled at: [ 37.867108][ T233] [] vprintk_emit+0x31b/0x3e0 [ 37.867116][ T233] CPU: 0 UID: 0 PID: 233 Comm: kworker/u16:3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 37.867120][ T233] Tainted: [W]=WARN [ 37.867121][ T233] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 37.867122][ T233] Workqueue: krds_cp_wq#1/2 rds_shutdown_worker [ 37.867127][ T233] Call Trace: [ 37.867129][ T233] [ 37.867131][ T233] dump_stack_lvl+0x6f/0xa0 [ 37.867136][ T233] ? vprintk_emit+0x31b/0x3e0 [ 37.867137][ T233] __might_resched.cold+0x1fe/0x2c1 [ 37.867142][ T233] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 37.867145][ T233] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 37.867147][ T233] ? rcu_is_watching+0x16/0xd0 [ 37.867151][ T233] __kmalloc_noprof+0x443/0x760 [ 37.867154][ T233] ? __rwlock_init+0x150/0x150 [ 37.867156][ T233] ? alloc_buf.isra.0+0x4b/0x260 [ 37.867160][ T233] ? do_raw_spin_unlock+0x59/0x250 [ 37.867162][ T233] alloc_buf.isra.0+0x4b/0x260 [ 37.867164][ T233] put_chars+0x1e1/0x2f0 [ 37.867166][ T233] ? prb_final_commit+0x50/0x50 [ 37.867167][ T233] ? __send_to_port+0x420/0x420 [ 37.867169][ T233] ? printk_get_next_message+0x240/0x650 [ 37.867172][ T233] hvc_console_print+0x292/0x780 [ 37.867175][ T233] ? hvc_write+0x3a0/0x3a0 [ 37.867177][ T233] ? do_raw_spin_lock+0x131/0x280 [ 37.867178][ T233] ? vsnprintf+0x668/0x1700 [ 37.867180][ T233] ? __rwlock_init+0x150/0x150 [ 37.867182][ T233] ? rcu_is_watching+0x16/0xd0 [ 37.867183][ T233] ? lock_acquire+0x13c/0x160 [ 37.867186][ T233] console_emit_next_record+0x22f/0x4c0 [ 37.867188][ T233] ? devkmsg_read+0x4b0/0x4b0 [ 37.867190][ T233] ? rcu_is_watching+0x16/0xd0 [ 37.867191][ T233] ? rcu_is_watching+0x16/0xd0 [ 37.867193][ T233] ? rcu_is_watching+0x16/0xd0 [ 37.867195][ T233] ? lock_acquire+0x13c/0x160 [ 37.867197][ T233] ? console_flush_one_record+0x111/0x710 [ 37.867198][ T233] console_flush_one_record+0x46f/0x710 [ 37.867201][ T233] ? console_emit_next_record+0x4c0/0x4c0 [ 37.867203][ T233] console_unlock+0xee/0x1f0 [ 37.867205][ T233] ? lock_acquire+0x13c/0x160 [ 37.867207][ T233] ? console_flush_one_record+0x710/0x710 [ 37.867208][ T233] ? rcu_is_watching+0x16/0xd0 [ 37.867210][ T233] ? lock_release+0x184/0x1f0 [ 37.867211][ T233] ? lock_acquire+0x60/0x160 [ 37.867213][ T233] ? __rcu_read_lock+0x30/0x70 [ 37.867215][ T233] ? __down_trylock_console_sem+0x5e/0xa0 [ 37.867217][ T233] ? vprintk_emit+0x320/0x3e0 [ 37.867219][ T233] vprintk_emit+0x37c/0x3e0 [ 37.867221][ T233] ? wake_up_klogd_work_func+0x90/0x90 [ 37.867223][ T233] ? ww_mutex_lock+0x160/0x160 [ 37.867225][ T233] __rds_conn_path_error+0xbd/0x100 [ 37.867228][ T233] ? rds_check_all_paths+0xb0/0xb0 [ 37.867229][ T233] ? lock_acquire+0x13c/0x160 [ 37.867231][ T233] ? rcu_is_watching+0x16/0xd0 [ 37.867233][ T233] ? rds_conn_shutdown+0x652/0xa20 [ 37.867235][ T233] rds_conn_shutdown+0x695/0xa20 [ 37.867236][ T233] ? __rds_conn_path_error+0x100/0x100 [ 37.867238][ T233] ? debug_object_active_state+0x430/0x430 [ 37.867242][ T233] ? rcu_is_watching+0x16/0xd0 [ 37.867243][ T233] ? rcu_is_watching+0x16/0xd0 [ 37.867245][ T233] ? lock_acquire+0x13c/0x160 [ 37.867246][ T233] ? rcu_is_watching+0x16/0xd0 [ 37.867248][ T233] ? process_one_work+0xdfc/0x1560 [ 37.867252][ T233] process_one_work+0xe3e/0x1560 [ 37.867255][ T233] ? __queue_delayed_work+0x470/0x470 [ 37.867259][ T233] ? __rwlock_init+0x150/0x150 [ 37.867261][ T233] worker_thread+0x4f1/0xd60 [ 37.867264][ T233] ? rescuer_thread+0x1340/0x1340 [ 37.867265][ T233] kthread+0x367/0x460 [ 37.867268][ T233] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 37.867270][ T233] ? kthread_affine_preferred+0x4c0/0x4c0 [ 37.867272][ T233] ret_from_fork+0x474/0x6b0 [ 37.867275][ T233] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 37.867277][ T233] ? __switch_to+0x5a3/0xe00 [ 37.867279][ T233] ? kthread_affine_preferred+0x4c0/0x4c0 [ 37.867281][ T233] ret_from_fork_asm+0x11/0x20 [ 37.867285][ T233]