[ 17.237527][ T301] ip (301) used greatest stack depth: 24272 bytes left [ 17.237543][ T301] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 17.237545][ T301] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 301, name: ip [ 17.237547][ T301] preempt_count: 2, expected: 0 [ 17.237548][ T301] RCU nest depth: 0, expected: 0 [ 17.237549][ T301] locks held by ip/301: 5, last CPU#2: [ 17.237551][ T301] #0: ffffffffaa0127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 17.237562][ T301] #1: ffffffffaa179cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 17.237568][ T301] #2: ffffffffaa179d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 17.237572][ T301] #3: ffffffffaa099660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 17.237576][ T301] #4: ffffffffaa099560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 17.237580][ T301] irq event stamp: 49012 [ 17.237581][ T301] hardirqs last enabled at (49011): [] __down_trylock_console_sem+0x86/0xa0 [ 17.237583][ T301] hardirqs last disabled at (49012): [] console_emit_next_record+0x3d4/0x4c0 [ 17.237585][ T301] softirqs last enabled at (48690): [] handle_softirqs+0x67c/0x900 [ 17.237587][ T301] softirqs last disabled at (48685): [] __irq_exit_rcu+0x145/0x1c0 [ 17.237589][ T301] Preemption disabled at: [ 17.237590][ T301] [<0000000000000000>] 0x0 [ 17.237597][ T301] CPU: 2 UID: 0 PID: 301 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 17.237601][ T301] Tainted: [W]=WARN [ 17.237601][ T301] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 17.237603][ T301] Call Trace: [ 17.237605][ T301] [ 17.237606][ T301] dump_stack_lvl+0x6f/0xa0 [ 17.237612][ T301] __might_resched.cold+0x1fe/0x2c1 [ 17.237617][ T301] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 17.237622][ T301] ? __kmalloc_noprof+0xdb/0x760 [ 17.237626][ T301] __kmalloc_noprof+0x443/0x760 [ 17.237629][ T301] ? alloc_buf.isra.0+0x4b/0x260 [ 17.237635][ T301] ? do_raw_spin_unlock+0x59/0x250 [ 17.237638][ T301] alloc_buf.isra.0+0x4b/0x260 [ 17.237641][ T301] put_chars+0x1e1/0x2f0 [ 17.237644][ T301] ? __send_to_port+0x420/0x420 [ 17.237646][ T301] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 17.237651][ T301] ? validate_chain+0x38b/0xc20 [ 17.237656][ T301] hvc_console_print+0x292/0x780 [ 17.237663][ T301] ? hvc_write+0x3a0/0x3a0 [ 17.237665][ T301] ? rcu_is_watching+0x16/0xd0 [ 17.237668][ T301] ? lock_acquire+0x13c/0x160 [ 17.237672][ T301] console_emit_next_record+0x22f/0x4c0 [ 17.237676][ T301] ? devkmsg_read+0x4b0/0x4b0 [ 17.237678][ T301] ? console_flush_one_record+0x106/0x710 [ 17.237681][ T301] ? rcu_is_watching+0x16/0xd0 [ 17.237683][ T301] ? lock_acquire+0x13c/0x160 [ 17.237687][ T301] console_flush_one_record+0x46f/0x710 [ 17.237692][ T301] ? console_emit_next_record+0x4c0/0x4c0 [ 17.237694][ T301] ? __lock_acquire+0x518/0xc20 [ 17.237699][ T301] console_unlock+0xee/0x1f0 [ 17.237702][ T301] ? console_flush_one_record+0x710/0x710 [ 17.237703][ T301] ? rcu_is_watching+0x16/0xd0 [ 17.237706][ T301] ? lock_acquire+0x60/0x160 [ 17.237709][ T301] ? __down_trylock_console_sem+0x5e/0xa0 [ 17.237711][ T301] ? vprintk_emit+0x320/0x3e0 [ 17.237715][ T301] vprintk_emit+0x37c/0x3e0 [ 17.237718][ T301] ? wake_up_klogd_work_func+0x90/0x90 [ 17.237722][ T301] ? __lock_acquire+0x518/0xc20 [ 17.237726][ T301] _printk+0xc7/0x100 [ 17.237729][ T301] ? snapshot_read.cold+0x21/0x21 [ 17.237732][ T301] ? do_raw_spin_lock+0x131/0x280 [ 17.237735][ T301] ? __rwlock_init+0x150/0x150 [ 17.237739][ T301] ? do_raw_spin_lock+0x131/0x280 [ 17.237741][ T301] do_exit.cold+0x82/0x9c [ 17.237745][ T301] ? exit_notify+0x890/0x890 [ 17.237747][ T301] ? __lock_release.isra.0+0x69/0x1a0 [ 17.237749][ T301] ? rcu_is_watching+0x16/0xd0 [ 17.237753][ T301] do_group_exit+0xb8/0x370 [ 17.237756][ T301] __x64_sys_exit_group+0x3c/0x50 [ 17.237758][ T301] x64_sys_call+0x1567/0x1570 [ 17.237761][ T301] do_syscall_64+0xff/0x530 [ 17.237765][ T301] ? exc_page_fault+0xee/0x100 [ 17.237767][ T301] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 17.237770][ T301] RIP: 0033:0x7f28e27e51b8 [ 17.237772][ T301] Code: Unable to access opcode bytes at 0x7f28e27e518e. [ 17.237773][ T301] RSP: 002b:00007ffce2e09698 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 17.237776][ T301] RAX: ffffffffffffffda RBX: 00007f28e2915f88 RCX: 00007f28e27e51b8 [ 17.237777][ T301] RDX: 00007f28e252ffc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 17.237778][ T301] RBP: 00007ffce2e096f0 R08: 0000000000000000 R09: 0000000000000000 [ 17.237779][ T301] R10: 00007ffce2e094b0 R11: 0000000000000246 R12: 0000000000000001 [ 17.237780][ T301] R13: 0000000000000000 R14: 00007f28e2914680 R15: 00007f28e2915fa0 [ 17.237787][ T301] [ 17.719437][ T316] ip (316) used greatest stack depth: 23904 bytes left [ 33.288220][ T741] iperf3 (741) used greatest stack depth: 23216 bytes left [ 33.288242][ T741] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 33.288245][ T741] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 741, name: iperf3 [ 33.288246][ T741] preempt_count: 2, expected: 0 [ 33.288247][ T741] RCU nest depth: 0, expected: 0 [ 33.288248][ T741] locks held by iperf3/741: 5, last CPU#2: [ 33.288250][ T741] #0: ffffffffaa0127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 33.288262][ T741] #1: ffffffffaa179cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 33.288269][ T741] #2: ffffffffaa179d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 33.288273][ T741] #3: ffffffffaa099660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 33.288277][ T741] #4: ffffffffaa099560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 33.288281][ T741] irq event stamp: 7144894 [ 33.288282][ T741] hardirqs last enabled at (7144893): [] __down_trylock_console_sem+0x86/0xa0 [ 33.288284][ T741] hardirqs last disabled at (7144894): [] console_emit_next_record+0x3d4/0x4c0 [ 33.288287][ T741] softirqs last enabled at (7144492): [] handle_softirqs+0x67c/0x900 [ 33.288289][ T741] softirqs last disabled at (7143591): [] __irq_exit_rcu+0x145/0x1c0 [ 33.288291][ T741] Preemption disabled at: [ 33.288292][ T741] [<0000000000000000>] 0x0 [ 33.288299][ T741] CPU: 2 UID: 0 PID: 741 Comm: iperf3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 33.288303][ T741] Tainted: [W]=WARN [ 33.288304][ T741] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 33.288306][ T741] Call Trace: [ 33.288308][ T741] [ 33.288309][ T741] dump_stack_lvl+0x6f/0xa0 [ 33.288316][ T741] __might_resched.cold+0x1fe/0x2c1 [ 33.288321][ T741] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 33.288325][ T741] ? __kmalloc_noprof+0xdb/0x760 [ 33.288330][ T741] __kmalloc_noprof+0x443/0x760 [ 33.288332][ T741] ? alloc_buf.isra.0+0x4b/0x260 [ 33.288339][ T741] ? do_raw_spin_unlock+0x59/0x250 [ 33.288342][ T741] alloc_buf.isra.0+0x4b/0x260 [ 33.288345][ T741] put_chars+0x1e1/0x2f0 [ 33.288347][ T741] ? prb_final_commit+0x50/0x50 [ 33.288349][ T741] ? __send_to_port+0x420/0x420 [ 33.288352][ T741] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 33.288357][ T741] ? rcu_read_lock_any_held+0x3c/0x90 [ 33.288359][ T741] ? validate_chain+0x38b/0xc20 [ 33.288363][ T741] hvc_console_print+0x292/0x780 [ 33.288367][ T741] ? mark_usage+0x61/0x170 [ 33.288369][ T741] ? __lock_acquire+0x518/0xc20 [ 33.288370][ T741] ? __lock_acquire+0x518/0xc20 [ 33.288374][ T741] ? hvc_write+0x3a0/0x3a0 [ 33.288376][ T741] ? console_emit_next_record+0x1df/0x4c0 [ 33.288380][ T741] ? rcu_is_watching+0x16/0xd0 [ 33.288382][ T741] ? lock_acquire+0x13c/0x160 [ 33.288386][ T741] console_emit_next_record+0x22f/0x4c0 [ 33.288390][ T741] ? devkmsg_read+0x4b0/0x4b0 [ 33.288392][ T741] ? console_flush_one_record+0x106/0x710 [ 33.288396][ T741] ? rcu_is_watching+0x16/0xd0 [ 33.288398][ T741] ? lock_acquire+0x13c/0x160 [ 33.288402][ T741] console_flush_one_record+0x46f/0x710 [ 33.288406][ T741] ? console_emit_next_record+0x4c0/0x4c0 [ 33.288408][ T741] ? __lock_acquire+0x518/0xc20 [ 33.288413][ T741] console_unlock+0xee/0x1f0 [ 33.288422][ T741] ? console_flush_one_record+0x710/0x710 [ 33.288424][ T741] ? rcu_is_watching+0x16/0xd0 [ 33.288427][ T741] ? lock_acquire+0x60/0x160 [ 33.288430][ T741] ? __down_trylock_console_sem+0x5e/0xa0 [ 33.288432][ T741] ? vprintk_emit+0x320/0x3e0 [ 33.288436][ T741] vprintk_emit+0x37c/0x3e0 [ 33.288440][ T741] ? wake_up_klogd_work_func+0x90/0x90 [ 33.288443][ T741] ? __lock_acquire+0x518/0xc20 [ 33.288447][ T741] _printk+0xc7/0x100 [ 33.288451][ T741] ? snapshot_read.cold+0x21/0x21 [ 33.288454][ T741] ? do_raw_spin_lock+0x131/0x280 [ 33.288456][ T741] ? __rwlock_init+0x150/0x150 [ 33.288460][ T741] ? do_raw_spin_lock+0x131/0x280 [ 33.288463][ T741] do_exit.cold+0x82/0x9c [ 33.288467][ T741] ? exit_notify+0x890/0x890 [ 33.288472][ T741] __x64_sys_exit+0x42/0x50 [ 33.288474][ T741] x64_sys_call+0x156c/0x1570 [ 33.288477][ T741] do_syscall_64+0xff/0x530 [ 33.288481][ T741] ? exc_page_fault+0xee/0x100 [ 33.288483][ T741] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 33.288486][ T741] RIP: 0033:0x7f5fd1b2cc49 [ 33.288488][ T741] Code: Unable to access opcode bytes at 0x7f5fd1b2cc1f. [ 33.288489][ T741] RSP: 002b:00007f5fd12ebe60 EFLAGS: 00000246 ORIG_RAX: 000000000000003c [ 33.288492][ T741] RAX: ffffffffffffffda RBX: 00007f5fd12ec6c0 RCX: 00007f5fd1b2cc49 [ 33.288493][ T741] RDX: 0000000000000000 RSI: 0000000000801000 RDI: 0000000000000000 [ 33.288494][ T741] RBP: 00007f5fd12ebf70 R08: 0000000000000001 R09: 00007f5fd12ec6c0 [ 33.288495][ T741] R10: 0000000000000008 R11: 0000000000000246 R12: 00007f5fd0aec000 [ 33.288496][ T741] R13: 00007fffc39cdab0 R14: 0000000000000002 R15: 00007fffc39cdbb7 [ 33.288503][ T741] [ 35.498606][ T835] tun0: deleting peer with id 1, reason 1 [ 35.498668][ T835] [ 35.498669][ T835] ===================================================== [ 35.498670][ T835] WARNING: SOFTIRQ-safe -> SOFTIRQ-unsafe lock order detected [ 35.498673][ T835] 7.2.0-virtme #1 Tainted: G W [ 35.498674][ T835] ----------------------------------------------------- [ 35.498675][ T835] ovpn-cli/835 [HC0[0]:SC0[2]:HE0:SE0] is trying to acquire: [ 35.498677][ T835] ffffffffaa099660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 35.498688][ T835] [ 35.498688][ T835] and this task is already holding: [ 35.498689][ T835] ff1100000da59e68 (&ovpn->lock){+.-.}-{3:3}, at: ovpn_peer_del+0xa0/0x590 [ovpn] [ 35.498696][ T835] which would create a new lock dependency: [ 35.498697][ T835] (&ovpn->lock){+.-.}-{3:3} -> (console_owner){....}-{0:0} [ 35.498700][ T835] [ 35.498700][ T835] but this new dependency connects a SOFTIRQ-irq-safe lock: [ 35.498701][ T835] (&ovpn->lock){+.-.}-{3:3} [ 35.498702][ T835] [ 35.498702][ T835] ... which became SOFTIRQ-irq-safe at: [ 35.498703][ T835] __lock_acquire+0x388/0xc20 [ 35.498707][ T835] lock_acquire.part.0+0xd4/0x280 [ 35.498708][ T835] _raw_spin_lock_bh+0x38/0x50 [ 35.498711][ T835] ovpn_peer_endpoints_update+0xbc6/0x1ba0 [ovpn] [ 35.498714][ T835] ovpn_decrypt_post+0x74a/0x13e0 [ovpn] [ 35.498717][ T835] ovpn_udp_encap_recv+0x295/0x610 [ovpn] [ 35.498720][ T835] udp_queue_rcv_one_skb+0x645/0xb00 [ 35.498723][ T835] udp_unicast_rcv_skb+0x366/0x450 [ 35.498725][ T835] udp_rcv+0xaba/0x1d90 [ 35.498726][ T835] ip_protocol_deliver_rcu+0x82/0x350 [ 35.498728][ T835] ip_local_deliver_finish+0x36f/0x610 [ 35.498730][ T835] ip_local_deliver+0x184/0x4c0 [ 35.498731][ T835] ip_rcv+0xdc/0x3d0 [ 35.498733][ T835] __netif_receive_skb_one_core+0xfc/0x180 [ 35.498736][ T835] process_backlog+0x431/0x14c0 [ 35.498738][ T835] __napi_poll+0xa7/0x3b0 [ 35.498740][ T835] net_rx_action+0x513/0xf50 [ 35.498741][ T835] handle_softirqs+0x1d3/0x900 [ 35.498744][ T835] do_softirq+0xac/0xe0 [ 35.498745][ T835] __local_bh_enable_ip+0x118/0x150 [ 35.498746][ T835] __dev_queue_xmit+0x979/0x1b80 [ 35.498748][ T835] ip_finish_output2+0x5b9/0x1bc0 [ 35.498750][ T835] ip_output+0x1ca/0x660 [ 35.498751][ T835] ip_push_pending_frames+0xf6/0x250 [ 35.498753][ T835] raw_sendmsg+0x1169/0x1cc0 [ 35.498755][ T835] __sys_sendto+0x2aa/0x400 [ 35.498758][ T835] __x64_sys_sendto+0xe4/0x1f0 [ 35.498759][ T835] do_syscall_64+0xff/0x530 [ 35.498762][ T835] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 35.498764][ T835] [ 35.498764][ T835] to a SOFTIRQ-irq-unsafe lock: [ 35.498765][ T835] (fs_reclaim){+.+.}-{0:0} [ 35.498766][ T835] [ 35.498766][ T835] ... which became SOFTIRQ-irq-unsafe at: [ 35.498767][ T835] ... [ 35.498768][ T835] __lock_acquire+0x388/0xc20 [ 35.498769][ T835] lock_acquire.part.0+0xd4/0x280 [ 35.498771][ T835] fs_reclaim_acquire+0xd5/0x120 [ 35.498773][ T835] __kmalloc_cache_noprof+0x6e/0x620 [ 35.498776][ T835] kthread_create_worker_on_node+0xea/0x210 [ 35.498778][ T835] workqueue_init+0x2a/0x680 [ 35.498782][ T835] kernel_init_freeable+0x2fe/0x630 [ 35.498784][ T835] kernel_init+0x21/0x150 [ 35.498786][ T835] ret_from_fork+0x474/0x6b0 [ 35.498789][ T835] ret_from_fork_asm+0x11/0x20 [ 35.498792][ T835] [ 35.498792][ T835] other info that might help us debug this: [ 35.498792][ T835] [ 35.498792][ T835] Chain exists of: [ 35.498792][ T835] &ovpn->lock --> console_owner --> fs_reclaim [ 35.498792][ T835] [ 35.498794][ T835] Possible interrupt unsafe locking scenario: [ 35.498794][ T835] [ 35.498795][ T835] CPU0 CPU1 [ 35.498795][ T835] ---- ---- [ 35.498796][ T835] lock(fs_reclaim); [ 35.498796][ T835] local_irq_disable(); [ 35.498797][ T835] lock(&ovpn->lock); [ 35.498798][ T835] lock(console_owner); [ 35.498799][ T835] [ 35.498799][ T835] lock(&ovpn->lock); [ 35.498800][ T835] [ 35.498800][ T835] *** DEADLOCK *** [ 35.498800][ T835] [ 35.498800][ T835] locks held by ovpn-cli/835: 4, last CPU#2: [ 35.498802][ T835] #0: ffffffffaa944b68 (cb_lock){++++}-{4:4}, at: genl_rcv+0x19/0x40 [ 35.498807][ T835] #1: ff1100000da59e68 (&ovpn->lock){+.-.}-{3:3}, at: ovpn_peer_del+0xa0/0x590 [ovpn] [ 35.498811][ T835] #2: ffffffffaa179cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 35.498814][ T835] #3: ffffffffaa179d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 35.498818][ T835] [ 35.498818][ T835] the dependencies between SOFTIRQ-irq-safe lock and the holding lock: [ 35.498819][ T835] -> (&ovpn->lock){+.-.}-{3:3} { [ 35.498821][ T835] HARDIRQ-ON-W at: [ 35.498822][ T835] __lock_acquire+0x388/0xc20 [ 35.498823][ T835] lock_acquire.part.0+0xd4/0x280 [ 35.498825][ T835] _raw_spin_lock_bh+0x38/0x50 [ 35.498826][ T835] ovpn_peer_add_mp+0xad/0x6a0 [ovpn] [ 35.498828][ T835] ovpn_peer_add+0x152/0x330 [ovpn] [ 35.498831][ T835] ovpn_nl_peer_new_doit+0x54f/0xcf0 [ovpn] [ 35.498833][ T835] genl_family_rcv_msg_doit+0x206/0x300 [ 35.498835][ T835] genl_family_rcv_msg+0x3a4/0x640 [ 35.498836][ T835] genl_rcv_msg+0xbb/0x160 [ 35.498838][ T835] netlink_rcv_skb+0x14e/0x3a0 [ 35.498840][ T835] genl_rcv+0x28/0x40 [ 35.498841][ T835] netlink_unicast+0x486/0x750 [ 35.498843][ T835] netlink_sendmsg+0x735/0xc60 [ 35.498845][ T835] ____sys_sendmsg+0x415/0x880 [ 35.498847][ T835] ___sys_sendmsg+0x14e/0x1d0 [ 35.498848][ T835] __sys_sendmsg+0x12c/0x1d0 [ 35.498850][ T835] do_syscall_64+0xff/0x530 [ 35.498851][ T835] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 35.498852][ T835] IN-SOFTIRQ-W at: [ 35.498853][ T835] __lock_acquire+0x388/0xc20 [ 35.498854][ T835] lock_acquire.part.0+0xd4/0x280 [ 35.498856][ T835] _raw_spin_lock_bh+0x38/0x50 [ 35.498857][ T835] ovpn_peer_endpoints_update+0xbc6/0x1ba0 [ovpn] [ 35.498859][ T835] ovpn_decrypt_post+0x74a/0x13e0 [ovpn] [ 35.498861][ T835] ovpn_udp_encap_recv+0x295/0x610 [ovpn] [ 35.498864][ T835] udp_queue_rcv_one_skb+0x645/0xb00 [ 35.498865][ T835] udp_unicast_rcv_skb+0x366/0x450 [ 35.498867][ T835] udp_rcv+0xaba/0x1d90 [ 35.498868][ T835] ip_protocol_deliver_rcu+0x82/0x350 [ 35.498869][ T835] ip_local_deliver_finish+0x36f/0x610 [ 35.498871][ T835] ip_local_deliver+0x184/0x4c0 [ 35.498872][ T835] ip_rcv+0xdc/0x3d0 [ 35.498873][ T835] __netif_receive_skb_one_core+0xfc/0x180 [ 35.498875][ T835] process_backlog+0x431/0x14c0 [ 35.498877][ T835] __napi_poll+0xa7/0x3b0 [ 35.498878][ T835] net_rx_action+0x513/0xf50 [ 35.498880][ T835] handle_softirqs+0x1d3/0x900 [ 35.498881][ T835] do_softirq+0xac/0xe0 [ 35.498882][ T835] __local_bh_enable_ip+0x118/0x150 [ 35.498884][ T835] __dev_queue_xmit+0x979/0x1b80 [ 35.498885][ T835] ip_finish_output2+0x5b9/0x1bc0 [ 35.498887][ T835] ip_output+0x1ca/0x660 [ 35.498888][ T835] ip_push_pending_frames+0xf6/0x250 [ 35.498890][ T835] raw_sendmsg+0x1169/0x1cc0 [ 35.498891][ T835] __sys_sendto+0x2aa/0x400 [ 35.498892][ T835] __x64_sys_sendto+0xe4/0x1f0 [ 35.498894][ T835] do_syscall_64+0xff/0x530 [ 35.498895][ T835] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 35.498897][ T835] INITIAL USE at: [ 35.498897][ T835] __lock_acquire+0x388/0xc20 [ 35.498899][ T835] lock_acquire.part.0+0xd4/0x280 [ 35.498900][ T835] _raw_spin_lock_bh+0x38/0x50 [ 35.498901][ T835] ovpn_peer_add_mp+0xad/0x6a0 [ovpn] [ 35.498903][ T835] ovpn_peer_add+0x152/0x330 [ovpn] [ 35.498905][ T835] ovpn_nl_peer_new_doit+0x54f/0xcf0 [ovpn] [ 35.498908][ T835] genl_family_rcv_msg_doit+0x206/0x300 [ 35.498909][ T835] genl_family_rcv_msg+0x3a4/0x640 [ 35.498911][ T835] genl_rcv_msg+0xbb/0x160 [ 35.498913][ T835] netlink_rcv_skb+0x14e/0x3a0 [ 35.498914][ T835] genl_rcv+0x28/0x40 [ 35.498916][ T835] netlink_unicast+0x486/0x750 [ 35.498917][ T835] netlink_sendmsg+0x735/0xc60 [ 35.498919][ T835] ____sys_sendmsg+0x415/0x880 [ 35.498920][ T835] ___sys_sendmsg+0x14e/0x1d0 [ 35.498922][ T835] __sys_sendmsg+0x12c/0x1d0 [ 35.498923][ T835] do_syscall_64+0xff/0x530 [ 35.498925][ T835] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 35.498926][ T835] } [ 35.498926][ T835] ... key at: [] __key.84+0x0/0x40 [ovpn] [ 35.498930][ T835] [ 35.498930][ T835] the dependencies between the lock to be acquired [ 35.498930][ T835] and SOFTIRQ-irq-unsafe lock: [ 35.498935][ T835] -> (fs_reclaim){+.+.}-{0:0} { [ 35.498937][ T835] HARDIRQ-ON-W at: [ 35.498937][ T835] __lock_acquire+0x388/0xc20 [ 35.498939][ T835] lock_acquire.part.0+0xd4/0x280 [ 35.498940][ T835] fs_reclaim_acquire+0xd5/0x120 [ 35.498941][ T835] __kmalloc_cache_noprof+0x6e/0x620 [ 35.498943][ T835] kthread_create_worker_on_node+0xea/0x210 [ 35.498944][ T835] workqueue_init+0x2a/0x680 [ 35.498945][ T835] kernel_init_freeable+0x2fe/0x630 [ 35.498947][ T835] kernel_init+0x21/0x150 [ 35.498948][ T835] ret_from_fork+0x474/0x6b0 [ 35.498949][ T835] ret_from_fork_asm+0x11/0x20 [ 35.498951][ T835] SOFTIRQ-ON-W at: [ 35.498952][ T835] __lock_acquire+0x388/0xc20 [ 35.498953][ T835] lock_acquire.part.0+0xd4/0x280 [ 35.498954][ T835] fs_reclaim_acquire+0xd5/0x120 [ 35.498955][ T835] __kmalloc_cache_noprof+0x6e/0x620 [ 35.498957][ T835] kthread_create_worker_on_node+0xea/0x210 [ 35.498958][ T835] workqueue_init+0x2a/0x680 [ 35.498959][ T835] kernel_init_freeable+0x2fe/0x630 [ 35.498961][ T835] kernel_init+0x21/0x150 [ 35.498962][ T835] ret_from_fork+0x474/0x6b0 [ 35.498963][ T835] ret_from_fork_asm+0x11/0x20 [ 35.498964][ T835] INITIAL USE at: [ 35.498965][ T835] __lock_acquire+0x388/0xc20 [ 35.498966][ T835] lock_acquire.part.0+0xd4/0x280 [ 35.498968][ T835] fs_reclaim_acquire+0xd5/0x120 [ 35.498969][ T835] __kmalloc_cache_noprof+0x6e/0x620 [ 35.498970][ T835] kthread_create_worker_on_node+0xea/0x210 [ 35.498972][ T835] workqueue_init+0x2a/0x680 [ 35.498973][ T835] kernel_init_freeable+0x2fe/0x630 [ 35.498974][ T835] kernel_init+0x21/0x150 [ 35.498976][ T835] ret_from_fork+0x474/0x6b0 [ 35.498977][ T835] ret_from_fork_asm+0x11/0x20 [ 35.498978][ T835] } [ 35.498978][ T835] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 35.498982][ T835] ... acquired at: [ 35.498982][ T835] __lock_acquire+0x518/0xc20 [ 35.498984][ T835] lock_acquire.part.0+0xd4/0x280 [ 35.498985][ T835] fs_reclaim_acquire+0xd5/0x120 [ 35.498986][ T835] __kmalloc_noprof+0xd3/0x760 [ 35.498987][ T835] alloc_buf.isra.0+0x4b/0x260 [ 35.498990][ T835] put_chars+0x1e1/0x2f0 [ 35.498992][ T835] hvc_console_print+0x292/0x780 [ 35.498994][ T835] console_emit_next_record+0x22f/0x4c0 [ 35.498996][ T835] console_flush_one_record+0x46f/0x710 [ 35.498998][ T835] console_unlock+0xee/0x1f0 [ 35.498999][ T835] vprintk_emit+0x37c/0x3e0 [ 35.499001][ T835] dev_vprintk_emit+0x27f/0x2c0 [ 35.499006][ T835] dev_printk_emit+0xb9/0xee [ 35.499007][ T835] _dev_info+0xe2/0x116 [ 35.499009][ T835] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 35.499011][ T835] cmos_do_probe+0x73b/0x98a [ 35.499013][ T835] platform_probe+0xfe/0x1f0 [ 35.499015][ T835] call_driver_probe+0x61/0x1c0 [ 35.499018][ T835] really_probe+0x199/0x760 [ 35.499019][ T835] __driver_probe_device+0x24f/0x440 [ 35.499021][ T835] driver_probe_device+0x4a/0xf0 [ 35.499022][ T835] __driver_attach+0x1b8/0x540 [ 35.499024][ T835] bus_for_each_dev+0x130/0x1e0 [ 35.499025][ T835] bus_add_driver+0x2c8/0x530 [ 35.499027][ T835] driver_register+0x1a3/0x390 [ 35.499028][ T835] __platform_driver_probe+0x13f/0x270 [ 35.499030][ T835] cmos_init+0x31/0x40 [ 35.499032][ T835] do_one_initcall+0x124/0x4f0 [ 35.499034][ T835] kernel_init_freeable+0x596/0x630 [ 35.499036][ T835] kernel_init+0x21/0x150 [ 35.499037][ T835] ret_from_fork+0x474/0x6b0 [ 35.499038][ T835] ret_from_fork_asm+0x11/0x20 [ 35.499039][ T835] [ 35.499040][ T835] -> (console_owner){....}-{0:0} { [ 35.499041][ T835] INITIAL USE at: [ 35.499042][ T835] } [ 35.499043][ T835] ... key at: [] console_owner_dep_map+0x0/0x60 [ 35.499046][ T835] ... acquired at: [ 35.499046][ T835] check_prev_add+0xef/0xe90 [ 35.499048][ T835] validate_chain+0x6b8/0xc20 [ 35.499049][ T835] __lock_acquire+0x518/0xc20 [ 35.499050][ T835] lock_acquire.part.0+0xd4/0x280 [ 35.499052][ T835] console_lock_spinning_enable+0x5c/0x60 [ 35.499053][ T835] console_emit_next_record+0x1d1/0x4c0 [ 35.499055][ T835] console_flush_one_record+0x46f/0x710 [ 35.499057][ T835] console_unlock+0xee/0x1f0 [ 35.499058][ T835] vprintk_emit+0x37c/0x3e0 [ 35.499060][ T835] _printk+0xc7/0x100 [ 35.499062][ T835] netdev_info+0xe2/0x116 [ 35.499064][ T835] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 35.499067][ T835] ovpn_peer_remove+0x394/0x640 [ovpn] [ 35.499070][ T835] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 35.499072][ T835] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 35.499074][ T835] genl_family_rcv_msg_doit+0x206/0x300 [ 35.499076][ T835] genl_family_rcv_msg+0x3a4/0x640 [ 35.499078][ T835] genl_rcv_msg+0xbb/0x160 [ 35.499079][ T835] netlink_rcv_skb+0x14e/0x3a0 [ 35.499081][ T835] genl_rcv+0x28/0x40 [ 35.499082][ T835] netlink_unicast+0x486/0x750 [ 35.499084][ T835] netlink_sendmsg+0x735/0xc60 [ 35.499085][ T835] ____sys_sendmsg+0x415/0x880 [ 35.499087][ T835] ___sys_sendmsg+0x14e/0x1d0 [ 35.499088][ T835] __sys_sendmsg+0x12c/0x1d0 [ 35.499090][ T835] do_syscall_64+0xff/0x530 [ 35.499091][ T835] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 35.499093][ T835] [ 35.499093][ T835] [ 35.499093][ T835] stack backtrace: [ 35.499096][ T835] CPU: 2 UID: 0 PID: 835 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 35.499099][ T835] Tainted: [W]=WARN [ 35.499100][ T835] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 35.499102][ T835] Call Trace: [ 35.499103][ T835] [ 35.499104][ T835] dump_stack_lvl+0x6f/0xa0 [ 35.499108][ T835] print_bad_irq_dependency+0x3e4/0x410 [ 35.499111][ T835] check_irq_usage+0x403/0x570 [ 35.499113][ T835] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 35.499117][ T835] ? rcu_read_lock_any_held+0x3c/0x90 [ 35.499119][ T835] ? check_path.constprop.0+0x24/0x50 [ 35.499122][ T835] ? check_prev_add+0xef/0xe90 [ 35.499123][ T835] check_prev_add+0xef/0xe90 [ 35.499125][ T835] validate_chain+0x6b8/0xc20 [ 35.499128][ T835] __lock_acquire+0x518/0xc20 [ 35.499130][ T835] lock_acquire.part.0+0xd4/0x280 [ 35.499132][ T835] ? console_lock_spinning_enable+0x40/0x60 [ 35.499134][ T835] ? rcu_is_watching+0x16/0xd0 [ 35.499136][ T835] ? lock_acquire+0x13c/0x160 [ 35.499138][ T835] console_lock_spinning_enable+0x5c/0x60 [ 35.499139][ T835] ? console_lock_spinning_enable+0x40/0x60 [ 35.499141][ T835] console_emit_next_record+0x1d1/0x4c0 [ 35.499143][ T835] ? devkmsg_read+0x4b0/0x4b0 [ 35.499145][ T835] ? console_flush_one_record+0x106/0x710 [ 35.499147][ T835] ? rcu_is_watching+0x16/0xd0 [ 35.499149][ T835] ? lock_acquire+0x13c/0x160 [ 35.499151][ T835] console_flush_one_record+0x46f/0x710 [ 35.499153][ T835] ? console_emit_next_record+0x4c0/0x4c0 [ 35.499155][ T835] ? __lock_acquire+0x518/0xc20 [ 35.499157][ T835] console_unlock+0xee/0x1f0 [ 35.499159][ T835] ? console_flush_one_record+0x710/0x710 [ 35.499161][ T835] ? rcu_is_watching+0x16/0xd0 [ 35.499162][ T835] ? lock_acquire+0x60/0x160 [ 35.499164][ T835] ? __down_trylock_console_sem+0x5e/0xa0 [ 35.499166][ T835] ? vprintk_emit+0x320/0x3e0 [ 35.499168][ T835] vprintk_emit+0x37c/0x3e0 [ 35.499170][ T835] ? wake_up_klogd_work_func+0x90/0x90 [ 35.499172][ T835] ? kernel_text_address+0x149/0x170 [ 35.499174][ T835] ? __kernel_text_address+0x12/0x30 [ 35.499175][ T835] ? write_profile+0xf0/0xf0 [ 35.499177][ T835] ? unwind_get_return_address+0x67/0xd0 [ 35.499180][ T835] _printk+0xc7/0x100 [ 35.499182][ T835] ? snapshot_read.cold+0x21/0x21 [ 35.499184][ T835] ? mark_usage+0x61/0x170 [ 35.499186][ T835] ? netdev_name+0x43/0x60 [ 35.499187][ T835] ? __netdev_printk+0x17f/0x1d0 [ 35.499189][ T835] netdev_info+0xe2/0x116 [ 35.499190][ T835] ? netdev_notice+0x120/0x120 [ 35.499191][ T835] ? find_held_lock+0x2b/0x80 [ 35.499193][ T835] ? mark_usage+0x61/0x170 [ 35.499195][ T835] ? __lock_acquire+0x518/0xc20 [ 35.499197][ T835] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 35.499200][ T835] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 35.499203][ T835] ? ovpn_peer_get_by_id+0x1fd/0x7a0 [ovpn] [ 35.499206][ T835] ovpn_peer_remove+0x394/0x640 [ovpn] [ 35.499208][ T835] ? do_raw_spin_lock+0x131/0x280 [ 35.499210][ T835] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 35.499214][ T835] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 35.499216][ T835] ? ovpn_peer_add+0x330/0x330 [ovpn] [ 35.499220][ T835] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 35.499222][ T835] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 35.499224][ T835] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 35.499226][ T835] ? ref_tracker_alloc+0x28d/0x430 [ 35.499232][ T835] ? ovpn_get_dev_from_attrs+0x170/0x660 [ovpn] [ 35.499235][ T835] ? ovpn_get_dev_from_attrs+0x17a/0x660 [ovpn] [ 35.499238][ T835] genl_family_rcv_msg_doit+0x206/0x300 [ 35.499240][ T835] ? genl_family_rcv_msg_attrs_parse.isra.0+0x330/0x330 [ 35.499242][ T835] ? __lock_release.isra.0+0x69/0x1a0 [ 35.499245][ T835] ? rcu_is_watching+0x16/0xd0 [ 35.499247][ T835] ? cap_capable+0x1d7/0x3d0 [ 35.499250][ T835] ? write_profile+0xf0/0xf0 [ 35.499251][ T835] ? unwind_get_return_address+0x67/0xd0 [ 35.499253][ T835] genl_family_rcv_msg+0x3a4/0x640 [ 35.499255][ T835] ? genl_family_rcv_msg_dumpit+0x340/0x340 [ 35.499257][ T835] ? rcu_read_lock_any_held+0x3c/0x90 [ 35.499259][ T835] ? ovpn_nl_send_peer+0x1300/0x1300 [ovpn] [ 35.499261][ T835] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 35.499264][ T835] ? ovpn_nl_pre_doit+0x90/0x90 [ovpn] [ 35.499266][ T835] ? __lock_acquire+0x518/0xc20 [ 35.499269][ T835] genl_rcv_msg+0xbb/0x160 [ 35.499271][ T835] netlink_rcv_skb+0x14e/0x3a0 [ 35.499273][ T835] ? genl_family_rcv_msg+0x640/0x640 [ 35.499275][ T835] ? netlink_ack+0xcf0/0xcf0 [ 35.499278][ T835] ? netlink_deliver_tap+0xc5/0x330 [ 35.499279][ T835] ? netlink_deliver_tap+0x13c/0x330 [ 35.499282][ T835] genl_rcv+0x28/0x40 [ 35.499283][ T835] netlink_unicast+0x486/0x750 [ 35.499286][ T835] ? netlink_attachskb+0x810/0x810 [ 35.499288][ T835] ? __lock_acquire+0x518/0xc20 [ 35.499290][ T835] netlink_sendmsg+0x735/0xc60 [ 35.499292][ T835] ? netlink_unicast+0x750/0x750 [ 35.499294][ T835] ? __might_fault+0x97/0x140 [ 35.499298][ T835] ____sys_sendmsg+0x415/0x880 [ 35.499300][ T835] ? copy_msghdr_from_user+0x279/0x420 [ 35.499301][ T835] ? get_timestamp.constprop.0+0x390/0x390 [ 35.499303][ T835] ? move_addr_to_kernel+0x40/0x40 [ 35.499306][ T835] ___sys_sendmsg+0x14e/0x1d0 [ 35.499308][ T835] ? copy_msghdr_from_user+0x420/0x420 [ 35.499309][ T835] ? kfree+0x22/0x590 [ 35.499314][ T835] __sys_sendmsg+0x12c/0x1d0 [ 35.499316][ T835] ? __sys_sendmsg_sock+0x20/0x20 [ 35.499319][ T835] ? rcu_is_watching+0x16/0xd0 [ 35.499321][ T835] ? rcu_is_watching+0x16/0xd0 [ 35.499323][ T835] do_syscall_64+0xff/0x530 [ 35.499325][ T835] ? exc_page_fault+0xee/0x100 [ 35.499326][ T835] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 35.499328][ T835] RIP: 0033:0x7fcccb66b54e [ 35.499331][ T835] 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.499332][ T835] RSP: 002b:00007fffe4350d50 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 35.499335][ T835] RAX: ffffffffffffffda RBX: 0000000001d40130 RCX: 00007fcccb66b54e [ 35.499336][ T835] RDX: 0000000000000000 RSI: 00007fffe4350df0 RDI: 0000000000000005 [ 35.499337][ T835] RBP: 00007fffe4350d60 R08: 0000000000000000 R09: 0000000000000000 [ 35.499338][ T835] R10: 0000000000000000 R11: 0000000000000202 R12: 0000000001d40200 [ 35.499339][ T835] R13: 00007fffe4350df0 R14: 0000000001d41260 R15: 000000000040bda8 [ 35.499341][ T835] [ 35.499345][ T835] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 35.499347][ T835] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 835, name: ovpn-cli [ 35.499348][ T835] preempt_count: 202, expected: 0 [ 35.499349][ T835] RCU nest depth: 0, expected: 0 [ 35.499349][ T835] INFO: lockdep is turned off. [ 35.499350][ T835] irq event stamp: 40437 [ 35.499350][ T835] hardirqs last enabled at (40436): [] __down_trylock_console_sem+0x86/0xa0 [ 35.499353][ T835] hardirqs last disabled at (40437): [] console_emit_next_record+0x3d4/0x4c0 [ 35.499354][ T835] softirqs last enabled at (40404): [] __alloc_skb+0x4c2/0x5f0 [ 35.499357][ T835] softirqs last disabled at (40432): [] ovpn_peer_del+0xa0/0x590 [ovpn] [ 35.499360][ T835] Preemption disabled at: [ 35.499360][ T835] [<0000000000000000>] 0x0 [ 35.499363][ T835] CPU: 2 UID: 0 PID: 835 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 35.499365][ T835] Tainted: [W]=WARN [ 35.499365][ T835] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 35.499366][ T835] Call Trace: [ 35.499367][ T835] [ 35.499367][ T835] dump_stack_lvl+0x6f/0xa0 [ 35.499370][ T835] __might_resched.cold+0x1fe/0x2c1 [ 35.499372][ T835] ? check_irq_usage+0x403/0x570 [ 35.499374][ T835] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 35.499377][ T835] ? rcu_is_watching+0x16/0xd0 [ 35.499379][ T835] __kmalloc_noprof+0x443/0x760 [ 35.499381][ T835] ? __rwlock_init+0x150/0x150 [ 35.499382][ T835] ? alloc_buf.isra.0+0x4b/0x260 [ 35.499384][ T835] ? do_raw_spin_unlock+0x59/0x250 [ 35.499386][ T835] alloc_buf.isra.0+0x4b/0x260 [ 35.499388][ T835] put_chars+0x1e1/0x2f0 [ 35.499390][ T835] ? __send_to_port+0x420/0x420 [ 35.499391][ T835] ? check_prev_add+0xef/0xe90 [ 35.499393][ T835] ? validate_chain+0x6b8/0xc20 [ 35.499395][ T835] hvc_console_print+0x292/0x780 [ 35.499397][ T835] ? __lock_acquire+0x518/0xc20 [ 35.499399][ T835] ? hvc_write+0x3a0/0x3a0 [ 35.499401][ T835] ? rcu_is_watching+0x16/0xd0 [ 35.499403][ T835] ? lock_acquire+0x13c/0x160 [ 35.499405][ T835] console_emit_next_record+0x22f/0x4c0 [ 35.499407][ T835] ? devkmsg_read+0x4b0/0x4b0 [ 35.499409][ T835] ? console_flush_one_record+0x106/0x710 [ 35.499411][ T835] ? rcu_is_watching+0x16/0xd0 [ 35.499412][ T835] ? lock_acquire+0x13c/0x160 [ 35.499414][ T835] console_flush_one_record+0x46f/0x710 [ 35.499417][ T835] ? console_emit_next_record+0x4c0/0x4c0 [ 35.499418][ T835] ? __lock_acquire+0x518/0xc20 [ 35.499420][ T835] console_unlock+0xee/0x1f0 [ 35.499422][ T835] ? console_flush_one_record+0x710/0x710 [ 35.499424][ T835] ? rcu_is_watching+0x16/0xd0 [ 35.499426][ T835] ? lock_acquire+0x60/0x160 [ 35.499428][ T835] ? __down_trylock_console_sem+0x5e/0xa0 [ 35.499429][ T835] ? vprintk_emit+0x320/0x3e0 [ 35.499437][ T835] vprintk_emit+0x37c/0x3e0 [ 35.499439][ T835] ? wake_up_klogd_work_func+0x90/0x90 [ 35.499441][ T835] ? kernel_text_address+0x149/0x170 [ 35.499442][ T835] ? __kernel_text_address+0x12/0x30 [ 35.499443][ T835] ? write_profile+0xf0/0xf0 [ 35.499445][ T835] ? unwind_get_return_address+0x67/0xd0 [ 35.499446][ T835] _printk+0xc7/0x100 [ 35.499448][ T835] ? snapshot_read.cold+0x21/0x21 [ 35.499450][ T835] ? mark_usage+0x61/0x170 [ 35.499452][ T835] ? netdev_name+0x43/0x60 [ 35.499453][ T835] ? __netdev_printk+0x17f/0x1d0 [ 35.499455][ T835] netdev_info+0xe2/0x116 [ 35.499456][ T835] ? netdev_notice+0x120/0x120 [ 35.499457][ T835] ? find_held_lock+0x2b/0x80 [ 35.499459][ T835] ? mark_usage+0x61/0x170 [ 35.499461][ T835] ? __lock_acquire+0x518/0xc20 [ 35.499463][ T835] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 35.499466][ T835] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 35.499468][ T835] ? ovpn_peer_get_by_id+0x1fd/0x7a0 [ovpn] [ 35.499471][ T835] ovpn_peer_remove+0x394/0x640 [ovpn] [ 35.499474][ T835] ? do_raw_spin_lock+0x131/0x280 [ 35.499476][ T835] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 35.499479][ T835] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 35.499482][ T835] ? ovpn_peer_add+0x330/0x330 [ovpn] [ 35.499485][ T835] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 35.499487][ T835] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 35.499489][ T835] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 35.499491][ T835] ? ref_tracker_alloc+0x28d/0x430 [ 35.499494][ T835] ? ovpn_get_dev_from_attrs+0x170/0x660 [ovpn] [ 35.499497][ T835] ? ovpn_get_dev_from_attrs+0x17a/0x660 [ovpn] [ 35.499500][ T835] genl_family_rcv_msg_doit+0x206/0x300 [ 35.499502][ T835] ? genl_family_rcv_msg_attrs_parse.isra.0+0x330/0x330 [ 35.499504][ T835] ? __lock_release.isra.0+0x69/0x1a0 [ 35.499507][ T835] ? rcu_is_watching+0x16/0xd0 [ 35.499508][ T835] ? cap_capable+0x1d7/0x3d0 [ 35.499510][ T835] ? write_profile+0xf0/0xf0 [ 35.499511][ T835] ? unwind_get_return_address+0x67/0xd0 [ 35.499513][ T835] genl_family_rcv_msg+0x3a4/0x640 [ 35.499515][ T835] ? genl_family_rcv_msg_dumpit+0x340/0x340 [ 35.499517][ T835] ? rcu_read_lock_any_held+0x3c/0x90 [ 35.499519][ T835] ? ovpn_nl_send_peer+0x1300/0x1300 [ovpn] [ 35.499521][ T835] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 35.499523][ T835] ? ovpn_nl_pre_doit+0x90/0x90 [ovpn] [ 35.499526][ T835] ? __lock_acquire+0x518/0xc20 [ 35.499528][ T835] genl_rcv_msg+0xbb/0x160 [ 35.499530][ T835] netlink_rcv_skb+0x14e/0x3a0 [ 35.499532][ T835] ? genl_family_rcv_msg+0x640/0x640 [ 35.499534][ T835] ? netlink_ack+0xcf0/0xcf0 [ 35.499537][ T835] ? netlink_deliver_tap+0xc5/0x330 [ 35.499539][ T835] ? netlink_deliver_tap+0x13c/0x330 [ 35.499541][ T835] genl_rcv+0x28/0x40 [ 35.499543][ T835] netlink_unicast+0x486/0x750 [ 35.499545][ T835] ? netlink_attachskb+0x810/0x810 [ 35.499547][ T835] ? __lock_acquire+0x518/0xc20 [ 35.499549][ T835] netlink_sendmsg+0x735/0xc60 [ 35.499552][ T835] ? netlink_unicast+0x750/0x750 [ 35.499554][ T835] ? __might_fault+0x97/0x140 [ 35.499556][ T835] ____sys_sendmsg+0x415/0x880 [ 35.499558][ T835] ? copy_msghdr_from_user+0x279/0x420 [ 35.499560][ T835] ? get_timestamp.constprop.0+0x390/0x390 [ 35.499561][ T835] ? move_addr_to_kernel+0x40/0x40 [ 35.499564][ T835] ___sys_sendmsg+0x14e/0x1d0 [ 35.499566][ T835] ? copy_msghdr_from_user+0x420/0x420 [ 35.499568][ T835] ? kfree+0x22/0x590 [ 35.499573][ T835] __sys_sendmsg+0x12c/0x1d0 [ 35.499575][ T835] ? __sys_sendmsg_sock+0x20/0x20 [ 35.499577][ T835] ? rcu_is_watching+0x16/0xd0 [ 35.499579][ T835] ? rcu_is_watching+0x16/0xd0 [ 35.499581][ T835] do_syscall_64+0xff/0x530 [ 35.499583][ T835] ? exc_page_fault+0xee/0x100 [ 35.499584][ T835] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 35.499586][ T835] RIP: 0033:0x7fcccb66b54e [ 35.499587][ T835] 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.499588][ T835] RSP: 002b:00007fffe4350d50 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 35.499589][ T835] RAX: ffffffffffffffda RBX: 0000000001d40130 RCX: 00007fcccb66b54e [ 35.499590][ T835] RDX: 0000000000000000 RSI: 00007fffe4350df0 RDI: 0000000000000005 [ 35.499591][ T835] RBP: 00007fffe4350d60 R08: 0000000000000000 R09: 0000000000000000 [ 35.499591][ T835] R10: 0000000000000000 R11: 0000000000000202 R12: 0000000001d40200 [ 35.499592][ T835] R13: 00007fffe4350df0 R14: 0000000001d41260 R15: 000000000040bda8 [ 35.499594][ T835] [ 35.718951][ T839] tun1: deleting peer with id 1, reason 1 [ 38.359291][ T887] tun0: deleting peer with id 2, reason 1 [ 38.359309][ T887] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 38.359312][ T887] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 887, name: ovpn-cli [ 38.359313][ T887] preempt_count: 202, expected: 0 [ 38.359314][ T887] RCU nest depth: 0, expected: 0 [ 38.359315][ T887] INFO: lockdep is turned off. [ 38.359316][ T887] irq event stamp: 0 [ 38.359317][ T887] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 38.359320][ T887] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 38.359327][ T887] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 38.359329][ T887] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 38.359331][ T887] Preemption disabled at: [ 38.359331][ T887] [<0000000000000000>] 0x0 [ 38.359336][ T887] CPU: 3 UID: 0 PID: 887 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 38.359340][ T887] Tainted: [W]=WARN [ 38.359341][ T887] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 38.359343][ T887] Call Trace: [ 38.359344][ T887] [ 38.359345][ T887] dump_stack_lvl+0x6f/0xa0 [ 38.359351][ T887] __might_resched.cold+0x1fe/0x2c1 [ 38.359355][ T887] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 38.359359][ T887] ? rcu_is_watching+0x16/0xd0 [ 38.359363][ T887] __kmalloc_noprof+0x443/0x760 [ 38.359367][ T887] ? __rwlock_init+0x150/0x150 [ 38.359369][ T887] ? alloc_buf.isra.0+0x4b/0x260 [ 38.359375][ T887] ? do_raw_spin_unlock+0x59/0x250 [ 38.359377][ T887] alloc_buf.isra.0+0x4b/0x260 [ 38.359381][ T887] put_chars+0x1e1/0x2f0 [ 38.359384][ T887] ? __send_to_port+0x420/0x420 [ 38.359386][ T887] ? printk_get_next_message+0x240/0x650 [ 38.359389][ T887] hvc_console_print+0x292/0x780 [ 38.359393][ T887] ? hvc_write+0x3a0/0x3a0 [ 38.359395][ T887] ? __rwlock_init+0x150/0x150 [ 38.359396][ T887] ? rcu_is_watching+0x16/0xd0 [ 38.359398][ T887] ? lock_acquire+0x13c/0x160 [ 38.359401][ T887] console_emit_next_record+0x22f/0x4c0 [ 38.359403][ T887] ? devkmsg_read+0x4b0/0x4b0 [ 38.359405][ T887] ? rcu_is_watching+0x16/0xd0 [ 38.359407][ T887] ? rcu_is_watching+0x16/0xd0 [ 38.359408][ T887] ? rcu_is_watching+0x16/0xd0 [ 38.359410][ T887] ? lock_acquire+0x13c/0x160 [ 38.359412][ T887] ? console_flush_one_record+0x111/0x710 [ 38.359414][ T887] console_flush_one_record+0x46f/0x710 [ 38.359416][ T887] ? console_emit_next_record+0x4c0/0x4c0 [ 38.359419][ T887] console_unlock+0xee/0x1f0 [ 38.359421][ T887] ? lock_acquire+0x13c/0x160 [ 38.359422][ T887] ? console_flush_one_record+0x710/0x710 [ 38.359424][ T887] ? rcu_is_watching+0x16/0xd0 [ 38.359426][ T887] ? lock_release+0x184/0x1f0 [ 38.359427][ T887] ? lock_acquire+0x60/0x160 [ 38.359428][ T887] ? __rcu_read_lock+0x30/0x70 [ 38.359430][ T887] ? __down_trylock_console_sem+0x5e/0xa0 [ 38.359432][ T887] ? vprintk_emit+0x320/0x3e0 [ 38.359434][ T887] vprintk_emit+0x37c/0x3e0 [ 38.359437][ T887] ? wake_up_klogd_work_func+0x90/0x90 [ 38.359439][ T887] ? kernel_text_address+0x149/0x170 [ 38.359441][ T887] ? __kernel_text_address+0x12/0x30 [ 38.359442][ T887] ? write_profile+0xf0/0xf0 [ 38.359444][ T887] ? unwind_get_return_address+0x67/0xd0 [ 38.359447][ T887] _printk+0xc7/0x100 [ 38.359457][ T887] ? snapshot_read.cold+0x21/0x21 [ 38.359460][ T887] ? netdev_name+0x43/0x60 [ 38.359462][ T887] ? __netdev_printk+0x17f/0x1d0 [ 38.359464][ T887] netdev_info+0xe2/0x116 [ 38.359466][ T887] ? netdev_notice+0x120/0x120 [ 38.359467][ T887] ? ovpn_nl_pre_doit+0x44/0x90 [ovpn] [ 38.359473][ T887] ? __module_address+0x36/0x330 [ 38.359476][ T887] ? lock_acquire+0x13c/0x160 [ 38.359477][ T887] ? rcu_is_watching+0x16/0xd0 [ 38.359479][ T887] ? lock_release+0x184/0x1f0 [ 38.359481][ T887] ? ovpn_peer_get_by_id+0x38a/0x7a0 [ovpn] [ 38.359484][ T887] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 38.359489][ T887] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 38.359491][ T887] ? lock_acquire+0x13c/0x160 [ 38.359493][ T887] ? rcu_is_watching+0x16/0xd0 [ 38.359495][ T887] ? lock_release+0x184/0x1f0 [ 38.359497][ T887] ovpn_peer_remove+0x394/0x640 [ovpn] [ 38.359500][ T887] ? do_raw_spin_lock+0x131/0x280 [ 38.359502][ T887] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 38.359505][ T887] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 38.359508][ T887] ? ovpn_peer_add+0x330/0x330 [ovpn] [ 38.359512][ T887] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 38.359514][ T887] ? trace_hardirqs_on+0x36/0x40 [ 38.359517][ T887] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 38.359519][ T887] ? ref_tracker_alloc+0x28d/0x430 [ 38.359524][ T887] ? lock_release+0x184/0x1f0 [ 38.359526][ T887] ? ovpn_get_dev_from_attrs+0x17a/0x660 [ovpn] [ 38.359530][ T887] genl_family_rcv_msg_doit+0x206/0x300 [ 38.359534][ T887] ? genl_family_rcv_msg_attrs_parse.isra.0+0x330/0x330 [ 38.359536][ T887] ? rcu_is_watching+0x16/0xd0 [ 38.359539][ T887] ? rcu_is_watching+0x16/0xd0 [ 38.359540][ T887] ? cap_capable+0x1d7/0x3d0 [ 38.359545][ T887] ? write_profile+0xf0/0xf0 [ 38.359547][ T887] ? unwind_get_return_address+0x67/0xd0 [ 38.359549][ T887] genl_family_rcv_msg+0x3a4/0x640 [ 38.359553][ T887] ? genl_family_rcv_msg_dumpit+0x340/0x340 [ 38.359555][ T887] ? ovpn_nl_send_peer+0x1300/0x1300 [ovpn] [ 38.359560][ T887] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 38.359563][ T887] ? ovpn_nl_pre_doit+0x90/0x90 [ovpn] [ 38.359565][ T887] ? filter_irq_stacks+0xd0/0xd0 [ 38.359567][ T887] ? stack_depot_save_flags+0x1bc/0x790 [ 38.359569][ T887] genl_rcv_msg+0xbb/0x160 [ 38.359571][ T887] netlink_rcv_skb+0x14e/0x3a0 [ 38.359573][ T887] ? genl_family_rcv_msg+0x640/0x640 [ 38.359576][ T887] ? netlink_ack+0xcf0/0xcf0 [ 38.359578][ T887] ? lock_acquire+0x13c/0x160 [ 38.359580][ T887] ? rcu_is_watching+0x16/0xd0 [ 38.359582][ T887] ? lock_release+0x184/0x1f0 [ 38.359583][ T887] genl_rcv+0x28/0x40 [ 38.359586][ T887] netlink_unicast+0x486/0x750 [ 38.359588][ T887] ? netlink_attachskb+0x810/0x810 [ 38.359590][ T887] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 38.359591][ T887] ? trace_hardirqs_on+0x36/0x40 [ 38.359592][ T887] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 38.359596][ T887] netlink_sendmsg+0x735/0xc60 [ 38.359598][ T887] ? netlink_unicast+0x750/0x750 [ 38.359600][ T887] ? rcu_is_watching+0x16/0xd0 [ 38.359602][ T887] ? lock_release+0x184/0x1f0 [ 38.359604][ T887] ____sys_sendmsg+0x415/0x880 [ 38.359607][ T887] ? copy_msghdr_from_user+0x279/0x420 [ 38.359609][ T887] ? get_timestamp.constprop.0+0x390/0x390 [ 38.359610][ T887] ? move_addr_to_kernel+0x40/0x40 [ 38.359614][ T887] ___sys_sendmsg+0x14e/0x1d0 [ 38.359615][ T887] ? copy_msghdr_from_user+0x420/0x420 [ 38.359617][ T887] ? kfree+0x22/0x590 [ 38.359622][ T887] __sys_sendmsg+0x12c/0x1d0 [ 38.359625][ T887] ? __sys_sendmsg_sock+0x20/0x20 [ 38.359627][ T887] ? rcu_is_watching+0x16/0xd0 [ 38.359629][ T887] ? rcu_is_watching+0x16/0xd0 [ 38.359631][ T887] do_syscall_64+0xff/0x530 [ 38.359634][ T887] ? exc_page_fault+0xee/0x100 [ 38.359636][ T887] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 38.359638][ T887] RIP: 0033:0x7f852a19d54e [ 38.359640][ T887] 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 [ 38.359642][ T887] RSP: 002b:00007ffce55fc470 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 38.359645][ T887] RAX: ffffffffffffffda RBX: 000000002bb6b130 RCX: 00007f852a19d54e [ 38.359647][ T887] RDX: 0000000000000000 RSI: 00007ffce55fc510 RDI: 0000000000000005 [ 38.359648][ T887] RBP: 00007ffce55fc480 R08: 0000000000000000 R09: 0000000000000000 [ 38.359649][ T887] R10: 0000000000000000 R11: 0000000000000202 R12: 000000002bb6b200 [ 38.359649][ T887] R13: 00007ffce55fc510 R14: 000000002bb6c260 R15: 000000000040bda8 [ 38.359652][ T887] [ 38.449762][ T891] tun2: deleting peer with id 2, reason 1 [ 43.275050][ T10] tun0: deleting peer with id 4, reason 2 [ 43.275071][ T10] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 43.275074][ T10] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 10, name: kworker/0:1 [ 43.275075][ T10] preempt_count: 202, expected: 0 [ 43.275076][ T10] RCU nest depth: 0, expected: 0 [ 43.275077][ T10] INFO: lockdep is turned off. [ 43.275078][ T10] irq event stamp: 22290 [ 43.275079][ T10] hardirqs last enabled at (22289): [] _raw_spin_unlock_irq+0x28/0x50 [ 43.275087][ T10] hardirqs last disabled at (22290): [] __schedule+0x1246/0x20e0 [ 43.275090][ T10] softirqs last enabled at (21560): [] handle_softirqs+0x67c/0x900 [ 43.275094][ T10] softirqs last disabled at (21553): [] __irq_exit_rcu+0x145/0x1c0 [ 43.275096][ T10] Preemption disabled at: [ 43.275097][ T10] [<0000000000000000>] 0x0 [ 43.275104][ T10] CPU: 0 UID: 0 PID: 10 Comm: kworker/0:1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 43.275108][ T10] Tainted: [W]=WARN [ 43.275109][ T10] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 43.275111][ T10] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 43.275120][ T10] Call Trace: [ 43.275121][ T10] [ 43.275123][ T10] dump_stack_lvl+0x6f/0xa0 [ 43.275128][ T10] __might_resched.cold+0x1fe/0x2c1 [ 43.275132][ T10] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 43.275135][ T10] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 43.275137][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.275141][ T10] __kmalloc_noprof+0x443/0x760 [ 43.275145][ T10] ? __rwlock_init+0x150/0x150 [ 43.275147][ T10] ? alloc_buf.isra.0+0x4b/0x260 [ 43.275151][ T10] ? do_raw_spin_unlock+0x59/0x250 [ 43.275153][ T10] alloc_buf.isra.0+0x4b/0x260 [ 43.275155][ T10] put_chars+0x1e1/0x2f0 [ 43.275157][ T10] ? prb_final_commit+0x50/0x50 [ 43.275158][ T10] ? __send_to_port+0x420/0x420 [ 43.275160][ T10] ? printk_get_next_message+0x240/0x650 [ 43.275163][ T10] hvc_console_print+0x292/0x780 [ 43.275167][ T10] ? hvc_write+0x3a0/0x3a0 [ 43.275168][ T10] ? do_raw_spin_lock+0x131/0x280 [ 43.275170][ T10] ? vsnprintf+0x527/0x1700 [ 43.275172][ T10] ? __rwlock_init+0x150/0x150 [ 43.275173][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.275175][ T10] ? lock_acquire+0x13c/0x160 [ 43.275177][ T10] console_emit_next_record+0x22f/0x4c0 [ 43.275180][ T10] ? devkmsg_read+0x4b0/0x4b0 [ 43.275182][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.275184][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.275185][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.275187][ T10] ? lock_acquire+0x13c/0x160 [ 43.275189][ T10] ? console_flush_one_record+0x111/0x710 [ 43.275190][ T10] console_flush_one_record+0x46f/0x710 [ 43.275193][ T10] ? console_emit_next_record+0x4c0/0x4c0 [ 43.275195][ T10] console_unlock+0xee/0x1f0 [ 43.275197][ T10] ? lock_acquire+0x13c/0x160 [ 43.275198][ T10] ? console_flush_one_record+0x710/0x710 [ 43.275200][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.275202][ T10] ? lock_release+0x184/0x1f0 [ 43.275203][ T10] ? lock_acquire+0x60/0x160 [ 43.275204][ T10] ? __rcu_read_lock+0x30/0x70 [ 43.275206][ T10] ? __down_trylock_console_sem+0x5e/0xa0 [ 43.275208][ T10] ? vprintk_emit+0x320/0x3e0 [ 43.275210][ T10] vprintk_emit+0x37c/0x3e0 [ 43.275213][ T10] ? wake_up_klogd_work_func+0x90/0x90 [ 43.275214][ T10] ? ret_from_fork_asm+0x11/0x20 [ 43.275217][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.275218][ T10] ? stack_access_ok+0x1e0/0x1e0 [ 43.275221][ T10] _printk+0xc7/0x100 [ 43.275224][ T10] ? snapshot_read.cold+0x21/0x21 [ 43.275226][ T10] ? __add_to_free_list+0x81/0x5c0 [ 43.275228][ T10] ? __mod_zone_page_state+0xe1/0x190 [ 43.275231][ T10] ? netdev_name+0x43/0x60 [ 43.275233][ T10] ? __netdev_printk+0x17f/0x1d0 [ 43.275235][ T10] netdev_info+0xe2/0x116 [ 43.275237][ T10] ? netdev_notice+0x120/0x120 [ 43.275238][ T10] ? free_pcppages_bulk+0x363/0x6e0 [ 43.275241][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.275242][ T10] ? trace_irq_enable.constprop.0+0x30/0x160 [ 43.275245][ T10] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 43.275249][ T10] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 43.275252][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.275254][ T10] ? lock_release+0x184/0x1f0 [ 43.275255][ T10] ? do_raw_spin_unlock+0x59/0x250 [ 43.275257][ T10] ovpn_peer_remove+0x394/0x640 [ovpn] [ 43.275261][ T10] ? do_raw_spin_lock+0x131/0x280 [ 43.275263][ T10] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 43.275265][ T10] ? __rwlock_init+0x150/0x150 [ 43.275267][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.275268][ T10] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 43.275269][ T10] ? trace_irq_disable.constprop.0+0x9b/0x160 [ 43.275271][ T10] ovpn_peer_keepalive_work_single+0x416/0x600 [ovpn] [ 43.275274][ T10] ? ovpn_peers_release_mp+0x490/0x490 [ovpn] [ 43.275276][ T10] ? __rwlock_init+0x150/0x150 [ 43.275279][ T10] ovpn_peer_keepalive_work+0x253/0x580 [ovpn] [ 43.275282][ T10] ? ovpn_peers_free+0xb0/0xb0 [ovpn] [ 43.275284][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.275286][ T10] ? lock_acquire+0x13c/0x160 [ 43.275287][ T10] ? rcu_is_watching+0x16/0xd0 [ 43.275289][ T10] process_one_work+0xe3e/0x1560 [ 43.275294][ T10] ? __queue_delayed_work+0x470/0x470 [ 43.275295][ T10] ? find_held_lock+0x2b/0x80 [ 43.275298][ T10] ? __rwlock_init+0x150/0x150 [ 43.275300][ T10] worker_thread+0x4f1/0xd60 [ 43.275302][ T10] ? rescuer_thread+0x1340/0x1340 [ 43.275304][ T10] ? __kthread_parkme+0xbd/0x210 [ 43.275306][ T10] ? rescuer_thread+0x1340/0x1340 [ 43.275308][ T10] ? rescuer_thread+0x1340/0x1340 [ 43.275310][ T10] kthread+0x367/0x460 [ 43.275311][ T10] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 43.275313][ T10] ? kthread_affine_preferred+0x4c0/0x4c0 [ 43.275314][ T10] ret_from_fork+0x474/0x6b0 [ 43.275317][ T10] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 43.275319][ T10] ? __switch_to+0x5a3/0xe00 [ 43.275322][ T10] ? kthread_affine_preferred+0x4c0/0x4c0 [ 43.275323][ T10] ret_from_fork_asm+0x11/0x20 [ 43.275326][ T10] [ 43.293821][ T10] tun0: deleting peer with id 3, reason 2 [ 44.299037][ T10] tun0: deleting peer with id 5, reason 2 [ 44.299057][ T10] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 44.299060][ T10] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 10, name: kworker/0:1 [ 44.299062][ T10] preempt_count: 202, expected: 0 [ 44.299063][ T10] RCU nest depth: 0, expected: 0 [ 44.299063][ T10] INFO: lockdep is turned off. [ 44.299065][ T10] irq event stamp: 22290 [ 44.299065][ T10] hardirqs last enabled at (22289): [] _raw_spin_unlock_irq+0x28/0x50 [ 44.299073][ T10] hardirqs last disabled at (22290): [] __schedule+0x1246/0x20e0 [ 44.299076][ T10] softirqs last enabled at (21560): [] handle_softirqs+0x67c/0x900 [ 44.299079][ T10] softirqs last disabled at (21553): [] __irq_exit_rcu+0x145/0x1c0 [ 44.299081][ T10] Preemption disabled at: [ 44.299082][ T10] [<0000000000000000>] 0x0 [ 44.299089][ T10] CPU: 0 UID: 0 PID: 10 Comm: kworker/0:1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 44.299092][ T10] Tainted: [W]=WARN [ 44.299093][ T10] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 44.299095][ T10] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 44.299105][ T10] Call Trace: [ 44.299107][ T10] [ 44.299108][ T10] dump_stack_lvl+0x6f/0xa0 [ 44.299113][ T10] __might_resched.cold+0x1fe/0x2c1 [ 44.299117][ T10] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 44.299121][ T10] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 44.299123][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.299127][ T10] __kmalloc_noprof+0x443/0x760 [ 44.299130][ T10] ? __rwlock_init+0x150/0x150 [ 44.299133][ T10] ? alloc_buf.isra.0+0x4b/0x260 [ 44.299137][ T10] ? do_raw_spin_unlock+0x59/0x250 [ 44.299138][ T10] alloc_buf.isra.0+0x4b/0x260 [ 44.299140][ T10] put_chars+0x1e1/0x2f0 [ 44.299142][ T10] ? prb_final_commit+0x50/0x50 [ 44.299144][ T10] ? __send_to_port+0x420/0x420 [ 44.299145][ T10] ? printk_get_next_message+0x240/0x650 [ 44.299149][ T10] hvc_console_print+0x292/0x780 [ 44.299153][ T10] ? hvc_write+0x3a0/0x3a0 [ 44.299154][ T10] ? do_raw_spin_lock+0x131/0x280 [ 44.299155][ T10] ? vsnprintf+0x527/0x1700 [ 44.299157][ T10] ? __rwlock_init+0x150/0x150 [ 44.299159][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.299161][ T10] ? lock_acquire+0x13c/0x160 [ 44.299163][ T10] console_emit_next_record+0x22f/0x4c0 [ 44.299166][ T10] ? devkmsg_read+0x4b0/0x4b0 [ 44.299168][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.299169][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.299171][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.299172][ T10] ? lock_acquire+0x13c/0x160 [ 44.299174][ T10] ? console_flush_one_record+0x111/0x710 [ 44.299176][ T10] console_flush_one_record+0x46f/0x710 [ 44.299178][ T10] ? console_emit_next_record+0x4c0/0x4c0 [ 44.299181][ T10] console_unlock+0xee/0x1f0 [ 44.299183][ T10] ? lock_acquire+0x13c/0x160 [ 44.299184][ T10] ? console_flush_one_record+0x710/0x710 [ 44.299186][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.299187][ T10] ? lock_release+0x184/0x1f0 [ 44.299189][ T10] ? lock_acquire+0x60/0x160 [ 44.299190][ T10] ? __rcu_read_lock+0x30/0x70 [ 44.299192][ T10] ? __down_trylock_console_sem+0x5e/0xa0 [ 44.299194][ T10] ? vprintk_emit+0x320/0x3e0 [ 44.299196][ T10] vprintk_emit+0x37c/0x3e0 [ 44.299198][ T10] ? wake_up_klogd_work_func+0x90/0x90 [ 44.299200][ T10] ? unwind_next_frame+0x69b/0x1ea0 [ 44.299202][ T10] ? ret_from_fork_asm+0x11/0x20 [ 44.299205][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.299207][ T10] _printk+0xc7/0x100 [ 44.299210][ T10] ? snapshot_read.cold+0x21/0x21 [ 44.299212][ T10] ? __add_to_free_list+0x81/0x5c0 [ 44.299214][ T10] ? __mod_zone_page_state+0xe1/0x190 [ 44.299217][ T10] ? netdev_name+0x43/0x60 [ 44.299219][ T10] ? __netdev_printk+0x17f/0x1d0 [ 44.299221][ T10] netdev_info+0xe2/0x116 [ 44.299222][ T10] ? netdev_notice+0x120/0x120 [ 44.299224][ T10] ? free_pcppages_bulk+0x363/0x6e0 [ 44.299226][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.299228][ T10] ? trace_irq_enable.constprop.0+0x30/0x160 [ 44.299231][ T10] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 44.299236][ T10] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 44.299238][ T10] ? __rwlock_init+0x150/0x150 [ 44.299240][ T10] ? lock_acquire+0x13c/0x160 [ 44.299241][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.299243][ T10] ovpn_peer_remove+0x394/0x640 [ovpn] [ 44.299246][ T10] ? do_raw_spin_lock+0x131/0x280 [ 44.299248][ T10] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 44.299251][ T10] ? __rwlock_init+0x150/0x150 [ 44.299252][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.299254][ T10] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 44.299255][ T10] ? trace_irq_disable.constprop.0+0x9b/0x160 [ 44.299257][ T10] ovpn_peer_keepalive_work_single+0x416/0x600 [ovpn] [ 44.299260][ T10] ? ovpn_peers_release_mp+0x490/0x490 [ovpn] [ 44.299262][ T10] ? __rwlock_init+0x150/0x150 [ 44.299264][ T10] ovpn_peer_keepalive_work+0x253/0x580 [ovpn] [ 44.299268][ T10] ? ovpn_peers_free+0xb0/0xb0 [ovpn] [ 44.299270][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.299272][ T10] ? lock_acquire+0x13c/0x160 [ 44.299273][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.299275][ T10] process_one_work+0xe3e/0x1560 [ 44.299280][ T10] ? __queue_delayed_work+0x470/0x470 [ 44.299281][ T10] ? find_held_lock+0x2b/0x80 [ 44.299284][ T10] ? __rwlock_init+0x150/0x150 [ 44.299286][ T10] worker_thread+0x4f1/0xd60 [ 44.299288][ T10] ? rescuer_thread+0x1340/0x1340 [ 44.299290][ T10] ? __kthread_parkme+0xbd/0x210 [ 44.299293][ T10] ? rescuer_thread+0x1340/0x1340 [ 44.299294][ T10] ? rescuer_thread+0x1340/0x1340 [ 44.299296][ T10] kthread+0x367/0x460 [ 44.299298][ T10] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 44.299299][ T10] ? kthread_affine_preferred+0x4c0/0x4c0 [ 44.299301][ T10] ret_from_fork+0x474/0x6b0 [ 44.299304][ T10] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 44.299306][ T10] ? __switch_to+0x5a3/0xe00 [ 44.299308][ T10] ? kthread_affine_preferred+0x4c0/0x4c0 [ 44.299310][ T10] ret_from_fork_asm+0x11/0x20 [ 44.299313][ T10] [ 44.313596][ T10] tun0: deleting peer with id 6, reason 2 [ 49.420102][ T66] tun3: deleting peer with id 3, reason 2 [ 49.420122][ T66] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 49.420124][ T66] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 66, name: kworker/2:2 [ 49.420126][ T66] preempt_count: 202, expected: 0 [ 49.420127][ T66] RCU nest depth: 0, expected: 0 [ 49.420127][ T66] INFO: lockdep is turned off. [ 49.420129][ T66] irq event stamp: 21086 [ 49.420130][ T66] hardirqs last enabled at (21085): [] _raw_spin_unlock_irq+0x28/0x50 [ 49.420137][ T66] hardirqs last disabled at (21086): [] __schedule+0x1246/0x20e0 [ 49.420140][ T66] softirqs last enabled at (17020): [] handle_softirqs+0x67c/0x900 [ 49.420144][ T66] softirqs last disabled at (17013): [] __irq_exit_rcu+0x145/0x1c0 [ 49.420146][ T66] Preemption disabled at: [ 49.420147][ T66] [<0000000000000000>] 0x0 [ 49.420154][ T66] CPU: 2 UID: 0 PID: 66 Comm: kworker/2:2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 49.420157][ T66] Tainted: [W]=WARN [ 49.420158][ T66] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 49.420160][ T66] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 49.420168][ T66] Call Trace: [ 49.420170][ T66] [ 49.420172][ T66] dump_stack_lvl+0x6f/0xa0 [ 49.420177][ T66] __might_resched.cold+0x1fe/0x2c1 [ 49.420181][ T66] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 49.420184][ T66] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 49.420187][ T66] ? rcu_is_watching+0x16/0xd0 [ 49.420190][ T66] __kmalloc_noprof+0x443/0x760 [ 49.420194][ T66] ? __rwlock_init+0x150/0x150 [ 49.420197][ T66] ? alloc_buf.isra.0+0x4b/0x260 [ 49.420201][ T66] ? do_raw_spin_unlock+0x59/0x250 [ 49.420202][ T66] alloc_buf.isra.0+0x4b/0x260 [ 49.420205][ T66] put_chars+0x1e1/0x2f0 [ 49.420206][ T66] ? prb_final_commit+0x50/0x50 [ 49.420208][ T66] ? __send_to_port+0x420/0x420 [ 49.420210][ T66] ? printk_get_next_message+0x240/0x650 [ 49.420213][ T66] hvc_console_print+0x292/0x780 [ 49.420217][ T66] ? hvc_write+0x3a0/0x3a0 [ 49.420219][ T66] ? do_raw_spin_lock+0x131/0x280 [ 49.420220][ T66] ? vsnprintf+0x527/0x1700 [ 49.420222][ T66] ? __rwlock_init+0x150/0x150 [ 49.420224][ T66] ? rcu_is_watching+0x16/0xd0 [ 49.420225][ T66] ? lock_acquire+0x13c/0x160 [ 49.420228][ T66] console_emit_next_record+0x22f/0x4c0 [ 49.420230][ T66] ? devkmsg_read+0x4b0/0x4b0 [ 49.420232][ T66] ? rcu_is_watching+0x16/0xd0 [ 49.420233][ T66] ? rcu_is_watching+0x16/0xd0 [ 49.420235][ T66] ? rcu_is_watching+0x16/0xd0 [ 49.420237][ T66] ? lock_acquire+0x13c/0x160 [ 49.420238][ T66] ? console_flush_one_record+0x111/0x710 [ 49.420240][ T66] console_flush_one_record+0x46f/0x710 [ 49.420242][ T66] ? console_emit_next_record+0x4c0/0x4c0 [ 49.420245][ T66] console_unlock+0xee/0x1f0 [ 49.420247][ T66] ? lock_acquire+0x13c/0x160 [ 49.420248][ T66] ? console_flush_one_record+0x710/0x710 [ 49.420250][ T66] ? rcu_is_watching+0x16/0xd0 [ 49.420251][ T66] ? lock_release+0x184/0x1f0 [ 49.420253][ T66] ? lock_acquire+0x60/0x160 [ 49.420254][ T66] ? __rcu_read_lock+0x30/0x70 [ 49.420256][ T66] ? __down_trylock_console_sem+0x5e/0xa0 [ 49.420258][ T66] ? vprintk_emit+0x320/0x3e0 [ 49.420260][ T66] vprintk_emit+0x37c/0x3e0 [ 49.420262][ T66] ? wake_up_klogd_work_func+0x90/0x90 [ 49.420264][ T66] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 49.420265][ T66] ? rcu_is_watching+0x16/0xd0 [ 49.420267][ T66] ? trace_sched_wakeup+0x9b/0x160 [ 49.420269][ T66] _printk+0xc7/0x100 [ 49.420272][ T66] ? snapshot_read.cold+0x21/0x21 [ 49.420274][ T66] ? try_to_wake_up+0x153/0x1130 [ 49.420276][ T66] ? select_fallback_rq+0x510/0x510 [ 49.420277][ T66] ? netdev_name+0x43/0x60 [ 49.420280][ T66] ? __netdev_printk+0x17f/0x1d0 [ 49.420281][ T66] netdev_info+0xe2/0x116 [ 49.420283][ T66] ? netdev_notice+0x120/0x120 [ 49.420285][ T66] ? rcu_is_watching+0x16/0xd0 [ 49.420287][ T66] ? __queue_work+0x3ab/0xd30 [ 49.420290][ T66] ? kthread+0x367/0x460 [ 49.420292][ T66] ? trace_irq_enable.constprop.0+0x30/0x160 [ 49.420295][ T66] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 49.420299][ T66] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 49.420302][ T66] ? rcu_is_watching+0x16/0xd0 [ 49.420303][ T66] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 49.420305][ T66] ovpn_peer_remove+0x394/0x640 [ovpn] [ 49.420309][ T66] ? do_raw_spin_lock+0x131/0x280 [ 49.420311][ T66] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 49.420313][ T66] ? __rwlock_init+0x150/0x150 [ 49.420315][ T66] ? rcu_is_watching+0x16/0xd0 [ 49.420317][ T66] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 49.420318][ T66] ? trace_irq_disable.constprop.0+0x9b/0x160 [ 49.420319][ T66] ovpn_peer_keepalive_work_single+0x416/0x600 [ovpn] [ 49.420322][ T66] ? ovpn_peers_release_mp+0x490/0x490 [ovpn] [ 49.420324][ T66] ? __rwlock_init+0x150/0x150 [ 49.420327][ T66] ovpn_peer_keepalive_work+0x389/0x580 [ovpn] [ 49.420330][ T66] ? ovpn_peers_free+0xb0/0xb0 [ovpn] [ 49.420332][ T66] ? rcu_is_watching+0x16/0xd0 [ 49.420334][ T66] ? lock_acquire+0x13c/0x160 [ 49.420335][ T66] ? rcu_is_watching+0x16/0xd0 [ 49.420337][ T66] ? process_one_work+0xdfc/0x1560 [ 49.420339][ T66] process_one_work+0xe3e/0x1560 [ 49.420342][ T66] ? __queue_delayed_work+0x470/0x470 [ 49.420344][ T66] ? find_held_lock+0x2b/0x80 [ 49.420346][ T66] ? __rwlock_init+0x150/0x150 [ 49.420348][ T66] worker_thread+0x4f1/0xd60 [ 49.420350][ T66] ? rescuer_thread+0x1340/0x1340 [ 49.420352][ T66] ? __kthread_parkme+0xbd/0x210 [ 49.420354][ T66] ? rescuer_thread+0x1340/0x1340 [ 49.420355][ T66] ? rescuer_thread+0x1340/0x1340 [ 49.420357][ T66] kthread+0x367/0x460 [ 49.420358][ T66] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 49.420359][ T66] ? kthread_affine_preferred+0x4c0/0x4c0 [ 49.420361][ T66] ret_from_fork+0x474/0x6b0 [ 49.420364][ T66] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 49.420365][ T66] ? __switch_to+0x5a3/0xe00 [ 49.420368][ T66] ? kthread_affine_preferred+0x4c0/0x4c0 [ 49.420370][ T66] ret_from_fork_asm+0x11/0x20 [ 49.420374][ T66] [ 49.484051][ T61] tun4: deleting peer with id 4, reason 2 [ 49.547048][ T10] tun5: deleting peer with id 5, reason 2 [ 49.611034][ T10] tun6: deleting peer with id 6, reason 2