[ 8.608863][ T173] ip (173) used greatest stack depth: 24416 bytes left [ 8.608878][ T173] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 8.608880][ T173] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 173, name: ip [ 8.608882][ T173] preempt_count: 2, expected: 0 [ 8.608882][ T173] RCU nest depth: 0, expected: 0 [ 8.608883][ T173] locks held by ip/173: 5, last CPU#0: [ 8.608886][ T173] #0: ffffffff878127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 8.608897][ T173] #1: ffffffff87979cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 8.608903][ T173] #2: ffffffff87979d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 8.608906][ T173] #3: ffffffff87899660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 8.608910][ T173] #4: ffffffff87899560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 8.608914][ T173] irq event stamp: 28842 [ 8.608915][ T173] hardirqs last enabled at (28841): [] __down_trylock_console_sem+0x86/0xa0 [ 8.608917][ T173] hardirqs last disabled at (28842): [] console_emit_next_record+0x3d4/0x4c0 [ 8.608919][ T173] softirqs last enabled at (28468): [] handle_softirqs+0x67c/0x900 [ 8.608921][ T173] softirqs last disabled at (28463): [] __irq_exit_rcu+0x145/0x1c0 [ 8.608924][ T173] Preemption disabled at: [ 8.608924][ T173] [<0000000000000000>] 0x0 [ 8.608931][ T173] CPU: 0 UID: 0 PID: 173 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 8.608934][ T173] Tainted: [W]=WARN [ 8.608935][ T173] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 8.608936][ T173] Call Trace: [ 8.608938][ T173] [ 8.608939][ T173] dump_stack_lvl+0x6f/0xa0 [ 8.608946][ T173] __might_resched.cold+0x1fe/0x2c1 [ 8.608950][ T173] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 8.608954][ T173] ? __kmalloc_noprof+0xdb/0x760 [ 8.608959][ T173] __kmalloc_noprof+0x443/0x760 [ 8.608962][ T173] ? alloc_buf.isra.0+0x4b/0x260 [ 8.608967][ T173] ? do_raw_spin_unlock+0x59/0x250 [ 8.608970][ T173] alloc_buf.isra.0+0x4b/0x260 [ 8.608973][ T173] put_chars+0x1e1/0x2f0 [ 8.608976][ T173] ? __send_to_port+0x420/0x420 [ 8.608978][ T173] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 8.608983][ T173] ? validate_chain+0x38b/0xc20 [ 8.608988][ T173] hvc_console_print+0x292/0x780 [ 8.608994][ T173] ? hvc_write+0x3a0/0x3a0 [ 8.608996][ T173] ? rcu_is_watching+0x16/0xd0 [ 8.608999][ T173] ? lock_acquire+0x13c/0x160 [ 8.609004][ T173] console_emit_next_record+0x22f/0x4c0 [ 8.609007][ T173] ? devkmsg_read+0x4b0/0x4b0 [ 8.609009][ T173] ? console_flush_one_record+0x106/0x710 [ 8.609012][ T173] ? rcu_is_watching+0x16/0xd0 [ 8.609014][ T173] ? lock_acquire+0x13c/0x160 [ 8.609018][ T173] console_flush_one_record+0x46f/0x710 [ 8.609022][ T173] ? console_emit_next_record+0x4c0/0x4c0 [ 8.609024][ T173] ? __lock_acquire+0x518/0xc20 [ 8.609029][ T173] console_unlock+0xee/0x1f0 [ 8.609031][ T173] ? console_flush_one_record+0x710/0x710 [ 8.609033][ T173] ? rcu_is_watching+0x16/0xd0 [ 8.609036][ T173] ? lock_acquire+0x60/0x160 [ 8.609039][ T173] ? __down_trylock_console_sem+0x5e/0xa0 [ 8.609041][ T173] ? vprintk_emit+0x320/0x3e0 [ 8.609044][ T173] vprintk_emit+0x37c/0x3e0 [ 8.609048][ T173] ? wake_up_klogd_work_func+0x90/0x90 [ 8.609051][ T173] ? __lock_acquire+0x518/0xc20 [ 8.609055][ T173] _printk+0xc7/0x100 [ 8.609058][ T173] ? snapshot_read.cold+0x21/0x21 [ 8.609061][ T173] ? do_raw_spin_lock+0x131/0x280 [ 8.609063][ T173] ? __rwlock_init+0x150/0x150 [ 8.609067][ T173] ? do_raw_spin_lock+0x131/0x280 [ 8.609070][ T173] do_exit.cold+0x82/0x9c [ 8.609073][ T173] ? exit_notify+0x890/0x890 [ 8.609074][ T173] ? __lock_release.isra.0+0x69/0x1a0 [ 8.609077][ T173] ? rcu_is_watching+0x16/0xd0 [ 8.609081][ T173] do_group_exit+0xb8/0x370 [ 8.609084][ T173] __x64_sys_exit_group+0x3c/0x50 [ 8.609086][ T173] x64_sys_call+0x1567/0x1570 [ 8.609088][ T173] do_syscall_64+0xff/0x530 [ 8.609092][ T173] ? exc_page_fault+0xee/0x100 [ 8.609095][ T173] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 8.609097][ T173] RIP: 0033:0x7f499455f1b8 [ 8.609099][ T173] Code: Unable to access opcode bytes at 0x7f499455f18e. [ 8.609100][ T173] RSP: 002b:00007ffc7e040448 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 8.609102][ T173] RAX: ffffffffffffffda RBX: 00007f499468ff88 RCX: 00007f499455f1b8 [ 8.609103][ T173] RDX: 00007f49942a9fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 8.609104][ T173] RBP: 00007ffc7e0404a0 R08: 0000000000000000 R09: 0000000000000050 [ 8.609105][ T173] R10: 00007ffc7e040260 R11: 0000000000000246 R12: 0000000000000001 [ 8.609106][ T173] R13: 0000000000000000 R14: 00007f499468e680 R15: 00007f499468ffa0 [ 8.609112][ T173] [ 8.882030][ T181] PPP generic driver version 2.4.2 [ 8.887680][ T181] NET: Registered PF_PPPOX protocol family [ 8.911011][ T181] l2tp_core: L2TP core driver, V2.0 [ 8.916388][ T181] l2tp_ppp: PPPoL2TP kernel driver, V2.0 [ 8.976676][ T182] ip (182) used greatest stack depth: 24224 bytes left [ 13.879087][ T240] iperf3 (240) used greatest stack depth: 23216 bytes left [ 13.879107][ T240] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.879109][ T240] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 240, name: iperf3 [ 13.879111][ T240] preempt_count: 2, expected: 0 [ 13.879112][ T240] RCU nest depth: 0, expected: 0 [ 13.879113][ T240] locks held by iperf3/240: 5, last CPU#2: [ 13.879115][ T240] #0: ffffffff878127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 13.879127][ T240] #1: ffffffff87979cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 13.879133][ T240] #2: ffffffff87979d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 13.879137][ T240] #3: ffffffff87899660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 13.879140][ T240] #4: ffffffff87899560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 13.879144][ T240] irq event stamp: 1703956 [ 13.879145][ T240] hardirqs last enabled at (1703955): [] __down_trylock_console_sem+0x86/0xa0 [ 13.879148][ T240] hardirqs last disabled at (1703956): [] console_emit_next_record+0x3d4/0x4c0 [ 13.879150][ T240] softirqs last enabled at (1703542): [] fpu__clear_user_states+0x104/0x290 [ 13.879153][ T240] softirqs last disabled at (1703540): [] fpu__clear_user_states+0x6d/0x290 [ 13.879156][ T240] Preemption disabled at: [ 13.879156][ T240] [<0000000000000000>] 0x0 [ 13.879163][ T240] CPU: 2 UID: 0 PID: 240 Comm: iperf3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.879167][ T240] Tainted: [W]=WARN [ 13.879168][ T240] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.879169][ T240] Call Trace: [ 13.879171][ T240] [ 13.879172][ T240] dump_stack_lvl+0x6f/0xa0 [ 13.879178][ T240] __might_resched.cold+0x1fe/0x2c1 [ 13.879183][ T240] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.879187][ T240] ? __kmalloc_noprof+0xdb/0x760 [ 13.879192][ T240] __kmalloc_noprof+0x443/0x760 [ 13.879194][ T240] ? alloc_buf.isra.0+0x4b/0x260 [ 13.879200][ T240] ? do_raw_spin_unlock+0x59/0x250 [ 13.879207][ T240] alloc_buf.isra.0+0x4b/0x260 [ 13.879210][ T240] put_chars+0x1e1/0x2f0 [ 13.879212][ T240] ? prb_final_commit+0x50/0x50 [ 13.879215][ T240] ? __send_to_port+0x420/0x420 [ 13.879218][ T240] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 13.879222][ T240] ? rcu_read_lock_any_held+0x3c/0x90 [ 13.879225][ T240] ? validate_chain+0x38b/0xc20 [ 13.879228][ T240] hvc_console_print+0x292/0x780 [ 13.879231][ T240] ? mark_usage+0x61/0x170 [ 13.879233][ T240] ? __lock_acquire+0x518/0xc20 [ 13.879235][ T240] ? __lock_acquire+0x518/0xc20 [ 13.879239][ T240] ? hvc_write+0x3a0/0x3a0 [ 13.879241][ T240] ? console_emit_next_record+0x1df/0x4c0 [ 13.879244][ T240] ? rcu_is_watching+0x16/0xd0 [ 13.879246][ T240] ? lock_acquire+0x13c/0x160 [ 13.879250][ T240] console_emit_next_record+0x22f/0x4c0 [ 13.879254][ T240] ? devkmsg_read+0x4b0/0x4b0 [ 13.879255][ T240] ? console_flush_one_record+0x106/0x710 [ 13.879258][ T240] ? rcu_is_watching+0x16/0xd0 [ 13.879261][ T240] ? lock_acquire+0x13c/0x160 [ 13.879264][ T240] console_flush_one_record+0x46f/0x710 [ 13.879268][ T240] ? console_emit_next_record+0x4c0/0x4c0 [ 13.879270][ T240] ? __lock_acquire+0x518/0xc20 [ 13.879275][ T240] console_unlock+0xee/0x1f0 [ 13.879278][ T240] ? console_flush_one_record+0x710/0x710 [ 13.879279][ T240] ? rcu_is_watching+0x16/0xd0 [ 13.879282][ T240] ? lock_acquire+0x60/0x160 [ 13.879285][ T240] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.879287][ T240] ? vprintk_emit+0x320/0x3e0 [ 13.879290][ T240] vprintk_emit+0x37c/0x3e0 [ 13.879294][ T240] ? wake_up_klogd_work_func+0x90/0x90 [ 13.879297][ T240] ? __lock_acquire+0x518/0xc20 [ 13.879300][ T240] _printk+0xc7/0x100 [ 13.879304][ T240] ? snapshot_read.cold+0x21/0x21 [ 13.879307][ T240] ? do_raw_spin_lock+0x131/0x280 [ 13.879309][ T240] ? __rwlock_init+0x150/0x150 [ 13.879313][ T240] ? do_raw_spin_lock+0x131/0x280 [ 13.879315][ T240] do_exit.cold+0x82/0x9c [ 13.879319][ T240] ? exit_notify+0x890/0x890 [ 13.879324][ T240] __x64_sys_exit+0x42/0x50 [ 13.879326][ T240] x64_sys_call+0x156c/0x1570 [ 13.879328][ T240] do_syscall_64+0xff/0x530 [ 13.879332][ T240] ? exc_page_fault+0xee/0x100 [ 13.879335][ T240] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 13.879337][ T240] RIP: 0033:0x7fb6ed256c49 [ 13.879339][ T240] Code: Unable to access opcode bytes at 0x7fb6ed256c1f. [ 13.879340][ T240] RSP: 002b:00007fb6eca15e60 EFLAGS: 00000246 ORIG_RAX: 000000000000003c [ 13.879342][ T240] RAX: ffffffffffffffda RBX: 00007fb6eca166c0 RCX: 00007fb6ed256c49 [ 13.879343][ T240] RDX: 0000000000000000 RSI: 0000000000801000 RDI: 0000000000000000 [ 13.879344][ T240] RBP: 00007fb6eca15f70 R08: 0000000000000001 R09: 00007fb6eca166c0 [ 13.879345][ T240] R10: 0000000000000008 R11: 0000000000000246 R12: 00007fb6ec216000 [ 13.879346][ T240] R13: 00007ffe3b5094f0 R14: 0000000000000002 R15: 00007ffe3b5095f7 [ 13.879353][ T240] [ 14.010705][ T244] ppp0: recursion detected [ 14.010734][ T244] [ 14.010735][ T244] ===================================================== [ 14.010737][ T244] WARNING: SOFTIRQ-safe -> SOFTIRQ-unsafe lock order detected [ 14.010739][ T244] 7.2.0-virtme #1 Tainted: G W [ 14.010740][ T244] ----------------------------------------------------- [ 14.010741][ T244] ping/244 [HC0[0]:SC0[10]:HE0:SE0] is trying to acquire: [ 14.010743][ T244] ffffffff87899660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 14.010754][ T244] [ 14.010754][ T244] and this task is already holding: [ 14.010754][ T244] ff1100000599d998 (slock-AF_INET/2){+.-.}-{3:3}, at: l2tp_xmit_core.constprop.0+0x480/0x19b0 [l2tp_core] [ 14.010761][ T244] which would create a new lock dependency: [ 14.010762][ T244] (slock-AF_INET/2){+.-.}-{3:3} -> (console_owner){....}-{0:0} [ 14.010765][ T244] [ 14.010765][ T244] but this new dependency connects a SOFTIRQ-irq-safe lock: [ 14.010765][ T244] (slock-AF_INET/2){+.-.}-{3:3} [ 14.010767][ T244] [ 14.010767][ T244] ... which became SOFTIRQ-irq-safe at: [ 14.010768][ T244] __lock_acquire+0x388/0xc20 [ 14.010771][ T244] lock_acquire.part.0+0xd4/0x280 [ 14.010772][ T244] _raw_spin_lock_nested+0x3d/0x50 [ 14.010775][ T244] l2tp_xmit_core.constprop.0+0x480/0x19b0 [l2tp_core] [ 14.010778][ T244] l2tp_xmit_skb+0x77/0x1d0 [l2tp_core] [ 14.010780][ T244] pppol2tp_xmit+0x436/0x690 [l2tp_ppp] [ 14.010782][ T244] ppp_push+0x165/0x2d0 [ppp_generic] [ 14.010785][ T244] ppp_xmit_process+0x318/0x8e0 [ppp_generic] [ 14.010787][ T244] ppp_start_xmit+0x4a0/0x7c0 [ppp_generic] [ 14.010788][ T244] dev_hard_start_xmit+0xf4/0x620 [ 14.010792][ T244] __dev_queue_xmit+0xc0a/0x1b80 [ 14.010793][ T244] ip_finish_output2+0x5b9/0x1bc0 [ 14.010796][ T244] ip_output+0x1ca/0x660 [ 14.010798][ T244] ip_push_pending_frames+0xf6/0x250 [ 14.010799][ T244] icmp_reply+0x94d/0xa50 [ 14.010802][ T244] icmp_echo+0x2ab/0x4b0 [ 14.010804][ T244] icmp_rcv+0x92f/0xfb0 [ 14.010805][ T244] ip_protocol_deliver_rcu+0x82/0x350 [ 14.010807][ T244] ip_local_deliver_finish+0x36f/0x610 [ 14.010808][ T244] ip_local_deliver+0x184/0x4c0 [ 14.010809][ T244] ip_rcv+0xdc/0x3d0 [ 14.010810][ T244] __netif_receive_skb_one_core+0xfc/0x180 [ 14.010812][ T244] process_backlog+0x431/0x14c0 [ 14.010814][ T244] __napi_poll+0xa7/0x3b0 [ 14.010816][ T244] net_rx_action+0x513/0xf50 [ 14.010817][ T244] handle_softirqs+0x1d3/0x900 [ 14.010820][ T244] do_softirq+0xac/0xe0 [ 14.010821][ T244] __local_bh_enable_ip+0x118/0x150 [ 14.010822][ T244] __dev_queue_xmit+0x979/0x1b80 [ 14.010824][ T244] ip_finish_output2+0x5b9/0x1bc0 [ 14.010825][ T244] ip_output+0x1ca/0x660 [ 14.010827][ T244] ip_push_pending_frames+0xf6/0x250 [ 14.010828][ T244] raw_sendmsg+0x1169/0x1cc0 [ 14.010830][ T244] __sys_sendto+0x2aa/0x400 [ 14.010833][ T244] __x64_sys_sendto+0xe4/0x1f0 [ 14.010834][ T244] do_syscall_64+0xff/0x530 [ 14.010837][ T244] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 14.010839][ T244] [ 14.010839][ T244] to a SOFTIRQ-irq-unsafe lock: [ 14.010840][ T244] (fs_reclaim){+.+.}-{0:0} [ 14.010841][ T244] [ 14.010841][ T244] ... which became SOFTIRQ-irq-unsafe at: [ 14.010842][ T244] ... [ 14.010842][ T244] __lock_acquire+0x388/0xc20 [ 14.010844][ T244] lock_acquire.part.0+0xd4/0x280 [ 14.010845][ T244] fs_reclaim_acquire+0xd5/0x120 [ 14.010848][ T244] __kmalloc_cache_noprof+0x6e/0x620 [ 14.010850][ T244] kthread_create_worker_on_node+0xea/0x210 [ 14.010852][ T244] workqueue_init+0x2a/0x680 [ 14.010856][ T244] kernel_init_freeable+0x2fe/0x630 [ 14.010859][ T244] kernel_init+0x21/0x150 [ 14.010861][ T244] ret_from_fork+0x474/0x6b0 [ 14.010863][ T244] ret_from_fork_asm+0x11/0x20 [ 14.010866][ T244] [ 14.010866][ T244] other info that might help us debug this: [ 14.010866][ T244] [ 14.010866][ T244] Chain exists of: [ 14.010866][ T244] slock-AF_INET/2 --> console_owner --> fs_reclaim [ 14.010866][ T244] [ 14.010869][ T244] Possible interrupt unsafe locking scenario: [ 14.010869][ T244] [ 14.010869][ T244] CPU0 CPU1 [ 14.010870][ T244] ---- ---- [ 14.010870][ T244] lock(fs_reclaim); [ 14.010871][ T244] local_irq_disable(); [ 14.010871][ T244] lock(slock-AF_INET/2); [ 14.010872][ T244] lock(console_owner); [ 14.010873][ T244] [ 14.010874][ T244] lock(slock-AF_INET/2); [ 14.010875][ T244] [ 14.010875][ T244] *** DEADLOCK *** [ 14.010875][ T244] [ 14.010875][ T244] locks held by ping/244: 14, last CPU#2: [ 14.010877][ T244] #0: ff11000005996290 (sk_lock-AF_INET){+.+.}-{0:0}, at: raw_sendmsg+0xba5/0x1cc0 [ 14.010880][ T244] #1: ffffffff87990b00 (rcu_read_lock){....}-{1:3}, at: ip_output+0xa9/0x660 [ 14.010883][ T244] #2: ffffffff87990b00 (rcu_read_lock){....}-{1:3}, at: ip_finish_output2+0x25c/0x1bc0 [ 14.010886][ T244] #3: ffffffff87990aa0 (rcu_read_lock_bh){....}-{1:3}, at: __dev_queue_xmit+0x1fc/0x1b80 [ 14.010889][ T244] #4: ffd1ffffffd06008 (&xmit_recursion->bh_lock){+.-.}-{3:3}, at: ppp_xmit_process+0x1d2/0x8e0 [ppp_generic] [ 14.010892][ T244] #5: ff1100000c7d2fd0 (&ppp->wlock){+.-.}-{3:3}, at: ppp_xmit_process+0x292/0x8e0 [ppp_generic] [ 14.010895][ T244] #6: ff1100000c6065d0 (&pch->downl){+.-.}-{3:3}, at: ppp_push+0xae/0x2d0 [ppp_generic] [ 14.010898][ T244] #7: ff1100000599d998 (slock-AF_INET/2){+.-.}-{3:3}, at: l2tp_xmit_core.constprop.0+0x480/0x19b0 [l2tp_core] [ 14.010902][ T244] #8: ffffffff87990b00 (rcu_read_lock){....}-{1:3}, at: __ip_queue_xmit+0x63/0x1650 [ 14.010905][ T244] #9: ffffffff87990b00 (rcu_read_lock){....}-{1:3}, at: ip_output+0xa9/0x660 [ 14.010908][ T244] #10: ffffffff87990b00 (rcu_read_lock){....}-{1:3}, at: ip_finish_output2+0x25c/0x1bc0 [ 14.010911][ T244] #11: ffffffff87990aa0 (rcu_read_lock_bh){....}-{1:3}, at: __dev_queue_xmit+0x1fc/0x1b80 [ 14.010914][ T244] #12: ffffffff87979cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 14.010917][ T244] #13: ffffffff87979d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 14.010920][ T244] [ 14.010920][ T244] the dependencies between SOFTIRQ-irq-safe lock and the holding lock: [ 14.010921][ T244] -> (slock-AF_INET/2){+.-.}-{3:3} { [ 14.010923][ T244] HARDIRQ-ON-W at: [ 14.010924][ T244] __lock_acquire+0x388/0xc20 [ 14.010926][ T244] lock_acquire.part.0+0xd4/0x280 [ 14.010927][ T244] _raw_spin_lock_nested+0x3d/0x50 [ 14.010928][ T244] l2tp_xmit_core.constprop.0+0x480/0x19b0 [l2tp_core] [ 14.010930][ T244] l2tp_xmit_skb+0x77/0x1d0 [l2tp_core] [ 14.010932][ T244] pppol2tp_xmit+0x436/0x690 [l2tp_ppp] [ 14.010933][ T244] __ppp_channel_push+0xed/0x280 [ppp_generic] [ 14.010935][ T244] ppp_channel_push+0x269/0x7b0 [ppp_generic] [ 14.010937][ T244] ppp_write+0x26b/0x350 [ppp_generic] [ 14.010939][ T244] vfs_write+0x1a4/0xbd0 [ 14.010941][ T244] ksys_write+0x116/0x250 [ 14.010943][ T244] do_syscall_64+0xff/0x530 [ 14.010944][ T244] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 14.010946][ T244] IN-SOFTIRQ-W at: [ 14.010946][ T244] __lock_acquire+0x388/0xc20 [ 14.010948][ T244] lock_acquire.part.0+0xd4/0x280 [ 14.010949][ T244] _raw_spin_lock_nested+0x3d/0x50 [ 14.010950][ T244] l2tp_xmit_core.constprop.0+0x480/0x19b0 [l2tp_core] [ 14.010952][ T244] l2tp_xmit_skb+0x77/0x1d0 [l2tp_core] [ 14.010954][ T244] pppol2tp_xmit+0x436/0x690 [l2tp_ppp] [ 14.010955][ T244] ppp_push+0x165/0x2d0 [ppp_generic] [ 14.010957][ T244] ppp_xmit_process+0x318/0x8e0 [ppp_generic] [ 14.010958][ T244] ppp_start_xmit+0x4a0/0x7c0 [ppp_generic] [ 14.010960][ T244] dev_hard_start_xmit+0xf4/0x620 [ 14.010962][ T244] __dev_queue_xmit+0xc0a/0x1b80 [ 14.010963][ T244] ip_finish_output2+0x5b9/0x1bc0 [ 14.010965][ T244] ip_output+0x1ca/0x660 [ 14.010966][ T244] ip_push_pending_frames+0xf6/0x250 [ 14.010967][ T244] icmp_reply+0x94d/0xa50 [ 14.010969][ T244] icmp_echo+0x2ab/0x4b0 [ 14.010970][ T244] icmp_rcv+0x92f/0xfb0 [ 14.010972][ T244] ip_protocol_deliver_rcu+0x82/0x350 [ 14.010973][ T244] ip_local_deliver_finish+0x36f/0x610 [ 14.010975][ T244] ip_local_deliver+0x184/0x4c0 [ 14.010976][ T244] ip_rcv+0xdc/0x3d0 [ 14.010977][ T244] __netif_receive_skb_one_core+0xfc/0x180 [ 14.010979][ T244] process_backlog+0x431/0x14c0 [ 14.010980][ T244] __napi_poll+0xa7/0x3b0 [ 14.010982][ T244] net_rx_action+0x513/0xf50 [ 14.010983][ T244] handle_softirqs+0x1d3/0x900 [ 14.010985][ T244] do_softirq+0xac/0xe0 [ 14.010986][ T244] __local_bh_enable_ip+0x118/0x150 [ 14.010987][ T244] __dev_queue_xmit+0x979/0x1b80 [ 14.010988][ T244] ip_finish_output2+0x5b9/0x1bc0 [ 14.010990][ T244] ip_output+0x1ca/0x660 [ 14.010991][ T244] ip_push_pending_frames+0xf6/0x250 [ 14.010993][ T244] raw_sendmsg+0x1169/0x1cc0 [ 14.010994][ T244] __sys_sendto+0x2aa/0x400 [ 14.010995][ T244] __x64_sys_sendto+0xe4/0x1f0 [ 14.010997][ T244] do_syscall_64+0xff/0x530 [ 14.010998][ T244] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 14.011000][ T244] INITIAL USE at: [ 14.011000][ T244] __lock_acquire+0x388/0xc20 [ 14.011002][ T244] lock_acquire.part.0+0xd4/0x280 [ 14.011003][ T244] _raw_spin_lock_nested+0x3d/0x50 [ 14.011004][ T244] l2tp_xmit_core.constprop.0+0x480/0x19b0 [l2tp_core] [ 14.011006][ T244] l2tp_xmit_skb+0x77/0x1d0 [l2tp_core] [ 14.011008][ T244] pppol2tp_xmit+0x436/0x690 [l2tp_ppp] [ 14.011010][ T244] __ppp_channel_push+0xed/0x280 [ppp_generic] [ 14.011011][ T244] ppp_channel_push+0x269/0x7b0 [ppp_generic] [ 14.011013][ T244] ppp_write+0x26b/0x350 [ppp_generic] [ 14.011014][ T244] vfs_write+0x1a4/0xbd0 [ 14.011016][ T244] ksys_write+0x116/0x250 [ 14.011017][ T244] do_syscall_64+0xff/0x530 [ 14.011019][ T244] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 14.011020][ T244] } [ 14.011020][ T244] ... key at: [] af_family_slock_keys+0x22/0x300 [ 14.011023][ T244] [ 14.011023][ T244] the dependencies between the lock to be acquired [ 14.011024][ T244] and SOFTIRQ-irq-unsafe lock: [ 14.011029][ T244] -> (fs_reclaim){+.+.}-{0:0} { [ 14.011030][ T244] HARDIRQ-ON-W at: [ 14.011031][ T244] __lock_acquire+0x388/0xc20 [ 14.011032][ T244] lock_acquire.part.0+0xd4/0x280 [ 14.011034][ T244] fs_reclaim_acquire+0xd5/0x120 [ 14.011035][ T244] __kmalloc_cache_noprof+0x6e/0x620 [ 14.011036][ T244] kthread_create_worker_on_node+0xea/0x210 [ 14.011037][ T244] workqueue_init+0x2a/0x680 [ 14.011038][ T244] kernel_init_freeable+0x2fe/0x630 [ 14.011040][ T244] kernel_init+0x21/0x150 [ 14.011041][ T244] ret_from_fork+0x474/0x6b0 [ 14.011042][ T244] ret_from_fork_asm+0x11/0x20 [ 14.011043][ T244] SOFTIRQ-ON-W at: [ 14.011044][ T244] __lock_acquire+0x388/0xc20 [ 14.011045][ T244] lock_acquire.part.0+0xd4/0x280 [ 14.011047][ T244] fs_reclaim_acquire+0xd5/0x120 [ 14.011048][ T244] __kmalloc_cache_noprof+0x6e/0x620 [ 14.011049][ T244] kthread_create_worker_on_node+0xea/0x210 [ 14.011050][ T244] workqueue_init+0x2a/0x680 [ 14.011051][ T244] kernel_init_freeable+0x2fe/0x630 [ 14.011053][ T244] kernel_init+0x21/0x150 [ 14.011054][ T244] ret_from_fork+0x474/0x6b0 [ 14.011055][ T244] ret_from_fork_asm+0x11/0x20 [ 14.011056][ T244] INITIAL USE at: [ 14.011057][ T244] __lock_acquire+0x388/0xc20 [ 14.011058][ T244] lock_acquire.part.0+0xd4/0x280 [ 14.011060][ T244] fs_reclaim_acquire+0xd5/0x120 [ 14.011061][ T244] __kmalloc_cache_noprof+0x6e/0x620 [ 14.011062][ T244] kthread_create_worker_on_node+0xea/0x210 [ 14.011063][ T244] workqueue_init+0x2a/0x680 [ 14.011064][ T244] kernel_init_freeable+0x2fe/0x630 [ 14.011066][ T244] kernel_init+0x21/0x150 [ 14.011067][ T244] ret_from_fork+0x474/0x6b0 [ 14.011068][ T244] ret_from_fork_asm+0x11/0x20 [ 14.011070][ T244] } [ 14.011070][ T244] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 14.011073][ T244] ... acquired at: [ 14.011074][ T244] __lock_acquire+0x518/0xc20 [ 14.011076][ T244] lock_acquire.part.0+0xd4/0x280 [ 14.011077][ T244] fs_reclaim_acquire+0xd5/0x120 [ 14.011078][ T244] __kmalloc_noprof+0xd3/0x760 [ 14.011079][ T244] alloc_buf.isra.0+0x4b/0x260 [ 14.011082][ T244] put_chars+0x1e1/0x2f0 [ 14.011084][ T244] hvc_console_print+0x292/0x780 [ 14.011086][ T244] console_emit_next_record+0x22f/0x4c0 [ 14.011087][ T244] console_flush_one_record+0x46f/0x710 [ 14.011089][ T244] console_unlock+0xee/0x1f0 [ 14.011090][ T244] vprintk_emit+0x37c/0x3e0 [ 14.011092][ T244] dev_vprintk_emit+0x27f/0x2c0 [ 14.011095][ T244] dev_printk_emit+0xb9/0xee [ 14.011097][ T244] _dev_info+0xe2/0x116 [ 14.011098][ T244] cmos_do_probe+0x8be/0x98a [ 14.011101][ T244] platform_probe+0xfe/0x1f0 [ 14.011103][ T244] call_driver_probe+0x61/0x1c0 [ 14.011105][ T244] really_probe+0x199/0x760 [ 14.011107][ T244] __driver_probe_device+0x24f/0x440 [ 14.011108][ T244] driver_probe_device+0x4a/0xf0 [ 14.011110][ T244] __driver_attach+0x1b8/0x540 [ 14.011111][ T244] bus_for_each_dev+0x130/0x1e0 [ 14.011113][ T244] bus_add_driver+0x2c8/0x530 [ 14.011114][ T244] driver_register+0x1a3/0x390 [ 14.011115][ T244] __platform_driver_probe+0x13f/0x270 [ 14.011116][ T244] cmos_init+0x31/0x40 [ 14.011119][ T244] do_one_initcall+0x124/0x4f0 [ 14.011121][ T244] kernel_init_freeable+0x596/0x630 [ 14.011122][ T244] kernel_init+0x21/0x150 [ 14.011123][ T244] ret_from_fork+0x474/0x6b0 [ 14.011124][ T244] ret_from_fork_asm+0x11/0x20 [ 14.011126][ T244] [ 14.011126][ T244] -> (console_owner){....}-{0:0} { [ 14.011128][ T244] INITIAL USE at: [ 14.011129][ T244] } [ 14.011129][ T244] ... key at: [] console_owner_dep_map+0x0/0x60 [ 14.011133][ T244] ... acquired at: [ 14.011134][ T244] check_prev_add+0xef/0xe90 [ 14.011135][ T244] validate_chain+0x6b8/0xc20 [ 14.011136][ T244] __lock_acquire+0x518/0xc20 [ 14.011137][ T244] lock_acquire.part.0+0xd4/0x280 [ 14.011139][ T244] console_lock_spinning_enable+0x5c/0x60 [ 14.011140][ T244] console_emit_next_record+0x1d1/0x4c0 [ 14.011142][ T244] console_flush_one_record+0x46f/0x710 [ 14.011143][ T244] console_unlock+0xee/0x1f0 [ 14.011144][ T244] vprintk_emit+0x37c/0x3e0 [ 14.011146][ T244] _printk+0xc7/0x100 [ 14.011148][ T244] netdev_err+0xe2/0x120 [ 14.011150][ T244] ppp_xmit_process.cold+0x13/0x18 [ppp_generic] [ 14.011152][ T244] ppp_start_xmit+0x4a0/0x7c0 [ppp_generic] [ 14.011154][ T244] dev_hard_start_xmit+0xf4/0x620 [ 14.011156][ T244] __dev_queue_xmit+0xc0a/0x1b80 [ 14.011157][ T244] ip_finish_output2+0x5b9/0x1bc0 [ 14.011158][ T244] ip_output+0x1ca/0x660 [ 14.011160][ T244] __ip_queue_xmit+0x774/0x1650 [ 14.011161][ T244] l2tp_xmit_core.constprop.0+0x999/0x19b0 [l2tp_core] [ 14.011163][ T244] l2tp_xmit_skb+0x77/0x1d0 [l2tp_core] [ 14.011165][ T244] pppol2tp_xmit+0x436/0x690 [l2tp_ppp] [ 14.011166][ T244] ppp_push+0x165/0x2d0 [ppp_generic] [ 14.011168][ T244] ppp_xmit_process+0x318/0x8e0 [ppp_generic] [ 14.011169][ T244] ppp_start_xmit+0x4a0/0x7c0 [ppp_generic] [ 14.011171][ T244] dev_hard_start_xmit+0xf4/0x620 [ 14.011172][ T244] __dev_queue_xmit+0xc0a/0x1b80 [ 14.011174][ T244] ip_finish_output2+0x5b9/0x1bc0 [ 14.011175][ T244] ip_output+0x1ca/0x660 [ 14.011177][ T244] ip_push_pending_frames+0xf6/0x250 [ 14.011178][ T244] raw_sendmsg+0x1169/0x1cc0 [ 14.011179][ T244] __sys_sendto+0x2aa/0x400 [ 14.011181][ T244] __x64_sys_sendto+0xe4/0x1f0 [ 14.011182][ T244] do_syscall_64+0xff/0x530 [ 14.011183][ T244] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 14.011184][ T244] [ 14.011185][ T244] [ 14.011185][ T244] stack backtrace: [ 14.011187][ T244] CPU: 2 UID: 0 PID: 244 Comm: ping Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 14.011190][ T244] Tainted: [W]=WARN [ 14.011191][ T244] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.011192][ T244] Call Trace: [ 14.011193][ T244] [ 14.011195][ T244] dump_stack_lvl+0x6f/0xa0 [ 14.011198][ T244] print_bad_irq_dependency+0x3e4/0x410 [ 14.011201][ T244] check_irq_usage+0x403/0x570 [ 14.011207][ T244] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 14.011211][ T244] ? rcu_read_lock_any_held+0x3c/0x90 [ 14.011213][ T244] ? check_path.constprop.0+0x24/0x50 [ 14.011216][ T244] ? check_prev_add+0xef/0xe90 [ 14.011217][ T244] check_prev_add+0xef/0xe90 [ 14.011219][ T244] validate_chain+0x6b8/0xc20 [ 14.011221][ T244] __lock_acquire+0x518/0xc20 [ 14.011223][ T244] lock_acquire.part.0+0xd4/0x280 [ 14.011225][ T244] ? console_lock_spinning_enable+0x40/0x60 [ 14.011227][ T244] ? rcu_is_watching+0x16/0xd0 [ 14.011229][ T244] ? lock_acquire+0x13c/0x160 [ 14.011230][ T244] console_lock_spinning_enable+0x5c/0x60 [ 14.011232][ T244] ? console_lock_spinning_enable+0x40/0x60 [ 14.011234][ T244] console_emit_next_record+0x1d1/0x4c0 [ 14.011236][ T244] ? devkmsg_read+0x4b0/0x4b0 [ 14.011237][ T244] ? console_flush_one_record+0x106/0x710 [ 14.011239][ T244] ? rcu_is_watching+0x16/0xd0 [ 14.011241][ T244] ? lock_acquire+0x13c/0x160 [ 14.011243][ T244] console_flush_one_record+0x46f/0x710 [ 14.011245][ T244] ? console_emit_next_record+0x4c0/0x4c0 [ 14.011246][ T244] ? __lock_acquire+0x518/0xc20 [ 14.011249][ T244] console_unlock+0xee/0x1f0 [ 14.011250][ T244] ? console_flush_one_record+0x710/0x710 [ 14.011252][ T244] ? rcu_is_watching+0x16/0xd0 [ 14.011254][ T244] ? lock_acquire+0x60/0x160 [ 14.011255][ T244] ? __down_trylock_console_sem+0x5e/0xa0 [ 14.011257][ T244] ? vprintk_emit+0x320/0x3e0 [ 14.011259][ T244] vprintk_emit+0x37c/0x3e0 [ 14.011261][ T244] ? wake_up_klogd_work_func+0x90/0x90 [ 14.011263][ T244] ? mark_lock+0x3bb/0xa00 [ 14.011265][ T244] _printk+0xc7/0x100 [ 14.011266][ T244] ? snapshot_read.cold+0x21/0x21 [ 14.011268][ T244] ? lock_acquire.part.0+0xd4/0x280 [ 14.011270][ T244] ? find_held_lock+0x2b/0x80 [ 14.011271][ T244] ? netdev_name+0x43/0x60 [ 14.011272][ T244] ? __netdev_printk+0x17f/0x1d0 [ 14.011274][ T244] netdev_err+0xe2/0x120 [ 14.011275][ T244] ? netdev_crit+0x120/0x120 [ 14.011276][ T244] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 14.011278][ T244] ? ___ratelimit+0x4e7/0xa00 [ 14.011281][ T244] ? idr_get_free+0x830/0x830 [ 14.011283][ T244] ppp_xmit_process.cold+0x13/0x18 [ppp_generic] [ 14.011285][ T244] ? ppp_prepare_tx_skb+0xcf0/0xcf0 [ppp_generic] [ 14.011287][ T244] ? dst_release+0x54/0x240 [ 14.011290][ T244] ppp_start_xmit+0x4a0/0x7c0 [ppp_generic] [ 14.011292][ T244] ? dev_nit_active_rcu+0x1f/0xf0 [ 14.011294][ T244] ? rcu_is_watching+0x16/0xd0 [ 14.011296][ T244] dev_hard_start_xmit+0xf4/0x620 [ 14.011298][ T244] ? rcu_is_watching+0x16/0xd0 [ 14.011300][ T244] __dev_queue_xmit+0xc0a/0x1b80 [ 14.011302][ T244] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 14.011304][ T244] ? lockdep_hardirqs_on+0x91/0x130 [ 14.011305][ T244] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 14.011306][ T244] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 14.011308][ T244] ? ref_tracker_dir_print+0x100/0x100 [ 14.011311][ T244] ? dst_init+0x84/0x530 [ 14.011312][ T244] ? dst_alloc+0x97/0x160 [ 14.011314][ T244] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 14.011315][ T244] ? ip_route_output_flow+0x21/0x150 [ 14.011317][ T244] ? __ip_queue_xmit+0xdc7/0x1650 [ 14.011318][ T244] ? __lock_acquire+0x518/0xc20 [ 14.011320][ T244] ? down_read_nested+0xe7/0x500 [ 14.011321][ T244] ? lock_acquire.part.0+0xd4/0x280 [ 14.011323][ T244] ? ip_finish_output2+0x25c/0x1bc0 [ 14.011324][ T244] ? rcu_is_watching+0x16/0xd0 [ 14.011327][ T244] ip_finish_output2+0x5b9/0x1bc0 [ 14.011328][ T244] ? ip_dst_mtu_maybe_forward+0x261/0x670 [ 14.011330][ T244] ? lock_acquire.part.0+0xd4/0x280 [ 14.011331][ T244] ? ip_fragment.constprop.0+0x2c0/0x2c0 [ 14.011334][ T244] ip_output+0x1ca/0x660 [ 14.011336][ T244] ? ip_finish_output+0x460/0x460 [ 14.011337][ T244] ? find_held_lock+0x2b/0x80 [ 14.011339][ T244] ? __lock_release.isra.0+0x69/0x1a0 [ 14.011340][ T244] ? ip4_dst_hoplimit+0x15b/0x320 [ 14.011342][ T244] __ip_queue_xmit+0x774/0x1650 [ 14.011345][ T244] l2tp_xmit_core.constprop.0+0x999/0x19b0 [l2tp_core] [ 14.011348][ T244] l2tp_xmit_skb+0x77/0x1d0 [l2tp_core] [ 14.011351][ T244] ? l2tp_xmit_core.constprop.0+0x19b0/0x19b0 [l2tp_core] [ 14.011353][ T244] ? do_raw_spin_lock+0x131/0x280 [ 14.011356][ T244] ? pppol2tp_xmit+0x423/0x690 [l2tp_ppp] [ 14.011357][ T244] pppol2tp_xmit+0x436/0x690 [l2tp_ppp] [ 14.011359][ T244] ppp_push+0x165/0x2d0 [ppp_generic] [ 14.011361][ T244] ppp_xmit_process+0x318/0x8e0 [ppp_generic] [ 14.011363][ T244] ? ppp_prepare_tx_skb+0xcf0/0xcf0 [ppp_generic] [ 14.011365][ T244] ? dst_release+0x54/0x240 [ 14.011367][ T244] ppp_start_xmit+0x4a0/0x7c0 [ppp_generic] [ 14.011369][ T244] ? dev_nit_active_rcu+0x1f/0xf0 [ 14.011371][ T244] ? rcu_is_watching+0x16/0xd0 [ 14.011373][ T244] dev_hard_start_xmit+0xf4/0x620 [ 14.011375][ T244] ? rcu_is_watching+0x16/0xd0 [ 14.011377][ T244] __dev_queue_xmit+0xc0a/0x1b80 [ 14.011380][ T244] ? __asan_memset+0x27/0x50 [ 14.011382][ T244] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 14.011383][ T244] ? _get_random_bytes+0x1f8/0x280 [ 14.011385][ T244] ? __lock_acquire+0x518/0xc20 [ 14.011386][ T244] ? down_read_nested+0xe7/0x500 [ 14.011388][ T244] ? lock_acquire.part.0+0xd4/0x280 [ 14.011389][ T244] ? ip_finish_output2+0x25c/0x1bc0 [ 14.011391][ T244] ? rcu_is_watching+0x16/0xd0 [ 14.011393][ T244] ip_finish_output2+0x5b9/0x1bc0 [ 14.011395][ T244] ? ip_dst_mtu_maybe_forward+0x261/0x670 [ 14.011396][ T244] ? lock_acquire.part.0+0xd4/0x280 [ 14.011398][ T244] ? ip_fragment.constprop.0+0x2c0/0x2c0 [ 14.011400][ T244] ? rcu_is_watching+0x16/0xd0 [ 14.011402][ T244] ip_output+0x1ca/0x660 [ 14.011404][ T244] ? ip_finish_output+0x460/0x460 [ 14.011405][ T244] ? __ip_make_skb+0x106a/0x2300 [ 14.011408][ T244] ip_push_pending_frames+0xf6/0x250 [ 14.011410][ T244] raw_sendmsg+0x1169/0x1cc0 [ 14.011412][ T244] ? raw_send_hdrinc+0x1740/0x1740 [ 14.011413][ T244] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 14.011417][ T244] ? __might_fault+0x97/0x140 [ 14.011420][ T244] ? __might_fault+0x97/0x140 [ 14.011422][ T244] ? __might_fault+0x97/0x140 [ 14.011424][ T244] __sys_sendto+0x2aa/0x400 [ 14.011426][ T244] ? __ia32_sys_getpeername+0xd0/0xd0 [ 14.011429][ T244] ? exc_page_fault+0x87/0x100 [ 14.011431][ T244] __x64_sys_sendto+0xe4/0x1f0 [ 14.011433][ T244] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.011435][ T244] ? lockdep_hardirqs_on+0x91/0x130 [ 14.011436][ T244] ? do_syscall_64+0xa6/0x530 [ 14.011438][ T244] do_syscall_64+0xff/0x530 [ 14.011439][ T244] ? exc_page_fault+0xee/0x100 [ 14.011441][ T244] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 14.011442][ T244] RIP: 0033:0x7f9a8ee2b54e [ 14.011445][ T244] Code: 4d 89 d8 e8 b4 bd 00 00 4c 8b 5d f8 41 8b 93 08 03 00 00 59 5e 48 83 f8 fc 74 11 c9 c3 0f 1f 80 00 00 00 00 48 8b 45 10 0f 05 c3 83 e2 39 83 fa 08 75 e7 e8 03 ff ff ff 0f 1f 00 f3 0f 1e fa [ 14.011446][ T244] RSP: 002b:00007ffffdae5dc0 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 14.011451][ T244] RAX: ffffffffffffffda RBX: 0000000000000040 RCX: 00007f9a8ee2b54e [ 14.011453][ T244] RDX: 0000000000000040 RSI: 0000558a80fc90a4 RDI: 0000000000000005 [ 14.011454][ T244] RBP: 00007ffffdae5dd0 R08: 0000558a80fdb320 R09: 0000000000000010 [ 14.011454][ T244] R10: 0000000000000000 R11: 0000000000000202 R12: 431bde82d7b634db [ 14.011455][ T244] R13: 0000000000000000 R14: 0000558a80fdc3e0 R15: 0000558a80fc90a0 [ 14.011457][ T244] [ 15.025687][ T244] ping (244) used greatest stack depth: 22536 bytes left [ 15.025694][ T244] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 15.025696][ T244] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 244, name: ping [ 15.025697][ T244] preempt_count: 2, expected: 0 [ 15.025698][ T244] RCU nest depth: 0, expected: 0 [ 15.025699][ T244] INFO: lockdep is turned off. [ 15.025700][ T244] irq event stamp: 28713 [ 15.025700][ T244] hardirqs last enabled at (28712): [] __down_trylock_console_sem+0x86/0xa0 [ 15.025707][ T244] hardirqs last disabled at (28713): [] console_emit_next_record+0x3d4/0x4c0 [ 15.025709][ T244] softirqs last enabled at (28616): [] __alloc_skb+0x4c2/0x5f0 [ 15.025712][ T244] softirqs last disabled at (28626): [] __dev_queue_xmit+0x1fc/0x1b80 [ 15.025716][ T244] Preemption disabled at: [ 15.025716][ T244] [<0000000000000000>] 0x0 [ 15.025720][ T244] CPU: 2 UID: 0 PID: 244 Comm: ping Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 15.025724][ T244] Tainted: [W]=WARN [ 15.025725][ T244] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.025726][ T244] Call Trace: [ 15.025727][ T244] [ 15.025728][ T244] dump_stack_lvl+0x6f/0xa0 [ 15.025732][ T244] __might_resched.cold+0x1fe/0x2c1 [ 15.025735][ T244] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 15.025739][ T244] ? __asan_memcpy+0x3c/0x60 [ 15.025741][ T244] ? rcu_is_watching+0x16/0xd0 [ 15.025745][ T244] __kmalloc_noprof+0x443/0x760 [ 15.025748][ T244] ? __rwlock_init+0x150/0x150 [ 15.025750][ T244] ? alloc_buf.isra.0+0x4b/0x260 [ 15.025754][ T244] ? do_raw_spin_unlock+0x59/0x250 [ 15.025755][ T244] alloc_buf.isra.0+0x4b/0x260 [ 15.025757][ T244] put_chars+0x1e1/0x2f0 [ 15.025759][ T244] ? __send_to_port+0x420/0x420 [ 15.025760][ T244] ? console_prepend_replay+0x20/0x20 [ 15.025763][ T244] hvc_console_print+0x292/0x780 [ 15.025766][ T244] ? hvc_write+0x3a0/0x3a0 [ 15.025767][ T244] ? rcu_is_watching+0x16/0xd0 [ 15.025769][ T244] ? lock_acquire+0x13c/0x160 [ 15.025771][ T244] console_emit_next_record+0x22f/0x4c0 [ 15.025773][ T244] ? devkmsg_read+0x4b0/0x4b0 [ 15.025775][ T244] ? rcu_is_watching+0x16/0xd0 [ 15.025777][ T244] ? rcu_is_watching+0x16/0xd0 [ 15.025779][ T244] ? rcu_is_watching+0x16/0xd0 [ 15.025780][ T244] ? lock_acquire+0x13c/0x160 [ 15.025782][ T244] ? console_flush_one_record+0x111/0x710 [ 15.025784][ T244] console_flush_one_record+0x46f/0x710 [ 15.025786][ T244] ? console_emit_next_record+0x4c0/0x4c0 [ 15.025788][ T244] console_unlock+0xee/0x1f0 [ 15.025790][ T244] ? lock_acquire+0x13c/0x160 [ 15.025791][ T244] ? console_flush_one_record+0x710/0x710 [ 15.025793][ T244] ? rcu_is_watching+0x16/0xd0 [ 15.025794][ T244] ? lock_release+0x184/0x1f0 [ 15.025796][ T244] ? lock_acquire+0x60/0x160 [ 15.025797][ T244] ? __rcu_read_lock+0x30/0x70 [ 15.025799][ T244] ? __down_trylock_console_sem+0x5e/0xa0 [ 15.025801][ T244] ? vprintk_emit+0x320/0x3e0 [ 15.025803][ T244] vprintk_emit+0x37c/0x3e0 [ 15.025805][ T244] ? wake_up_klogd_work_func+0x90/0x90 [ 15.025807][ T244] ? do_raw_read_unlock+0x70/0x70 [ 15.025808][ T244] ? forget_original_parent+0x5c/0xdb0 [ 15.025812][ T244] _printk+0xc7/0x100 [ 15.025815][ T244] ? snapshot_read.cold+0x21/0x21 [ 15.025816][ T244] ? do_raw_spin_lock+0x131/0x280 [ 15.025818][ T244] ? do_raw_spin_lock+0x131/0x280 [ 15.025819][ T244] ? __rwlock_init+0x150/0x150 [ 15.025821][ T244] ? do_raw_spin_lock+0x131/0x280 [ 15.025823][ T244] do_exit.cold+0x82/0x9c [ 15.025826][ T244] ? exit_notify+0x890/0x890 [ 15.025827][ T244] ? posixtimer_sig_unignore.isra.0+0x5f0/0x5f0 [ 15.025830][ T244] ? rcu_is_watching+0x16/0xd0 [ 15.025832][ T244] do_group_exit+0xb8/0x370 [ 15.025833][ T244] __x64_sys_exit_group+0x3c/0x50 [ 15.025835][ T244] x64_sys_call+0x1567/0x1570 [ 15.025837][ T244] do_syscall_64+0xff/0x530 [ 15.025840][ T244] ? exc_page_fault+0xee/0x100 [ 15.025841][ T244] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 15.025843][ T244] RIP: 0033:0x7f9a8ee7c1b8 [ 15.025845][ T244] Code: Unable to access opcode bytes at 0x7f9a8ee7c18e. [ 15.025846][ T244] RSP: 002b:00007ffffdae7558 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 15.025848][ T244] RAX: ffffffffffffffda RBX: 00007f9a8efacf88 RCX: 00007f9a8ee7c1b8 [ 15.025850][ T244] RDX: 00007f9a8ec0d7c8 RSI: ffffffffffffffb0 RDI: 0000000000000001 [ 15.025851][ T244] RBP: 00007ffffdae75b0 R08: 0000000000000000 R09: 0000000000001010 [ 15.025851][ T244] R10: 00007ffffdae73d0 R11: 0000000000000246 R12: 0000000000000002 [ 15.025852][ T244] R13: 0000000000000001 R14: 00007f9a8efab680 R15: 00007f9a8efacfa0 [ 15.025854][ T244] [ 15.056841][ T205] ppp0: recursion detected