[ 14.664763][ T301] ip (301) used greatest stack depth: 24496 bytes left [ 14.664778][ T301] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 14.664779][ T301] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 301, name: ip [ 14.664781][ T301] preempt_count: 2, expected: 0 [ 14.664782][ T301] RCU nest depth: 0, expected: 0 [ 14.664783][ T301] locks held by ip/301: 5, last CPU#3: [ 14.664785][ T301] #0: ffffffffabc127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 14.664796][ T301] #1: ffffffffabd79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 14.664801][ T301] #2: ffffffffabd79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 14.664805][ T301] #3: ffffffffabc99660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 14.664809][ T301] #4: ffffffffabc99560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 14.664812][ T301] irq event stamp: 40178 [ 14.664813][ T301] hardirqs last enabled at (40177): [] __down_trylock_console_sem+0x86/0xa0 [ 14.664816][ T301] hardirqs last disabled at (40178): [] console_emit_next_record+0x3d4/0x4c0 [ 14.664818][ T301] softirqs last enabled at (39908): [] handle_softirqs+0x67c/0x900 [ 14.664820][ T301] softirqs last disabled at (39901): [] __irq_exit_rcu+0x145/0x1c0 [ 14.664822][ T301] Preemption disabled at: [ 14.664822][ T301] [<0000000000000000>] 0x0 [ 14.664829][ T301] CPU: 3 UID: 0 PID: 301 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 14.664833][ T301] Tainted: [W]=WARN [ 14.664833][ T301] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.664835][ T301] Call Trace: [ 14.664836][ T301] [ 14.664838][ T301] dump_stack_lvl+0x6f/0xa0 [ 14.664844][ T301] __might_resched.cold+0x1fe/0x2c1 [ 14.664849][ T301] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 14.664853][ T301] ? __kmalloc_noprof+0xdb/0x760 [ 14.664858][ T301] __kmalloc_noprof+0x443/0x760 [ 14.664860][ T301] ? alloc_buf.isra.0+0x4b/0x260 [ 14.664867][ T301] ? do_raw_spin_unlock+0x59/0x250 [ 14.664869][ T301] alloc_buf.isra.0+0x4b/0x260 [ 14.664873][ T301] put_chars+0x1e1/0x2f0 [ 14.664876][ T301] ? __send_to_port+0x420/0x420 [ 14.664877][ T301] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 14.664882][ T301] ? validate_chain+0x38b/0xc20 [ 14.664887][ T301] hvc_console_print+0x292/0x780 [ 14.664895][ T301] ? hvc_write+0x3a0/0x3a0 [ 14.664897][ T301] ? rcu_is_watching+0x16/0xd0 [ 14.664899][ T301] ? lock_acquire+0x13c/0x160 [ 14.664904][ T301] console_emit_next_record+0x22f/0x4c0 [ 14.664908][ T301] ? devkmsg_read+0x4b0/0x4b0 [ 14.664909][ T301] ? console_flush_one_record+0x106/0x710 [ 14.664913][ T301] ? rcu_is_watching+0x16/0xd0 [ 14.664915][ T301] ? lock_acquire+0x13c/0x160 [ 14.664919][ T301] console_flush_one_record+0x46f/0x710 [ 14.664923][ T301] ? console_emit_next_record+0x4c0/0x4c0 [ 14.664925][ T301] ? __lock_acquire+0x518/0xc20 [ 14.664931][ T301] console_unlock+0xee/0x1f0 [ 14.664933][ T301] ? console_flush_one_record+0x710/0x710 [ 14.664935][ T301] ? rcu_is_watching+0x16/0xd0 [ 14.664938][ T301] ? lock_acquire+0x60/0x160 [ 14.664941][ T301] ? __down_trylock_console_sem+0x5e/0xa0 [ 14.664943][ T301] ? vprintk_emit+0x320/0x3e0 [ 14.664946][ T301] vprintk_emit+0x37c/0x3e0 [ 14.664950][ T301] ? wake_up_klogd_work_func+0x90/0x90 [ 14.664954][ T301] ? __lock_acquire+0x518/0xc20 [ 14.664958][ T301] _printk+0xc7/0x100 [ 14.664961][ T301] ? snapshot_read.cold+0x21/0x21 [ 14.664964][ T301] ? do_raw_spin_lock+0x131/0x280 [ 14.664967][ T301] ? __rwlock_init+0x150/0x150 [ 14.664971][ T301] ? do_raw_spin_lock+0x131/0x280 [ 14.664974][ T301] do_exit.cold+0x82/0x9c [ 14.664978][ T301] ? exit_notify+0x890/0x890 [ 14.664979][ T301] ? __lock_release.isra.0+0x69/0x1a0 [ 14.664981][ T301] ? rcu_is_watching+0x16/0xd0 [ 14.664986][ T301] do_group_exit+0xb8/0x370 [ 14.664989][ T301] __x64_sys_exit_group+0x3c/0x50 [ 14.664990][ T301] x64_sys_call+0x1567/0x1570 [ 14.664993][ T301] do_syscall_64+0xff/0x530 [ 14.664997][ T301] ? exc_page_fault+0xee/0x100 [ 14.665000][ T301] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 14.665002][ T301] RIP: 0033:0x7f3f028d61b8 [ 14.665004][ T301] Code: Unable to access opcode bytes at 0x7f3f028d618e. [ 14.665005][ T301] RSP: 002b:00007ffe3e856e88 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 14.665008][ T301] RAX: ffffffffffffffda RBX: 00007f3f02a06f88 RCX: 00007f3f028d61b8 [ 14.665009][ T301] RDX: 00007f3f02620fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 14.665010][ T301] RBP: 00007ffe3e856ee0 R08: 0000000000000000 R09: 0000000000000000 [ 14.665011][ T301] R10: 00007ffe3e856ca0 R11: 0000000000000246 R12: 0000000000000001 [ 14.665011][ T301] R13: 0000000000000000 R14: 00007f3f02a05680 R15: 00007f3f02a06fa0 [ 14.665019][ T301] [ 15.115869][ T316] ip (316) used greatest stack depth: 24480 bytes left [ 15.555806][ T330] ip (330) used greatest stack depth: 24160 bytes left [ 28.905663][ T741] iperf3 (741) used greatest stack depth: 23536 bytes left [ 28.905682][ T741] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 28.905684][ T741] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 741, name: iperf3 [ 28.905686][ T741] preempt_count: 2, expected: 0 [ 28.905687][ T741] RCU nest depth: 0, expected: 0 [ 28.905688][ T741] locks held by iperf3/741: 5, last CPU#0: [ 28.905690][ T741] #0: ffffffffabc127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 28.905701][ T741] #1: ffffffffabd79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 28.905707][ T741] #2: ffffffffabd79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 28.905712][ T741] #3: ffffffffabc99660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 28.905716][ T741] #4: ffffffffabc99560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 28.905719][ T741] irq event stamp: 7678200 [ 28.905720][ T741] hardirqs last enabled at (7678199): [] __down_trylock_console_sem+0x86/0xa0 [ 28.905723][ T741] hardirqs last disabled at (7678200): [] console_emit_next_record+0x3d4/0x4c0 [ 28.905725][ T741] softirqs last enabled at (7676404): [] handle_softirqs+0x67c/0x900 [ 28.905727][ T741] softirqs last disabled at (7675501): [] __irq_exit_rcu+0x145/0x1c0 [ 28.905729][ T741] Preemption disabled at: [ 28.905730][ T741] [<0000000000000000>] 0x0 [ 28.905738][ T741] CPU: 0 UID: 0 PID: 741 Comm: iperf3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 28.905741][ T741] Tainted: [W]=WARN [ 28.905742][ T741] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 28.905743][ T741] Call Trace: [ 28.905745][ T741] [ 28.905746][ T741] dump_stack_lvl+0x6f/0xa0 [ 28.905752][ T741] __might_resched.cold+0x1fe/0x2c1 [ 28.905757][ T741] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 28.905761][ T741] ? __kmalloc_noprof+0xdb/0x760 [ 28.905766][ T741] __kmalloc_noprof+0x443/0x760 [ 28.905768][ T741] ? alloc_buf.isra.0+0x4b/0x260 [ 28.905774][ T741] ? do_raw_spin_unlock+0x59/0x250 [ 28.905777][ T741] alloc_buf.isra.0+0x4b/0x260 [ 28.905780][ T741] put_chars+0x1e1/0x2f0 [ 28.905782][ T741] ? prb_final_commit+0x50/0x50 [ 28.905784][ T741] ? __send_to_port+0x420/0x420 [ 28.905787][ T741] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 28.905792][ T741] ? rcu_read_lock_any_held+0x3c/0x90 [ 28.905794][ T741] ? validate_chain+0x38b/0xc20 [ 28.905797][ T741] hvc_console_print+0x292/0x780 [ 28.905801][ T741] ? mark_usage+0x61/0x170 [ 28.905803][ T741] ? __lock_acquire+0x518/0xc20 [ 28.905804][ T741] ? __lock_acquire+0x518/0xc20 [ 28.905808][ T741] ? hvc_write+0x3a0/0x3a0 [ 28.905810][ T741] ? console_emit_next_record+0x1df/0x4c0 [ 28.905813][ T741] ? rcu_is_watching+0x16/0xd0 [ 28.905816][ T741] ? lock_acquire+0x13c/0x160 [ 28.905819][ T741] console_emit_next_record+0x22f/0x4c0 [ 28.905823][ T741] ? devkmsg_read+0x4b0/0x4b0 [ 28.905825][ T741] ? console_flush_one_record+0x106/0x710 [ 28.905828][ T741] ? rcu_is_watching+0x16/0xd0 [ 28.905830][ T741] ? lock_acquire+0x13c/0x160 [ 28.905834][ T741] console_flush_one_record+0x46f/0x710 [ 28.905838][ T741] ? console_emit_next_record+0x4c0/0x4c0 [ 28.905840][ T741] ? __lock_acquire+0x518/0xc20 [ 28.905845][ T741] console_unlock+0xee/0x1f0 [ 28.905847][ T741] ? console_flush_one_record+0x710/0x710 [ 28.905849][ T741] ? rcu_is_watching+0x16/0xd0 [ 28.905851][ T741] ? lock_acquire+0x60/0x160 [ 28.905855][ T741] ? __down_trylock_console_sem+0x5e/0xa0 [ 28.905856][ T741] ? vprintk_emit+0x320/0x3e0 [ 28.905860][ T741] vprintk_emit+0x37c/0x3e0 [ 28.905863][ T741] ? wake_up_klogd_work_func+0x90/0x90 [ 28.905867][ T741] ? __lock_acquire+0x518/0xc20 [ 28.905870][ T741] _printk+0xc7/0x100 [ 28.905874][ T741] ? snapshot_read.cold+0x21/0x21 [ 28.905877][ T741] ? do_raw_spin_lock+0x131/0x280 [ 28.905879][ T741] ? __rwlock_init+0x150/0x150 [ 28.905883][ T741] ? do_raw_spin_lock+0x131/0x280 [ 28.905885][ T741] do_exit.cold+0x82/0x9c [ 28.905889][ T741] ? exit_notify+0x890/0x890 [ 28.905894][ T741] __x64_sys_exit+0x42/0x50 [ 28.905896][ T741] x64_sys_call+0x156c/0x1570 [ 28.905898][ T741] do_syscall_64+0xff/0x530 [ 28.905902][ T741] ? exc_page_fault+0xee/0x100 [ 28.905905][ T741] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.905907][ T741] RIP: 0033:0x7f361eb8fc49 [ 28.905909][ T741] Code: Unable to access opcode bytes at 0x7f361eb8fc1f. [ 28.905911][ T741] RSP: 002b:00007f361e34ee60 EFLAGS: 00000246 ORIG_RAX: 000000000000003c [ 28.905913][ T741] RAX: ffffffffffffffda RBX: 00007f361e34f6c0 RCX: 00007f361eb8fc49 [ 28.905914][ T741] RDX: 0000000000000000 RSI: 0000000000801000 RDI: 0000000000000000 [ 28.905915][ T741] RBP: 00007f361e34ef70 R08: 0000000000000001 R09: 00007f361e34f6c0 [ 28.905916][ T741] R10: 0000000000000008 R11: 0000000000000246 R12: 00007f361db4f000 [ 28.905917][ T741] R13: 00007ffc43c85700 R14: 0000000000000002 R15: 00007ffc43c85807 [ 28.905923][ T741] [ 30.786865][ T835] tun0: deleting peer with id 1, reason 1 [ 30.786929][ T835] [ 30.786931][ T835] ===================================================== [ 30.786932][ T835] WARNING: SOFTIRQ-safe -> SOFTIRQ-unsafe lock order detected [ 30.786935][ T835] 7.2.0-virtme #1 Tainted: G W [ 30.786936][ T835] ----------------------------------------------------- [ 30.786936][ T835] ovpn-cli/835 [HC0[0]:SC0[2]:HE0:SE0] is trying to acquire: [ 30.786938][ T835] ffffffffabc99660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 30.786950][ T835] [ 30.786950][ T835] and this task is already holding: [ 30.786951][ T835] ff1100000c7a9e68 (&ovpn->lock){+.-.}-{3:3}, at: ovpn_peer_del+0xa0/0x590 [ovpn] [ 30.786958][ T835] which would create a new lock dependency: [ 30.786959][ T835] (&ovpn->lock){+.-.}-{3:3} -> (console_owner){....}-{0:0} [ 30.786961][ T835] [ 30.786961][ T835] but this new dependency connects a SOFTIRQ-irq-safe lock: [ 30.786962][ T835] (&ovpn->lock){+.-.}-{3:3} [ 30.786963][ T835] [ 30.786963][ T835] ... which became SOFTIRQ-irq-safe at: [ 30.786964][ T835] __lock_acquire+0x388/0xc20 [ 30.786968][ T835] lock_acquire.part.0+0xd4/0x280 [ 30.786969][ T835] _raw_spin_lock_bh+0x38/0x50 [ 30.786972][ T835] ovpn_peer_endpoints_update+0xbc6/0x1ba0 [ovpn] [ 30.786976][ T835] ovpn_decrypt_post+0x74a/0x13e0 [ovpn] [ 30.786979][ T835] ovpn_udp_encap_recv+0x295/0x610 [ovpn] [ 30.786981][ T835] udp_queue_rcv_one_skb+0x645/0xb00 [ 30.786984][ T835] udp_unicast_rcv_skb+0x366/0x450 [ 30.786986][ T835] udp_rcv+0xaba/0x1d90 [ 30.786987][ T835] ip_protocol_deliver_rcu+0x82/0x350 [ 30.786989][ T835] ip_local_deliver_finish+0x36f/0x610 [ 30.786991][ T835] ip_local_deliver+0x184/0x4c0 [ 30.786992][ T835] ip_rcv+0xdc/0x3d0 [ 30.786993][ T835] __netif_receive_skb_one_core+0xfc/0x180 [ 30.786996][ T835] process_backlog+0x431/0x14c0 [ 30.786998][ T835] __napi_poll+0xa7/0x3b0 [ 30.787000][ T835] net_rx_action+0x513/0xf50 [ 30.787001][ T835] handle_softirqs+0x1d3/0x900 [ 30.787004][ T835] do_softirq+0xac/0xe0 [ 30.787005][ T835] __local_bh_enable_ip+0x118/0x150 [ 30.787006][ T835] __dev_queue_xmit+0x979/0x1b80 [ 30.787008][ T835] ip_finish_output2+0x5b9/0x1bc0 [ 30.787010][ T835] ip_output+0x1ca/0x660 [ 30.787011][ T835] ip_push_pending_frames+0xf6/0x250 [ 30.787013][ T835] raw_sendmsg+0x1169/0x1cc0 [ 30.787015][ T835] __sys_sendto+0x2aa/0x400 [ 30.787017][ T835] __x64_sys_sendto+0xe4/0x1f0 [ 30.787019][ T835] do_syscall_64+0xff/0x530 [ 30.787021][ T835] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 30.787023][ T835] [ 30.787023][ T835] to a SOFTIRQ-irq-unsafe lock: [ 30.787024][ T835] (fs_reclaim){+.+.}-{0:0} [ 30.787025][ T835] [ 30.787025][ T835] ... which became SOFTIRQ-irq-unsafe at: [ 30.787026][ T835] ... [ 30.787027][ T835] __lock_acquire+0x388/0xc20 [ 30.787028][ T835] lock_acquire.part.0+0xd4/0x280 [ 30.787029][ T835] fs_reclaim_acquire+0xd5/0x120 [ 30.787032][ T835] __kmalloc_cache_noprof+0x6e/0x620 [ 30.787034][ T835] kthread_create_worker_on_node+0xea/0x210 [ 30.787037][ T835] workqueue_init+0x2a/0x680 [ 30.787040][ T835] kernel_init_freeable+0x2fe/0x630 [ 30.787043][ T835] kernel_init+0x21/0x150 [ 30.787045][ T835] ret_from_fork+0x474/0x6b0 [ 30.787047][ T835] ret_from_fork_asm+0x11/0x20 [ 30.787050][ T835] [ 30.787050][ T835] other info that might help us debug this: [ 30.787050][ T835] [ 30.787051][ T835] Chain exists of: [ 30.787051][ T835] &ovpn->lock --> console_owner --> fs_reclaim [ 30.787051][ T835] [ 30.787053][ T835] Possible interrupt unsafe locking scenario: [ 30.787053][ T835] [ 30.787053][ T835] CPU0 CPU1 [ 30.787054][ T835] ---- ---- [ 30.787054][ T835] lock(fs_reclaim); [ 30.787055][ T835] local_irq_disable(); [ 30.787056][ T835] lock(&ovpn->lock); [ 30.787056][ T835] lock(console_owner); [ 30.787057][ T835] [ 30.787057][ T835] lock(&ovpn->lock); [ 30.787058][ T835] [ 30.787058][ T835] *** DEADLOCK *** [ 30.787058][ T835] [ 30.787059][ T835] locks held by ovpn-cli/835: 4, last CPU#3: [ 30.787060][ T835] #0: ffffffffac544b68 (cb_lock){++++}-{4:4}, at: genl_rcv+0x19/0x40 [ 30.787065][ T835] #1: ff1100000c7a9e68 (&ovpn->lock){+.-.}-{3:3}, at: ovpn_peer_del+0xa0/0x590 [ovpn] [ 30.787069][ T835] #2: ffffffffabd79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 30.787072][ T835] #3: ffffffffabd79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 30.787075][ T835] [ 30.787075][ T835] the dependencies between SOFTIRQ-irq-safe lock and the holding lock: [ 30.787076][ T835] -> (&ovpn->lock){+.-.}-{3:3} { [ 30.787078][ T835] HARDIRQ-ON-W at: [ 30.787079][ T835] __lock_acquire+0x388/0xc20 [ 30.787081][ T835] lock_acquire.part.0+0xd4/0x280 [ 30.787082][ T835] _raw_spin_lock_bh+0x38/0x50 [ 30.787083][ T835] ovpn_peer_add_mp+0xad/0x6a0 [ovpn] [ 30.787085][ T835] ovpn_peer_add+0x152/0x330 [ovpn] [ 30.787087][ T835] ovpn_nl_peer_new_doit+0x54f/0xcf0 [ovpn] [ 30.787090][ T835] genl_family_rcv_msg_doit+0x206/0x300 [ 30.787092][ T835] genl_family_rcv_msg+0x3a4/0x640 [ 30.787093][ T835] genl_rcv_msg+0xbb/0x160 [ 30.787095][ T835] netlink_rcv_skb+0x14e/0x3a0 [ 30.787097][ T835] genl_rcv+0x28/0x40 [ 30.787098][ T835] netlink_unicast+0x486/0x750 [ 30.787099][ T835] netlink_sendmsg+0x735/0xc60 [ 30.787101][ T835] ____sys_sendmsg+0x415/0x880 [ 30.787103][ T835] ___sys_sendmsg+0x14e/0x1d0 [ 30.787104][ T835] __sys_sendmsg+0x12c/0x1d0 [ 30.787106][ T835] do_syscall_64+0xff/0x530 [ 30.787107][ T835] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 30.787109][ T835] IN-SOFTIRQ-W at: [ 30.787109][ T835] __lock_acquire+0x388/0xc20 [ 30.787111][ T835] lock_acquire.part.0+0xd4/0x280 [ 30.787112][ T835] _raw_spin_lock_bh+0x38/0x50 [ 30.787113][ T835] ovpn_peer_endpoints_update+0xbc6/0x1ba0 [ovpn] [ 30.787115][ T835] ovpn_decrypt_post+0x74a/0x13e0 [ovpn] [ 30.787117][ T835] ovpn_udp_encap_recv+0x295/0x610 [ovpn] [ 30.787120][ T835] udp_queue_rcv_one_skb+0x645/0xb00 [ 30.787121][ T835] udp_unicast_rcv_skb+0x366/0x450 [ 30.787122][ T835] udp_rcv+0xaba/0x1d90 [ 30.787123][ T835] ip_protocol_deliver_rcu+0x82/0x350 [ 30.787125][ T835] ip_local_deliver_finish+0x36f/0x610 [ 30.787126][ T835] ip_local_deliver+0x184/0x4c0 [ 30.787127][ T835] ip_rcv+0xdc/0x3d0 [ 30.787128][ T835] __netif_receive_skb_one_core+0xfc/0x180 [ 30.787130][ T835] process_backlog+0x431/0x14c0 [ 30.787132][ T835] __napi_poll+0xa7/0x3b0 [ 30.787133][ T835] net_rx_action+0x513/0xf50 [ 30.787135][ T835] handle_softirqs+0x1d3/0x900 [ 30.787136][ T835] do_softirq+0xac/0xe0 [ 30.787137][ T835] __local_bh_enable_ip+0x118/0x150 [ 30.787138][ T835] __dev_queue_xmit+0x979/0x1b80 [ 30.787140][ T835] ip_finish_output2+0x5b9/0x1bc0 [ 30.787141][ T835] ip_output+0x1ca/0x660 [ 30.787143][ T835] ip_push_pending_frames+0xf6/0x250 [ 30.787144][ T835] raw_sendmsg+0x1169/0x1cc0 [ 30.787145][ T835] __sys_sendto+0x2aa/0x400 [ 30.787147][ T835] __x64_sys_sendto+0xe4/0x1f0 [ 30.787148][ T835] do_syscall_64+0xff/0x530 [ 30.787150][ T835] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 30.787151][ T835] INITIAL USE at: [ 30.787151][ T835] __lock_acquire+0x388/0xc20 [ 30.787153][ T835] lock_acquire.part.0+0xd4/0x280 [ 30.787154][ T835] _raw_spin_lock_bh+0x38/0x50 [ 30.787155][ T835] ovpn_peer_add_mp+0xad/0x6a0 [ovpn] [ 30.787157][ T835] ovpn_peer_add+0x152/0x330 [ovpn] [ 30.787159][ T835] ovpn_nl_peer_new_doit+0x54f/0xcf0 [ovpn] [ 30.787161][ T835] genl_family_rcv_msg_doit+0x206/0x300 [ 30.787163][ T835] genl_family_rcv_msg+0x3a4/0x640 [ 30.787164][ T835] genl_rcv_msg+0xbb/0x160 [ 30.787166][ T835] netlink_rcv_skb+0x14e/0x3a0 [ 30.787168][ T835] genl_rcv+0x28/0x40 [ 30.787169][ T835] netlink_unicast+0x486/0x750 [ 30.787170][ T835] netlink_sendmsg+0x735/0xc60 [ 30.787172][ T835] ____sys_sendmsg+0x415/0x880 [ 30.787173][ T835] ___sys_sendmsg+0x14e/0x1d0 [ 30.787175][ T835] __sys_sendmsg+0x12c/0x1d0 [ 30.787176][ T835] do_syscall_64+0xff/0x530 [ 30.787178][ T835] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 30.787179][ T835] } [ 30.787179][ T835] ... key at: [] __key.84+0x0/0x40 [ovpn] [ 30.787182][ T835] [ 30.787182][ T835] the dependencies between the lock to be acquired [ 30.787183][ T835] and SOFTIRQ-irq-unsafe lock: [ 30.787187][ T835] -> (fs_reclaim){+.+.}-{0:0} { [ 30.787189][ T835] HARDIRQ-ON-W at: [ 30.787189][ T835] __lock_acquire+0x388/0xc20 [ 30.787191][ T835] lock_acquire.part.0+0xd4/0x280 [ 30.787192][ T835] fs_reclaim_acquire+0xd5/0x120 [ 30.787193][ T835] __kmalloc_cache_noprof+0x6e/0x620 [ 30.787195][ T835] kthread_create_worker_on_node+0xea/0x210 [ 30.787196][ T835] workqueue_init+0x2a/0x680 [ 30.787197][ T835] kernel_init_freeable+0x2fe/0x630 [ 30.787199][ T835] kernel_init+0x21/0x150 [ 30.787200][ T835] ret_from_fork+0x474/0x6b0 [ 30.787201][ T835] ret_from_fork_asm+0x11/0x20 [ 30.787202][ T835] SOFTIRQ-ON-W at: [ 30.787203][ T835] __lock_acquire+0x388/0xc20 [ 30.787204][ T835] lock_acquire.part.0+0xd4/0x280 [ 30.787205][ T835] fs_reclaim_acquire+0xd5/0x120 [ 30.787206][ T835] __kmalloc_cache_noprof+0x6e/0x620 [ 30.787208][ T835] kthread_create_worker_on_node+0xea/0x210 [ 30.787209][ T835] workqueue_init+0x2a/0x680 [ 30.787210][ T835] kernel_init_freeable+0x2fe/0x630 [ 30.787212][ T835] kernel_init+0x21/0x150 [ 30.787213][ T835] ret_from_fork+0x474/0x6b0 [ 30.787214][ T835] ret_from_fork_asm+0x11/0x20 [ 30.787215][ T835] INITIAL USE at: [ 30.787216][ T835] __lock_acquire+0x388/0xc20 [ 30.787217][ T835] lock_acquire.part.0+0xd4/0x280 [ 30.787218][ T835] fs_reclaim_acquire+0xd5/0x120 [ 30.787219][ T835] __kmalloc_cache_noprof+0x6e/0x620 [ 30.787221][ T835] kthread_create_worker_on_node+0xea/0x210 [ 30.787222][ T835] workqueue_init+0x2a/0x680 [ 30.787223][ T835] kernel_init_freeable+0x2fe/0x630 [ 30.787225][ T835] kernel_init+0x21/0x150 [ 30.787226][ T835] ret_from_fork+0x474/0x6b0 [ 30.787227][ T835] ret_from_fork_asm+0x11/0x20 [ 30.787228][ T835] } [ 30.787228][ T835] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 30.787232][ T835] ... acquired at: [ 30.787233][ T835] __lock_acquire+0x518/0xc20 [ 30.787234][ T835] lock_acquire.part.0+0xd4/0x280 [ 30.787235][ T835] fs_reclaim_acquire+0xd5/0x120 [ 30.787236][ T835] __kmalloc_noprof+0xd3/0x760 [ 30.787238][ T835] alloc_buf.isra.0+0x4b/0x260 [ 30.787241][ T835] put_chars+0x1e1/0x2f0 [ 30.787242][ T835] hvc_console_print+0x292/0x780 [ 30.787244][ T835] console_emit_next_record+0x22f/0x4c0 [ 30.787246][ T835] console_flush_one_record+0x46f/0x710 [ 30.787247][ T835] console_unlock+0xee/0x1f0 [ 30.787249][ T835] vprintk_emit+0x37c/0x3e0 [ 30.787250][ T835] dev_vprintk_emit+0x27f/0x2c0 [ 30.787253][ T835] dev_printk_emit+0xb9/0xee [ 30.787255][ T835] _dev_info+0xe2/0x116 [ 30.787256][ T835] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 30.787259][ T835] cmos_do_probe+0x73b/0x98a [ 30.787260][ T835] platform_probe+0xfe/0x1f0 [ 30.787263][ T835] call_driver_probe+0x61/0x1c0 [ 30.787265][ T835] really_probe+0x199/0x760 [ 30.787267][ T835] __driver_probe_device+0x24f/0x440 [ 30.787268][ T835] driver_probe_device+0x4a/0xf0 [ 30.787270][ T835] __driver_attach+0x1b8/0x540 [ 30.787271][ T835] bus_for_each_dev+0x130/0x1e0 [ 30.787272][ T835] bus_add_driver+0x2c8/0x530 [ 30.787274][ T835] driver_register+0x1a3/0x390 [ 30.787276][ T835] __platform_driver_probe+0x13f/0x270 [ 30.787277][ T835] cmos_init+0x31/0x40 [ 30.787279][ T835] do_one_initcall+0x124/0x4f0 [ 30.787281][ T835] kernel_init_freeable+0x596/0x630 [ 30.787282][ T835] kernel_init+0x21/0x150 [ 30.787283][ T835] ret_from_fork+0x474/0x6b0 [ 30.787284][ T835] ret_from_fork_asm+0x11/0x20 [ 30.787286][ T835] [ 30.787286][ T835] -> (console_owner){....}-{0:0} { [ 30.787288][ T835] INITIAL USE at: [ 30.787289][ T835] } [ 30.787289][ T835] ... key at: [] console_owner_dep_map+0x0/0x60 [ 30.787293][ T835] ... acquired at: [ 30.787293][ T835] check_prev_add+0xef/0xe90 [ 30.787294][ T835] validate_chain+0x6b8/0xc20 [ 30.787296][ T835] __lock_acquire+0x518/0xc20 [ 30.787297][ T835] lock_acquire.part.0+0xd4/0x280 [ 30.787298][ T835] console_lock_spinning_enable+0x5c/0x60 [ 30.787300][ T835] console_emit_next_record+0x1d1/0x4c0 [ 30.787301][ T835] console_flush_one_record+0x46f/0x710 [ 30.787303][ T835] console_unlock+0xee/0x1f0 [ 30.787304][ T835] vprintk_emit+0x37c/0x3e0 [ 30.787306][ T835] _printk+0xc7/0x100 [ 30.787308][ T835] netdev_info+0xe2/0x116 [ 30.787315][ T835] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 30.787318][ T835] ovpn_peer_remove+0x394/0x640 [ovpn] [ 30.787321][ T835] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 30.787323][ T835] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 30.787325][ T835] genl_family_rcv_msg_doit+0x206/0x300 [ 30.787327][ T835] genl_family_rcv_msg+0x3a4/0x640 [ 30.787328][ T835] genl_rcv_msg+0xbb/0x160 [ 30.787332][ T835] netlink_rcv_skb+0x14e/0x3a0 [ 30.787334][ T835] genl_rcv+0x28/0x40 [ 30.787335][ T835] netlink_unicast+0x486/0x750 [ 30.787336][ T835] netlink_sendmsg+0x735/0xc60 [ 30.787338][ T835] ____sys_sendmsg+0x415/0x880 [ 30.787339][ T835] ___sys_sendmsg+0x14e/0x1d0 [ 30.787341][ T835] __sys_sendmsg+0x12c/0x1d0 [ 30.787342][ T835] do_syscall_64+0xff/0x530 [ 30.787344][ T835] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 30.787345][ T835] [ 30.787345][ T835] [ 30.787345][ T835] stack backtrace: [ 30.787348][ T835] CPU: 3 UID: 0 PID: 835 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 30.787351][ T835] Tainted: [W]=WARN [ 30.787351][ T835] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 30.787353][ T835] Call Trace: [ 30.787354][ T835] [ 30.787355][ T835] dump_stack_lvl+0x6f/0xa0 [ 30.787360][ T835] print_bad_irq_dependency+0x3e4/0x410 [ 30.787362][ T835] check_irq_usage+0x403/0x570 [ 30.787364][ T835] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 30.787368][ T835] ? rcu_read_lock_any_held+0x3c/0x90 [ 30.787370][ T835] ? check_path.constprop.0+0x24/0x50 [ 30.787373][ T835] ? check_prev_add+0xef/0xe90 [ 30.787374][ T835] check_prev_add+0xef/0xe90 [ 30.787376][ T835] validate_chain+0x6b8/0xc20 [ 30.787378][ T835] __lock_acquire+0x518/0xc20 [ 30.787381][ T835] lock_acquire.part.0+0xd4/0x280 [ 30.787382][ T835] ? console_lock_spinning_enable+0x40/0x60 [ 30.787384][ T835] ? rcu_is_watching+0x16/0xd0 [ 30.787386][ T835] ? lock_acquire+0x13c/0x160 [ 30.787388][ T835] console_lock_spinning_enable+0x5c/0x60 [ 30.787390][ T835] ? console_lock_spinning_enable+0x40/0x60 [ 30.787392][ T835] console_emit_next_record+0x1d1/0x4c0 [ 30.787394][ T835] ? devkmsg_read+0x4b0/0x4b0 [ 30.787395][ T835] ? console_flush_one_record+0x106/0x710 [ 30.787397][ T835] ? rcu_is_watching+0x16/0xd0 [ 30.787399][ T835] ? lock_acquire+0x13c/0x160 [ 30.787401][ T835] console_flush_one_record+0x46f/0x710 [ 30.787403][ T835] ? console_emit_next_record+0x4c0/0x4c0 [ 30.787405][ T835] ? __lock_acquire+0x518/0xc20 [ 30.787407][ T835] console_unlock+0xee/0x1f0 [ 30.787409][ T835] ? console_flush_one_record+0x710/0x710 [ 30.787411][ T835] ? rcu_is_watching+0x16/0xd0 [ 30.787412][ T835] ? lock_acquire+0x60/0x160 [ 30.787414][ T835] ? __down_trylock_console_sem+0x5e/0xa0 [ 30.787416][ T835] ? vprintk_emit+0x320/0x3e0 [ 30.787418][ T835] vprintk_emit+0x37c/0x3e0 [ 30.787420][ T835] ? wake_up_klogd_work_func+0x90/0x90 [ 30.787422][ T835] ? kernel_text_address+0x149/0x170 [ 30.787423][ T835] ? __kernel_text_address+0x12/0x30 [ 30.787425][ T835] ? write_profile+0xf0/0xf0 [ 30.787427][ T835] ? unwind_get_return_address+0x67/0xd0 [ 30.787430][ T835] _printk+0xc7/0x100 [ 30.787431][ T835] ? snapshot_read.cold+0x21/0x21 [ 30.787433][ T835] ? mark_usage+0x61/0x170 [ 30.787435][ T835] ? netdev_name+0x43/0x60 [ 30.787436][ T835] ? __netdev_printk+0x17f/0x1d0 [ 30.787438][ T835] netdev_info+0xe2/0x116 [ 30.787439][ T835] ? netdev_notice+0x120/0x120 [ 30.787440][ T835] ? find_held_lock+0x2b/0x80 [ 30.787442][ T835] ? mark_usage+0x61/0x170 [ 30.787443][ T835] ? __lock_acquire+0x518/0xc20 [ 30.787446][ T835] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 30.787448][ T835] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 30.787451][ T835] ? ovpn_peer_get_by_id+0x1fd/0x7a0 [ovpn] [ 30.787454][ T835] ovpn_peer_remove+0x394/0x640 [ovpn] [ 30.787456][ T835] ? do_raw_spin_lock+0x131/0x280 [ 30.787458][ T835] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 30.787461][ T835] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 30.787464][ T835] ? ovpn_peer_add+0x330/0x330 [ovpn] [ 30.787467][ T835] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 30.787469][ T835] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 30.787471][ T835] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 30.787473][ T835] ? ref_tracker_alloc+0x28d/0x430 [ 30.787478][ T835] ? ovpn_get_dev_from_attrs+0x170/0x660 [ovpn] [ 30.787481][ T835] ? ovpn_get_dev_from_attrs+0x17a/0x660 [ovpn] [ 30.787484][ T835] genl_family_rcv_msg_doit+0x206/0x300 [ 30.787486][ T835] ? genl_family_rcv_msg_attrs_parse.isra.0+0x330/0x330 [ 30.787488][ T835] ? __lock_release.isra.0+0x69/0x1a0 [ 30.787490][ T835] ? rcu_is_watching+0x16/0xd0 [ 30.787492][ T835] ? cap_capable+0x1d7/0x3d0 [ 30.787495][ T835] ? write_profile+0xf0/0xf0 [ 30.787496][ T835] ? unwind_get_return_address+0x67/0xd0 [ 30.787498][ T835] genl_family_rcv_msg+0x3a4/0x640 [ 30.787500][ T835] ? genl_family_rcv_msg_dumpit+0x340/0x340 [ 30.787502][ T835] ? rcu_read_lock_any_held+0x3c/0x90 [ 30.787504][ T835] ? ovpn_nl_send_peer+0x1300/0x1300 [ovpn] [ 30.787506][ T835] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 30.787508][ T835] ? ovpn_nl_pre_doit+0x90/0x90 [ovpn] [ 30.787510][ T835] ? __lock_acquire+0x518/0xc20 [ 30.787513][ T835] genl_rcv_msg+0xbb/0x160 [ 30.787515][ T835] netlink_rcv_skb+0x14e/0x3a0 [ 30.787517][ T835] ? genl_family_rcv_msg+0x640/0x640 [ 30.787519][ T835] ? netlink_ack+0xcf0/0xcf0 [ 30.787522][ T835] ? netlink_deliver_tap+0xc5/0x330 [ 30.787523][ T835] ? netlink_deliver_tap+0x13c/0x330 [ 30.787525][ T835] genl_rcv+0x28/0x40 [ 30.787527][ T835] netlink_unicast+0x486/0x750 [ 30.787529][ T835] ? netlink_attachskb+0x810/0x810 [ 30.787531][ T835] ? __lock_acquire+0x518/0xc20 [ 30.787533][ T835] netlink_sendmsg+0x735/0xc60 [ 30.787535][ T835] ? netlink_unicast+0x750/0x750 [ 30.787538][ T835] ? __might_fault+0x97/0x140 [ 30.787541][ T835] ____sys_sendmsg+0x415/0x880 [ 30.787543][ T835] ? copy_msghdr_from_user+0x279/0x420 [ 30.787545][ T835] ? get_timestamp.constprop.0+0x390/0x390 [ 30.787546][ T835] ? move_addr_to_kernel+0x40/0x40 [ 30.787549][ T835] ___sys_sendmsg+0x14e/0x1d0 [ 30.787551][ T835] ? copy_msghdr_from_user+0x420/0x420 [ 30.787552][ T835] ? kfree+0x22/0x590 [ 30.787557][ T835] __sys_sendmsg+0x12c/0x1d0 [ 30.787559][ T835] ? __sys_sendmsg_sock+0x20/0x20 [ 30.787562][ T835] ? rcu_is_watching+0x16/0xd0 [ 30.787564][ T835] ? rcu_is_watching+0x16/0xd0 [ 30.787566][ T835] do_syscall_64+0xff/0x530 [ 30.787567][ T835] ? exc_page_fault+0xee/0x100 [ 30.787569][ T835] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 30.787570][ T835] RIP: 0033:0x7ff4c4ce454e [ 30.787573][ 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 [ 30.787575][ T835] RSP: 002b:00007fff97bfe8b0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 30.787577][ T835] RAX: ffffffffffffffda RBX: 000000000d916130 RCX: 00007ff4c4ce454e [ 30.787579][ T835] RDX: 0000000000000000 RSI: 00007fff97bfe950 RDI: 0000000000000005 [ 30.787580][ T835] RBP: 00007fff97bfe8c0 R08: 0000000000000000 R09: 0000000000000000 [ 30.787580][ T835] R10: 0000000000000000 R11: 0000000000000202 R12: 000000000d916200 [ 30.787581][ T835] R13: 00007fff97bfe950 R14: 000000000d917260 R15: 000000000040bda8 [ 30.787584][ T835] [ 30.787587][ T835] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 30.787589][ T835] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 835, name: ovpn-cli [ 30.787590][ T835] preempt_count: 202, expected: 0 [ 30.787591][ T835] RCU nest depth: 0, expected: 0 [ 30.787591][ T835] INFO: lockdep is turned off. [ 30.787592][ T835] irq event stamp: 45545 [ 30.787592][ T835] hardirqs last enabled at (45544): [] __down_trylock_console_sem+0x86/0xa0 [ 30.787595][ T835] hardirqs last disabled at (45545): [] console_emit_next_record+0x3d4/0x4c0 [ 30.787597][ T835] softirqs last enabled at (45512): [] __alloc_skb+0x4c2/0x5f0 [ 30.787599][ T835] softirqs last disabled at (45540): [] ovpn_peer_del+0xa0/0x590 [ovpn] [ 30.787602][ T835] Preemption disabled at: [ 30.787602][ T835] [<0000000000000000>] 0x0 [ 30.787604][ T835] CPU: 3 UID: 0 PID: 835 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 30.787606][ T835] Tainted: [W]=WARN [ 30.787606][ T835] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 30.787607][ T835] Call Trace: [ 30.787608][ T835] [ 30.787608][ T835] dump_stack_lvl+0x6f/0xa0 [ 30.787610][ T835] __might_resched.cold+0x1fe/0x2c1 [ 30.787613][ T835] ? check_irq_usage+0x403/0x570 [ 30.787614][ T835] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 30.787617][ T835] ? rcu_is_watching+0x16/0xd0 [ 30.787619][ T835] __kmalloc_noprof+0x443/0x760 [ 30.787621][ T835] ? __rwlock_init+0x150/0x150 [ 30.787622][ T835] ? alloc_buf.isra.0+0x4b/0x260 [ 30.787624][ T835] ? do_raw_spin_unlock+0x59/0x250 [ 30.787626][ T835] alloc_buf.isra.0+0x4b/0x260 [ 30.787628][ T835] put_chars+0x1e1/0x2f0 [ 30.787629][ T835] ? __send_to_port+0x420/0x420 [ 30.787631][ T835] ? check_prev_add+0xef/0xe90 [ 30.787633][ T835] ? validate_chain+0x6b8/0xc20 [ 30.787634][ T835] hvc_console_print+0x292/0x780 [ 30.787636][ T835] ? __lock_acquire+0x518/0xc20 [ 30.787638][ T835] ? hvc_write+0x3a0/0x3a0 [ 30.787640][ T835] ? rcu_is_watching+0x16/0xd0 [ 30.787642][ T835] ? lock_acquire+0x13c/0x160 [ 30.787644][ T835] console_emit_next_record+0x22f/0x4c0 [ 30.787646][ T835] ? devkmsg_read+0x4b0/0x4b0 [ 30.787647][ T835] ? console_flush_one_record+0x106/0x710 [ 30.787649][ T835] ? rcu_is_watching+0x16/0xd0 [ 30.787651][ T835] ? lock_acquire+0x13c/0x160 [ 30.787653][ T835] console_flush_one_record+0x46f/0x710 [ 30.787655][ T835] ? console_emit_next_record+0x4c0/0x4c0 [ 30.787657][ T835] ? __lock_acquire+0x518/0xc20 [ 30.787659][ T835] console_unlock+0xee/0x1f0 [ 30.787661][ T835] ? console_flush_one_record+0x710/0x710 [ 30.787663][ T835] ? rcu_is_watching+0x16/0xd0 [ 30.787664][ T835] ? lock_acquire+0x60/0x160 [ 30.787666][ T835] ? __down_trylock_console_sem+0x5e/0xa0 [ 30.787668][ T835] ? vprintk_emit+0x320/0x3e0 [ 30.787669][ T835] vprintk_emit+0x37c/0x3e0 [ 30.787672][ T835] ? wake_up_klogd_work_func+0x90/0x90 [ 30.787673][ T835] ? kernel_text_address+0x149/0x170 [ 30.787675][ T835] ? __kernel_text_address+0x12/0x30 [ 30.787676][ T835] ? write_profile+0xf0/0xf0 [ 30.787677][ T835] ? unwind_get_return_address+0x67/0xd0 [ 30.787679][ T835] _printk+0xc7/0x100 [ 30.787680][ T835] ? snapshot_read.cold+0x21/0x21 [ 30.787682][ T835] ? mark_usage+0x61/0x170 [ 30.787684][ T835] ? netdev_name+0x43/0x60 [ 30.787685][ T835] ? __netdev_printk+0x17f/0x1d0 [ 30.787686][ T835] netdev_info+0xe2/0x116 [ 30.787688][ T835] ? netdev_notice+0x120/0x120 [ 30.787689][ T835] ? find_held_lock+0x2b/0x80 [ 30.787690][ T835] ? mark_usage+0x61/0x170 [ 30.787692][ T835] ? __lock_acquire+0x518/0xc20 [ 30.787694][ T835] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 30.787697][ T835] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 30.787699][ T835] ? ovpn_peer_get_by_id+0x1fd/0x7a0 [ovpn] [ 30.787702][ T835] ovpn_peer_remove+0x394/0x640 [ovpn] [ 30.787704][ T835] ? do_raw_spin_lock+0x131/0x280 [ 30.787706][ T835] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 30.787709][ T835] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 30.787712][ T835] ? ovpn_peer_add+0x330/0x330 [ovpn] [ 30.787715][ T835] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 30.787717][ T835] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 30.787719][ T835] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 30.787721][ T835] ? ref_tracker_alloc+0x28d/0x430 [ 30.787724][ T835] ? ovpn_get_dev_from_attrs+0x170/0x660 [ovpn] [ 30.787727][ T835] ? ovpn_get_dev_from_attrs+0x17a/0x660 [ovpn] [ 30.787730][ T835] genl_family_rcv_msg_doit+0x206/0x300 [ 30.787732][ T835] ? genl_family_rcv_msg_attrs_parse.isra.0+0x330/0x330 [ 30.787734][ T835] ? __lock_release.isra.0+0x69/0x1a0 [ 30.787737][ T835] ? rcu_is_watching+0x16/0xd0 [ 30.787738][ T835] ? cap_capable+0x1d7/0x3d0 [ 30.787740][ T835] ? write_profile+0xf0/0xf0 [ 30.787741][ T835] ? unwind_get_return_address+0x67/0xd0 [ 30.787743][ T835] genl_family_rcv_msg+0x3a4/0x640 [ 30.787745][ T835] ? genl_family_rcv_msg_dumpit+0x340/0x340 [ 30.787747][ T835] ? rcu_read_lock_any_held+0x3c/0x90 [ 30.787748][ T835] ? ovpn_nl_send_peer+0x1300/0x1300 [ovpn] [ 30.787751][ T835] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 30.787753][ T835] ? ovpn_nl_pre_doit+0x90/0x90 [ovpn] [ 30.787755][ T835] ? __lock_acquire+0x518/0xc20 [ 30.787757][ T835] genl_rcv_msg+0xbb/0x160 [ 30.787760][ T835] netlink_rcv_skb+0x14e/0x3a0 [ 30.787761][ T835] ? genl_family_rcv_msg+0x640/0x640 [ 30.787763][ T835] ? netlink_ack+0xcf0/0xcf0 [ 30.787766][ T835] ? netlink_deliver_tap+0xc5/0x330 [ 30.787768][ T835] ? netlink_deliver_tap+0x13c/0x330 [ 30.787770][ T835] genl_rcv+0x28/0x40 [ 30.787772][ T835] netlink_unicast+0x486/0x750 [ 30.787774][ T835] ? netlink_attachskb+0x810/0x810 [ 30.787776][ T835] ? __lock_acquire+0x518/0xc20 [ 30.787778][ T835] netlink_sendmsg+0x735/0xc60 [ 30.787780][ T835] ? netlink_unicast+0x750/0x750 [ 30.787782][ T835] ? __might_fault+0x97/0x140 [ 30.787784][ T835] ____sys_sendmsg+0x415/0x880 [ 30.787786][ T835] ? copy_msghdr_from_user+0x279/0x420 [ 30.787787][ T835] ? get_timestamp.constprop.0+0x390/0x390 [ 30.787789][ T835] ? move_addr_to_kernel+0x40/0x40 [ 30.787792][ T835] ___sys_sendmsg+0x14e/0x1d0 [ 30.787794][ T835] ? copy_msghdr_from_user+0x420/0x420 [ 30.787795][ T835] ? kfree+0x22/0x590 [ 30.787800][ T835] __sys_sendmsg+0x12c/0x1d0 [ 30.787802][ T835] ? __sys_sendmsg_sock+0x20/0x20 [ 30.787804][ T835] ? rcu_is_watching+0x16/0xd0 [ 30.787806][ T835] ? rcu_is_watching+0x16/0xd0 [ 30.787808][ T835] do_syscall_64+0xff/0x530 [ 30.787810][ T835] ? exc_page_fault+0xee/0x100 [ 30.787811][ T835] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 30.787812][ T835] RIP: 0033:0x7ff4c4ce454e [ 30.787814][ 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 [ 30.787815][ T835] RSP: 002b:00007fff97bfe8b0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 30.787816][ T835] RAX: ffffffffffffffda RBX: 000000000d916130 RCX: 00007ff4c4ce454e [ 30.787817][ T835] RDX: 0000000000000000 RSI: 00007fff97bfe950 RDI: 0000000000000005 [ 30.787817][ T835] RBP: 00007fff97bfe8c0 R08: 0000000000000000 R09: 0000000000000000 [ 30.787818][ T835] R10: 0000000000000000 R11: 0000000000000202 R12: 000000000d916200 [ 30.787819][ T835] R13: 00007fff97bfe950 R14: 000000000d917260 R15: 000000000040bda8 [ 30.787821][ T835] [ 30.889375][ T835] ovpn-cli (835) used greatest stack depth: 23432 bytes left [ 30.941084][ T839] tun1: deleting peer with id 1, reason 1 [ 33.588195][ T887] tun0: deleting peer with id 2, reason 1 [ 33.588212][ T887] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 33.588215][ T887] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 887, name: ovpn-cli [ 33.588217][ T887] preempt_count: 202, expected: 0 [ 33.588218][ T887] RCU nest depth: 0, expected: 0 [ 33.588218][ T887] INFO: lockdep is turned off. [ 33.588219][ T887] irq event stamp: 0 [ 33.588220][ T887] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 33.588224][ T887] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 33.588231][ T887] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 33.588232][ T887] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 33.588234][ T887] Preemption disabled at: [ 33.588235][ T887] [<0000000000000000>] 0x0 [ 33.588240][ T887] CPU: 2 UID: 0 PID: 887 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 33.588243][ T887] Tainted: [W]=WARN [ 33.588244][ T887] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 33.588245][ T887] Call Trace: [ 33.588247][ T887] [ 33.588248][ T887] dump_stack_lvl+0x6f/0xa0 [ 33.588253][ T887] __might_resched.cold+0x1fe/0x2c1 [ 33.588257][ T887] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 33.588261][ T887] ? rcu_is_watching+0x16/0xd0 [ 33.588265][ T887] __kmalloc_noprof+0x443/0x760 [ 33.588268][ T887] ? __rwlock_init+0x150/0x150 [ 33.588271][ T887] ? alloc_buf.isra.0+0x4b/0x260 [ 33.588275][ T887] ? do_raw_spin_unlock+0x59/0x250 [ 33.588277][ T887] alloc_buf.isra.0+0x4b/0x260 [ 33.588279][ T887] put_chars+0x1e1/0x2f0 [ 33.588281][ T887] ? __send_to_port+0x420/0x420 [ 33.588282][ T887] ? printk_get_next_message+0x240/0x650 [ 33.588286][ T887] hvc_console_print+0x292/0x780 [ 33.588290][ T887] ? hvc_write+0x3a0/0x3a0 [ 33.588291][ T887] ? __rwlock_init+0x150/0x150 [ 33.588293][ T887] ? rcu_is_watching+0x16/0xd0 [ 33.588295][ T887] ? lock_acquire+0x13c/0x160 [ 33.588297][ T887] console_emit_next_record+0x22f/0x4c0 [ 33.588299][ T887] ? devkmsg_read+0x4b0/0x4b0 [ 33.588301][ T887] ? rcu_is_watching+0x16/0xd0 [ 33.588303][ T887] ? rcu_is_watching+0x16/0xd0 [ 33.588304][ T887] ? rcu_is_watching+0x16/0xd0 [ 33.588306][ T887] ? lock_acquire+0x13c/0x160 [ 33.588308][ T887] ? console_flush_one_record+0x111/0x710 [ 33.588309][ T887] console_flush_one_record+0x46f/0x710 [ 33.588312][ T887] ? console_emit_next_record+0x4c0/0x4c0 [ 33.588314][ T887] console_unlock+0xee/0x1f0 [ 33.588316][ T887] ? lock_acquire+0x13c/0x160 [ 33.588318][ T887] ? console_flush_one_record+0x710/0x710 [ 33.588325][ T887] ? rcu_is_watching+0x16/0xd0 [ 33.588326][ T887] ? lock_release+0x184/0x1f0 [ 33.588328][ T887] ? lock_acquire+0x60/0x160 [ 33.588331][ T887] ? __rcu_read_lock+0x30/0x70 [ 33.588333][ T887] ? __down_trylock_console_sem+0x5e/0xa0 [ 33.588335][ T887] ? vprintk_emit+0x320/0x3e0 [ 33.588337][ T887] vprintk_emit+0x37c/0x3e0 [ 33.588339][ T887] ? wake_up_klogd_work_func+0x90/0x90 [ 33.588341][ T887] ? kernel_text_address+0x149/0x170 [ 33.588343][ T887] ? __kernel_text_address+0x12/0x30 [ 33.588344][ T887] ? write_profile+0xf0/0xf0 [ 33.588346][ T887] ? unwind_get_return_address+0x67/0xd0 [ 33.588349][ T887] _printk+0xc7/0x100 [ 33.588352][ T887] ? snapshot_read.cold+0x21/0x21 [ 33.588355][ T887] ? netdev_name+0x43/0x60 [ 33.588357][ T887] ? __netdev_printk+0x17f/0x1d0 [ 33.588359][ T887] netdev_info+0xe2/0x116 [ 33.588361][ T887] ? netdev_notice+0x120/0x120 [ 33.588362][ T887] ? ovpn_nl_pre_doit+0x44/0x90 [ovpn] [ 33.588368][ T887] ? __module_address+0x36/0x330 [ 33.588371][ T887] ? lock_acquire+0x13c/0x160 [ 33.588372][ T887] ? rcu_is_watching+0x16/0xd0 [ 33.588374][ T887] ? lock_release+0x184/0x1f0 [ 33.588376][ T887] ? ovpn_peer_get_by_id+0x38a/0x7a0 [ovpn] [ 33.588379][ T887] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 33.588384][ T887] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 33.588386][ T887] ? lock_acquire+0x13c/0x160 [ 33.588388][ T887] ? rcu_is_watching+0x16/0xd0 [ 33.588390][ T887] ? lock_release+0x184/0x1f0 [ 33.588392][ T887] ovpn_peer_remove+0x394/0x640 [ovpn] [ 33.588395][ T887] ? do_raw_spin_lock+0x131/0x280 [ 33.588396][ T887] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 33.588400][ T887] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 33.588403][ T887] ? ovpn_peer_add+0x330/0x330 [ovpn] [ 33.588406][ T887] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 33.588408][ T887] ? trace_hardirqs_on+0x36/0x40 [ 33.588411][ T887] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 33.588413][ T887] ? ref_tracker_alloc+0x28d/0x430 [ 33.588418][ T887] ? lock_release+0x184/0x1f0 [ 33.588420][ T887] ? ovpn_get_dev_from_attrs+0x17a/0x660 [ovpn] [ 33.588423][ T887] genl_family_rcv_msg_doit+0x206/0x300 [ 33.588427][ T887] ? genl_family_rcv_msg_attrs_parse.isra.0+0x330/0x330 [ 33.588429][ T887] ? rcu_is_watching+0x16/0xd0 [ 33.588432][ T887] ? rcu_is_watching+0x16/0xd0 [ 33.588434][ T887] ? cap_capable+0x1d7/0x3d0 [ 33.588437][ T887] ? write_profile+0xf0/0xf0 [ 33.588438][ T887] ? unwind_get_return_address+0x67/0xd0 [ 33.588440][ T887] genl_family_rcv_msg+0x3a4/0x640 [ 33.588442][ T887] ? genl_family_rcv_msg_dumpit+0x340/0x340 [ 33.588444][ T887] ? ovpn_nl_send_peer+0x1300/0x1300 [ovpn] [ 33.588446][ T887] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 33.588448][ T887] ? ovpn_nl_pre_doit+0x90/0x90 [ovpn] [ 33.588451][ T887] ? filter_irq_stacks+0xd0/0xd0 [ 33.588452][ T887] ? stack_depot_save_flags+0x1bc/0x790 [ 33.588454][ T887] genl_rcv_msg+0xbb/0x160 [ 33.588457][ T887] netlink_rcv_skb+0x14e/0x3a0 [ 33.588459][ T887] ? genl_family_rcv_msg+0x640/0x640 [ 33.588461][ T887] ? netlink_ack+0xcf0/0xcf0 [ 33.588463][ T887] ? lock_acquire+0x13c/0x160 [ 33.588465][ T887] ? rcu_is_watching+0x16/0xd0 [ 33.588467][ T887] ? lock_release+0x184/0x1f0 [ 33.588468][ T887] genl_rcv+0x28/0x40 [ 33.588470][ T887] netlink_unicast+0x486/0x750 [ 33.588473][ T887] ? netlink_attachskb+0x810/0x810 [ 33.588474][ T887] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 33.588476][ T887] ? trace_hardirqs_on+0x36/0x40 [ 33.588477][ T887] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 33.588480][ T887] netlink_sendmsg+0x735/0xc60 [ 33.588482][ T887] ? netlink_unicast+0x750/0x750 [ 33.588484][ T887] ? rcu_is_watching+0x16/0xd0 [ 33.588486][ T887] ? lock_release+0x184/0x1f0 [ 33.588488][ T887] ____sys_sendmsg+0x415/0x880 [ 33.588492][ T887] ? copy_msghdr_from_user+0x279/0x420 [ 33.588493][ T887] ? get_timestamp.constprop.0+0x390/0x390 [ 33.588495][ T887] ? move_addr_to_kernel+0x40/0x40 [ 33.588498][ T887] ___sys_sendmsg+0x14e/0x1d0 [ 33.588499][ T887] ? copy_msghdr_from_user+0x420/0x420 [ 33.588501][ T887] ? kfree+0x22/0x590 [ 33.588506][ T887] __sys_sendmsg+0x12c/0x1d0 [ 33.588508][ T887] ? __sys_sendmsg_sock+0x20/0x20 [ 33.588510][ T887] ? rcu_is_watching+0x16/0xd0 [ 33.588512][ T887] ? rcu_is_watching+0x16/0xd0 [ 33.588514][ T887] do_syscall_64+0xff/0x530 [ 33.588517][ T887] ? exc_page_fault+0xee/0x100 [ 33.588519][ T887] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 33.588521][ T887] RIP: 0033:0x7fb9947cf54e [ 33.588523][ 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 [ 33.588524][ T887] RSP: 002b:00007ffe222cbc00 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 33.588528][ T887] RAX: ffffffffffffffda RBX: 000000001eba9130 RCX: 00007fb9947cf54e [ 33.588529][ T887] RDX: 0000000000000000 RSI: 00007ffe222cbca0 RDI: 0000000000000005 [ 33.588530][ T887] RBP: 00007ffe222cbc10 R08: 0000000000000000 R09: 0000000000000000 [ 33.588531][ T887] R10: 0000000000000000 R11: 0000000000000202 R12: 000000001eba9200 [ 33.588532][ T887] R13: 00007ffe222cbca0 R14: 000000001ebaa260 R15: 000000000040bda8 [ 33.588534][ T887] [ 33.669389][ T891] tun2: deleting peer with id 2, reason 1 [ 38.298357][ T66] tun0: deleting peer with id 3, reason 2 [ 38.298377][ T66] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 38.298379][ T66] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 66, name: kworker/2:2 [ 38.298381][ T66] preempt_count: 202, expected: 0 [ 38.298382][ T66] RCU nest depth: 0, expected: 0 [ 38.298382][ T66] INFO: lockdep is turned off. [ 38.298384][ T66] irq event stamp: 28218 [ 38.298384][ T66] hardirqs last enabled at (28217): [] _raw_spin_unlock_irq+0x28/0x50 [ 38.298392][ T66] hardirqs last disabled at (28218): [] __schedule+0x1246/0x20e0 [ 38.298396][ T66] softirqs last enabled at (28038): [] handle_softirqs+0x67c/0x900 [ 38.298399][ T66] softirqs last disabled at (28031): [] __irq_exit_rcu+0x145/0x1c0 [ 38.298401][ T66] Preemption disabled at: [ 38.298402][ T66] [<0000000000000000>] 0x0 [ 38.298410][ T66] CPU: 2 UID: 0 PID: 66 Comm: kworker/2:2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 38.298413][ T66] Tainted: [W]=WARN [ 38.298414][ T66] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 38.298416][ T66] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 38.298426][ T66] Call Trace: [ 38.298428][ T66] [ 38.298430][ T66] dump_stack_lvl+0x6f/0xa0 [ 38.298436][ T66] __might_resched.cold+0x1fe/0x2c1 [ 38.298439][ T66] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 38.298443][ T66] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 38.298445][ T66] ? rcu_is_watching+0x16/0xd0 [ 38.298449][ T66] __kmalloc_noprof+0x443/0x760 [ 38.298452][ T66] ? __rwlock_init+0x150/0x150 [ 38.298455][ T66] ? alloc_buf.isra.0+0x4b/0x260 [ 38.298458][ T66] ? do_raw_spin_unlock+0x59/0x250 [ 38.298460][ T66] alloc_buf.isra.0+0x4b/0x260 [ 38.298462][ T66] put_chars+0x1e1/0x2f0 [ 38.298464][ T66] ? prb_final_commit+0x50/0x50 [ 38.298465][ T66] ? __send_to_port+0x420/0x420 [ 38.298467][ T66] ? printk_get_next_message+0x240/0x650 [ 38.298470][ T66] hvc_console_print+0x292/0x780 [ 38.298474][ T66] ? hvc_write+0x3a0/0x3a0 [ 38.298475][ T66] ? do_raw_spin_lock+0x131/0x280 [ 38.298476][ T66] ? vsnprintf+0x527/0x1700 [ 38.298478][ T66] ? __rwlock_init+0x150/0x150 [ 38.298480][ T66] ? rcu_is_watching+0x16/0xd0 [ 38.298482][ T66] ? lock_acquire+0x13c/0x160 [ 38.298484][ T66] console_emit_next_record+0x22f/0x4c0 [ 38.298487][ T66] ? devkmsg_read+0x4b0/0x4b0 [ 38.298489][ T66] ? rcu_is_watching+0x16/0xd0 [ 38.298490][ T66] ? rcu_is_watching+0x16/0xd0 [ 38.298492][ T66] ? rcu_is_watching+0x16/0xd0 [ 38.298493][ T66] ? lock_acquire+0x13c/0x160 [ 38.298495][ T66] ? console_flush_one_record+0x111/0x710 [ 38.298497][ T66] console_flush_one_record+0x46f/0x710 [ 38.298499][ T66] ? console_emit_next_record+0x4c0/0x4c0 [ 38.298502][ T66] console_unlock+0xee/0x1f0 [ 38.298503][ T66] ? lock_acquire+0x13c/0x160 [ 38.298505][ T66] ? console_flush_one_record+0x710/0x710 [ 38.298506][ T66] ? rcu_is_watching+0x16/0xd0 [ 38.298508][ T66] ? lock_release+0x184/0x1f0 [ 38.298509][ T66] ? lock_acquire+0x60/0x160 [ 38.298511][ T66] ? __rcu_read_lock+0x30/0x70 [ 38.298513][ T66] ? __down_trylock_console_sem+0x5e/0xa0 [ 38.298514][ T66] ? vprintk_emit+0x320/0x3e0 [ 38.298516][ T66] vprintk_emit+0x37c/0x3e0 [ 38.298519][ T66] ? wake_up_klogd_work_func+0x90/0x90 [ 38.298520][ T66] ? ret_from_fork_asm+0x11/0x20 [ 38.298523][ T66] ? stack_access_ok+0x1e0/0x1e0 [ 38.298526][ T66] _printk+0xc7/0x100 [ 38.298528][ T66] ? snapshot_read.cold+0x21/0x21 [ 38.298530][ T66] ? write_profile+0xf0/0xf0 [ 38.298532][ T66] ? do_raw_spin_lock+0x131/0x280 [ 38.298534][ T66] ? netdev_name+0x43/0x60 [ 38.298537][ T66] ? __netdev_printk+0x17f/0x1d0 [ 38.298539][ T66] netdev_info+0xe2/0x116 [ 38.298540][ T66] ? netdev_notice+0x120/0x120 [ 38.298542][ T66] ? debug_object_free+0x530/0x530 [ 38.298546][ T66] ? __rwlock_init+0x150/0x150 [ 38.298548][ T66] ? trace_irq_enable.constprop.0+0x30/0x160 [ 38.298551][ T66] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 38.298556][ T66] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 38.298558][ T66] ? remove_and_enqueue_same_base+0x200/0x730 [ 38.298561][ T66] ? do_raw_spin_lock+0x131/0x280 [ 38.298563][ T66] ovpn_peer_remove+0x394/0x640 [ovpn] [ 38.298567][ T66] ? do_raw_spin_lock+0x131/0x280 [ 38.298568][ T66] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 38.298571][ T66] ? __rwlock_init+0x150/0x150 [ 38.298572][ T66] ? rcu_is_watching+0x16/0xd0 [ 38.298574][ T66] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 38.298575][ T66] ? trace_irq_disable.constprop.0+0x9b/0x160 [ 38.298577][ T66] ovpn_peer_keepalive_work_single+0x416/0x600 [ovpn] [ 38.298580][ T66] ? ovpn_peers_release_mp+0x490/0x490 [ovpn] [ 38.298582][ T66] ? __rwlock_init+0x150/0x150 [ 38.298584][ T66] ovpn_peer_keepalive_work+0x253/0x580 [ovpn] [ 38.298588][ T66] ? ovpn_peers_free+0xb0/0xb0 [ovpn] [ 38.298590][ T66] ? rcu_is_watching+0x16/0xd0 [ 38.298592][ T66] ? lock_acquire+0x13c/0x160 [ 38.298593][ T66] ? rcu_is_watching+0x16/0xd0 [ 38.298595][ T66] process_one_work+0xe3e/0x1560 [ 38.298599][ T66] ? __queue_delayed_work+0x470/0x470 [ 38.298601][ T66] ? find_held_lock+0x2b/0x80 [ 38.298603][ T66] ? __rwlock_init+0x150/0x150 [ 38.298605][ T66] worker_thread+0x4f1/0xd60 [ 38.298608][ T66] ? rescuer_thread+0x1340/0x1340 [ 38.298610][ T66] ? __kthread_parkme+0xbd/0x210 [ 38.298612][ T66] ? rescuer_thread+0x1340/0x1340 [ 38.298614][ T66] ? rescuer_thread+0x1340/0x1340 [ 38.298615][ T66] kthread+0x367/0x460 [ 38.298617][ T66] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 38.298618][ T66] ? kthread_affine_preferred+0x4c0/0x4c0 [ 38.298620][ T66] ret_from_fork+0x474/0x6b0 [ 38.298623][ T66] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 38.298625][ T66] ? __switch_to+0x5a3/0xe00 [ 38.298627][ T66] ? kthread_affine_preferred+0x4c0/0x4c0 [ 38.298629][ T66] ret_from_fork_asm+0x11/0x20 [ 38.298632][ T66] [ 39.323358][ T66] tun0: deleting peer with id 4, reason 2 [ 39.323376][ T66] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 39.323379][ T66] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 66, name: kworker/2:2 [ 39.323380][ T66] preempt_count: 202, expected: 0 [ 39.323381][ T66] RCU nest depth: 0, expected: 0 [ 39.323382][ T66] INFO: lockdep is turned off. [ 39.323383][ T66] irq event stamp: 28218 [ 39.323384][ T66] hardirqs last enabled at (28217): [] _raw_spin_unlock_irq+0x28/0x50 [ 39.323392][ T66] hardirqs last disabled at (28218): [] __schedule+0x1246/0x20e0 [ 39.323395][ T66] softirqs last enabled at (28038): [] handle_softirqs+0x67c/0x900 [ 39.323398][ T66] softirqs last disabled at (28031): [] __irq_exit_rcu+0x145/0x1c0 [ 39.323401][ T66] Preemption disabled at: [ 39.323402][ T66] [<0000000000000000>] 0x0 [ 39.323408][ T66] CPU: 2 UID: 0 PID: 66 Comm: kworker/2:2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 39.323412][ T66] Tainted: [W]=WARN [ 39.323413][ T66] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 39.323415][ T66] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 39.323424][ T66] Call Trace: [ 39.323426][ T66] [ 39.323428][ T66] dump_stack_lvl+0x6f/0xa0 [ 39.323434][ T66] __might_resched.cold+0x1fe/0x2c1 [ 39.323437][ T66] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 39.323441][ T66] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 39.323443][ T66] ? rcu_is_watching+0x16/0xd0 [ 39.323447][ T66] __kmalloc_noprof+0x443/0x760 [ 39.323451][ T66] ? __rwlock_init+0x150/0x150 [ 39.323454][ T66] ? alloc_buf.isra.0+0x4b/0x260 [ 39.323458][ T66] ? do_raw_spin_unlock+0x59/0x250 [ 39.323459][ T66] alloc_buf.isra.0+0x4b/0x260 [ 39.323461][ T66] put_chars+0x1e1/0x2f0 [ 39.323463][ T66] ? prb_final_commit+0x50/0x50 [ 39.323465][ T66] ? __send_to_port+0x420/0x420 [ 39.323466][ T66] ? printk_get_next_message+0x240/0x650 [ 39.323469][ T66] hvc_console_print+0x292/0x780 [ 39.323473][ T66] ? hvc_write+0x3a0/0x3a0 [ 39.323475][ T66] ? do_raw_spin_lock+0x131/0x280 [ 39.323476][ T66] ? vsnprintf+0x527/0x1700 [ 39.323478][ T66] ? __rwlock_init+0x150/0x150 [ 39.323480][ T66] ? rcu_is_watching+0x16/0xd0 [ 39.323481][ T66] ? lock_acquire+0x13c/0x160 [ 39.323484][ T66] console_emit_next_record+0x22f/0x4c0 [ 39.323486][ T66] ? devkmsg_read+0x4b0/0x4b0 [ 39.323488][ T66] ? rcu_is_watching+0x16/0xd0 [ 39.323490][ T66] ? rcu_is_watching+0x16/0xd0 [ 39.323491][ T66] ? rcu_is_watching+0x16/0xd0 [ 39.323493][ T66] ? lock_acquire+0x13c/0x160 [ 39.323495][ T66] ? console_flush_one_record+0x111/0x710 [ 39.323496][ T66] console_flush_one_record+0x46f/0x710 [ 39.323499][ T66] ? console_emit_next_record+0x4c0/0x4c0 [ 39.323501][ T66] console_unlock+0xee/0x1f0 [ 39.323503][ T66] ? lock_acquire+0x13c/0x160 [ 39.323504][ T66] ? console_flush_one_record+0x710/0x710 [ 39.323506][ T66] ? rcu_is_watching+0x16/0xd0 [ 39.323507][ T66] ? lock_release+0x184/0x1f0 [ 39.323509][ T66] ? lock_acquire+0x60/0x160 [ 39.323510][ T66] ? __rcu_read_lock+0x30/0x70 [ 39.323512][ T66] ? __down_trylock_console_sem+0x5e/0xa0 [ 39.323514][ T66] ? vprintk_emit+0x320/0x3e0 [ 39.323516][ T66] vprintk_emit+0x37c/0x3e0 [ 39.323518][ T66] ? wake_up_klogd_work_func+0x90/0x90 [ 39.323520][ T66] ? unwind_next_frame+0x69b/0x1ea0 [ 39.323522][ T66] ? ret_from_fork_asm+0x11/0x20 [ 39.323525][ T66] _printk+0xc7/0x100 [ 39.323528][ T66] ? snapshot_read.cold+0x21/0x21 [ 39.323529][ T66] ? __unwind_start+0x42e/0x900 [ 39.323531][ T66] ? write_profile+0xf0/0xf0 [ 39.323533][ T66] ? netdev_name+0x43/0x60 [ 39.323535][ T66] ? __netdev_printk+0x17f/0x1d0 [ 39.323537][ T66] netdev_info+0xe2/0x116 [ 39.323539][ T66] ? netdev_notice+0x120/0x120 [ 39.323541][ T66] ? stack_trace_save+0x93/0xc0 [ 39.323542][ T66] ? filter_irq_stacks+0xd0/0xd0 [ 39.323544][ T66] ? trace_irq_enable.constprop.0+0x30/0x160 [ 39.323547][ T66] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 39.323551][ T66] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 39.323553][ T66] ? __rwlock_init+0x150/0x150 [ 39.323555][ T66] ? lock_acquire+0x13c/0x160 [ 39.323556][ T66] ? rcu_is_watching+0x16/0xd0 [ 39.323558][ T66] ovpn_peer_remove+0x394/0x640 [ovpn] [ 39.323562][ T66] ? do_raw_spin_lock+0x131/0x280 [ 39.323563][ T66] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 39.323566][ T66] ? __rwlock_init+0x150/0x150 [ 39.323567][ T66] ? rcu_is_watching+0x16/0xd0 [ 39.323569][ T66] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 39.323570][ T66] ? trace_irq_disable.constprop.0+0x9b/0x160 [ 39.323571][ T66] ovpn_peer_keepalive_work_single+0x416/0x600 [ovpn] [ 39.323574][ T66] ? ovpn_peers_release_mp+0x490/0x490 [ovpn] [ 39.323577][ T66] ? __rwlock_init+0x150/0x150 [ 39.323579][ T66] ovpn_peer_keepalive_work+0x253/0x580 [ovpn] [ 39.323582][ T66] ? ovpn_peers_free+0xb0/0xb0 [ovpn] [ 39.323585][ T66] ? rcu_is_watching+0x16/0xd0 [ 39.323586][ T66] ? lock_acquire+0x13c/0x160 [ 39.323588][ T66] ? rcu_is_watching+0x16/0xd0 [ 39.323590][ T66] process_one_work+0xe3e/0x1560 [ 39.323593][ T66] ? __queue_delayed_work+0x470/0x470 [ 39.323595][ T66] ? find_held_lock+0x2b/0x80 [ 39.323597][ T66] ? __rwlock_init+0x150/0x150 [ 39.323599][ T66] worker_thread+0x4f1/0xd60 [ 39.323602][ T66] ? rescuer_thread+0x1340/0x1340 [ 39.323603][ T66] ? __kthread_parkme+0xbd/0x210 [ 39.323606][ T66] ? rescuer_thread+0x1340/0x1340 [ 39.323607][ T66] ? rescuer_thread+0x1340/0x1340 [ 39.323609][ T66] kthread+0x367/0x460 [ 39.323611][ T66] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 39.323612][ T66] ? kthread_affine_preferred+0x4c0/0x4c0 [ 39.323613][ T66] ret_from_fork+0x474/0x6b0 [ 39.323616][ T66] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 39.323618][ T66] ? __switch_to+0x5a3/0xe00 [ 39.323620][ T66] ? kthread_affine_preferred+0x4c0/0x4c0 [ 39.323622][ T66] ret_from_fork_asm+0x11/0x20 [ 39.323625][ T66] [ 39.342156][ T66] tun0: deleting peer with id 5, reason 2 [ 39.342388][ T66] tun0: deleting peer with id 6, reason 2 [ 44.378388][ T10] tun3: deleting peer with id 3, reason 2 [ 44.378407][ T10] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 44.378410][ T10] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 10, name: kworker/0:1 [ 44.378411][ T10] preempt_count: 202, expected: 0 [ 44.378412][ T10] RCU nest depth: 0, expected: 0 [ 44.378413][ T10] INFO: lockdep is turned off. [ 44.378414][ T10] irq event stamp: 50158 [ 44.378415][ T10] hardirqs last enabled at (50157): [] _raw_spin_unlock_irq+0x28/0x50 [ 44.378423][ T10] hardirqs last disabled at (50158): [] __schedule+0x1246/0x20e0 [ 44.378426][ T10] softirqs last enabled at (47314): [] handle_softirqs+0x67c/0x900 [ 44.378429][ T10] softirqs last disabled at (45553): [] do_softirq+0xac/0xe0 [ 44.378432][ T10] Preemption disabled at: [ 44.378432][ T10] [<0000000000000000>] 0x0 [ 44.378439][ T10] CPU: 0 UID: 0 PID: 10 Comm: kworker/0:1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 44.378443][ T10] Tainted: [W]=WARN [ 44.378443][ T10] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 44.378445][ T10] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 44.378453][ T10] Call Trace: [ 44.378455][ T10] [ 44.378456][ T10] dump_stack_lvl+0x6f/0xa0 [ 44.378462][ T10] __might_resched.cold+0x1fe/0x2c1 [ 44.378465][ T10] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 44.378469][ T10] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 44.378471][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.378475][ T10] __kmalloc_noprof+0x443/0x760 [ 44.378478][ T10] ? __rwlock_init+0x150/0x150 [ 44.378480][ T10] ? alloc_buf.isra.0+0x4b/0x260 [ 44.378484][ T10] ? do_raw_spin_unlock+0x59/0x250 [ 44.378486][ T10] alloc_buf.isra.0+0x4b/0x260 [ 44.378488][ T10] put_chars+0x1e1/0x2f0 [ 44.378490][ T10] ? prb_final_commit+0x50/0x50 [ 44.378491][ T10] ? __send_to_port+0x420/0x420 [ 44.378493][ T10] ? printk_get_next_message+0x240/0x650 [ 44.378496][ T10] hvc_console_print+0x292/0x780 [ 44.378499][ T10] ? hvc_write+0x3a0/0x3a0 [ 44.378501][ T10] ? do_raw_spin_lock+0x131/0x280 [ 44.378502][ T10] ? vsnprintf+0x527/0x1700 [ 44.378504][ T10] ? __rwlock_init+0x150/0x150 [ 44.378506][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.378508][ T10] ? lock_acquire+0x13c/0x160 [ 44.378510][ T10] console_emit_next_record+0x22f/0x4c0 [ 44.378512][ T10] ? devkmsg_read+0x4b0/0x4b0 [ 44.378514][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.378516][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.378517][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.378519][ T10] ? lock_acquire+0x13c/0x160 [ 44.378521][ T10] ? console_flush_one_record+0x111/0x710 [ 44.378522][ T10] console_flush_one_record+0x46f/0x710 [ 44.378525][ T10] ? console_emit_next_record+0x4c0/0x4c0 [ 44.378527][ T10] console_unlock+0xee/0x1f0 [ 44.378529][ T10] ? lock_acquire+0x13c/0x160 [ 44.378531][ T10] ? console_flush_one_record+0x710/0x710 [ 44.378532][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.378534][ T10] ? lock_release+0x184/0x1f0 [ 44.378535][ T10] ? lock_acquire+0x60/0x160 [ 44.378536][ T10] ? __rcu_read_lock+0x30/0x70 [ 44.378538][ T10] ? __down_trylock_console_sem+0x5e/0xa0 [ 44.378540][ T10] ? vprintk_emit+0x320/0x3e0 [ 44.378542][ T10] vprintk_emit+0x37c/0x3e0 [ 44.378544][ T10] ? wake_up_klogd_work_func+0x90/0x90 [ 44.378546][ T10] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 44.378548][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.378549][ T10] ? trace_sched_wakeup+0x9b/0x160 [ 44.378552][ T10] _printk+0xc7/0x100 [ 44.378555][ T10] ? snapshot_read.cold+0x21/0x21 [ 44.378556][ T10] ? try_to_wake_up+0x153/0x1130 [ 44.378558][ T10] ? select_fallback_rq+0x510/0x510 [ 44.378560][ T10] ? netdev_name+0x43/0x60 [ 44.378562][ T10] ? __netdev_printk+0x17f/0x1d0 [ 44.378564][ T10] netdev_info+0xe2/0x116 [ 44.378566][ T10] ? netdev_notice+0x120/0x120 [ 44.378568][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.378570][ T10] ? __queue_work+0x3ab/0xd30 [ 44.378573][ T10] ? trace_irq_enable.constprop.0+0x30/0x160 [ 44.378575][ T10] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 44.378579][ T10] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 44.378582][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.378584][ T10] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 44.378585][ T10] ovpn_peer_remove+0x394/0x640 [ovpn] [ 44.378589][ T10] ? do_raw_spin_lock+0x131/0x280 [ 44.378591][ T10] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 44.378593][ T10] ? __rwlock_init+0x150/0x150 [ 44.378594][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.378596][ T10] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 44.378597][ T10] ? trace_irq_disable.constprop.0+0x9b/0x160 [ 44.378599][ T10] ovpn_peer_keepalive_work_single+0x416/0x600 [ovpn] [ 44.378601][ T10] ? ovpn_peers_release_mp+0x490/0x490 [ovpn] [ 44.378604][ T10] ? __rwlock_init+0x150/0x150 [ 44.378606][ T10] ovpn_peer_keepalive_work+0x389/0x580 [ovpn] [ 44.378609][ T10] ? ovpn_peers_free+0xb0/0xb0 [ovpn] [ 44.378611][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.378613][ T10] ? lock_acquire+0x13c/0x160 [ 44.378614][ T10] ? rcu_is_watching+0x16/0xd0 [ 44.378616][ T10] ? process_one_work+0xdfc/0x1560 [ 44.378618][ T10] process_one_work+0xe3e/0x1560 [ 44.378621][ T10] ? __queue_delayed_work+0x470/0x470 [ 44.378623][ T10] ? find_held_lock+0x2b/0x80 [ 44.378625][ T10] ? __rwlock_init+0x150/0x150 [ 44.378627][ T10] worker_thread+0x4f1/0xd60 [ 44.378629][ T10] ? rescuer_thread+0x1340/0x1340 [ 44.378631][ T10] ? __kthread_parkme+0xbd/0x210 [ 44.378633][ T10] ? rescuer_thread+0x1340/0x1340 [ 44.378634][ T10] ? rescuer_thread+0x1340/0x1340 [ 44.378636][ T10] kthread+0x367/0x460 [ 44.378637][ T10] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 44.378639][ T10] ? kthread_affine_preferred+0x4c0/0x4c0 [ 44.378640][ T10] ret_from_fork+0x474/0x6b0 [ 44.378643][ T10] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 44.378645][ T10] ? __switch_to+0x5a3/0xe00 [ 44.378647][ T10] ? kthread_affine_preferred+0x4c0/0x4c0 [ 44.378649][ T10] ret_from_fork_asm+0x11/0x20 [ 44.378652][ T10] [ 44.443366][ T66] tun4: deleting peer with id 4, reason 2 [ 44.507355][ T66] tun5: deleting peer with id 5, reason 2 [ 44.570355][ T10] tun6: deleting peer with id 6, reason 2