[ 14.955857][ T300] ip (300) used greatest stack depth: 23920 bytes left [ 14.955873][ T300] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 14.955875][ T300] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 300, name: ip [ 14.955876][ T300] preempt_count: 2, expected: 0 [ 14.955877][ T300] RCU nest depth: 0, expected: 0 [ 14.955878][ T300] locks held by ip/300: 5, last CPU#2: [ 14.955880][ T300] #0: ffffffff886127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 14.955890][ T300] #1: ffffffff88779cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 14.955896][ T300] #2: ffffffff88779d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 14.955899][ T300] #3: ffffffff88699660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 14.955903][ T300] #4: ffffffff88699560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 14.955907][ T300] irq event stamp: 38526 [ 14.955908][ T300] hardirqs last enabled at (38525): [] __down_trylock_console_sem+0x86/0xa0 [ 14.955910][ T300] hardirqs last disabled at (38526): [] console_emit_next_record+0x3d4/0x4c0 [ 14.955912][ T300] softirqs last enabled at (38256): [] handle_softirqs+0x67c/0x900 [ 14.955914][ T300] softirqs last disabled at (38247): [] __irq_exit_rcu+0x145/0x1c0 [ 14.955917][ T300] Preemption disabled at: [ 14.955917][ T300] [<0000000000000000>] 0x0 [ 14.955924][ T300] CPU: 2 UID: 0 PID: 300 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 14.955928][ T300] Tainted: [W]=WARN [ 14.955928][ T300] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.955930][ T300] Call Trace: [ 14.955932][ T300] [ 14.955933][ T300] dump_stack_lvl+0x6f/0xa0 [ 14.955939][ T300] __might_resched.cold+0x1fe/0x2c1 [ 14.955944][ T300] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 14.955948][ T300] ? __kmalloc_noprof+0xdb/0x760 [ 14.955953][ T300] __kmalloc_noprof+0x443/0x760 [ 14.955955][ T300] ? alloc_buf.isra.0+0x4b/0x260 [ 14.955961][ T300] ? do_raw_spin_unlock+0x59/0x250 [ 14.955964][ T300] alloc_buf.isra.0+0x4b/0x260 [ 14.955967][ T300] put_chars+0x1e1/0x2f0 [ 14.955970][ T300] ? __send_to_port+0x420/0x420 [ 14.955972][ T300] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 14.955977][ T300] ? validate_chain+0x38b/0xc20 [ 14.955982][ T300] hvc_console_print+0x292/0x780 [ 14.955989][ T300] ? hvc_write+0x3a0/0x3a0 [ 14.955991][ T300] ? rcu_is_watching+0x16/0xd0 [ 14.955993][ T300] ? lock_acquire+0x13c/0x160 [ 14.955997][ T300] console_emit_next_record+0x22f/0x4c0 [ 14.956001][ T300] ? devkmsg_read+0x4b0/0x4b0 [ 14.956002][ T300] ? console_flush_one_record+0x106/0x710 [ 14.956006][ T300] ? rcu_is_watching+0x16/0xd0 [ 14.956008][ T300] ? lock_acquire+0x13c/0x160 [ 14.956012][ T300] console_flush_one_record+0x46f/0x710 [ 14.956016][ T300] ? console_emit_next_record+0x4c0/0x4c0 [ 14.956017][ T300] ? __lock_acquire+0x518/0xc20 [ 14.956022][ T300] console_unlock+0xee/0x1f0 [ 14.956025][ T300] ? console_flush_one_record+0x710/0x710 [ 14.956027][ T300] ? rcu_is_watching+0x16/0xd0 [ 14.956029][ T300] ? lock_acquire+0x60/0x160 [ 14.956033][ T300] ? __down_trylock_console_sem+0x5e/0xa0 [ 14.956034][ T300] ? vprintk_emit+0x320/0x3e0 [ 14.956038][ T300] vprintk_emit+0x37c/0x3e0 [ 14.956041][ T300] ? wake_up_klogd_work_func+0x90/0x90 [ 14.956045][ T300] ? __lock_acquire+0x518/0xc20 [ 14.956048][ T300] _printk+0xc7/0x100 [ 14.956052][ T300] ? snapshot_read.cold+0x21/0x21 [ 14.956054][ T300] ? do_raw_spin_lock+0x131/0x280 [ 14.956057][ T300] ? __rwlock_init+0x150/0x150 [ 14.956060][ T300] ? do_raw_spin_lock+0x131/0x280 [ 14.956063][ T300] do_exit.cold+0x82/0x9c [ 14.956067][ T300] ? exit_notify+0x890/0x890 [ 14.956068][ T300] ? __lock_release.isra.0+0x69/0x1a0 [ 14.956070][ T300] ? rcu_is_watching+0x16/0xd0 [ 14.956074][ T300] do_group_exit+0xb8/0x370 [ 14.956077][ T300] __x64_sys_exit_group+0x3c/0x50 [ 14.956079][ T300] x64_sys_call+0x1567/0x1570 [ 14.956082][ T300] do_syscall_64+0xff/0x530 [ 14.956085][ T300] ? exc_page_fault+0xee/0x100 [ 14.956088][ T300] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 14.956090][ T300] RIP: 0033:0x7f61d3c3d1b8 [ 14.956092][ T300] Code: Unable to access opcode bytes at 0x7f61d3c3d18e. [ 14.956093][ T300] RSP: 002b:00007fff01245c28 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 14.956096][ T300] RAX: ffffffffffffffda RBX: 00007f61d3d6df88 RCX: 00007f61d3c3d1b8 [ 14.956097][ T300] RDX: 00007f61d3987fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 14.956098][ T300] RBP: 00007fff01245c80 R08: 0000000000000000 R09: 0000000000000000 [ 14.956099][ T300] R10: 00007fff01245a40 R11: 0000000000000246 R12: 0000000000000001 [ 14.956100][ T300] R13: 0000000000000000 R14: 00007f61d3d6c680 R15: 00007f61d3d6dfa0 [ 14.956106][ T300] [ 15.636413][ T322] ip (322) used greatest stack depth: 23792 bytes left [ 22.489637][ C0] tun0: no available key for peer 1, key-id: 0 [ 22.489670][ C0] [ 22.489671][ C0] ======================================================== [ 22.489672][ C0] WARNING: possible irq lock inversion dependency detected [ 22.489674][ C0] 7.2.0-virtme #1 Tainted: G W [ 22.489679][ C0] -------------------------------------------------------- [ 22.489680][ C0] ovpn-cli/400 just changed the state of lock: [ 22.489681][ C0] ffffffff88699660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 22.489692][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 22.489694][ C0] (fs_reclaim){+.+.}-{0:0} [ 22.489695][ C0] [ 22.489695][ C0] [ 22.489695][ C0] and interrupts could create inverse lock ordering between them. [ 22.489695][ C0] [ 22.489696][ C0] [ 22.489696][ C0] other info that might help us debug this: [ 22.489697][ C0] Possible interrupt unsafe locking scenario: [ 22.489697][ C0] [ 22.489698][ C0] CPU0 CPU1 [ 22.489698][ C0] ---- ---- [ 22.489698][ C0] lock(fs_reclaim); [ 22.489699][ C0] local_irq_disable(); [ 22.489700][ C0] lock(console_owner); [ 22.489701][ C0] lock(fs_reclaim); [ 22.489702][ C0] [ 22.489702][ C0] lock(console_owner); [ 22.489703][ C0] [ 22.489703][ C0] *** DEADLOCK *** [ 22.489703][ C0] [ 22.489703][ C0] locks held by ovpn-cli/400: 6, last CPU#0: [ 22.489704][ C0] #0: ffffffff88790b00 (rcu_read_lock){....}-{1:3}, at: process_backlog+0x3f1/0x14c0 [ 22.489710][ C0] #1: ffffffff88790b00 (rcu_read_lock){....}-{1:3}, at: ip_local_deliver_finish+0x2ba/0x610 [ 22.489715][ C0] #2: ff11000004ed9d18 (slock-AF_INET/1){+.-.}-{3:3}, at: tcp_v4_rcv+0x1a81/0x2b70 [ 22.489719][ C0] #3: ffffffff88790b00 (rcu_read_lock){....}-{1:3}, at: ovpn_tcp_data_ready+0x62/0x390 [ovpn] [ 22.489726][ C0] #4: ffffffff88779cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 22.489730][ C0] #5: ffffffff88779d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 22.489733][ C0] [ 22.489733][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 22.489737][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 22.489739][ C0] HARDIRQ-ON-W at: [ 22.489741][ C0] __lock_acquire+0x388/0xc20 [ 22.489744][ C0] lock_acquire.part.0+0xd4/0x280 [ 22.489745][ C0] fs_reclaim_acquire+0xd5/0x120 [ 22.489748][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 22.489750][ C0] kthread_create_worker_on_node+0xea/0x210 [ 22.489753][ C0] workqueue_init+0x2a/0x680 [ 22.489756][ C0] kernel_init_freeable+0x2fe/0x630 [ 22.489759][ C0] kernel_init+0x21/0x150 [ 22.489761][ C0] ret_from_fork+0x474/0x6b0 [ 22.489764][ C0] ret_from_fork_asm+0x11/0x20 [ 22.489767][ C0] SOFTIRQ-ON-W at: [ 22.489768][ C0] __lock_acquire+0x388/0xc20 [ 22.489769][ C0] lock_acquire.part.0+0xd4/0x280 [ 22.489771][ C0] fs_reclaim_acquire+0xd5/0x120 [ 22.489772][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 22.489773][ C0] kthread_create_worker_on_node+0xea/0x210 [ 22.489774][ C0] workqueue_init+0x2a/0x680 [ 22.489775][ C0] kernel_init_freeable+0x2fe/0x630 [ 22.489777][ C0] kernel_init+0x21/0x150 [ 22.489778][ C0] ret_from_fork+0x474/0x6b0 [ 22.489779][ C0] ret_from_fork_asm+0x11/0x20 [ 22.489780][ C0] INITIAL USE at: [ 22.489781][ C0] __lock_acquire+0x388/0xc20 [ 22.489782][ C0] lock_acquire.part.0+0xd4/0x280 [ 22.489784][ C0] fs_reclaim_acquire+0xd5/0x120 [ 22.489785][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 22.489786][ C0] kthread_create_worker_on_node+0xea/0x210 [ 22.489787][ C0] workqueue_init+0x2a/0x680 [ 22.489788][ C0] kernel_init_freeable+0x2fe/0x630 [ 22.489790][ C0] kernel_init+0x21/0x150 [ 22.489791][ C0] ret_from_fork+0x474/0x6b0 [ 22.489792][ C0] ret_from_fork_asm+0x11/0x20 [ 22.489794][ C0] } [ 22.489794][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 22.489798][ C0] ... acquired at: [ 22.489798][ C0] __lock_acquire+0x518/0xc20 [ 22.489799][ C0] lock_acquire.part.0+0xd4/0x280 [ 22.489801][ C0] fs_reclaim_acquire+0xd5/0x120 [ 22.489802][ C0] __kmalloc_noprof+0xd3/0x760 [ 22.489803][ C0] alloc_buf.isra.0+0x4b/0x260 [ 22.489806][ C0] put_chars+0x1e1/0x2f0 [ 22.489808][ C0] hvc_console_print+0x292/0x780 [ 22.489810][ C0] console_emit_next_record+0x22f/0x4c0 [ 22.489812][ C0] console_flush_one_record+0x46f/0x710 [ 22.489813][ C0] console_unlock+0xee/0x1f0 [ 22.489814][ C0] vprintk_emit+0x37c/0x3e0 [ 22.489816][ C0] _printk+0xc7/0x100 [ 22.489819][ C0] print_ipi_mode+0x2e/0x40 [ 22.489821][ C0] do_one_initcall+0x124/0x4f0 [ 22.489822][ C0] kernel_init_freeable+0x596/0x630 [ 22.489824][ C0] kernel_init+0x21/0x150 [ 22.489825][ C0] ret_from_fork+0x474/0x6b0 [ 22.489826][ C0] ret_from_fork_asm+0x11/0x20 [ 22.489828][ C0] [ 22.489828][ C0] -> (console_owner){..-.}-{0:0} { [ 22.489830][ C0] IN-SOFTIRQ-W at: [ 22.489830][ C0] __lock_acquire+0x388/0xc20 [ 22.489832][ C0] lock_acquire.part.0+0xd4/0x280 [ 22.489833][ C0] console_lock_spinning_enable+0x5c/0x60 [ 22.489834][ C0] console_emit_next_record+0x1d1/0x4c0 [ 22.489836][ C0] console_flush_one_record+0x46f/0x710 [ 22.489837][ C0] console_unlock+0xee/0x1f0 [ 22.489839][ C0] vprintk_emit+0x37c/0x3e0 [ 22.489840][ C0] _printk+0xc7/0x100 [ 22.489842][ C0] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 22.489845][ C0] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 22.489848][ C0] __strp_recv+0x20f/0x1c20 [ 22.489851][ C0] __tcp_read_sock+0x1c7/0x850 [ 22.489853][ C0] strp_read_sock+0x20f/0x2b0 [ 22.489855][ C0] strp_data_ready+0x18e/0x2c0 [ 22.489857][ C0] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 22.489859][ C0] tcp_rcv_established+0x1e1d/0x3910 [ 22.489861][ C0] tcp_v4_do_rcv+0x4f6/0xb90 [ 22.489862][ C0] tcp_v4_rcv+0x1caa/0x2b70 [ 22.489864][ C0] ip_protocol_deliver_rcu+0x82/0x350 [ 22.489865][ C0] ip_local_deliver_finish+0x36f/0x610 [ 22.489866][ C0] ip_local_deliver+0x184/0x4c0 [ 22.489867][ C0] ip_rcv+0xdc/0x3d0 [ 22.489869][ C0] __netif_receive_skb_one_core+0xfc/0x180 [ 22.489871][ C0] process_backlog+0x431/0x14c0 [ 22.489872][ C0] __napi_poll+0xa7/0x3b0 [ 22.489874][ C0] net_rx_action+0x513/0xf50 [ 22.489875][ C0] handle_softirqs+0x1d3/0x900 [ 22.489878][ C0] do_softirq+0xac/0xe0 [ 22.489879][ C0] __local_bh_enable_ip+0x118/0x150 [ 22.489880][ C0] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 22.489883][ C0] __sys_sendto+0x2aa/0x400 [ 22.489885][ C0] __x64_sys_sendto+0xe4/0x1f0 [ 22.489887][ C0] do_syscall_64+0xff/0x530 [ 22.489889][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 22.489891][ C0] INITIAL USE at: [ 22.489891][ C0] } [ 22.489892][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 22.489895][ C0] ... acquired at: [ 22.489896][ C0] mark_lock+0x1d7/0xa00 [ 22.489897][ C0] mark_usage+0x42/0x170 [ 22.489899][ C0] __lock_acquire+0x388/0xc20 [ 22.489900][ C0] lock_acquire.part.0+0xd4/0x280 [ 22.489901][ C0] console_lock_spinning_enable+0x5c/0x60 [ 22.489903][ C0] console_emit_next_record+0x1d1/0x4c0 [ 22.489904][ C0] console_flush_one_record+0x46f/0x710 [ 22.489906][ C0] console_unlock+0xee/0x1f0 [ 22.489907][ C0] vprintk_emit+0x37c/0x3e0 [ 22.489908][ C0] _printk+0xc7/0x100 [ 22.489910][ C0] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 22.489912][ C0] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 22.489914][ C0] __strp_recv+0x20f/0x1c20 [ 22.489916][ C0] __tcp_read_sock+0x1c7/0x850 [ 22.489917][ C0] strp_read_sock+0x20f/0x2b0 [ 22.489918][ C0] strp_data_ready+0x18e/0x2c0 [ 22.489920][ C0] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 22.489922][ C0] tcp_rcv_established+0x1e1d/0x3910 [ 22.489924][ C0] tcp_v4_do_rcv+0x4f6/0xb90 [ 22.489925][ C0] tcp_v4_rcv+0x1caa/0x2b70 [ 22.489927][ C0] ip_protocol_deliver_rcu+0x82/0x350 [ 22.489928][ C0] ip_local_deliver_finish+0x36f/0x610 [ 22.489929][ C0] ip_local_deliver+0x184/0x4c0 [ 22.489930][ C0] ip_rcv+0xdc/0x3d0 [ 22.489931][ C0] __netif_receive_skb_one_core+0xfc/0x180 [ 22.489933][ C0] process_backlog+0x431/0x14c0 [ 22.489935][ C0] __napi_poll+0xa7/0x3b0 [ 22.489936][ C0] net_rx_action+0x513/0xf50 [ 22.489938][ C0] handle_softirqs+0x1d3/0x900 [ 22.489939][ C0] do_softirq+0xac/0xe0 [ 22.489940][ C0] __local_bh_enable_ip+0x118/0x150 [ 22.489941][ C0] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 22.489943][ C0] __sys_sendto+0x2aa/0x400 [ 22.489945][ C0] __x64_sys_sendto+0xe4/0x1f0 [ 22.489946][ C0] do_syscall_64+0xff/0x530 [ 22.489948][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 22.489949][ C0] [ 22.489949][ C0] [ 22.489949][ C0] stack backtrace: [ 22.489952][ C0] CPU: 0 UID: 0 PID: 400 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 22.489955][ C0] Tainted: [W]=WARN [ 22.489956][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 22.489957][ C0] Call Trace: [ 22.489958][ C0] [ 22.489960][ C0] dump_stack_lvl+0x6f/0xa0 [ 22.489963][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 22.489966][ C0] mark_lock_irq+0x989/0x9c0 [ 22.489968][ C0] mark_lock+0x1d7/0xa00 [ 22.489970][ C0] mark_usage+0x42/0x170 [ 22.489972][ C0] __lock_acquire+0x388/0xc20 [ 22.489974][ C0] lock_acquire.part.0+0xd4/0x280 [ 22.489975][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 22.489977][ C0] ? rcu_is_watching+0x16/0xd0 [ 22.489981][ C0] ? lock_acquire+0x13c/0x160 [ 22.489982][ C0] console_lock_spinning_enable+0x5c/0x60 [ 22.489984][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 22.489986][ C0] console_emit_next_record+0x1d1/0x4c0 [ 22.489988][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 22.489989][ C0] ? console_flush_one_record+0x106/0x710 [ 22.489991][ C0] ? rcu_is_watching+0x16/0xd0 [ 22.489993][ C0] ? lock_acquire+0x13c/0x160 [ 22.489995][ C0] console_flush_one_record+0x46f/0x710 [ 22.489997][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 22.489999][ C0] ? __lock_acquire+0x518/0xc20 [ 22.490001][ C0] console_unlock+0xee/0x1f0 [ 22.490003][ C0] ? console_flush_one_record+0x710/0x710 [ 22.490004][ C0] ? rcu_is_watching+0x16/0xd0 [ 22.490006][ C0] ? lock_acquire+0x60/0x160 [ 22.490008][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 22.490010][ C0] ? vprintk_emit+0x320/0x3e0 [ 22.490012][ C0] vprintk_emit+0x37c/0x3e0 [ 22.490014][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 22.490016][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 22.490018][ C0] _printk+0xc7/0x100 [ 22.490019][ C0] ? snapshot_read.cold+0x21/0x21 [ 22.490021][ C0] ? ___ratelimit+0x4e7/0xa00 [ 22.490024][ C0] ? ovpn_netdev_write+0x730/0x730 [ovpn] [ 22.490027][ C0] ? idr_get_free+0x830/0x830 [ 22.490029][ C0] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 22.490032][ C0] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 22.490036][ C0] ? ovpn_tcp_write_space+0x2e0/0x2e0 [ovpn] [ 22.490038][ C0] ? __copy_skb_header+0xb7/0x510 [ 22.490041][ C0] ? ovpn_tcp_disconnect+0x10/0x10 [ovpn] [ 22.490043][ C0] ? sock_queue_err_skb+0xb0/0x680 [ 22.490045][ C0] __strp_recv+0x20f/0x1c20 [ 22.490048][ C0] __tcp_read_sock+0x1c7/0x850 [ 22.490050][ C0] ? strp_process+0xb0/0xb0 [ 22.490051][ C0] ? __tcp_transmit_skb+0x1b6e/0x3c10 [ 22.490053][ C0] ? tcp_cleanup_rbuf+0x1c0/0x1c0 [ 22.490055][ C0] ? mark_usage+0x61/0x170 [ 22.490057][ C0] strp_read_sock+0x20f/0x2b0 [ 22.490059][ C0] ? strp_stop+0x50/0x50 [ 22.490061][ C0] ? rcu_is_watching+0x16/0xd0 [ 22.490063][ C0] ? lock_acquire+0x13c/0x160 [ 22.490064][ C0] strp_data_ready+0x18e/0x2c0 [ 22.490066][ C0] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 22.490069][ C0] tcp_rcv_established+0x1e1d/0x3910 [ 22.490072][ C0] ? __tcp_check_space+0x600/0x600 [ 22.490073][ C0] ? tcp_v4_rcv+0x1a81/0x2b70 [ 22.490075][ C0] ? do_raw_spin_lock+0x131/0x280 [ 22.490077][ C0] tcp_v4_do_rcv+0x4f6/0xb90 [ 22.490079][ C0] tcp_v4_rcv+0x1caa/0x2b70 [ 22.490082][ C0] ? mark_usage+0x61/0x170 [ 22.490083][ C0] ? tcp_add_backlog+0x1e30/0x1e30 [ 22.490085][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 22.490087][ C0] ? ip_local_deliver_finish+0x2ba/0x610 [ 22.490089][ C0] ip_protocol_deliver_rcu+0x82/0x350 [ 22.490091][ C0] ? process_backlog+0x3f1/0x14c0 [ 22.490093][ C0] ip_local_deliver_finish+0x36f/0x610 [ 22.490094][ C0] ip_local_deliver+0x184/0x4c0 [ 22.490096][ C0] ? ip_local_deliver_finish+0x610/0x610 [ 22.490097][ C0] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 22.490100][ C0] ? process_backlog+0x3f1/0x14c0 [ 22.490102][ C0] ip_rcv+0xdc/0x3d0 [ 22.490103][ C0] ? ip_local_deliver+0x4c0/0x4c0 [ 22.490105][ C0] ? rcu_read_lock_any_held+0x3c/0x90 [ 22.490107][ C0] ? mark_usage+0x61/0x170 [ 22.490108][ C0] ? __lock_acquire+0x518/0xc20 [ 22.490109][ C0] ? trace_raw_output_rcu_invoke_kfree_bulk_callback+0x57/0x130 [ 22.490112][ C0] __netif_receive_skb_one_core+0xfc/0x180 [ 22.490114][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 22.490115][ C0] ? process_backlog+0x3f1/0x14c0 [ 22.490117][ C0] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 22.490119][ C0] ? rcu_is_watching+0x16/0xd0 [ 22.490121][ C0] process_backlog+0x431/0x14c0 [ 22.490124][ C0] __napi_poll+0xa7/0x3b0 [ 22.490126][ C0] net_rx_action+0x513/0xf50 [ 22.490128][ C0] ? __lock_acquire+0x518/0xc20 [ 22.490130][ C0] ? __napi_poll+0x3b0/0x3b0 [ 22.490133][ C0] ? ktime_get_update_offsets_now+0x2a8/0x490 [ 22.490136][ C0] ? rcu_is_watching+0x16/0xd0 [ 22.490138][ C0] handle_softirqs+0x1d3/0x900 [ 22.490140][ C0] ? _local_bh_enable+0xc0/0xc0 [ 22.490142][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 22.490143][ C0] ? rcu_is_watching+0x16/0xd0 [ 22.490145][ C0] do_softirq+0xac/0xe0 [ 22.490147][ C0] [ 22.490147][ C0] [ 22.490148][ C0] __local_bh_enable_ip+0x118/0x150 [ 22.490149][ C0] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 22.490152][ C0] ? ovpn_tcp_recvmsg+0x6d0/0x6d0 [ovpn] [ 22.490156][ C0] __sys_sendto+0x2aa/0x400 [ 22.490158][ C0] ? __ia32_sys_getpeername+0xd0/0xd0 [ 22.490161][ C0] ? fput_close_sync+0xde/0x1b0 [ 22.490164][ C0] ? alloc_file_clone+0xe0/0xe0 [ 22.490165][ C0] __x64_sys_sendto+0xe4/0x1f0 [ 22.490167][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 22.490169][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 22.490171][ C0] ? do_syscall_64+0xa6/0x530 [ 22.490172][ C0] do_syscall_64+0xff/0x530 [ 22.490174][ C0] ? exc_page_fault+0xee/0x100 [ 22.490175][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 22.490177][ C0] RIP: 0033:0x7f903aee854e [ 22.490179][ C0] 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 [ 22.490181][ C0] RSP: 002b:00007ffd289b4530 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 22.490184][ C0] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f903aee854e [ 22.490185][ C0] RDX: 00000000000003ea RSI: 00007ffd289b45a0 RDI: 0000000000000005 [ 22.490186][ C0] RBP: 00007ffd289b4540 R08: 0000000000000000 R09: 0000000000000000 [ 22.490187][ C0] R10: 0000000000004000 R11: 0000000000000202 R12: 00007ffd289b4ec8 [ 22.490188][ C0] R13: 0000000000000008 R14: 00007f903b1d3000 R15: 000000000040bda8 [ 22.490190][ C0] [ 22.490194][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 22.490195][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 400, name: ovpn-cli [ 22.490196][ C0] preempt_count: 103, expected: 0 [ 22.490197][ C0] RCU nest depth: 3, expected: 0 [ 22.490197][ C0] INFO: lockdep is turned off. [ 22.490198][ C0] irq event stamp: 35059 [ 22.490199][ C0] hardirqs last enabled at (35058): [] __down_trylock_console_sem+0x86/0xa0 [ 22.490201][ C0] hardirqs last disabled at (35059): [] console_emit_next_record+0x3d4/0x4c0 [ 22.490203][ C0] softirqs last enabled at (34944): [] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 22.490205][ C0] softirqs last disabled at (34945): [] do_softirq+0xac/0xe0 [ 22.490207][ C0] Preemption disabled at: [ 22.490207][ C0] [<0000000000000000>] 0x0 [ 22.490209][ C0] CPU: 0 UID: 0 PID: 400 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 22.490211][ C0] Tainted: [W]=WARN [ 22.490212][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 22.490213][ C0] Call Trace: [ 22.490213][ C0] [ 22.490214][ C0] dump_stack_lvl+0x6f/0xa0 [ 22.490216][ C0] __might_resched.cold+0x1fe/0x2c1 [ 22.490219][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 22.490222][ C0] ? rcu_is_watching+0x16/0xd0 [ 22.490224][ C0] __kmalloc_noprof+0x443/0x760 [ 22.490225][ C0] ? __rwlock_init+0x150/0x150 [ 22.490227][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 22.490229][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 22.490230][ C0] alloc_buf.isra.0+0x4b/0x260 [ 22.490233][ C0] put_chars+0x1e1/0x2f0 [ 22.490234][ C0] ? __send_to_port+0x420/0x420 [ 22.490237][ C0] hvc_console_print+0x292/0x780 [ 22.490239][ C0] ? __lock_acquire+0x388/0xc20 [ 22.490241][ C0] ? hvc_write+0x3a0/0x3a0 [ 22.490243][ C0] ? rcu_is_watching+0x16/0xd0 [ 22.490244][ C0] ? lock_acquire+0x13c/0x160 [ 22.490246][ C0] console_emit_next_record+0x22f/0x4c0 [ 22.490248][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 22.490250][ C0] ? console_flush_one_record+0x106/0x710 [ 22.490252][ C0] ? rcu_is_watching+0x16/0xd0 [ 22.490253][ C0] ? lock_acquire+0x13c/0x160 [ 22.490255][ C0] console_flush_one_record+0x46f/0x710 [ 22.490258][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 22.490259][ C0] ? __lock_acquire+0x518/0xc20 [ 22.490261][ C0] console_unlock+0xee/0x1f0 [ 22.490263][ C0] ? console_flush_one_record+0x710/0x710 [ 22.490265][ C0] ? rcu_is_watching+0x16/0xd0 [ 22.490266][ C0] ? lock_acquire+0x60/0x160 [ 22.490268][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 22.490270][ C0] ? vprintk_emit+0x320/0x3e0 [ 22.490272][ C0] vprintk_emit+0x37c/0x3e0 [ 22.490274][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 22.490276][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 22.490278][ C0] _printk+0xc7/0x100 [ 22.490279][ C0] ? snapshot_read.cold+0x21/0x21 [ 22.490281][ C0] ? ___ratelimit+0x4e7/0xa00 [ 22.490283][ C0] ? ovpn_netdev_write+0x730/0x730 [ovpn] [ 22.490285][ C0] ? idr_get_free+0x830/0x830 [ 22.490287][ C0] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 22.490290][ C0] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 22.490293][ C0] ? ovpn_tcp_write_space+0x2e0/0x2e0 [ovpn] [ 22.490295][ C0] ? __copy_skb_header+0xb7/0x510 [ 22.490297][ C0] ? ovpn_tcp_disconnect+0x10/0x10 [ovpn] [ 22.490299][ C0] ? sock_queue_err_skb+0xb0/0x680 [ 22.490301][ C0] __strp_recv+0x20f/0x1c20 [ 22.490304][ C0] __tcp_read_sock+0x1c7/0x850 [ 22.490306][ C0] ? strp_process+0xb0/0xb0 [ 22.490308][ C0] ? __tcp_transmit_skb+0x1b6e/0x3c10 [ 22.490309][ C0] ? tcp_cleanup_rbuf+0x1c0/0x1c0 [ 22.490311][ C0] ? mark_usage+0x61/0x170 [ 22.490312][ C0] strp_read_sock+0x20f/0x2b0 [ 22.490315][ C0] ? strp_stop+0x50/0x50 [ 22.490317][ C0] ? rcu_is_watching+0x16/0xd0 [ 22.490318][ C0] ? lock_acquire+0x13c/0x160 [ 22.490320][ C0] strp_data_ready+0x18e/0x2c0 [ 22.490322][ C0] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 22.490324][ C0] tcp_rcv_established+0x1e1d/0x3910 [ 22.490327][ C0] ? __tcp_check_space+0x600/0x600 [ 22.490329][ C0] ? tcp_v4_rcv+0x1a81/0x2b70 [ 22.490331][ C0] ? do_raw_spin_lock+0x131/0x280 [ 22.490333][ C0] tcp_v4_do_rcv+0x4f6/0xb90 [ 22.490335][ C0] tcp_v4_rcv+0x1caa/0x2b70 [ 22.490337][ C0] ? mark_usage+0x61/0x170 [ 22.490339][ C0] ? tcp_add_backlog+0x1e30/0x1e30 [ 22.490341][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 22.490342][ C0] ? ip_local_deliver_finish+0x2ba/0x610 [ 22.490344][ C0] ip_protocol_deliver_rcu+0x82/0x350 [ 22.490346][ C0] ? process_backlog+0x3f1/0x14c0 [ 22.490348][ C0] ip_local_deliver_finish+0x36f/0x610 [ 22.490350][ C0] ip_local_deliver+0x184/0x4c0 [ 22.490351][ C0] ? ip_local_deliver_finish+0x610/0x610 [ 22.490353][ C0] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 22.490355][ C0] ? process_backlog+0x3f1/0x14c0 [ 22.490357][ C0] ip_rcv+0xdc/0x3d0 [ 22.490358][ C0] ? ip_local_deliver+0x4c0/0x4c0 [ 22.490360][ C0] ? rcu_read_lock_any_held+0x3c/0x90 [ 22.490361][ C0] ? mark_usage+0x61/0x170 [ 22.490363][ C0] ? __lock_acquire+0x518/0xc20 [ 22.490364][ C0] ? trace_raw_output_rcu_invoke_kfree_bulk_callback+0x57/0x130 [ 22.490366][ C0] __netif_receive_skb_one_core+0xfc/0x180 [ 22.490368][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 22.490369][ C0] ? process_backlog+0x3f1/0x14c0 [ 22.490371][ C0] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 22.490373][ C0] ? rcu_is_watching+0x16/0xd0 [ 22.490375][ C0] process_backlog+0x431/0x14c0 [ 22.490378][ C0] __napi_poll+0xa7/0x3b0 [ 22.490380][ C0] net_rx_action+0x513/0xf50 [ 22.490382][ C0] ? __lock_acquire+0x518/0xc20 [ 22.490384][ C0] ? __napi_poll+0x3b0/0x3b0 [ 22.490387][ C0] ? ktime_get_update_offsets_now+0x2a8/0x490 [ 22.490389][ C0] ? rcu_is_watching+0x16/0xd0 [ 22.490394][ C0] handle_softirqs+0x1d3/0x900 [ 22.490396][ C0] ? _local_bh_enable+0xc0/0xc0 [ 22.490397][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 22.490399][ C0] ? rcu_is_watching+0x16/0xd0 [ 22.490401][ C0] do_softirq+0xac/0xe0 [ 22.490402][ C0] [ 22.490403][ C0] [ 22.490403][ C0] __local_bh_enable_ip+0x118/0x150 [ 22.490405][ C0] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 22.490407][ C0] ? ovpn_tcp_recvmsg+0x6d0/0x6d0 [ovpn] [ 22.490411][ C0] __sys_sendto+0x2aa/0x400 [ 22.490413][ C0] ? __ia32_sys_getpeername+0xd0/0xd0 [ 22.490417][ C0] ? fput_close_sync+0xde/0x1b0 [ 22.490418][ C0] ? alloc_file_clone+0xe0/0xe0 [ 22.490419][ C0] __x64_sys_sendto+0xe4/0x1f0 [ 22.490421][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 22.490422][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 22.490424][ C0] ? do_syscall_64+0xa6/0x530 [ 22.490425][ C0] do_syscall_64+0xff/0x530 [ 22.490427][ C0] ? exc_page_fault+0xee/0x100 [ 22.490428][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 22.490429][ C0] RIP: 0033:0x7f903aee854e [ 22.490431][ C0] 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 [ 22.490432][ C0] RSP: 002b:00007ffd289b4530 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 22.490433][ C0] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f903aee854e [ 22.490434][ C0] RDX: 00000000000003ea RSI: 00007ffd289b45a0 RDI: 0000000000000005 [ 22.490434][ C0] RBP: 00007ffd289b4540 R08: 0000000000000000 R09: 0000000000000000 [ 22.490435][ C0] R10: 0000000000004000 R11: 0000000000000202 R12: 00007ffd289b4ec8 [ 22.490436][ C0] R13: 0000000000000008 R14: 00007f903b1d3000 R15: 000000000040bda8 [ 22.490438][ C0] [ 22.914282][ C1] tun0: no available key for peer 6, key-id: 0 [ 31.421925][ T624] iperf3 (624) used greatest stack depth: 23128 bytes left [ 31.421943][ T624] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 31.421945][ T624] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 624, name: iperf3 [ 31.421947][ T624] preempt_count: 2, expected: 0 [ 31.421948][ T624] RCU nest depth: 0, expected: 0 [ 31.421949][ T624] INFO: lockdep is turned off. [ 31.421950][ T624] irq event stamp: 0 [ 31.421950][ T624] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 31.421955][ T624] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 31.421961][ T624] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 31.421963][ T624] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 31.421964][ T624] Preemption disabled at: [ 31.421965][ T624] [<0000000000000000>] 0x0 [ 31.421970][ T624] CPU: 0 UID: 0 PID: 624 Comm: iperf3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 31.421974][ T624] Tainted: [W]=WARN [ 31.421974][ T624] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 31.421976][ T624] Call Trace: [ 31.421978][ T624] [ 31.421979][ T624] dump_stack_lvl+0x6f/0xa0 [ 31.421984][ T624] __might_resched.cold+0x1fe/0x2c1 [ 31.421988][ T624] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 31.421991][ T624] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 31.421994][ T624] ? rcu_is_watching+0x16/0xd0 [ 31.421997][ T624] __kmalloc_noprof+0x443/0x760 [ 31.422001][ T624] ? __rwlock_init+0x150/0x150 [ 31.422003][ T624] ? alloc_buf.isra.0+0x4b/0x260 [ 31.422007][ T624] ? do_raw_spin_unlock+0x59/0x250 [ 31.422009][ T624] alloc_buf.isra.0+0x4b/0x260 [ 31.422011][ T624] put_chars+0x1e1/0x2f0 [ 31.422013][ T624] ? prb_final_commit+0x50/0x50 [ 31.422014][ T624] ? __send_to_port+0x420/0x420 [ 31.422016][ T624] ? printk_get_next_message+0x240/0x650 [ 31.422019][ T624] hvc_console_print+0x292/0x780 [ 31.422023][ T624] ? hvc_write+0x3a0/0x3a0 [ 31.422024][ T624] ? do_raw_spin_lock+0x131/0x280 [ 31.422026][ T624] ? vsnprintf+0x668/0x1700 [ 31.422028][ T624] ? __rwlock_init+0x150/0x150 [ 31.422030][ T624] ? rcu_is_watching+0x16/0xd0 [ 31.422032][ T624] ? lock_acquire+0x13c/0x160 [ 31.422034][ T624] console_emit_next_record+0x22f/0x4c0 [ 31.422036][ T624] ? devkmsg_read+0x4b0/0x4b0 [ 31.422038][ T624] ? rcu_is_watching+0x16/0xd0 [ 31.422040][ T624] ? rcu_is_watching+0x16/0xd0 [ 31.422041][ T624] ? rcu_is_watching+0x16/0xd0 [ 31.422043][ T624] ? lock_acquire+0x13c/0x160 [ 31.422045][ T624] ? console_flush_one_record+0x111/0x710 [ 31.422046][ T624] console_flush_one_record+0x46f/0x710 [ 31.422049][ T624] ? console_emit_next_record+0x4c0/0x4c0 [ 31.422051][ T624] console_unlock+0xee/0x1f0 [ 31.422053][ T624] ? lock_acquire+0x13c/0x160 [ 31.422054][ T624] ? console_flush_one_record+0x710/0x710 [ 31.422056][ T624] ? rcu_is_watching+0x16/0xd0 [ 31.422057][ T624] ? lock_release+0x184/0x1f0 [ 31.422059][ T624] ? lock_acquire+0x60/0x160 [ 31.422060][ T624] ? __rcu_read_lock+0x30/0x70 [ 31.422062][ T624] ? __down_trylock_console_sem+0x5e/0xa0 [ 31.422064][ T624] ? vprintk_emit+0x320/0x3e0 [ 31.422066][ T624] vprintk_emit+0x37c/0x3e0 [ 31.422068][ T624] ? wake_up_klogd_work_func+0x90/0x90 [ 31.422071][ T624] _printk+0xc7/0x100 [ 31.422074][ T624] ? snapshot_read.cold+0x21/0x21 [ 31.422075][ T624] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 31.422078][ T624] ? do_raw_spin_lock+0x131/0x280 [ 31.422080][ T624] ? __rwlock_init+0x150/0x150 [ 31.422082][ T624] ? do_raw_spin_lock+0x131/0x280 [ 31.422083][ T624] do_exit.cold+0x82/0x9c [ 31.422086][ T624] ? exit_notify+0x890/0x890 [ 31.422089][ T624] __x64_sys_exit+0x42/0x50 [ 31.422090][ T624] x64_sys_call+0x156c/0x1570 [ 31.422092][ T624] do_syscall_64+0xff/0x530 [ 31.422095][ T624] ? exc_page_fault+0xee/0x100 [ 31.422096][ T624] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 31.422099][ T624] RIP: 0033:0x7f83fbb34c49 [ 31.422100][ T624] Code: Unable to access opcode bytes at 0x7f83fbb34c1f. [ 31.422102][ T624] RSP: 002b:00007f83fb2f3e60 EFLAGS: 00000246 ORIG_RAX: 000000000000003c [ 31.422105][ T624] RAX: ffffffffffffffda RBX: 00007f83fb2f46c0 RCX: 00007f83fbb34c49 [ 31.422106][ T624] RDX: 0000000000000000 RSI: 0000000000801000 RDI: 0000000000000000 [ 31.422107][ T624] RBP: 00007f83fb2f3f70 R08: 0000000000000001 R09: 00007f83fb2f46c0 [ 31.422108][ T624] R10: 0000000000000008 R11: 0000000000000246 R12: 00007f83faaf4000 [ 31.422109][ T624] R13: 00007ffd2a9a4660 R14: 0000000000000002 R15: 00007ffd2a9a4767 [ 31.422111][ T624] [ 32.597125][ T719] tun0: deleting peer with id 1, reason 1 [ 32.597140][ T719] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 32.597142][ T719] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 719, name: ovpn-cli [ 32.597144][ T719] preempt_count: 202, expected: 0 [ 32.597144][ T719] RCU nest depth: 0, expected: 0 [ 32.597145][ T719] INFO: lockdep is turned off. [ 32.597146][ T719] irq event stamp: 0 [ 32.597147][ T719] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 32.597151][ T719] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 32.597157][ T719] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 32.597158][ T719] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 32.597160][ T719] Preemption disabled at: [ 32.597161][ T719] [<0000000000000000>] 0x0 [ 32.597166][ T719] CPU: 0 UID: 0 PID: 719 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 32.597169][ T719] Tainted: [W]=WARN [ 32.597170][ T719] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 32.597172][ T719] Call Trace: [ 32.597173][ T719] [ 32.597174][ T719] dump_stack_lvl+0x6f/0xa0 [ 32.597179][ T719] __might_resched.cold+0x1fe/0x2c1 [ 32.597183][ T719] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 32.597187][ T719] ? rcu_is_watching+0x16/0xd0 [ 32.597190][ T719] __kmalloc_noprof+0x443/0x760 [ 32.597194][ T719] ? __rwlock_init+0x150/0x150 [ 32.597196][ T719] ? alloc_buf.isra.0+0x4b/0x260 [ 32.597200][ T719] ? do_raw_spin_unlock+0x59/0x250 [ 32.597202][ T719] alloc_buf.isra.0+0x4b/0x260 [ 32.597204][ T719] put_chars+0x1e1/0x2f0 [ 32.597206][ T719] ? __send_to_port+0x420/0x420 [ 32.597208][ T719] ? printk_get_next_message+0x240/0x650 [ 32.597211][ T719] hvc_console_print+0x292/0x780 [ 32.597215][ T719] ? hvc_write+0x3a0/0x3a0 [ 32.597216][ T719] ? __rwlock_init+0x150/0x150 [ 32.597218][ T719] ? rcu_is_watching+0x16/0xd0 [ 32.597219][ T719] ? lock_acquire+0x13c/0x160 [ 32.597222][ T719] console_emit_next_record+0x22f/0x4c0 [ 32.597224][ T719] ? devkmsg_read+0x4b0/0x4b0 [ 32.597226][ T719] ? rcu_is_watching+0x16/0xd0 [ 32.597227][ T719] ? rcu_is_watching+0x16/0xd0 [ 32.597229][ T719] ? rcu_is_watching+0x16/0xd0 [ 32.597231][ T719] ? lock_acquire+0x13c/0x160 [ 32.597232][ T719] ? console_flush_one_record+0x111/0x710 [ 32.597234][ T719] console_flush_one_record+0x46f/0x710 [ 32.597236][ T719] ? console_emit_next_record+0x4c0/0x4c0 [ 32.597239][ T719] console_unlock+0xee/0x1f0 [ 32.597241][ T719] ? lock_acquire+0x13c/0x160 [ 32.597242][ T719] ? console_flush_one_record+0x710/0x710 [ 32.597244][ T719] ? rcu_is_watching+0x16/0xd0 [ 32.597245][ T719] ? lock_release+0x184/0x1f0 [ 32.597246][ T719] ? lock_acquire+0x60/0x160 [ 32.597248][ T719] ? __rcu_read_lock+0x30/0x70 [ 32.597250][ T719] ? __down_trylock_console_sem+0x5e/0xa0 [ 32.597252][ T719] ? vprintk_emit+0x320/0x3e0 [ 32.597253][ T719] vprintk_emit+0x37c/0x3e0 [ 32.597256][ T719] ? wake_up_klogd_work_func+0x90/0x90 [ 32.597257][ T719] ? kernel_text_address+0x149/0x170 [ 32.597260][ T719] ? __kernel_text_address+0x12/0x30 [ 32.597261][ T719] ? write_profile+0xf0/0xf0 [ 32.597263][ T719] ? unwind_get_return_address+0x67/0xd0 [ 32.597266][ T719] _printk+0xc7/0x100 [ 32.597268][ T719] ? snapshot_read.cold+0x21/0x21 [ 32.597270][ T719] ? netdev_name+0x43/0x60 [ 32.597273][ T719] ? __netdev_printk+0x17f/0x1d0 [ 32.597274][ T719] netdev_info+0xe2/0x116 [ 32.597276][ T719] ? netdev_notice+0x120/0x120 [ 32.597277][ T719] ? ovpn_nl_pre_doit+0x44/0x90 [ovpn] [ 32.597283][ T719] ? __module_address+0x36/0x330 [ 32.597286][ T719] ? lock_acquire+0x13c/0x160 [ 32.597287][ T719] ? rcu_is_watching+0x16/0xd0 [ 32.597289][ T719] ? lock_release+0x184/0x1f0 [ 32.597290][ T719] ? ovpn_peer_get_by_id+0x38a/0x7a0 [ovpn] [ 32.597293][ T719] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 32.597297][ T719] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 32.597299][ T719] ? lock_acquire+0x13c/0x160 [ 32.597301][ T719] ? rcu_is_watching+0x16/0xd0 [ 32.597303][ T719] ? lock_release+0x184/0x1f0 [ 32.597304][ T719] ovpn_peer_remove+0x394/0x640 [ovpn] [ 32.597307][ T719] ? do_raw_spin_lock+0x131/0x280 [ 32.597309][ T719] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 32.597312][ T719] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 32.597315][ T719] ? ovpn_peer_add+0x330/0x330 [ovpn] [ 32.597318][ T719] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 32.597321][ T719] ? trace_hardirqs_on+0x36/0x40 [ 32.597323][ T719] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 32.597325][ T719] ? ref_tracker_alloc+0x28d/0x430 [ 32.597330][ T719] ? lock_release+0x184/0x1f0 [ 32.597332][ T719] ? ovpn_get_dev_from_attrs+0x17a/0x660 [ovpn] [ 32.597335][ T719] genl_family_rcv_msg_doit+0x206/0x300 [ 32.597340][ T719] ? genl_family_rcv_msg_attrs_parse.isra.0+0x330/0x330 [ 32.597341][ T719] ? rcu_is_watching+0x16/0xd0 [ 32.597344][ T719] ? rcu_is_watching+0x16/0xd0 [ 32.597346][ T719] ? cap_capable+0x1d7/0x3d0 [ 32.597349][ T719] ? write_profile+0xf0/0xf0 [ 32.597350][ T719] ? unwind_get_return_address+0x67/0xd0 [ 32.597352][ T719] genl_family_rcv_msg+0x3a4/0x640 [ 32.597354][ T719] ? genl_family_rcv_msg_dumpit+0x340/0x340 [ 32.597356][ T719] ? ovpn_nl_send_peer+0x1300/0x1300 [ovpn] [ 32.597358][ T719] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 32.597360][ T719] ? ovpn_nl_pre_doit+0x90/0x90 [ovpn] [ 32.597363][ T719] ? filter_irq_stacks+0xd0/0xd0 [ 32.597364][ T719] ? stack_depot_save_flags+0x1bc/0x790 [ 32.597366][ T719] genl_rcv_msg+0xbb/0x160 [ 32.597368][ T719] netlink_rcv_skb+0x14e/0x3a0 [ 32.597370][ T719] ? genl_family_rcv_msg+0x640/0x640 [ 32.597372][ T719] ? netlink_ack+0xcf0/0xcf0 [ 32.597375][ T719] ? lock_acquire+0x13c/0x160 [ 32.597376][ T719] ? rcu_is_watching+0x16/0xd0 [ 32.597378][ T719] ? lock_release+0x184/0x1f0 [ 32.597380][ T719] genl_rcv+0x28/0x40 [ 32.597382][ T719] netlink_unicast+0x486/0x750 [ 32.597384][ T719] ? netlink_attachskb+0x810/0x810 [ 32.597385][ T719] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 32.597387][ T719] ? trace_hardirqs_on+0x36/0x40 [ 32.597388][ T719] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 32.597394][ T719] netlink_sendmsg+0x735/0xc60 [ 32.597396][ T719] ? netlink_unicast+0x750/0x750 [ 32.597398][ T719] ? rcu_is_watching+0x16/0xd0 [ 32.597400][ T719] ? lock_release+0x184/0x1f0 [ 32.597402][ T719] ____sys_sendmsg+0x415/0x880 [ 32.597405][ T719] ? copy_msghdr_from_user+0x279/0x420 [ 32.597406][ T719] ? get_timestamp.constprop.0+0x390/0x390 [ 32.597408][ T719] ? move_addr_to_kernel+0x40/0x40 [ 32.597411][ T719] ___sys_sendmsg+0x14e/0x1d0 [ 32.597413][ T719] ? copy_msghdr_from_user+0x420/0x420 [ 32.597414][ T719] ? kfree+0x22/0x590 [ 32.597419][ T719] __sys_sendmsg+0x12c/0x1d0 [ 32.597421][ T719] ? __sys_sendmsg_sock+0x20/0x20 [ 32.597423][ T719] ? rcu_is_watching+0x16/0xd0 [ 32.597425][ T719] ? rcu_is_watching+0x16/0xd0 [ 32.597427][ T719] do_syscall_64+0xff/0x530 [ 32.597430][ T719] ? exc_page_fault+0xee/0x100 [ 32.597431][ T719] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 32.597434][ T719] RIP: 0033:0x7f714deba54e [ 32.597435][ T719] 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 [ 32.597437][ T719] RSP: 002b:00007ffdf945d130 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 32.597440][ T719] RAX: ffffffffffffffda RBX: 0000000022efd130 RCX: 00007f714deba54e [ 32.597442][ T719] RDX: 0000000000000000 RSI: 00007ffdf945d1d0 RDI: 0000000000000005 [ 32.597443][ T719] RBP: 00007ffdf945d140 R08: 0000000000000000 R09: 0000000000000000 [ 32.597443][ T719] R10: 0000000000000000 R11: 0000000000000202 R12: 0000000022efd200 [ 32.597444][ T719] R13: 00007ffdf945d1d0 R14: 0000000022efe260 R15: 000000000040bda8 [ 32.597446][ T719] [ 32.674083][ T723] tun1: deleting peer with id 10, reason 1 [ 35.189967][ T771] tun0: deleting peer with id 2, reason 1 [ 35.189984][ T771] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 35.189987][ T771] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 771, name: ovpn-cli [ 35.189988][ T771] preempt_count: 202, expected: 0 [ 35.189989][ T771] RCU nest depth: 0, expected: 0 [ 35.189990][ T771] INFO: lockdep is turned off. [ 35.189991][ T771] irq event stamp: 0 [ 35.189991][ T771] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 35.189995][ T771] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 35.190001][ T771] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 35.190003][ T771] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 35.190005][ T771] Preemption disabled at: [ 35.190005][ T771] [<0000000000000000>] 0x0 [ 35.190011][ T771] CPU: 2 UID: 0 PID: 771 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 35.190014][ T771] Tainted: [W]=WARN [ 35.190015][ T771] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 35.190017][ T771] Call Trace: [ 35.190018][ T771] [ 35.190020][ T771] dump_stack_lvl+0x6f/0xa0 [ 35.190025][ T771] __might_resched.cold+0x1fe/0x2c1 [ 35.190029][ T771] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 35.190033][ T771] ? rcu_is_watching+0x16/0xd0 [ 35.190036][ T771] __kmalloc_noprof+0x443/0x760 [ 35.190040][ T771] ? __rwlock_init+0x150/0x150 [ 35.190043][ T771] ? alloc_buf.isra.0+0x4b/0x260 [ 35.190047][ T771] ? do_raw_spin_unlock+0x59/0x250 [ 35.190048][ T771] alloc_buf.isra.0+0x4b/0x260 [ 35.190050][ T771] put_chars+0x1e1/0x2f0 [ 35.190052][ T771] ? __send_to_port+0x420/0x420 [ 35.190054][ T771] ? printk_get_next_message+0x240/0x650 [ 35.190057][ T771] hvc_console_print+0x292/0x780 [ 35.190061][ T771] ? hvc_write+0x3a0/0x3a0 [ 35.190062][ T771] ? __rwlock_init+0x150/0x150 [ 35.190064][ T771] ? rcu_is_watching+0x16/0xd0 [ 35.190066][ T771] ? lock_acquire+0x13c/0x160 [ 35.190068][ T771] console_emit_next_record+0x22f/0x4c0 [ 35.190070][ T771] ? devkmsg_read+0x4b0/0x4b0 [ 35.190072][ T771] ? rcu_is_watching+0x16/0xd0 [ 35.190074][ T771] ? rcu_is_watching+0x16/0xd0 [ 35.190076][ T771] ? rcu_is_watching+0x16/0xd0 [ 35.190077][ T771] ? lock_acquire+0x13c/0x160 [ 35.190079][ T771] ? console_flush_one_record+0x111/0x710 [ 35.190081][ T771] console_flush_one_record+0x46f/0x710 [ 35.190083][ T771] ? console_emit_next_record+0x4c0/0x4c0 [ 35.190086][ T771] console_unlock+0xee/0x1f0 [ 35.190087][ T771] ? lock_acquire+0x13c/0x160 [ 35.190089][ T771] ? console_flush_one_record+0x710/0x710 [ 35.190090][ T771] ? rcu_is_watching+0x16/0xd0 [ 35.190092][ T771] ? lock_release+0x184/0x1f0 [ 35.190094][ T771] ? lock_acquire+0x60/0x160 [ 35.190095][ T771] ? __rcu_read_lock+0x30/0x70 [ 35.190097][ T771] ? __down_trylock_console_sem+0x5e/0xa0 [ 35.190099][ T771] ? vprintk_emit+0x320/0x3e0 [ 35.190101][ T771] vprintk_emit+0x37c/0x3e0 [ 35.190103][ T771] ? wake_up_klogd_work_func+0x90/0x90 [ 35.190105][ T771] ? kernel_text_address+0x149/0x170 [ 35.190107][ T771] ? __kernel_text_address+0x12/0x30 [ 35.190108][ T771] ? write_profile+0xf0/0xf0 [ 35.190110][ T771] ? unwind_get_return_address+0x67/0xd0 [ 35.190113][ T771] _printk+0xc7/0x100 [ 35.190116][ T771] ? snapshot_read.cold+0x21/0x21 [ 35.190118][ T771] ? netdev_name+0x43/0x60 [ 35.190121][ T771] ? __netdev_printk+0x17f/0x1d0 [ 35.190122][ T771] netdev_info+0xe2/0x116 [ 35.190124][ T771] ? netdev_notice+0x120/0x120 [ 35.190125][ T771] ? ovpn_nl_pre_doit+0x44/0x90 [ovpn] [ 35.190131][ T771] ? __module_address+0x36/0x330 [ 35.190134][ T771] ? lock_acquire+0x13c/0x160 [ 35.190135][ T771] ? rcu_is_watching+0x16/0xd0 [ 35.190137][ T771] ? lock_release+0x184/0x1f0 [ 35.190139][ T771] ? ovpn_peer_get_by_id+0x38a/0x7a0 [ovpn] [ 35.190142][ T771] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 35.190145][ T771] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 35.190148][ T771] ? lock_acquire+0x13c/0x160 [ 35.190149][ T771] ? rcu_is_watching+0x16/0xd0 [ 35.190151][ T771] ? lock_release+0x184/0x1f0 [ 35.190153][ T771] ovpn_peer_remove+0x394/0x640 [ovpn] [ 35.190155][ T771] ? do_raw_spin_lock+0x131/0x280 [ 35.190157][ T771] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 35.190160][ T771] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 35.190163][ T771] ? ovpn_peer_add+0x330/0x330 [ovpn] [ 35.190166][ T771] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 35.190169][ T771] ? trace_hardirqs_on+0x36/0x40 [ 35.190171][ T771] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 35.190174][ T771] ? ref_tracker_alloc+0x28d/0x430 [ 35.190179][ T771] ? lock_release+0x184/0x1f0 [ 35.190180][ T771] ? ovpn_get_dev_from_attrs+0x17a/0x660 [ovpn] [ 35.190184][ T771] genl_family_rcv_msg_doit+0x206/0x300 [ 35.190188][ T771] ? genl_family_rcv_msg_attrs_parse.isra.0+0x330/0x330 [ 35.190190][ T771] ? rcu_is_watching+0x16/0xd0 [ 35.190192][ T771] ? rcu_is_watching+0x16/0xd0 [ 35.190194][ T771] ? cap_capable+0x1d7/0x3d0 [ 35.190197][ T771] ? write_profile+0xf0/0xf0 [ 35.190199][ T771] ? unwind_get_return_address+0x67/0xd0 [ 35.190200][ T771] genl_family_rcv_msg+0x3a4/0x640 [ 35.190203][ T771] ? genl_family_rcv_msg_dumpit+0x340/0x340 [ 35.190205][ T771] ? ovpn_nl_send_peer+0x1300/0x1300 [ovpn] [ 35.190207][ T771] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 35.190209][ T771] ? ovpn_nl_pre_doit+0x90/0x90 [ovpn] [ 35.190212][ T771] ? filter_irq_stacks+0xd0/0xd0 [ 35.190213][ T771] ? stack_depot_save_flags+0x1bc/0x790 [ 35.190215][ T771] genl_rcv_msg+0xbb/0x160 [ 35.190217][ T771] netlink_rcv_skb+0x14e/0x3a0 [ 35.190219][ T771] ? genl_family_rcv_msg+0x640/0x640 [ 35.190221][ T771] ? netlink_ack+0xcf0/0xcf0 [ 35.190224][ T771] ? lock_acquire+0x13c/0x160 [ 35.190225][ T771] ? rcu_is_watching+0x16/0xd0 [ 35.190227][ T771] ? lock_release+0x184/0x1f0 [ 35.190229][ T771] genl_rcv+0x28/0x40 [ 35.190231][ T771] netlink_unicast+0x486/0x750 [ 35.190233][ T771] ? netlink_attachskb+0x810/0x810 [ 35.190235][ T771] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 35.190236][ T771] ? trace_hardirqs_on+0x36/0x40 [ 35.190237][ T771] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 35.190240][ T771] netlink_sendmsg+0x735/0xc60 [ 35.190243][ T771] ? netlink_unicast+0x750/0x750 [ 35.190245][ T771] ? rcu_is_watching+0x16/0xd0 [ 35.190246][ T771] ? lock_release+0x184/0x1f0 [ 35.190248][ T771] ____sys_sendmsg+0x415/0x880 [ 35.190252][ T771] ? copy_msghdr_from_user+0x279/0x420 [ 35.190253][ T771] ? get_timestamp.constprop.0+0x390/0x390 [ 35.190255][ T771] ? move_addr_to_kernel+0x40/0x40 [ 35.190258][ T771] ___sys_sendmsg+0x14e/0x1d0 [ 35.190259][ T771] ? copy_msghdr_from_user+0x420/0x420 [ 35.190261][ T771] ? kfree+0x22/0x590 [ 35.190266][ T771] __sys_sendmsg+0x12c/0x1d0 [ 35.190268][ T771] ? __sys_sendmsg_sock+0x20/0x20 [ 35.190270][ T771] ? rcu_is_watching+0x16/0xd0 [ 35.190272][ T771] ? rcu_is_watching+0x16/0xd0 [ 35.190274][ T771] do_syscall_64+0xff/0x530 [ 35.190277][ T771] ? exc_page_fault+0xee/0x100 [ 35.190279][ T771] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 35.190280][ T771] RIP: 0033:0x7f7143f0a54e [ 35.190282][ T771] 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 [ 35.190284][ T771] RSP: 002b:00007ffe9f8699b0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 35.190287][ T771] RAX: ffffffffffffffda RBX: 000000000ed45130 RCX: 00007f7143f0a54e [ 35.190289][ T771] RDX: 0000000000000000 RSI: 00007ffe9f869a50 RDI: 0000000000000005 [ 35.190290][ T771] RBP: 00007ffe9f8699c0 R08: 0000000000000000 R09: 0000000000000000 [ 35.190290][ T771] R10: 0000000000000000 R11: 0000000000000202 R12: 000000000ed45200 [ 35.190291][ T771] R13: 00007ffe9f869a50 R14: 000000000ed46260 R15: 000000000040bda8 [ 35.190293][ T771] [ 35.269517][ T775] tun2: deleting peer with id 11, reason 1 [ 40.873413][ T67] tun0: deleting peer with id 4, reason 2 [ 40.873433][ T67] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 40.873436][ T67] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 67, name: kworker/2:2 [ 40.873438][ T67] preempt_count: 202, expected: 0 [ 40.873439][ T67] RCU nest depth: 0, expected: 0 [ 40.873439][ T67] INFO: lockdep is turned off. [ 40.873441][ T67] irq event stamp: 7144 [ 40.873442][ T67] hardirqs last enabled at (7143): [] _raw_spin_unlock_irq+0x28/0x50 [ 40.873450][ T67] hardirqs last disabled at (7144): [] __schedule+0x1246/0x20e0 [ 40.873453][ T67] softirqs last enabled at (6812): [] process_one_work+0xe3e/0x1560 [ 40.873456][ T67] softirqs last disabled at (6808): [] neigh_managed_work+0x2d/0x220 [ 40.873460][ T67] Preemption disabled at: [ 40.873461][ T67] [<0000000000000000>] 0x0 [ 40.873468][ T67] CPU: 2 UID: 0 PID: 67 Comm: kworker/2:2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 40.873472][ T67] Tainted: [W]=WARN [ 40.873472][ T67] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 40.873474][ T67] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 40.873484][ T67] Call Trace: [ 40.873485][ T67] [ 40.873487][ T67] dump_stack_lvl+0x6f/0xa0 [ 40.873492][ T67] __might_resched.cold+0x1fe/0x2c1 [ 40.873496][ T67] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 40.873499][ T67] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 40.873501][ T67] ? rcu_is_watching+0x16/0xd0 [ 40.873505][ T67] __kmalloc_noprof+0x443/0x760 [ 40.873509][ T67] ? __rwlock_init+0x150/0x150 [ 40.873511][ T67] ? alloc_buf.isra.0+0x4b/0x260 [ 40.873515][ T67] ? do_raw_spin_unlock+0x59/0x250 [ 40.873516][ T67] alloc_buf.isra.0+0x4b/0x260 [ 40.873519][ T67] put_chars+0x1e1/0x2f0 [ 40.873520][ T67] ? prb_final_commit+0x50/0x50 [ 40.873522][ T67] ? __send_to_port+0x420/0x420 [ 40.873524][ T67] ? printk_get_next_message+0x240/0x650 [ 40.873526][ T67] hvc_console_print+0x292/0x780 [ 40.873530][ T67] ? hvc_write+0x3a0/0x3a0 [ 40.873532][ T67] ? do_raw_spin_lock+0x131/0x280 [ 40.873533][ T67] ? vsnprintf+0x527/0x1700 [ 40.873535][ T67] ? __rwlock_init+0x150/0x150 [ 40.873536][ T67] ? rcu_is_watching+0x16/0xd0 [ 40.873538][ T67] ? lock_acquire+0x13c/0x160 [ 40.873540][ T67] console_emit_next_record+0x22f/0x4c0 [ 40.873543][ T67] ? devkmsg_read+0x4b0/0x4b0 [ 40.873545][ T67] ? rcu_is_watching+0x16/0xd0 [ 40.873547][ T67] ? rcu_is_watching+0x16/0xd0 [ 40.873548][ T67] ? rcu_is_watching+0x16/0xd0 [ 40.873550][ T67] ? lock_acquire+0x13c/0x160 [ 40.873551][ T67] ? console_flush_one_record+0x111/0x710 [ 40.873553][ T67] console_flush_one_record+0x46f/0x710 [ 40.873555][ T67] ? console_emit_next_record+0x4c0/0x4c0 [ 40.873558][ T67] console_unlock+0xee/0x1f0 [ 40.873559][ T67] ? lock_acquire+0x13c/0x160 [ 40.873561][ T67] ? console_flush_one_record+0x710/0x710 [ 40.873562][ T67] ? rcu_is_watching+0x16/0xd0 [ 40.873564][ T67] ? lock_release+0x184/0x1f0 [ 40.873565][ T67] ? lock_acquire+0x60/0x160 [ 40.873567][ T67] ? __rcu_read_lock+0x30/0x70 [ 40.873569][ T67] ? __down_trylock_console_sem+0x5e/0xa0 [ 40.873570][ T67] ? vprintk_emit+0x320/0x3e0 [ 40.873572][ T67] vprintk_emit+0x37c/0x3e0 [ 40.873574][ T67] ? wake_up_klogd_work_func+0x90/0x90 [ 40.873576][ T67] ? ret_from_fork_asm+0x11/0x20 [ 40.873578][ T67] ? queued_spin_lock_slowpath+0x103/0xa60 [ 40.873580][ T67] ? rcu_is_watching+0x16/0xd0 [ 40.873581][ T67] ? stack_access_ok+0x1e0/0x1e0 [ 40.873584][ T67] _printk+0xc7/0x100 [ 40.873587][ T67] ? snapshot_read.cold+0x21/0x21 [ 40.873589][ T67] ? __add_to_free_list+0x81/0x5c0 [ 40.873591][ T67] ? __mod_zone_page_state+0xe1/0x190 [ 40.873594][ T67] ? netdev_name+0x43/0x60 [ 40.873597][ T67] ? __netdev_printk+0x17f/0x1d0 [ 40.873598][ T67] netdev_info+0xe2/0x116 [ 40.873600][ T67] ? netdev_notice+0x120/0x120 [ 40.873602][ T67] ? free_pcppages_bulk+0x363/0x6e0 [ 40.873604][ T67] ? rcu_is_watching+0x16/0xd0 [ 40.873605][ T67] ? trace_irq_enable.constprop.0+0x30/0x160 [ 40.873608][ T67] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 40.873612][ T67] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 40.873614][ T67] ? __rwlock_init+0x150/0x150 [ 40.873616][ T67] ? lock_acquire+0x13c/0x160 [ 40.873618][ T67] ? rcu_is_watching+0x16/0xd0 [ 40.873620][ T67] ovpn_peer_remove+0x394/0x640 [ovpn] [ 40.873623][ T67] ? do_raw_spin_lock+0x131/0x280 [ 40.873625][ T67] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 40.873628][ T67] ? __rwlock_init+0x150/0x150 [ 40.873629][ T67] ? rcu_is_watching+0x16/0xd0 [ 40.873631][ T67] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 40.873632][ T67] ? trace_irq_disable.constprop.0+0x9b/0x160 [ 40.873633][ T67] ovpn_peer_keepalive_work_single+0x416/0x600 [ovpn] [ 40.873636][ T67] ? ovpn_peers_release_mp+0x490/0x490 [ovpn] [ 40.873639][ T67] ? __rwlock_init+0x150/0x150 [ 40.873641][ T67] ovpn_peer_keepalive_work+0x253/0x580 [ovpn] [ 40.873644][ T67] ? ovpn_peers_free+0xb0/0xb0 [ovpn] [ 40.873646][ T67] ? rcu_is_watching+0x16/0xd0 [ 40.873648][ T67] ? lock_acquire+0x13c/0x160 [ 40.873649][ T67] ? rcu_is_watching+0x16/0xd0 [ 40.873651][ T67] process_one_work+0xe3e/0x1560 [ 40.873654][ T67] ? __queue_delayed_work+0x470/0x470 [ 40.873656][ T67] ? find_held_lock+0x2b/0x80 [ 40.873658][ T67] ? __rwlock_init+0x150/0x150 [ 40.873660][ T67] worker_thread+0x4f1/0xd60 [ 40.873662][ T67] ? rescuer_thread+0x1340/0x1340 [ 40.873664][ T67] ? __kthread_parkme+0xbd/0x210 [ 40.873666][ T67] ? rescuer_thread+0x1340/0x1340 [ 40.873668][ T67] ? rescuer_thread+0x1340/0x1340 [ 40.873669][ T67] kthread+0x367/0x460 [ 40.873671][ T67] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 40.873672][ T67] ? kthread_affine_preferred+0x4c0/0x4c0 [ 40.873674][ T67] ret_from_fork+0x474/0x6b0 [ 40.873677][ T67] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 40.873678][ T67] ? __switch_to+0x5a3/0xe00 [ 40.873681][ T67] ? kthread_affine_preferred+0x4c0/0x4c0 [ 40.873682][ T67] ret_from_fork_asm+0x11/0x20 [ 40.873685][ T67] [ 40.896410][ T67] tun0: deleting peer with id 3, reason 2 [ 40.896628][ T67] tun0: deleting peer with id 5, reason 2 [ 40.896884][ T67] tun0: deleting peer with id 6, reason 2 [ 45.993440][ T10] tun3: deleting peer with id 12, reason 2 [ 45.993459][ T10] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 45.993462][ T10] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 10, name: kworker/0:1 [ 45.993464][ T10] preempt_count: 202, expected: 0 [ 45.993465][ T10] RCU nest depth: 0, expected: 0 [ 45.993466][ T10] INFO: lockdep is turned off. [ 45.993467][ T10] irq event stamp: 35958 [ 45.993468][ T10] hardirqs last enabled at (35957): [] _raw_spin_unlock_irq+0x28/0x50 [ 45.993476][ T10] hardirqs last disabled at (35958): [] __schedule+0x1246/0x20e0 [ 45.993479][ T10] softirqs last enabled at (35698): [] process_one_work+0xe3e/0x1560 [ 45.993483][ T10] softirqs last disabled at (35694): [] neigh_managed_work+0x2d/0x220 [ 45.993487][ T10] Preemption disabled at: [ 45.993488][ T10] [<0000000000000000>] 0x0 [ 45.993494][ T10] CPU: 0 UID: 0 PID: 10 Comm: kworker/0:1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 45.993498][ T10] Tainted: [W]=WARN [ 45.993499][ T10] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 45.993501][ T10] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 45.993509][ T10] Call Trace: [ 45.993511][ T10] [ 45.993512][ T10] dump_stack_lvl+0x6f/0xa0 [ 45.993517][ T10] __might_resched.cold+0x1fe/0x2c1 [ 45.993520][ T10] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 45.993524][ T10] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 45.993526][ T10] ? rcu_is_watching+0x16/0xd0 [ 45.993530][ T10] __kmalloc_noprof+0x443/0x760 [ 45.993533][ T10] ? __rwlock_init+0x150/0x150 [ 45.993536][ T10] ? alloc_buf.isra.0+0x4b/0x260 [ 45.993539][ T10] ? do_raw_spin_unlock+0x59/0x250 [ 45.993541][ T10] alloc_buf.isra.0+0x4b/0x260 [ 45.993543][ T10] put_chars+0x1e1/0x2f0 [ 45.993545][ T10] ? prb_final_commit+0x50/0x50 [ 45.993546][ T10] ? __send_to_port+0x420/0x420 [ 45.993548][ T10] ? printk_get_next_message+0x240/0x650 [ 45.993551][ T10] hvc_console_print+0x292/0x780 [ 45.993555][ T10] ? hvc_write+0x3a0/0x3a0 [ 45.993556][ T10] ? do_raw_spin_lock+0x131/0x280 [ 45.993558][ T10] ? vsnprintf+0x527/0x1700 [ 45.993560][ T10] ? __rwlock_init+0x150/0x150 [ 45.993561][ T10] ? rcu_is_watching+0x16/0xd0 [ 45.993563][ T10] ? lock_acquire+0x13c/0x160 [ 45.993565][ T10] console_emit_next_record+0x22f/0x4c0 [ 45.993568][ T10] ? devkmsg_read+0x4b0/0x4b0 [ 45.993570][ T10] ? rcu_is_watching+0x16/0xd0 [ 45.993571][ T10] ? rcu_is_watching+0x16/0xd0 [ 45.993573][ T10] ? rcu_is_watching+0x16/0xd0 [ 45.993574][ T10] ? lock_acquire+0x13c/0x160 [ 45.993576][ T10] ? console_flush_one_record+0x111/0x710 [ 45.993578][ T10] console_flush_one_record+0x46f/0x710 [ 45.993580][ T10] ? console_emit_next_record+0x4c0/0x4c0 [ 45.993582][ T10] console_unlock+0xee/0x1f0 [ 45.993584][ T10] ? lock_acquire+0x13c/0x160 [ 45.993586][ T10] ? console_flush_one_record+0x710/0x710 [ 45.993587][ T10] ? rcu_is_watching+0x16/0xd0 [ 45.993589][ T10] ? lock_release+0x184/0x1f0 [ 45.993590][ T10] ? lock_acquire+0x60/0x160 [ 45.993591][ T10] ? __rcu_read_lock+0x30/0x70 [ 45.993593][ T10] ? __down_trylock_console_sem+0x5e/0xa0 [ 45.993595][ T10] ? vprintk_emit+0x320/0x3e0 [ 45.993597][ T10] vprintk_emit+0x37c/0x3e0 [ 45.993599][ T10] ? wake_up_klogd_work_func+0x90/0x90 [ 45.993601][ T10] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 45.993603][ T10] ? rcu_is_watching+0x16/0xd0 [ 45.993604][ T10] ? trace_sched_wakeup+0x9b/0x160 [ 45.993607][ T10] _printk+0xc7/0x100 [ 45.993610][ T10] ? snapshot_read.cold+0x21/0x21 [ 45.993611][ T10] ? try_to_wake_up+0x153/0x1130 [ 45.993613][ T10] ? select_fallback_rq+0x510/0x510 [ 45.993615][ T10] ? netdev_name+0x43/0x60 [ 45.993617][ T10] ? __netdev_printk+0x17f/0x1d0 [ 45.993619][ T10] netdev_info+0xe2/0x116 [ 45.993621][ T10] ? netdev_notice+0x120/0x120 [ 45.993623][ T10] ? rcu_is_watching+0x16/0xd0 [ 45.993624][ T10] ? __queue_work+0x3ab/0xd30 [ 45.993627][ T10] ? trace_irq_enable.constprop.0+0x30/0x160 [ 45.993630][ T10] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 45.993633][ T10] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 45.993636][ T10] ? rcu_is_watching+0x16/0xd0 [ 45.993637][ T10] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 45.993639][ T10] ovpn_peer_remove+0x394/0x640 [ovpn] [ 45.993643][ T10] ? do_raw_spin_lock+0x131/0x280 [ 45.993644][ T10] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 45.993647][ T10] ? __rwlock_init+0x150/0x150 [ 45.993648][ T10] ? rcu_is_watching+0x16/0xd0 [ 45.993650][ T10] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 45.993651][ T10] ? trace_irq_disable.constprop.0+0x9b/0x160 [ 45.993653][ T10] ovpn_peer_keepalive_work_single+0x416/0x600 [ovpn] [ 45.993655][ T10] ? ovpn_peers_release_mp+0x490/0x490 [ovpn] [ 45.993658][ T10] ? __rwlock_init+0x150/0x150 [ 45.993660][ T10] ovpn_peer_keepalive_work+0x389/0x580 [ovpn] [ 45.993663][ T10] ? ovpn_peers_free+0xb0/0xb0 [ovpn] [ 45.993665][ T10] ? rcu_is_watching+0x16/0xd0 [ 45.993667][ T10] ? lock_acquire+0x13c/0x160 [ 45.993669][ T10] ? rcu_is_watching+0x16/0xd0 [ 45.993671][ T10] ? process_one_work+0xdfc/0x1560 [ 45.993672][ T10] process_one_work+0xe3e/0x1560 [ 45.993675][ T10] ? __queue_delayed_work+0x470/0x470 [ 45.993677][ T10] ? find_held_lock+0x2b/0x80 [ 45.993679][ T10] ? __rwlock_init+0x150/0x150 [ 45.993681][ T10] worker_thread+0x4f1/0xd60 [ 45.993683][ T10] ? rescuer_thread+0x1340/0x1340 [ 45.993685][ T10] ? __kthread_parkme+0xbd/0x210 [ 45.993687][ T10] ? rescuer_thread+0x1340/0x1340 [ 45.993688][ T10] ? rescuer_thread+0x1340/0x1340 [ 45.993690][ T10] kthread+0x367/0x460 [ 45.993691][ T10] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 45.993693][ T10] ? kthread_affine_preferred+0x4c0/0x4c0 [ 45.993694][ T10] ret_from_fork+0x474/0x6b0 [ 45.993697][ T10] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 45.993699][ T10] ? __switch_to+0x5a3/0xe00 [ 45.993701][ T10] ? kthread_affine_preferred+0x4c0/0x4c0 [ 45.993703][ T10] ret_from_fork_asm+0x11/0x20 [ 45.993707][ T10] [ 46.057424][ T10] tun4: deleting peer with id 13, reason 2 [ 46.122445][ T67] tun5: deleting peer with id 14, reason 2 [ 46.185411][ T10] tun6: deleting peer with id 15, reason 2