[ 11.824442][ T264] gre: GRE over IPv4 demultiplexer driver [ 11.824461][ T264] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.824464][ T264] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 264, name: modprobe [ 11.824466][ T264] preempt_count: 1, expected: 0 [ 11.824467][ T264] RCU nest depth: 0, expected: 0 [ 11.824469][ T264] locks held by modprobe/264: 4, last CPU#0: [ 11.824472][ T264] #0: ffffffff8d969cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.824486][ T264] #1: ffffffff8d969d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.824493][ T264] #2: ffffffff8d889660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.824499][ T264] #3: ffffffff8d889560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.824505][ T264] irq event stamp: 24120 [ 11.824506][ T264] hardirqs last enabled at (24119): [] __down_trylock_console_sem+0x86/0xa0 [ 11.824509][ T264] hardirqs last disabled at (24120): [] console_emit_next_record+0x3d4/0x4c0 [ 11.824512][ T264] softirqs last enabled at (22518): [] handle_softirqs+0x67c/0x900 [ 11.824516][ T264] softirqs last disabled at (22411): [] __irq_exit_rcu+0x145/0x1c0 [ 11.824519][ T264] Preemption disabled at: [ 11.824520][ T264] [] vprintk_emit+0x31b/0x3e0 [ 11.824527][ T264] CPU: 0 UID: 0 PID: 264 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.824532][ T264] Tainted: [W]=WARN [ 11.824533][ T264] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.824535][ T264] Call Trace: [ 11.824538][ T264] [ 11.824540][ T264] dump_stack_lvl+0x6f/0xa0 [ 11.824547][ T264] ? vprintk_emit+0x31b/0x3e0 [ 11.824550][ T264] __might_resched.cold+0x1fe/0x2c1 [ 11.824556][ T264] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.824562][ T264] ? __kmalloc_noprof+0xdb/0x760 [ 11.824569][ T264] __kmalloc_noprof+0x443/0x760 [ 11.824573][ T264] ? alloc_buf.isra.0+0x4b/0x260 [ 11.824581][ T264] ? do_raw_spin_unlock+0x59/0x250 [ 11.824585][ T264] alloc_buf.isra.0+0x4b/0x260 [ 11.824590][ T264] put_chars+0x1e1/0x2f0 [ 11.824592][ T264] ? desc_read_finalized_seq+0x79/0x120 [ 11.824596][ T264] ? __send_to_port+0x420/0x420 [ 11.824601][ T264] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.824606][ T264] ? validate_chain+0x38b/0xc20 [ 11.824613][ T264] hvc_console_print+0x292/0x780 [ 11.824616][ T264] ? __lock_acquire+0x518/0xc20 [ 11.824618][ T264] ? __lock_acquire+0x518/0xc20 [ 11.824626][ T264] ? hvc_write+0x3a0/0x3a0 [ 11.824628][ T264] ? console_emit_next_record+0x1df/0x4c0 [ 11.824633][ T264] ? rcu_is_watching+0x16/0xd0 [ 11.824637][ T264] ? lock_acquire+0x13c/0x160 [ 11.824643][ T264] console_emit_next_record+0x22f/0x4c0 [ 11.824649][ T264] ? devkmsg_read+0x4b0/0x4b0 [ 11.824652][ T264] ? console_flush_one_record+0x106/0x710 [ 11.824657][ T264] ? rcu_is_watching+0x16/0xd0 [ 11.824660][ T264] ? lock_acquire+0x13c/0x160 [ 11.824667][ T264] console_flush_one_record+0x46f/0x710 [ 11.824673][ T264] ? console_emit_next_record+0x4c0/0x4c0 [ 11.824676][ T264] ? __lock_acquire+0x518/0xc20 [ 11.824684][ T264] console_unlock+0xee/0x1f0 [ 11.824689][ T264] ? console_flush_one_record+0x710/0x710 [ 11.824691][ T264] ? rcu_is_watching+0x16/0xd0 [ 11.824695][ T264] ? lock_acquire+0x60/0x160 [ 11.824701][ T264] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.824704][ T264] ? vprintk_emit+0x320/0x3e0 [ 11.824709][ T264] vprintk_emit+0x37c/0x3e0 [ 11.824715][ T264] ? wake_up_klogd_work_func+0x90/0x90 [ 11.824724][ T264] ? gre_exit+0x3f0/0x3f0 [gre] [ 11.824728][ T264] _printk+0xc7/0x100 [ 11.824733][ T264] ? snapshot_read.cold+0x21/0x21 [ 11.824744][ T264] ? do_one_initcall+0x113/0x4f0 [ 11.824749][ T264] gre_init+0x15/0x1000 [gre] [ 11.824752][ T264] do_one_initcall+0x124/0x4f0 [ 11.824757][ T264] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 11.824764][ T264] ? do_init_module+0xae/0x8a0 [ 11.824768][ T264] ? kasan_unpoison+0x44/0x70 [ 11.824776][ T264] do_init_module+0x2ad/0x8a0 [ 11.824781][ T264] ? lockdep_hardirqs_on+0x91/0x130 [ 11.824787][ T264] ? free_module+0x470/0x470 [ 11.824792][ T264] ? kfree+0x123/0x590 [ 11.824798][ T264] load_module+0x1424/0x1bb0 [ 11.824811][ T264] ? layout_and_allocate.isra.0+0x680/0x680 [ 11.824819][ T264] ? backing_file_read_iter+0x541/0x790 [ 11.824824][ T264] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.824830][ T264] init_module_from_file+0x11f/0x1a0 [ 11.824835][ T264] ? __do_sys_init_module+0x220/0x220 [ 11.824849][ T264] ? __rwlock_init+0x150/0x150 [ 11.824855][ T264] ? do_raw_spin_unlock+0x59/0x250 [ 11.824860][ T264] idempotent_init_module+0x37b/0x7c0 [ 11.824865][ T264] ? init_module_from_file+0x1a0/0x1a0 [ 11.824876][ T264] ? rcu_is_watching+0x16/0xd0 [ 11.824879][ T264] ? cap_capable+0x1d7/0x3d0 [ 11.824889][ T264] __x64_sys_finit_module+0xdf/0x190 [ 11.824892][ T264] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.824897][ T264] do_syscall_64+0xff/0x530 [ 11.824900][ T264] ? exc_page_fault+0xee/0x100 [ 11.824904][ T264] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.824907][ T264] RIP: 0033:0x7fb0a232c37d [ 11.824912][ T264] Code: ff c3 66 2e 0f 1f 84 00 00 00 00 00 90 f3 0f 1e fa 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 4b aa 0f 00 f7 d8 64 89 01 48 [ 11.824914][ T264] RSP: 002b:00007ffc78fafca8 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 11.824918][ T264] RAX: ffffffffffffffda RBX: 00005615ebcf2a40 RCX: 00007fb0a232c37d [ 11.824920][ T264] RDX: 0000000000000000 RSI: 00005615d2393ffd RDI: 0000000000000001 [ 11.824922][ T264] RBP: 00007ffc78fafd40 R08: 0000000000000000 R09: 0000000000000000 [ 11.824923][ T264] R10: 0000000000000000 R11: 0000000000000246 R12: 00005615d2393ffd [ 11.824924][ T264] R13: 00005615ebcf2a00 R14: 0000000000040000 R15: 0000000000000000 [ 11.824936][ T264] [ 11.883197][ T264] ip_gre: GRE over IPv4 tunneling driver [ 12.517025][ T288] 8021q: 802.1Q VLAN Support v1.8 [ 13.634773][ T328] GACT probability NOT on [ 13.634790][ T328] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.634792][ T328] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 328, name: modprobe [ 13.634794][ T328] preempt_count: 1, expected: 0 [ 13.634795][ T328] RCU nest depth: 0, expected: 0 [ 13.634796][ T328] locks held by modprobe/328: 4, last CPU#0: [ 13.634798][ T328] #0: ffffffff8d969cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 13.634810][ T328] #1: ffffffff8d969d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 13.634814][ T328] #2: ffffffff8d889660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 13.634818][ T328] #3: ffffffff8d889560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 13.634822][ T328] irq event stamp: 17374 [ 13.634823][ T328] hardirqs last enabled at (17373): [] __down_trylock_console_sem+0x86/0xa0 [ 13.634825][ T328] hardirqs last disabled at (17374): [] console_emit_next_record+0x3d4/0x4c0 [ 13.634827][ T328] softirqs last enabled at (16480): [] handle_softirqs+0x67c/0x900 [ 13.634830][ T328] softirqs last disabled at (16387): [] __irq_exit_rcu+0x145/0x1c0 [ 13.634833][ T328] Preemption disabled at: [ 13.634833][ T328] [] vprintk_emit+0x31b/0x3e0 [ 13.634839][ T328] CPU: 0 UID: 0 PID: 328 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.634843][ T328] Tainted: [W]=WARN [ 13.634844][ T328] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.634846][ T328] Call Trace: [ 13.634847][ T328] [ 13.634849][ T328] dump_stack_lvl+0x6f/0xa0 [ 13.634854][ T328] ? vprintk_emit+0x31b/0x3e0 [ 13.634857][ T328] __might_resched.cold+0x1fe/0x2c1 [ 13.634861][ T328] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.634866][ T328] ? __kmalloc_noprof+0xdb/0x760 [ 13.634871][ T328] __kmalloc_noprof+0x443/0x760 [ 13.634873][ T328] ? alloc_buf.isra.0+0x4b/0x260 [ 13.634879][ T328] ? do_raw_spin_unlock+0x59/0x250 [ 13.634882][ T328] alloc_buf.isra.0+0x4b/0x260 [ 13.634885][ T328] put_chars+0x1e1/0x2f0 [ 13.634887][ T328] ? desc_read_finalized_seq+0x79/0x120 [ 13.634889][ T328] ? __send_to_port+0x420/0x420 [ 13.634892][ T328] ? rcu_read_lock_any_held+0x3c/0x90 [ 13.634895][ T328] ? validate_chain+0x38b/0xc20 [ 13.634899][ T328] hvc_console_print+0x292/0x780 [ 13.634902][ T328] ? __lock_acquire+0x518/0xc20 [ 13.634903][ T328] ? __lock_acquire+0x518/0xc20 [ 13.634908][ T328] ? hvc_write+0x3a0/0x3a0 [ 13.634909][ T328] ? console_emit_next_record+0x1df/0x4c0 [ 13.634912][ T328] ? rcu_is_watching+0x16/0xd0 [ 13.634915][ T328] ? lock_acquire+0x13c/0x160 [ 13.634919][ T328] console_emit_next_record+0x22f/0x4c0 [ 13.634923][ T328] ? devkmsg_read+0x4b0/0x4b0 [ 13.634924][ T328] ? console_flush_one_record+0x106/0x710 [ 13.634927][ T328] ? rcu_is_watching+0x16/0xd0 [ 13.634930][ T328] ? lock_acquire+0x13c/0x160 [ 13.634934][ T328] console_flush_one_record+0x46f/0x710 [ 13.634938][ T328] ? console_emit_next_record+0x4c0/0x4c0 [ 13.634939][ T328] ? __lock_acquire+0x518/0xc20 [ 13.634944][ T328] console_unlock+0xee/0x1f0 [ 13.634947][ T328] ? console_flush_one_record+0x710/0x710 [ 13.634949][ T328] ? rcu_is_watching+0x16/0xd0 [ 13.634951][ T328] ? lock_acquire+0x60/0x160 [ 13.634954][ T328] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.634956][ T328] ? vprintk_emit+0x320/0x3e0 [ 13.634959][ T328] vprintk_emit+0x37c/0x3e0 [ 13.634963][ T328] ? wake_up_klogd_work_func+0x90/0x90 [ 13.634969][ T328] ? gact_cleanup_module+0xf0/0xf0 [act_gact] [ 13.634972][ T328] _printk+0xc7/0x100 [ 13.634975][ T328] ? snapshot_read.cold+0x21/0x21 [ 13.634986][ T328] ? do_one_initcall+0x113/0x4f0 [ 13.634990][ T328] gact_init_module+0x15/0x1000 [act_gact] [ 13.634992][ T328] do_one_initcall+0x124/0x4f0 [ 13.634995][ T328] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 13.635000][ T328] ? do_init_module+0xae/0x8a0 [ 13.635003][ T328] ? kasan_unpoison+0x44/0x70 [ 13.635007][ T328] do_init_module+0x2ad/0x8a0 [ 13.635011][ T328] ? lockdep_hardirqs_on+0x91/0x130 [ 13.635015][ T328] ? free_module+0x470/0x470 [ 13.635018][ T328] ? kfree+0x123/0x590 [ 13.635022][ T328] load_module+0x1424/0x1bb0 [ 13.635029][ T328] ? layout_and_allocate.isra.0+0x680/0x680 [ 13.635033][ T328] ? __ia32_sys_fsconfig+0x180/0x180 [ 13.635036][ T328] ? ovl_real_file+0x172/0x1e0 [ 13.635040][ T328] ? backing_file_read_iter+0x541/0x790 [ 13.635043][ T328] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 13.635047][ T328] init_module_from_file+0x11f/0x1a0 [ 13.635050][ T328] ? __do_sys_init_module+0x220/0x220 [ 13.635058][ T328] ? __rwlock_init+0x150/0x150 [ 13.635061][ T328] ? do_raw_spin_unlock+0x59/0x250 [ 13.635064][ T328] idempotent_init_module+0x37b/0x7c0 [ 13.635067][ T328] ? init_module_from_file+0x1a0/0x1a0 [ 13.635073][ T328] ? rcu_is_watching+0x16/0xd0 [ 13.635076][ T328] ? cap_capable+0x1d7/0x3d0 [ 13.635081][ T328] __x64_sys_finit_module+0xdf/0x190 [ 13.635083][ T328] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.635087][ T328] do_syscall_64+0xff/0x530 [ 13.635089][ T328] ? exc_page_fault+0xee/0x100 [ 13.635091][ T328] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 13.635093][ T328] RIP: 0033:0x7f4faa5d237d [ 13.635097][ T328] Code: ff c3 66 2e 0f 1f 84 00 00 00 00 00 90 f3 0f 1e fa 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 4b aa 0f 00 f7 d8 64 89 01 48 [ 13.635098][ T328] RSP: 002b:00007fffc36b71d8 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 13.635101][ T328] RAX: ffffffffffffffda RBX: 000055b4d4acf810 RCX: 00007f4faa5d237d [ 13.635102][ T328] RDX: 0000000000000000 RSI: 000055b4bcb91ffd RDI: 0000000000000000 [ 13.635103][ T328] RBP: 00007fffc36b7270 R08: 0000000000000000 R09: 0000000000000000 [ 13.635104][ T328] R10: 0000000000000000 R11: 0000000000000246 R12: 000055b4bcb91ffd [ 13.635105][ T328] R13: 000055b4d4acf960 R14: 0000000000040000 R15: 0000000000000000 [ 13.635111][ T328] [ 14.446284][ C0] clocksource: Watchdog remote CPU 3 read timed out [ 14.446546][ C0] [ 14.446548][ C0] ======================================================== [ 14.446549][ C0] WARNING: possible irq lock inversion dependency detected [ 14.446551][ C0] 7.2.0-virtme #1 Tainted: G W [ 14.446552][ C0] -------------------------------------------------------- [ 14.446553][ C0] swapper/0/0 just changed the state of lock: [ 14.446554][ C0] ffffffff8d889660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 14.446567][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 14.446568][ C0] (fs_reclaim){+.+.}-{0:0} [ 14.446570][ C0] [ 14.446570][ C0] [ 14.446570][ C0] and interrupts could create inverse lock ordering between them. [ 14.446570][ C0] [ 14.446570][ C0] [ 14.446570][ C0] other info that might help us debug this: [ 14.446571][ C0] Possible interrupt unsafe locking scenario: [ 14.446571][ C0] [ 14.446572][ C0] CPU0 CPU1 [ 14.446572][ C0] ---- ---- [ 14.446573][ C0] lock(fs_reclaim); [ 14.446574][ C0] local_irq_disable(); [ 14.446574][ C0] lock(console_owner); [ 14.446575][ C0] lock(fs_reclaim); [ 14.446576][ C0] [ 14.446576][ C0] lock(console_owner); [ 14.446577][ C0] [ 14.446577][ C0] *** DEADLOCK *** [ 14.446577][ C0] [ 14.446577][ C0] locks held by swapper/0/0: 4, last CPU#0: [ 14.446579][ C0] #0: ffa0000000007c90 ((&watchdog_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 14.446584][ C0] #1: ffffffff8d9ce8b8 (watchdog_lock){+.-.}-{3:3}, at: clocksource_watchdog+0x15/0x30 [ 14.446588][ C0] #2: ffffffff8d969cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 14.446592][ C0] #3: ffffffff8d969d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 14.446595][ C0] [ 14.446595][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 14.446599][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 14.446601][ C0] HARDIRQ-ON-W at: [ 14.446603][ C0] __lock_acquire+0x388/0xc20 [ 14.446606][ C0] lock_acquire.part.0+0xd4/0x280 [ 14.446607][ C0] fs_reclaim_acquire+0xd5/0x120 [ 14.446610][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 14.446612][ C0] kthread_create_worker_on_node+0xea/0x210 [ 14.446615][ C0] workqueue_init+0x2a/0x680 [ 14.446619][ C0] kernel_init_freeable+0x2fe/0x630 [ 14.446621][ C0] kernel_init+0x21/0x150 [ 14.446625][ C0] ret_from_fork+0x474/0x6b0 [ 14.446628][ C0] ret_from_fork_asm+0x11/0x20 [ 14.446631][ C0] SOFTIRQ-ON-W at: [ 14.446632][ C0] __lock_acquire+0x388/0xc20 [ 14.446633][ C0] lock_acquire.part.0+0xd4/0x280 [ 14.446635][ C0] fs_reclaim_acquire+0xd5/0x120 [ 14.446636][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 14.446637][ C0] kthread_create_worker_on_node+0xea/0x210 [ 14.446638][ C0] workqueue_init+0x2a/0x680 [ 14.446639][ C0] kernel_init_freeable+0x2fe/0x630 [ 14.446640][ C0] kernel_init+0x21/0x150 [ 14.446642][ C0] ret_from_fork+0x474/0x6b0 [ 14.446643][ C0] ret_from_fork_asm+0x11/0x20 [ 14.446644][ C0] INITIAL USE at: [ 14.446645][ C0] __lock_acquire+0x388/0xc20 [ 14.446646][ C0] lock_acquire.part.0+0xd4/0x280 [ 14.446647][ C0] fs_reclaim_acquire+0xd5/0x120 [ 14.446648][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 14.446650][ C0] kthread_create_worker_on_node+0xea/0x210 [ 14.446651][ C0] workqueue_init+0x2a/0x680 [ 14.446652][ C0] kernel_init_freeable+0x2fe/0x630 [ 14.446653][ C0] kernel_init+0x21/0x150 [ 14.446655][ C0] ret_from_fork+0x474/0x6b0 [ 14.446656][ C0] ret_from_fork_asm+0x11/0x20 [ 14.446657][ C0] } [ 14.446657][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 14.446661][ C0] ... acquired at: [ 14.446662][ C0] __lock_acquire+0x518/0xc20 [ 14.446664][ C0] lock_acquire.part.0+0xd4/0x280 [ 14.446665][ C0] fs_reclaim_acquire+0xd5/0x120 [ 14.446666][ C0] __kmalloc_noprof+0xd3/0x760 [ 14.446667][ C0] alloc_buf.isra.0+0x4b/0x260 [ 14.446670][ C0] put_chars+0x1e1/0x2f0 [ 14.446671][ C0] hvc_console_print+0x292/0x780 [ 14.446673][ C0] console_emit_next_record+0x22f/0x4c0 [ 14.446675][ C0] console_flush_one_record+0x46f/0x710 [ 14.446676][ C0] console_unlock+0xee/0x1f0 [ 14.446678][ C0] vprintk_emit+0x37c/0x3e0 [ 14.446679][ C0] dev_vprintk_emit+0x27f/0x2c0 [ 14.446683][ C0] dev_printk_emit+0xb9/0xee [ 14.446684][ C0] _dev_info+0xe2/0x116 [ 14.446686][ C0] cmos_do_probe+0x8be/0x98a [ 14.446688][ C0] platform_probe+0xfe/0x1f0 [ 14.446691][ C0] call_driver_probe+0x61/0x1c0 [ 14.446693][ C0] really_probe+0x199/0x760 [ 14.446695][ C0] __driver_probe_device+0x24f/0x440 [ 14.446696][ C0] driver_probe_device+0x4a/0xf0 [ 14.446697][ C0] __driver_attach+0x1b8/0x540 [ 14.446699][ C0] bus_for_each_dev+0x130/0x1e0 [ 14.446700][ C0] bus_add_driver+0x2c8/0x530 [ 14.446701][ C0] driver_register+0x1a3/0x390 [ 14.446703][ C0] __platform_driver_probe+0x13f/0x270 [ 14.446704][ C0] cmos_init+0x31/0x40 [ 14.446707][ C0] do_one_initcall+0x124/0x4f0 [ 14.446708][ C0] kernel_init_freeable+0x596/0x630 [ 14.446709][ C0] kernel_init+0x21/0x150 [ 14.446711][ C0] ret_from_fork+0x474/0x6b0 [ 14.446712][ C0] ret_from_fork_asm+0x11/0x20 [ 14.446713][ C0] [ 14.446713][ C0] -> (console_owner){..-.}-{0:0} { [ 14.446715][ C0] IN-SOFTIRQ-W at: [ 14.446715][ C0] __lock_acquire+0x388/0xc20 [ 14.446717][ C0] lock_acquire.part.0+0xd4/0x280 [ 14.446718][ C0] console_lock_spinning_enable+0x5c/0x60 [ 14.446720][ C0] console_emit_next_record+0x1d1/0x4c0 [ 14.446721][ C0] console_flush_one_record+0x46f/0x710 [ 14.446723][ C0] console_unlock+0xee/0x1f0 [ 14.446724][ C0] vprintk_emit+0x37c/0x3e0 [ 14.446726][ C0] _printk+0xc7/0x100 [ 14.446728][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 14.446731][ C0] call_timer_fn+0x160/0x4d0 [ 14.446732][ C0] __run_timers+0x68f/0xaa0 [ 14.446734][ C0] run_timer_softirq+0xf0/0x160 [ 14.446736][ C0] handle_softirqs+0x1d3/0x900 [ 14.446738][ C0] __irq_exit_rcu+0x145/0x1c0 [ 14.446739][ C0] irq_exit_rcu+0xe/0x30 [ 14.446740][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 14.446742][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.446744][ C0] pv_native_safe_halt+0xf/0x10 [ 14.446745][ C0] default_idle+0x9/0x10 [ 14.446747][ C0] default_idle_call+0x6e/0xb0 [ 14.446748][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.446750][ C0] do_idle+0xd8/0x190 [ 14.446751][ C0] cpu_startup_entry+0x53/0x70 [ 14.446753][ C0] rest_init+0x279/0x280 [ 14.446754][ C0] start_kernel+0x3af/0x3b0 [ 14.446755][ C0] x86_64_start_reservations+0x24/0x30 [ 14.446757][ C0] x86_64_start_kernel+0x12b/0x130 [ 14.446759][ C0] common_startup_64+0x13e/0x148 [ 14.446761][ C0] INITIAL USE at: [ 14.446762][ C0] } [ 14.446762][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 14.446765][ C0] ... acquired at: [ 14.446766][ C0] mark_lock+0x1d7/0xa00 [ 14.446767][ C0] mark_usage+0x42/0x170 [ 14.446768][ C0] __lock_acquire+0x388/0xc20 [ 14.446769][ C0] lock_acquire.part.0+0xd4/0x280 [ 14.446770][ C0] console_lock_spinning_enable+0x5c/0x60 [ 14.446772][ C0] console_emit_next_record+0x1d1/0x4c0 [ 14.446773][ C0] console_flush_one_record+0x46f/0x710 [ 14.446775][ C0] console_unlock+0xee/0x1f0 [ 14.446776][ C0] vprintk_emit+0x37c/0x3e0 [ 14.446778][ C0] _printk+0xc7/0x100 [ 14.446779][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 14.446780][ C0] call_timer_fn+0x160/0x4d0 [ 14.446782][ C0] __run_timers+0x68f/0xaa0 [ 14.446783][ C0] run_timer_softirq+0xf0/0x160 [ 14.446784][ C0] handle_softirqs+0x1d3/0x900 [ 14.446786][ C0] __irq_exit_rcu+0x145/0x1c0 [ 14.446787][ C0] irq_exit_rcu+0xe/0x30 [ 14.446788][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 14.446789][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.446790][ C0] pv_native_safe_halt+0xf/0x10 [ 14.446792][ C0] default_idle+0x9/0x10 [ 14.446793][ C0] default_idle_call+0x6e/0xb0 [ 14.446794][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.446796][ C0] do_idle+0xd8/0x190 [ 14.446797][ C0] cpu_startup_entry+0x53/0x70 [ 14.446798][ C0] rest_init+0x279/0x280 [ 14.446799][ C0] start_kernel+0x3af/0x3b0 [ 14.446800][ C0] x86_64_start_reservations+0x24/0x30 [ 14.446801][ C0] x86_64_start_kernel+0x12b/0x130 [ 14.446803][ C0] common_startup_64+0x13e/0x148 [ 14.446804][ C0] [ 14.446804][ C0] [ 14.446804][ C0] stack backtrace: [ 14.446807][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 14.446810][ C0] Tainted: [W]=WARN [ 14.446811][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.446812][ C0] Call Trace: [ 14.446813][ C0] [ 14.446814][ C0] dump_stack_lvl+0x6f/0xa0 [ 14.446818][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 14.446820][ C0] mark_lock_irq+0x989/0x9c0 [ 14.446822][ C0] ? add_lock_to_list+0x2c/0x1a0 [ 14.446825][ C0] mark_lock+0x1d7/0xa00 [ 14.446826][ C0] mark_usage+0x42/0x170 [ 14.446828][ C0] __lock_acquire+0x388/0xc20 [ 14.446830][ C0] lock_acquire.part.0+0xd4/0x280 [ 14.446832][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 14.446834][ C0] ? rcu_is_watching+0x16/0xd0 [ 14.446837][ C0] ? lock_acquire+0x13c/0x160 [ 14.446839][ C0] console_lock_spinning_enable+0x5c/0x60 [ 14.446840][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 14.446842][ C0] console_emit_next_record+0x1d1/0x4c0 [ 14.446844][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 14.446845][ C0] ? console_flush_one_record+0x106/0x710 [ 14.446847][ C0] ? rcu_is_watching+0x16/0xd0 [ 14.446849][ C0] ? lock_acquire+0x13c/0x160 [ 14.446851][ C0] console_flush_one_record+0x46f/0x710 [ 14.446853][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 14.446855][ C0] ? __lock_acquire+0x518/0xc20 [ 14.446857][ C0] console_unlock+0xee/0x1f0 [ 14.446859][ C0] ? console_flush_one_record+0x710/0x710 [ 14.446860][ C0] ? rcu_is_watching+0x16/0xd0 [ 14.446862][ C0] ? lock_acquire+0x60/0x160 [ 14.446864][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 14.446866][ C0] ? vprintk_emit+0x320/0x3e0 [ 14.446867][ C0] vprintk_emit+0x37c/0x3e0 [ 14.446870][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 14.446872][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 14.446874][ C0] _printk+0xc7/0x100 [ 14.446875][ C0] ? snapshot_read.cold+0x21/0x21 [ 14.446877][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 14.446879][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 14.446881][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 14.446882][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 14.446884][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 14.446886][ C0] call_timer_fn+0x160/0x4d0 [ 14.446888][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 14.446889][ C0] ? debug_object_active_state+0x430/0x430 [ 14.446893][ C0] ? find_held_lock+0x2b/0x80 [ 14.446894][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 14.446896][ C0] ? rcu_is_watching+0x16/0xd0 [ 14.446898][ C0] __run_timers+0x68f/0xaa0 [ 14.446900][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 14.446902][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 14.446903][ C0] ? __lock_acquire+0x518/0xc20 [ 14.446906][ C0] ? __rwlock_init+0x150/0x150 [ 14.446908][ C0] run_timer_softirq+0xf0/0x160 [ 14.446910][ C0] ? __run_timers+0xaa0/0xaa0 [ 14.446912][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.446914][ C0] ? rcu_is_watching+0x16/0xd0 [ 14.446916][ C0] handle_softirqs+0x1d3/0x900 [ 14.446918][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 14.446919][ C0] ? _local_bh_enable+0xc0/0xc0 [ 14.446921][ C0] __irq_exit_rcu+0x145/0x1c0 [ 14.446922][ C0] irq_exit_rcu+0xe/0x30 [ 14.446924][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 14.446925][ C0] [ 14.446926][ C0] [ 14.446926][ C0] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 14.446929][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.446930][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 14.446932][ C0] Code: 48 8b 3d 94 d2 f5 01 e8 1f 00 00 00 48 2b 05 58 93 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 86 11 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 14.446934][ C0] RSP: 0018:ffffffff8d607cf8 EFLAGS: 00000296 [ 14.446937][ C0] RAX: 000000000008e5e1 RBX: ffffffff8d61c600 RCX: ffffffff8a6f0307 [ 14.446938][ C0] RDX: ffffffff8d61c600 RSI: ffffffff8d438af6 RDI: ffffffff8ce8d8e0 [ 14.446939][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 14.446939][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff1ac0fa2 [ 14.446940][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 14.446942][ C0] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.446944][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 14.446945][ C0] default_idle+0x9/0x10 [ 14.446947][ C0] default_idle_call+0x6e/0xb0 [ 14.446949][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.446950][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 14.446952][ C0] ? mark_tsc_async_resets+0x30/0x30 [ 14.446954][ C0] ? rcu_is_watching+0x16/0xd0 [ 14.446956][ C0] do_idle+0xd8/0x190 [ 14.446957][ C0] cpu_startup_entry+0x53/0x70 [ 14.446959][ C0] rest_init+0x279/0x280 [ 14.446960][ C0] ? __cpuidle_text_end+0x3b/0x3b [ 14.446963][ C0] ? rest_init+0x280/0x280 [ 14.446965][ C0] ? acpi_hw_set_mode+0x4a0/0x4a0 [ 14.446969][ C0] ? cpus_read_unlock+0x4f/0xc0 [ 14.446971][ C0] ? acpi_enable+0x1e4/0x330 [ 14.446974][ C0] start_kernel+0x3af/0x3b0 [ 14.446975][ C0] x86_64_start_reservations+0x24/0x30 [ 14.446977][ C0] x86_64_start_kernel+0x12b/0x130 [ 14.446979][ C0] common_startup_64+0x13e/0x148 [ 14.446981][ C0]