[ 15.148042][ T302] ip (302) used greatest stack depth: 24480 bytes left [ 15.148058][ T302] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 15.148060][ T302] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 302, name: ip [ 15.148062][ T302] preempt_count: 2, expected: 0 [ 15.148063][ T302] RCU nest depth: 0, expected: 0 [ 15.148064][ T302] locks held by ip/302: 5, last CPU#0: [ 15.148071][ T302] #0: ffffffff8be127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 15.148082][ T302] #1: ffffffff8bf79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 15.148088][ T302] #2: ffffffff8bf79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 15.148092][ T302] #3: ffffffff8be99660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 15.148096][ T302] #4: ffffffff8be99560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 15.148100][ T302] irq event stamp: 44478 [ 15.148101][ T302] hardirqs last enabled at (44477): [] __down_trylock_console_sem+0x86/0xa0 [ 15.148103][ T302] hardirqs last disabled at (44478): [] console_emit_next_record+0x3d4/0x4c0 [ 15.148106][ T302] softirqs last enabled at (44396): [] handle_softirqs+0x67c/0x900 [ 15.148108][ T302] softirqs last disabled at (44387): [] __irq_exit_rcu+0x145/0x1c0 [ 15.148110][ T302] Preemption disabled at: [ 15.148111][ T302] [<0000000000000000>] 0x0 [ 15.148118][ T302] CPU: 0 UID: 0 PID: 302 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 15.148121][ T302] Tainted: [W]=WARN [ 15.148122][ T302] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.148124][ T302] Call Trace: [ 15.148125][ T302] [ 15.148127][ T302] dump_stack_lvl+0x6f/0xa0 [ 15.148133][ T302] __might_resched.cold+0x1fe/0x2c1 [ 15.148138][ T302] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 15.148142][ T302] ? __kmalloc_noprof+0xdb/0x760 [ 15.148147][ T302] __kmalloc_noprof+0x443/0x760 [ 15.148150][ T302] ? alloc_buf.isra.0+0x4b/0x260 [ 15.148156][ T302] ? do_raw_spin_unlock+0x59/0x250 [ 15.148159][ T302] alloc_buf.isra.0+0x4b/0x260 [ 15.148162][ T302] put_chars+0x1e1/0x2f0 [ 15.148165][ T302] ? __send_to_port+0x420/0x420 [ 15.148166][ T302] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 15.148171][ T302] ? validate_chain+0x38b/0xc20 [ 15.148177][ T302] hvc_console_print+0x292/0x780 [ 15.148183][ T302] ? hvc_write+0x3a0/0x3a0 [ 15.148186][ T302] ? rcu_is_watching+0x16/0xd0 [ 15.148188][ T302] ? lock_acquire+0x13c/0x160 [ 15.148193][ T302] console_emit_next_record+0x22f/0x4c0 [ 15.148196][ T302] ? devkmsg_read+0x4b0/0x4b0 [ 15.148198][ T302] ? console_flush_one_record+0x106/0x710 [ 15.148202][ T302] ? rcu_is_watching+0x16/0xd0 [ 15.148204][ T302] ? lock_acquire+0x13c/0x160 [ 15.148208][ T302] console_flush_one_record+0x46f/0x710 [ 15.148212][ T302] ? console_emit_next_record+0x4c0/0x4c0 [ 15.148214][ T302] ? __lock_acquire+0x518/0xc20 [ 15.148219][ T302] console_unlock+0xee/0x1f0 [ 15.148222][ T302] ? console_flush_one_record+0x710/0x710 [ 15.148224][ T302] ? rcu_is_watching+0x16/0xd0 [ 15.148227][ T302] ? lock_acquire+0x60/0x160 [ 15.148231][ T302] ? __down_trylock_console_sem+0x5e/0xa0 [ 15.148232][ T302] ? vprintk_emit+0x320/0x3e0 [ 15.148236][ T302] vprintk_emit+0x37c/0x3e0 [ 15.148240][ T302] ? wake_up_klogd_work_func+0x90/0x90 [ 15.148243][ T302] ? __lock_acquire+0x518/0xc20 [ 15.148247][ T302] _printk+0xc7/0x100 [ 15.148251][ T302] ? snapshot_read.cold+0x21/0x21 [ 15.148254][ T302] ? do_raw_spin_lock+0x131/0x280 [ 15.148256][ T302] ? __rwlock_init+0x150/0x150 [ 15.148260][ T302] ? do_raw_spin_lock+0x131/0x280 [ 15.148263][ T302] do_exit.cold+0x82/0x9c [ 15.148267][ T302] ? exit_notify+0x890/0x890 [ 15.148268][ T302] ? __lock_release.isra.0+0x69/0x1a0 [ 15.148271][ T302] ? rcu_is_watching+0x16/0xd0 [ 15.148275][ T302] do_group_exit+0xb8/0x370 [ 15.148278][ T302] __x64_sys_exit_group+0x3c/0x50 [ 15.148280][ T302] x64_sys_call+0x1567/0x1570 [ 15.148283][ T302] do_syscall_64+0xff/0x530 [ 15.148286][ T302] ? exc_page_fault+0xee/0x100 [ 15.148289][ T302] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 15.148292][ T302] RIP: 0033:0x7fdd8f3511b8 [ 15.148294][ T302] Code: Unable to access opcode bytes at 0x7fdd8f35118e. [ 15.148295][ T302] RSP: 002b:00007ffd0325f318 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 15.148298][ T302] RAX: ffffffffffffffda RBX: 00007fdd8f481f88 RCX: 00007fdd8f3511b8 [ 15.148299][ T302] RDX: 00007fdd8f09bfc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 15.148300][ T302] RBP: 00007ffd0325f370 R08: 0000000000000000 R09: 0000000000000000 [ 15.148301][ T302] R10: 00007ffd0325f130 R11: 0000000000000246 R12: 0000000000000001 [ 15.148302][ T302] R13: 0000000000000000 R14: 00007fdd8f480680 R15: 00007fdd8f481fa0 [ 15.148309][ T302] [ 25.088206][ T725] ping (725) used greatest stack depth: 24416 bytes left [ 25.088264][ T725] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 25.088266][ T725] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 725, name: ping [ 25.088268][ T725] preempt_count: 2, expected: 0 [ 25.088269][ T725] RCU nest depth: 0, expected: 0 [ 25.088270][ T725] locks held by ping/725: 5, last CPU#3: [ 25.088272][ T725] #0: ffffffff8be127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 25.088283][ T725] #1: ffffffff8bf79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 25.088289][ T725] #2: ffffffff8bf79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 25.088293][ T725] #3: ffffffff8be99660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 25.088297][ T725] #4: ffffffff8be99560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 25.088302][ T725] irq event stamp: 79010 [ 25.088303][ T725] hardirqs last enabled at (79009): [] __down_trylock_console_sem+0x86/0xa0 [ 25.088306][ T725] hardirqs last disabled at (79010): [] console_emit_next_record+0x3d4/0x4c0 [ 25.088308][ T725] softirqs last enabled at (78822): [] handle_softirqs+0x67c/0x900 [ 25.088310][ T725] softirqs last disabled at (78815): [] __irq_exit_rcu+0x145/0x1c0 [ 25.088312][ T725] Preemption disabled at: [ 25.088313][ T725] [<0000000000000000>] 0x0 [ 25.088319][ T725] CPU: 3 UID: 0 PID: 725 Comm: ping Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 25.088323][ T725] Tainted: [W]=WARN [ 25.088324][ T725] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 25.088325][ T725] Call Trace: [ 25.088327][ T725] [ 25.088328][ T725] dump_stack_lvl+0x6f/0xa0 [ 25.088335][ T725] __might_resched.cold+0x1fe/0x2c1 [ 25.088339][ T725] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 25.088344][ T725] ? __kmalloc_noprof+0xdb/0x760 [ 25.088349][ T725] __kmalloc_noprof+0x443/0x760 [ 25.088351][ T725] ? alloc_buf.isra.0+0x4b/0x260 [ 25.088357][ T725] ? do_raw_spin_unlock+0x59/0x250 [ 25.088360][ T725] alloc_buf.isra.0+0x4b/0x260 [ 25.088363][ T725] put_chars+0x1e1/0x2f0 [ 25.088366][ T725] ? __send_to_port+0x420/0x420 [ 25.088368][ T725] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 25.088373][ T725] ? validate_chain+0x38b/0xc20 [ 25.088378][ T725] hvc_console_print+0x292/0x780 [ 25.088385][ T725] ? hvc_write+0x3a0/0x3a0 [ 25.088387][ T725] ? rcu_is_watching+0x16/0xd0 [ 25.088389][ T725] ? lock_acquire+0x13c/0x160 [ 25.088393][ T725] console_emit_next_record+0x22f/0x4c0 [ 25.088397][ T725] ? devkmsg_read+0x4b0/0x4b0 [ 25.088399][ T725] ? console_flush_one_record+0x106/0x710 [ 25.088402][ T725] ? rcu_is_watching+0x16/0xd0 [ 25.088404][ T725] ? lock_acquire+0x13c/0x160 [ 25.088408][ T725] console_flush_one_record+0x46f/0x710 [ 25.088412][ T725] ? console_emit_next_record+0x4c0/0x4c0 [ 25.088414][ T725] ? __lock_acquire+0x518/0xc20 [ 25.088419][ T725] console_unlock+0xee/0x1f0 [ 25.088422][ T725] ? console_flush_one_record+0x710/0x710 [ 25.088424][ T725] ? rcu_is_watching+0x16/0xd0 [ 25.088426][ T725] ? lock_acquire+0x60/0x160 [ 25.088430][ T725] ? __down_trylock_console_sem+0x5e/0xa0 [ 25.088432][ T725] ? vprintk_emit+0x320/0x3e0 [ 25.088435][ T725] vprintk_emit+0x37c/0x3e0 [ 25.088439][ T725] ? wake_up_klogd_work_func+0x90/0x90 [ 25.088442][ T725] ? __lock_acquire+0x518/0xc20 [ 25.088446][ T725] _printk+0xc7/0x100 [ 25.088450][ T725] ? snapshot_read.cold+0x21/0x21 [ 25.088453][ T725] ? do_raw_spin_lock+0x131/0x280 [ 25.088455][ T725] ? __rwlock_init+0x150/0x150 [ 25.088459][ T725] ? do_raw_spin_lock+0x131/0x280 [ 25.088462][ T725] do_exit.cold+0x82/0x9c [ 25.088465][ T725] ? exit_notify+0x890/0x890 [ 25.088467][ T725] ? __lock_release.isra.0+0x69/0x1a0 [ 25.088469][ T725] ? rcu_is_watching+0x16/0xd0 [ 25.088473][ T725] do_group_exit+0xb8/0x370 [ 25.088476][ T725] __x64_sys_exit_group+0x3c/0x50 [ 25.088478][ T725] x64_sys_call+0x1567/0x1570 [ 25.088481][ T725] do_syscall_64+0xff/0x530 [ 25.088485][ T725] ? exc_page_fault+0xee/0x100 [ 25.088488][ T725] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 25.088492][ T725] RIP: 0033:0x7f4e1b8961b8 [ 25.088495][ T725] Code: Unable to access opcode bytes at 0x7f4e1b89618e. [ 25.088496][ T725] RSP: 002b:00007ffcc579b868 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 25.088499][ T725] RAX: ffffffffffffffda RBX: 00007f4e1b9c6f88 RCX: 00007f4e1b8961b8 [ 25.088501][ T725] RDX: 00007f4e1b6277c8 RSI: ffffffffffffffb0 RDI: 0000000000000000 [ 25.088502][ T725] RBP: 00007ffcc579b8c0 R08: 0000000000000000 R09: 0000000000000050 [ 25.088503][ T725] R10: 00007ffcc579b6e0 R11: 0000000000000246 R12: 0000000000000002 [ 25.088504][ T725] R13: 0000000000000000 R14: 00007f4e1b9c5680 R15: 00007f4e1b9c6fa0 [ 25.088510][ T725] [ 29.715112][ T753] iperf3 (753) used greatest stack depth: 23536 bytes left [ 29.715133][ T753] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 29.715135][ T753] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 753, name: iperf3 [ 29.715137][ T753] preempt_count: 2, expected: 0 [ 29.715137][ T753] RCU nest depth: 0, expected: 0 [ 29.715138][ T753] locks held by iperf3/753: 5, last CPU#2: [ 29.715140][ T753] #0: ffffffff8be127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 29.715158][ T753] #1: ffffffff8bf79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 29.715164][ T753] #2: ffffffff8bf79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 29.715167][ T753] #3: ffffffff8be99660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 29.715171][ T753] #4: ffffffff8be99560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 29.715175][ T753] irq event stamp: 7645894 [ 29.715176][ T753] hardirqs last enabled at (7645893): [] __down_trylock_console_sem+0x86/0xa0 [ 29.715179][ T753] hardirqs last disabled at (7645894): [] console_emit_next_record+0x3d4/0x4c0 [ 29.715181][ T753] softirqs last enabled at (7644792): [] handle_softirqs+0x67c/0x900 [ 29.715183][ T753] softirqs last disabled at (7643891): [] __irq_exit_rcu+0x145/0x1c0 [ 29.715185][ T753] Preemption disabled at: [ 29.715186][ T753] [<0000000000000000>] 0x0 [ 29.715194][ T753] CPU: 2 UID: 0 PID: 753 Comm: iperf3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 29.715198][ T753] Tainted: [W]=WARN [ 29.715199][ T753] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 29.715200][ T753] Call Trace: [ 29.715202][ T753] [ 29.715203][ T753] dump_stack_lvl+0x6f/0xa0 [ 29.715209][ T753] __might_resched.cold+0x1fe/0x2c1 [ 29.715214][ T753] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 29.715218][ T753] ? __kmalloc_noprof+0xdb/0x760 [ 29.715223][ T753] __kmalloc_noprof+0x443/0x760 [ 29.715225][ T753] ? alloc_buf.isra.0+0x4b/0x260 [ 29.715232][ T753] ? do_raw_spin_unlock+0x59/0x250 [ 29.715234][ T753] alloc_buf.isra.0+0x4b/0x260 [ 29.715238][ T753] put_chars+0x1e1/0x2f0 [ 29.715240][ T753] ? prb_final_commit+0x50/0x50 [ 29.715242][ T753] ? __send_to_port+0x420/0x420 [ 29.715245][ T753] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 29.715250][ T753] ? rcu_read_lock_any_held+0x3c/0x90 [ 29.715252][ T753] ? validate_chain+0x38b/0xc20 [ 29.715255][ T753] hvc_console_print+0x292/0x780 [ 29.715259][ T753] ? mark_usage+0x61/0x170 [ 29.715261][ T753] ? __lock_acquire+0x518/0xc20 [ 29.715263][ T753] ? __lock_acquire+0x518/0xc20 [ 29.715266][ T753] ? hvc_write+0x3a0/0x3a0 [ 29.715269][ T753] ? console_emit_next_record+0x1df/0x4c0 [ 29.715272][ T753] ? rcu_is_watching+0x16/0xd0 [ 29.715274][ T753] ? lock_acquire+0x13c/0x160 [ 29.715278][ T753] console_emit_next_record+0x22f/0x4c0 [ 29.715282][ T753] ? devkmsg_read+0x4b0/0x4b0 [ 29.715283][ T753] ? console_flush_one_record+0x106/0x710 [ 29.715287][ T753] ? rcu_is_watching+0x16/0xd0 [ 29.715289][ T753] ? lock_acquire+0x13c/0x160 [ 29.715293][ T753] console_flush_one_record+0x46f/0x710 [ 29.715297][ T753] ? console_emit_next_record+0x4c0/0x4c0 [ 29.715299][ T753] ? __lock_acquire+0x518/0xc20 [ 29.715304][ T753] console_unlock+0xee/0x1f0 [ 29.715307][ T753] ? console_flush_one_record+0x710/0x710 [ 29.715309][ T753] ? rcu_is_watching+0x16/0xd0 [ 29.715311][ T753] ? lock_acquire+0x60/0x160 [ 29.715315][ T753] ? __down_trylock_console_sem+0x5e/0xa0 [ 29.715317][ T753] ? vprintk_emit+0x320/0x3e0 [ 29.715320][ T753] vprintk_emit+0x37c/0x3e0 [ 29.715324][ T753] ? wake_up_klogd_work_func+0x90/0x90 [ 29.715327][ T753] ? __lock_acquire+0x518/0xc20 [ 29.715331][ T753] _printk+0xc7/0x100 [ 29.715334][ T753] ? snapshot_read.cold+0x21/0x21 [ 29.715337][ T753] ? do_raw_spin_lock+0x131/0x280 [ 29.715340][ T753] ? __rwlock_init+0x150/0x150 [ 29.715343][ T753] ? do_raw_spin_lock+0x131/0x280 [ 29.715346][ T753] do_exit.cold+0x82/0x9c [ 29.715350][ T753] ? exit_notify+0x890/0x890 [ 29.715355][ T753] __x64_sys_exit+0x42/0x50 [ 29.715356][ T753] x64_sys_call+0x156c/0x1570 [ 29.715359][ T753] do_syscall_64+0xff/0x530 [ 29.715363][ T753] ? exc_page_fault+0xee/0x100 [ 29.715366][ T753] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 29.715368][ T753] RIP: 0033:0x7f392feffc49 [ 29.715370][ T753] Code: Unable to access opcode bytes at 0x7f392feffc1f. [ 29.715372][ T753] RSP: 002b:00007f392f6bee60 EFLAGS: 00000246 ORIG_RAX: 000000000000003c [ 29.715374][ T753] RAX: ffffffffffffffda RBX: 00007f392f6bf6c0 RCX: 00007f392feffc49 [ 29.715375][ T753] RDX: 0000000000000000 RSI: 0000000000801000 RDI: 0000000000000000 [ 29.715376][ T753] RBP: 00007f392f6bef70 R08: 0000000000000001 R09: 00007f392f6bf6c0 [ 29.715377][ T753] R10: 0000000000000008 R11: 0000000000000246 R12: 00007f392eebf000 [ 29.715378][ T753] R13: 00007fff07a64970 R14: 0000000000000002 R15: 00007fff07a64a77 [ 29.715384][ T753] [ 31.478758][ T847] tun0: deleting peer with id 1, reason 1 [ 31.478804][ T847] [ 31.478805][ T847] ===================================================== [ 31.478806][ T847] WARNING: SOFTIRQ-safe -> SOFTIRQ-unsafe lock order detected [ 31.478809][ T847] 7.2.0-virtme #1 Tainted: G W [ 31.478811][ T847] ----------------------------------------------------- [ 31.478811][ T847] ovpn-cli/847 [HC0[0]:SC0[2]:HE0:SE0] is trying to acquire: [ 31.478813][ T847] ffffffff8be99660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 31.478825][ T847] [ 31.478825][ T847] and this task is already holding: [ 31.478826][ T847] ff110000087f1e68 (&ovpn->lock){+.-.}-{3:3}, at: ovpn_peer_del+0xa0/0x590 [ovpn] [ 31.478833][ T847] which would create a new lock dependency: [ 31.478833][ T847] (&ovpn->lock){+.-.}-{3:3} -> (console_owner){....}-{0:0} [ 31.478836][ T847] [ 31.478836][ T847] but this new dependency connects a SOFTIRQ-irq-safe lock: [ 31.478837][ T847] (&ovpn->lock){+.-.}-{3:3} [ 31.478838][ T847] [ 31.478838][ T847] ... which became SOFTIRQ-irq-safe at: [ 31.478839][ T847] __lock_acquire+0x388/0xc20 [ 31.478843][ T847] lock_acquire.part.0+0xd4/0x280 [ 31.478844][ T847] _raw_spin_lock_bh+0x38/0x50 [ 31.478847][ T847] ovpn_peer_endpoints_update+0xbc6/0x1ba0 [ovpn] [ 31.478850][ T847] ovpn_decrypt_post+0x74a/0x13e0 [ovpn] [ 31.478853][ T847] ovpn_udp_encap_recv+0x295/0x610 [ovpn] [ 31.478855][ T847] udp_queue_rcv_one_skb+0x645/0xb00 [ 31.478858][ T847] udp_unicast_rcv_skb+0x366/0x450 [ 31.478860][ T847] udp_rcv+0xaba/0x1d90 [ 31.478861][ T847] ip_protocol_deliver_rcu+0x82/0x350 [ 31.478864][ T847] ip_local_deliver_finish+0x36f/0x610 [ 31.478865][ T847] ip_local_deliver+0x184/0x4c0 [ 31.478866][ T847] ip_rcv+0xdc/0x3d0 [ 31.478867][ T847] __netif_receive_skb_one_core+0xfc/0x180 [ 31.478871][ T847] process_backlog+0x431/0x14c0 [ 31.478873][ T847] __napi_poll+0xa7/0x3b0 [ 31.478874][ T847] net_rx_action+0x513/0xf50 [ 31.478876][ T847] handle_softirqs+0x1d3/0x900 [ 31.478879][ T847] do_softirq+0xac/0xe0 [ 31.478880][ T847] __local_bh_enable_ip+0x118/0x150 [ 31.478881][ T847] __dev_queue_xmit+0x979/0x1b80 [ 31.478883][ T847] ip_finish_output2+0x5b9/0x1bc0 [ 31.478885][ T847] ip_output+0x1ca/0x660 [ 31.478886][ T847] ip_push_pending_frames+0xf6/0x250 [ 31.478888][ T847] raw_sendmsg+0x1169/0x1cc0 [ 31.478889][ T847] __sys_sendto+0x2aa/0x400 [ 31.478892][ T847] __x64_sys_sendto+0xe4/0x1f0 [ 31.478894][ T847] do_syscall_64+0xff/0x530 [ 31.478896][ T847] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 31.478899][ T847] [ 31.478899][ T847] to a SOFTIRQ-irq-unsafe lock: [ 31.478899][ T847] (fs_reclaim){+.+.}-{0:0} [ 31.478901][ T847] [ 31.478901][ T847] ... which became SOFTIRQ-irq-unsafe at: [ 31.478901][ T847] ... [ 31.478902][ T847] __lock_acquire+0x388/0xc20 [ 31.478904][ T847] lock_acquire.part.0+0xd4/0x280 [ 31.478905][ T847] fs_reclaim_acquire+0xd5/0x120 [ 31.478908][ T847] __kmalloc_cache_noprof+0x6e/0x620 [ 31.478910][ T847] kthread_create_worker_on_node+0xea/0x210 [ 31.478913][ T847] workqueue_init+0x2a/0x680 [ 31.478916][ T847] kernel_init_freeable+0x2fe/0x630 [ 31.478919][ T847] kernel_init+0x21/0x150 [ 31.478921][ T847] ret_from_fork+0x474/0x6b0 [ 31.478923][ T847] ret_from_fork_asm+0x11/0x20 [ 31.478926][ T847] [ 31.478926][ T847] other info that might help us debug this: [ 31.478926][ T847] [ 31.478927][ T847] Chain exists of: [ 31.478927][ T847] &ovpn->lock --> console_owner --> fs_reclaim [ 31.478927][ T847] [ 31.478929][ T847] Possible interrupt unsafe locking scenario: [ 31.478929][ T847] [ 31.478929][ T847] CPU0 CPU1 [ 31.478930][ T847] ---- ---- [ 31.478930][ T847] lock(fs_reclaim); [ 31.478931][ T847] local_irq_disable(); [ 31.478932][ T847] lock(&ovpn->lock); [ 31.478932][ T847] lock(console_owner); [ 31.478933][ T847] [ 31.478934][ T847] lock(&ovpn->lock); [ 31.478934][ T847] [ 31.478934][ T847] *** DEADLOCK *** [ 31.478934][ T847] [ 31.478935][ T847] locks held by ovpn-cli/847: 4, last CPU#3: [ 31.478936][ T847] #0: ffffffff8c744b68 (cb_lock){++++}-{4:4}, at: genl_rcv+0x19/0x40 [ 31.478941][ T847] #1: ff110000087f1e68 (&ovpn->lock){+.-.}-{3:3}, at: ovpn_peer_del+0xa0/0x590 [ovpn] [ 31.478945][ T847] #2: ffffffff8bf79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 31.478948][ T847] #3: ffffffff8bf79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 31.478951][ T847] [ 31.478951][ T847] the dependencies between SOFTIRQ-irq-safe lock and the holding lock: [ 31.478952][ T847] -> (&ovpn->lock){+.-.}-{3:3} { [ 31.478954][ T847] HARDIRQ-ON-W at: [ 31.478955][ T847] __lock_acquire+0x388/0xc20 [ 31.478957][ T847] lock_acquire.part.0+0xd4/0x280 [ 31.478958][ T847] _raw_spin_lock_bh+0x38/0x50 [ 31.478959][ T847] ovpn_peer_add_mp+0xad/0x6a0 [ovpn] [ 31.478962][ T847] ovpn_peer_add+0x152/0x330 [ovpn] [ 31.478964][ T847] ovpn_nl_peer_new_doit+0x54f/0xcf0 [ovpn] [ 31.478966][ T847] genl_family_rcv_msg_doit+0x206/0x300 [ 31.478968][ T847] genl_family_rcv_msg+0x3a4/0x640 [ 31.478969][ T847] genl_rcv_msg+0xbb/0x160 [ 31.478971][ T847] netlink_rcv_skb+0x14e/0x3a0 [ 31.478973][ T847] genl_rcv+0x28/0x40 [ 31.478974][ T847] netlink_unicast+0x486/0x750 [ 31.478976][ T847] netlink_sendmsg+0x735/0xc60 [ 31.478977][ T847] ____sys_sendmsg+0x415/0x880 [ 31.478979][ T847] ___sys_sendmsg+0x14e/0x1d0 [ 31.478981][ T847] __sys_sendmsg+0x12c/0x1d0 [ 31.478982][ T847] do_syscall_64+0xff/0x530 [ 31.478984][ T847] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 31.478985][ T847] IN-SOFTIRQ-W at: [ 31.478985][ T847] __lock_acquire+0x388/0xc20 [ 31.478987][ T847] lock_acquire.part.0+0xd4/0x280 [ 31.478988][ T847] _raw_spin_lock_bh+0x38/0x50 [ 31.478989][ T847] ovpn_peer_endpoints_update+0xbc6/0x1ba0 [ovpn] [ 31.478991][ T847] ovpn_decrypt_post+0x74a/0x13e0 [ovpn] [ 31.478993][ T847] ovpn_udp_encap_recv+0x295/0x610 [ovpn] [ 31.478995][ T847] udp_queue_rcv_one_skb+0x645/0xb00 [ 31.478997][ T847] udp_unicast_rcv_skb+0x366/0x450 [ 31.478998][ T847] udp_rcv+0xaba/0x1d90 [ 31.478999][ T847] ip_protocol_deliver_rcu+0x82/0x350 [ 31.479001][ T847] ip_local_deliver_finish+0x36f/0x610 [ 31.479002][ T847] ip_local_deliver+0x184/0x4c0 [ 31.479003][ T847] ip_rcv+0xdc/0x3d0 [ 31.479004][ T847] __netif_receive_skb_one_core+0xfc/0x180 [ 31.479006][ T847] process_backlog+0x431/0x14c0 [ 31.479008][ T847] __napi_poll+0xa7/0x3b0 [ 31.479009][ T847] net_rx_action+0x513/0xf50 [ 31.479011][ T847] handle_softirqs+0x1d3/0x900 [ 31.479012][ T847] do_softirq+0xac/0xe0 [ 31.479013][ T847] __local_bh_enable_ip+0x118/0x150 [ 31.479014][ T847] __dev_queue_xmit+0x979/0x1b80 [ 31.479016][ T847] ip_finish_output2+0x5b9/0x1bc0 [ 31.479017][ T847] ip_output+0x1ca/0x660 [ 31.479019][ T847] ip_push_pending_frames+0xf6/0x250 [ 31.479020][ T847] raw_sendmsg+0x1169/0x1cc0 [ 31.479021][ T847] __sys_sendto+0x2aa/0x400 [ 31.479023][ T847] __x64_sys_sendto+0xe4/0x1f0 [ 31.479024][ T847] do_syscall_64+0xff/0x530 [ 31.479026][ T847] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 31.479029][ T847] INITIAL USE at: [ 31.479030][ T847] __lock_acquire+0x388/0xc20 [ 31.479031][ T847] lock_acquire.part.0+0xd4/0x280 [ 31.479032][ T847] _raw_spin_lock_bh+0x38/0x50 [ 31.479033][ T847] ovpn_peer_add_mp+0xad/0x6a0 [ovpn] [ 31.479035][ T847] ovpn_peer_add+0x152/0x330 [ovpn] [ 31.479038][ T847] ovpn_nl_peer_new_doit+0x54f/0xcf0 [ovpn] [ 31.479040][ T847] genl_family_rcv_msg_doit+0x206/0x300 [ 31.479041][ T847] genl_family_rcv_msg+0x3a4/0x640 [ 31.479043][ T847] genl_rcv_msg+0xbb/0x160 [ 31.479044][ T847] netlink_rcv_skb+0x14e/0x3a0 [ 31.479046][ T847] genl_rcv+0x28/0x40 [ 31.479047][ T847] netlink_unicast+0x486/0x750 [ 31.479049][ T847] netlink_sendmsg+0x735/0xc60 [ 31.479050][ T847] ____sys_sendmsg+0x415/0x880 [ 31.479052][ T847] ___sys_sendmsg+0x14e/0x1d0 [ 31.479053][ T847] __sys_sendmsg+0x12c/0x1d0 [ 31.479055][ T847] do_syscall_64+0xff/0x530 [ 31.479056][ T847] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 31.479057][ T847] } [ 31.479058][ T847] ... key at: [] __key.84+0x0/0x40 [ovpn] [ 31.479061][ T847] [ 31.479061][ T847] the dependencies between the lock to be acquired [ 31.479061][ T847] and SOFTIRQ-irq-unsafe lock: [ 31.479066][ T847] -> (fs_reclaim){+.+.}-{0:0} { [ 31.479068][ T847] HARDIRQ-ON-W at: [ 31.479068][ T847] __lock_acquire+0x388/0xc20 [ 31.479070][ T847] lock_acquire.part.0+0xd4/0x280 [ 31.479071][ T847] fs_reclaim_acquire+0xd5/0x120 [ 31.479072][ T847] __kmalloc_cache_noprof+0x6e/0x620 [ 31.479074][ T847] kthread_create_worker_on_node+0xea/0x210 [ 31.479075][ T847] workqueue_init+0x2a/0x680 [ 31.479076][ T847] kernel_init_freeable+0x2fe/0x630 [ 31.479078][ T847] kernel_init+0x21/0x150 [ 31.479079][ T847] ret_from_fork+0x474/0x6b0 [ 31.479080][ T847] ret_from_fork_asm+0x11/0x20 [ 31.479082][ T847] SOFTIRQ-ON-W at: [ 31.479082][ T847] __lock_acquire+0x388/0xc20 [ 31.479084][ T847] lock_acquire.part.0+0xd4/0x280 [ 31.479085][ T847] fs_reclaim_acquire+0xd5/0x120 [ 31.479086][ T847] __kmalloc_cache_noprof+0x6e/0x620 [ 31.479087][ T847] kthread_create_worker_on_node+0xea/0x210 [ 31.479089][ T847] workqueue_init+0x2a/0x680 [ 31.479090][ T847] kernel_init_freeable+0x2fe/0x630 [ 31.479091][ T847] kernel_init+0x21/0x150 [ 31.479092][ T847] ret_from_fork+0x474/0x6b0 [ 31.479093][ T847] ret_from_fork_asm+0x11/0x20 [ 31.479095][ T847] INITIAL USE at: [ 31.479095][ T847] __lock_acquire+0x388/0xc20 [ 31.479097][ T847] lock_acquire.part.0+0xd4/0x280 [ 31.479098][ T847] fs_reclaim_acquire+0xd5/0x120 [ 31.479099][ T847] __kmalloc_cache_noprof+0x6e/0x620 [ 31.479100][ T847] kthread_create_worker_on_node+0xea/0x210 [ 31.479102][ T847] workqueue_init+0x2a/0x680 [ 31.479103][ T847] kernel_init_freeable+0x2fe/0x630 [ 31.479104][ T847] kernel_init+0x21/0x150 [ 31.479105][ T847] ret_from_fork+0x474/0x6b0 [ 31.479106][ T847] ret_from_fork_asm+0x11/0x20 [ 31.479108][ T847] } [ 31.479108][ T847] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 31.479111][ T847] ... acquired at: [ 31.479112][ T847] __lock_acquire+0x518/0xc20 [ 31.479114][ T847] lock_acquire.part.0+0xd4/0x280 [ 31.479115][ T847] fs_reclaim_acquire+0xd5/0x120 [ 31.479116][ T847] __kmalloc_noprof+0xd3/0x760 [ 31.479118][ T847] alloc_buf.isra.0+0x4b/0x260 [ 31.479121][ T847] put_chars+0x1e1/0x2f0 [ 31.479122][ T847] hvc_console_print+0x292/0x780 [ 31.479124][ T847] console_emit_next_record+0x22f/0x4c0 [ 31.479126][ T847] console_flush_one_record+0x46f/0x710 [ 31.479128][ T847] console_unlock+0xee/0x1f0 [ 31.479129][ T847] vprintk_emit+0x37c/0x3e0 [ 31.479131][ T847] _printk+0xc7/0x100 [ 31.479133][ T847] dm_interface_init+0x50/0x60 [ 31.479136][ T847] dm_init+0x51/0xd0 [ 31.479137][ T847] do_one_initcall+0x124/0x4f0 [ 31.479139][ T847] kernel_init_freeable+0x596/0x630 [ 31.479141][ T847] kernel_init+0x21/0x150 [ 31.479142][ T847] ret_from_fork+0x474/0x6b0 [ 31.479143][ T847] ret_from_fork_asm+0x11/0x20 [ 31.479144][ T847] [ 31.479144][ T847] -> (console_owner){....}-{0:0} { [ 31.479146][ T847] INITIAL USE at: [ 31.479147][ T847] } [ 31.479147][ T847] ... key at: [] console_owner_dep_map+0x0/0x60 [ 31.479156][ T847] ... acquired at: [ 31.479156][ T847] check_prev_add+0xef/0xe90 [ 31.479158][ T847] validate_chain+0x6b8/0xc20 [ 31.479159][ T847] __lock_acquire+0x518/0xc20 [ 31.479160][ T847] lock_acquire.part.0+0xd4/0x280 [ 31.479161][ T847] console_lock_spinning_enable+0x5c/0x60 [ 31.479163][ T847] console_emit_next_record+0x1d1/0x4c0 [ 31.479164][ T847] console_flush_one_record+0x46f/0x710 [ 31.479166][ T847] console_unlock+0xee/0x1f0 [ 31.479167][ T847] vprintk_emit+0x37c/0x3e0 [ 31.479169][ T847] _printk+0xc7/0x100 [ 31.479170][ T847] netdev_info+0xe2/0x116 [ 31.479172][ T847] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 31.479175][ T847] ovpn_peer_remove+0x394/0x640 [ovpn] [ 31.479178][ T847] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 31.479180][ T847] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 31.479182][ T847] genl_family_rcv_msg_doit+0x206/0x300 [ 31.479184][ T847] genl_family_rcv_msg+0x3a4/0x640 [ 31.479185][ T847] genl_rcv_msg+0xbb/0x160 [ 31.479187][ T847] netlink_rcv_skb+0x14e/0x3a0 [ 31.479188][ T847] genl_rcv+0x28/0x40 [ 31.479190][ T847] netlink_unicast+0x486/0x750 [ 31.479191][ T847] netlink_sendmsg+0x735/0xc60 [ 31.479193][ T847] ____sys_sendmsg+0x415/0x880 [ 31.479194][ T847] ___sys_sendmsg+0x14e/0x1d0 [ 31.479195][ T847] __sys_sendmsg+0x12c/0x1d0 [ 31.479197][ T847] do_syscall_64+0xff/0x530 [ 31.479198][ T847] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 31.479199][ T847] [ 31.479200][ T847] [ 31.479200][ T847] stack backtrace: [ 31.479202][ T847] CPU: 3 UID: 0 PID: 847 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 31.479206][ T847] Tainted: [W]=WARN [ 31.479207][ T847] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 31.479208][ T847] Call Trace: [ 31.479209][ T847] [ 31.479211][ T847] dump_stack_lvl+0x6f/0xa0 [ 31.479215][ T847] print_bad_irq_dependency+0x3e4/0x410 [ 31.479217][ T847] check_irq_usage+0x403/0x570 [ 31.479219][ T847] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 31.479223][ T847] ? rcu_read_lock_any_held+0x3c/0x90 [ 31.479226][ T847] ? check_path.constprop.0+0x24/0x50 [ 31.479228][ T847] ? check_prev_add+0xef/0xe90 [ 31.479229][ T847] check_prev_add+0xef/0xe90 [ 31.479231][ T847] validate_chain+0x6b8/0xc20 [ 31.479234][ T847] __lock_acquire+0x518/0xc20 [ 31.479236][ T847] lock_acquire.part.0+0xd4/0x280 [ 31.479238][ T847] ? console_lock_spinning_enable+0x40/0x60 [ 31.479240][ T847] ? rcu_is_watching+0x16/0xd0 [ 31.479242][ T847] ? lock_acquire+0x13c/0x160 [ 31.479243][ T847] console_lock_spinning_enable+0x5c/0x60 [ 31.479245][ T847] ? console_lock_spinning_enable+0x40/0x60 [ 31.479247][ T847] console_emit_next_record+0x1d1/0x4c0 [ 31.479249][ T847] ? devkmsg_read+0x4b0/0x4b0 [ 31.479251][ T847] ? console_flush_one_record+0x106/0x710 [ 31.479253][ T847] ? rcu_is_watching+0x16/0xd0 [ 31.479254][ T847] ? lock_acquire+0x13c/0x160 [ 31.479256][ T847] console_flush_one_record+0x46f/0x710 [ 31.479258][ T847] ? console_emit_next_record+0x4c0/0x4c0 [ 31.479260][ T847] ? __lock_acquire+0x518/0xc20 [ 31.479262][ T847] console_unlock+0xee/0x1f0 [ 31.479264][ T847] ? console_flush_one_record+0x710/0x710 [ 31.479266][ T847] ? rcu_is_watching+0x16/0xd0 [ 31.479267][ T847] ? lock_acquire+0x60/0x160 [ 31.479269][ T847] ? __down_trylock_console_sem+0x5e/0xa0 [ 31.479271][ T847] ? vprintk_emit+0x320/0x3e0 [ 31.479273][ T847] vprintk_emit+0x37c/0x3e0 [ 31.479275][ T847] ? wake_up_klogd_work_func+0x90/0x90 [ 31.479277][ T847] ? kernel_text_address+0x149/0x170 [ 31.479279][ T847] ? __kernel_text_address+0x12/0x30 [ 31.479280][ T847] ? write_profile+0xf0/0xf0 [ 31.479282][ T847] ? unwind_get_return_address+0x67/0xd0 [ 31.479285][ T847] _printk+0xc7/0x100 [ 31.479286][ T847] ? snapshot_read.cold+0x21/0x21 [ 31.479288][ T847] ? mark_usage+0x61/0x170 [ 31.479290][ T847] ? netdev_name+0x43/0x60 [ 31.479291][ T847] ? __netdev_printk+0x17f/0x1d0 [ 31.479293][ T847] netdev_info+0xe2/0x116 [ 31.479294][ T847] ? netdev_notice+0x120/0x120 [ 31.479295][ T847] ? find_held_lock+0x2b/0x80 [ 31.479297][ T847] ? mark_usage+0x61/0x170 [ 31.479298][ T847] ? __lock_acquire+0x518/0xc20 [ 31.479301][ T847] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 31.479304][ T847] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 31.479306][ T847] ? ovpn_peer_get_by_id+0x1fd/0x7a0 [ovpn] [ 31.479309][ T847] ovpn_peer_remove+0x394/0x640 [ovpn] [ 31.479312][ T847] ? do_raw_spin_lock+0x131/0x280 [ 31.479313][ T847] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 31.479317][ T847] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 31.479319][ T847] ? ovpn_peer_add+0x330/0x330 [ovpn] [ 31.479322][ T847] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 31.479325][ T847] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 31.479326][ T847] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 31.479328][ T847] ? ref_tracker_alloc+0x28d/0x430 [ 31.479334][ T847] ? ovpn_get_dev_from_attrs+0x170/0x660 [ovpn] [ 31.479336][ T847] ? ovpn_get_dev_from_attrs+0x17a/0x660 [ovpn] [ 31.479340][ T847] genl_family_rcv_msg_doit+0x206/0x300 [ 31.479342][ T847] ? genl_family_rcv_msg_attrs_parse.isra.0+0x330/0x330 [ 31.479344][ T847] ? __lock_release.isra.0+0x69/0x1a0 [ 31.479346][ T847] ? rcu_is_watching+0x16/0xd0 [ 31.479348][ T847] ? cap_capable+0x1d7/0x3d0 [ 31.479351][ T847] ? write_profile+0xf0/0xf0 [ 31.479353][ T847] ? unwind_get_return_address+0x67/0xd0 [ 31.479354][ T847] genl_family_rcv_msg+0x3a4/0x640 [ 31.479356][ T847] ? genl_family_rcv_msg_dumpit+0x340/0x340 [ 31.479358][ T847] ? rcu_read_lock_any_held+0x3c/0x90 [ 31.479360][ T847] ? ovpn_nl_send_peer+0x1300/0x1300 [ovpn] [ 31.479362][ T847] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 31.479365][ T847] ? ovpn_nl_pre_doit+0x90/0x90 [ovpn] [ 31.479367][ T847] ? __lock_acquire+0x518/0xc20 [ 31.479370][ T847] genl_rcv_msg+0xbb/0x160 [ 31.479372][ T847] netlink_rcv_skb+0x14e/0x3a0 [ 31.479373][ T847] ? genl_family_rcv_msg+0x640/0x640 [ 31.479375][ T847] ? netlink_ack+0xcf0/0xcf0 [ 31.479378][ T847] ? netlink_deliver_tap+0xc5/0x330 [ 31.479380][ T847] ? netlink_deliver_tap+0x13c/0x330 [ 31.479382][ T847] genl_rcv+0x28/0x40 [ 31.479384][ T847] netlink_unicast+0x486/0x750 [ 31.479386][ T847] ? netlink_attachskb+0x810/0x810 [ 31.479388][ T847] ? __lock_acquire+0x518/0xc20 [ 31.479390][ T847] netlink_sendmsg+0x735/0xc60 [ 31.479392][ T847] ? netlink_unicast+0x750/0x750 [ 31.479394][ T847] ? __might_fault+0x97/0x140 [ 31.479398][ T847] ____sys_sendmsg+0x415/0x880 [ 31.479399][ T847] ? copy_msghdr_from_user+0x279/0x420 [ 31.479401][ T847] ? get_timestamp.constprop.0+0x390/0x390 [ 31.479403][ T847] ? move_addr_to_kernel+0x40/0x40 [ 31.479405][ T847] ___sys_sendmsg+0x14e/0x1d0 [ 31.479407][ T847] ? copy_msghdr_from_user+0x420/0x420 [ 31.479409][ T847] ? kfree+0x22/0x590 [ 31.479414][ T847] __sys_sendmsg+0x12c/0x1d0 [ 31.479416][ T847] ? __sys_sendmsg_sock+0x20/0x20 [ 31.479418][ T847] ? rcu_is_watching+0x16/0xd0 [ 31.479420][ T847] ? rcu_is_watching+0x16/0xd0 [ 31.479422][ T847] do_syscall_64+0xff/0x530 [ 31.479424][ T847] ? exc_page_fault+0xee/0x100 [ 31.479425][ T847] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 31.479427][ T847] RIP: 0033:0x7f31253e354e [ 31.479430][ T847] 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.479431][ T847] RSP: 002b:00007ffd1f287fd0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 31.479434][ T847] RAX: ffffffffffffffda RBX: 000000001431b130 RCX: 00007f31253e354e [ 31.479435][ T847] RDX: 0000000000000000 RSI: 00007ffd1f288070 RDI: 0000000000000005 [ 31.479436][ T847] RBP: 00007ffd1f287fe0 R08: 0000000000000000 R09: 0000000000000000 [ 31.479437][ T847] R10: 0000000000000000 R11: 0000000000000202 R12: 000000001431b200 [ 31.479438][ T847] R13: 00007ffd1f288070 R14: 000000001431c260 R15: 000000000040bda8 [ 31.479440][ T847] [ 31.479444][ T847] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 31.479445][ T847] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 847, name: ovpn-cli [ 31.479447][ T847] preempt_count: 202, expected: 0 [ 31.479448][ T847] RCU nest depth: 0, expected: 0 [ 31.479448][ T847] INFO: lockdep is turned off. [ 31.479449][ T847] irq event stamp: 40789 [ 31.479449][ T847] hardirqs last enabled at (40788): [] __down_trylock_console_sem+0x86/0xa0 [ 31.479451][ T847] hardirqs last disabled at (40789): [] console_emit_next_record+0x3d4/0x4c0 [ 31.479453][ T847] softirqs last enabled at (40756): [] __alloc_skb+0x4c2/0x5f0 [ 31.479456][ T847] softirqs last disabled at (40784): [] ovpn_peer_del+0xa0/0x590 [ovpn] [ 31.479458][ T847] Preemption disabled at: [ 31.479459][ T847] [<0000000000000000>] 0x0 [ 31.479461][ T847] CPU: 3 UID: 0 PID: 847 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 31.479463][ T847] Tainted: [W]=WARN [ 31.479463][ T847] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 31.479464][ T847] Call Trace: [ 31.479465][ T847] [ 31.479465][ T847] dump_stack_lvl+0x6f/0xa0 [ 31.479467][ T847] __might_resched.cold+0x1fe/0x2c1 [ 31.479470][ T847] ? check_irq_usage+0x403/0x570 [ 31.479472][ T847] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 31.479475][ T847] ? rcu_is_watching+0x16/0xd0 [ 31.479477][ T847] __kmalloc_noprof+0x443/0x760 [ 31.479479][ T847] ? __rwlock_init+0x150/0x150 [ 31.479480][ T847] ? alloc_buf.isra.0+0x4b/0x260 [ 31.479482][ T847] ? do_raw_spin_unlock+0x59/0x250 [ 31.479483][ T847] alloc_buf.isra.0+0x4b/0x260 [ 31.479486][ T847] put_chars+0x1e1/0x2f0 [ 31.479488][ T847] ? __send_to_port+0x420/0x420 [ 31.479490][ T847] ? check_prev_add+0xef/0xe90 [ 31.479493][ T847] ? validate_chain+0x6b8/0xc20 [ 31.479496][ T847] hvc_console_print+0x292/0x780 [ 31.479499][ T847] ? __lock_acquire+0x518/0xc20 [ 31.479501][ T847] ? hvc_write+0x3a0/0x3a0 [ 31.479502][ T847] ? rcu_is_watching+0x16/0xd0 [ 31.479504][ T847] ? lock_acquire+0x13c/0x160 [ 31.479506][ T847] console_emit_next_record+0x22f/0x4c0 [ 31.479509][ T847] ? devkmsg_read+0x4b0/0x4b0 [ 31.479510][ T847] ? console_flush_one_record+0x106/0x710 [ 31.479512][ T847] ? rcu_is_watching+0x16/0xd0 [ 31.479514][ T847] ? lock_acquire+0x13c/0x160 [ 31.479516][ T847] console_flush_one_record+0x46f/0x710 [ 31.479518][ T847] ? console_emit_next_record+0x4c0/0x4c0 [ 31.479520][ T847] ? __lock_acquire+0x518/0xc20 [ 31.479522][ T847] console_unlock+0xee/0x1f0 [ 31.479524][ T847] ? console_flush_one_record+0x710/0x710 [ 31.479525][ T847] ? rcu_is_watching+0x16/0xd0 [ 31.479527][ T847] ? lock_acquire+0x60/0x160 [ 31.479529][ T847] ? __down_trylock_console_sem+0x5e/0xa0 [ 31.479530][ T847] ? vprintk_emit+0x320/0x3e0 [ 31.479532][ T847] vprintk_emit+0x37c/0x3e0 [ 31.479534][ T847] ? wake_up_klogd_work_func+0x90/0x90 [ 31.479536][ T847] ? kernel_text_address+0x149/0x170 [ 31.479537][ T847] ? __kernel_text_address+0x12/0x30 [ 31.479538][ T847] ? write_profile+0xf0/0xf0 [ 31.479539][ T847] ? unwind_get_return_address+0x67/0xd0 [ 31.479541][ T847] _printk+0xc7/0x100 [ 31.479543][ T847] ? snapshot_read.cold+0x21/0x21 [ 31.479545][ T847] ? mark_usage+0x61/0x170 [ 31.479546][ T847] ? netdev_name+0x43/0x60 [ 31.479547][ T847] ? __netdev_printk+0x17f/0x1d0 [ 31.479549][ T847] netdev_info+0xe2/0x116 [ 31.479550][ T847] ? netdev_notice+0x120/0x120 [ 31.479552][ T847] ? find_held_lock+0x2b/0x80 [ 31.479553][ T847] ? mark_usage+0x61/0x170 [ 31.479554][ T847] ? __lock_acquire+0x518/0xc20 [ 31.479557][ T847] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 31.479560][ T847] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 31.479562][ T847] ? ovpn_peer_get_by_id+0x1fd/0x7a0 [ovpn] [ 31.479565][ T847] ovpn_peer_remove+0x394/0x640 [ovpn] [ 31.479567][ T847] ? do_raw_spin_lock+0x131/0x280 [ 31.479569][ T847] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 31.479572][ T847] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 31.479575][ T847] ? ovpn_peer_add+0x330/0x330 [ovpn] [ 31.479578][ T847] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 31.479581][ T847] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 31.479582][ T847] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 31.479584][ T847] ? ref_tracker_alloc+0x28d/0x430 [ 31.479587][ T847] ? ovpn_get_dev_from_attrs+0x170/0x660 [ovpn] [ 31.479590][ T847] ? ovpn_get_dev_from_attrs+0x17a/0x660 [ovpn] [ 31.479593][ T847] genl_family_rcv_msg_doit+0x206/0x300 [ 31.479596][ T847] ? genl_family_rcv_msg_attrs_parse.isra.0+0x330/0x330 [ 31.479597][ T847] ? __lock_release.isra.0+0x69/0x1a0 [ 31.479600][ T847] ? rcu_is_watching+0x16/0xd0 [ 31.479602][ T847] ? cap_capable+0x1d7/0x3d0 [ 31.479603][ T847] ? write_profile+0xf0/0xf0 [ 31.479604][ T847] ? unwind_get_return_address+0x67/0xd0 [ 31.479606][ T847] genl_family_rcv_msg+0x3a4/0x640 [ 31.479608][ T847] ? genl_family_rcv_msg_dumpit+0x340/0x340 [ 31.479610][ T847] ? rcu_read_lock_any_held+0x3c/0x90 [ 31.479612][ T847] ? ovpn_nl_send_peer+0x1300/0x1300 [ovpn] [ 31.479614][ T847] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 31.479616][ T847] ? ovpn_nl_pre_doit+0x90/0x90 [ovpn] [ 31.479618][ T847] ? __lock_acquire+0x518/0xc20 [ 31.479621][ T847] genl_rcv_msg+0xbb/0x160 [ 31.479623][ T847] netlink_rcv_skb+0x14e/0x3a0 [ 31.479624][ T847] ? genl_family_rcv_msg+0x640/0x640 [ 31.479627][ T847] ? netlink_ack+0xcf0/0xcf0 [ 31.479629][ T847] ? netlink_deliver_tap+0xc5/0x330 [ 31.479631][ T847] ? netlink_deliver_tap+0x13c/0x330 [ 31.479633][ T847] genl_rcv+0x28/0x40 [ 31.479635][ T847] netlink_unicast+0x486/0x750 [ 31.479637][ T847] ? netlink_attachskb+0x810/0x810 [ 31.479639][ T847] ? __lock_acquire+0x518/0xc20 [ 31.479641][ T847] netlink_sendmsg+0x735/0xc60 [ 31.479643][ T847] ? netlink_unicast+0x750/0x750 [ 31.479645][ T847] ? __might_fault+0x97/0x140 [ 31.479647][ T847] ____sys_sendmsg+0x415/0x880 [ 31.479649][ T847] ? copy_msghdr_from_user+0x279/0x420 [ 31.479650][ T847] ? get_timestamp.constprop.0+0x390/0x390 [ 31.479652][ T847] ? move_addr_to_kernel+0x40/0x40 [ 31.479655][ T847] ___sys_sendmsg+0x14e/0x1d0 [ 31.479657][ T847] ? copy_msghdr_from_user+0x420/0x420 [ 31.479658][ T847] ? kfree+0x22/0x590 [ 31.479663][ T847] __sys_sendmsg+0x12c/0x1d0 [ 31.479665][ T847] ? __sys_sendmsg_sock+0x20/0x20 [ 31.479667][ T847] ? rcu_is_watching+0x16/0xd0 [ 31.479669][ T847] ? rcu_is_watching+0x16/0xd0 [ 31.479671][ T847] do_syscall_64+0xff/0x530 [ 31.479673][ T847] ? exc_page_fault+0xee/0x100 [ 31.479674][ T847] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 31.479675][ T847] RIP: 0033:0x7f31253e354e [ 31.479676][ T847] 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.479677][ T847] RSP: 002b:00007ffd1f287fd0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 31.479679][ T847] RAX: ffffffffffffffda RBX: 000000001431b130 RCX: 00007f31253e354e [ 31.479679][ T847] RDX: 0000000000000000 RSI: 00007ffd1f288070 RDI: 0000000000000005 [ 31.479680][ T847] RBP: 00007ffd1f287fe0 R08: 0000000000000000 R09: 0000000000000000 [ 31.479681][ T847] R10: 0000000000000000 R11: 0000000000000202 R12: 000000001431b200 [ 31.479681][ T847] R13: 00007ffd1f288070 R14: 000000001431c260 R15: 000000000040bda8 [ 31.479684][ T847] [ 31.577045][ T847] ovpn-cli (847) used greatest stack depth: 23432 bytes left [ 31.628729][ T851] tun1: deleting peer with id 10, reason 1 [ 34.170454][ T899] tun0: deleting peer with id 2, reason 1 [ 34.170473][ T899] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 34.170475][ T899] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 899, name: ovpn-cli [ 34.170477][ T899] preempt_count: 202, expected: 0 [ 34.170478][ T899] RCU nest depth: 0, expected: 0 [ 34.170479][ T899] INFO: lockdep is turned off. [ 34.170480][ T899] irq event stamp: 0 [ 34.170481][ T899] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 34.170485][ T899] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 34.170494][ T899] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 34.170497][ T899] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 34.170499][ T899] Preemption disabled at: [ 34.170500][ T899] [<0000000000000000>] 0x0 [ 34.170505][ T899] CPU: 2 UID: 0 PID: 899 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 34.170509][ T899] Tainted: [W]=WARN [ 34.170510][ T899] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 34.170511][ T899] Call Trace: [ 34.170513][ T899] [ 34.170514][ T899] dump_stack_lvl+0x6f/0xa0 [ 34.170520][ T899] __might_resched.cold+0x1fe/0x2c1 [ 34.170524][ T899] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 34.170528][ T899] ? rcu_is_watching+0x16/0xd0 [ 34.170532][ T899] __kmalloc_noprof+0x443/0x760 [ 34.170536][ T899] ? __rwlock_init+0x150/0x150 [ 34.170539][ T899] ? alloc_buf.isra.0+0x4b/0x260 [ 34.170543][ T899] ? do_raw_spin_unlock+0x59/0x250 [ 34.170545][ T899] alloc_buf.isra.0+0x4b/0x260 [ 34.170547][ T899] put_chars+0x1e1/0x2f0 [ 34.170549][ T899] ? __send_to_port+0x420/0x420 [ 34.170551][ T899] ? printk_get_next_message+0x240/0x650 [ 34.170554][ T899] hvc_console_print+0x292/0x780 [ 34.170558][ T899] ? hvc_write+0x3a0/0x3a0 [ 34.170560][ T899] ? __rwlock_init+0x150/0x150 [ 34.170562][ T899] ? rcu_is_watching+0x16/0xd0 [ 34.170564][ T899] ? lock_acquire+0x13c/0x160 [ 34.170566][ T899] console_emit_next_record+0x22f/0x4c0 [ 34.170569][ T899] ? devkmsg_read+0x4b0/0x4b0 [ 34.170571][ T899] ? rcu_is_watching+0x16/0xd0 [ 34.170572][ T899] ? rcu_is_watching+0x16/0xd0 [ 34.170574][ T899] ? rcu_is_watching+0x16/0xd0 [ 34.170576][ T899] ? lock_acquire+0x13c/0x160 [ 34.170578][ T899] ? console_flush_one_record+0x111/0x710 [ 34.170579][ T899] console_flush_one_record+0x46f/0x710 [ 34.170582][ T899] ? console_emit_next_record+0x4c0/0x4c0 [ 34.170584][ T899] console_unlock+0xee/0x1f0 [ 34.170586][ T899] ? lock_acquire+0x13c/0x160 [ 34.170588][ T899] ? console_flush_one_record+0x710/0x710 [ 34.170590][ T899] ? rcu_is_watching+0x16/0xd0 [ 34.170591][ T899] ? lock_release+0x184/0x1f0 [ 34.170593][ T899] ? lock_acquire+0x60/0x160 [ 34.170594][ T899] ? __rcu_read_lock+0x30/0x70 [ 34.170596][ T899] ? __down_trylock_console_sem+0x5e/0xa0 [ 34.170598][ T899] ? vprintk_emit+0x320/0x3e0 [ 34.170600][ T899] vprintk_emit+0x37c/0x3e0 [ 34.170603][ T899] ? wake_up_klogd_work_func+0x90/0x90 [ 34.170604][ T899] ? kernel_text_address+0x149/0x170 [ 34.170607][ T899] ? __kernel_text_address+0x12/0x30 [ 34.170608][ T899] ? write_profile+0xf0/0xf0 [ 34.170611][ T899] ? unwind_get_return_address+0x67/0xd0 [ 34.170614][ T899] _printk+0xc7/0x100 [ 34.170617][ T899] ? snapshot_read.cold+0x21/0x21 [ 34.170619][ T899] ? netdev_name+0x43/0x60 [ 34.170622][ T899] ? __netdev_printk+0x17f/0x1d0 [ 34.170624][ T899] netdev_info+0xe2/0x116 [ 34.170626][ T899] ? netdev_notice+0x120/0x120 [ 34.170627][ T899] ? ovpn_nl_pre_doit+0x44/0x90 [ovpn] [ 34.170633][ T899] ? __module_address+0x36/0x330 [ 34.170636][ T899] ? lock_acquire+0x13c/0x160 [ 34.170637][ T899] ? rcu_is_watching+0x16/0xd0 [ 34.170639][ T899] ? lock_release+0x184/0x1f0 [ 34.170641][ T899] ? ovpn_peer_get_by_id+0x38a/0x7a0 [ovpn] [ 34.170644][ T899] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 34.170648][ T899] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 34.170651][ T899] ? lock_acquire+0x13c/0x160 [ 34.170652][ T899] ? rcu_is_watching+0x16/0xd0 [ 34.170654][ T899] ? lock_release+0x184/0x1f0 [ 34.170656][ T899] ovpn_peer_remove+0x394/0x640 [ovpn] [ 34.170659][ T899] ? do_raw_spin_lock+0x131/0x280 [ 34.170661][ T899] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 34.170664][ T899] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 34.170667][ T899] ? ovpn_peer_add+0x330/0x330 [ovpn] [ 34.170671][ T899] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 34.170674][ T899] ? trace_hardirqs_on+0x36/0x40 [ 34.170676][ T899] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 34.170679][ T899] ? ref_tracker_alloc+0x28d/0x430 [ 34.170684][ T899] ? lock_release+0x184/0x1f0 [ 34.170686][ T899] ? ovpn_get_dev_from_attrs+0x17a/0x660 [ovpn] [ 34.170689][ T899] genl_family_rcv_msg_doit+0x206/0x300 [ 34.170694][ T899] ? genl_family_rcv_msg_attrs_parse.isra.0+0x330/0x330 [ 34.170696][ T899] ? rcu_is_watching+0x16/0xd0 [ 34.170699][ T899] ? rcu_is_watching+0x16/0xd0 [ 34.170700][ T899] ? cap_capable+0x1d7/0x3d0 [ 34.170704][ T899] ? write_profile+0xf0/0xf0 [ 34.170705][ T899] ? unwind_get_return_address+0x67/0xd0 [ 34.170707][ T899] genl_family_rcv_msg+0x3a4/0x640 [ 34.170709][ T899] ? genl_family_rcv_msg_dumpit+0x340/0x340 [ 34.170712][ T899] ? ovpn_nl_send_peer+0x1300/0x1300 [ovpn] [ 34.170714][ T899] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 34.170716][ T899] ? ovpn_nl_pre_doit+0x90/0x90 [ovpn] [ 34.170719][ T899] ? filter_irq_stacks+0xd0/0xd0 [ 34.170720][ T899] ? stack_depot_save_flags+0x1bc/0x790 [ 34.170723][ T899] genl_rcv_msg+0xbb/0x160 [ 34.170725][ T899] netlink_rcv_skb+0x14e/0x3a0 [ 34.170727][ T899] ? genl_family_rcv_msg+0x640/0x640 [ 34.170729][ T899] ? netlink_ack+0xcf0/0xcf0 [ 34.170732][ T899] ? lock_acquire+0x13c/0x160 [ 34.170734][ T899] ? rcu_is_watching+0x16/0xd0 [ 34.170735][ T899] ? lock_release+0x184/0x1f0 [ 34.170737][ T899] genl_rcv+0x28/0x40 [ 34.170739][ T899] netlink_unicast+0x486/0x750 [ 34.170742][ T899] ? netlink_attachskb+0x810/0x810 [ 34.170743][ T899] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 34.170745][ T899] ? trace_hardirqs_on+0x36/0x40 [ 34.170746][ T899] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 34.170750][ T899] netlink_sendmsg+0x735/0xc60 [ 34.170752][ T899] ? netlink_unicast+0x750/0x750 [ 34.170754][ T899] ? rcu_is_watching+0x16/0xd0 [ 34.170756][ T899] ? lock_release+0x184/0x1f0 [ 34.170758][ T899] ____sys_sendmsg+0x415/0x880 [ 34.170762][ T899] ? copy_msghdr_from_user+0x279/0x420 [ 34.170763][ T899] ? get_timestamp.constprop.0+0x390/0x390 [ 34.170765][ T899] ? move_addr_to_kernel+0x40/0x40 [ 34.170768][ T899] ___sys_sendmsg+0x14e/0x1d0 [ 34.170770][ T899] ? copy_msghdr_from_user+0x420/0x420 [ 34.170772][ T899] ? kfree+0x22/0x590 [ 34.170777][ T899] __sys_sendmsg+0x12c/0x1d0 [ 34.170779][ T899] ? __sys_sendmsg_sock+0x20/0x20 [ 34.170782][ T899] ? rcu_is_watching+0x16/0xd0 [ 34.170784][ T899] ? rcu_is_watching+0x16/0xd0 [ 34.170786][ T899] do_syscall_64+0xff/0x530 [ 34.170789][ T899] ? exc_page_fault+0xee/0x100 [ 34.170791][ T899] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 34.170793][ T899] RIP: 0033:0x7f9ff22a454e [ 34.170795][ T899] 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.170797][ T899] RSP: 002b:00007ffe352f62b0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 34.170800][ T899] RAX: ffffffffffffffda RBX: 00000000073af130 RCX: 00007f9ff22a454e [ 34.170802][ T899] RDX: 0000000000000000 RSI: 00007ffe352f6350 RDI: 0000000000000005 [ 34.170803][ T899] RBP: 00007ffe352f62c0 R08: 0000000000000000 R09: 0000000000000000 [ 34.170804][ T899] R10: 0000000000000000 R11: 0000000000000202 R12: 00000000073af200 [ 34.170804][ T899] R13: 00007ffe352f6350 R14: 00000000073b0260 R15: 000000000040bda8 [ 34.170807][ T899] [ 34.262957][ T903] tun2: deleting peer with id 11, reason 1 [ 39.867041][ T57] tun0: deleting peer with id 4, reason 2 [ 39.867058][ T57] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 39.867061][ T57] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 57, name: kworker/3:1 [ 39.867062][ T57] preempt_count: 202, expected: 0 [ 39.867063][ T57] RCU nest depth: 0, expected: 0 [ 39.867064][ T57] INFO: lockdep is turned off. [ 39.867065][ T57] irq event stamp: 29506 [ 39.867066][ T57] hardirqs last enabled at (29505): [] _raw_spin_unlock_irq+0x28/0x50 [ 39.867074][ T57] hardirqs last disabled at (29506): [] __schedule+0x1246/0x20e0 [ 39.867077][ T57] softirqs last enabled at (27122): [] handle_softirqs+0x67c/0x900 [ 39.867081][ T57] softirqs last disabled at (26227): [] __irq_exit_rcu+0x145/0x1c0 [ 39.867083][ T57] Preemption disabled at: [ 39.867084][ T57] [<0000000000000000>] 0x0 [ 39.867090][ T57] CPU: 3 UID: 0 PID: 57 Comm: kworker/3:1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 39.867093][ T57] Tainted: [W]=WARN [ 39.867094][ T57] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 39.867096][ T57] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 39.867104][ T57] Call Trace: [ 39.867105][ T57] [ 39.867107][ T57] dump_stack_lvl+0x6f/0xa0 [ 39.867112][ T57] __might_resched.cold+0x1fe/0x2c1 [ 39.867116][ T57] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 39.867120][ T57] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 39.867122][ T57] ? rcu_is_watching+0x16/0xd0 [ 39.867126][ T57] __kmalloc_noprof+0x443/0x760 [ 39.867129][ T57] ? __rwlock_init+0x150/0x150 [ 39.867132][ T57] ? alloc_buf.isra.0+0x4b/0x260 [ 39.867136][ T57] ? do_raw_spin_unlock+0x59/0x250 [ 39.867138][ T57] alloc_buf.isra.0+0x4b/0x260 [ 39.867140][ T57] put_chars+0x1e1/0x2f0 [ 39.867142][ T57] ? prb_final_commit+0x50/0x50 [ 39.867143][ T57] ? __send_to_port+0x420/0x420 [ 39.867145][ T57] ? printk_get_next_message+0x240/0x650 [ 39.867148][ T57] hvc_console_print+0x292/0x780 [ 39.867152][ T57] ? hvc_write+0x3a0/0x3a0 [ 39.867154][ T57] ? do_raw_spin_lock+0x131/0x280 [ 39.867155][ T57] ? vsnprintf+0x527/0x1700 [ 39.867157][ T57] ? __rwlock_init+0x150/0x150 [ 39.867159][ T57] ? rcu_is_watching+0x16/0xd0 [ 39.867161][ T57] ? lock_acquire+0x13c/0x160 [ 39.867163][ T57] console_emit_next_record+0x22f/0x4c0 [ 39.867166][ T57] ? devkmsg_read+0x4b0/0x4b0 [ 39.867168][ T57] ? rcu_is_watching+0x16/0xd0 [ 39.867169][ T57] ? rcu_is_watching+0x16/0xd0 [ 39.867171][ T57] ? rcu_is_watching+0x16/0xd0 [ 39.867172][ T57] ? lock_acquire+0x13c/0x160 [ 39.867174][ T57] ? console_flush_one_record+0x111/0x710 [ 39.867176][ T57] console_flush_one_record+0x46f/0x710 [ 39.867178][ T57] ? console_emit_next_record+0x4c0/0x4c0 [ 39.867181][ T57] console_unlock+0xee/0x1f0 [ 39.867183][ T57] ? lock_acquire+0x13c/0x160 [ 39.867185][ T57] ? console_flush_one_record+0x710/0x710 [ 39.867186][ T57] ? rcu_is_watching+0x16/0xd0 [ 39.867188][ T57] ? lock_release+0x184/0x1f0 [ 39.867189][ T57] ? lock_acquire+0x60/0x160 [ 39.867191][ T57] ? __rcu_read_lock+0x30/0x70 [ 39.867193][ T57] ? __down_trylock_console_sem+0x5e/0xa0 [ 39.867195][ T57] ? vprintk_emit+0x320/0x3e0 [ 39.867204][ T57] vprintk_emit+0x37c/0x3e0 [ 39.867206][ T57] ? wake_up_klogd_work_func+0x90/0x90 [ 39.867208][ T57] ? arch_stack_walk+0xd7/0x130 [ 39.867211][ T57] ? queued_spin_lock_slowpath+0x103/0xa60 [ 39.867213][ T57] ? rcu_is_watching+0x16/0xd0 [ 39.867215][ T57] _printk+0xc7/0x100 [ 39.867218][ T57] ? snapshot_read.cold+0x21/0x21 [ 39.867220][ T57] ? __add_to_free_list+0x81/0x5c0 [ 39.867222][ T57] ? do_raw_spin_lock+0x131/0x280 [ 39.867224][ T57] ? netdev_name+0x43/0x60 [ 39.867226][ T57] ? __netdev_printk+0x17f/0x1d0 [ 39.867228][ T57] netdev_info+0xe2/0x116 [ 39.867230][ T57] ? netdev_notice+0x120/0x120 [ 39.867232][ T57] ? debug_object_free+0x530/0x530 [ 39.867236][ T57] ? __rwlock_init+0x150/0x150 [ 39.867238][ T57] ? trace_irq_enable.constprop.0+0x30/0x160 [ 39.867241][ T57] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 39.867246][ T57] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 39.867248][ T57] ? remove_and_enqueue_same_base+0x200/0x730 [ 39.867251][ T57] ? do_raw_spin_lock+0x131/0x280 [ 39.867254][ T57] ovpn_peer_remove+0x394/0x640 [ovpn] [ 39.867257][ T57] ? do_raw_spin_lock+0x131/0x280 [ 39.867259][ T57] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 39.867261][ T57] ? __rwlock_init+0x150/0x150 [ 39.867263][ T57] ? rcu_is_watching+0x16/0xd0 [ 39.867265][ T57] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 39.867266][ T57] ? trace_irq_disable.constprop.0+0x9b/0x160 [ 39.867267][ T57] ovpn_peer_keepalive_work_single+0x416/0x600 [ovpn] [ 39.867270][ T57] ? ovpn_peers_release_mp+0x490/0x490 [ovpn] [ 39.867273][ T57] ? __rwlock_init+0x150/0x150 [ 39.867275][ T57] ovpn_peer_keepalive_work+0x253/0x580 [ovpn] [ 39.867279][ T57] ? ovpn_peers_free+0xb0/0xb0 [ovpn] [ 39.867281][ T57] ? rcu_is_watching+0x16/0xd0 [ 39.867283][ T57] ? lock_acquire+0x13c/0x160 [ 39.867284][ T57] ? rcu_is_watching+0x16/0xd0 [ 39.867286][ T57] process_one_work+0xe3e/0x1560 [ 39.867291][ T57] ? __queue_delayed_work+0x470/0x470 [ 39.867293][ T57] ? __rwlock_init+0x150/0x150 [ 39.867296][ T57] worker_thread+0x4f1/0xd60 [ 39.867298][ T57] ? rescuer_thread+0x1340/0x1340 [ 39.867300][ T57] ? __kthread_parkme+0xbd/0x210 [ 39.867303][ T57] ? rescuer_thread+0x1340/0x1340 [ 39.867304][ T57] ? rescuer_thread+0x1340/0x1340 [ 39.867306][ T57] kthread+0x367/0x460 [ 39.867308][ T57] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 39.867309][ T57] ? kthread_affine_preferred+0x4c0/0x4c0 [ 39.867311][ T57] ret_from_fork+0x474/0x6b0 [ 39.867313][ T57] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 39.867315][ T57] ? __switch_to+0x5a3/0xe00 [ 39.867317][ T57] ? kthread_affine_preferred+0x4c0/0x4c0 [ 39.867319][ T57] ret_from_fork_asm+0x11/0x20 [ 39.867323][ T57] [ 39.881206][ T57] tun0: deleting peer with id 3, reason 2 [ 39.881379][ T57] tun0: deleting peer with id 5, reason 2 [ 39.881546][ T57] tun0: deleting peer with id 6, reason 2 [ 44.986059][ T62] tun3: deleting peer with id 12, reason 2 [ 44.986076][ T62] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 44.986078][ T62] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 62, name: kworker/2:2 [ 44.986080][ T62] preempt_count: 202, expected: 0 [ 44.986081][ T62] RCU nest depth: 0, expected: 0 [ 44.986082][ T62] INFO: lockdep is turned off. [ 44.986083][ T62] irq event stamp: 25470 [ 44.986084][ T62] hardirqs last enabled at (25469): [] _raw_spin_unlock_irq+0x28/0x50 [ 44.986092][ T62] hardirqs last disabled at (25470): [] __schedule+0x1246/0x20e0 [ 44.986095][ T62] softirqs last enabled at (18452): [] handle_softirqs+0x67c/0x900 [ 44.986099][ T62] softirqs last disabled at (16755): [] __irq_exit_rcu+0x145/0x1c0 [ 44.986101][ T62] Preemption disabled at: [ 44.986102][ T62] [<0000000000000000>] 0x0 [ 44.986108][ T62] CPU: 2 UID: 0 PID: 62 Comm: kworker/2:2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 44.986112][ T62] Tainted: [W]=WARN [ 44.986113][ T62] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 44.986115][ T62] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 44.986123][ T62] Call Trace: [ 44.986124][ T62] [ 44.986126][ T62] dump_stack_lvl+0x6f/0xa0 [ 44.986131][ T62] __might_resched.cold+0x1fe/0x2c1 [ 44.986135][ T62] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 44.986138][ T62] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 44.986141][ T62] ? rcu_is_watching+0x16/0xd0 [ 44.986145][ T62] __kmalloc_noprof+0x443/0x760 [ 44.986149][ T62] ? __rwlock_init+0x150/0x150 [ 44.986151][ T62] ? alloc_buf.isra.0+0x4b/0x260 [ 44.986156][ T62] ? do_raw_spin_unlock+0x59/0x250 [ 44.986157][ T62] alloc_buf.isra.0+0x4b/0x260 [ 44.986159][ T62] put_chars+0x1e1/0x2f0 [ 44.986161][ T62] ? prb_final_commit+0x50/0x50 [ 44.986163][ T62] ? __send_to_port+0x420/0x420 [ 44.986165][ T62] ? printk_get_next_message+0x240/0x650 [ 44.986168][ T62] hvc_console_print+0x292/0x780 [ 44.986172][ T62] ? hvc_write+0x3a0/0x3a0 [ 44.986173][ T62] ? do_raw_spin_lock+0x131/0x280 [ 44.986175][ T62] ? vsnprintf+0x527/0x1700 [ 44.986177][ T62] ? __rwlock_init+0x150/0x150 [ 44.986179][ T62] ? rcu_is_watching+0x16/0xd0 [ 44.986181][ T62] ? lock_acquire+0x13c/0x160 [ 44.986183][ T62] console_emit_next_record+0x22f/0x4c0 [ 44.986185][ T62] ? devkmsg_read+0x4b0/0x4b0 [ 44.986188][ T62] ? rcu_is_watching+0x16/0xd0 [ 44.986189][ T62] ? rcu_is_watching+0x16/0xd0 [ 44.986191][ T62] ? rcu_is_watching+0x16/0xd0 [ 44.986193][ T62] ? lock_acquire+0x13c/0x160 [ 44.986194][ T62] ? console_flush_one_record+0x111/0x710 [ 44.986196][ T62] console_flush_one_record+0x46f/0x710 [ 44.986199][ T62] ? console_emit_next_record+0x4c0/0x4c0 [ 44.986201][ T62] console_unlock+0xee/0x1f0 [ 44.986203][ T62] ? lock_acquire+0x13c/0x160 [ 44.986205][ T62] ? console_flush_one_record+0x710/0x710 [ 44.986207][ T62] ? rcu_is_watching+0x16/0xd0 [ 44.986208][ T62] ? lock_release+0x184/0x1f0 [ 44.986210][ T62] ? lock_acquire+0x60/0x160 [ 44.986211][ T62] ? __rcu_read_lock+0x30/0x70 [ 44.986213][ T62] ? __down_trylock_console_sem+0x5e/0xa0 [ 44.986215][ T62] ? vprintk_emit+0x320/0x3e0 [ 44.986217][ T62] vprintk_emit+0x37c/0x3e0 [ 44.986220][ T62] ? wake_up_klogd_work_func+0x90/0x90 [ 44.986222][ T62] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 44.986231][ T62] ? rcu_is_watching+0x16/0xd0 [ 44.986233][ T62] ? trace_sched_wakeup+0x9b/0x160 [ 44.986236][ T62] _printk+0xc7/0x100 [ 44.986239][ T62] ? snapshot_read.cold+0x21/0x21 [ 44.986241][ T62] ? try_to_wake_up+0x153/0x1130 [ 44.986243][ T62] ? select_fallback_rq+0x510/0x510 [ 44.986245][ T62] ? netdev_name+0x43/0x60 [ 44.986247][ T62] ? __netdev_printk+0x17f/0x1d0 [ 44.986249][ T62] netdev_info+0xe2/0x116 [ 44.986251][ T62] ? netdev_notice+0x120/0x120 [ 44.986253][ T62] ? rcu_is_watching+0x16/0xd0 [ 44.986255][ T62] ? __queue_work+0x3ab/0xd30 [ 44.986258][ T62] ? trace_irq_enable.constprop.0+0x30/0x160 [ 44.986261][ T62] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 44.986265][ T62] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 44.986267][ T62] ? rcu_is_watching+0x16/0xd0 [ 44.986269][ T62] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 44.986271][ T62] ovpn_peer_remove+0x394/0x640 [ovpn] [ 44.986274][ T62] ? do_raw_spin_lock+0x131/0x280 [ 44.986276][ T62] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 44.986279][ T62] ? __rwlock_init+0x150/0x150 [ 44.986281][ T62] ? rcu_is_watching+0x16/0xd0 [ 44.986282][ T62] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 44.986284][ T62] ? trace_irq_disable.constprop.0+0x9b/0x160 [ 44.986285][ T62] ovpn_peer_keepalive_work_single+0x416/0x600 [ovpn] [ 44.986288][ T62] ? ovpn_peers_release_mp+0x490/0x490 [ovpn] [ 44.986291][ T62] ? __rwlock_init+0x150/0x150 [ 44.986293][ T62] ovpn_peer_keepalive_work+0x389/0x580 [ovpn] [ 44.986296][ T62] ? ovpn_peers_free+0xb0/0xb0 [ovpn] [ 44.986299][ T62] ? rcu_is_watching+0x16/0xd0 [ 44.986301][ T62] ? lock_acquire+0x13c/0x160 [ 44.986302][ T62] ? rcu_is_watching+0x16/0xd0 [ 44.986304][ T62] ? process_one_work+0xdfc/0x1560 [ 44.986306][ T62] process_one_work+0xe3e/0x1560 [ 44.986309][ T62] ? __queue_delayed_work+0x470/0x470 [ 44.986311][ T62] ? find_held_lock+0x2b/0x80 [ 44.986313][ T62] ? __rwlock_init+0x150/0x150 [ 44.986316][ T62] worker_thread+0x4f1/0xd60 [ 44.986318][ T62] ? rescuer_thread+0x1340/0x1340 [ 44.986320][ T62] ? __kthread_parkme+0xbd/0x210 [ 44.986322][ T62] ? rescuer_thread+0x1340/0x1340 [ 44.986324][ T62] ? rescuer_thread+0x1340/0x1340 [ 44.986326][ T62] kthread+0x367/0x460 [ 44.986327][ T62] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 44.986329][ T62] ? kthread_affine_preferred+0x4c0/0x4c0 [ 44.986330][ T62] ret_from_fork+0x474/0x6b0 [ 44.986333][ T62] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 44.986335][ T62] ? __switch_to+0x5a3/0xe00 [ 44.986338][ T62] ? kthread_affine_preferred+0x4c0/0x4c0 [ 44.986339][ T62] ret_from_fork_asm+0x11/0x20 [ 44.986343][ T62] [ 45.050052][ T10] tun4: deleting peer with id 13, reason 2 [ 45.114048][ T10] tun6: deleting peer with id 15, reason 2 [ 45.115086][ T62] tun5: deleting peer with id 14, reason 2