[ 9.727283][ T203] ip (203) used greatest stack depth: 24080 bytes left [ 9.727301][ T203] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 9.727303][ T203] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 203, name: ip [ 9.727304][ T203] preempt_count: 2, expected: 0 [ 9.727305][ T203] RCU nest depth: 0, expected: 0 [ 9.727306][ T203] locks held by ip/203: 5, last CPU#2: [ 9.727308][ T203] #0: ffffffffaa2167b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 9.727319][ T203] #1: ffffffffaa37ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 9.727324][ T203] #2: ffffffffaa37de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 9.727328][ T203] #3: ffffffffaa29d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 9.727332][ T203] #4: ffffffffaa29d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 9.727336][ T203] irq event stamp: 20544 [ 9.727337][ T203] hardirqs last enabled at (20543): [] __down_trylock_console_sem+0x86/0xa0 [ 9.727339][ T203] hardirqs last disabled at (20544): [] console_emit_next_record+0x3d4/0x4c0 [ 9.727341][ T203] softirqs last enabled at (19466): [] handle_softirqs+0x67c/0x900 [ 9.727344][ T203] softirqs last disabled at (19457): [] __irq_exit_rcu+0x145/0x1c0 [ 9.727346][ T203] Preemption disabled at: [ 9.727347][ T203] [<0000000000000000>] 0x0 [ 9.727353][ T203] CPU: 2 UID: 0 PID: 203 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.727356][ T203] Tainted: [W]=WARN [ 9.727357][ T203] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.727359][ T203] Call Trace: [ 9.727360][ T203] [ 9.727362][ T203] dump_stack_lvl+0x6f/0xa0 [ 9.727368][ T203] __might_resched.cold+0x1fe/0x2c1 [ 9.727372][ T203] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 9.727376][ T203] ? __kmalloc_noprof+0xdb/0x760 [ 9.727381][ T203] __kmalloc_noprof+0x443/0x760 [ 9.727382][ T203] ? alloc_buf.isra.0+0x4b/0x260 [ 9.727389][ T203] ? do_raw_spin_unlock+0x59/0x250 [ 9.727392][ T203] alloc_buf.isra.0+0x4b/0x260 [ 9.727395][ T203] put_chars+0x1e1/0x2f0 [ 9.727398][ T203] ? __send_to_port+0x420/0x420 [ 9.727399][ T203] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 9.727402][ T203] ? validate_chain+0x38b/0xc20 [ 9.727408][ T203] hvc_console_print+0x292/0x780 [ 9.727415][ T203] ? hvc_write+0x3a0/0x3a0 [ 9.727418][ T203] ? rcu_is_watching+0x16/0xd0 [ 9.727420][ T203] ? lock_acquire+0x13c/0x160 [ 9.727424][ T203] console_emit_next_record+0x22f/0x4c0 [ 9.727428][ T203] ? devkmsg_read+0x4b0/0x4b0 [ 9.727429][ T203] ? console_flush_one_record+0x106/0x710 [ 9.727433][ T203] ? rcu_is_watching+0x16/0xd0 [ 9.727434][ T203] ? lock_acquire+0x13c/0x160 [ 9.727438][ T203] console_flush_one_record+0x46f/0x710 [ 9.727442][ T203] ? console_emit_next_record+0x4c0/0x4c0 [ 9.727444][ T203] ? __lock_acquire+0x518/0xc20 [ 9.727449][ T203] console_unlock+0xee/0x1f0 [ 9.727452][ T203] ? console_flush_one_record+0x710/0x710 [ 9.727454][ T203] ? rcu_is_watching+0x16/0xd0 [ 9.727456][ T203] ? lock_acquire+0xe0/0x160 [ 9.727460][ T203] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.727463][ T203] ? vprintk_emit+0x320/0x3e0 [ 9.727466][ T203] vprintk_emit+0x37c/0x3e0 [ 9.727469][ T203] ? wake_up_klogd_work_func+0x90/0x90 [ 9.727472][ T203] ? __lock_acquire+0x518/0xc20 [ 9.727476][ T203] _printk+0xc7/0x100 [ 9.727479][ T203] ? snapshot_read.cold+0x21/0x21 [ 9.727482][ T203] ? do_raw_spin_lock+0x131/0x280 [ 9.727485][ T203] ? __rwlock_init+0x150/0x150 [ 9.727489][ T203] ? do_raw_spin_lock+0x131/0x280 [ 9.727491][ T203] do_exit.cold+0x82/0x9c [ 9.727495][ T203] ? exit_notify+0x890/0x890 [ 9.727496][ T203] ? __lock_release.isra.0+0x69/0x1a0 [ 9.727499][ T203] ? rcu_is_watching+0x16/0xd0 [ 9.727502][ T203] do_group_exit+0xb8/0x370 [ 9.727505][ T203] __x64_sys_exit_group+0x3c/0x50 [ 9.727507][ T203] x64_sys_call+0x1567/0x1570 [ 9.727509][ T203] do_syscall_64+0xff/0x530 [ 9.727513][ T203] ? exc_page_fault+0xee/0x100 [ 9.727516][ T203] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.727518][ T203] RIP: 0033:0x7f35c91411b8 [ 9.727520][ T203] Code: Unable to access opcode bytes at 0x7f35c914118e. [ 9.727521][ T203] RSP: 002b:00007ffe721a0a08 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 9.727524][ T203] RAX: ffffffffffffffda RBX: 00007f35c9271f88 RCX: 00007f35c91411b8 [ 9.727525][ T203] RDX: 00007f35c8e8bfc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 9.727526][ T203] RBP: 00007ffe721a0a60 R08: 0000000000000000 R09: 0000000000000050 [ 9.727527][ T203] R10: 00007ffe721a0820 R11: 0000000000000246 R12: 0000000000000001 [ 9.727527][ T203] R13: 0000000000000000 R14: 00007f35c9270680 R15: 00007f35c9271fa0 [ 9.727534][ T203] [ 15.400457][ C1] IPv4: Oversized IP packet from 172.17.0.2 [ 15.400493][ C1] [ 15.400494][ C1] ======================================================== [ 15.400495][ C1] WARNING: possible irq lock inversion dependency detected [ 15.400497][ C1] 7.2.0-virtme #1 Tainted: G W [ 15.400498][ C1] -------------------------------------------------------- [ 15.400499][ C1] psock_snd/375 just changed the state of lock: [ 15.400500][ C1] ffffffffaa29d760 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 15.400512][ C1] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 15.400513][ C1] (fs_reclaim){+.+.}-{0:0} [ 15.400514][ C1] [ 15.400514][ C1] [ 15.400514][ C1] and interrupts could create inverse lock ordering between them. [ 15.400514][ C1] [ 15.400515][ C1] [ 15.400515][ C1] other info that might help us debug this: [ 15.400515][ C1] Possible interrupt unsafe locking scenario: [ 15.400515][ C1] [ 15.400516][ C1] CPU0 CPU1 [ 15.400516][ C1] ---- ---- [ 15.400517][ C1] lock(fs_reclaim); [ 15.400518][ C1] local_irq_disable(); [ 15.400518][ C1] lock(console_owner); [ 15.400519][ C1] lock(fs_reclaim); [ 15.400520][ C1] [ 15.400520][ C1] lock(console_owner); [ 15.400521][ C1] [ 15.400521][ C1] *** DEADLOCK *** [ 15.400521][ C1] [ 15.400521][ C1] locks held by psock_snd/375: 5, last CPU#1: [ 15.400523][ C1] #0: ffffffffaa394c00 (rcu_read_lock){....}-{1:3}, at: process_backlog+0x3f1/0x14c0 [ 15.400529][ C1] #1: ffffffffaa394c00 (rcu_read_lock){....}-{1:3}, at: ip_defrag+0xcd/0x7a0 [ 15.400532][ C1] #2: ff1100000e1223e8 (&q->lock){+.-.}-{3:3}, at: ip_defrag+0x2c4/0x7a0 [ 15.400535][ C1] #3: ffffffffaa37ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 15.400538][ C1] #4: ffffffffaa37de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 15.400541][ C1] [ 15.400541][ C1] the shortest dependencies between 2nd lock and 1st lock: [ 15.400545][ C1] -> (fs_reclaim){+.+.}-{0:0} { [ 15.400547][ C1] HARDIRQ-ON-W at: [ 15.400549][ C1] __lock_acquire+0x388/0xc20 [ 15.400552][ C1] lock_acquire.part.0+0xd4/0x280 [ 15.400554][ C1] fs_reclaim_acquire+0xd5/0x120 [ 15.400557][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 15.400559][ C1] kthread_create_worker_on_node+0xea/0x210 [ 15.400562][ C1] workqueue_init+0x2a/0x680 [ 15.400566][ C1] kernel_init_freeable+0x2fe/0x630 [ 15.400570][ C1] kernel_init+0x21/0x150 [ 15.400573][ C1] ret_from_fork+0x474/0x6b0 [ 15.400576][ C1] ret_from_fork_asm+0x11/0x20 [ 15.400579][ C1] SOFTIRQ-ON-W at: [ 15.400580][ C1] __lock_acquire+0x388/0xc20 [ 15.400582][ C1] lock_acquire.part.0+0xd4/0x280 [ 15.400583][ C1] fs_reclaim_acquire+0xd5/0x120 [ 15.400584][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 15.400585][ C1] kthread_create_worker_on_node+0xea/0x210 [ 15.400587][ C1] workqueue_init+0x2a/0x680 [ 15.400588][ C1] kernel_init_freeable+0x2fe/0x630 [ 15.400590][ C1] kernel_init+0x21/0x150 [ 15.400591][ C1] ret_from_fork+0x474/0x6b0 [ 15.400592][ C1] ret_from_fork_asm+0x11/0x20 [ 15.400594][ C1] INITIAL USE at: [ 15.400594][ C1] __lock_acquire+0x388/0xc20 [ 15.400596][ C1] lock_acquire.part.0+0xd4/0x280 [ 15.400597][ C1] fs_reclaim_acquire+0xd5/0x120 [ 15.400598][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 15.400599][ C1] kthread_create_worker_on_node+0xea/0x210 [ 15.400601][ C1] workqueue_init+0x2a/0x680 [ 15.400602][ C1] kernel_init_freeable+0x2fe/0x630 [ 15.400604][ C1] kernel_init+0x21/0x150 [ 15.400605][ C1] ret_from_fork+0x474/0x6b0 [ 15.400606][ C1] ret_from_fork_asm+0x11/0x20 [ 15.400608][ C1] } [ 15.400608][ C1] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 15.400612][ C1] ... acquired at: [ 15.400613][ C1] __lock_acquire+0x518/0xc20 [ 15.400614][ C1] lock_acquire.part.0+0xd4/0x280 [ 15.400615][ C1] fs_reclaim_acquire+0xd5/0x120 [ 15.400616][ C1] __kmalloc_noprof+0xd3/0x760 [ 15.400617][ C1] alloc_buf.isra.0+0x4b/0x260 [ 15.400625][ C1] put_chars+0x1e1/0x2f0 [ 15.400626][ C1] hvc_console_print+0x292/0x780 [ 15.400630][ C1] console_emit_next_record+0x22f/0x4c0 [ 15.400631][ C1] console_flush_one_record+0x46f/0x710 [ 15.400633][ C1] console_unlock+0xee/0x1f0 [ 15.400635][ C1] vprintk_emit+0x37c/0x3e0 [ 15.400635][ C1] _printk+0xc7/0x100 [ 15.400638][ C1] tun_init+0x24/0xb0 [ 15.400641][ C1] do_one_initcall+0x124/0x4f0 [ 15.400642][ C1] kernel_init_freeable+0x596/0x630 [ 15.400644][ C1] kernel_init+0x21/0x150 [ 15.400645][ C1] ret_from_fork+0x474/0x6b0 [ 15.400646][ C1] ret_from_fork_asm+0x11/0x20 [ 15.400647][ C1] [ 15.400648][ C1] -> (console_owner){..-.}-{0:0} { [ 15.400649][ C1] IN-SOFTIRQ-W at: [ 15.400650][ C1] __lock_acquire+0x388/0xc20 [ 15.400652][ C1] lock_acquire.part.0+0xd4/0x280 [ 15.400653][ C1] console_lock_spinning_enable+0x5c/0x60 [ 15.400654][ C1] console_emit_next_record+0x1d1/0x4c0 [ 15.400656][ C1] console_flush_one_record+0x46f/0x710 [ 15.400658][ C1] console_unlock+0xee/0x1f0 [ 15.400659][ C1] vprintk_emit+0x37c/0x3e0 [ 15.400660][ C1] _printk+0xc7/0x100 [ 15.400661][ C1] ip_frag_reasm.constprop.0.cold+0x10/0x15 [ 15.400663][ C1] ip_frag_queue+0xeb5/0x1830 [ 15.400664][ C1] ip_defrag+0x2d4/0x7a0 [ 15.400665][ C1] ip_local_deliver+0x171/0x4c0 [ 15.400666][ C1] ip_rcv+0xdc/0x3d0 [ 15.400667][ C1] __netif_receive_skb_core.constprop.0+0x13b5/0x2bb0 [ 15.400669][ C1] __netif_receive_skb_one_core+0xa2/0x180 [ 15.400670][ C1] process_backlog+0x431/0x14c0 [ 15.400672][ C1] __napi_poll+0xa7/0x3b0 [ 15.400673][ C1] net_rx_action+0x513/0xf50 [ 15.400675][ C1] handle_softirqs+0x1d3/0x900 [ 15.400678][ C1] do_softirq+0xac/0xe0 [ 15.400679][ C1] __local_bh_enable_ip+0x118/0x150 [ 15.400680][ C1] __dev_queue_xmit+0x989/0x1b90 [ 15.400682][ C1] packet_snd+0xee8/0x1840 [ 15.400685][ C1] __sock_sendmsg+0xce/0x190 [ 15.400687][ C1] __sys_sendto+0x260/0x320 [ 15.400689][ C1] __x64_sys_sendto+0xe4/0x1f0 [ 15.400690][ C1] do_syscall_64+0xff/0x530 [ 15.400693][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 15.400694][ C1] INITIAL USE at: [ 15.400695][ C1] } [ 15.400696][ C1] ... key at: [] console_owner_dep_map+0x0/0x60 [ 15.400698][ C1] ... acquired at: [ 15.400699][ C1] mark_lock+0x1d7/0xa00 [ 15.400700][ C1] mark_usage+0x42/0x170 [ 15.400701][ C1] __lock_acquire+0x388/0xc20 [ 15.400703][ C1] lock_acquire.part.0+0xd4/0x280 [ 15.400704][ C1] console_lock_spinning_enable+0x5c/0x60 [ 15.400706][ C1] console_emit_next_record+0x1d1/0x4c0 [ 15.400707][ C1] console_flush_one_record+0x46f/0x710 [ 15.400709][ C1] console_unlock+0xee/0x1f0 [ 15.400710][ C1] vprintk_emit+0x37c/0x3e0 [ 15.400711][ C1] _printk+0xc7/0x100 [ 15.400712][ C1] ip_frag_reasm.constprop.0.cold+0x10/0x15 [ 15.400713][ C1] ip_frag_queue+0xeb5/0x1830 [ 15.400714][ C1] ip_defrag+0x2d4/0x7a0 [ 15.400715][ C1] ip_local_deliver+0x171/0x4c0 [ 15.400716][ C1] ip_rcv+0xdc/0x3d0 [ 15.400717][ C1] __netif_receive_skb_core.constprop.0+0x13b5/0x2bb0 [ 15.400718][ C1] __netif_receive_skb_one_core+0xa2/0x180 [ 15.400720][ C1] process_backlog+0x431/0x14c0 [ 15.400721][ C1] __napi_poll+0xa7/0x3b0 [ 15.400722][ C1] net_rx_action+0x513/0xf50 [ 15.400724][ C1] handle_softirqs+0x1d3/0x900 [ 15.400725][ C1] do_softirq+0xac/0xe0 [ 15.400726][ C1] __local_bh_enable_ip+0x118/0x150 [ 15.400728][ C1] __dev_queue_xmit+0x989/0x1b90 [ 15.400729][ C1] packet_snd+0xee8/0x1840 [ 15.400730][ C1] __sock_sendmsg+0xce/0x190 [ 15.400731][ C1] __sys_sendto+0x260/0x320 [ 15.400733][ C1] __x64_sys_sendto+0xe4/0x1f0 [ 15.400734][ C1] do_syscall_64+0xff/0x530 [ 15.400735][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 15.400736][ C1] [ 15.400737][ C1] [ 15.400737][ C1] stack backtrace: [ 15.400739][ C1] CPU: 1 UID: 0 PID: 375 Comm: psock_snd Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 15.400742][ C1] Tainted: [W]=WARN [ 15.400743][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.400744][ C1] Call Trace: [ 15.400745][ C1] [ 15.400747][ C1] dump_stack_lvl+0x6f/0xa0 [ 15.400751][ C1] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 15.400753][ C1] mark_lock_irq+0x989/0x9c0 [ 15.400756][ C1] mark_lock+0x1d7/0xa00 [ 15.400758][ C1] mark_usage+0x42/0x170 [ 15.400760][ C1] __lock_acquire+0x388/0xc20 [ 15.400762][ C1] lock_acquire.part.0+0xd4/0x280 [ 15.400763][ C1] ? console_lock_spinning_enable+0x40/0x60 [ 15.400766][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.400768][ C1] ? lock_acquire+0x13c/0x160 [ 15.400770][ C1] console_lock_spinning_enable+0x5c/0x60 [ 15.400771][ C1] ? console_lock_spinning_enable+0x40/0x60 [ 15.400773][ C1] console_emit_next_record+0x1d1/0x4c0 [ 15.400775][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 15.400777][ C1] ? console_flush_one_record+0x106/0x710 [ 15.400779][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.400780][ C1] ? lock_acquire+0x13c/0x160 [ 15.400782][ C1] console_flush_one_record+0x46f/0x710 [ 15.400784][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 15.400785][ C1] ? __lock_acquire+0x518/0xc20 [ 15.400788][ C1] console_unlock+0xee/0x1f0 [ 15.400789][ C1] ? console_flush_one_record+0x710/0x710 [ 15.400791][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.400792][ C1] ? lock_acquire+0xe0/0x160 [ 15.400794][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 15.400796][ C1] ? vprintk_emit+0x320/0x3e0 [ 15.400797][ C1] vprintk_emit+0x37c/0x3e0 [ 15.400798][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 15.400800][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 15.400802][ C1] _printk+0xc7/0x100 [ 15.400804][ C1] ? snapshot_read.cold+0x21/0x21 [ 15.400805][ C1] ? ___ratelimit+0x4e7/0xa00 [ 15.400808][ C1] ? idr_get_free+0x830/0x830 [ 15.400810][ C1] ip_frag_reasm.constprop.0.cold+0x10/0x15 [ 15.400812][ C1] ip_frag_queue+0xeb5/0x1830 [ 15.400814][ C1] ip_defrag+0x2d4/0x7a0 [ 15.400815][ C1] ? ip4_obj_hashfn+0x280/0x280 [ 15.400817][ C1] ? ip_route_input_noref+0x137/0x250 [ 15.400819][ C1] ? ip_route_input_slow+0x2420/0x2420 [ 15.400821][ C1] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 15.400823][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.400825][ C1] ip_local_deliver+0x171/0x4c0 [ 15.400826][ C1] ? ip_local_deliver_finish+0x610/0x610 [ 15.400827][ C1] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 15.400828][ C1] ? __asan_memset+0x27/0x50 [ 15.400832][ C1] ip_rcv+0xdc/0x3d0 [ 15.400833][ C1] ? ip_local_deliver+0x4c0/0x4c0 [ 15.400834][ C1] ? rcu_do_batch+0x2b6/0x1000 [ 15.400836][ C1] ? is_bpf_text_address+0x72/0x110 [ 15.400839][ C1] ? kernel_text_address+0x149/0x170 [ 15.400840][ C1] ? __kernel_text_address+0x12/0x30 [ 15.400842][ C1] ? write_profile+0xf0/0xf0 [ 15.400844][ C1] ? unwind_get_return_address+0x67/0xd0 [ 15.400847][ C1] __netif_receive_skb_core.constprop.0+0x13b5/0x2bb0 [ 15.400849][ C1] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 15.400851][ C1] ? rcu_read_lock_any_held+0x3c/0x90 [ 15.400853][ C1] ? validate_chain+0x38b/0xc20 [ 15.400855][ C1] ? mark_usage+0x61/0x170 [ 15.400856][ C1] ? __lock_acquire+0x518/0xc20 [ 15.400858][ C1] ? do_xdp_generic+0x4a0/0x4a0 [ 15.400860][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 15.400861][ C1] ? find_held_lock+0x2b/0x80 [ 15.400863][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 15.400865][ C1] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 15.400866][ C1] ? rcu_read_lock_any_held+0x3c/0x90 [ 15.400867][ C1] ? validate_chain+0x38b/0xc20 [ 15.400869][ C1] ? sock_def_readable+0x156/0x480 [ 15.400871][ C1] ? mark_usage+0x61/0x170 [ 15.400872][ C1] ? __lock_acquire+0x518/0xc20 [ 15.400874][ C1] ? process_backlog+0x3f1/0x14c0 [ 15.400876][ C1] __netif_receive_skb_one_core+0xa2/0x180 [ 15.400877][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 15.400879][ C1] ? process_backlog+0x3f1/0x14c0 [ 15.400880][ C1] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 15.400882][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.400884][ C1] process_backlog+0x431/0x14c0 [ 15.400886][ C1] __napi_poll+0xa7/0x3b0 [ 15.400888][ C1] net_rx_action+0x513/0xf50 [ 15.400890][ C1] ? __lock_acquire+0x518/0xc20 [ 15.400892][ C1] ? __napi_poll+0x3b0/0x3b0 [ 15.400895][ C1] ? ktime_get_update_offsets_now+0x2a8/0x490 [ 15.400898][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.400899][ C1] handle_softirqs+0x1d3/0x900 [ 15.400901][ C1] ? _local_bh_enable+0xc0/0xc0 [ 15.400902][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 15.400905][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.400906][ C1] ? __dev_queue_xmit+0x974/0x1b90 [ 15.400907][ C1] do_softirq+0xac/0xe0 [ 15.400909][ C1] [ 15.400909][ C1] [ 15.400910][ C1] __local_bh_enable_ip+0x118/0x150 [ 15.400912][ C1] __dev_queue_xmit+0x989/0x1b90 [ 15.400913][ C1] ? _copy_from_iter+0x1bb/0x1810 [ 15.400917][ C1] ? _copy_from_iter_flushcache+0x1970/0x1970 [ 15.400918][ C1] ? _copy_from_iter_flushcache+0x1970/0x1970 [ 15.400920][ C1] ? __might_fault+0x97/0x140 [ 15.400922][ C1] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 15.400924][ C1] ? __virtio_net_hdr_to_skb.constprop.0+0x327/0x1440 [ 15.400926][ C1] ? alloc_pg_vec.isra.0+0x540/0x540 [ 15.400927][ C1] ? packet_rcv_spkt+0x5a0/0x5a0 [ 15.400929][ C1] packet_snd+0xee8/0x1840 [ 15.400931][ C1] ? kasan_addr_to_slab+0x41/0x50 [ 15.400934][ C1] ? tpacket_snd+0x1990/0x1990 [ 15.400935][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 15.400937][ C1] ? __might_fault+0x97/0x140 [ 15.400938][ C1] ? find_held_lock+0x2b/0x80 [ 15.400939][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 15.400941][ C1] __sock_sendmsg+0xce/0x190 [ 15.400943][ C1] ? fdget+0x4f/0x1e0 [ 15.400946][ C1] __sys_sendto+0x260/0x320 [ 15.400948][ C1] ? __ia32_sys_getpeername+0xd0/0xd0 [ 15.400951][ C1] ? fput_close_sync+0xde/0x1b0 [ 15.400954][ C1] ? alloc_file_clone+0xe0/0xe0 [ 15.400956][ C1] __x64_sys_sendto+0xe4/0x1f0 [ 15.400958][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 15.400960][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 15.400962][ C1] ? do_syscall_64+0xa6/0x530 [ 15.400963][ C1] do_syscall_64+0xff/0x530 [ 15.400965][ C1] ? exc_page_fault+0xee/0x100 [ 15.400966][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 15.400968][ C1] RIP: 0033:0x7f19864b754e [ 15.400970][ C1] 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 [ 15.400972][ C1] RSP: 002b:00007ffdaff49fa0 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 15.400975][ C1] RAX: ffffffffffffffda RBX: 0000000000010018 RCX: 00007f19864b754e [ 15.400976][ C1] RDX: 0000000000010018 RSI: 0000000000415120 RDI: 0000000000000007 [ 15.400977][ C1] RBP: 00007ffdaff49fb0 R08: 00007ffdaff4a010 R09: 0000000000000014 [ 15.400978][ C1] R10: 0000000000000000 R11: 0000000000000202 R12: 0000000000000007 [ 15.400979][ C1] R13: 0000000000000006 R14: 00007f1986688000 R15: 0000000000404e00 [ 15.400981][ C1] [ 15.400984][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 15.400986][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 375, name: psock_snd [ 15.400987][ C1] preempt_count: 103, expected: 0 [ 15.400988][ C1] RCU nest depth: 2, expected: 0 [ 15.400988][ C1] INFO: lockdep is turned off. [ 15.400989][ C1] irq event stamp: 25669 [ 15.400989][ C1] hardirqs last enabled at (25668): [] __down_trylock_console_sem+0x86/0xa0 [ 15.400992][ C1] hardirqs last disabled at (25669): [] console_emit_next_record+0x3d4/0x4c0 [ 15.400994][ C1] softirqs last enabled at (25308): [] __dev_queue_xmit+0x974/0x1b90 [ 15.400995][ C1] softirqs last disabled at (25309): [] do_softirq+0xac/0xe0 [ 15.400997][ C1] Preemption disabled at: [ 15.400998][ C1] [] __dev_queue_xmit+0x20c/0x1b90 [ 15.401000][ C1] CPU: 1 UID: 0 PID: 375 Comm: psock_snd Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 15.401002][ C1] Tainted: [W]=WARN [ 15.401003][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.401003][ C1] Call Trace: [ 15.401004][ C1] [ 15.401004][ C1] dump_stack_lvl+0x6f/0xa0 [ 15.401006][ C1] ? __dev_queue_xmit+0x20c/0x1b90 [ 15.401008][ C1] __might_resched.cold+0x1fe/0x2c1 [ 15.401011][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 15.401014][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.401015][ C1] __kmalloc_noprof+0x443/0x760 [ 15.401016][ C1] ? __rwlock_init+0x150/0x150 [ 15.401018][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 15.401020][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 15.401022][ C1] alloc_buf.isra.0+0x4b/0x260 [ 15.401024][ C1] put_chars+0x1e1/0x2f0 [ 15.401026][ C1] ? __send_to_port+0x420/0x420 [ 15.401028][ C1] hvc_console_print+0x292/0x780 [ 15.401030][ C1] ? __lock_acquire+0x388/0xc20 [ 15.401032][ C1] ? hvc_write+0x3a0/0x3a0 [ 15.401034][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.401035][ C1] ? lock_acquire+0x13c/0x160 [ 15.401037][ C1] console_emit_next_record+0x22f/0x4c0 [ 15.401039][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 15.401041][ C1] ? console_flush_one_record+0x106/0x710 [ 15.401043][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.401044][ C1] ? lock_acquire+0x13c/0x160 [ 15.401046][ C1] console_flush_one_record+0x46f/0x710 [ 15.401048][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 15.401049][ C1] ? __lock_acquire+0x518/0xc20 [ 15.401051][ C1] console_unlock+0xee/0x1f0 [ 15.401053][ C1] ? console_flush_one_record+0x710/0x710 [ 15.401055][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.401056][ C1] ? lock_acquire+0xe0/0x160 [ 15.401058][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 15.401059][ C1] ? vprintk_emit+0x320/0x3e0 [ 15.401061][ C1] vprintk_emit+0x37c/0x3e0 [ 15.401062][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 15.401063][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 15.401065][ C1] _printk+0xc7/0x100 [ 15.401067][ C1] ? snapshot_read.cold+0x21/0x21 [ 15.401068][ C1] ? ___ratelimit+0x4e7/0xa00 [ 15.401070][ C1] ? idr_get_free+0x830/0x830 [ 15.401072][ C1] ip_frag_reasm.constprop.0.cold+0x10/0x15 [ 15.401074][ C1] ip_frag_queue+0xeb5/0x1830 [ 15.401076][ C1] ip_defrag+0x2d4/0x7a0 [ 15.401077][ C1] ? ip4_obj_hashfn+0x280/0x280 [ 15.401079][ C1] ? ip_route_input_noref+0x137/0x250 [ 15.401080][ C1] ? ip_route_input_slow+0x2420/0x2420 [ 15.401082][ C1] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 15.401083][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.401085][ C1] ip_local_deliver+0x171/0x4c0 [ 15.401086][ C1] ? ip_local_deliver_finish+0x610/0x610 [ 15.401087][ C1] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 15.401088][ C1] ? __asan_memset+0x27/0x50 [ 15.401091][ C1] ip_rcv+0xdc/0x3d0 [ 15.401092][ C1] ? ip_local_deliver+0x4c0/0x4c0 [ 15.401093][ C1] ? rcu_do_batch+0x2b6/0x1000 [ 15.401094][ C1] ? is_bpf_text_address+0x72/0x110 [ 15.401095][ C1] ? kernel_text_address+0x149/0x170 [ 15.401097][ C1] ? __kernel_text_address+0x12/0x30 [ 15.401098][ C1] ? write_profile+0xf0/0xf0 [ 15.401099][ C1] ? unwind_get_return_address+0x67/0xd0 [ 15.401101][ C1] __netif_receive_skb_core.constprop.0+0x13b5/0x2bb0 [ 15.401103][ C1] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 15.401104][ C1] ? rcu_read_lock_any_held+0x3c/0x90 [ 15.401106][ C1] ? validate_chain+0x38b/0xc20 [ 15.401107][ C1] ? mark_usage+0x61/0x170 [ 15.401109][ C1] ? __lock_acquire+0x518/0xc20 [ 15.401111][ C1] ? do_xdp_generic+0x4a0/0x4a0 [ 15.401112][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 15.401114][ C1] ? find_held_lock+0x2b/0x80 [ 15.401115][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 15.401117][ C1] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 15.401118][ C1] ? rcu_read_lock_any_held+0x3c/0x90 [ 15.401120][ C1] ? validate_chain+0x38b/0xc20 [ 15.401121][ C1] ? sock_def_readable+0x156/0x480 [ 15.401122][ C1] ? mark_usage+0x61/0x170 [ 15.401124][ C1] ? __lock_acquire+0x518/0xc20 [ 15.401126][ C1] ? process_backlog+0x3f1/0x14c0 [ 15.401127][ C1] __netif_receive_skb_one_core+0xa2/0x180 [ 15.401129][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 15.401130][ C1] ? process_backlog+0x3f1/0x14c0 [ 15.401132][ C1] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 15.401134][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.401135][ C1] process_backlog+0x431/0x14c0 [ 15.401138][ C1] __napi_poll+0xa7/0x3b0 [ 15.401140][ C1] net_rx_action+0x513/0xf50 [ 15.401142][ C1] ? __lock_acquire+0x518/0xc20 [ 15.401143][ C1] ? __napi_poll+0x3b0/0x3b0 [ 15.401147][ C1] ? ktime_get_update_offsets_now+0x2a8/0x490 [ 15.401148][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.401150][ C1] handle_softirqs+0x1d3/0x900 [ 15.401152][ C1] ? _local_bh_enable+0xc0/0xc0 [ 15.401153][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 15.401155][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.401156][ C1] ? __dev_queue_xmit+0x974/0x1b90 [ 15.401157][ C1] do_softirq+0xac/0xe0 [ 15.401159][ C1] [ 15.401159][ C1] [ 15.401160][ C1] __local_bh_enable_ip+0x118/0x150 [ 15.401161][ C1] __dev_queue_xmit+0x989/0x1b90 [ 15.401163][ C1] ? _copy_from_iter+0x1bb/0x1810 [ 15.401165][ C1] ? _copy_from_iter_flushcache+0x1970/0x1970 [ 15.401166][ C1] ? _copy_from_iter_flushcache+0x1970/0x1970 [ 15.401168][ C1] ? __might_fault+0x97/0x140 [ 15.401169][ C1] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 15.401171][ C1] ? __virtio_net_hdr_to_skb.constprop.0+0x327/0x1440 [ 15.401176][ C1] ? alloc_pg_vec.isra.0+0x540/0x540 [ 15.401177][ C1] ? packet_rcv_spkt+0x5a0/0x5a0 [ 15.401179][ C1] packet_snd+0xee8/0x1840 [ 15.401182][ C1] ? kasan_addr_to_slab+0x41/0x50 [ 15.401183][ C1] ? tpacket_snd+0x1990/0x1990 [ 15.401184][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 15.401186][ C1] ? __might_fault+0x97/0x140 [ 15.401187][ C1] ? find_held_lock+0x2b/0x80 [ 15.401188][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 15.401190][ C1] __sock_sendmsg+0xce/0x190 [ 15.401192][ C1] ? fdget+0x4f/0x1e0 [ 15.401194][ C1] __sys_sendto+0x260/0x320 [ 15.401195][ C1] ? __ia32_sys_getpeername+0xd0/0xd0 [ 15.401199][ C1] ? fput_close_sync+0xde/0x1b0 [ 15.401200][ C1] ? alloc_file_clone+0xe0/0xe0 [ 15.401202][ C1] __x64_sys_sendto+0xe4/0x1f0 [ 15.401204][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 15.401205][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 15.401207][ C1] ? do_syscall_64+0xa6/0x530 [ 15.401208][ C1] do_syscall_64+0xff/0x530 [ 15.401210][ C1] ? exc_page_fault+0xee/0x100 [ 15.401211][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 15.401212][ C1] RIP: 0033:0x7f19864b754e [ 15.401213][ C1] 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 [ 15.401214][ C1] RSP: 002b:00007ffdaff49fa0 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 15.401215][ C1] RAX: ffffffffffffffda RBX: 0000000000010018 RCX: 00007f19864b754e [ 15.401216][ C1] RDX: 0000000000010018 RSI: 0000000000415120 RDI: 0000000000000007 [ 15.401217][ C1] RBP: 00007ffdaff49fb0 R08: 00007ffdaff4a010 R09: 0000000000000014 [ 15.401218][ C1] R10: 0000000000000000 R11: 0000000000000202 R12: 0000000000000007 [ 15.401218][ C1] R13: 0000000000000006 R14: 00007f1986688000 R15: 0000000000404e00 [ 15.401220][ C1]