[ 17.070358][ T310] ip (310) used greatest stack depth: 24048 bytes left [ 17.070374][ T310] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 17.070376][ T310] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 310, name: ip [ 17.070377][ T310] preempt_count: 2, expected: 0 [ 17.070378][ T310] RCU nest depth: 0, expected: 0 [ 17.070379][ T310] locks held by ip/310: 5, last CPU#0: [ 17.070382][ T310] #0: ffffffff9e6127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 17.070393][ T310] #1: ffffffff9e779cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 17.070399][ T310] #2: ffffffff9e779d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 17.070402][ T310] #3: ffffffff9e699660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 17.070406][ T310] #4: ffffffff9e699560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 17.070410][ T310] irq event stamp: 32144 [ 17.070411][ T310] hardirqs last enabled at (32143): [] __down_trylock_console_sem+0x86/0xa0 [ 17.070414][ T310] hardirqs last disabled at (32144): [] console_emit_next_record+0x3d4/0x4c0 [ 17.070416][ T310] softirqs last enabled at (30862): [] netlink_release+0x17b/0xcf0 [ 17.070420][ T310] softirqs last disabled at (30860): [] netlink_release+0xd2/0xcf0 [ 17.070422][ T310] Preemption disabled at: [ 17.070423][ T310] [<0000000000000000>] 0x0 [ 17.070430][ T310] CPU: 0 UID: 0 PID: 310 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 17.070433][ T310] Tainted: [W]=WARN [ 17.070434][ T310] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 17.070436][ T310] Call Trace: [ 17.070437][ T310] [ 17.070439][ T310] dump_stack_lvl+0x6f/0xa0 [ 17.070445][ T310] __might_resched.cold+0x1fe/0x2c1 [ 17.070450][ T310] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 17.070454][ T310] ? __kmalloc_noprof+0xdb/0x760 [ 17.070459][ T310] __kmalloc_noprof+0x443/0x760 [ 17.070461][ T310] ? alloc_buf.isra.0+0x4b/0x260 [ 17.070467][ T310] ? do_raw_spin_unlock+0x59/0x250 [ 17.070470][ T310] alloc_buf.isra.0+0x4b/0x260 [ 17.070473][ T310] put_chars+0x1e1/0x2f0 [ 17.070476][ T310] ? __send_to_port+0x420/0x420 [ 17.070478][ T310] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 17.070483][ T310] ? validate_chain+0x38b/0xc20 [ 17.070489][ T310] hvc_console_print+0x292/0x780 [ 17.070496][ T310] ? hvc_write+0x3a0/0x3a0 [ 17.070498][ T310] ? rcu_is_watching+0x16/0xd0 [ 17.070500][ T310] ? lock_acquire+0x13c/0x160 [ 17.070504][ T310] console_emit_next_record+0x22f/0x4c0 [ 17.070508][ T310] ? devkmsg_read+0x4b0/0x4b0 [ 17.070510][ T310] ? console_flush_one_record+0x106/0x710 [ 17.070513][ T310] ? rcu_is_watching+0x16/0xd0 [ 17.070516][ T310] ? lock_acquire+0x13c/0x160 [ 17.070520][ T310] console_flush_one_record+0x46f/0x710 [ 17.070524][ T310] ? console_emit_next_record+0x4c0/0x4c0 [ 17.070526][ T310] ? __lock_acquire+0x518/0xc20 [ 17.070531][ T310] console_unlock+0xee/0x1f0 [ 17.070534][ T310] ? console_flush_one_record+0x710/0x710 [ 17.070536][ T310] ? rcu_is_watching+0x16/0xd0 [ 17.070538][ T310] ? lock_acquire+0x60/0x160 [ 17.070541][ T310] ? __down_trylock_console_sem+0x5e/0xa0 [ 17.070543][ T310] ? vprintk_emit+0x320/0x3e0 [ 17.070547][ T310] vprintk_emit+0x37c/0x3e0 [ 17.070550][ T310] ? wake_up_klogd_work_func+0x90/0x90 [ 17.070554][ T310] ? __lock_acquire+0x518/0xc20 [ 17.070558][ T310] _printk+0xc7/0x100 [ 17.070561][ T310] ? snapshot_read.cold+0x21/0x21 [ 17.070564][ T310] ? do_raw_spin_lock+0x131/0x280 [ 17.070567][ T310] ? __rwlock_init+0x150/0x150 [ 17.070571][ T310] ? do_raw_spin_lock+0x131/0x280 [ 17.070573][ T310] do_exit.cold+0x82/0x9c [ 17.070577][ T310] ? exit_notify+0x890/0x890 [ 17.070579][ T310] ? __lock_release.isra.0+0x69/0x1a0 [ 17.070581][ T310] ? rcu_is_watching+0x16/0xd0 [ 17.070586][ T310] do_group_exit+0xb8/0x370 [ 17.070589][ T310] __x64_sys_exit_group+0x3c/0x50 [ 17.070590][ T310] x64_sys_call+0x1567/0x1570 [ 17.070593][ T310] do_syscall_64+0xff/0x530 [ 17.070597][ T310] ? exc_page_fault+0xee/0x100 [ 17.070600][ T310] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 17.070602][ T310] RIP: 0033:0x7ff15882e1b8 [ 17.070604][ T310] Code: Unable to access opcode bytes at 0x7ff15882e18e. [ 17.070605][ T310] RSP: 002b:00007ffdfcce8c68 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 17.070608][ T310] RAX: ffffffffffffffda RBX: 00007ff15895ef88 RCX: 00007ff15882e1b8 [ 17.070609][ T310] RDX: 00007ff158578fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 17.070610][ T310] RBP: 00007ffdfcce8cc0 R08: 0000000000000000 R09: 0000000000000000 [ 17.070611][ T310] R10: 00007ffdfcce8a80 R11: 0000000000000246 R12: 0000000000000001 [ 17.070612][ T310] R13: 0000000000000000 R14: 00007ff15895d680 R15: 00007ff15895efa0 [ 17.070619][ T310] [ 17.333806][ T317] ip (317) used greatest stack depth: 23920 bytes left [ 24.712665][ C0] tun0: no available key for peer 2, key-id: 0 [ 24.712715][ C0] [ 24.712717][ C0] ======================================================== [ 24.712719][ C0] WARNING: possible irq lock inversion dependency detected [ 24.712721][ C0] 7.2.0-virtme #1 Tainted: G W [ 24.712723][ C0] -------------------------------------------------------- [ 24.712724][ C0] ovpn-cli/405 just changed the state of lock: [ 24.712726][ C0] ffffffff9e699660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 24.712742][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 24.712743][ C0] (fs_reclaim){+.+.}-{0:0} [ 24.712746][ C0] [ 24.712746][ C0] [ 24.712746][ C0] and interrupts could create inverse lock ordering between them. [ 24.712746][ C0] [ 24.712747][ C0] [ 24.712747][ C0] other info that might help us debug this: [ 24.712748][ C0] Possible interrupt unsafe locking scenario: [ 24.712748][ C0] [ 24.712749][ C0] CPU0 CPU1 [ 24.712750][ C0] ---- ---- [ 24.712751][ C0] lock(fs_reclaim); [ 24.712752][ C0] local_irq_disable(); [ 24.712753][ C0] lock(console_owner); [ 24.712755][ C0] lock(fs_reclaim); [ 24.712757][ C0] [ 24.712757][ C0] lock(console_owner); [ 24.712759][ C0] [ 24.712759][ C0] *** DEADLOCK *** [ 24.712759][ C0] [ 24.712760][ C0] locks held by ovpn-cli/405: 6, last CPU#0: [ 24.712762][ C0] #0: ffffffff9e790b00 (rcu_read_lock){....}-{1:3}, at: process_backlog+0x3f1/0x14c0 [ 24.712770][ C0] #1: ffffffff9e790b00 (rcu_read_lock){....}-{1:3}, at: ip_local_deliver_finish+0x2ba/0x610 [ 24.712777][ C0] #2: ff1100001a40b818 (slock-AF_INET/1){+.-.}-{3:3}, at: tcp_v4_rcv+0x1a81/0x2b70 [ 24.712784][ C0] #3: ffffffff9e790b00 (rcu_read_lock){....}-{1:3}, at: ovpn_tcp_data_ready+0x62/0x390 [ovpn] [ 24.712795][ C0] #4: ffffffff9e779cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 24.712800][ C0] #5: ffffffff9e779d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 24.712806][ C0] [ 24.712806][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 24.712818][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 24.712821][ C0] HARDIRQ-ON-W at: [ 24.712824][ C0] __lock_acquire+0x388/0xc20 [ 24.712827][ C0] lock_acquire.part.0+0xd4/0x280 [ 24.712830][ C0] fs_reclaim_acquire+0xd5/0x120 [ 24.712833][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 24.712836][ C0] kthread_create_worker_on_node+0xea/0x210 [ 24.712840][ C0] workqueue_init+0x2a/0x680 [ 24.712844][ C0] kernel_init_freeable+0x2fe/0x630 [ 24.712847][ C0] kernel_init+0x21/0x150 [ 24.712851][ C0] ret_from_fork+0x474/0x6b0 [ 24.712855][ C0] ret_from_fork_asm+0x11/0x20 [ 24.712859][ C0] SOFTIRQ-ON-W at: [ 24.712861][ C0] __lock_acquire+0x388/0xc20 [ 24.712863][ C0] lock_acquire.part.0+0xd4/0x280 [ 24.712865][ C0] fs_reclaim_acquire+0xd5/0x120 [ 24.712867][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 24.712869][ C0] kthread_create_worker_on_node+0xea/0x210 [ 24.712871][ C0] workqueue_init+0x2a/0x680 [ 24.712873][ C0] kernel_init_freeable+0x2fe/0x630 [ 24.712875][ C0] kernel_init+0x21/0x150 [ 24.712877][ C0] ret_from_fork+0x474/0x6b0 [ 24.712879][ C0] ret_from_fork_asm+0x11/0x20 [ 24.712881][ C0] INITIAL USE at: [ 24.712882][ C0] __lock_acquire+0x388/0xc20 [ 24.712884][ C0] lock_acquire.part.0+0xd4/0x280 [ 24.712886][ C0] fs_reclaim_acquire+0xd5/0x120 [ 24.712888][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 24.712890][ C0] kthread_create_worker_on_node+0xea/0x210 [ 24.712892][ C0] workqueue_init+0x2a/0x680 [ 24.712894][ C0] kernel_init_freeable+0x2fe/0x630 [ 24.712896][ C0] kernel_init+0x21/0x150 [ 24.712898][ C0] ret_from_fork+0x474/0x6b0 [ 24.712900][ C0] ret_from_fork_asm+0x11/0x20 [ 24.712902][ C0] } [ 24.712902][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 24.712907][ C0] ... acquired at: [ 24.712908][ C0] __lock_acquire+0x518/0xc20 [ 24.712910][ C0] lock_acquire.part.0+0xd4/0x280 [ 24.712912][ C0] fs_reclaim_acquire+0xd5/0x120 [ 24.712914][ C0] __kmalloc_noprof+0xd3/0x760 [ 24.712916][ C0] alloc_buf.isra.0+0x4b/0x260 [ 24.712920][ C0] put_chars+0x1e1/0x2f0 [ 24.712922][ C0] hvc_console_print+0x292/0x780 [ 24.712925][ C0] console_emit_next_record+0x22f/0x4c0 [ 24.712928][ C0] console_flush_one_record+0x46f/0x710 [ 24.712930][ C0] console_unlock+0xee/0x1f0 [ 24.712932][ C0] vprintk_emit+0x37c/0x3e0 [ 24.712935][ C0] dev_vprintk_emit+0x27f/0x2c0 [ 24.712939][ C0] dev_printk_emit+0xb9/0xee [ 24.712941][ C0] _dev_info+0xe2/0x116 [ 24.712944][ C0] cmos_do_probe+0x8be/0x98a [ 24.712947][ C0] platform_probe+0xfe/0x1f0 [ 24.712950][ C0] call_driver_probe+0x61/0x1c0 [ 24.712953][ C0] really_probe+0x199/0x760 [ 24.712955][ C0] __driver_probe_device+0x24f/0x440 [ 24.712958][ C0] driver_probe_device+0x4a/0xf0 [ 24.712960][ C0] __driver_attach+0x1b8/0x540 [ 24.712962][ C0] bus_for_each_dev+0x130/0x1e0 [ 24.712965][ C0] bus_add_driver+0x2c8/0x530 [ 24.712967][ C0] driver_register+0x1a3/0x390 [ 24.712969][ C0] __platform_driver_probe+0x13f/0x270 [ 24.712971][ C0] cmos_init+0x31/0x40 [ 24.712974][ C0] do_one_initcall+0x124/0x4f0 [ 24.712977][ C0] kernel_init_freeable+0x596/0x630 [ 24.712979][ C0] kernel_init+0x21/0x150 [ 24.712981][ C0] ret_from_fork+0x474/0x6b0 [ 24.712983][ C0] ret_from_fork_asm+0x11/0x20 [ 24.712985][ C0] [ 24.712985][ C0] -> (console_owner){..-.}-{0:0} { [ 24.712989][ C0] IN-SOFTIRQ-W at: [ 24.712990][ C0] __lock_acquire+0x388/0xc20 [ 24.712992][ C0] lock_acquire.part.0+0xd4/0x280 [ 24.712994][ C0] console_lock_spinning_enable+0x5c/0x60 [ 24.712996][ C0] console_emit_next_record+0x1d1/0x4c0 [ 24.712999][ C0] console_flush_one_record+0x46f/0x710 [ 24.713001][ C0] console_unlock+0xee/0x1f0 [ 24.713003][ C0] vprintk_emit+0x37c/0x3e0 [ 24.713006][ C0] _printk+0xc7/0x100 [ 24.713009][ C0] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 24.713015][ C0] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 24.713019][ C0] __strp_recv+0x20f/0x1c20 [ 24.713023][ C0] __tcp_read_sock+0x1c7/0x850 [ 24.713026][ C0] strp_read_sock+0x20f/0x2b0 [ 24.713028][ C0] strp_data_ready+0x18e/0x2c0 [ 24.713031][ C0] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 24.713035][ C0] tcp_rcv_established+0x1e1d/0x3910 [ 24.713038][ C0] tcp_v4_do_rcv+0x4f6/0xb90 [ 24.713040][ C0] tcp_v4_rcv+0x1caa/0x2b70 [ 24.713042][ C0] ip_protocol_deliver_rcu+0x82/0x350 [ 24.713044][ C0] ip_local_deliver_finish+0x36f/0x610 [ 24.713046][ C0] ip_local_deliver+0x184/0x4c0 [ 24.713048][ C0] ip_rcv+0xdc/0x3d0 [ 24.713050][ C0] __netif_receive_skb_one_core+0xfc/0x180 [ 24.713053][ C0] process_backlog+0x431/0x14c0 [ 24.713056][ C0] __napi_poll+0xa7/0x3b0 [ 24.713058][ C0] net_rx_action+0x513/0xf50 [ 24.713061][ C0] handle_softirqs+0x1d3/0x900 [ 24.713064][ C0] do_softirq+0xac/0xe0 [ 24.713066][ C0] __local_bh_enable_ip+0x118/0x150 [ 24.713068][ C0] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 24.713072][ C0] __sys_sendto+0x2aa/0x400 [ 24.713075][ C0] __x64_sys_sendto+0xe4/0x1f0 [ 24.713078][ C0] do_syscall_64+0xff/0x530 [ 24.713081][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 24.713083][ C0] INITIAL USE at: [ 24.713085][ C0] } [ 24.713086][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 24.713090][ C0] ... acquired at: [ 24.713091][ C0] mark_lock+0x1d7/0xa00 [ 24.713093][ C0] mark_usage+0x42/0x170 [ 24.713098][ C0] __lock_acquire+0x388/0xc20 [ 24.713100][ C0] lock_acquire.part.0+0xd4/0x280 [ 24.713102][ C0] console_lock_spinning_enable+0x5c/0x60 [ 24.713104][ C0] console_emit_next_record+0x1d1/0x4c0 [ 24.713107][ C0] console_flush_one_record+0x46f/0x710 [ 24.713109][ C0] console_unlock+0xee/0x1f0 [ 24.713111][ C0] vprintk_emit+0x37c/0x3e0 [ 24.713113][ C0] _printk+0xc7/0x100 [ 24.713116][ C0] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 24.713120][ C0] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 24.713124][ C0] __strp_recv+0x20f/0x1c20 [ 24.713126][ C0] __tcp_read_sock+0x1c7/0x850 [ 24.713128][ C0] strp_read_sock+0x20f/0x2b0 [ 24.713131][ C0] strp_data_ready+0x18e/0x2c0 [ 24.713133][ C0] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 24.713137][ C0] tcp_rcv_established+0x1e1d/0x3910 [ 24.713139][ C0] tcp_v4_do_rcv+0x4f6/0xb90 [ 24.713141][ C0] tcp_v4_rcv+0x1caa/0x2b70 [ 24.713144][ C0] ip_protocol_deliver_rcu+0x82/0x350 [ 24.713145][ C0] ip_local_deliver_finish+0x36f/0x610 [ 24.713148][ C0] ip_local_deliver+0x184/0x4c0 [ 24.713150][ C0] ip_rcv+0xdc/0x3d0 [ 24.713151][ C0] __netif_receive_skb_one_core+0xfc/0x180 [ 24.713154][ C0] process_backlog+0x431/0x14c0 [ 24.713156][ C0] __napi_poll+0xa7/0x3b0 [ 24.713159][ C0] net_rx_action+0x513/0xf50 [ 24.713161][ C0] handle_softirqs+0x1d3/0x900 [ 24.713163][ C0] do_softirq+0xac/0xe0 [ 24.713165][ C0] __local_bh_enable_ip+0x118/0x150 [ 24.713167][ C0] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 24.713171][ C0] __sys_sendto+0x2aa/0x400 [ 24.713173][ C0] __x64_sys_sendto+0xe4/0x1f0 [ 24.713175][ C0] do_syscall_64+0xff/0x530 [ 24.713177][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 24.713179][ C0] [ 24.713180][ C0] [ 24.713180][ C0] stack backtrace: [ 24.713184][ C0] CPU: 0 UID: 0 PID: 405 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 24.713188][ C0] Tainted: [W]=WARN [ 24.713190][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 24.713192][ C0] Call Trace: [ 24.713194][ C0] [ 24.713195][ C0] dump_stack_lvl+0x6f/0xa0 [ 24.713201][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 24.713205][ C0] mark_lock_irq+0x989/0x9c0 [ 24.713209][ C0] mark_lock+0x1d7/0xa00 [ 24.713212][ C0] mark_usage+0x42/0x170 [ 24.713215][ C0] __lock_acquire+0x388/0xc20 [ 24.713218][ C0] lock_acquire.part.0+0xd4/0x280 [ 24.713221][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 24.713224][ C0] ? rcu_is_watching+0x16/0xd0 [ 24.713229][ C0] ? lock_acquire+0x13c/0x160 [ 24.713232][ C0] console_lock_spinning_enable+0x5c/0x60 [ 24.713235][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 24.713237][ C0] console_emit_next_record+0x1d1/0x4c0 [ 24.713241][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 24.713243][ C0] ? console_flush_one_record+0x106/0x710 [ 24.713246][ C0] ? rcu_is_watching+0x16/0xd0 [ 24.713249][ C0] ? lock_acquire+0x13c/0x160 [ 24.713252][ C0] console_flush_one_record+0x46f/0x710 [ 24.713256][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 24.713258][ C0] ? __lock_acquire+0x518/0xc20 [ 24.713262][ C0] console_unlock+0xee/0x1f0 [ 24.713265][ C0] ? console_flush_one_record+0x710/0x710 [ 24.713267][ C0] ? rcu_is_watching+0x16/0xd0 [ 24.713270][ C0] ? lock_acquire+0x60/0x160 [ 24.713273][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 24.713275][ C0] ? vprintk_emit+0x320/0x3e0 [ 24.713278][ C0] vprintk_emit+0x37c/0x3e0 [ 24.713282][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 24.713285][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 24.713288][ C0] _printk+0xc7/0x100 [ 24.713291][ C0] ? snapshot_read.cold+0x21/0x21 [ 24.713293][ C0] ? ___ratelimit+0x4e7/0xa00 [ 24.713297][ C0] ? ovpn_netdev_write+0x730/0x730 [ovpn] [ 24.713303][ C0] ? idr_get_free+0x830/0x830 [ 24.713306][ C0] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 24.713311][ C0] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 24.713317][ C0] ? ovpn_tcp_write_space+0x2e0/0x2e0 [ovpn] [ 24.713321][ C0] ? __copy_skb_header+0xb7/0x510 [ 24.713325][ C0] ? ovpn_tcp_disconnect+0x10/0x10 [ovpn] [ 24.713329][ C0] ? sock_queue_err_skb+0xb0/0x680 [ 24.713332][ C0] __strp_recv+0x20f/0x1c20 [ 24.713337][ C0] __tcp_read_sock+0x1c7/0x850 [ 24.713340][ C0] ? strp_process+0xb0/0xb0 [ 24.713343][ C0] ? __tcp_transmit_skb+0x1b6e/0x3c10 [ 24.713346][ C0] ? tcp_cleanup_rbuf+0x1c0/0x1c0 [ 24.713348][ C0] ? mark_usage+0x61/0x170 [ 24.713352][ C0] strp_read_sock+0x20f/0x2b0 [ 24.713355][ C0] ? strp_stop+0x50/0x50 [ 24.713358][ C0] ? rcu_is_watching+0x16/0xd0 [ 24.713361][ C0] ? lock_acquire+0x13c/0x160 [ 24.713364][ C0] strp_data_ready+0x18e/0x2c0 [ 24.713367][ C0] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 24.713372][ C0] tcp_rcv_established+0x1e1d/0x3910 [ 24.713376][ C0] ? __tcp_check_space+0x600/0x600 [ 24.713379][ C0] ? tcp_v4_rcv+0x1a81/0x2b70 [ 24.713382][ C0] ? do_raw_spin_lock+0x131/0x280 [ 24.713386][ C0] tcp_v4_do_rcv+0x4f6/0xb90 [ 24.713389][ C0] tcp_v4_rcv+0x1caa/0x2b70 [ 24.713393][ C0] ? mark_usage+0x61/0x170 [ 24.713395][ C0] ? tcp_add_backlog+0x1e30/0x1e30 [ 24.713399][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 24.713401][ C0] ? ip_local_deliver_finish+0x2ba/0x610 [ 24.713405][ C0] ip_protocol_deliver_rcu+0x82/0x350 [ 24.713408][ C0] ? process_backlog+0x3f1/0x14c0 [ 24.713411][ C0] ip_local_deliver_finish+0x36f/0x610 [ 24.713414][ C0] ip_local_deliver+0x184/0x4c0 [ 24.713417][ C0] ? ip_local_deliver_finish+0x610/0x610 [ 24.713419][ C0] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 24.713423][ C0] ? process_backlog+0x3f1/0x14c0 [ 24.713426][ C0] ip_rcv+0xdc/0x3d0 [ 24.713428][ C0] ? ip_local_deliver+0x4c0/0x4c0 [ 24.713431][ C0] ? rcu_is_watching+0x16/0xd0 [ 24.713433][ C0] ? __update_load_avg_cfs_rq+0x36c/0x10c0 [ 24.713437][ C0] ? mark_usage+0x61/0x170 [ 24.713439][ C0] ? __lock_acquire+0x518/0xc20 [ 24.713442][ C0] ? trace_raw_output_rcu_invoke_kfree_bulk_callback+0x57/0x130 [ 24.713446][ C0] __netif_receive_skb_one_core+0xfc/0x180 [ 24.713449][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 24.713451][ C0] ? process_backlog+0x3f1/0x14c0 [ 24.713454][ C0] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 24.713457][ C0] ? rcu_is_watching+0x16/0xd0 [ 24.713461][ C0] process_backlog+0x431/0x14c0 [ 24.713465][ C0] __napi_poll+0xa7/0x3b0 [ 24.713468][ C0] net_rx_action+0x513/0xf50 [ 24.713472][ C0] ? __lock_acquire+0x518/0xc20 [ 24.713474][ C0] ? __napi_poll+0x3b0/0x3b0 [ 24.713480][ C0] ? ktime_get_update_offsets_now+0x2a8/0x490 [ 24.713484][ C0] ? rcu_is_watching+0x16/0xd0 [ 24.713488][ C0] handle_softirqs+0x1d3/0x900 [ 24.713491][ C0] ? _local_bh_enable+0xc0/0xc0 [ 24.713493][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 24.713496][ C0] ? rcu_is_watching+0x16/0xd0 [ 24.713500][ C0] do_softirq+0xac/0xe0 [ 24.713502][ C0] [ 24.713503][ C0] [ 24.713504][ C0] __local_bh_enable_ip+0x118/0x150 [ 24.713507][ C0] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 24.713512][ C0] ? ovpn_tcp_recvmsg+0x6d0/0x6d0 [ovpn] [ 24.713518][ C0] __sys_sendto+0x2aa/0x400 [ 24.713522][ C0] ? __ia32_sys_getpeername+0xd0/0xd0 [ 24.713528][ C0] ? fput_close_sync+0xde/0x1b0 [ 24.713531][ C0] ? alloc_file_clone+0xe0/0xe0 [ 24.713534][ C0] __x64_sys_sendto+0xe4/0x1f0 [ 24.713537][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 24.713541][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 24.713543][ C0] ? do_syscall_64+0xa6/0x530 [ 24.713545][ C0] do_syscall_64+0xff/0x530 [ 24.713547][ C0] ? exc_page_fault+0xee/0x100 [ 24.713550][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 24.713552][ C0] RIP: 0033:0x7fc971fa154e [ 24.713556][ 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 [ 24.713559][ C0] RSP: 002b:00007ffed1ce7650 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 24.713563][ C0] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007fc971fa154e [ 24.713565][ C0] RDX: 00000000000003ea RSI: 00007ffed1ce76c0 RDI: 0000000000000005 [ 24.713566][ C0] RBP: 00007ffed1ce7660 R08: 0000000000000000 R09: 0000000000000000 [ 24.713568][ C0] R10: 0000000000004000 R11: 0000000000000202 R12: 00007ffed1ce7fe8 [ 24.713569][ C0] R13: 0000000000000008 R14: 00007fc97228c000 R15: 000000000040bda8 [ 24.713573][ C0] [ 24.713579][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 24.713581][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 405, name: ovpn-cli [ 24.713583][ C0] preempt_count: 103, expected: 0 [ 24.713584][ C0] RCU nest depth: 3, expected: 0 [ 24.713585][ C0] INFO: lockdep is turned off. [ 24.713586][ C0] irq event stamp: 46467 [ 24.713587][ C0] hardirqs last enabled at (46466): [] __down_trylock_console_sem+0x86/0xa0 [ 24.713591][ C0] hardirqs last disabled at (46467): [] console_emit_next_record+0x3d4/0x4c0 [ 24.713593][ C0] softirqs last enabled at (46352): [] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 24.713598][ C0] softirqs last disabled at (46353): [] do_softirq+0xac/0xe0 [ 24.713601][ C0] Preemption disabled at: [ 24.713601][ C0] [<0000000000000000>] 0x0 [ 24.713605][ C0] CPU: 0 UID: 0 PID: 405 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 24.713608][ C0] Tainted: [W]=WARN [ 24.713609][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 24.713610][ C0] Call Trace: [ 24.713611][ C0] [ 24.713612][ C0] dump_stack_lvl+0x6f/0xa0 [ 24.713616][ C0] __might_resched.cold+0x1fe/0x2c1 [ 24.713619][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 24.713624][ C0] ? rcu_is_watching+0x16/0xd0 [ 24.713627][ C0] __kmalloc_noprof+0x443/0x760 [ 24.713630][ C0] ? __rwlock_init+0x150/0x150 [ 24.713632][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 24.713635][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 24.713638][ C0] alloc_buf.isra.0+0x4b/0x260 [ 24.713641][ C0] put_chars+0x1e1/0x2f0 [ 24.713644][ C0] ? __send_to_port+0x420/0x420 [ 24.713648][ C0] hvc_console_print+0x292/0x780 [ 24.713651][ C0] ? __lock_acquire+0x388/0xc20 [ 24.713655][ C0] ? hvc_write+0x3a0/0x3a0 [ 24.713657][ C0] ? rcu_is_watching+0x16/0xd0 [ 24.713660][ C0] ? lock_acquire+0x13c/0x160 [ 24.713664][ C0] console_emit_next_record+0x22f/0x4c0 [ 24.713667][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 24.713669][ C0] ? console_flush_one_record+0x106/0x710 [ 24.713672][ C0] ? rcu_is_watching+0x16/0xd0 [ 24.713675][ C0] ? lock_acquire+0x13c/0x160 [ 24.713678][ C0] console_flush_one_record+0x46f/0x710 [ 24.713682][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 24.713684][ C0] ? __lock_acquire+0x518/0xc20 [ 24.713688][ C0] console_unlock+0xee/0x1f0 [ 24.713691][ C0] ? console_flush_one_record+0x710/0x710 [ 24.713693][ C0] ? rcu_is_watching+0x16/0xd0 [ 24.713696][ C0] ? lock_acquire+0x60/0x160 [ 24.713699][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 24.713701][ C0] ? vprintk_emit+0x320/0x3e0 [ 24.713704][ C0] vprintk_emit+0x37c/0x3e0 [ 24.713708][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 24.713711][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 24.713714][ C0] _printk+0xc7/0x100 [ 24.713717][ C0] ? snapshot_read.cold+0x21/0x21 [ 24.713719][ C0] ? ___ratelimit+0x4e7/0xa00 [ 24.713722][ C0] ? ovpn_netdev_write+0x730/0x730 [ovpn] [ 24.713727][ C0] ? idr_get_free+0x830/0x830 [ 24.713730][ C0] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 24.713735][ C0] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 24.713740][ C0] ? ovpn_tcp_write_space+0x2e0/0x2e0 [ovpn] [ 24.713745][ C0] ? __copy_skb_header+0xb7/0x510 [ 24.713748][ C0] ? ovpn_tcp_disconnect+0x10/0x10 [ovpn] [ 24.713752][ C0] ? sock_queue_err_skb+0xb0/0x680 [ 24.713755][ C0] __strp_recv+0x20f/0x1c20 [ 24.713760][ C0] __tcp_read_sock+0x1c7/0x850 [ 24.713763][ C0] ? strp_process+0xb0/0xb0 [ 24.713766][ C0] ? __tcp_transmit_skb+0x1b6e/0x3c10 [ 24.713768][ C0] ? tcp_cleanup_rbuf+0x1c0/0x1c0 [ 24.713771][ C0] ? mark_usage+0x61/0x170 [ 24.713774][ C0] strp_read_sock+0x20f/0x2b0 [ 24.713777][ C0] ? strp_stop+0x50/0x50 [ 24.713781][ C0] ? rcu_is_watching+0x16/0xd0 [ 24.713783][ C0] ? lock_acquire+0x13c/0x160 [ 24.713786][ C0] strp_data_ready+0x18e/0x2c0 [ 24.713789][ C0] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 24.713794][ C0] tcp_rcv_established+0x1e1d/0x3910 [ 24.713799][ C0] ? __tcp_check_space+0x600/0x600 [ 24.713801][ C0] ? tcp_v4_rcv+0x1a81/0x2b70 [ 24.713804][ C0] ? do_raw_spin_lock+0x131/0x280 [ 24.713807][ C0] tcp_v4_do_rcv+0x4f6/0xb90 [ 24.713814][ C0] tcp_v4_rcv+0x1caa/0x2b70 [ 24.713818][ C0] ? mark_usage+0x61/0x170 [ 24.713820][ C0] ? tcp_add_backlog+0x1e30/0x1e30 [ 24.713824][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 24.713826][ C0] ? ip_local_deliver_finish+0x2ba/0x610 [ 24.713829][ C0] ip_protocol_deliver_rcu+0x82/0x350 [ 24.713833][ C0] ? process_backlog+0x3f1/0x14c0 [ 24.713835][ C0] ip_local_deliver_finish+0x36f/0x610 [ 24.713838][ C0] ip_local_deliver+0x184/0x4c0 [ 24.713841][ C0] ? ip_local_deliver_finish+0x610/0x610 [ 24.713843][ C0] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 24.713847][ C0] ? process_backlog+0x3f1/0x14c0 [ 24.713850][ C0] ip_rcv+0xdc/0x3d0 [ 24.713852][ C0] ? ip_local_deliver+0x4c0/0x4c0 [ 24.713855][ C0] ? rcu_is_watching+0x16/0xd0 [ 24.713857][ C0] ? __update_load_avg_cfs_rq+0x36c/0x10c0 [ 24.713860][ C0] ? mark_usage+0x61/0x170 [ 24.713863][ C0] ? __lock_acquire+0x518/0xc20 [ 24.713865][ C0] ? trace_raw_output_rcu_invoke_kfree_bulk_callback+0x57/0x130 [ 24.713868][ C0] __netif_receive_skb_one_core+0xfc/0x180 [ 24.713871][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 24.713873][ C0] ? process_backlog+0x3f1/0x14c0 [ 24.713876][ C0] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 24.713879][ C0] ? rcu_is_watching+0x16/0xd0 [ 24.713883][ C0] process_backlog+0x431/0x14c0 [ 24.713887][ C0] __napi_poll+0xa7/0x3b0 [ 24.713890][ C0] net_rx_action+0x513/0xf50 [ 24.713895][ C0] ? __lock_acquire+0x518/0xc20 [ 24.713897][ C0] ? __napi_poll+0x3b0/0x3b0 [ 24.713903][ C0] ? ktime_get_update_offsets_now+0x2a8/0x490 [ 24.713906][ C0] ? rcu_is_watching+0x16/0xd0 [ 24.713909][ C0] handle_softirqs+0x1d3/0x900 [ 24.713913][ C0] ? _local_bh_enable+0xc0/0xc0 [ 24.713915][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 24.713917][ C0] ? rcu_is_watching+0x16/0xd0 [ 24.713920][ C0] do_softirq+0xac/0xe0 [ 24.713923][ C0] [ 24.713924][ C0] [ 24.713925][ C0] __local_bh_enable_ip+0x118/0x150 [ 24.713927][ C0] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 24.713932][ C0] ? ovpn_tcp_recvmsg+0x6d0/0x6d0 [ovpn] [ 24.713939][ C0] __sys_sendto+0x2aa/0x400 [ 24.713942][ C0] ? __ia32_sys_getpeername+0xd0/0xd0 [ 24.713948][ C0] ? fput_close_sync+0xde/0x1b0 [ 24.713951][ C0] ? alloc_file_clone+0xe0/0xe0 [ 24.713953][ C0] __x64_sys_sendto+0xe4/0x1f0 [ 24.713956][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 24.713959][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 24.713961][ C0] ? do_syscall_64+0xa6/0x530 [ 24.713963][ C0] do_syscall_64+0xff/0x530 [ 24.713965][ C0] ? exc_page_fault+0xee/0x100 [ 24.713968][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 24.713970][ C0] RIP: 0033:0x7fc971fa154e [ 24.713972][ 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 [ 24.713974][ C0] RSP: 002b:00007ffed1ce7650 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 24.713976][ C0] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007fc971fa154e [ 24.713978][ C0] RDX: 00000000000003ea RSI: 00007ffed1ce76c0 RDI: 0000000000000005 [ 24.713979][ C0] RBP: 00007ffed1ce7660 R08: 0000000000000000 R09: 0000000000000000 [ 24.713981][ C0] R10: 0000000000004000 R11: 0000000000000202 R12: 00007ffed1ce7fe8 [ 24.713982][ C0] R13: 0000000000000008 R14: 00007fc97228c000 R15: 000000000040bda8 [ 24.713986][ C0] [ 24.987917][ C1] tun0: no available key for peer 4, key-id: 0 [ 25.036729][ C1] tun0: no available key for peer 5, key-id: 0 [ 25.106807][ C3] tun0: no available key for peer 6, key-id: 0 [ 33.796386][ T615] iperf3 (615) used greatest stack depth: 23128 bytes left [ 33.796404][ T615] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 33.796407][ T615] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 615, name: iperf3 [ 33.796409][ T615] preempt_count: 2, expected: 0 [ 33.796410][ T615] RCU nest depth: 0, expected: 0 [ 33.796411][ T615] INFO: lockdep is turned off. [ 33.796412][ T615] irq event stamp: 0 [ 33.796413][ T615] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 33.796417][ T615] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 33.796423][ T615] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 33.796425][ T615] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 33.796427][ T615] Preemption disabled at: [ 33.796428][ T615] [<0000000000000000>] 0x0 [ 33.796433][ T615] CPU: 3 UID: 0 PID: 615 Comm: iperf3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 33.796436][ T615] Tainted: [W]=WARN [ 33.796437][ T615] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 33.796439][ T615] Call Trace: [ 33.796441][ T615] [ 33.796442][ T615] dump_stack_lvl+0x6f/0xa0 [ 33.796448][ T615] __might_resched.cold+0x1fe/0x2c1 [ 33.796452][ T615] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 33.796455][ T615] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 33.796458][ T615] ? rcu_is_watching+0x16/0xd0 [ 33.796462][ T615] __kmalloc_noprof+0x443/0x760 [ 33.796465][ T615] ? __rwlock_init+0x150/0x150 [ 33.796468][ T615] ? alloc_buf.isra.0+0x4b/0x260 [ 33.796472][ T615] ? do_raw_spin_unlock+0x59/0x250 [ 33.796474][ T615] alloc_buf.isra.0+0x4b/0x260 [ 33.796476][ T615] put_chars+0x1e1/0x2f0 [ 33.796478][ T615] ? prb_final_commit+0x50/0x50 [ 33.796480][ T615] ? __send_to_port+0x420/0x420 [ 33.796482][ T615] ? printk_get_next_message+0x240/0x650 [ 33.796485][ T615] hvc_console_print+0x292/0x780 [ 33.796489][ T615] ? hvc_write+0x3a0/0x3a0 [ 33.796491][ T615] ? do_raw_spin_lock+0x131/0x280 [ 33.796492][ T615] ? vsnprintf+0x668/0x1700 [ 33.796496][ T615] ? __rwlock_init+0x150/0x150 [ 33.796497][ T615] ? rcu_is_watching+0x16/0xd0 [ 33.796499][ T615] ? lock_acquire+0x13c/0x160 [ 33.796501][ T615] console_emit_next_record+0x22f/0x4c0 [ 33.796504][ T615] ? devkmsg_read+0x4b0/0x4b0 [ 33.796506][ T615] ? rcu_is_watching+0x16/0xd0 [ 33.796508][ T615] ? rcu_is_watching+0x16/0xd0 [ 33.796510][ T615] ? rcu_is_watching+0x16/0xd0 [ 33.796512][ T615] ? lock_acquire+0x13c/0x160 [ 33.796514][ T615] ? console_flush_one_record+0x111/0x710 [ 33.796515][ T615] console_flush_one_record+0x46f/0x710 [ 33.796518][ T615] ? console_emit_next_record+0x4c0/0x4c0 [ 33.796521][ T615] console_unlock+0xee/0x1f0 [ 33.796523][ T615] ? lock_acquire+0x13c/0x160 [ 33.796524][ T615] ? console_flush_one_record+0x710/0x710 [ 33.796526][ T615] ? rcu_is_watching+0x16/0xd0 [ 33.796528][ T615] ? lock_release+0x184/0x1f0 [ 33.796529][ T615] ? lock_acquire+0x60/0x160 [ 33.796531][ T615] ? __rcu_read_lock+0x30/0x70 [ 33.796533][ T615] ? __down_trylock_console_sem+0x5e/0xa0 [ 33.796535][ T615] ? vprintk_emit+0x320/0x3e0 [ 33.796537][ T615] vprintk_emit+0x37c/0x3e0 [ 33.796539][ T615] ? wake_up_klogd_work_func+0x90/0x90 [ 33.796542][ T615] _printk+0xc7/0x100 [ 33.796545][ T615] ? snapshot_read.cold+0x21/0x21 [ 33.796547][ T615] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 33.796550][ T615] ? do_raw_spin_lock+0x131/0x280 [ 33.796551][ T615] ? __rwlock_init+0x150/0x150 [ 33.796554][ T615] ? do_raw_spin_lock+0x131/0x280 [ 33.796555][ T615] do_exit.cold+0x82/0x9c [ 33.796559][ T615] ? exit_notify+0x890/0x890 [ 33.796561][ T615] __x64_sys_exit+0x42/0x50 [ 33.796563][ T615] x64_sys_call+0x156c/0x1570 [ 33.796566][ T615] do_syscall_64+0xff/0x530 [ 33.796568][ T615] ? exc_page_fault+0xee/0x100 [ 33.796570][ T615] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 33.796572][ T615] RIP: 0033:0x7f25a49dbc49 [ 33.796574][ T615] Code: Unable to access opcode bytes at 0x7f25a49dbc1f. [ 33.796575][ T615] RSP: 002b:00007f25a419ae60 EFLAGS: 00000246 ORIG_RAX: 000000000000003c [ 33.796579][ T615] RAX: ffffffffffffffda RBX: 00007f25a419b6c0 RCX: 00007f25a49dbc49 [ 33.796580][ T615] RDX: 0000000000000000 RSI: 0000000000801000 RDI: 0000000000000000 [ 33.796581][ T615] RBP: 00007f25a419af70 R08: 0000000000000001 R09: 00007f25a419b6c0 [ 33.796582][ T615] R10: 0000000000000008 R11: 0000000000000246 R12: 00007f25a399b000 [ 33.796583][ T615] R13: 00007fff813b30c0 R14: 0000000000000002 R15: 00007fff813b31c7 [ 33.796585][ T615] [ 35.145301][ T709] tun0: deleting peer with id 1, reason 1 [ 35.145319][ T709] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 35.145322][ T709] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 709, name: ovpn-cli [ 35.145323][ T709] preempt_count: 202, expected: 0 [ 35.145324][ T709] RCU nest depth: 0, expected: 0 [ 35.145325][ T709] INFO: lockdep is turned off. [ 35.145326][ T709] irq event stamp: 0 [ 35.145327][ T709] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 35.145331][ T709] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 35.145338][ T709] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 35.145339][ T709] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 35.145341][ T709] Preemption disabled at: [ 35.145342][ T709] [<0000000000000000>] 0x0 [ 35.145347][ T709] CPU: 0 UID: 0 PID: 709 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 35.145350][ T709] Tainted: [W]=WARN [ 35.145352][ T709] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 35.145353][ T709] Call Trace: [ 35.145355][ T709] [ 35.145356][ T709] dump_stack_lvl+0x6f/0xa0 [ 35.145362][ T709] __might_resched.cold+0x1fe/0x2c1 [ 35.145366][ T709] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 35.145370][ T709] ? rcu_is_watching+0x16/0xd0 [ 35.145374][ T709] __kmalloc_noprof+0x443/0x760 [ 35.145378][ T709] ? __rwlock_init+0x150/0x150 [ 35.145381][ T709] ? alloc_buf.isra.0+0x4b/0x260 [ 35.145385][ T709] ? do_raw_spin_unlock+0x59/0x250 [ 35.145387][ T709] alloc_buf.isra.0+0x4b/0x260 [ 35.145389][ T709] put_chars+0x1e1/0x2f0 [ 35.145391][ T709] ? __send_to_port+0x420/0x420 [ 35.145393][ T709] ? printk_get_next_message+0x240/0x650 [ 35.145396][ T709] hvc_console_print+0x292/0x780 [ 35.145400][ T709] ? hvc_write+0x3a0/0x3a0 [ 35.145402][ T709] ? __rwlock_init+0x150/0x150 [ 35.145404][ T709] ? rcu_is_watching+0x16/0xd0 [ 35.145406][ T709] ? lock_acquire+0x13c/0x160 [ 35.145408][ T709] console_emit_next_record+0x22f/0x4c0 [ 35.145411][ T709] ? devkmsg_read+0x4b0/0x4b0 [ 35.145413][ T709] ? rcu_is_watching+0x16/0xd0 [ 35.145415][ T709] ? rcu_is_watching+0x16/0xd0 [ 35.145416][ T709] ? rcu_is_watching+0x16/0xd0 [ 35.145418][ T709] ? lock_acquire+0x13c/0x160 [ 35.145420][ T709] ? console_flush_one_record+0x111/0x710 [ 35.145422][ T709] console_flush_one_record+0x46f/0x710 [ 35.145424][ T709] ? console_emit_next_record+0x4c0/0x4c0 [ 35.145427][ T709] console_unlock+0xee/0x1f0 [ 35.145429][ T709] ? lock_acquire+0x13c/0x160 [ 35.145431][ T709] ? console_flush_one_record+0x710/0x710 [ 35.145432][ T709] ? rcu_is_watching+0x16/0xd0 [ 35.145434][ T709] ? lock_release+0x184/0x1f0 [ 35.145436][ T709] ? lock_acquire+0x60/0x160 [ 35.145437][ T709] ? __rcu_read_lock+0x30/0x70 [ 35.145439][ T709] ? __down_trylock_console_sem+0x5e/0xa0 [ 35.145441][ T709] ? vprintk_emit+0x320/0x3e0 [ 35.145443][ T709] vprintk_emit+0x37c/0x3e0 [ 35.145445][ T709] ? wake_up_klogd_work_func+0x90/0x90 [ 35.145447][ T709] ? kernel_text_address+0x149/0x170 [ 35.145450][ T709] ? __kernel_text_address+0x12/0x30 [ 35.145451][ T709] ? write_profile+0xf0/0xf0 [ 35.145453][ T709] ? unwind_get_return_address+0x67/0xd0 [ 35.145456][ T709] _printk+0xc7/0x100 [ 35.145459][ T709] ? snapshot_read.cold+0x21/0x21 [ 35.145462][ T709] ? netdev_name+0x43/0x60 [ 35.145464][ T709] ? __netdev_printk+0x17f/0x1d0 [ 35.145466][ T709] netdev_info+0xe2/0x116 [ 35.145468][ T709] ? netdev_notice+0x120/0x120 [ 35.145469][ T709] ? ovpn_nl_pre_doit+0x44/0x90 [ovpn] [ 35.145475][ T709] ? __module_address+0x36/0x330 [ 35.145478][ T709] ? lock_acquire+0x13c/0x160 [ 35.145480][ T709] ? rcu_is_watching+0x16/0xd0 [ 35.145482][ T709] ? lock_release+0x184/0x1f0 [ 35.145484][ T709] ? ovpn_peer_get_by_id+0x38a/0x7a0 [ovpn] [ 35.145487][ T709] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 35.145491][ T709] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 35.145494][ T709] ? lock_acquire+0x13c/0x160 [ 35.145495][ T709] ? rcu_is_watching+0x16/0xd0 [ 35.145497][ T709] ? lock_release+0x184/0x1f0 [ 35.145499][ T709] ovpn_peer_remove+0x394/0x640 [ovpn] [ 35.145502][ T709] ? do_raw_spin_lock+0x131/0x280 [ 35.145504][ T709] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 35.145507][ T709] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 35.145511][ T709] ? ovpn_peer_add+0x330/0x330 [ovpn] [ 35.145514][ T709] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 35.145517][ T709] ? trace_hardirqs_on+0x36/0x40 [ 35.145520][ T709] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 35.145522][ T709] ? ref_tracker_alloc+0x28d/0x430 [ 35.145527][ T709] ? lock_release+0x184/0x1f0 [ 35.145529][ T709] ? ovpn_get_dev_from_attrs+0x17a/0x660 [ovpn] [ 35.145532][ T709] genl_family_rcv_msg_doit+0x206/0x300 [ 35.145537][ T709] ? genl_family_rcv_msg_attrs_parse.isra.0+0x330/0x330 [ 35.145539][ T709] ? rcu_is_watching+0x16/0xd0 [ 35.145542][ T709] ? rcu_is_watching+0x16/0xd0 [ 35.145543][ T709] ? cap_capable+0x1d7/0x3d0 [ 35.145547][ T709] ? write_profile+0xf0/0xf0 [ 35.145548][ T709] ? unwind_get_return_address+0x67/0xd0 [ 35.145550][ T709] genl_family_rcv_msg+0x3a4/0x640 [ 35.145552][ T709] ? genl_family_rcv_msg_dumpit+0x340/0x340 [ 35.145555][ T709] ? ovpn_nl_send_peer+0x1300/0x1300 [ovpn] [ 35.145557][ T709] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 35.145559][ T709] ? ovpn_nl_pre_doit+0x90/0x90 [ovpn] [ 35.145562][ T709] ? filter_irq_stacks+0xd0/0xd0 [ 35.145564][ T709] ? stack_depot_save_flags+0x1bc/0x790 [ 35.145566][ T709] genl_rcv_msg+0xbb/0x160 [ 35.145568][ T709] netlink_rcv_skb+0x14e/0x3a0 [ 35.145570][ T709] ? genl_family_rcv_msg+0x640/0x640 [ 35.145572][ T709] ? netlink_ack+0xcf0/0xcf0 [ 35.145575][ T709] ? lock_acquire+0x13c/0x160 [ 35.145577][ T709] ? rcu_is_watching+0x16/0xd0 [ 35.145579][ T709] ? lock_release+0x184/0x1f0 [ 35.145581][ T709] genl_rcv+0x28/0x40 [ 35.145582][ T709] netlink_unicast+0x486/0x750 [ 35.145585][ T709] ? netlink_attachskb+0x810/0x810 [ 35.145587][ T709] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 35.145588][ T709] ? trace_hardirqs_on+0x36/0x40 [ 35.145589][ T709] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 35.145593][ T709] netlink_sendmsg+0x735/0xc60 [ 35.145595][ T709] ? netlink_unicast+0x750/0x750 [ 35.145598][ T709] ? rcu_is_watching+0x16/0xd0 [ 35.145600][ T709] ? lock_release+0x184/0x1f0 [ 35.145602][ T709] ____sys_sendmsg+0x415/0x880 [ 35.145605][ T709] ? copy_msghdr_from_user+0x279/0x420 [ 35.145607][ T709] ? get_timestamp.constprop.0+0x390/0x390 [ 35.145609][ T709] ? move_addr_to_kernel+0x40/0x40 [ 35.145612][ T709] ___sys_sendmsg+0x14e/0x1d0 [ 35.145614][ T709] ? copy_msghdr_from_user+0x420/0x420 [ 35.145615][ T709] ? kfree+0x22/0x590 [ 35.145620][ T709] __sys_sendmsg+0x12c/0x1d0 [ 35.145623][ T709] ? __sys_sendmsg_sock+0x20/0x20 [ 35.145625][ T709] ? rcu_is_watching+0x16/0xd0 [ 35.145627][ T709] ? rcu_is_watching+0x16/0xd0 [ 35.145629][ T709] do_syscall_64+0xff/0x530 [ 35.145632][ T709] ? exc_page_fault+0xee/0x100 [ 35.145634][ T709] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 35.145636][ T709] RIP: 0033:0x7f1757cac54e [ 35.145638][ T709] 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.145640][ T709] RSP: 002b:00007fffee714a20 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 35.145644][ T709] RAX: ffffffffffffffda RBX: 00000000294ad130 RCX: 00007f1757cac54e [ 35.145646][ T709] RDX: 0000000000000000 RSI: 00007fffee714ac0 RDI: 0000000000000005 [ 35.145647][ T709] RBP: 00007fffee714a30 R08: 0000000000000000 R09: 0000000000000000 [ 35.145647][ T709] R10: 0000000000000000 R11: 0000000000000202 R12: 00000000294ad200 [ 35.145648][ T709] R13: 00007fffee714ac0 R14: 00000000294ae260 R15: 000000000040bda8 [ 35.145651][ T709] [ 35.230073][ T713] tun1: deleting peer with id 1, reason 1 [ 37.821888][ T761] tun0: deleting peer with id 2, reason 1 [ 37.821905][ T761] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 37.821907][ T761] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 761, name: ovpn-cli [ 37.821909][ T761] preempt_count: 202, expected: 0 [ 37.821910][ T761] RCU nest depth: 0, expected: 0 [ 37.821910][ T761] INFO: lockdep is turned off. [ 37.821912][ T761] irq event stamp: 0 [ 37.821912][ T761] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 37.821917][ T761] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 37.821923][ T761] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 37.821931][ T761] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 37.821933][ T761] Preemption disabled at: [ 37.821933][ T761] [<0000000000000000>] 0x0 [ 37.821939][ T761] CPU: 2 UID: 0 PID: 761 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 37.821942][ T761] Tainted: [W]=WARN [ 37.821943][ T761] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 37.821945][ T761] Call Trace: [ 37.821946][ T761] [ 37.821947][ T761] dump_stack_lvl+0x6f/0xa0 [ 37.821953][ T761] __might_resched.cold+0x1fe/0x2c1 [ 37.821957][ T761] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 37.821961][ T761] ? rcu_is_watching+0x16/0xd0 [ 37.821965][ T761] __kmalloc_noprof+0x443/0x760 [ 37.821969][ T761] ? __rwlock_init+0x150/0x150 [ 37.821972][ T761] ? alloc_buf.isra.0+0x4b/0x260 [ 37.821976][ T761] ? do_raw_spin_unlock+0x59/0x250 [ 37.821978][ T761] alloc_buf.isra.0+0x4b/0x260 [ 37.821980][ T761] put_chars+0x1e1/0x2f0 [ 37.821982][ T761] ? __send_to_port+0x420/0x420 [ 37.821984][ T761] ? printk_get_next_message+0x240/0x650 [ 37.821987][ T761] hvc_console_print+0x292/0x780 [ 37.821991][ T761] ? hvc_write+0x3a0/0x3a0 [ 37.821993][ T761] ? __rwlock_init+0x150/0x150 [ 37.821995][ T761] ? rcu_is_watching+0x16/0xd0 [ 37.821996][ T761] ? lock_acquire+0x13c/0x160 [ 37.821999][ T761] console_emit_next_record+0x22f/0x4c0 [ 37.822001][ T761] ? devkmsg_read+0x4b0/0x4b0 [ 37.822003][ T761] ? rcu_is_watching+0x16/0xd0 [ 37.822005][ T761] ? rcu_is_watching+0x16/0xd0 [ 37.822007][ T761] ? rcu_is_watching+0x16/0xd0 [ 37.822008][ T761] ? lock_acquire+0x13c/0x160 [ 37.822010][ T761] ? console_flush_one_record+0x111/0x710 [ 37.822012][ T761] console_flush_one_record+0x46f/0x710 [ 37.822014][ T761] ? console_emit_next_record+0x4c0/0x4c0 [ 37.822017][ T761] console_unlock+0xee/0x1f0 [ 37.822019][ T761] ? lock_acquire+0x13c/0x160 [ 37.822020][ T761] ? console_flush_one_record+0x710/0x710 [ 37.822022][ T761] ? rcu_is_watching+0x16/0xd0 [ 37.822024][ T761] ? lock_release+0x184/0x1f0 [ 37.822025][ T761] ? lock_acquire+0x60/0x160 [ 37.822027][ T761] ? __rcu_read_lock+0x30/0x70 [ 37.822029][ T761] ? __down_trylock_console_sem+0x5e/0xa0 [ 37.822031][ T761] ? vprintk_emit+0x320/0x3e0 [ 37.822033][ T761] vprintk_emit+0x37c/0x3e0 [ 37.822035][ T761] ? wake_up_klogd_work_func+0x90/0x90 [ 37.822037][ T761] ? kernel_text_address+0x149/0x170 [ 37.822039][ T761] ? __kernel_text_address+0x12/0x30 [ 37.822040][ T761] ? write_profile+0xf0/0xf0 [ 37.822043][ T761] ? unwind_get_return_address+0x67/0xd0 [ 37.822046][ T761] _printk+0xc7/0x100 [ 37.822049][ T761] ? snapshot_read.cold+0x21/0x21 [ 37.822051][ T761] ? netdev_name+0x43/0x60 [ 37.822054][ T761] ? __netdev_printk+0x17f/0x1d0 [ 37.822056][ T761] netdev_info+0xe2/0x116 [ 37.822058][ T761] ? netdev_notice+0x120/0x120 [ 37.822059][ T761] ? ovpn_nl_pre_doit+0x44/0x90 [ovpn] [ 37.822065][ T761] ? __module_address+0x36/0x330 [ 37.822068][ T761] ? lock_acquire+0x13c/0x160 [ 37.822069][ T761] ? rcu_is_watching+0x16/0xd0 [ 37.822071][ T761] ? lock_release+0x184/0x1f0 [ 37.822073][ T761] ? ovpn_peer_get_by_id+0x38a/0x7a0 [ovpn] [ 37.822076][ T761] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 37.822080][ T761] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 37.822083][ T761] ? lock_acquire+0x13c/0x160 [ 37.822084][ T761] ? rcu_is_watching+0x16/0xd0 [ 37.822086][ T761] ? lock_release+0x184/0x1f0 [ 37.822088][ T761] ovpn_peer_remove+0x394/0x640 [ovpn] [ 37.822092][ T761] ? do_raw_spin_lock+0x131/0x280 [ 37.822093][ T761] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 37.822099][ T761] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 37.822102][ T761] ? ovpn_peer_add+0x330/0x330 [ovpn] [ 37.822105][ T761] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 37.822108][ T761] ? trace_hardirqs_on+0x36/0x40 [ 37.822111][ T761] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 37.822114][ T761] ? ref_tracker_alloc+0x28d/0x430 [ 37.822119][ T761] ? lock_release+0x184/0x1f0 [ 37.822121][ T761] ? ovpn_get_dev_from_attrs+0x17a/0x660 [ovpn] [ 37.822124][ T761] genl_family_rcv_msg_doit+0x206/0x300 [ 37.822128][ T761] ? genl_family_rcv_msg_attrs_parse.isra.0+0x330/0x330 [ 37.822130][ T761] ? rcu_is_watching+0x16/0xd0 [ 37.822133][ T761] ? rcu_is_watching+0x16/0xd0 [ 37.822135][ T761] ? cap_capable+0x1d7/0x3d0 [ 37.822139][ T761] ? write_profile+0xf0/0xf0 [ 37.822140][ T761] ? unwind_get_return_address+0x67/0xd0 [ 37.822141][ T761] genl_family_rcv_msg+0x3a4/0x640 [ 37.822144][ T761] ? genl_family_rcv_msg_dumpit+0x340/0x340 [ 37.822146][ T761] ? ovpn_nl_send_peer+0x1300/0x1300 [ovpn] [ 37.822148][ T761] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 37.822151][ T761] ? ovpn_nl_pre_doit+0x90/0x90 [ovpn] [ 37.822153][ T761] ? filter_irq_stacks+0xd0/0xd0 [ 37.822155][ T761] ? stack_depot_save_flags+0x1bc/0x790 [ 37.822157][ T761] genl_rcv_msg+0xbb/0x160 [ 37.822159][ T761] netlink_rcv_skb+0x14e/0x3a0 [ 37.822161][ T761] ? genl_family_rcv_msg+0x640/0x640 [ 37.822163][ T761] ? netlink_ack+0xcf0/0xcf0 [ 37.822166][ T761] ? lock_acquire+0x13c/0x160 [ 37.822168][ T761] ? rcu_is_watching+0x16/0xd0 [ 37.822170][ T761] ? lock_release+0x184/0x1f0 [ 37.822171][ T761] genl_rcv+0x28/0x40 [ 37.822173][ T761] netlink_unicast+0x486/0x750 [ 37.822176][ T761] ? netlink_attachskb+0x810/0x810 [ 37.822177][ T761] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 37.822179][ T761] ? trace_hardirqs_on+0x36/0x40 [ 37.822180][ T761] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 37.822184][ T761] netlink_sendmsg+0x735/0xc60 [ 37.822186][ T761] ? netlink_unicast+0x750/0x750 [ 37.822188][ T761] ? rcu_is_watching+0x16/0xd0 [ 37.822190][ T761] ? lock_release+0x184/0x1f0 [ 37.822192][ T761] ____sys_sendmsg+0x415/0x880 [ 37.822196][ T761] ? copy_msghdr_from_user+0x279/0x420 [ 37.822197][ T761] ? get_timestamp.constprop.0+0x390/0x390 [ 37.822199][ T761] ? move_addr_to_kernel+0x40/0x40 [ 37.822202][ T761] ___sys_sendmsg+0x14e/0x1d0 [ 37.822204][ T761] ? copy_msghdr_from_user+0x420/0x420 [ 37.822206][ T761] ? kfree+0x22/0x590 [ 37.822211][ T761] __sys_sendmsg+0x12c/0x1d0 [ 37.822213][ T761] ? __sys_sendmsg_sock+0x20/0x20 [ 37.822216][ T761] ? rcu_is_watching+0x16/0xd0 [ 37.822218][ T761] ? rcu_is_watching+0x16/0xd0 [ 37.822220][ T761] do_syscall_64+0xff/0x530 [ 37.822223][ T761] ? exc_page_fault+0xee/0x100 [ 37.822224][ T761] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 37.822226][ T761] RIP: 0033:0x7fe4ee38354e [ 37.822228][ T761] 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 [ 37.822230][ T761] RSP: 002b:00007ffc8c190050 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 37.822234][ T761] RAX: ffffffffffffffda RBX: 000000003ba21130 RCX: 00007fe4ee38354e [ 37.822235][ T761] RDX: 0000000000000000 RSI: 00007ffc8c1900f0 RDI: 0000000000000005 [ 37.822236][ T761] RBP: 00007ffc8c190060 R08: 0000000000000000 R09: 0000000000000000 [ 37.822237][ T761] R10: 0000000000000000 R11: 0000000000000202 R12: 000000003ba21200 [ 37.822238][ T761] R13: 00007ffc8c1900f0 R14: 000000003ba22260 R15: 000000000040bda8 [ 37.822240][ T761] [ 37.914799][ T765] tun2: deleting peer with id 2, reason 1 [ 43.748156][ T10] tun0: deleting peer with id 4, reason 2 [ 43.748179][ T10] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 43.748182][ T10] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 10, name: kworker/0:1 [ 43.748183][ T10] preempt_count: 202, expected: 0 [ 43.748184][ T10] RCU nest depth: 0, expected: 0 [ 43.748185][ T10] INFO: lockdep is turned off. [ 43.748187][ T10] irq event stamp: 20170 [ 43.748187][ T10] hardirqs last enabled at (20169): [] _raw_spin_unlock_irq+0x28/0x50 [ 43.748196][ T10] hardirqs last disabled at (20170): [] __schedule+0x1246/0x20e0 [ 43.748199][ T10] softirqs last enabled at (19888): [] handle_softirqs+0x67c/0x900 [ 43.748203][ T10] softirqs last disabled at (19849): [] do_softirq+0xac/0xe0 [ 43.748205][ T10] Preemption disabled at: [ 43.748206][ T10] [<0000000000000000>] 0x0 [ 43.748213][ T10] CPU: 0 UID: 0 PID: 10 Comm: kworker/0:1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 43.748216][ T10] Tainted: [W]=WARN [ 43.748217][ T10] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 43.748220][ T10] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 43.748229][ T10] Call Trace: [ 43.748231][ T10] [ 43.748232][ T10] dump_stack_lvl+0x6f/0xa0 [ 43.748237][ T10] __might_resched.cold+0x1fe/0x2c1 [ 43.748241][ T10] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 43.748244][ T10] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 43.748247][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.748251][ T10] __kmalloc_noprof+0x443/0x760 [ 43.748255][ T10] ? __rwlock_init+0x150/0x150 [ 43.748258][ T10] ? alloc_buf.isra.0+0x4b/0x260 [ 43.748262][ T10] ? do_raw_spin_unlock+0x59/0x250 [ 43.748264][ T10] alloc_buf.isra.0+0x4b/0x260 [ 43.748266][ T10] put_chars+0x1e1/0x2f0 [ 43.748268][ T10] ? prb_final_commit+0x50/0x50 [ 43.748269][ T10] ? __send_to_port+0x420/0x420 [ 43.748271][ T10] ? printk_get_next_message+0x240/0x650 [ 43.748275][ T10] hvc_console_print+0x292/0x780 [ 43.748279][ T10] ? hvc_write+0x3a0/0x3a0 [ 43.748280][ T10] ? do_raw_spin_lock+0x131/0x280 [ 43.748282][ T10] ? vsnprintf+0x527/0x1700 [ 43.748284][ T10] ? __rwlock_init+0x150/0x150 [ 43.748285][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.748287][ T10] ? lock_acquire+0x13c/0x160 [ 43.748289][ T10] console_emit_next_record+0x22f/0x4c0 [ 43.748292][ T10] ? devkmsg_read+0x4b0/0x4b0 [ 43.748294][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.748296][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.748298][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.748299][ T10] ? lock_acquire+0x13c/0x160 [ 43.748301][ T10] ? console_flush_one_record+0x111/0x710 [ 43.748303][ T10] console_flush_one_record+0x46f/0x710 [ 43.748305][ T10] ? console_emit_next_record+0x4c0/0x4c0 [ 43.748308][ T10] console_unlock+0xee/0x1f0 [ 43.748310][ T10] ? lock_acquire+0x13c/0x160 [ 43.748312][ T10] ? console_flush_one_record+0x710/0x710 [ 43.748313][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.748315][ T10] ? lock_release+0x184/0x1f0 [ 43.748316][ T10] ? lock_acquire+0x60/0x160 [ 43.748318][ T10] ? __rcu_read_lock+0x30/0x70 [ 43.748320][ T10] ? __down_trylock_console_sem+0x5e/0xa0 [ 43.748322][ T10] ? vprintk_emit+0x320/0x3e0 [ 43.748324][ T10] vprintk_emit+0x37c/0x3e0 [ 43.748326][ T10] ? wake_up_klogd_work_func+0x90/0x90 [ 43.748328][ T10] ? ret_from_fork_asm+0x11/0x20 [ 43.748331][ T10] ? queued_spin_lock_slowpath+0x103/0xa60 [ 43.748333][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.748334][ T10] ? stack_access_ok+0x1e0/0x1e0 [ 43.748337][ T10] _printk+0xc7/0x100 [ 43.748340][ T10] ? snapshot_read.cold+0x21/0x21 [ 43.748342][ T10] ? __add_to_free_list+0x81/0x5c0 [ 43.748344][ T10] ? __mod_zone_page_state+0xe1/0x190 [ 43.748347][ T10] ? netdev_name+0x43/0x60 [ 43.748350][ T10] ? __netdev_printk+0x17f/0x1d0 [ 43.748352][ T10] netdev_info+0xe2/0x116 [ 43.748353][ T10] ? netdev_notice+0x120/0x120 [ 43.748355][ T10] ? free_pcppages_bulk+0x363/0x6e0 [ 43.748357][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.748359][ T10] ? trace_irq_enable.constprop.0+0x30/0x160 [ 43.748362][ T10] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 43.748367][ T10] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 43.748369][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.748371][ T10] ? lock_release+0x184/0x1f0 [ 43.748372][ T10] ? do_raw_spin_unlock+0x59/0x250 [ 43.748375][ T10] ovpn_peer_remove+0x394/0x640 [ovpn] [ 43.748378][ T10] ? do_raw_spin_lock+0x131/0x280 [ 43.748380][ T10] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 43.748383][ T10] ? __rwlock_init+0x150/0x150 [ 43.748384][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.748386][ T10] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 43.748387][ T10] ? trace_irq_disable.constprop.0+0x9b/0x160 [ 43.748389][ T10] ovpn_peer_keepalive_work_single+0x416/0x600 [ovpn] [ 43.748392][ T10] ? ovpn_peers_release_mp+0x490/0x490 [ovpn] [ 43.748394][ T10] ? __rwlock_init+0x150/0x150 [ 43.748397][ T10] ovpn_peer_keepalive_work+0x253/0x580 [ovpn] [ 43.748400][ T10] ? ovpn_peers_free+0xb0/0xb0 [ovpn] [ 43.748403][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.748404][ T10] ? lock_acquire+0x13c/0x160 [ 43.748406][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.748408][ T10] process_one_work+0xe3e/0x1560 [ 43.748412][ T10] ? __queue_delayed_work+0x470/0x470 [ 43.748414][ T10] ? find_held_lock+0x2b/0x80 [ 43.748416][ T10] ? __rwlock_init+0x150/0x150 [ 43.748419][ T10] worker_thread+0x4f1/0xd60 [ 43.748421][ T10] ? rescuer_thread+0x1340/0x1340 [ 43.748423][ T10] ? __kthread_parkme+0xbd/0x210 [ 43.748426][ T10] ? rescuer_thread+0x1340/0x1340 [ 43.748428][ T10] ? rescuer_thread+0x1340/0x1340 [ 43.748429][ T10] kthread+0x367/0x460 [ 43.748431][ T10] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 43.748432][ T10] ? kthread_affine_preferred+0x4c0/0x4c0 [ 43.748434][ T10] ret_from_fork+0x474/0x6b0 [ 43.748437][ T10] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 43.748439][ T10] ? __switch_to+0x5a3/0xe00 [ 43.748442][ T10] ? kthread_affine_preferred+0x4c0/0x4c0 [ 43.748444][ T10] ret_from_fork_asm+0x11/0x20 [ 43.748447][ T10] [ 43.763367][ T10] tun0: deleting peer with id 3, reason 2 [ 43.763576][ T10] tun0: deleting peer with id 5, reason 2 [ 43.763746][ T10] tun0: deleting peer with id 6, reason 2 [ 48.868157][ T65] tun3: deleting peer with id 3, reason 2 [ 48.868176][ T65] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 48.868179][ T65] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 65, name: kworker/3:1 [ 48.868181][ T65] preempt_count: 202, expected: 0 [ 48.868182][ T65] RCU nest depth: 0, expected: 0 [ 48.868183][ T65] INFO: lockdep is turned off. [ 48.868184][ T65] irq event stamp: 25276 [ 48.868184][ T65] hardirqs last enabled at (25275): [] _raw_spin_unlock_irq+0x28/0x50 [ 48.868192][ T65] hardirqs last disabled at (25276): [] __schedule+0x1246/0x20e0 [ 48.868195][ T65] softirqs last enabled at (24128): [] process_one_work+0xe3e/0x1560 [ 48.868199][ T65] softirqs last disabled at (24124): [] neigh_managed_work+0x2d/0x220 [ 48.868204][ T65] Preemption disabled at: [ 48.868204][ T65] [<0000000000000000>] 0x0 [ 48.868211][ T65] CPU: 3 UID: 0 PID: 65 Comm: kworker/3:1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 48.868215][ T65] Tainted: [W]=WARN [ 48.868216][ T65] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 48.868218][ T65] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 48.868226][ T65] Call Trace: [ 48.868227][ T65] [ 48.868229][ T65] dump_stack_lvl+0x6f/0xa0 [ 48.868235][ T65] __might_resched.cold+0x1fe/0x2c1 [ 48.868239][ T65] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 48.868242][ T65] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 48.868244][ T65] ? rcu_is_watching+0x16/0xd0 [ 48.868248][ T65] __kmalloc_noprof+0x443/0x760 [ 48.868252][ T65] ? __rwlock_init+0x150/0x150 [ 48.868255][ T65] ? alloc_buf.isra.0+0x4b/0x260 [ 48.868258][ T65] ? do_raw_spin_unlock+0x59/0x250 [ 48.868260][ T65] alloc_buf.isra.0+0x4b/0x260 [ 48.868262][ T65] put_chars+0x1e1/0x2f0 [ 48.868264][ T65] ? prb_final_commit+0x50/0x50 [ 48.868266][ T65] ? __send_to_port+0x420/0x420 [ 48.868267][ T65] ? printk_get_next_message+0x240/0x650 [ 48.868270][ T65] hvc_console_print+0x292/0x780 [ 48.868274][ T65] ? hvc_write+0x3a0/0x3a0 [ 48.868276][ T65] ? do_raw_spin_lock+0x131/0x280 [ 48.868277][ T65] ? vsnprintf+0x527/0x1700 [ 48.868279][ T65] ? __rwlock_init+0x150/0x150 [ 48.868281][ T65] ? rcu_is_watching+0x16/0xd0 [ 48.868283][ T65] ? lock_acquire+0x13c/0x160 [ 48.868285][ T65] console_emit_next_record+0x22f/0x4c0 [ 48.868288][ T65] ? devkmsg_read+0x4b0/0x4b0 [ 48.868290][ T65] ? rcu_is_watching+0x16/0xd0 [ 48.868292][ T65] ? rcu_is_watching+0x16/0xd0 [ 48.868293][ T65] ? rcu_is_watching+0x16/0xd0 [ 48.868295][ T65] ? lock_acquire+0x13c/0x160 [ 48.868297][ T65] ? console_flush_one_record+0x111/0x710 [ 48.868299][ T65] console_flush_one_record+0x46f/0x710 [ 48.868301][ T65] ? console_emit_next_record+0x4c0/0x4c0 [ 48.868303][ T65] console_unlock+0xee/0x1f0 [ 48.868305][ T65] ? lock_acquire+0x13c/0x160 [ 48.868307][ T65] ? console_flush_one_record+0x710/0x710 [ 48.868308][ T65] ? rcu_is_watching+0x16/0xd0 [ 48.868310][ T65] ? lock_release+0x184/0x1f0 [ 48.868312][ T65] ? lock_acquire+0x60/0x160 [ 48.868313][ T65] ? __rcu_read_lock+0x30/0x70 [ 48.868315][ T65] ? __down_trylock_console_sem+0x5e/0xa0 [ 48.868317][ T65] ? vprintk_emit+0x320/0x3e0 [ 48.868319][ T65] vprintk_emit+0x37c/0x3e0 [ 48.868321][ T65] ? wake_up_klogd_work_func+0x90/0x90 [ 48.868323][ T65] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 48.868325][ T65] ? rcu_is_watching+0x16/0xd0 [ 48.868326][ T65] ? trace_sched_wakeup+0x9b/0x160 [ 48.868329][ T65] _printk+0xc7/0x100 [ 48.868332][ T65] ? snapshot_read.cold+0x21/0x21 [ 48.868333][ T65] ? try_to_wake_up+0x153/0x1130 [ 48.868335][ T65] ? select_fallback_rq+0x510/0x510 [ 48.868337][ T65] ? netdev_name+0x43/0x60 [ 48.868340][ T65] ? __netdev_printk+0x17f/0x1d0 [ 48.868341][ T65] netdev_info+0xe2/0x116 [ 48.868343][ T65] ? netdev_notice+0x120/0x120 [ 48.868345][ T65] ? rcu_is_watching+0x16/0xd0 [ 48.868347][ T65] ? __queue_work+0x3ab/0xd30 [ 48.868349][ T65] ? trace_irq_enable.constprop.0+0x30/0x160 [ 48.868352][ T65] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 48.868356][ T65] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 48.868358][ T65] ? rcu_is_watching+0x16/0xd0 [ 48.868360][ T65] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 48.868362][ T65] ovpn_peer_remove+0x394/0x640 [ovpn] [ 48.868365][ T65] ? do_raw_spin_lock+0x131/0x280 [ 48.868367][ T65] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 48.868369][ T65] ? __rwlock_init+0x150/0x150 [ 48.868371][ T65] ? rcu_is_watching+0x16/0xd0 [ 48.868372][ T65] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 48.868374][ T65] ? trace_irq_disable.constprop.0+0x9b/0x160 [ 48.868375][ T65] ovpn_peer_keepalive_work_single+0x416/0x600 [ovpn] [ 48.868378][ T65] ? ovpn_peers_release_mp+0x490/0x490 [ovpn] [ 48.868380][ T65] ? __rwlock_init+0x150/0x150 [ 48.868383][ T65] ovpn_peer_keepalive_work+0x389/0x580 [ovpn] [ 48.868386][ T65] ? ovpn_peers_free+0xb0/0xb0 [ovpn] [ 48.868388][ T65] ? rcu_is_watching+0x16/0xd0 [ 48.868390][ T65] ? lock_acquire+0x13c/0x160 [ 48.868391][ T65] ? rcu_is_watching+0x16/0xd0 [ 48.868394][ T65] ? process_one_work+0xdfc/0x1560 [ 48.868395][ T65] process_one_work+0xe3e/0x1560 [ 48.868398][ T65] ? __queue_delayed_work+0x470/0x470 [ 48.868400][ T65] ? find_held_lock+0x2b/0x80 [ 48.868402][ T65] ? __rwlock_init+0x150/0x150 [ 48.868404][ T65] worker_thread+0x4f1/0xd60 [ 48.868407][ T65] ? rescuer_thread+0x1340/0x1340 [ 48.868408][ T65] ? __kthread_parkme+0xbd/0x210 [ 48.868411][ T65] ? rescuer_thread+0x1340/0x1340 [ 48.868413][ T65] ? rescuer_thread+0x1340/0x1340 [ 48.868414][ T65] kthread+0x367/0x460 [ 48.868416][ T65] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 48.868417][ T65] ? kthread_affine_preferred+0x4c0/0x4c0 [ 48.868419][ T65] ret_from_fork+0x474/0x6b0 [ 48.868422][ T65] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 48.868424][ T65] ? __switch_to+0x5a3/0xe00 [ 48.868426][ T65] ? kthread_affine_preferred+0x4c0/0x4c0 [ 48.868428][ T65] ret_from_fork_asm+0x11/0x20 [ 48.868432][ T65] [ 48.932151][ T10] tun4: deleting peer with id 4, reason 2 [ 48.996135][ T10] tun5: deleting peer with id 5, reason 2 [ 48.996145][ T65] tun6: deleting peer with id 6, reason 2