[ 21.982296][ C0] tun0: no available key for peer 1, key-id: 0 [ 21.982331][ C0] [ 21.982332][ C0] ======================================================== [ 21.982333][ C0] WARNING: possible irq lock inversion dependency detected [ 21.982335][ C0] 7.2.0-virtme #1 Tainted: G W [ 21.982337][ C0] -------------------------------------------------------- [ 21.982337][ C0] ovpn-cli/400 just changed the state of lock: [ 21.982339][ C0] ffffffffa0a99660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 21.982352][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 21.982353][ C0] (fs_reclaim){+.+.}-{0:0} [ 21.982354][ C0] [ 21.982354][ C0] [ 21.982354][ C0] and interrupts could create inverse lock ordering between them. [ 21.982354][ C0] [ 21.982355][ C0] [ 21.982355][ C0] other info that might help us debug this: [ 21.982356][ C0] Possible interrupt unsafe locking scenario: [ 21.982356][ C0] [ 21.982357][ C0] CPU0 CPU1 [ 21.982357][ C0] ---- ---- [ 21.982358][ C0] lock(fs_reclaim); [ 21.982359][ C0] local_irq_disable(); [ 21.982359][ C0] lock(console_owner); [ 21.982360][ C0] lock(fs_reclaim); [ 21.982361][ C0] [ 21.982361][ C0] lock(console_owner); [ 21.982362][ C0] [ 21.982362][ C0] *** DEADLOCK *** [ 21.982362][ C0] [ 21.982363][ C0] locks held by ovpn-cli/400: 6, last CPU#0: [ 21.982364][ C0] #0: ffffffffa0b90b00 (rcu_read_lock){....}-{1:3}, at: process_backlog+0x3f1/0x14c0 [ 21.982371][ C0] #1: ffffffffa0b90b00 (rcu_read_lock){....}-{1:3}, at: ip_local_deliver_finish+0x2ba/0x610 [ 21.982375][ C0] #2: ff11000021709d18 (slock-AF_INET/1){+.-.}-{3:3}, at: tcp_v4_rcv+0x1a81/0x2b70 [ 21.982380][ C0] #3: ffffffffa0b90b00 (rcu_read_lock){....}-{1:3}, at: ovpn_tcp_data_ready+0x62/0x390 [ovpn] [ 21.982387][ C0] #4: ffffffffa0b79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 21.982390][ C0] #5: ffffffffa0b79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 21.982393][ C0] [ 21.982393][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 21.982398][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 21.982400][ C0] HARDIRQ-ON-W at: [ 21.982402][ C0] __lock_acquire+0x388/0xc20 [ 21.982405][ C0] lock_acquire.part.0+0xd4/0x280 [ 21.982406][ C0] fs_reclaim_acquire+0xd5/0x120 [ 21.982409][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 21.982412][ C0] kthread_create_worker_on_node+0xea/0x210 [ 21.982414][ C0] workqueue_init+0x2a/0x680 [ 21.982417][ C0] kernel_init_freeable+0x2fe/0x630 [ 21.982420][ C0] kernel_init+0x21/0x150 [ 21.982423][ C0] ret_from_fork+0x474/0x6b0 [ 21.982427][ C0] ret_from_fork_asm+0x11/0x20 [ 21.982429][ C0] SOFTIRQ-ON-W at: [ 21.982430][ C0] __lock_acquire+0x388/0xc20 [ 21.982431][ C0] lock_acquire.part.0+0xd4/0x280 [ 21.982433][ C0] fs_reclaim_acquire+0xd5/0x120 [ 21.982434][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 21.982435][ C0] kthread_create_worker_on_node+0xea/0x210 [ 21.982436][ C0] workqueue_init+0x2a/0x680 [ 21.982437][ C0] kernel_init_freeable+0x2fe/0x630 [ 21.982439][ C0] kernel_init+0x21/0x150 [ 21.982440][ C0] ret_from_fork+0x474/0x6b0 [ 21.982442][ C0] ret_from_fork_asm+0x11/0x20 [ 21.982443][ C0] INITIAL USE at: [ 21.982443][ C0] __lock_acquire+0x388/0xc20 [ 21.982445][ C0] lock_acquire.part.0+0xd4/0x280 [ 21.982446][ C0] fs_reclaim_acquire+0xd5/0x120 [ 21.982447][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 21.982449][ C0] kthread_create_worker_on_node+0xea/0x210 [ 21.982450][ C0] workqueue_init+0x2a/0x680 [ 21.982451][ C0] kernel_init_freeable+0x2fe/0x630 [ 21.982453][ C0] kernel_init+0x21/0x150 [ 21.982454][ C0] ret_from_fork+0x474/0x6b0 [ 21.982455][ C0] ret_from_fork_asm+0x11/0x20 [ 21.982456][ C0] } [ 21.982457][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 21.982460][ C0] ... acquired at: [ 21.982461][ C0] __lock_acquire+0x518/0xc20 [ 21.982462][ C0] lock_acquire.part.0+0xd4/0x280 [ 21.982464][ C0] fs_reclaim_acquire+0xd5/0x120 [ 21.982465][ C0] __kmalloc_noprof+0xd3/0x760 [ 21.982466][ C0] alloc_buf.isra.0+0x4b/0x260 [ 21.982469][ C0] put_chars+0x1e1/0x2f0 [ 21.982471][ C0] hvc_console_print+0x292/0x780 [ 21.982473][ C0] console_emit_next_record+0x22f/0x4c0 [ 21.982475][ C0] console_flush_one_record+0x46f/0x710 [ 21.982476][ C0] console_unlock+0xee/0x1f0 [ 21.982478][ C0] vprintk_emit+0x37c/0x3e0 [ 21.982480][ C0] dev_vprintk_emit+0x27f/0x2c0 [ 21.982483][ C0] dev_printk_emit+0xb9/0xee [ 21.982485][ C0] _dev_info+0xe2/0x116 [ 21.982486][ C0] cmos_do_probe+0x8be/0x98a [ 21.982489][ C0] platform_probe+0xfe/0x1f0 [ 21.982491][ C0] call_driver_probe+0x61/0x1c0 [ 21.982494][ C0] really_probe+0x199/0x760 [ 21.982495][ C0] __driver_probe_device+0x24f/0x440 [ 21.982497][ C0] driver_probe_device+0x4a/0xf0 [ 21.982498][ C0] __driver_attach+0x1b8/0x540 [ 21.982500][ C0] bus_for_each_dev+0x130/0x1e0 [ 21.982506][ C0] bus_add_driver+0x2c8/0x530 [ 21.982507][ C0] driver_register+0x1a3/0x390 [ 21.982509][ C0] __platform_driver_probe+0x13f/0x270 [ 21.982510][ C0] cmos_init+0x31/0x40 [ 21.982512][ C0] do_one_initcall+0x124/0x4f0 [ 21.982514][ C0] kernel_init_freeable+0x596/0x630 [ 21.982516][ C0] kernel_init+0x21/0x150 [ 21.982517][ C0] ret_from_fork+0x474/0x6b0 [ 21.982518][ C0] ret_from_fork_asm+0x11/0x20 [ 21.982519][ C0] [ 21.982520][ C0] -> (console_owner){..-.}-{0:0} { [ 21.982522][ C0] IN-SOFTIRQ-W at: [ 21.982522][ C0] __lock_acquire+0x388/0xc20 [ 21.982524][ C0] lock_acquire.part.0+0xd4/0x280 [ 21.982525][ C0] console_lock_spinning_enable+0x5c/0x60 [ 21.982527][ C0] console_emit_next_record+0x1d1/0x4c0 [ 21.982528][ C0] console_flush_one_record+0x46f/0x710 [ 21.982530][ C0] console_unlock+0xee/0x1f0 [ 21.982531][ C0] vprintk_emit+0x37c/0x3e0 [ 21.982533][ C0] _printk+0xc7/0x100 [ 21.982535][ C0] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 21.982539][ C0] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 21.982541][ C0] __strp_recv+0x20f/0x1c20 [ 21.982544][ C0] __tcp_read_sock+0x1c7/0x850 [ 21.982546][ C0] strp_read_sock+0x20f/0x2b0 [ 21.982548][ C0] strp_data_ready+0x18e/0x2c0 [ 21.982550][ C0] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 21.982552][ C0] tcp_rcv_established+0x1e1d/0x3910 [ 21.982554][ C0] tcp_v4_do_rcv+0x4f6/0xb90 [ 21.982556][ C0] tcp_v4_rcv+0x1caa/0x2b70 [ 21.982557][ C0] ip_protocol_deliver_rcu+0x82/0x350 [ 21.982559][ C0] ip_local_deliver_finish+0x36f/0x610 [ 21.982560][ C0] ip_local_deliver+0x184/0x4c0 [ 21.982561][ C0] ip_rcv+0xdc/0x3d0 [ 21.982562][ C0] __netif_receive_skb_one_core+0xfc/0x180 [ 21.982564][ C0] process_backlog+0x431/0x14c0 [ 21.982566][ C0] __napi_poll+0xa7/0x3b0 [ 21.982568][ C0] net_rx_action+0x513/0xf50 [ 21.982569][ C0] handle_softirqs+0x1d3/0x900 [ 21.982572][ C0] do_softirq+0xac/0xe0 [ 21.982573][ C0] __local_bh_enable_ip+0x118/0x150 [ 21.982575][ C0] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 21.982577][ C0] __sys_sendto+0x2aa/0x400 [ 21.982580][ C0] __x64_sys_sendto+0xe4/0x1f0 [ 21.982581][ C0] do_syscall_64+0xff/0x530 [ 21.982584][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 21.982585][ C0] INITIAL USE at: [ 21.982586][ C0] } [ 21.982587][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 21.982590][ C0] ... acquired at: [ 21.982591][ C0] mark_lock+0x1d7/0xa00 [ 21.982592][ C0] mark_usage+0x42/0x170 [ 21.982593][ C0] __lock_acquire+0x388/0xc20 [ 21.982594][ C0] lock_acquire.part.0+0xd4/0x280 [ 21.982596][ C0] console_lock_spinning_enable+0x5c/0x60 [ 21.982597][ C0] console_emit_next_record+0x1d1/0x4c0 [ 21.982599][ C0] console_flush_one_record+0x46f/0x710 [ 21.982600][ C0] console_unlock+0xee/0x1f0 [ 21.982602][ C0] vprintk_emit+0x37c/0x3e0 [ 21.982603][ C0] _printk+0xc7/0x100 [ 21.982604][ C0] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 21.982607][ C0] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 21.982609][ C0] __strp_recv+0x20f/0x1c20 [ 21.982611][ C0] __tcp_read_sock+0x1c7/0x850 [ 21.982612][ C0] strp_read_sock+0x20f/0x2b0 [ 21.982614][ C0] strp_data_ready+0x18e/0x2c0 [ 21.982615][ C0] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 21.982617][ C0] tcp_rcv_established+0x1e1d/0x3910 [ 21.982619][ C0] tcp_v4_do_rcv+0x4f6/0xb90 [ 21.982620][ C0] tcp_v4_rcv+0x1caa/0x2b70 [ 21.982622][ C0] ip_protocol_deliver_rcu+0x82/0x350 [ 21.982623][ C0] ip_local_deliver_finish+0x36f/0x610 [ 21.982624][ C0] ip_local_deliver+0x184/0x4c0 [ 21.982626][ C0] ip_rcv+0xdc/0x3d0 [ 21.982627][ C0] __netif_receive_skb_one_core+0xfc/0x180 [ 21.982628][ C0] process_backlog+0x431/0x14c0 [ 21.982630][ C0] __napi_poll+0xa7/0x3b0 [ 21.982632][ C0] net_rx_action+0x513/0xf50 [ 21.982633][ C0] handle_softirqs+0x1d3/0x900 [ 21.982634][ C0] do_softirq+0xac/0xe0 [ 21.982635][ C0] __local_bh_enable_ip+0x118/0x150 [ 21.982637][ C0] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 21.982639][ C0] __sys_sendto+0x2aa/0x400 [ 21.982640][ C0] __x64_sys_sendto+0xe4/0x1f0 [ 21.982642][ C0] do_syscall_64+0xff/0x530 [ 21.982643][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 21.982644][ C0] [ 21.982644][ C0] [ 21.982644][ C0] stack backtrace: [ 21.982647][ C0] CPU: 0 UID: 0 PID: 400 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 21.982650][ C0] Tainted: [W]=WARN [ 21.982651][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 21.982652][ C0] Call Trace: [ 21.982654][ C0] [ 21.982655][ C0] dump_stack_lvl+0x6f/0xa0 [ 21.982660][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 21.982663][ C0] mark_lock_irq+0x989/0x9c0 [ 21.982666][ C0] mark_lock+0x1d7/0xa00 [ 21.982667][ C0] mark_usage+0x42/0x170 [ 21.982669][ C0] __lock_acquire+0x388/0xc20 [ 21.982671][ C0] lock_acquire.part.0+0xd4/0x280 [ 21.982673][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 21.982675][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.982678][ C0] ? lock_acquire+0x13c/0x160 [ 21.982680][ C0] console_lock_spinning_enable+0x5c/0x60 [ 21.982682][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 21.982684][ C0] console_emit_next_record+0x1d1/0x4c0 [ 21.982686][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 21.982687][ C0] ? console_flush_one_record+0x106/0x710 [ 21.982689][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.982691][ C0] ? lock_acquire+0x13c/0x160 [ 21.982693][ C0] console_flush_one_record+0x46f/0x710 [ 21.982695][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 21.982697][ C0] ? __lock_acquire+0x518/0xc20 [ 21.982699][ C0] console_unlock+0xee/0x1f0 [ 21.982701][ C0] ? console_flush_one_record+0x710/0x710 [ 21.982702][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.982704][ C0] ? lock_acquire+0x60/0x160 [ 21.982706][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 21.982707][ C0] ? vprintk_emit+0x320/0x3e0 [ 21.982709][ C0] vprintk_emit+0x37c/0x3e0 [ 21.982711][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 21.982713][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 21.982715][ C0] _printk+0xc7/0x100 [ 21.982717][ C0] ? snapshot_read.cold+0x21/0x21 [ 21.982719][ C0] ? ___ratelimit+0x4e7/0xa00 [ 21.982721][ C0] ? ovpn_netdev_write+0x730/0x730 [ovpn] [ 21.982725][ C0] ? idr_get_free+0x830/0x830 [ 21.982727][ C0] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 21.982730][ C0] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 21.982733][ C0] ? ovpn_tcp_write_space+0x2e0/0x2e0 [ovpn] [ 21.982735][ C0] ? __copy_skb_header+0xb7/0x510 [ 21.982738][ C0] ? ovpn_tcp_disconnect+0x10/0x10 [ovpn] [ 21.982740][ C0] ? sock_queue_err_skb+0xb0/0x680 [ 21.982742][ C0] __strp_recv+0x20f/0x1c20 [ 21.982746][ C0] __tcp_read_sock+0x1c7/0x850 [ 21.982747][ C0] ? strp_process+0xb0/0xb0 [ 21.982749][ C0] ? __tcp_transmit_skb+0x1b6e/0x3c10 [ 21.982751][ C0] ? tcp_cleanup_rbuf+0x1c0/0x1c0 [ 21.982752][ C0] ? mark_usage+0x61/0x170 [ 21.982754][ C0] strp_read_sock+0x20f/0x2b0 [ 21.982756][ C0] ? strp_stop+0x50/0x50 [ 21.982758][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.982760][ C0] ? lock_acquire+0x13c/0x160 [ 21.982762][ C0] strp_data_ready+0x18e/0x2c0 [ 21.982764][ C0] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 21.982766][ C0] tcp_rcv_established+0x1e1d/0x3910 [ 21.982769][ C0] ? __tcp_check_space+0x600/0x600 [ 21.982771][ C0] ? tcp_v4_rcv+0x1a81/0x2b70 [ 21.982773][ C0] ? do_raw_spin_lock+0x131/0x280 [ 21.982775][ C0] tcp_v4_do_rcv+0x4f6/0xb90 [ 21.982777][ C0] tcp_v4_rcv+0x1caa/0x2b70 [ 21.982780][ C0] ? mark_usage+0x61/0x170 [ 21.982781][ C0] ? tcp_add_backlog+0x1e30/0x1e30 [ 21.982784][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 21.982785][ C0] ? ip_local_deliver_finish+0x2ba/0x610 [ 21.982787][ C0] ip_protocol_deliver_rcu+0x82/0x350 [ 21.982789][ C0] ? process_backlog+0x3f1/0x14c0 [ 21.982791][ C0] ip_local_deliver_finish+0x36f/0x610 [ 21.982792][ C0] ip_local_deliver+0x184/0x4c0 [ 21.982794][ C0] ? ip_local_deliver_finish+0x610/0x610 [ 21.982796][ C0] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 21.982798][ C0] ? process_backlog+0x3f1/0x14c0 [ 21.982800][ C0] ip_rcv+0xdc/0x3d0 [ 21.982801][ C0] ? ip_local_deliver+0x4c0/0x4c0 [ 21.982803][ C0] ? rcu_read_lock_any_held+0x3c/0x90 [ 21.982805][ C0] ? mark_usage+0x61/0x170 [ 21.982806][ C0] ? __lock_acquire+0x518/0xc20 [ 21.982808][ C0] ? trace_raw_output_rcu_invoke_kfree_bulk_callback+0x57/0x130 [ 21.982810][ C0] __netif_receive_skb_one_core+0xfc/0x180 [ 21.982812][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 21.982814][ C0] ? process_backlog+0x3f1/0x14c0 [ 21.982815][ C0] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 21.982817][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.982820][ C0] process_backlog+0x431/0x14c0 [ 21.982822][ C0] __napi_poll+0xa7/0x3b0 [ 21.982824][ C0] net_rx_action+0x513/0xf50 [ 21.982827][ C0] ? __lock_acquire+0x518/0xc20 [ 21.982828][ C0] ? __napi_poll+0x3b0/0x3b0 [ 21.982832][ C0] ? ktime_get_update_offsets_now+0x2a8/0x490 [ 21.982835][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.982837][ C0] handle_softirqs+0x1d3/0x900 [ 21.982839][ C0] ? _local_bh_enable+0xc0/0xc0 [ 21.982840][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 21.982842][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.982844][ C0] do_softirq+0xac/0xe0 [ 21.982845][ C0] [ 21.982846][ C0] [ 21.982846][ C0] __local_bh_enable_ip+0x118/0x150 [ 21.982848][ C0] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 21.982851][ C0] ? ovpn_tcp_recvmsg+0x6d0/0x6d0 [ovpn] [ 21.982854][ C0] __sys_sendto+0x2aa/0x400 [ 21.982856][ C0] ? __ia32_sys_getpeername+0xd0/0xd0 [ 21.982860][ C0] ? fput_close_sync+0xde/0x1b0 [ 21.982862][ C0] ? alloc_file_clone+0xe0/0xe0 [ 21.982864][ C0] __x64_sys_sendto+0xe4/0x1f0 [ 21.982866][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 21.982868][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 21.982869][ C0] ? do_syscall_64+0xa6/0x530 [ 21.982871][ C0] do_syscall_64+0xff/0x530 [ 21.982872][ C0] ? exc_page_fault+0xee/0x100 [ 21.982874][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 21.982875][ C0] RIP: 0033:0x7fe7df91554e [ 21.982878][ 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 [ 21.982880][ C0] RSP: 002b:00007ffca625be30 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 21.982882][ C0] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007fe7df91554e [ 21.982884][ C0] RDX: 00000000000003ea RSI: 00007ffca625bea0 RDI: 0000000000000005 [ 21.982885][ C0] RBP: 00007ffca625be40 R08: 0000000000000000 R09: 0000000000000000 [ 21.982886][ C0] R10: 0000000000004000 R11: 0000000000000202 R12: 00007ffca625c7c8 [ 21.982886][ C0] R13: 0000000000000008 R14: 00007fe7dfc00000 R15: 000000000040bda8 [ 21.982889][ C0] [ 21.982893][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 21.982894][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 400, name: ovpn-cli [ 21.982895][ C0] preempt_count: 103, expected: 0 [ 21.982896][ C0] RCU nest depth: 3, expected: 0 [ 21.982897][ C0] INFO: lockdep is turned off. [ 21.982897][ C0] irq event stamp: 36181 [ 21.982898][ C0] hardirqs last enabled at (36180): [] __down_trylock_console_sem+0x86/0xa0 [ 21.982900][ C0] hardirqs last disabled at (36181): [] console_emit_next_record+0x3d4/0x4c0 [ 21.982902][ C0] softirqs last enabled at (36066): [] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 21.982905][ C0] softirqs last disabled at (36067): [] do_softirq+0xac/0xe0 [ 21.982906][ C0] Preemption disabled at: [ 21.982907][ C0] [<0000000000000000>] 0x0 [ 21.982909][ C0] CPU: 0 UID: 0 PID: 400 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 21.982911][ C0] Tainted: [W]=WARN [ 21.982911][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 21.982912][ C0] Call Trace: [ 21.982913][ C0] [ 21.982913][ C0] dump_stack_lvl+0x6f/0xa0 [ 21.982915][ C0] __might_resched.cold+0x1fe/0x2c1 [ 21.982918][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 21.982921][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.982923][ C0] __kmalloc_noprof+0x443/0x760 [ 21.982925][ C0] ? __rwlock_init+0x150/0x150 [ 21.982927][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 21.982929][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 21.982930][ C0] alloc_buf.isra.0+0x4b/0x260 [ 21.982932][ C0] put_chars+0x1e1/0x2f0 [ 21.982934][ C0] ? __send_to_port+0x420/0x420 [ 21.982936][ C0] hvc_console_print+0x292/0x780 [ 21.982938][ C0] ? __lock_acquire+0x388/0xc20 [ 21.982940][ C0] ? hvc_write+0x3a0/0x3a0 [ 21.982942][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.982944][ C0] ? lock_acquire+0x13c/0x160 [ 21.982946][ C0] console_emit_next_record+0x22f/0x4c0 [ 21.982948][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 21.982949][ C0] ? console_flush_one_record+0x106/0x710 [ 21.982951][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.982953][ C0] ? lock_acquire+0x13c/0x160 [ 21.982955][ C0] console_flush_one_record+0x46f/0x710 [ 21.982957][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 21.982959][ C0] ? __lock_acquire+0x518/0xc20 [ 21.982961][ C0] console_unlock+0xee/0x1f0 [ 21.982963][ C0] ? console_flush_one_record+0x710/0x710 [ 21.982964][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.982966][ C0] ? lock_acquire+0x60/0x160 [ 21.982968][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 21.982969][ C0] ? vprintk_emit+0x320/0x3e0 [ 21.982971][ C0] vprintk_emit+0x37c/0x3e0 [ 21.982974][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 21.982975][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 21.982978][ C0] _printk+0xc7/0x100 [ 21.982979][ C0] ? snapshot_read.cold+0x21/0x21 [ 21.982981][ C0] ? ___ratelimit+0x4e7/0xa00 [ 21.982983][ C0] ? ovpn_netdev_write+0x730/0x730 [ovpn] [ 21.982985][ C0] ? idr_get_free+0x830/0x830 [ 21.982987][ C0] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 21.982990][ C0] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 21.982993][ C0] ? ovpn_tcp_write_space+0x2e0/0x2e0 [ovpn] [ 21.982995][ C0] ? __copy_skb_header+0xb7/0x510 [ 21.982997][ C0] ? ovpn_tcp_disconnect+0x10/0x10 [ovpn] [ 21.982999][ C0] ? sock_queue_err_skb+0xb0/0x680 [ 21.983001][ C0] __strp_recv+0x20f/0x1c20 [ 21.983005][ C0] __tcp_read_sock+0x1c7/0x850 [ 21.983006][ C0] ? strp_process+0xb0/0xb0 [ 21.983008][ C0] ? __tcp_transmit_skb+0x1b6e/0x3c10 [ 21.983009][ C0] ? tcp_cleanup_rbuf+0x1c0/0x1c0 [ 21.983011][ C0] ? mark_usage+0x61/0x170 [ 21.983013][ C0] strp_read_sock+0x20f/0x2b0 [ 21.983015][ C0] ? strp_stop+0x50/0x50 [ 21.983017][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.983019][ C0] ? lock_acquire+0x13c/0x160 [ 21.983020][ C0] strp_data_ready+0x18e/0x2c0 [ 21.983023][ C0] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 21.983025][ C0] tcp_rcv_established+0x1e1d/0x3910 [ 21.983028][ C0] ? __tcp_check_space+0x600/0x600 [ 21.983030][ C0] ? tcp_v4_rcv+0x1a81/0x2b70 [ 21.983031][ C0] ? do_raw_spin_lock+0x131/0x280 [ 21.983034][ C0] tcp_v4_do_rcv+0x4f6/0xb90 [ 21.983035][ C0] tcp_v4_rcv+0x1caa/0x2b70 [ 21.983038][ C0] ? mark_usage+0x61/0x170 [ 21.983039][ C0] ? tcp_add_backlog+0x1e30/0x1e30 [ 21.983042][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 21.983043][ C0] ? ip_local_deliver_finish+0x2ba/0x610 [ 21.983045][ C0] ip_protocol_deliver_rcu+0x82/0x350 [ 21.983047][ C0] ? process_backlog+0x3f1/0x14c0 [ 21.983049][ C0] ip_local_deliver_finish+0x36f/0x610 [ 21.983051][ C0] ip_local_deliver+0x184/0x4c0 [ 21.983052][ C0] ? ip_local_deliver_finish+0x610/0x610 [ 21.983054][ C0] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 21.983056][ C0] ? process_backlog+0x3f1/0x14c0 [ 21.983058][ C0] ip_rcv+0xdc/0x3d0 [ 21.983059][ C0] ? ip_local_deliver+0x4c0/0x4c0 [ 21.983061][ C0] ? rcu_read_lock_any_held+0x3c/0x90 [ 21.983062][ C0] ? mark_usage+0x61/0x170 [ 21.983064][ C0] ? __lock_acquire+0x518/0xc20 [ 21.983065][ C0] ? trace_raw_output_rcu_invoke_kfree_bulk_callback+0x57/0x130 [ 21.983067][ C0] __netif_receive_skb_one_core+0xfc/0x180 [ 21.983069][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 21.983071][ C0] ? process_backlog+0x3f1/0x14c0 [ 21.983072][ C0] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 21.983074][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.983077][ C0] process_backlog+0x431/0x14c0 [ 21.983079][ C0] __napi_poll+0xa7/0x3b0 [ 21.983081][ C0] net_rx_action+0x513/0xf50 [ 21.983084][ C0] ? __lock_acquire+0x518/0xc20 [ 21.983085][ C0] ? __napi_poll+0x3b0/0x3b0 [ 21.983089][ C0] ? ktime_get_update_offsets_now+0x2a8/0x490 [ 21.983090][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.983093][ C0] handle_softirqs+0x1d3/0x900 [ 21.983095][ C0] ? _local_bh_enable+0xc0/0xc0 [ 21.983096][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 21.983097][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.983099][ C0] do_softirq+0xac/0xe0 [ 21.983101][ C0] [ 21.983101][ C0] [ 21.983102][ C0] __local_bh_enable_ip+0x118/0x150 [ 21.983103][ C0] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 21.983106][ C0] ? ovpn_tcp_recvmsg+0x6d0/0x6d0 [ovpn] [ 21.983109][ C0] __sys_sendto+0x2aa/0x400 [ 21.983111][ C0] ? __ia32_sys_getpeername+0xd0/0xd0 [ 21.983115][ C0] ? fput_close_sync+0xde/0x1b0 [ 21.983116][ C0] ? alloc_file_clone+0xe0/0xe0 [ 21.983118][ C0] __x64_sys_sendto+0xe4/0x1f0 [ 21.983120][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 21.983121][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 21.983122][ C0] ? do_syscall_64+0xa6/0x530 [ 21.983124][ C0] do_syscall_64+0xff/0x530 [ 21.983125][ C0] ? exc_page_fault+0xee/0x100 [ 21.983126][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 21.983128][ C0] RIP: 0033:0x7fe7df91554e [ 21.983129][ 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 [ 21.983130][ C0] RSP: 002b:00007ffca625be30 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 21.983131][ C0] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007fe7df91554e [ 21.983132][ C0] RDX: 00000000000003ea RSI: 00007ffca625bea0 RDI: 0000000000000005 [ 21.983133][ C0] RBP: 00007ffca625be40 R08: 0000000000000000 R09: 0000000000000000 [ 21.983133][ C0] R10: 0000000000004000 R11: 0000000000000202 R12: 00007ffca625c7c8 [ 21.983134][ C0] R13: 0000000000000008 R14: 00007fe7dfc00000 R15: 000000000040bda8 [ 21.983136][ C0] [ 22.120239][ C0] tun0: no available key for peer 2, key-id: 0 [ 22.304333][ C0] tun0: no available key for peer 6, key-id: 0 [ 30.660063][ T613] iperf3 (613) used greatest stack depth: 23128 bytes left [ 30.660079][ T613] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 30.660081][ T613] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 613, name: iperf3 [ 30.660083][ T613] preempt_count: 2, expected: 0 [ 30.660084][ T613] RCU nest depth: 0, expected: 0 [ 30.660085][ T613] INFO: lockdep is turned off. [ 30.660086][ T613] irq event stamp: 0 [ 30.660086][ T613] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 30.660091][ T613] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 30.660097][ T613] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 30.660099][ T613] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 30.660100][ T613] Preemption disabled at: [ 30.660101][ T613] [<0000000000000000>] 0x0 [ 30.660106][ T613] CPU: 2 UID: 0 PID: 613 Comm: iperf3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 30.660109][ T613] Tainted: [W]=WARN [ 30.660110][ T613] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 30.660112][ T613] Call Trace: [ 30.660114][ T613] [ 30.660115][ T613] dump_stack_lvl+0x6f/0xa0 [ 30.660120][ T613] __might_resched.cold+0x1fe/0x2c1 [ 30.660124][ T613] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 30.660127][ T613] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 30.660130][ T613] ? rcu_is_watching+0x16/0xd0 [ 30.660134][ T613] __kmalloc_noprof+0x443/0x760 [ 30.660137][ T613] ? __rwlock_init+0x150/0x150 [ 30.660140][ T613] ? alloc_buf.isra.0+0x4b/0x260 [ 30.660144][ T613] ? do_raw_spin_unlock+0x59/0x250 [ 30.660145][ T613] alloc_buf.isra.0+0x4b/0x260 [ 30.660147][ T613] put_chars+0x1e1/0x2f0 [ 30.660149][ T613] ? prb_final_commit+0x50/0x50 [ 30.660151][ T613] ? __send_to_port+0x420/0x420 [ 30.660152][ T613] ? printk_get_next_message+0x240/0x650 [ 30.660155][ T613] hvc_console_print+0x292/0x780 [ 30.660159][ T613] ? hvc_write+0x3a0/0x3a0 [ 30.660161][ T613] ? do_raw_spin_lock+0x131/0x280 [ 30.660162][ T613] ? vsnprintf+0x668/0x1700 [ 30.660165][ T613] ? __rwlock_init+0x150/0x150 [ 30.660166][ T613] ? rcu_is_watching+0x16/0xd0 [ 30.660168][ T613] ? lock_acquire+0x13c/0x160 [ 30.660170][ T613] console_emit_next_record+0x22f/0x4c0 [ 30.660173][ T613] ? devkmsg_read+0x4b0/0x4b0 [ 30.660175][ T613] ? rcu_is_watching+0x16/0xd0 [ 30.660176][ T613] ? rcu_is_watching+0x16/0xd0 [ 30.660178][ T613] ? rcu_is_watching+0x16/0xd0 [ 30.660180][ T613] ? lock_acquire+0x13c/0x160 [ 30.660181][ T613] ? console_flush_one_record+0x111/0x710 [ 30.660183][ T613] console_flush_one_record+0x46f/0x710 [ 30.660185][ T613] ? console_emit_next_record+0x4c0/0x4c0 [ 30.660188][ T613] console_unlock+0xee/0x1f0 [ 30.660190][ T613] ? lock_acquire+0x13c/0x160 [ 30.660191][ T613] ? console_flush_one_record+0x710/0x710 [ 30.660193][ T613] ? rcu_is_watching+0x16/0xd0 [ 30.660195][ T613] ? lock_release+0x184/0x1f0 [ 30.660196][ T613] ? lock_acquire+0x60/0x160 [ 30.660197][ T613] ? __rcu_read_lock+0x30/0x70 [ 30.660199][ T613] ? __down_trylock_console_sem+0x5e/0xa0 [ 30.660201][ T613] ? vprintk_emit+0x320/0x3e0 [ 30.660203][ T613] vprintk_emit+0x37c/0x3e0 [ 30.660205][ T613] ? wake_up_klogd_work_func+0x90/0x90 [ 30.660208][ T613] _printk+0xc7/0x100 [ 30.660211][ T613] ? snapshot_read.cold+0x21/0x21 [ 30.660212][ T613] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 30.660215][ T613] ? do_raw_spin_lock+0x131/0x280 [ 30.660217][ T613] ? __rwlock_init+0x150/0x150 [ 30.660219][ T613] ? do_raw_spin_lock+0x131/0x280 [ 30.660220][ T613] do_exit.cold+0x82/0x9c [ 30.660223][ T613] ? exit_notify+0x890/0x890 [ 30.660226][ T613] __x64_sys_exit+0x42/0x50 [ 30.660227][ T613] x64_sys_call+0x156c/0x1570 [ 30.660230][ T613] do_syscall_64+0xff/0x530 [ 30.660232][ T613] ? exc_page_fault+0xee/0x100 [ 30.660234][ T613] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 30.660236][ T613] RIP: 0033:0x7f648e8a2c49 [ 30.660237][ T613] Code: Unable to access opcode bytes at 0x7f648e8a2c1f. [ 30.660239][ T613] RSP: 002b:00007f648e061e60 EFLAGS: 00000246 ORIG_RAX: 000000000000003c [ 30.660242][ T613] RAX: ffffffffffffffda RBX: 00007f648e0626c0 RCX: 00007f648e8a2c49 [ 30.660243][ T613] RDX: 0000000000000000 RSI: 0000000000801000 RDI: 0000000000000000 [ 30.660244][ T613] RBP: 00007f648e061f70 R08: 0000000000000001 R09: 00007f648e0626c0 [ 30.660245][ T613] R10: 0000000000000008 R11: 0000000000000246 R12: 00007f648d862000 [ 30.660245][ T613] R13: 00007fff155cf480 R14: 0000000000000002 R15: 00007fff155cf587 [ 30.660248][ T613] [ 31.834483][ T707] tun0: deleting peer with id 1, reason 1 [ 31.834499][ T707] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 31.834501][ T707] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 707, name: ovpn-cli [ 31.834502][ T707] preempt_count: 202, expected: 0 [ 31.834503][ T707] RCU nest depth: 0, expected: 0 [ 31.834504][ T707] INFO: lockdep is turned off. [ 31.834505][ T707] irq event stamp: 0 [ 31.834506][ T707] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 31.834510][ T707] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 31.834516][ T707] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 31.834517][ T707] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 31.834519][ T707] Preemption disabled at: [ 31.834520][ T707] [<0000000000000000>] 0x0 [ 31.834525][ T707] CPU: 3 UID: 0 PID: 707 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 31.834528][ T707] Tainted: [W]=WARN [ 31.834529][ T707] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 31.834531][ T707] Call Trace: [ 31.834532][ T707] [ 31.834533][ T707] dump_stack_lvl+0x6f/0xa0 [ 31.834542][ T707] __might_resched.cold+0x1fe/0x2c1 [ 31.834546][ T707] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 31.834549][ T707] ? rcu_is_watching+0x16/0xd0 [ 31.834553][ T707] __kmalloc_noprof+0x443/0x760 [ 31.834556][ T707] ? __rwlock_init+0x150/0x150 [ 31.834559][ T707] ? alloc_buf.isra.0+0x4b/0x260 [ 31.834563][ T707] ? do_raw_spin_unlock+0x59/0x250 [ 31.834565][ T707] alloc_buf.isra.0+0x4b/0x260 [ 31.834567][ T707] put_chars+0x1e1/0x2f0 [ 31.834569][ T707] ? __send_to_port+0x420/0x420 [ 31.834571][ T707] ? printk_get_next_message+0x240/0x650 [ 31.834574][ T707] hvc_console_print+0x292/0x780 [ 31.834578][ T707] ? hvc_write+0x3a0/0x3a0 [ 31.834579][ T707] ? __rwlock_init+0x150/0x150 [ 31.834581][ T707] ? rcu_is_watching+0x16/0xd0 [ 31.834583][ T707] ? lock_acquire+0x13c/0x160 [ 31.834585][ T707] console_emit_next_record+0x22f/0x4c0 [ 31.834587][ T707] ? devkmsg_read+0x4b0/0x4b0 [ 31.834589][ T707] ? rcu_is_watching+0x16/0xd0 [ 31.834590][ T707] ? rcu_is_watching+0x16/0xd0 [ 31.834592][ T707] ? rcu_is_watching+0x16/0xd0 [ 31.834594][ T707] ? lock_acquire+0x13c/0x160 [ 31.834595][ T707] ? console_flush_one_record+0x111/0x710 [ 31.834597][ T707] console_flush_one_record+0x46f/0x710 [ 31.834599][ T707] ? console_emit_next_record+0x4c0/0x4c0 [ 31.834602][ T707] console_unlock+0xee/0x1f0 [ 31.834604][ T707] ? lock_acquire+0x13c/0x160 [ 31.834605][ T707] ? console_flush_one_record+0x710/0x710 [ 31.834607][ T707] ? rcu_is_watching+0x16/0xd0 [ 31.834608][ T707] ? lock_release+0x184/0x1f0 [ 31.834610][ T707] ? lock_acquire+0x60/0x160 [ 31.834611][ T707] ? __rcu_read_lock+0x30/0x70 [ 31.834613][ T707] ? __down_trylock_console_sem+0x5e/0xa0 [ 31.834615][ T707] ? vprintk_emit+0x320/0x3e0 [ 31.834617][ T707] vprintk_emit+0x37c/0x3e0 [ 31.834619][ T707] ? wake_up_klogd_work_func+0x90/0x90 [ 31.834621][ T707] ? kernel_text_address+0x149/0x170 [ 31.834623][ T707] ? __kernel_text_address+0x12/0x30 [ 31.834624][ T707] ? write_profile+0xf0/0xf0 [ 31.834626][ T707] ? unwind_get_return_address+0x67/0xd0 [ 31.834629][ T707] _printk+0xc7/0x100 [ 31.834632][ T707] ? snapshot_read.cold+0x21/0x21 [ 31.834634][ T707] ? netdev_name+0x43/0x60 [ 31.834636][ T707] ? __netdev_printk+0x17f/0x1d0 [ 31.834638][ T707] netdev_info+0xe2/0x116 [ 31.834640][ T707] ? netdev_notice+0x120/0x120 [ 31.834641][ T707] ? ovpn_nl_pre_doit+0x44/0x90 [ovpn] [ 31.834646][ T707] ? __module_address+0x36/0x330 [ 31.834649][ T707] ? lock_acquire+0x13c/0x160 [ 31.834651][ T707] ? rcu_is_watching+0x16/0xd0 [ 31.834653][ T707] ? lock_release+0x184/0x1f0 [ 31.834654][ T707] ? ovpn_peer_get_by_id+0x38a/0x7a0 [ovpn] [ 31.834659][ T707] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 31.834663][ T707] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 31.834666][ T707] ? lock_acquire+0x13c/0x160 [ 31.834667][ T707] ? rcu_is_watching+0x16/0xd0 [ 31.834669][ T707] ? lock_release+0x184/0x1f0 [ 31.834671][ T707] ovpn_peer_remove+0x394/0x640 [ovpn] [ 31.834673][ T707] ? do_raw_spin_lock+0x131/0x280 [ 31.834675][ T707] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 31.834678][ T707] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 31.834681][ T707] ? ovpn_peer_add+0x330/0x330 [ovpn] [ 31.834684][ T707] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 31.834687][ T707] ? trace_hardirqs_on+0x36/0x40 [ 31.834689][ T707] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 31.834691][ T707] ? ref_tracker_alloc+0x28d/0x430 [ 31.834696][ T707] ? lock_release+0x184/0x1f0 [ 31.834698][ T707] ? ovpn_get_dev_from_attrs+0x17a/0x660 [ovpn] [ 31.834701][ T707] genl_family_rcv_msg_doit+0x206/0x300 [ 31.834705][ T707] ? genl_family_rcv_msg_attrs_parse.isra.0+0x330/0x330 [ 31.834707][ T707] ? rcu_is_watching+0x16/0xd0 [ 31.834710][ T707] ? rcu_is_watching+0x16/0xd0 [ 31.834711][ T707] ? cap_capable+0x1d7/0x3d0 [ 31.834715][ T707] ? write_profile+0xf0/0xf0 [ 31.834716][ T707] ? unwind_get_return_address+0x67/0xd0 [ 31.834717][ T707] genl_family_rcv_msg+0x3a4/0x640 [ 31.834720][ T707] ? genl_family_rcv_msg_dumpit+0x340/0x340 [ 31.834722][ T707] ? ovpn_nl_send_peer+0x1300/0x1300 [ovpn] [ 31.834724][ T707] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 31.834726][ T707] ? ovpn_nl_pre_doit+0x90/0x90 [ovpn] [ 31.834728][ T707] ? filter_irq_stacks+0xd0/0xd0 [ 31.834730][ T707] ? stack_depot_save_flags+0x1bc/0x790 [ 31.834732][ T707] genl_rcv_msg+0xbb/0x160 [ 31.834734][ T707] netlink_rcv_skb+0x14e/0x3a0 [ 31.834736][ T707] ? genl_family_rcv_msg+0x640/0x640 [ 31.834738][ T707] ? netlink_ack+0xcf0/0xcf0 [ 31.834740][ T707] ? lock_acquire+0x13c/0x160 [ 31.834742][ T707] ? rcu_is_watching+0x16/0xd0 [ 31.834744][ T707] ? lock_release+0x184/0x1f0 [ 31.834745][ T707] genl_rcv+0x28/0x40 [ 31.834747][ T707] netlink_unicast+0x486/0x750 [ 31.834750][ T707] ? netlink_attachskb+0x810/0x810 [ 31.834751][ T707] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 31.834753][ T707] ? trace_hardirqs_on+0x36/0x40 [ 31.834754][ T707] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 31.834757][ T707] netlink_sendmsg+0x735/0xc60 [ 31.834760][ T707] ? netlink_unicast+0x750/0x750 [ 31.834762][ T707] ? rcu_is_watching+0x16/0xd0 [ 31.834764][ T707] ? lock_release+0x184/0x1f0 [ 31.834765][ T707] ____sys_sendmsg+0x415/0x880 [ 31.834769][ T707] ? copy_msghdr_from_user+0x279/0x420 [ 31.834770][ T707] ? get_timestamp.constprop.0+0x390/0x390 [ 31.834772][ T707] ? move_addr_to_kernel+0x40/0x40 [ 31.834775][ T707] ___sys_sendmsg+0x14e/0x1d0 [ 31.834776][ T707] ? copy_msghdr_from_user+0x420/0x420 [ 31.834778][ T707] ? kfree+0x22/0x590 [ 31.834782][ T707] __sys_sendmsg+0x12c/0x1d0 [ 31.834785][ T707] ? __sys_sendmsg_sock+0x20/0x20 [ 31.834787][ T707] ? rcu_is_watching+0x16/0xd0 [ 31.834789][ T707] ? rcu_is_watching+0x16/0xd0 [ 31.834791][ T707] do_syscall_64+0xff/0x530 [ 31.834794][ T707] ? exc_page_fault+0xee/0x100 [ 31.834795][ T707] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 31.834797][ T707] RIP: 0033:0x7fb797acd54e [ 31.834799][ T707] 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 [ 31.834801][ T707] RSP: 002b:00007ffc3162b760 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 31.834804][ T707] RAX: ffffffffffffffda RBX: 000000000f8e6130 RCX: 00007fb797acd54e [ 31.834806][ T707] RDX: 0000000000000000 RSI: 00007ffc3162b800 RDI: 0000000000000005 [ 31.834806][ T707] RBP: 00007ffc3162b770 R08: 0000000000000000 R09: 0000000000000000 [ 31.834807][ T707] R10: 0000000000000000 R11: 0000000000000202 R12: 000000000f8e6200 [ 31.834808][ T707] R13: 00007ffc3162b800 R14: 000000000f8e7260 R15: 000000000040bda8 [ 31.834810][ T707] [ 31.906854][ T711] tun1: deleting peer with id 1, reason 1 [ 34.471332][ T759] tun0: deleting peer with id 2, reason 1 [ 34.471349][ T759] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 34.471351][ T759] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 759, name: ovpn-cli [ 34.471353][ T759] preempt_count: 202, expected: 0 [ 34.471354][ T759] RCU nest depth: 0, expected: 0 [ 34.471355][ T759] INFO: lockdep is turned off. [ 34.471356][ T759] irq event stamp: 0 [ 34.471356][ T759] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 34.471360][ T759] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 34.471366][ T759] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 34.471368][ T759] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 34.471369][ T759] Preemption disabled at: [ 34.471370][ T759] [<0000000000000000>] 0x0 [ 34.471375][ T759] CPU: 2 UID: 0 PID: 759 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 34.471379][ T759] Tainted: [W]=WARN [ 34.471380][ T759] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 34.471381][ T759] Call Trace: [ 34.471383][ T759] [ 34.471384][ T759] dump_stack_lvl+0x6f/0xa0 [ 34.471389][ T759] __might_resched.cold+0x1fe/0x2c1 [ 34.471393][ T759] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 34.471396][ T759] ? rcu_is_watching+0x16/0xd0 [ 34.471400][ T759] __kmalloc_noprof+0x443/0x760 [ 34.471404][ T759] ? __rwlock_init+0x150/0x150 [ 34.471406][ T759] ? alloc_buf.isra.0+0x4b/0x260 [ 34.471411][ T759] ? do_raw_spin_unlock+0x59/0x250 [ 34.471412][ T759] alloc_buf.isra.0+0x4b/0x260 [ 34.471414][ T759] put_chars+0x1e1/0x2f0 [ 34.471416][ T759] ? __send_to_port+0x420/0x420 [ 34.471418][ T759] ? printk_get_next_message+0x240/0x650 [ 34.471422][ T759] hvc_console_print+0x292/0x780 [ 34.471425][ T759] ? hvc_write+0x3a0/0x3a0 [ 34.471427][ T759] ? __rwlock_init+0x150/0x150 [ 34.471428][ T759] ? rcu_is_watching+0x16/0xd0 [ 34.471430][ T759] ? lock_acquire+0x13c/0x160 [ 34.471432][ T759] console_emit_next_record+0x22f/0x4c0 [ 34.471435][ T759] ? devkmsg_read+0x4b0/0x4b0 [ 34.471436][ T759] ? rcu_is_watching+0x16/0xd0 [ 34.471438][ T759] ? rcu_is_watching+0x16/0xd0 [ 34.471440][ T759] ? rcu_is_watching+0x16/0xd0 [ 34.471441][ T759] ? lock_acquire+0x13c/0x160 [ 34.471443][ T759] ? console_flush_one_record+0x111/0x710 [ 34.471445][ T759] console_flush_one_record+0x46f/0x710 [ 34.471447][ T759] ? console_emit_next_record+0x4c0/0x4c0 [ 34.471449][ T759] console_unlock+0xee/0x1f0 [ 34.471451][ T759] ? lock_acquire+0x13c/0x160 [ 34.471453][ T759] ? console_flush_one_record+0x710/0x710 [ 34.471454][ T759] ? rcu_is_watching+0x16/0xd0 [ 34.471456][ T759] ? lock_release+0x184/0x1f0 [ 34.471457][ T759] ? lock_acquire+0x60/0x160 [ 34.471458][ T759] ? __rcu_read_lock+0x30/0x70 [ 34.471460][ T759] ? __down_trylock_console_sem+0x5e/0xa0 [ 34.471462][ T759] ? vprintk_emit+0x320/0x3e0 [ 34.471464][ T759] vprintk_emit+0x37c/0x3e0 [ 34.471467][ T759] ? wake_up_klogd_work_func+0x90/0x90 [ 34.471468][ T759] ? kernel_text_address+0x149/0x170 [ 34.471470][ T759] ? __kernel_text_address+0x12/0x30 [ 34.471472][ T759] ? write_profile+0xf0/0xf0 [ 34.471474][ T759] ? unwind_get_return_address+0x67/0xd0 [ 34.471476][ T759] _printk+0xc7/0x100 [ 34.471479][ T759] ? snapshot_read.cold+0x21/0x21 [ 34.471481][ T759] ? netdev_name+0x43/0x60 [ 34.471484][ T759] ? __netdev_printk+0x17f/0x1d0 [ 34.471485][ T759] netdev_info+0xe2/0x116 [ 34.471487][ T759] ? netdev_notice+0x120/0x120 [ 34.471488][ T759] ? ovpn_nl_pre_doit+0x44/0x90 [ovpn] [ 34.471494][ T759] ? __module_address+0x36/0x330 [ 34.471497][ T759] ? lock_acquire+0x13c/0x160 [ 34.471498][ T759] ? rcu_is_watching+0x16/0xd0 [ 34.471500][ T759] ? lock_release+0x184/0x1f0 [ 34.471502][ T759] ? ovpn_peer_get_by_id+0x38a/0x7a0 [ovpn] [ 34.471505][ T759] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 34.471508][ T759] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 34.471510][ T759] ? lock_acquire+0x13c/0x160 [ 34.471512][ T759] ? rcu_is_watching+0x16/0xd0 [ 34.471514][ T759] ? lock_release+0x184/0x1f0 [ 34.471515][ T759] ovpn_peer_remove+0x394/0x640 [ovpn] [ 34.471518][ T759] ? do_raw_spin_lock+0x131/0x280 [ 34.471520][ T759] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 34.471523][ T759] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 34.471526][ T759] ? ovpn_peer_add+0x330/0x330 [ovpn] [ 34.471529][ T759] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 34.471531][ T759] ? trace_hardirqs_on+0x36/0x40 [ 34.471534][ T759] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 34.471536][ T759] ? ref_tracker_alloc+0x28d/0x430 [ 34.471541][ T759] ? lock_release+0x184/0x1f0 [ 34.471543][ T759] ? ovpn_get_dev_from_attrs+0x17a/0x660 [ovpn] [ 34.471551][ T759] genl_family_rcv_msg_doit+0x206/0x300 [ 34.471555][ T759] ? genl_family_rcv_msg_attrs_parse.isra.0+0x330/0x330 [ 34.471557][ T759] ? rcu_is_watching+0x16/0xd0 [ 34.471560][ T759] ? rcu_is_watching+0x16/0xd0 [ 34.471561][ T759] ? cap_capable+0x1d7/0x3d0 [ 34.471565][ T759] ? write_profile+0xf0/0xf0 [ 34.471566][ T759] ? unwind_get_return_address+0x67/0xd0 [ 34.471567][ T759] genl_family_rcv_msg+0x3a4/0x640 [ 34.471570][ T759] ? genl_family_rcv_msg_dumpit+0x340/0x340 [ 34.471572][ T759] ? ovpn_nl_send_peer+0x1300/0x1300 [ovpn] [ 34.471574][ T759] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 34.471576][ T759] ? ovpn_nl_pre_doit+0x90/0x90 [ovpn] [ 34.471578][ T759] ? filter_irq_stacks+0xd0/0xd0 [ 34.471580][ T759] ? stack_depot_save_flags+0x1bc/0x790 [ 34.471582][ T759] genl_rcv_msg+0xbb/0x160 [ 34.471584][ T759] netlink_rcv_skb+0x14e/0x3a0 [ 34.471586][ T759] ? genl_family_rcv_msg+0x640/0x640 [ 34.471588][ T759] ? netlink_ack+0xcf0/0xcf0 [ 34.471591][ T759] ? lock_acquire+0x13c/0x160 [ 34.471592][ T759] ? rcu_is_watching+0x16/0xd0 [ 34.471594][ T759] ? lock_release+0x184/0x1f0 [ 34.471596][ T759] genl_rcv+0x28/0x40 [ 34.471597][ T759] netlink_unicast+0x486/0x750 [ 34.471600][ T759] ? netlink_attachskb+0x810/0x810 [ 34.471601][ T759] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 34.471603][ T759] ? trace_hardirqs_on+0x36/0x40 [ 34.471604][ T759] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 34.471607][ T759] netlink_sendmsg+0x735/0xc60 [ 34.471609][ T759] ? netlink_unicast+0x750/0x750 [ 34.471611][ T759] ? rcu_is_watching+0x16/0xd0 [ 34.471613][ T759] ? lock_release+0x184/0x1f0 [ 34.471615][ T759] ____sys_sendmsg+0x415/0x880 [ 34.471618][ T759] ? copy_msghdr_from_user+0x279/0x420 [ 34.471620][ T759] ? get_timestamp.constprop.0+0x390/0x390 [ 34.471621][ T759] ? move_addr_to_kernel+0x40/0x40 [ 34.471624][ T759] ___sys_sendmsg+0x14e/0x1d0 [ 34.471626][ T759] ? copy_msghdr_from_user+0x420/0x420 [ 34.471627][ T759] ? kfree+0x22/0x590 [ 34.471632][ T759] __sys_sendmsg+0x12c/0x1d0 [ 34.471634][ T759] ? __sys_sendmsg_sock+0x20/0x20 [ 34.471637][ T759] ? rcu_is_watching+0x16/0xd0 [ 34.471638][ T759] ? rcu_is_watching+0x16/0xd0 [ 34.471640][ T759] do_syscall_64+0xff/0x530 [ 34.471643][ T759] ? exc_page_fault+0xee/0x100 [ 34.471645][ T759] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 34.471647][ T759] RIP: 0033:0x7fa89cdcd54e [ 34.471648][ T759] 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 [ 34.471650][ T759] RSP: 002b:00007ffea2f9b1c0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 34.471653][ T759] RAX: ffffffffffffffda RBX: 00000000028a3130 RCX: 00007fa89cdcd54e [ 34.471655][ T759] RDX: 0000000000000000 RSI: 00007ffea2f9b260 RDI: 0000000000000005 [ 34.471658][ T759] RBP: 00007ffea2f9b1d0 R08: 0000000000000000 R09: 0000000000000000 [ 34.471659][ T759] R10: 0000000000000000 R11: 0000000000000202 R12: 00000000028a3200 [ 34.471660][ T759] R13: 00007ffea2f9b260 R14: 00000000028a4260 R15: 000000000040bda8 [ 34.471662][ T759] [ 34.550296][ T763] tun2: deleting peer with id 2, reason 1 [ 39.149674][ T10] tun0: deleting peer with id 4, reason 2 [ 39.149689][ T10] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 39.149691][ T10] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 10, name: kworker/0:1 [ 39.149693][ T10] preempt_count: 202, expected: 0 [ 39.149694][ T10] RCU nest depth: 0, expected: 0 [ 39.149694][ T10] INFO: lockdep is turned off. [ 39.149695][ T10] irq event stamp: 16068 [ 39.149696][ T10] hardirqs last enabled at (16067): [] _raw_spin_unlock_irq+0x28/0x50 [ 39.149704][ T10] hardirqs last disabled at (16068): [] __schedule+0x1246/0x20e0 [ 39.149707][ T10] softirqs last enabled at (15910): [] handle_softirqs+0x67c/0x900 [ 39.149710][ T10] softirqs last disabled at (15871): [] do_softirq+0xac/0xe0 [ 39.149712][ T10] Preemption disabled at: [ 39.149713][ T10] [<0000000000000000>] 0x0 [ 39.149719][ T10] CPU: 0 UID: 0 PID: 10 Comm: kworker/0:1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 39.149722][ T10] Tainted: [W]=WARN [ 39.149723][ T10] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 39.149725][ T10] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 39.149733][ T10] Call Trace: [ 39.149734][ T10] [ 39.149735][ T10] dump_stack_lvl+0x6f/0xa0 [ 39.149741][ T10] __might_resched.cold+0x1fe/0x2c1 [ 39.149744][ T10] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 39.149747][ T10] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 39.149750][ T10] ? rcu_is_watching+0x16/0xd0 [ 39.149754][ T10] __kmalloc_noprof+0x443/0x760 [ 39.149757][ T10] ? __rwlock_init+0x150/0x150 [ 39.149760][ T10] ? alloc_buf.isra.0+0x4b/0x260 [ 39.149763][ T10] ? do_raw_spin_unlock+0x59/0x250 [ 39.149765][ T10] alloc_buf.isra.0+0x4b/0x260 [ 39.149767][ T10] put_chars+0x1e1/0x2f0 [ 39.149769][ T10] ? prb_final_commit+0x50/0x50 [ 39.149770][ T10] ? __send_to_port+0x420/0x420 [ 39.149772][ T10] ? printk_get_next_message+0x240/0x650 [ 39.149775][ T10] hvc_console_print+0x292/0x780 [ 39.149779][ T10] ? hvc_write+0x3a0/0x3a0 [ 39.149780][ T10] ? do_raw_spin_lock+0x131/0x280 [ 39.149782][ T10] ? vsnprintf+0x527/0x1700 [ 39.149784][ T10] ? __rwlock_init+0x150/0x150 [ 39.149786][ T10] ? rcu_is_watching+0x16/0xd0 [ 39.149787][ T10] ? lock_acquire+0x13c/0x160 [ 39.149790][ T10] console_emit_next_record+0x22f/0x4c0 [ 39.149792][ T10] ? devkmsg_read+0x4b0/0x4b0 [ 39.149794][ T10] ? rcu_is_watching+0x16/0xd0 [ 39.149796][ T10] ? rcu_is_watching+0x16/0xd0 [ 39.149797][ T10] ? rcu_is_watching+0x16/0xd0 [ 39.149799][ T10] ? lock_acquire+0x13c/0x160 [ 39.149801][ T10] ? console_flush_one_record+0x111/0x710 [ 39.149802][ T10] console_flush_one_record+0x46f/0x710 [ 39.149805][ T10] ? console_emit_next_record+0x4c0/0x4c0 [ 39.149807][ T10] console_unlock+0xee/0x1f0 [ 39.149809][ T10] ? lock_acquire+0x13c/0x160 [ 39.149810][ T10] ? console_flush_one_record+0x710/0x710 [ 39.149812][ T10] ? rcu_is_watching+0x16/0xd0 [ 39.149813][ T10] ? lock_release+0x184/0x1f0 [ 39.149815][ T10] ? lock_acquire+0x60/0x160 [ 39.149816][ T10] ? __rcu_read_lock+0x30/0x70 [ 39.149818][ T10] ? __down_trylock_console_sem+0x5e/0xa0 [ 39.149820][ T10] ? vprintk_emit+0x320/0x3e0 [ 39.149822][ T10] vprintk_emit+0x37c/0x3e0 [ 39.149824][ T10] ? wake_up_klogd_work_func+0x90/0x90 [ 39.149827][ T10] ? arch_stack_walk+0xd7/0x130 [ 39.149830][ T10] _printk+0xc7/0x100 [ 39.149833][ T10] ? snapshot_read.cold+0x21/0x21 [ 39.149834][ T10] ? ret_from_fork_asm+0x11/0x20 [ 39.149837][ T10] ? nfc_urelease_event_work+0x1d4/0x2d0 [ 39.149840][ T10] ? stack_trace_save+0x93/0xc0 [ 39.149842][ T10] ? netdev_name+0x43/0x60 [ 39.149844][ T10] ? __netdev_printk+0x17f/0x1d0 [ 39.149846][ T10] netdev_info+0xe2/0x116 [ 39.149848][ T10] ? netdev_notice+0x120/0x120 [ 39.149849][ T10] ? kasan_save_track+0x14/0x30 [ 39.149852][ T10] ? kasan_save_free_info+0x3b/0x60 [ 39.149854][ T10] ? process_one_work+0xe3e/0x1560 [ 39.149857][ T10] ? worker_thread+0x4f1/0xd60 [ 39.149859][ T10] ? kthread+0x367/0x460 [ 39.149861][ T10] ? ret_from_fork+0x474/0x6b0 [ 39.149862][ T10] ? ret_from_fork_asm+0x11/0x20 [ 39.149864][ T10] ? trace_irq_enable.constprop.0+0x30/0x160 [ 39.149867][ T10] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 39.149871][ T10] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 39.149873][ T10] ? rcu_is_watching+0x16/0xd0 [ 39.149875][ T10] ? lock_release+0x184/0x1f0 [ 39.149876][ T10] ? do_raw_spin_unlock+0x59/0x250 [ 39.149878][ T10] ovpn_peer_remove+0x394/0x640 [ovpn] [ 39.149882][ T10] ? do_raw_spin_lock+0x131/0x280 [ 39.149883][ T10] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 39.149886][ T10] ? __rwlock_init+0x150/0x150 [ 39.149887][ T10] ? rcu_is_watching+0x16/0xd0 [ 39.149889][ T10] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 39.149890][ T10] ? trace_irq_disable.constprop.0+0x9b/0x160 [ 39.149892][ T10] ovpn_peer_keepalive_work_single+0x416/0x600 [ovpn] [ 39.149895][ T10] ? ovpn_peers_release_mp+0x490/0x490 [ovpn] [ 39.149897][ T10] ? __rwlock_init+0x150/0x150 [ 39.149900][ T10] ovpn_peer_keepalive_work+0x253/0x580 [ovpn] [ 39.149903][ T10] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 39.149905][ T10] ? ovpn_peers_free+0xb0/0xb0 [ovpn] [ 39.149907][ T10] ? rcu_is_watching+0x16/0xd0 [ 39.149909][ T10] ? lock_acquire+0x13c/0x160 [ 39.149910][ T10] ? rcu_is_watching+0x16/0xd0 [ 39.149912][ T10] process_one_work+0xe3e/0x1560 [ 39.149915][ T10] ? __queue_delayed_work+0x470/0x470 [ 39.149917][ T10] ? __rwlock_init+0x150/0x150 [ 39.149920][ T10] worker_thread+0x4f1/0xd60 [ 39.149922][ T10] ? rescuer_thread+0x1340/0x1340 [ 39.149924][ T10] ? __kthread_parkme+0xbd/0x210 [ 39.149925][ T10] ? rescuer_thread+0x1340/0x1340 [ 39.149927][ T10] ? rescuer_thread+0x1340/0x1340 [ 39.149928][ T10] kthread+0x367/0x460 [ 39.149930][ T10] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 39.149931][ T10] ? kthread_affine_preferred+0x4c0/0x4c0 [ 39.149933][ T10] ret_from_fork+0x474/0x6b0 [ 39.149935][ T10] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 39.149936][ T10] ? __switch_to+0x5a3/0xe00 [ 39.149939][ T10] ? kthread_affine_preferred+0x4c0/0x4c0 [ 39.149940][ T10] ret_from_fork_asm+0x11/0x20 [ 39.149943][ T10] [ 39.168380][ T10] tun0: deleting peer with id 3, reason 2 [ 39.168544][ T10] tun0: deleting peer with id 5, reason 2 [ 40.173668][ T10] tun0: deleting peer with id 6, reason 2 [ 40.173674][ T10] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 40.173676][ T10] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 10, name: kworker/0:1 [ 40.173677][ T10] preempt_count: 202, expected: 0 [ 40.173678][ T10] RCU nest depth: 0, expected: 0 [ 40.173679][ T10] INFO: lockdep is turned off. [ 40.173680][ T10] irq event stamp: 16068 [ 40.173680][ T10] hardirqs last enabled at (16067): [] _raw_spin_unlock_irq+0x28/0x50 [ 40.173686][ T10] hardirqs last disabled at (16068): [] __schedule+0x1246/0x20e0 [ 40.173688][ T10] softirqs last enabled at (15910): [] handle_softirqs+0x67c/0x900 [ 40.173692][ T10] softirqs last disabled at (15871): [] do_softirq+0xac/0xe0 [ 40.173694][ T10] Preemption disabled at: [ 40.173694][ T10] [<0000000000000000>] 0x0 [ 40.173699][ T10] CPU: 0 UID: 0 PID: 10 Comm: kworker/0:1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 40.173702][ T10] Tainted: [W]=WARN [ 40.173702][ T10] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 40.173704][ T10] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 40.173709][ T10] Call Trace: [ 40.173711][ T10] [ 40.173712][ T10] dump_stack_lvl+0x6f/0xa0 [ 40.173716][ T10] __might_resched.cold+0x1fe/0x2c1 [ 40.173719][ T10] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 40.173722][ T10] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 40.173724][ T10] ? rcu_is_watching+0x16/0xd0 [ 40.173728][ T10] __kmalloc_noprof+0x443/0x760 [ 40.173731][ T10] ? __rwlock_init+0x150/0x150 [ 40.173733][ T10] ? alloc_buf.isra.0+0x4b/0x260 [ 40.173736][ T10] ? do_raw_spin_unlock+0x59/0x250 [ 40.173737][ T10] alloc_buf.isra.0+0x4b/0x260 [ 40.173739][ T10] put_chars+0x1e1/0x2f0 [ 40.173741][ T10] ? prb_final_commit+0x50/0x50 [ 40.173742][ T10] ? __send_to_port+0x420/0x420 [ 40.173744][ T10] ? printk_get_next_message+0x240/0x650 [ 40.173747][ T10] hvc_console_print+0x292/0x780 [ 40.173750][ T10] ? hvc_write+0x3a0/0x3a0 [ 40.173751][ T10] ? do_raw_spin_lock+0x131/0x280 [ 40.173753][ T10] ? vsnprintf+0x527/0x1700 [ 40.173754][ T10] ? __rwlock_init+0x150/0x150 [ 40.173756][ T10] ? rcu_is_watching+0x16/0xd0 [ 40.173758][ T10] ? lock_acquire+0x13c/0x160 [ 40.173760][ T10] console_emit_next_record+0x22f/0x4c0 [ 40.173762][ T10] ? devkmsg_read+0x4b0/0x4b0 [ 40.173764][ T10] ? rcu_is_watching+0x16/0xd0 [ 40.173766][ T10] ? rcu_is_watching+0x16/0xd0 [ 40.173767][ T10] ? rcu_is_watching+0x16/0xd0 [ 40.173769][ T10] ? lock_acquire+0x13c/0x160 [ 40.173770][ T10] ? console_flush_one_record+0x111/0x710 [ 40.173772][ T10] console_flush_one_record+0x46f/0x710 [ 40.173774][ T10] ? console_emit_next_record+0x4c0/0x4c0 [ 40.173777][ T10] console_unlock+0xee/0x1f0 [ 40.173778][ T10] ? lock_acquire+0x13c/0x160 [ 40.173780][ T10] ? console_flush_one_record+0x710/0x710 [ 40.173781][ T10] ? rcu_is_watching+0x16/0xd0 [ 40.173783][ T10] ? lock_release+0x184/0x1f0 [ 40.173784][ T10] ? lock_acquire+0x60/0x160 [ 40.173786][ T10] ? __rcu_read_lock+0x30/0x70 [ 40.173788][ T10] ? __down_trylock_console_sem+0x5e/0xa0 [ 40.173789][ T10] ? vprintk_emit+0x320/0x3e0 [ 40.173791][ T10] vprintk_emit+0x37c/0x3e0 [ 40.173793][ T10] ? wake_up_klogd_work_func+0x90/0x90 [ 40.173795][ T10] ? arch_stack_walk+0xd7/0x130 [ 40.173798][ T10] _printk+0xc7/0x100 [ 40.173801][ T10] ? snapshot_read.cold+0x21/0x21 [ 40.173803][ T10] ? stack_trace_save+0x93/0xc0 [ 40.173805][ T10] ? filter_irq_stacks+0xd0/0xd0 [ 40.173806][ T10] ? netdev_name+0x43/0x60 [ 40.173809][ T10] ? __netdev_printk+0x17f/0x1d0 [ 40.173810][ T10] netdev_info+0xe2/0x116 [ 40.173812][ T10] ? netdev_notice+0x120/0x120 [ 40.173813][ T10] ? kasan_save_track+0x14/0x30 [ 40.173816][ T10] ? kmem_cache_free+0xf8/0x550 [ 40.173817][ T10] ? free_object_list.isra.0+0x1b6/0x310 [ 40.173821][ T10] ? kthread+0x367/0x460 [ 40.173823][ T10] ? ret_from_fork+0x474/0x6b0 [ 40.173824][ T10] ? ret_from_fork_asm+0x11/0x20 [ 40.173827][ T10] ? trace_irq_enable.constprop.0+0x30/0x160 [ 40.173829][ T10] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 40.173833][ T10] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 40.173835][ T10] ? __rwlock_init+0x150/0x150 [ 40.173837][ T10] ? lock_acquire+0x13c/0x160 [ 40.173838][ T10] ? rcu_is_watching+0x16/0xd0 [ 40.173840][ T10] ovpn_peer_remove+0x394/0x640 [ovpn] [ 40.173843][ T10] ? do_raw_spin_lock+0x131/0x280 [ 40.173844][ T10] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 40.173847][ T10] ? __rwlock_init+0x150/0x150 [ 40.173848][ T10] ? rcu_is_watching+0x16/0xd0 [ 40.173850][ T10] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 40.173851][ T10] ? trace_irq_disable.constprop.0+0x9b/0x160 [ 40.173853][ T10] ovpn_peer_keepalive_work_single+0x416/0x600 [ovpn] [ 40.173855][ T10] ? ovpn_peers_release_mp+0x490/0x490 [ovpn] [ 40.173858][ T10] ? __rwlock_init+0x150/0x150 [ 40.173860][ T10] ovpn_peer_keepalive_work+0x253/0x580 [ovpn] [ 40.173863][ T10] ? ovpn_peers_free+0xb0/0xb0 [ovpn] [ 40.173865][ T10] ? rcu_is_watching+0x16/0xd0 [ 40.173867][ T10] ? lock_acquire+0x13c/0x160 [ 40.173868][ T10] ? rcu_is_watching+0x16/0xd0 [ 40.173871][ T10] process_one_work+0xe3e/0x1560 [ 40.173874][ T10] ? __queue_delayed_work+0x470/0x470 [ 40.173877][ T10] ? __rwlock_init+0x150/0x150 [ 40.173879][ T10] worker_thread+0x4f1/0xd60 [ 40.173881][ T10] ? rescuer_thread+0x1340/0x1340 [ 40.173883][ T10] ? __kthread_parkme+0xbd/0x210 [ 40.173884][ T10] ? rescuer_thread+0x1340/0x1340 [ 40.173886][ T10] ? rescuer_thread+0x1340/0x1340 [ 40.173888][ T10] kthread+0x367/0x460 [ 40.173889][ T10] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 40.173890][ T10] ? kthread_affine_preferred+0x4c0/0x4c0 [ 40.173892][ T10] ret_from_fork+0x474/0x6b0 [ 40.173894][ T10] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 40.173895][ T10] ? __switch_to+0x5a3/0xe00 [ 40.173898][ T10] ? kthread_affine_preferred+0x4c0/0x4c0 [ 40.173899][ T10] ret_from_fork_asm+0x11/0x20 [ 40.173902][ T10] [ 45.229683][ T50] tun3: deleting peer with id 3, reason 2 [ 45.229696][ T50] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 45.229698][ T50] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 50, name: kworker/3:1 [ 45.229699][ T50] preempt_count: 202, expected: 0 [ 45.229700][ T50] RCU nest depth: 0, expected: 0 [ 45.229702][ T50] INFO: lockdep is turned off. [ 45.229702][ T50] irq event stamp: 30436 [ 45.229703][ T50] hardirqs last enabled at (30435): [] _raw_spin_unlock_irq+0x28/0x50 [ 45.229710][ T50] hardirqs last disabled at (30436): [] __schedule+0x1246/0x20e0 [ 45.229713][ T50] softirqs last enabled at (30228): [] handle_softirqs+0x67c/0x900 [ 45.229717][ T50] softirqs last disabled at (30189): [] do_softirq+0xac/0xe0 [ 45.229719][ T50] Preemption disabled at: [ 45.229720][ T50] [<0000000000000000>] 0x0 [ 45.229726][ T50] CPU: 3 UID: 0 PID: 50 Comm: kworker/3:1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 45.229729][ T50] Tainted: [W]=WARN [ 45.229730][ T50] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 45.229732][ T50] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 45.229738][ T50] Call Trace: [ 45.229740][ T50] [ 45.229741][ T50] dump_stack_lvl+0x6f/0xa0 [ 45.229746][ T50] __might_resched.cold+0x1fe/0x2c1 [ 45.229750][ T50] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 45.229753][ T50] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 45.229755][ T50] ? rcu_is_watching+0x16/0xd0 [ 45.229759][ T50] __kmalloc_noprof+0x443/0x760 [ 45.229762][ T50] ? __rwlock_init+0x150/0x150 [ 45.229764][ T50] ? alloc_buf.isra.0+0x4b/0x260 [ 45.229768][ T50] ? do_raw_spin_unlock+0x59/0x250 [ 45.229769][ T50] alloc_buf.isra.0+0x4b/0x260 [ 45.229771][ T50] put_chars+0x1e1/0x2f0 [ 45.229773][ T50] ? prb_final_commit+0x50/0x50 [ 45.229774][ T50] ? __send_to_port+0x420/0x420 [ 45.229776][ T50] ? printk_get_next_message+0x240/0x650 [ 45.229779][ T50] hvc_console_print+0x292/0x780 [ 45.229782][ T50] ? hvc_write+0x3a0/0x3a0 [ 45.229784][ T50] ? do_raw_spin_lock+0x131/0x280 [ 45.229785][ T50] ? vsnprintf+0x527/0x1700 [ 45.229787][ T50] ? __rwlock_init+0x150/0x150 [ 45.229789][ T50] ? rcu_is_watching+0x16/0xd0 [ 45.229791][ T50] ? lock_acquire+0x13c/0x160 [ 45.229793][ T50] console_emit_next_record+0x22f/0x4c0 [ 45.229795][ T50] ? devkmsg_read+0x4b0/0x4b0 [ 45.229797][ T50] ? rcu_is_watching+0x16/0xd0 [ 45.229799][ T50] ? rcu_is_watching+0x16/0xd0 [ 45.229801][ T50] ? rcu_is_watching+0x16/0xd0 [ 45.229802][ T50] ? lock_acquire+0x13c/0x160 [ 45.229804][ T50] ? console_flush_one_record+0x111/0x710 [ 45.229806][ T50] console_flush_one_record+0x46f/0x710 [ 45.229808][ T50] ? console_emit_next_record+0x4c0/0x4c0 [ 45.229811][ T50] console_unlock+0xee/0x1f0 [ 45.229812][ T50] ? lock_acquire+0x13c/0x160 [ 45.229814][ T50] ? console_flush_one_record+0x710/0x710 [ 45.229815][ T50] ? rcu_is_watching+0x16/0xd0 [ 45.229817][ T50] ? lock_release+0x184/0x1f0 [ 45.229818][ T50] ? lock_acquire+0x60/0x160 [ 45.229820][ T50] ? __rcu_read_lock+0x30/0x70 [ 45.229822][ T50] ? __down_trylock_console_sem+0x5e/0xa0 [ 45.229823][ T50] ? vprintk_emit+0x320/0x3e0 [ 45.229825][ T50] vprintk_emit+0x37c/0x3e0 [ 45.229828][ T50] ? wake_up_klogd_work_func+0x90/0x90 [ 45.229829][ T50] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 45.229831][ T50] ? rcu_is_watching+0x16/0xd0 [ 45.229832][ T50] ? trace_sched_wakeup+0x9b/0x160 [ 45.229835][ T50] _printk+0xc7/0x100 [ 45.229838][ T50] ? snapshot_read.cold+0x21/0x21 [ 45.229839][ T50] ? try_to_wake_up+0x153/0x1130 [ 45.229841][ T50] ? select_fallback_rq+0x510/0x510 [ 45.229843][ T50] ? netdev_name+0x43/0x60 [ 45.229845][ T50] ? __netdev_printk+0x17f/0x1d0 [ 45.229847][ T50] netdev_info+0xe2/0x116 [ 45.229849][ T50] ? netdev_notice+0x120/0x120 [ 45.229850][ T50] ? rcu_is_watching+0x16/0xd0 [ 45.229853][ T50] ? __queue_work+0x3ab/0xd30 [ 45.229855][ T50] ? kthread+0x367/0x460 [ 45.229857][ T50] ? trace_irq_enable.constprop.0+0x30/0x160 [ 45.229860][ T50] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 45.229863][ T50] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 45.229866][ T50] ? rcu_is_watching+0x16/0xd0 [ 45.229868][ T50] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 45.229869][ T50] ovpn_peer_remove+0x394/0x640 [ovpn] [ 45.229873][ T50] ? do_raw_spin_lock+0x131/0x280 [ 45.229874][ T50] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 45.229877][ T50] ? __rwlock_init+0x150/0x150 [ 45.229878][ T50] ? rcu_is_watching+0x16/0xd0 [ 45.229880][ T50] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 45.229881][ T50] ? trace_irq_disable.constprop.0+0x9b/0x160 [ 45.229883][ T50] ovpn_peer_keepalive_work_single+0x416/0x600 [ovpn] [ 45.229886][ T50] ? ovpn_peers_release_mp+0x490/0x490 [ovpn] [ 45.229888][ T50] ? __rwlock_init+0x150/0x150 [ 45.229890][ T50] ovpn_peer_keepalive_work+0x389/0x580 [ovpn] [ 45.229893][ T50] ? ovpn_peers_free+0xb0/0xb0 [ovpn] [ 45.229895][ T50] ? rcu_is_watching+0x16/0xd0 [ 45.229897][ T50] ? lock_acquire+0x13c/0x160 [ 45.229899][ T50] ? rcu_is_watching+0x16/0xd0 [ 45.229901][ T50] ? process_one_work+0xdfc/0x1560 [ 45.229902][ T50] process_one_work+0xe3e/0x1560 [ 45.229905][ T50] ? __queue_delayed_work+0x470/0x470 [ 45.229908][ T50] ? __rwlock_init+0x150/0x150 [ 45.229910][ T50] worker_thread+0x4f1/0xd60 [ 45.229912][ T50] ? rescuer_thread+0x1340/0x1340 [ 45.229914][ T50] ? __kthread_parkme+0xbd/0x210 [ 45.229915][ T50] ? rescuer_thread+0x1340/0x1340 [ 45.229917][ T50] ? rescuer_thread+0x1340/0x1340 [ 45.229919][ T50] kthread+0x367/0x460 [ 45.229920][ T50] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 45.229922][ T50] ? kthread_affine_preferred+0x4c0/0x4c0 [ 45.229923][ T50] ret_from_fork+0x474/0x6b0 [ 45.229926][ T50] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 45.229928][ T50] ? __switch_to+0x5a3/0xe00 [ 45.229930][ T50] ? kthread_affine_preferred+0x4c0/0x4c0 [ 45.229932][ T50] ret_from_fork_asm+0x11/0x20 [ 45.229936][ T50] [ 45.293679][ T10] tun4: deleting peer with id 4, reason 2 [ 45.357675][ T50] tun5: deleting peer with id 5, reason 2 [ 45.422676][ T50] tun6: deleting peer with id 6, reason 2