[ 15.792315][ T313] ip (313) used greatest stack depth: 24424 bytes left [ 15.792337][ T313] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 15.792339][ T313] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 313, name: ip [ 15.792340][ T313] preempt_count: 2, expected: 0 [ 15.792342][ T313] RCU nest depth: 0, expected: 0 [ 15.792343][ T313] locks held by ip/313: 5, last CPU#3: [ 15.792345][ T313] #0: ffffffff980127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 15.792356][ T313] #1: ffffffff98179cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 15.792362][ T313] #2: ffffffff98179d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 15.792366][ T313] #3: ffffffff98099660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 15.792369][ T313] #4: ffffffff98099560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 15.792374][ T313] irq event stamp: 20978 [ 15.792375][ T313] hardirqs last enabled at (20977): [] __down_trylock_console_sem+0x86/0xa0 [ 15.792377][ T313] hardirqs last disabled at (20978): [] console_emit_next_record+0x3d4/0x4c0 [ 15.792379][ T313] softirqs last enabled at (20752): [] handle_softirqs+0x67c/0x900 [ 15.792382][ T313] softirqs last disabled at (20747): [] __irq_exit_rcu+0x145/0x1c0 [ 15.792384][ T313] Preemption disabled at: [ 15.792384][ T313] [<0000000000000000>] 0x0 [ 15.792391][ T313] CPU: 3 UID: 0 PID: 313 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 15.792395][ T313] Tainted: [W]=WARN [ 15.792396][ T313] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.792397][ T313] Call Trace: [ 15.792399][ T313] [ 15.792400][ T313] dump_stack_lvl+0x6f/0xa0 [ 15.792407][ T313] __might_resched.cold+0x1fe/0x2c1 [ 15.792412][ T313] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 15.792416][ T313] ? __kmalloc_noprof+0xdb/0x760 [ 15.792422][ T313] __kmalloc_noprof+0x443/0x760 [ 15.792424][ T313] ? alloc_buf.isra.0+0x4b/0x260 [ 15.792430][ T313] ? do_raw_spin_unlock+0x59/0x250 [ 15.792433][ T313] alloc_buf.isra.0+0x4b/0x260 [ 15.792436][ T313] put_chars+0x1e1/0x2f0 [ 15.792439][ T313] ? __send_to_port+0x420/0x420 [ 15.792441][ T313] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 15.792447][ T313] ? validate_chain+0x38b/0xc20 [ 15.792452][ T313] hvc_console_print+0x292/0x780 [ 15.792459][ T313] ? hvc_write+0x3a0/0x3a0 [ 15.792461][ T313] ? rcu_is_watching+0x16/0xd0 [ 15.792464][ T313] ? lock_acquire+0x13c/0x160 [ 15.792468][ T313] console_emit_next_record+0x22f/0x4c0 [ 15.792472][ T313] ? devkmsg_read+0x4b0/0x4b0 [ 15.792474][ T313] ? console_flush_one_record+0x106/0x710 [ 15.792477][ T313] ? rcu_is_watching+0x16/0xd0 [ 15.792479][ T313] ? lock_acquire+0x13c/0x160 [ 15.792483][ T313] console_flush_one_record+0x46f/0x710 [ 15.792488][ T313] ? console_emit_next_record+0x4c0/0x4c0 [ 15.792490][ T313] ? __lock_acquire+0x518/0xc20 [ 15.792495][ T313] console_unlock+0xee/0x1f0 [ 15.792498][ T313] ? console_flush_one_record+0x710/0x710 [ 15.792500][ T313] ? rcu_is_watching+0x16/0xd0 [ 15.792502][ T313] ? lock_acquire+0x60/0x160 [ 15.792506][ T313] ? __down_trylock_console_sem+0x5e/0xa0 [ 15.792508][ T313] ? vprintk_emit+0x320/0x3e0 [ 15.792511][ T313] vprintk_emit+0x37c/0x3e0 [ 15.792515][ T313] ? wake_up_klogd_work_func+0x90/0x90 [ 15.792519][ T313] ? __lock_acquire+0x518/0xc20 [ 15.792522][ T313] _printk+0xc7/0x100 [ 15.792526][ T313] ? snapshot_read.cold+0x21/0x21 [ 15.792529][ T313] ? do_raw_spin_lock+0x131/0x280 [ 15.792532][ T313] ? __rwlock_init+0x150/0x150 [ 15.792536][ T313] ? do_raw_spin_lock+0x131/0x280 [ 15.792538][ T313] do_exit.cold+0x82/0x9c [ 15.792542][ T313] ? exit_notify+0x890/0x890 [ 15.792544][ T313] ? __lock_release.isra.0+0x69/0x1a0 [ 15.792547][ T313] ? rcu_is_watching+0x16/0xd0 [ 15.792551][ T313] do_group_exit+0xb8/0x370 [ 15.792554][ T313] __x64_sys_exit_group+0x3c/0x50 [ 15.792556][ T313] x64_sys_call+0x1567/0x1570 [ 15.792559][ T313] do_syscall_64+0xff/0x530 [ 15.792563][ T313] ? exc_page_fault+0xee/0x100 [ 15.792565][ T313] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 15.792568][ T313] RIP: 0033:0x7f568d2461b8 [ 15.792570][ T313] Code: Unable to access opcode bytes at 0x7f568d24618e. [ 15.792572][ T313] RSP: 002b:00007ffd036fb9b8 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 15.792574][ T313] RAX: ffffffffffffffda RBX: 00007f568d376f88 RCX: 00007f568d2461b8 [ 15.792575][ T313] RDX: 00007f568cf90fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 15.792576][ T313] RBP: 00007ffd036fba10 R08: 0000000000000000 R09: 0000000000000050 [ 15.792578][ T313] R10: 00007ffd036fb7d0 R11: 0000000000000246 R12: 0000000000000001 [ 15.792578][ T313] R13: 0000000000000000 R14: 00007f568d375680 R15: 00007f568d376fa0 [ 15.792585][ T313] [ 16.102853][ T321] ip (321) used greatest stack depth: 24416 bytes left [ 16.314632][ T327] ip (327) used greatest stack depth: 24096 bytes left [ 23.142846][ C2] tun0: no available key for peer 2, key-id: 0 [ 23.142882][ C2] [ 23.142884][ C2] ======================================================== [ 23.142885][ C2] WARNING: possible irq lock inversion dependency detected [ 23.142887][ C2] 7.2.0-virtme #1 Tainted: G W [ 23.142889][ C2] -------------------------------------------------------- [ 23.142889][ C2] ovpn-cli/406 just changed the state of lock: [ 23.142891][ C2] ffffffff98099660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 23.142905][ C2] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 23.142907][ C2] (fs_reclaim){+.+.}-{0:0} [ 23.142908][ C2] [ 23.142908][ C2] [ 23.142908][ C2] and interrupts could create inverse lock ordering between them. [ 23.142908][ C2] [ 23.142909][ C2] [ 23.142909][ C2] other info that might help us debug this: [ 23.142910][ C2] Possible interrupt unsafe locking scenario: [ 23.142910][ C2] [ 23.142910][ C2] CPU0 CPU1 [ 23.142911][ C2] ---- ---- [ 23.142911][ C2] lock(fs_reclaim); [ 23.142913][ C2] local_irq_disable(); [ 23.142913][ C2] lock(console_owner); [ 23.142914][ C2] lock(fs_reclaim); [ 23.142915][ C2] [ 23.142915][ C2] lock(console_owner); [ 23.142916][ C2] [ 23.142916][ C2] *** DEADLOCK *** [ 23.142916][ C2] [ 23.142917][ C2] locks held by ovpn-cli/406: 6, last CPU#2: [ 23.142918][ C2] #0: ffffffff98190b00 (rcu_read_lock){....}-{1:3}, at: process_backlog+0x3f1/0x14c0 [ 23.142925][ C2] #1: ffffffff98190b00 (rcu_read_lock){....}-{1:3}, at: ip_local_deliver_finish+0x2ba/0x610 [ 23.142935][ C2] #2: ff11000008c2b818 (slock-AF_INET/1){+.-.}-{3:3}, at: tcp_v4_rcv+0x1a81/0x2b70 [ 23.142940][ C2] #3: ffffffff98190b00 (rcu_read_lock){....}-{1:3}, at: ovpn_tcp_data_ready+0x62/0x390 [ovpn] [ 23.142947][ C2] #4: ffffffff98179cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 23.142951][ C2] #5: ffffffff98179d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 23.142954][ C2] [ 23.142954][ C2] the shortest dependencies between 2nd lock and 1st lock: [ 23.142959][ C2] -> (fs_reclaim){+.+.}-{0:0} { [ 23.142962][ C2] HARDIRQ-ON-W at: [ 23.142963][ C2] __lock_acquire+0x388/0xc20 [ 23.142966][ C2] lock_acquire.part.0+0xd4/0x280 [ 23.142968][ C2] fs_reclaim_acquire+0xd5/0x120 [ 23.142971][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 23.142973][ C2] kthread_create_worker_on_node+0xea/0x210 [ 23.142976][ C2] workqueue_init+0x2a/0x680 [ 23.142980][ C2] kernel_init_freeable+0x2fe/0x630 [ 23.142983][ C2] kernel_init+0x21/0x150 [ 23.142986][ C2] ret_from_fork+0x474/0x6b0 [ 23.142989][ C2] ret_from_fork_asm+0x11/0x20 [ 23.142992][ C2] SOFTIRQ-ON-W at: [ 23.142993][ C2] __lock_acquire+0x388/0xc20 [ 23.142994][ C2] lock_acquire.part.0+0xd4/0x280 [ 23.142996][ C2] fs_reclaim_acquire+0xd5/0x120 [ 23.142997][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 23.142998][ C2] kthread_create_worker_on_node+0xea/0x210 [ 23.143000][ C2] workqueue_init+0x2a/0x680 [ 23.143001][ C2] kernel_init_freeable+0x2fe/0x630 [ 23.143003][ C2] kernel_init+0x21/0x150 [ 23.143004][ C2] ret_from_fork+0x474/0x6b0 [ 23.143005][ C2] ret_from_fork_asm+0x11/0x20 [ 23.143006][ C2] INITIAL USE at: [ 23.143007][ C2] __lock_acquire+0x388/0xc20 [ 23.143009][ C2] lock_acquire.part.0+0xd4/0x280 [ 23.143010][ C2] fs_reclaim_acquire+0xd5/0x120 [ 23.143011][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 23.143013][ C2] kthread_create_worker_on_node+0xea/0x210 [ 23.143014][ C2] workqueue_init+0x2a/0x680 [ 23.143015][ C2] kernel_init_freeable+0x2fe/0x630 [ 23.143017][ C2] kernel_init+0x21/0x150 [ 23.143018][ C2] ret_from_fork+0x474/0x6b0 [ 23.143019][ C2] ret_from_fork_asm+0x11/0x20 [ 23.143021][ C2] } [ 23.143021][ C2] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 23.143025][ C2] ... acquired at: [ 23.143026][ C2] __lock_acquire+0x518/0xc20 [ 23.143027][ C2] lock_acquire.part.0+0xd4/0x280 [ 23.143029][ C2] fs_reclaim_acquire+0xd5/0x120 [ 23.143030][ C2] __kmalloc_noprof+0xd3/0x760 [ 23.143031][ C2] alloc_buf.isra.0+0x4b/0x260 [ 23.143034][ C2] put_chars+0x1e1/0x2f0 [ 23.143036][ C2] hvc_console_print+0x292/0x780 [ 23.143038][ C2] console_emit_next_record+0x22f/0x4c0 [ 23.143040][ C2] console_flush_one_record+0x46f/0x710 [ 23.143042][ C2] console_unlock+0xee/0x1f0 [ 23.143043][ C2] vprintk_emit+0x37c/0x3e0 [ 23.143045][ C2] dev_vprintk_emit+0x27f/0x2c0 [ 23.143049][ C2] dev_printk_emit+0xb9/0xee [ 23.143050][ C2] _dev_info+0xe2/0x116 [ 23.143052][ C2] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 23.143055][ C2] cmos_do_probe+0x73b/0x98a [ 23.143056][ C2] platform_probe+0xfe/0x1f0 [ 23.143059][ C2] call_driver_probe+0x61/0x1c0 [ 23.143061][ C2] really_probe+0x199/0x760 [ 23.143063][ C2] __driver_probe_device+0x24f/0x440 [ 23.143064][ C2] driver_probe_device+0x4a/0xf0 [ 23.143066][ C2] __driver_attach+0x1b8/0x540 [ 23.143068][ C2] bus_for_each_dev+0x130/0x1e0 [ 23.143069][ C2] bus_add_driver+0x2c8/0x530 [ 23.143071][ C2] driver_register+0x1a3/0x390 [ 23.143072][ C2] __platform_driver_probe+0x13f/0x270 [ 23.143074][ C2] cmos_init+0x31/0x40 [ 23.143076][ C2] do_one_initcall+0x124/0x4f0 [ 23.143078][ C2] kernel_init_freeable+0x596/0x630 [ 23.143080][ C2] kernel_init+0x21/0x150 [ 23.143081][ C2] ret_from_fork+0x474/0x6b0 [ 23.143082][ C2] ret_from_fork_asm+0x11/0x20 [ 23.143084][ C2] [ 23.143084][ C2] -> (console_owner){..-.}-{0:0} { [ 23.143086][ C2] IN-SOFTIRQ-W at: [ 23.143086][ C2] __lock_acquire+0x388/0xc20 [ 23.143088][ C2] lock_acquire.part.0+0xd4/0x280 [ 23.143089][ C2] console_lock_spinning_enable+0x5c/0x60 [ 23.143091][ C2] console_emit_next_record+0x1d1/0x4c0 [ 23.143093][ C2] console_flush_one_record+0x46f/0x710 [ 23.143094][ C2] console_unlock+0xee/0x1f0 [ 23.143096][ C2] vprintk_emit+0x37c/0x3e0 [ 23.143097][ C2] _printk+0xc7/0x100 [ 23.143100][ C2] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 23.143104][ C2] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 23.143106][ C2] __strp_recv+0x20f/0x1c20 [ 23.143109][ C2] __tcp_read_sock+0x1c7/0x850 [ 23.143112][ C2] strp_read_sock+0x20f/0x2b0 [ 23.143114][ C2] strp_data_ready+0x18e/0x2c0 [ 23.143116][ C2] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 23.143118][ C2] tcp_rcv_established+0x1e1d/0x3910 [ 23.143120][ C2] tcp_v4_do_rcv+0x4f6/0xb90 [ 23.143122][ C2] tcp_v4_rcv+0x1caa/0x2b70 [ 23.143123][ C2] ip_protocol_deliver_rcu+0x82/0x350 [ 23.143125][ C2] ip_local_deliver_finish+0x36f/0x610 [ 23.143126][ C2] ip_local_deliver+0x184/0x4c0 [ 23.143128][ C2] ip_rcv+0xdc/0x3d0 [ 23.143129][ C2] __netif_receive_skb_one_core+0xfc/0x180 [ 23.143131][ C2] process_backlog+0x431/0x14c0 [ 23.143133][ C2] __napi_poll+0xa7/0x3b0 [ 23.143135][ C2] net_rx_action+0x513/0xf50 [ 23.143137][ C2] handle_softirqs+0x1d3/0x900 [ 23.143139][ C2] do_softirq+0xac/0xe0 [ 23.143140][ C2] __local_bh_enable_ip+0x118/0x150 [ 23.143142][ C2] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 23.143144][ C2] __sys_sendto+0x2aa/0x400 [ 23.143147][ C2] __x64_sys_sendto+0xe4/0x1f0 [ 23.143149][ C2] do_syscall_64+0xff/0x530 [ 23.143151][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 23.143153][ C2] INITIAL USE at: [ 23.143156][ C2] } [ 23.143157][ C2] ... key at: [] console_owner_dep_map+0x0/0x60 [ 23.143161][ C2] ... acquired at: [ 23.143161][ C2] mark_lock+0x1d7/0xa00 [ 23.143162][ C2] mark_usage+0x42/0x170 [ 23.143164][ C2] __lock_acquire+0x388/0xc20 [ 23.143165][ C2] lock_acquire.part.0+0xd4/0x280 [ 23.143167][ C2] console_lock_spinning_enable+0x5c/0x60 [ 23.143168][ C2] console_emit_next_record+0x1d1/0x4c0 [ 23.143170][ C2] console_flush_one_record+0x46f/0x710 [ 23.143171][ C2] console_unlock+0xee/0x1f0 [ 23.143173][ C2] vprintk_emit+0x37c/0x3e0 [ 23.143175][ C2] _printk+0xc7/0x100 [ 23.143176][ C2] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 23.143178][ C2] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 23.143181][ C2] __strp_recv+0x20f/0x1c20 [ 23.143182][ C2] __tcp_read_sock+0x1c7/0x850 [ 23.143184][ C2] strp_read_sock+0x20f/0x2b0 [ 23.143185][ C2] strp_data_ready+0x18e/0x2c0 [ 23.143187][ C2] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 23.143189][ C2] tcp_rcv_established+0x1e1d/0x3910 [ 23.143191][ C2] tcp_v4_do_rcv+0x4f6/0xb90 [ 23.143192][ C2] tcp_v4_rcv+0x1caa/0x2b70 [ 23.143194][ C2] ip_protocol_deliver_rcu+0x82/0x350 [ 23.143195][ C2] ip_local_deliver_finish+0x36f/0x610 [ 23.143197][ C2] ip_local_deliver+0x184/0x4c0 [ 23.143198][ C2] ip_rcv+0xdc/0x3d0 [ 23.143199][ C2] __netif_receive_skb_one_core+0xfc/0x180 [ 23.143201][ C2] process_backlog+0x431/0x14c0 [ 23.143203][ C2] __napi_poll+0xa7/0x3b0 [ 23.143205][ C2] net_rx_action+0x513/0xf50 [ 23.143206][ C2] handle_softirqs+0x1d3/0x900 [ 23.143208][ C2] do_softirq+0xac/0xe0 [ 23.143209][ C2] __local_bh_enable_ip+0x118/0x150 [ 23.143210][ C2] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 23.143212][ C2] __sys_sendto+0x2aa/0x400 [ 23.143214][ C2] __x64_sys_sendto+0xe4/0x1f0 [ 23.143215][ C2] do_syscall_64+0xff/0x530 [ 23.143217][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 23.143218][ C2] [ 23.143218][ C2] [ 23.143218][ C2] stack backtrace: [ 23.143221][ C2] CPU: 2 UID: 0 PID: 406 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 23.143224][ C2] Tainted: [W]=WARN [ 23.143225][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 23.143227][ C2] Call Trace: [ 23.143228][ C2] [ 23.143229][ C2] dump_stack_lvl+0x6f/0xa0 [ 23.143233][ C2] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 23.143236][ C2] mark_lock_irq+0x989/0x9c0 [ 23.143239][ C2] mark_lock+0x1d7/0xa00 [ 23.143241][ C2] mark_usage+0x42/0x170 [ 23.143242][ C2] __lock_acquire+0x388/0xc20 [ 23.143245][ C2] lock_acquire.part.0+0xd4/0x280 [ 23.143246][ C2] ? console_lock_spinning_enable+0x40/0x60 [ 23.143249][ C2] ? rcu_is_watching+0x16/0xd0 [ 23.143253][ C2] ? lock_acquire+0x13c/0x160 [ 23.143255][ C2] console_lock_spinning_enable+0x5c/0x60 [ 23.143257][ C2] ? console_lock_spinning_enable+0x40/0x60 [ 23.143258][ C2] console_emit_next_record+0x1d1/0x4c0 [ 23.143261][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 23.143262][ C2] ? console_flush_one_record+0x106/0x710 [ 23.143264][ C2] ? rcu_is_watching+0x16/0xd0 [ 23.143266][ C2] ? lock_acquire+0x13c/0x160 [ 23.143268][ C2] console_flush_one_record+0x46f/0x710 [ 23.143271][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 23.143273][ C2] ? __lock_acquire+0x518/0xc20 [ 23.143275][ C2] console_unlock+0xee/0x1f0 [ 23.143277][ C2] ? console_flush_one_record+0x710/0x710 [ 23.143279][ C2] ? rcu_is_watching+0x16/0xd0 [ 23.143281][ C2] ? lock_acquire+0x60/0x160 [ 23.143282][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 23.143284][ C2] ? vprintk_emit+0x320/0x3e0 [ 23.143286][ C2] vprintk_emit+0x37c/0x3e0 [ 23.143289][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 23.143291][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 23.143293][ C2] _printk+0xc7/0x100 [ 23.143295][ C2] ? snapshot_read.cold+0x21/0x21 [ 23.143297][ C2] ? ___ratelimit+0x4e7/0xa00 [ 23.143300][ C2] ? ovpn_netdev_write+0x730/0x730 [ovpn] [ 23.143303][ C2] ? idr_get_free+0x830/0x830 [ 23.143306][ C2] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 23.143309][ C2] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 23.143312][ C2] ? ovpn_tcp_write_space+0x2e0/0x2e0 [ovpn] [ 23.143314][ C2] ? __copy_skb_header+0xb7/0x510 [ 23.143317][ C2] ? ovpn_tcp_disconnect+0x10/0x10 [ovpn] [ 23.143320][ C2] ? sock_queue_err_skb+0xb0/0x680 [ 23.143322][ C2] __strp_recv+0x20f/0x1c20 [ 23.143325][ C2] __tcp_read_sock+0x1c7/0x850 [ 23.143327][ C2] ? strp_process+0xb0/0xb0 [ 23.143329][ C2] ? __tcp_transmit_skb+0x1b6e/0x3c10 [ 23.143331][ C2] ? tcp_cleanup_rbuf+0x1c0/0x1c0 [ 23.143333][ C2] ? mark_usage+0x61/0x170 [ 23.143335][ C2] strp_read_sock+0x20f/0x2b0 [ 23.143337][ C2] ? strp_stop+0x50/0x50 [ 23.143339][ C2] ? rcu_is_watching+0x16/0xd0 [ 23.143341][ C2] ? lock_acquire+0x13c/0x160 [ 23.143343][ C2] strp_data_ready+0x18e/0x2c0 [ 23.143345][ C2] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 23.143348][ C2] tcp_rcv_established+0x1e1d/0x3910 [ 23.143351][ C2] ? __tcp_check_space+0x600/0x600 [ 23.143353][ C2] ? tcp_v4_rcv+0x1a81/0x2b70 [ 23.143355][ C2] ? do_raw_spin_lock+0x131/0x280 [ 23.143357][ C2] tcp_v4_do_rcv+0x4f6/0xb90 [ 23.143359][ C2] tcp_v4_rcv+0x1caa/0x2b70 [ 23.143362][ C2] ? mark_usage+0x61/0x170 [ 23.143364][ C2] ? tcp_add_backlog+0x1e30/0x1e30 [ 23.143366][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 23.143368][ C2] ? ip_local_deliver_finish+0x2ba/0x610 [ 23.143370][ C2] ip_protocol_deliver_rcu+0x82/0x350 [ 23.143372][ C2] ? process_backlog+0x3f1/0x14c0 [ 23.143374][ C2] ip_local_deliver_finish+0x36f/0x610 [ 23.143376][ C2] ip_local_deliver+0x184/0x4c0 [ 23.143377][ C2] ? ip_local_deliver_finish+0x610/0x610 [ 23.143379][ C2] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 23.143382][ C2] ? process_backlog+0x3f1/0x14c0 [ 23.143384][ C2] ip_rcv+0xdc/0x3d0 [ 23.143385][ C2] ? ip_local_deliver+0x4c0/0x4c0 [ 23.143387][ C2] ? rcu_is_watching+0x16/0xd0 [ 23.143389][ C2] ? __update_load_avg_cfs_rq+0x36c/0x10c0 [ 23.143392][ C2] ? mark_usage+0x61/0x170 [ 23.143393][ C2] ? __lock_acquire+0x518/0xc20 [ 23.143395][ C2] ? trace_raw_output_rcu_invoke_kfree_bulk_callback+0x57/0x130 [ 23.143398][ C2] __netif_receive_skb_one_core+0xfc/0x180 [ 23.143400][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 23.143401][ C2] ? process_backlog+0x3f1/0x14c0 [ 23.143403][ C2] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 23.143405][ C2] ? rcu_is_watching+0x16/0xd0 [ 23.143408][ C2] process_backlog+0x431/0x14c0 [ 23.143411][ C2] __napi_poll+0xa7/0x3b0 [ 23.143413][ C2] net_rx_action+0x513/0xf50 [ 23.143416][ C2] ? __lock_acquire+0x518/0xc20 [ 23.143417][ C2] ? __napi_poll+0x3b0/0x3b0 [ 23.143421][ C2] ? ktime_get_update_offsets_now+0x2a8/0x490 [ 23.143424][ C2] ? rcu_is_watching+0x16/0xd0 [ 23.143426][ C2] handle_softirqs+0x1d3/0x900 [ 23.143428][ C2] ? _local_bh_enable+0xc0/0xc0 [ 23.143430][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 23.143432][ C2] ? rcu_is_watching+0x16/0xd0 [ 23.143434][ C2] do_softirq+0xac/0xe0 [ 23.143435][ C2] [ 23.143436][ C2] [ 23.143436][ C2] __local_bh_enable_ip+0x118/0x150 [ 23.143438][ C2] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 23.143441][ C2] ? ovpn_tcp_recvmsg+0x6d0/0x6d0 [ovpn] [ 23.143445][ C2] __sys_sendto+0x2aa/0x400 [ 23.143447][ C2] ? __ia32_sys_getpeername+0xd0/0xd0 [ 23.143453][ C2] ? fput_close_sync+0xde/0x1b0 [ 23.143456][ C2] ? alloc_file_clone+0xe0/0xe0 [ 23.143459][ C2] __x64_sys_sendto+0xe4/0x1f0 [ 23.143462][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 23.143465][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 23.143466][ C2] ? do_syscall_64+0xa6/0x530 [ 23.143468][ C2] do_syscall_64+0xff/0x530 [ 23.143469][ C2] ? exc_page_fault+0xee/0x100 [ 23.143471][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 23.143472][ C2] RIP: 0033:0x7fe120a4f54e [ 23.143476][ C2] 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 [ 23.143477][ C2] RSP: 002b:00007fffe0010810 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 23.143480][ C2] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007fe120a4f54e [ 23.143482][ C2] RDX: 00000000000003ea RSI: 00007fffe0010880 RDI: 0000000000000005 [ 23.143483][ C2] RBP: 00007fffe0010820 R08: 0000000000000000 R09: 0000000000000000 [ 23.143484][ C2] R10: 0000000000004000 R11: 0000000000000202 R12: 00007fffe00111a8 [ 23.143484][ C2] R13: 0000000000000008 R14: 00007fe120d3a000 R15: 000000000040bda8 [ 23.143487][ C2] [ 23.143491][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 23.143492][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 406, name: ovpn-cli [ 23.143494][ C2] preempt_count: 103, expected: 0 [ 23.143494][ C2] RCU nest depth: 3, expected: 0 [ 23.143495][ C2] INFO: lockdep is turned off. [ 23.143496][ C2] irq event stamp: 29605 [ 23.143497][ C2] hardirqs last enabled at (29604): [] __down_trylock_console_sem+0x86/0xa0 [ 23.143499][ C2] hardirqs last disabled at (29605): [] console_emit_next_record+0x3d4/0x4c0 [ 23.143501][ C2] softirqs last enabled at (29486): [] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 23.143504][ C2] softirqs last disabled at (29487): [] do_softirq+0xac/0xe0 [ 23.143506][ C2] Preemption disabled at: [ 23.143506][ C2] [<0000000000000000>] 0x0 [ 23.143509][ C2] CPU: 2 UID: 0 PID: 406 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 23.143511][ C2] Tainted: [W]=WARN [ 23.143511][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 23.143512][ C2] Call Trace: [ 23.143513][ C2] [ 23.143513][ C2] dump_stack_lvl+0x6f/0xa0 [ 23.143516][ C2] __might_resched.cold+0x1fe/0x2c1 [ 23.143519][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 23.143522][ C2] ? rcu_is_watching+0x16/0xd0 [ 23.143524][ C2] __kmalloc_noprof+0x443/0x760 [ 23.143526][ C2] ? __rwlock_init+0x150/0x150 [ 23.143527][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 23.143530][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 23.143531][ C2] alloc_buf.isra.0+0x4b/0x260 [ 23.143533][ C2] put_chars+0x1e1/0x2f0 [ 23.143535][ C2] ? __send_to_port+0x420/0x420 [ 23.143538][ C2] hvc_console_print+0x292/0x780 [ 23.143540][ C2] ? __lock_acquire+0x388/0xc20 [ 23.143542][ C2] ? hvc_write+0x3a0/0x3a0 [ 23.143544][ C2] ? rcu_is_watching+0x16/0xd0 [ 23.143546][ C2] ? lock_acquire+0x13c/0x160 [ 23.143548][ C2] console_emit_next_record+0x22f/0x4c0 [ 23.143550][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 23.143552][ C2] ? console_flush_one_record+0x106/0x710 [ 23.143554][ C2] ? rcu_is_watching+0x16/0xd0 [ 23.143556][ C2] ? lock_acquire+0x13c/0x160 [ 23.143558][ C2] console_flush_one_record+0x46f/0x710 [ 23.143560][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 23.143562][ C2] ? __lock_acquire+0x518/0xc20 [ 23.143564][ C2] console_unlock+0xee/0x1f0 [ 23.143566][ C2] ? console_flush_one_record+0x710/0x710 [ 23.143568][ C2] ? rcu_is_watching+0x16/0xd0 [ 23.143570][ C2] ? lock_acquire+0x60/0x160 [ 23.143572][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 23.143574][ C2] ? vprintk_emit+0x320/0x3e0 [ 23.143576][ C2] vprintk_emit+0x37c/0x3e0 [ 23.143578][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 23.143580][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 23.143582][ C2] _printk+0xc7/0x100 [ 23.143584][ C2] ? snapshot_read.cold+0x21/0x21 [ 23.143586][ C2] ? ___ratelimit+0x4e7/0xa00 [ 23.143588][ C2] ? ovpn_netdev_write+0x730/0x730 [ovpn] [ 23.143590][ C2] ? idr_get_free+0x830/0x830 [ 23.143593][ C2] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 23.143596][ C2] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 23.143598][ C2] ? ovpn_tcp_write_space+0x2e0/0x2e0 [ovpn] [ 23.143601][ C2] ? __copy_skb_header+0xb7/0x510 [ 23.143603][ C2] ? ovpn_tcp_disconnect+0x10/0x10 [ovpn] [ 23.143606][ C2] ? sock_queue_err_skb+0xb0/0x680 [ 23.143608][ C2] __strp_recv+0x20f/0x1c20 [ 23.143611][ C2] __tcp_read_sock+0x1c7/0x850 [ 23.143613][ C2] ? strp_process+0xb0/0xb0 [ 23.143615][ C2] ? __tcp_transmit_skb+0x1b6e/0x3c10 [ 23.143617][ C2] ? tcp_cleanup_rbuf+0x1c0/0x1c0 [ 23.143618][ C2] ? mark_usage+0x61/0x170 [ 23.143620][ C2] strp_read_sock+0x20f/0x2b0 [ 23.143623][ C2] ? strp_stop+0x50/0x50 [ 23.143625][ C2] ? rcu_is_watching+0x16/0xd0 [ 23.143627][ C2] ? lock_acquire+0x13c/0x160 [ 23.143629][ C2] strp_data_ready+0x18e/0x2c0 [ 23.143631][ C2] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 23.143634][ C2] tcp_rcv_established+0x1e1d/0x3910 [ 23.143637][ C2] ? __tcp_check_space+0x600/0x600 [ 23.143639][ C2] ? tcp_v4_rcv+0x1a81/0x2b70 [ 23.143640][ C2] ? do_raw_spin_lock+0x131/0x280 [ 23.143643][ C2] tcp_v4_do_rcv+0x4f6/0xb90 [ 23.143645][ C2] tcp_v4_rcv+0x1caa/0x2b70 [ 23.143648][ C2] ? mark_usage+0x61/0x170 [ 23.143649][ C2] ? tcp_add_backlog+0x1e30/0x1e30 [ 23.143652][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 23.143653][ C2] ? ip_local_deliver_finish+0x2ba/0x610 [ 23.143655][ C2] ip_protocol_deliver_rcu+0x82/0x350 [ 23.143657][ C2] ? process_backlog+0x3f1/0x14c0 [ 23.143659][ C2] ip_local_deliver_finish+0x36f/0x610 [ 23.143661][ C2] ip_local_deliver+0x184/0x4c0 [ 23.143663][ C2] ? ip_local_deliver_finish+0x610/0x610 [ 23.143665][ C2] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 23.143667][ C2] ? process_backlog+0x3f1/0x14c0 [ 23.143669][ C2] ip_rcv+0xdc/0x3d0 [ 23.143671][ C2] ? ip_local_deliver+0x4c0/0x4c0 [ 23.143672][ C2] ? rcu_is_watching+0x16/0xd0 [ 23.143674][ C2] ? __update_load_avg_cfs_rq+0x36c/0x10c0 [ 23.143676][ C2] ? mark_usage+0x61/0x170 [ 23.143678][ C2] ? __lock_acquire+0x518/0xc20 [ 23.143679][ C2] ? trace_raw_output_rcu_invoke_kfree_bulk_callback+0x57/0x130 [ 23.143681][ C2] __netif_receive_skb_one_core+0xfc/0x180 [ 23.143683][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 23.143685][ C2] ? process_backlog+0x3f1/0x14c0 [ 23.143687][ C2] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 23.143689][ C2] ? rcu_is_watching+0x16/0xd0 [ 23.143691][ C2] process_backlog+0x431/0x14c0 [ 23.143694][ C2] __napi_poll+0xa7/0x3b0 [ 23.143696][ C2] net_rx_action+0x513/0xf50 [ 23.143699][ C2] ? __lock_acquire+0x518/0xc20 [ 23.143700][ C2] ? __napi_poll+0x3b0/0x3b0 [ 23.143704][ C2] ? ktime_get_update_offsets_now+0x2a8/0x490 [ 23.143706][ C2] ? rcu_is_watching+0x16/0xd0 [ 23.143708][ C2] handle_softirqs+0x1d3/0x900 [ 23.143710][ C2] ? _local_bh_enable+0xc0/0xc0 [ 23.143712][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 23.143713][ C2] ? rcu_is_watching+0x16/0xd0 [ 23.143715][ C2] do_softirq+0xac/0xe0 [ 23.143717][ C2] [ 23.143717][ C2] [ 23.143718][ C2] __local_bh_enable_ip+0x118/0x150 [ 23.143720][ C2] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 23.143723][ C2] ? ovpn_tcp_recvmsg+0x6d0/0x6d0 [ovpn] [ 23.143726][ C2] __sys_sendto+0x2aa/0x400 [ 23.143728][ C2] ? __ia32_sys_getpeername+0xd0/0xd0 [ 23.143732][ C2] ? fput_close_sync+0xde/0x1b0 [ 23.143734][ C2] ? alloc_file_clone+0xe0/0xe0 [ 23.143735][ C2] __x64_sys_sendto+0xe4/0x1f0 [ 23.143737][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 23.143739][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 23.143740][ C2] ? do_syscall_64+0xa6/0x530 [ 23.143742][ C2] do_syscall_64+0xff/0x530 [ 23.143743][ C2] ? exc_page_fault+0xee/0x100 [ 23.143745][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 23.143746][ C2] RIP: 0033:0x7fe120a4f54e [ 23.143748][ C2] 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 [ 23.143749][ C2] RSP: 002b:00007fffe0010810 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 23.143750][ C2] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007fe120a4f54e [ 23.143751][ C2] RDX: 00000000000003ea RSI: 00007fffe0010880 RDI: 0000000000000005 [ 23.143752][ C2] RBP: 00007fffe0010820 R08: 0000000000000000 R09: 0000000000000000 [ 23.143752][ C2] R10: 0000000000004000 R11: 0000000000000202 R12: 00007fffe00111a8 [ 23.143753][ C2] R13: 0000000000000008 R14: 00007fe120d3a000 R15: 000000000040bda8 [ 23.143755][ C2] [ 23.335132][ C2] tun0: no available key for peer 3, key-id: 0 [ 23.401481][ T12] tun0: no available key for peer 4, key-id: 0 [ 32.061597][ T623] iperf3 (623) used greatest stack depth: 23128 bytes left [ 32.061617][ T623] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 32.061619][ T623] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 623, name: iperf3 [ 32.061621][ T623] preempt_count: 2, expected: 0 [ 32.061622][ T623] RCU nest depth: 0, expected: 0 [ 32.061623][ T623] INFO: lockdep is turned off. [ 32.061624][ T623] irq event stamp: 0 [ 32.061625][ T623] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 32.061630][ T623] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 32.061637][ T623] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 32.061638][ T623] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 32.061640][ T623] Preemption disabled at: [ 32.061641][ T623] [<0000000000000000>] 0x0 [ 32.061647][ T623] CPU: 0 UID: 0 PID: 623 Comm: iperf3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 32.061651][ T623] Tainted: [W]=WARN [ 32.061652][ T623] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 32.061654][ T623] Call Trace: [ 32.061655][ T623] [ 32.061656][ T623] dump_stack_lvl+0x6f/0xa0 [ 32.061662][ T623] __might_resched.cold+0x1fe/0x2c1 [ 32.061666][ T623] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 32.061670][ T623] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 32.061673][ T623] ? rcu_is_watching+0x16/0xd0 [ 32.061677][ T623] __kmalloc_noprof+0x443/0x760 [ 32.061681][ T623] ? __rwlock_init+0x150/0x150 [ 32.061683][ T623] ? alloc_buf.isra.0+0x4b/0x260 [ 32.061687][ T623] ? do_raw_spin_unlock+0x59/0x250 [ 32.061689][ T623] alloc_buf.isra.0+0x4b/0x260 [ 32.061691][ T623] put_chars+0x1e1/0x2f0 [ 32.061693][ T623] ? prb_final_commit+0x50/0x50 [ 32.061695][ T623] ? __send_to_port+0x420/0x420 [ 32.061697][ T623] ? printk_get_next_message+0x240/0x650 [ 32.061700][ T623] hvc_console_print+0x292/0x780 [ 32.061705][ T623] ? hvc_write+0x3a0/0x3a0 [ 32.061706][ T623] ? do_raw_spin_lock+0x131/0x280 [ 32.061708][ T623] ? vsnprintf+0x668/0x1700 [ 32.061711][ T623] ? __rwlock_init+0x150/0x150 [ 32.061713][ T623] ? rcu_is_watching+0x16/0xd0 [ 32.061715][ T623] ? lock_acquire+0x13c/0x160 [ 32.061717][ T623] console_emit_next_record+0x22f/0x4c0 [ 32.061720][ T623] ? devkmsg_read+0x4b0/0x4b0 [ 32.061722][ T623] ? rcu_is_watching+0x16/0xd0 [ 32.061724][ T623] ? rcu_is_watching+0x16/0xd0 [ 32.061726][ T623] ? rcu_is_watching+0x16/0xd0 [ 32.061728][ T623] ? lock_acquire+0x13c/0x160 [ 32.061730][ T623] ? console_flush_one_record+0x111/0x710 [ 32.061732][ T623] console_flush_one_record+0x46f/0x710 [ 32.061734][ T623] ? console_emit_next_record+0x4c0/0x4c0 [ 32.061737][ T623] console_unlock+0xee/0x1f0 [ 32.061739][ T623] ? lock_acquire+0x13c/0x160 [ 32.061741][ T623] ? console_flush_one_record+0x710/0x710 [ 32.061743][ T623] ? rcu_is_watching+0x16/0xd0 [ 32.061744][ T623] ? lock_release+0x184/0x1f0 [ 32.061746][ T623] ? lock_acquire+0x60/0x160 [ 32.061747][ T623] ? __rcu_read_lock+0x30/0x70 [ 32.061750][ T623] ? __down_trylock_console_sem+0x5e/0xa0 [ 32.061752][ T623] ? vprintk_emit+0x320/0x3e0 [ 32.061755][ T623] vprintk_emit+0x37c/0x3e0 [ 32.061758][ T623] ? wake_up_klogd_work_func+0x90/0x90 [ 32.061762][ T623] _printk+0xc7/0x100 [ 32.061766][ T623] ? snapshot_read.cold+0x21/0x21 [ 32.061768][ T623] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 32.061771][ T623] ? do_raw_spin_lock+0x131/0x280 [ 32.061773][ T623] ? __rwlock_init+0x150/0x150 [ 32.061775][ T623] ? do_raw_spin_lock+0x131/0x280 [ 32.061777][ T623] do_exit.cold+0x82/0x9c [ 32.061780][ T623] ? exit_notify+0x890/0x890 [ 32.061783][ T623] __x64_sys_exit+0x42/0x50 [ 32.061784][ T623] x64_sys_call+0x156c/0x1570 [ 32.061787][ T623] do_syscall_64+0xff/0x530 [ 32.061790][ T623] ? exc_page_fault+0xee/0x100 [ 32.061792][ T623] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 32.061794][ T623] RIP: 0033:0x7ff6a03d7c49 [ 32.061796][ T623] Code: Unable to access opcode bytes at 0x7ff6a03d7c1f. [ 32.061797][ T623] RSP: 002b:00007ff69fb96e60 EFLAGS: 00000246 ORIG_RAX: 000000000000003c [ 32.061801][ T623] RAX: ffffffffffffffda RBX: 00007ff69fb976c0 RCX: 00007ff6a03d7c49 [ 32.061802][ T623] RDX: 0000000000000000 RSI: 0000000000801000 RDI: 0000000000000000 [ 32.061804][ T623] RBP: 00007ff69fb96f70 R08: 0000000000000001 R09: 00007ff69fb976c0 [ 32.061805][ T623] R10: 0000000000000008 R11: 0000000000000246 R12: 00007ff69f397000 [ 32.061806][ T623] R13: 00007ffc75358bf0 R14: 0000000000000002 R15: 00007ffc75358cf7 [ 32.061808][ T623] [ 33.316142][ T717] tun0: deleting peer with id 1, reason 1 [ 33.316166][ T717] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 33.316168][ T717] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 717, name: ovpn-cli [ 33.316170][ T717] preempt_count: 202, expected: 0 [ 33.316171][ T717] RCU nest depth: 0, expected: 0 [ 33.316172][ T717] INFO: lockdep is turned off. [ 33.316173][ T717] irq event stamp: 0 [ 33.316174][ T717] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 33.316178][ T717] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 33.316184][ T717] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 33.316186][ T717] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 33.316188][ T717] Preemption disabled at: [ 33.316188][ T717] [<0000000000000000>] 0x0 [ 33.316193][ T717] CPU: 2 UID: 0 PID: 717 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 33.316197][ T717] Tainted: [W]=WARN [ 33.316198][ T717] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 33.316200][ T717] Call Trace: [ 33.316201][ T717] [ 33.316203][ T717] dump_stack_lvl+0x6f/0xa0 [ 33.316208][ T717] __might_resched.cold+0x1fe/0x2c1 [ 33.316212][ T717] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 33.316216][ T717] ? rcu_is_watching+0x16/0xd0 [ 33.316220][ T717] __kmalloc_noprof+0x443/0x760 [ 33.316224][ T717] ? __rwlock_init+0x150/0x150 [ 33.316227][ T717] ? alloc_buf.isra.0+0x4b/0x260 [ 33.316231][ T717] ? do_raw_spin_unlock+0x59/0x250 [ 33.316233][ T717] alloc_buf.isra.0+0x4b/0x260 [ 33.316235][ T717] put_chars+0x1e1/0x2f0 [ 33.316237][ T717] ? __send_to_port+0x420/0x420 [ 33.316239][ T717] ? printk_get_next_message+0x240/0x650 [ 33.316242][ T717] ? lock_release+0xf1/0x1f0 [ 33.316244][ T717] hvc_console_print+0x292/0x780 [ 33.316248][ T717] ? clockevents_program_event+0x307/0x7e0 [ 33.316251][ T717] ? hvc_write+0x3a0/0x3a0 [ 33.316253][ T717] ? __rwlock_init+0x150/0x150 [ 33.316254][ T717] ? rcu_is_watching+0x16/0xd0 [ 33.316256][ T717] ? lock_acquire+0x13c/0x160 [ 33.316258][ T717] console_emit_next_record+0x22f/0x4c0 [ 33.316261][ T717] ? devkmsg_read+0x4b0/0x4b0 [ 33.316264][ T717] console_flush_one_record+0x46f/0x710 [ 33.316267][ T717] ? console_emit_next_record+0x4c0/0x4c0 [ 33.316269][ T717] console_unlock+0xee/0x1f0 [ 33.316271][ T717] ? lock_acquire+0x13c/0x160 [ 33.316273][ T717] ? console_flush_one_record+0x710/0x710 [ 33.316275][ T717] ? rcu_is_watching+0x16/0xd0 [ 33.316276][ T717] ? lock_release+0x184/0x1f0 [ 33.316278][ T717] ? lock_acquire+0x60/0x160 [ 33.316279][ T717] ? __rcu_read_lock+0x30/0x70 [ 33.316281][ T717] ? __down_trylock_console_sem+0x5e/0xa0 [ 33.316283][ T717] ? vprintk_emit+0x320/0x3e0 [ 33.316285][ T717] vprintk_emit+0x37c/0x3e0 [ 33.316288][ T717] ? wake_up_klogd_work_func+0x90/0x90 [ 33.316290][ T717] ? kernel_text_address+0x149/0x170 [ 33.316292][ T717] ? __kernel_text_address+0x12/0x30 [ 33.316293][ T717] ? write_profile+0xf0/0xf0 [ 33.316295][ T717] ? unwind_get_return_address+0x67/0xd0 [ 33.316298][ T717] _printk+0xc7/0x100 [ 33.316301][ T717] ? snapshot_read.cold+0x21/0x21 [ 33.316303][ T717] ? netdev_name+0x43/0x60 [ 33.316306][ T717] ? __netdev_printk+0x17f/0x1d0 [ 33.316308][ T717] netdev_info+0xe2/0x116 [ 33.316310][ T717] ? netdev_notice+0x120/0x120 [ 33.316311][ T717] ? ovpn_nl_pre_doit+0x44/0x90 [ovpn] [ 33.316317][ T717] ? __module_address+0x36/0x330 [ 33.316320][ T717] ? lock_acquire+0x13c/0x160 [ 33.316321][ T717] ? rcu_is_watching+0x16/0xd0 [ 33.316323][ T717] ? lock_release+0x184/0x1f0 [ 33.316325][ T717] ? ovpn_peer_get_by_id+0x38a/0x7a0 [ovpn] [ 33.316329][ T717] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 33.316333][ T717] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 33.316335][ T717] ? lock_acquire+0x13c/0x160 [ 33.316337][ T717] ? rcu_is_watching+0x16/0xd0 [ 33.316339][ T717] ? lock_release+0x184/0x1f0 [ 33.316341][ T717] ovpn_peer_remove+0x394/0x640 [ovpn] [ 33.316344][ T717] ? do_raw_spin_lock+0x131/0x280 [ 33.316346][ T717] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 33.316349][ T717] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 33.316353][ T717] ? ovpn_peer_add+0x330/0x330 [ovpn] [ 33.316356][ T717] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 33.316359][ T717] ? trace_hardirqs_on+0x36/0x40 [ 33.316362][ T717] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 33.316364][ T717] ? ref_tracker_alloc+0x28d/0x430 [ 33.316369][ T717] ? lock_release+0x184/0x1f0 [ 33.316371][ T717] ? ovpn_get_dev_from_attrs+0x17a/0x660 [ovpn] [ 33.316374][ T717] genl_family_rcv_msg_doit+0x206/0x300 [ 33.316379][ T717] ? genl_family_rcv_msg_attrs_parse.isra.0+0x330/0x330 [ 33.316381][ T717] ? rcu_is_watching+0x16/0xd0 [ 33.316383][ T717] ? rcu_is_watching+0x16/0xd0 [ 33.316385][ T717] ? cap_capable+0x1d7/0x3d0 [ 33.316389][ T717] ? write_profile+0xf0/0xf0 [ 33.316390][ T717] ? unwind_get_return_address+0x67/0xd0 [ 33.316392][ T717] genl_family_rcv_msg+0x3a4/0x640 [ 33.316394][ T717] ? genl_family_rcv_msg_dumpit+0x340/0x340 [ 33.316396][ T717] ? ovpn_nl_send_peer+0x1300/0x1300 [ovpn] [ 33.316399][ T717] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 33.316401][ T717] ? ovpn_nl_pre_doit+0x90/0x90 [ovpn] [ 33.316403][ T717] ? filter_irq_stacks+0xd0/0xd0 [ 33.316405][ T717] ? stack_depot_save_flags+0x1bc/0x790 [ 33.316407][ T717] genl_rcv_msg+0xbb/0x160 [ 33.316410][ T717] netlink_rcv_skb+0x14e/0x3a0 [ 33.316412][ T717] ? genl_family_rcv_msg+0x640/0x640 [ 33.316414][ T717] ? netlink_ack+0xcf0/0xcf0 [ 33.316417][ T717] ? lock_acquire+0x13c/0x160 [ 33.316418][ T717] ? rcu_is_watching+0x16/0xd0 [ 33.316420][ T717] ? lock_release+0x184/0x1f0 [ 33.316422][ T717] genl_rcv+0x28/0x40 [ 33.316424][ T717] netlink_unicast+0x486/0x750 [ 33.316426][ T717] ? netlink_attachskb+0x810/0x810 [ 33.316428][ T717] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 33.316430][ T717] ? trace_hardirqs_on+0x36/0x40 [ 33.316431][ T717] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 33.316434][ T717] netlink_sendmsg+0x735/0xc60 [ 33.316437][ T717] ? netlink_unicast+0x750/0x750 [ 33.316439][ T717] ? rcu_is_watching+0x16/0xd0 [ 33.316441][ T717] ? lock_release+0x184/0x1f0 [ 33.316443][ T717] ____sys_sendmsg+0x415/0x880 [ 33.316446][ T717] ? copy_msghdr_from_user+0x279/0x420 [ 33.316448][ T717] ? get_timestamp.constprop.0+0x390/0x390 [ 33.316450][ T717] ? move_addr_to_kernel+0x40/0x40 [ 33.316453][ T717] ___sys_sendmsg+0x14e/0x1d0 [ 33.316455][ T717] ? copy_msghdr_from_user+0x420/0x420 [ 33.316457][ T717] ? kfree+0x22/0x590 [ 33.316461][ T717] __sys_sendmsg+0x12c/0x1d0 [ 33.316464][ T717] ? __sys_sendmsg_sock+0x20/0x20 [ 33.316466][ T717] ? rcu_is_watching+0x16/0xd0 [ 33.316468][ T717] ? rcu_is_watching+0x16/0xd0 [ 33.316470][ T717] do_syscall_64+0xff/0x530 [ 33.316473][ T717] ? exc_page_fault+0xee/0x100 [ 33.316475][ T717] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 33.316477][ T717] RIP: 0033:0x7fa8b851b54e [ 33.316479][ T717] 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 [ 33.316481][ T717] RSP: 002b:00007ffcedcdf740 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 33.316485][ T717] RAX: ffffffffffffffda RBX: 0000000035c2c130 RCX: 00007fa8b851b54e [ 33.316486][ T717] RDX: 0000000000000000 RSI: 00007ffcedcdf7e0 RDI: 0000000000000005 [ 33.316487][ T717] RBP: 00007ffcedcdf750 R08: 0000000000000000 R09: 0000000000000000 [ 33.316488][ T717] R10: 0000000000000000 R11: 0000000000000202 R12: 0000000035c2c200 [ 33.316489][ T717] R13: 00007ffcedcdf7e0 R14: 0000000035c2d260 R15: 000000000040bda8 [ 33.316492][ T717] [ 33.400825][ T721] tun1: deleting peer with id 10, reason 1 [ 35.995347][ T769] tun0: deleting peer with id 2, reason 1 [ 35.995366][ T769] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 35.995368][ T769] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 769, name: ovpn-cli [ 35.995370][ T769] preempt_count: 202, expected: 0 [ 35.995371][ T769] RCU nest depth: 0, expected: 0 [ 35.995372][ T769] INFO: lockdep is turned off. [ 35.995373][ T769] irq event stamp: 0 [ 35.995374][ T769] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 35.995378][ T769] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 35.995385][ T769] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 35.995386][ T769] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 35.995388][ T769] Preemption disabled at: [ 35.995389][ T769] [<0000000000000000>] 0x0 [ 35.995394][ T769] CPU: 2 UID: 0 PID: 769 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 35.995398][ T769] Tainted: [W]=WARN [ 35.995399][ T769] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 35.995400][ T769] Call Trace: [ 35.995402][ T769] [ 35.995403][ T769] dump_stack_lvl+0x6f/0xa0 [ 35.995409][ T769] __might_resched.cold+0x1fe/0x2c1 [ 35.995413][ T769] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 35.995416][ T769] ? rcu_is_watching+0x16/0xd0 [ 35.995421][ T769] __kmalloc_noprof+0x443/0x760 [ 35.995424][ T769] ? __rwlock_init+0x150/0x150 [ 35.995427][ T769] ? alloc_buf.isra.0+0x4b/0x260 [ 35.995431][ T769] ? do_raw_spin_unlock+0x59/0x250 [ 35.995433][ T769] alloc_buf.isra.0+0x4b/0x260 [ 35.995436][ T769] put_chars+0x1e1/0x2f0 [ 35.995438][ T769] ? __send_to_port+0x420/0x420 [ 35.995440][ T769] ? printk_get_next_message+0x240/0x650 [ 35.995443][ T769] hvc_console_print+0x292/0x780 [ 35.995447][ T769] ? hvc_write+0x3a0/0x3a0 [ 35.995449][ T769] ? __rwlock_init+0x150/0x150 [ 35.995450][ T769] ? rcu_is_watching+0x16/0xd0 [ 35.995452][ T769] ? lock_acquire+0x13c/0x160 [ 35.995455][ T769] console_emit_next_record+0x22f/0x4c0 [ 35.995457][ T769] ? devkmsg_read+0x4b0/0x4b0 [ 35.995459][ T769] ? rcu_is_watching+0x16/0xd0 [ 35.995461][ T769] ? rcu_is_watching+0x16/0xd0 [ 35.995463][ T769] ? rcu_is_watching+0x16/0xd0 [ 35.995464][ T769] ? lock_acquire+0x13c/0x160 [ 35.995466][ T769] ? console_flush_one_record+0x111/0x710 [ 35.995468][ T769] console_flush_one_record+0x46f/0x710 [ 35.995470][ T769] ? console_emit_next_record+0x4c0/0x4c0 [ 35.995473][ T769] console_unlock+0xee/0x1f0 [ 35.995475][ T769] ? lock_acquire+0x13c/0x160 [ 35.995477][ T769] ? console_flush_one_record+0x710/0x710 [ 35.995478][ T769] ? rcu_is_watching+0x16/0xd0 [ 35.995480][ T769] ? lock_release+0x184/0x1f0 [ 35.995482][ T769] ? lock_acquire+0x60/0x160 [ 35.995483][ T769] ? __rcu_read_lock+0x30/0x70 [ 35.995485][ T769] ? __down_trylock_console_sem+0x5e/0xa0 [ 35.995487][ T769] ? vprintk_emit+0x320/0x3e0 [ 35.995489][ T769] vprintk_emit+0x37c/0x3e0 [ 35.995492][ T769] ? wake_up_klogd_work_func+0x90/0x90 [ 35.995493][ T769] ? kernel_text_address+0x149/0x170 [ 35.995496][ T769] ? __kernel_text_address+0x12/0x30 [ 35.995497][ T769] ? write_profile+0xf0/0xf0 [ 35.995500][ T769] ? unwind_get_return_address+0x67/0xd0 [ 35.995502][ T769] _printk+0xc7/0x100 [ 35.995505][ T769] ? snapshot_read.cold+0x21/0x21 [ 35.995508][ T769] ? netdev_name+0x43/0x60 [ 35.995510][ T769] ? __netdev_printk+0x17f/0x1d0 [ 35.995512][ T769] netdev_info+0xe2/0x116 [ 35.995514][ T769] ? netdev_notice+0x120/0x120 [ 35.995515][ T769] ? ovpn_nl_pre_doit+0x44/0x90 [ovpn] [ 35.995521][ T769] ? __module_address+0x36/0x330 [ 35.995524][ T769] ? lock_acquire+0x13c/0x160 [ 35.995526][ T769] ? rcu_is_watching+0x16/0xd0 [ 35.995528][ T769] ? lock_release+0x184/0x1f0 [ 35.995530][ T769] ? ovpn_peer_get_by_id+0x38a/0x7a0 [ovpn] [ 35.995533][ T769] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 35.995537][ T769] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 35.995540][ T769] ? lock_acquire+0x13c/0x160 [ 35.995542][ T769] ? rcu_is_watching+0x16/0xd0 [ 35.995543][ T769] ? lock_release+0x184/0x1f0 [ 35.995546][ T769] ovpn_peer_remove+0x394/0x640 [ovpn] [ 35.995548][ T769] ? do_raw_spin_lock+0x131/0x280 [ 35.995550][ T769] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 35.995554][ T769] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 35.995557][ T769] ? ovpn_peer_add+0x330/0x330 [ovpn] [ 35.995561][ T769] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 35.995564][ T769] ? trace_hardirqs_on+0x36/0x40 [ 35.995566][ T769] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 35.995569][ T769] ? ref_tracker_alloc+0x28d/0x430 [ 35.995574][ T769] ? lock_release+0x184/0x1f0 [ 35.995576][ T769] ? ovpn_get_dev_from_attrs+0x17a/0x660 [ovpn] [ 35.995579][ T769] genl_family_rcv_msg_doit+0x206/0x300 [ 35.995583][ T769] ? genl_family_rcv_msg_attrs_parse.isra.0+0x330/0x330 [ 35.995585][ T769] ? rcu_is_watching+0x16/0xd0 [ 35.995588][ T769] ? rcu_is_watching+0x16/0xd0 [ 35.995590][ T769] ? cap_capable+0x1d7/0x3d0 [ 35.995594][ T769] ? write_profile+0xf0/0xf0 [ 35.995595][ T769] ? unwind_get_return_address+0x67/0xd0 [ 35.995597][ T769] genl_family_rcv_msg+0x3a4/0x640 [ 35.995599][ T769] ? genl_family_rcv_msg_dumpit+0x340/0x340 [ 35.995601][ T769] ? ovpn_nl_send_peer+0x1300/0x1300 [ovpn] [ 35.995604][ T769] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 35.995606][ T769] ? ovpn_nl_pre_doit+0x90/0x90 [ovpn] [ 35.995609][ T769] ? filter_irq_stacks+0xd0/0xd0 [ 35.995610][ T769] ? stack_depot_save_flags+0x1bc/0x790 [ 35.995613][ T769] genl_rcv_msg+0xbb/0x160 [ 35.995615][ T769] netlink_rcv_skb+0x14e/0x3a0 [ 35.995617][ T769] ? genl_family_rcv_msg+0x640/0x640 [ 35.995619][ T769] ? netlink_ack+0xcf0/0xcf0 [ 35.995622][ T769] ? lock_acquire+0x13c/0x160 [ 35.995624][ T769] ? rcu_is_watching+0x16/0xd0 [ 35.995625][ T769] ? lock_release+0x184/0x1f0 [ 35.995627][ T769] genl_rcv+0x28/0x40 [ 35.995629][ T769] netlink_unicast+0x486/0x750 [ 35.995632][ T769] ? netlink_attachskb+0x810/0x810 [ 35.995633][ T769] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 35.995635][ T769] ? trace_hardirqs_on+0x36/0x40 [ 35.995636][ T769] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 35.995640][ T769] netlink_sendmsg+0x735/0xc60 [ 35.995642][ T769] ? netlink_unicast+0x750/0x750 [ 35.995644][ T769] ? rcu_is_watching+0x16/0xd0 [ 35.995646][ T769] ? lock_release+0x184/0x1f0 [ 35.995648][ T769] ____sys_sendmsg+0x415/0x880 [ 35.995652][ T769] ? copy_msghdr_from_user+0x279/0x420 [ 35.995654][ T769] ? get_timestamp.constprop.0+0x390/0x390 [ 35.995655][ T769] ? move_addr_to_kernel+0x40/0x40 [ 35.995658][ T769] ___sys_sendmsg+0x14e/0x1d0 [ 35.995660][ T769] ? copy_msghdr_from_user+0x420/0x420 [ 35.995662][ T769] ? kfree+0x22/0x590 [ 35.995667][ T769] __sys_sendmsg+0x12c/0x1d0 [ 35.995669][ T769] ? __sys_sendmsg_sock+0x20/0x20 [ 35.995672][ T769] ? rcu_is_watching+0x16/0xd0 [ 35.995674][ T769] ? rcu_is_watching+0x16/0xd0 [ 35.995676][ T769] do_syscall_64+0xff/0x530 [ 35.995679][ T769] ? exc_page_fault+0xee/0x100 [ 35.995681][ T769] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 35.995683][ T769] RIP: 0033:0x7f44abb6a54e [ 35.995685][ T769] 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.995686][ T769] RSP: 002b:00007ffc74dbba90 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 35.995690][ T769] RAX: ffffffffffffffda RBX: 0000000038c4f130 RCX: 00007f44abb6a54e [ 35.995692][ T769] RDX: 0000000000000000 RSI: 00007ffc74dbbb30 RDI: 0000000000000005 [ 35.995693][ T769] RBP: 00007ffc74dbbaa0 R08: 0000000000000000 R09: 0000000000000000 [ 35.995693][ T769] R10: 0000000000000000 R11: 0000000000000202 R12: 0000000038c4f200 [ 35.995694][ T769] R13: 00007ffc74dbbb30 R14: 0000000038c50260 R15: 000000000040bda8 [ 35.995697][ T769] [ 36.077537][ T773] tun2: deleting peer with id 11, reason 1 [ 41.782190][ T64] tun0: deleting peer with id 4, reason 2 [ 41.782214][ T64] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 41.782217][ T64] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 64, name: kworker/2:2 [ 41.782218][ T64] preempt_count: 202, expected: 0 [ 41.782220][ T64] RCU nest depth: 0, expected: 0 [ 41.782220][ T64] INFO: lockdep is turned off. [ 41.782222][ T64] irq event stamp: 12744 [ 41.782223][ T64] hardirqs last enabled at (12743): [] _raw_spin_unlock_irq+0x28/0x50 [ 41.782231][ T64] hardirqs last disabled at (12744): [] __schedule+0x1246/0x20e0 [ 41.782234][ T64] softirqs last enabled at (12406): [] handle_softirqs+0x67c/0x900 [ 41.782238][ T64] softirqs last disabled at (12363): [] do_softirq+0xac/0xe0 [ 41.782240][ T64] Preemption disabled at: [ 41.782241][ T64] [<0000000000000000>] 0x0 [ 41.782249][ T64] CPU: 2 UID: 0 PID: 64 Comm: kworker/2:2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 41.782253][ T64] Tainted: [W]=WARN [ 41.782254][ T64] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 41.782256][ T64] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 41.782266][ T64] Call Trace: [ 41.782268][ T64] [ 41.782270][ T64] dump_stack_lvl+0x6f/0xa0 [ 41.782276][ T64] __might_resched.cold+0x1fe/0x2c1 [ 41.782280][ T64] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 41.782283][ T64] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 41.782286][ T64] ? rcu_is_watching+0x16/0xd0 [ 41.782290][ T64] __kmalloc_noprof+0x443/0x760 [ 41.782294][ T64] ? __rwlock_init+0x150/0x150 [ 41.782297][ T64] ? alloc_buf.isra.0+0x4b/0x260 [ 41.782301][ T64] ? do_raw_spin_unlock+0x59/0x250 [ 41.782303][ T64] alloc_buf.isra.0+0x4b/0x260 [ 41.782305][ T64] put_chars+0x1e1/0x2f0 [ 41.782307][ T64] ? prb_final_commit+0x50/0x50 [ 41.782309][ T64] ? __send_to_port+0x420/0x420 [ 41.782310][ T64] ? printk_get_next_message+0x240/0x650 [ 41.782314][ T64] hvc_console_print+0x292/0x780 [ 41.782318][ T64] ? hvc_write+0x3a0/0x3a0 [ 41.782320][ T64] ? do_raw_spin_lock+0x131/0x280 [ 41.782321][ T64] ? vsnprintf+0x527/0x1700 [ 41.782323][ T64] ? __rwlock_init+0x150/0x150 [ 41.782325][ T64] ? rcu_is_watching+0x16/0xd0 [ 41.782327][ T64] ? lock_acquire+0x13c/0x160 [ 41.782329][ T64] console_emit_next_record+0x22f/0x4c0 [ 41.782332][ T64] ? devkmsg_read+0x4b0/0x4b0 [ 41.782334][ T64] ? rcu_is_watching+0x16/0xd0 [ 41.782336][ T64] ? rcu_is_watching+0x16/0xd0 [ 41.782338][ T64] ? rcu_is_watching+0x16/0xd0 [ 41.782339][ T64] ? lock_acquire+0x13c/0x160 [ 41.782341][ T64] ? console_flush_one_record+0x111/0x710 [ 41.782343][ T64] console_flush_one_record+0x46f/0x710 [ 41.782345][ T64] ? console_emit_next_record+0x4c0/0x4c0 [ 41.782348][ T64] console_unlock+0xee/0x1f0 [ 41.782350][ T64] ? lock_acquire+0x13c/0x160 [ 41.782352][ T64] ? console_flush_one_record+0x710/0x710 [ 41.782353][ T64] ? rcu_is_watching+0x16/0xd0 [ 41.782355][ T64] ? lock_release+0x184/0x1f0 [ 41.782356][ T64] ? lock_acquire+0x60/0x160 [ 41.782358][ T64] ? __rcu_read_lock+0x30/0x70 [ 41.782360][ T64] ? __down_trylock_console_sem+0x5e/0xa0 [ 41.782362][ T64] ? vprintk_emit+0x320/0x3e0 [ 41.782364][ T64] vprintk_emit+0x37c/0x3e0 [ 41.782366][ T64] ? wake_up_klogd_work_func+0x90/0x90 [ 41.782368][ T64] ? ret_from_fork_asm+0x11/0x20 [ 41.782371][ T64] ? stack_access_ok+0x1e0/0x1e0 [ 41.782374][ T64] _printk+0xc7/0x100 [ 41.782377][ T64] ? snapshot_read.cold+0x21/0x21 [ 41.782379][ T64] ? write_profile+0xf0/0xf0 [ 41.782381][ T64] ? netdev_name+0x43/0x60 [ 41.782384][ T64] ? __netdev_printk+0x17f/0x1d0 [ 41.782386][ T64] netdev_info+0xe2/0x116 [ 41.782388][ T64] ? netdev_notice+0x120/0x120 [ 41.782390][ T64] ? delayed_vfree_work+0x57/0x80 [ 41.782393][ T64] ? filter_irq_stacks+0xd0/0xd0 [ 41.782395][ T64] ? stack_depot_save_flags+0x1bc/0x790 [ 41.782399][ T64] ? trace_irq_enable.constprop.0+0x30/0x160 [ 41.782401][ T64] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 41.782406][ T64] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 41.782409][ T64] ? __rwlock_init+0x150/0x150 [ 41.782411][ T64] ? lock_acquire+0x13c/0x160 [ 41.782412][ T64] ? rcu_is_watching+0x16/0xd0 [ 41.782414][ T64] ovpn_peer_remove+0x394/0x640 [ovpn] [ 41.782418][ T64] ? do_raw_spin_lock+0x131/0x280 [ 41.782420][ T64] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 41.782422][ T64] ? __rwlock_init+0x150/0x150 [ 41.782424][ T64] ? rcu_is_watching+0x16/0xd0 [ 41.782426][ T64] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 41.782427][ T64] ? trace_irq_disable.constprop.0+0x9b/0x160 [ 41.782429][ T64] ovpn_peer_keepalive_work_single+0x416/0x600 [ovpn] [ 41.782432][ T64] ? ovpn_peers_release_mp+0x490/0x490 [ovpn] [ 41.782435][ T64] ? __rwlock_init+0x150/0x150 [ 41.782437][ T64] ovpn_peer_keepalive_work+0x253/0x580 [ovpn] [ 41.782440][ T64] ? ovpn_peers_free+0xb0/0xb0 [ovpn] [ 41.782443][ T64] ? rcu_is_watching+0x16/0xd0 [ 41.782445][ T64] ? lock_acquire+0x13c/0x160 [ 41.782446][ T64] ? rcu_is_watching+0x16/0xd0 [ 41.782449][ T64] process_one_work+0xe3e/0x1560 [ 41.782453][ T64] ? __queue_delayed_work+0x470/0x470 [ 41.782455][ T64] ? __rwlock_init+0x150/0x150 [ 41.782458][ T64] worker_thread+0x4f1/0xd60 [ 41.782460][ T64] ? rescuer_thread+0x1340/0x1340 [ 41.782462][ T64] ? __kthread_parkme+0xbd/0x210 [ 41.782465][ T64] ? rescuer_thread+0x1340/0x1340 [ 41.782467][ T64] ? rescuer_thread+0x1340/0x1340 [ 41.782468][ T64] kthread+0x367/0x460 [ 41.782470][ T64] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 41.782472][ T64] ? kthread_affine_preferred+0x4c0/0x4c0 [ 41.782473][ T64] ret_from_fork+0x474/0x6b0 [ 41.782477][ T64] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 41.782479][ T64] ? __switch_to+0x5a3/0xe00 [ 41.782482][ T64] ? kthread_affine_preferred+0x4c0/0x4c0 [ 41.782483][ T64] ret_from_fork_asm+0x11/0x20 [ 41.782487][ T64] [ 41.810412][ T64] tun0: deleting peer with id 3, reason 2 [ 41.810693][ T64] tun0: deleting peer with id 5, reason 2 [ 41.810915][ T64] tun0: deleting peer with id 6, reason 2 [ 46.903205][ T64] tun4: deleting peer with id 13, reason 2 [ 46.903210][ T34] tun3: deleting peer with id 12, reason 2 [ 46.903227][ T64] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 46.903229][ T64] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 64, name: kworker/2:2 [ 46.903231][ T64] preempt_count: 202, expected: 0 [ 46.903232][ T64] RCU nest depth: 0, expected: 0 [ 46.903233][ T64] INFO: lockdep is turned off. [ 46.903234][ T64] irq event stamp: 12744 [ 46.903235][ T64] hardirqs last enabled at (12743): [] _raw_spin_unlock_irq+0x28/0x50 [ 46.903243][ T64] hardirqs last disabled at (12744): [] __schedule+0x1246/0x20e0 [ 46.903246][ T64] softirqs last enabled at (12406): [] handle_softirqs+0x67c/0x900 [ 46.903250][ T64] softirqs last disabled at (12363): [] do_softirq+0xac/0xe0 [ 46.903252][ T64] Preemption disabled at: [ 46.903253][ T64] [<0000000000000000>] 0x0 [ 46.903260][ T64] CPU: 2 UID: 0 PID: 64 Comm: kworker/2:2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 46.903264][ T64] Tainted: [W]=WARN [ 46.903265][ T64] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 46.903267][ T64] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 46.903275][ T64] Call Trace: [ 46.903277][ T64] [ 46.903278][ T64] dump_stack_lvl+0x6f/0xa0 [ 46.903284][ T64] __might_resched.cold+0x1fe/0x2c1 [ 46.903288][ T64] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 46.903291][ T64] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 46.903294][ T64] ? rcu_is_watching+0x16/0xd0 [ 46.903298][ T64] __kmalloc_noprof+0x443/0x760 [ 46.903301][ T64] ? __rwlock_init+0x150/0x150 [ 46.903304][ T64] ? alloc_buf.isra.0+0x4b/0x260 [ 46.903308][ T64] ? do_raw_spin_unlock+0x59/0x250 [ 46.903310][ T64] alloc_buf.isra.0+0x4b/0x260 [ 46.903312][ T64] put_chars+0x1e1/0x2f0 [ 46.903313][ T64] ? prb_final_commit+0x50/0x50 [ 46.903315][ T64] ? __send_to_port+0x420/0x420 [ 46.903317][ T64] ? printk_get_next_message+0x240/0x650 [ 46.903320][ T64] hvc_console_print+0x292/0x780 [ 46.903324][ T64] ? hvc_write+0x3a0/0x3a0 [ 46.903326][ T64] ? do_raw_spin_lock+0x131/0x280 [ 46.903327][ T64] ? vsnprintf+0x527/0x1700 [ 46.903329][ T64] ? __rwlock_init+0x150/0x150 [ 46.903331][ T64] ? rcu_is_watching+0x16/0xd0 [ 46.903333][ T64] ? lock_acquire+0x13c/0x160 [ 46.903335][ T64] console_emit_next_record+0x22f/0x4c0 [ 46.903337][ T64] ? devkmsg_read+0x4b0/0x4b0 [ 46.903339][ T64] ? rcu_is_watching+0x16/0xd0 [ 46.903341][ T64] ? rcu_is_watching+0x16/0xd0 [ 46.903343][ T64] ? rcu_is_watching+0x16/0xd0 [ 46.903344][ T64] ? lock_acquire+0x13c/0x160 [ 46.903346][ T64] ? console_flush_one_record+0x111/0x710 [ 46.903348][ T64] console_flush_one_record+0x46f/0x710 [ 46.903350][ T64] ? console_emit_next_record+0x4c0/0x4c0 [ 46.903353][ T64] console_unlock+0xee/0x1f0 [ 46.903354][ T64] ? lock_acquire+0x13c/0x160 [ 46.903356][ T64] ? console_flush_one_record+0x710/0x710 [ 46.903358][ T64] ? rcu_is_watching+0x16/0xd0 [ 46.903359][ T64] ? lock_release+0x184/0x1f0 [ 46.903361][ T64] ? lock_acquire+0x60/0x160 [ 46.903362][ T64] ? __rcu_read_lock+0x30/0x70 [ 46.903364][ T64] ? __down_trylock_console_sem+0x5e/0xa0 [ 46.903366][ T64] ? vprintk_emit+0x320/0x3e0 [ 46.903368][ T64] vprintk_emit+0x37c/0x3e0 [ 46.903370][ T64] ? wake_up_klogd_work_func+0x90/0x90 [ 46.903372][ T64] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 46.903373][ T64] ? rcu_is_watching+0x16/0xd0 [ 46.903375][ T64] ? trace_sched_wakeup+0x9b/0x160 [ 46.903378][ T64] _printk+0xc7/0x100 [ 46.903381][ T64] ? snapshot_read.cold+0x21/0x21 [ 46.903382][ T64] ? try_to_wake_up+0x153/0x1130 [ 46.903384][ T64] ? select_fallback_rq+0x510/0x510 [ 46.903386][ T64] ? netdev_name+0x43/0x60 [ 46.903389][ T64] ? __netdev_printk+0x17f/0x1d0 [ 46.903390][ T64] netdev_info+0xe2/0x116 [ 46.903392][ T64] ? netdev_notice+0x120/0x120 [ 46.903394][ T64] ? rcu_is_watching+0x16/0xd0 [ 46.903396][ T64] ? __queue_work+0x3ab/0xd30 [ 46.903399][ T64] ? trace_irq_enable.constprop.0+0x30/0x160 [ 46.903402][ T64] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 46.903405][ T64] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 46.903408][ T64] ? rcu_is_watching+0x16/0xd0 [ 46.903410][ T64] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 46.903412][ T64] ovpn_peer_remove+0x394/0x640 [ovpn] [ 46.903415][ T64] ? do_raw_spin_lock+0x131/0x280 [ 46.903417][ T64] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 46.903419][ T64] ? __rwlock_init+0x150/0x150 [ 46.903421][ T64] ? rcu_is_watching+0x16/0xd0 [ 46.903423][ T64] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 46.903424][ T64] ? trace_irq_disable.constprop.0+0x9b/0x160 [ 46.903426][ T64] ovpn_peer_keepalive_work_single+0x416/0x600 [ovpn] [ 46.903428][ T64] ? ovpn_peers_release_mp+0x490/0x490 [ovpn] [ 46.903431][ T64] ? __rwlock_init+0x150/0x150 [ 46.903433][ T64] ovpn_peer_keepalive_work+0x389/0x580 [ovpn] [ 46.903436][ T64] ? ovpn_peers_free+0xb0/0xb0 [ovpn] [ 46.903439][ T64] ? rcu_is_watching+0x16/0xd0 [ 46.903440][ T64] ? lock_acquire+0x13c/0x160 [ 46.903442][ T64] ? rcu_is_watching+0x16/0xd0 [ 46.903444][ T64] ? process_one_work+0xdfc/0x1560 [ 46.903446][ T64] process_one_work+0xe3e/0x1560 [ 46.903449][ T64] ? __queue_delayed_work+0x470/0x470 [ 46.903451][ T64] ? __rwlock_init+0x150/0x150 [ 46.903454][ T64] worker_thread+0x4f1/0xd60 [ 46.903456][ T64] ? rescuer_thread+0x1340/0x1340 [ 46.903458][ T64] ? __kthread_parkme+0xbd/0x210 [ 46.903460][ T64] ? rescuer_thread+0x1340/0x1340 [ 46.903462][ T64] ? rescuer_thread+0x1340/0x1340 [ 46.903464][ T64] kthread+0x367/0x460 [ 46.903465][ T64] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 46.903467][ T64] ? kthread_affine_preferred+0x4c0/0x4c0 [ 46.903468][ T64] ret_from_fork+0x474/0x6b0 [ 46.903471][ T64] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 46.903473][ T64] ? __switch_to+0x5a3/0xe00 [ 46.903476][ T64] ? kthread_affine_preferred+0x4c0/0x4c0 [ 46.903477][ T64] ret_from_fork_asm+0x11/0x20 [ 46.903481][ T64] [ 46.966189][ T10] tun5: deleting peer with id 14, reason 2 [ 47.030188][ T64] tun6: deleting peer with id 15, reason 2