[ 11.289600][ T249] ip (249) used greatest stack depth: 23728 bytes left [ 11.289616][ T249] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.289618][ T249] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 249, name: ip [ 11.289619][ T249] preempt_count: 2, expected: 0 [ 11.289620][ T249] RCU nest depth: 0, expected: 0 [ 11.289621][ T249] locks held by ip/249: 5, last CPU#2: [ 11.289623][ T249] #0: ffffffffaf2127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 11.289634][ T249] #1: ffffffffaf379cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.289639][ T249] #2: ffffffffaf379d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.289643][ T249] #3: ffffffffaf299660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.289647][ T249] #4: ffffffffaf299560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.289651][ T249] irq event stamp: 44122 [ 11.289651][ T249] hardirqs last enabled at (44121): [] __down_trylock_console_sem+0x86/0xa0 [ 11.289654][ T249] hardirqs last disabled at (44122): [] console_emit_next_record+0x3d4/0x4c0 [ 11.289656][ T249] softirqs last enabled at (40522): [] handle_softirqs+0x67c/0x900 [ 11.289658][ T249] softirqs last disabled at (39825): [] __irq_exit_rcu+0x145/0x1c0 [ 11.289660][ T249] Preemption disabled at: [ 11.289661][ T249] [<0000000000000000>] 0x0 [ 11.289667][ T249] CPU: 2 UID: 0 PID: 249 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.289671][ T249] Tainted: [W]=WARN [ 11.289671][ T249] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.289673][ T249] Call Trace: [ 11.289674][ T249] [ 11.289676][ T249] dump_stack_lvl+0x6f/0xa0 [ 11.289682][ T249] __might_resched.cold+0x1fe/0x2c1 [ 11.289686][ T249] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.289690][ T249] ? __kmalloc_noprof+0xdb/0x760 [ 11.289695][ T249] __kmalloc_noprof+0x443/0x760 [ 11.289697][ T249] ? alloc_buf.isra.0+0x4b/0x260 [ 11.289703][ T249] ? do_raw_spin_unlock+0x59/0x250 [ 11.289706][ T249] alloc_buf.isra.0+0x4b/0x260 [ 11.289709][ T249] put_chars+0x1e1/0x2f0 [ 11.289712][ T249] ? __send_to_port+0x420/0x420 [ 11.289713][ T249] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.289718][ T249] ? validate_chain+0x38b/0xc20 [ 11.289723][ T249] hvc_console_print+0x292/0x780 [ 11.289730][ T249] ? hvc_write+0x3a0/0x3a0 [ 11.289732][ T249] ? rcu_is_watching+0x16/0xd0 [ 11.289734][ T249] ? lock_acquire+0x13c/0x160 [ 11.289738][ T249] console_emit_next_record+0x22f/0x4c0 [ 11.289742][ T249] ? devkmsg_read+0x4b0/0x4b0 [ 11.289744][ T249] ? console_flush_one_record+0x106/0x710 [ 11.289747][ T249] ? rcu_is_watching+0x16/0xd0 [ 11.289749][ T249] ? lock_acquire+0x13c/0x160 [ 11.289753][ T249] console_flush_one_record+0x46f/0x710 [ 11.289757][ T249] ? console_emit_next_record+0x4c0/0x4c0 [ 11.289759][ T249] ? __lock_acquire+0x518/0xc20 [ 11.289763][ T249] console_unlock+0xee/0x1f0 [ 11.289766][ T249] ? console_flush_one_record+0x710/0x710 [ 11.289768][ T249] ? rcu_is_watching+0x16/0xd0 [ 11.289770][ T249] ? lock_acquire+0x60/0x160 [ 11.289774][ T249] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.289775][ T249] ? vprintk_emit+0x320/0x3e0 [ 11.289779][ T249] vprintk_emit+0x37c/0x3e0 [ 11.289782][ T249] ? wake_up_klogd_work_func+0x90/0x90 [ 11.289786][ T249] ? __lock_acquire+0x518/0xc20 [ 11.289789][ T249] _printk+0xc7/0x100 [ 11.289793][ T249] ? snapshot_read.cold+0x21/0x21 [ 11.289795][ T249] ? do_raw_spin_lock+0x131/0x280 [ 11.289798][ T249] ? __rwlock_init+0x150/0x150 [ 11.289801][ T249] ? do_raw_spin_lock+0x131/0x280 [ 11.289804][ T249] do_exit.cold+0x82/0x9c [ 11.289808][ T249] ? exit_notify+0x890/0x890 [ 11.289809][ T249] ? __lock_release.isra.0+0x69/0x1a0 [ 11.289811][ T249] ? rcu_is_watching+0x16/0xd0 [ 11.289816][ T249] do_group_exit+0xb8/0x370 [ 11.289819][ T249] __x64_sys_exit_group+0x3c/0x50 [ 11.289820][ T249] x64_sys_call+0x1567/0x1570 [ 11.289823][ T249] do_syscall_64+0xff/0x530 [ 11.289827][ T249] ? exc_page_fault+0xee/0x100 [ 11.289830][ T249] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.289832][ T249] RIP: 0033:0x7f01c25e61b8 [ 11.289834][ T249] Code: Unable to access opcode bytes at 0x7f01c25e618e. [ 11.289836][ T249] RSP: 002b:00007ffd00467378 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 11.289838][ T249] RAX: ffffffffffffffda RBX: 00007f01c2716f88 RCX: 00007f01c25e61b8 [ 11.289839][ T249] RDX: 00007f01c2330fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 11.289840][ T249] RBP: 00007ffd004673d0 R08: 0000000000000000 R09: 0000000000000000 [ 11.289841][ T249] R10: 00007ffd00467190 R11: 0000000000000246 R12: 0000000000000001 [ 11.289841][ T249] R13: 0000000000000000 R14: 00007f01c2715680 R15: 00007f01c2716fa0 [ 11.289848][ T249] [ 20.948973][ T350] tun1: deleting peer with id 10, reason 4 [ 20.949071][ T350] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 20.949073][ T350] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 350, name: ovpn-cli [ 20.949075][ T350] preempt_count: 202, expected: 0 [ 20.949076][ T350] RCU nest depth: 0, expected: 0 [ 20.949077][ T350] locks held by ovpn-cli/350: 6, last CPU#2: [ 20.949079][ T350] #0: ff1100000e99b478 (&sb->s_type->i_mutex_key#10){+.+.}-{4:4}, at: __sock_release+0x8f/0x280 [ 20.949092][ T350] #1: ff110000104d9e68 (&ovpn->lock){+...}-{3:3}, at: ovpn_peer_release_p2p+0x8a/0x2a0 [ovpn] [ 20.949100][ T350] #2: ffffffffaf379cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 20.949106][ T350] #3: ffffffffaf379d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 20.949110][ T350] #4: ffffffffaf299660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 20.949114][ T350] #5: ffffffffaf299560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 20.949119][ T350] irq event stamp: 3637 [ 20.949120][ T350] hardirqs last enabled at (3636): [] __down_trylock_console_sem+0x86/0xa0 [ 20.949123][ T350] hardirqs last disabled at (3637): [] console_emit_next_record+0x3d4/0x4c0 [ 20.949125][ T350] softirqs last enabled at (3626): [] udpv6_destroy_sock+0x73/0x200 [ 20.949129][ T350] softirqs last disabled at (3628): [] ovpn_peer_release_p2p+0x8a/0x2a0 [ovpn] [ 20.949132][ T350] Preemption disabled at: [ 20.949133][ T350] [<0000000000000000>] 0x0 [ 20.949140][ T350] CPU: 2 UID: 0 PID: 350 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 20.949144][ T350] Tainted: [W]=WARN [ 20.949146][ T350] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 20.949147][ T350] Call Trace: [ 20.949149][ T350] [ 20.949151][ T350] dump_stack_lvl+0x6f/0xa0 [ 20.949157][ T350] __might_resched.cold+0x1fe/0x2c1 [ 20.949161][ T350] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 20.949165][ T350] ? __kmalloc_noprof+0xdb/0x760 [ 20.949170][ T350] __kmalloc_noprof+0x443/0x760 [ 20.949173][ T350] ? alloc_buf.isra.0+0x4b/0x260 [ 20.949179][ T350] ? do_raw_spin_unlock+0x59/0x250 [ 20.949182][ T350] alloc_buf.isra.0+0x4b/0x260 [ 20.949186][ T350] put_chars+0x1e1/0x2f0 [ 20.949189][ T350] ? __send_to_port+0x420/0x420 [ 20.949197][ T350] hvc_console_print+0x292/0x780 [ 20.949204][ T350] ? hvc_write+0x3a0/0x3a0 [ 20.949207][ T350] ? lock_acquire+0x13c/0x160 [ 20.949212][ T350] console_emit_next_record+0x22f/0x4c0 [ 20.949216][ T350] ? devkmsg_read+0x4b0/0x4b0 [ 20.949218][ T350] ? console_flush_one_record+0x106/0x710 [ 20.949222][ T350] ? rcu_is_watching+0x16/0xd0 [ 20.949228][ T350] ? lock_acquire+0x13c/0x160 [ 20.949233][ T350] console_flush_one_record+0x46f/0x710 [ 20.949238][ T350] ? console_emit_next_record+0x4c0/0x4c0 [ 20.949240][ T350] ? __lock_acquire+0x518/0xc20 [ 20.949246][ T350] console_unlock+0xee/0x1f0 [ 20.949250][ T350] ? console_flush_one_record+0x710/0x710 [ 20.949252][ T350] ? rcu_is_watching+0x16/0xd0 [ 20.949254][ T350] ? lock_acquire+0x60/0x160 [ 20.949258][ T350] ? __down_trylock_console_sem+0x5e/0xa0 [ 20.949260][ T350] ? vprintk_emit+0x320/0x3e0 [ 20.949264][ T350] vprintk_emit+0x37c/0x3e0 [ 20.949268][ T350] ? wake_up_klogd_work_func+0x90/0x90 [ 20.949271][ T350] ? __lock_release.isra.0+0x69/0x1a0 [ 20.949276][ T350] _printk+0xc7/0x100 [ 20.949279][ T350] ? snapshot_read.cold+0x21/0x21 [ 20.949281][ T350] ? try_to_wake_up+0x153/0x1130 [ 20.949285][ T350] ? select_fallback_rq+0x510/0x510 [ 20.949287][ T350] ? netdev_name+0x43/0x60 [ 20.949290][ T350] ? __netdev_printk+0x17f/0x1d0 [ 20.949294][ T350] netdev_info+0xe2/0x116 [ 20.949296][ T350] ? netdev_notice+0x120/0x120 [ 20.949301][ T350] ? __queue_work+0x3ab/0xd30 [ 20.949306][ T350] ? __sock_release+0xb8/0x280 [ 20.949310][ T350] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 20.949316][ T350] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 20.949320][ T350] ? mark_held_locks+0x40/0x70 [ 20.949323][ T350] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 20.949325][ T350] ? lockdep_hardirqs_on+0x91/0x130 [ 20.949330][ T350] ovpn_peer_remove+0x394/0x640 [ovpn] [ 20.949333][ T350] ? do_raw_spin_lock+0x131/0x280 [ 20.949336][ T350] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 20.949339][ T350] ? __rwlock_init+0x150/0x150 [ 20.949346][ T350] ovpn_peer_release_p2p+0x155/0x2a0 [ovpn] [ 20.949351][ T350] ? ovpn_peer_remove+0x640/0x640 [ovpn] [ 20.949355][ T350] ? ovpn_udp_encap_destroy+0xc6/0x280 [ovpn] [ 20.949362][ T350] udpv6_destroy_sock+0xe2/0x200 [ 20.949364][ T350] sk_common_release+0x62/0x310 [ 20.949369][ T350] inet_release+0x10a/0x240 [ 20.949372][ T350] ? fcntl_setlk+0xc80/0xc80 [ 20.949377][ T350] __sock_release+0xb8/0x280 [ 20.949381][ T350] sock_close+0x18/0x20 [ 20.949382][ T350] __fput+0x363/0xac0 [ 20.949386][ T350] ? lockdep_hardirqs_on+0x91/0x130 [ 20.949388][ T350] ? __call_rcu_common.constprop.0+0x3d3/0xa20 [ 20.949390][ T350] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 20.949393][ T350] ? do_raw_spin_unlock+0x59/0x250 [ 20.949396][ T350] task_work_run+0x12b/0x240 [ 20.949399][ T350] ? lockdep_hardirqs_on+0x91/0x130 [ 20.949401][ T350] ? task_work_cancel+0x30/0x30 [ 20.949404][ T350] ? kmem_cache_free+0xf8/0x550 [ 20.949409][ T350] do_exit+0x614/0xdc0 [ 20.949412][ T350] ? exit_notify+0x890/0x890 [ 20.949413][ T350] ? find_held_lock+0x2b/0x80 [ 20.949416][ T350] ? __lock_release.isra.0+0x69/0x1a0 [ 20.949418][ T350] ? __rwlock_init+0x150/0x150 [ 20.949422][ T350] do_group_exit+0xb8/0x370 [ 20.949424][ T350] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 20.949426][ T350] ? lockdep_hardirqs_on+0x91/0x130 [ 20.949427][ T350] ? _raw_spin_unlock_irq+0x28/0x50 [ 20.949430][ T350] ? _raw_spin_unlock_irq+0x33/0x50 [ 20.949431][ T350] get_signal+0x1886/0x1980 [ 20.949438][ T350] ? rcu_is_watching+0x16/0xd0 [ 20.949441][ T350] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 20.949444][ T350] ? ptrace_signal+0x600/0x600 [ 20.949446][ T350] ? __switch_to+0x5a3/0xe00 [ 20.949448][ T350] ? rcu_is_watching+0x16/0xd0 [ 20.949451][ T350] ? trace_sched_exit_tp+0x9b/0x160 [ 20.949456][ T350] arch_do_signal_or_restart+0xc2/0x3a0 [ 20.949459][ T350] ? get_sigframe_size+0x20/0x20 [ 20.949461][ T350] ? find_held_lock+0x2b/0x80 [ 20.949467][ T350] ? rcu_is_watching+0x16/0xd0 [ 20.949470][ T350] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 20.949472][ T350] exit_to_user_mode_loop+0xd5/0x5a0 [ 20.949475][ T350] ? rcu_is_watching+0x16/0xd0 [ 20.949479][ T350] do_syscall_64+0x3e3/0x530 [ 20.949482][ T350] ? exc_page_fault+0xee/0x100 [ 20.949485][ T350] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 20.949487][ T350] RIP: 0033:0x7fe0863b854e [ 20.949490][ T350] Code: Unable to access opcode bytes at 0x7fe0863b8524. [ 20.949491][ T350] RSP: 002b:00007ffc1f695fb0 EFLAGS: 00000202 ORIG_RAX: 0000000000000022 [ 20.949493][ T350] RAX: fffffffffffffdfe RBX: 0000000000000000 RCX: 00007fe0863b854e [ 20.949495][ T350] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000 [ 20.949496][ T350] RBP: 00007ffc1f695fc0 R08: 0000000000000000 R09: 0000000000000000 [ 20.949496][ T350] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffc1f696548 [ 20.949497][ T350] R13: 0000000000000008 R14: 00007fe0866a3000 R15: 000000000040bda8 [ 20.949506][ T350] [ 20.995338][ T378] tun3: deleting peer with id 12, reason 4 [ 20.995353][ T364] tun2: deleting peer with id 11, reason 4 [ 20.998034][ T321] tun0: deleting peer with id 4, reason 4 [ 20.998402][ T321] tun0: deleting peer with id 3, reason 4 [ 20.998730][ T321] tun0: deleting peer with id 5, reason 4 [ 20.999049][ T321] tun0: deleting peer with id 1, reason 4 [ 20.999382][ T321] tun0: deleting peer with id 6, reason 4 [ 20.999718][ T321] tun0: deleting peer with id 2, reason 4