[ 15.445421][ T301] ip (301) used greatest stack depth: 24688 bytes left [ 15.445435][ T301] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 15.445437][ T301] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 301, name: ip [ 15.445439][ T301] preempt_count: 2, expected: 0 [ 15.445440][ T301] RCU nest depth: 0, expected: 0 [ 15.445441][ T301] locks held by ip/301: 5, last CPU#0: [ 15.445443][ T301] #0: ffffffff972127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 15.445454][ T301] #1: ffffffff97379cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 15.445460][ T301] #2: ffffffff97379d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 15.445464][ T301] #3: ffffffff97299660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 15.445467][ T301] #4: ffffffff97299560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 15.445471][ T301] irq event stamp: 44158 [ 15.445472][ T301] hardirqs last enabled at (44157): [] __down_trylock_console_sem+0x86/0xa0 [ 15.445475][ T301] hardirqs last disabled at (44158): [] console_emit_next_record+0x3d4/0x4c0 [ 15.445477][ T301] softirqs last enabled at (42876): [] netlink_release+0x17b/0xcf0 [ 15.445481][ T301] softirqs last disabled at (42874): [] netlink_release+0xd2/0xcf0 [ 15.445483][ T301] Preemption disabled at: [ 15.445484][ T301] [<0000000000000000>] 0x0 [ 15.445491][ T301] CPU: 0 UID: 0 PID: 301 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 15.445494][ T301] Tainted: [W]=WARN [ 15.445495][ T301] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.445496][ T301] Call Trace: [ 15.445498][ T301] [ 15.445499][ T301] dump_stack_lvl+0x6f/0xa0 [ 15.445506][ T301] __might_resched.cold+0x1fe/0x2c1 [ 15.445510][ T301] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 15.445514][ T301] ? __kmalloc_noprof+0xdb/0x760 [ 15.445519][ T301] __kmalloc_noprof+0x443/0x760 [ 15.445522][ T301] ? alloc_buf.isra.0+0x4b/0x260 [ 15.445528][ T301] ? do_raw_spin_unlock+0x59/0x250 [ 15.445530][ T301] alloc_buf.isra.0+0x4b/0x260 [ 15.445533][ T301] put_chars+0x1e1/0x2f0 [ 15.445536][ T301] ? __send_to_port+0x420/0x420 [ 15.445538][ T301] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 15.445543][ T301] ? validate_chain+0x38b/0xc20 [ 15.445548][ T301] hvc_console_print+0x292/0x780 [ 15.445554][ T301] ? hvc_write+0x3a0/0x3a0 [ 15.445557][ T301] ? rcu_is_watching+0x16/0xd0 [ 15.445559][ T301] ? lock_acquire+0x13c/0x160 [ 15.445563][ T301] console_emit_next_record+0x22f/0x4c0 [ 15.445567][ T301] ? devkmsg_read+0x4b0/0x4b0 [ 15.445569][ T301] ? console_flush_one_record+0x106/0x710 [ 15.445572][ T301] ? rcu_is_watching+0x16/0xd0 [ 15.445574][ T301] ? lock_acquire+0x13c/0x160 [ 15.445578][ T301] console_flush_one_record+0x46f/0x710 [ 15.445582][ T301] ? console_emit_next_record+0x4c0/0x4c0 [ 15.445584][ T301] ? __lock_acquire+0x518/0xc20 [ 15.445589][ T301] console_unlock+0xee/0x1f0 [ 15.445592][ T301] ? console_flush_one_record+0x710/0x710 [ 15.445594][ T301] ? rcu_is_watching+0x16/0xd0 [ 15.445596][ T301] ? lock_acquire+0x60/0x160 [ 15.445600][ T301] ? __down_trylock_console_sem+0x5e/0xa0 [ 15.445601][ T301] ? vprintk_emit+0x320/0x3e0 [ 15.445605][ T301] vprintk_emit+0x37c/0x3e0 [ 15.445608][ T301] ? wake_up_klogd_work_func+0x90/0x90 [ 15.445612][ T301] ? __lock_acquire+0x518/0xc20 [ 15.445615][ T301] _printk+0xc7/0x100 [ 15.445619][ T301] ? snapshot_read.cold+0x21/0x21 [ 15.445622][ T301] ? do_raw_spin_lock+0x131/0x280 [ 15.445624][ T301] ? __rwlock_init+0x150/0x150 [ 15.445630][ T301] ? do_raw_spin_lock+0x131/0x280 [ 15.445634][ T301] do_exit.cold+0x82/0x9c [ 15.445639][ T301] ? exit_notify+0x890/0x890 [ 15.445640][ T301] ? __lock_release.isra.0+0x69/0x1a0 [ 15.445643][ T301] ? rcu_is_watching+0x16/0xd0 [ 15.445647][ T301] do_group_exit+0xb8/0x370 [ 15.445650][ T301] __x64_sys_exit_group+0x3c/0x50 [ 15.445651][ T301] x64_sys_call+0x1567/0x1570 [ 15.445654][ T301] do_syscall_64+0xff/0x530 [ 15.445657][ T301] ? exc_page_fault+0xee/0x100 [ 15.445660][ T301] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 15.445663][ T301] RIP: 0033:0x7f8d395831b8 [ 15.445665][ T301] Code: Unable to access opcode bytes at 0x7f8d3958318e. [ 15.445666][ T301] RSP: 002b:00007ffc724562d8 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 15.445668][ T301] RAX: ffffffffffffffda RBX: 00007f8d396b3f88 RCX: 00007f8d395831b8 [ 15.445670][ T301] RDX: 00007f8d392cdfc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 15.445671][ T301] RBP: 00007ffc72456330 R08: 0000000000000000 R09: 0000000000000000 [ 15.445671][ T301] R10: 00007ffc724560f0 R11: 0000000000000246 R12: 0000000000000001 [ 15.445672][ T301] R13: 0000000000000000 R14: 00007f8d396b2680 R15: 00007f8d396b3fa0 [ 15.445679][ T301] [ 15.644616][ T307] ip (307) used greatest stack depth: 24664 bytes left [ 15.871065][ T314] ip (314) used greatest stack depth: 24464 bytes left [ 16.084411][ T321] ip (321) used greatest stack depth: 24008 bytes left [ 23.189020][ C3] tun0: no available key for peer 3, key-id: 0 [ 23.189054][ C3] [ 23.189056][ C3] ======================================================== [ 23.189057][ C3] WARNING: possible irq lock inversion dependency detected [ 23.189059][ C3] 7.2.0-virtme #1 Tainted: G W [ 23.189060][ C3] -------------------------------------------------------- [ 23.189061][ C3] ovpn-cli/414 just changed the state of lock: [ 23.189062][ C3] ffffffff97299660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 23.189074][ C3] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 23.189076][ C3] (fs_reclaim){+.+.}-{0:0} [ 23.189077][ C3] [ 23.189077][ C3] [ 23.189077][ C3] and interrupts could create inverse lock ordering between them. [ 23.189077][ C3] [ 23.189078][ C3] [ 23.189078][ C3] other info that might help us debug this: [ 23.189079][ C3] Possible interrupt unsafe locking scenario: [ 23.189079][ C3] [ 23.189079][ C3] CPU0 CPU1 [ 23.189080][ C3] ---- ---- [ 23.189080][ C3] lock(fs_reclaim); [ 23.189081][ C3] local_irq_disable(); [ 23.189082][ C3] lock(console_owner); [ 23.189083][ C3] lock(fs_reclaim); [ 23.189084][ C3] [ 23.189084][ C3] lock(console_owner); [ 23.189085][ C3] [ 23.189085][ C3] *** DEADLOCK *** [ 23.189085][ C3] [ 23.189085][ C3] locks held by ovpn-cli/414: 6, last CPU#3: [ 23.189087][ C3] #0: ffffffff97390b00 (rcu_read_lock){....}-{1:3}, at: process_backlog+0x3f1/0x14c0 [ 23.189093][ C3] #1: ffffffff97390b00 (rcu_read_lock){....}-{1:3}, at: ip_local_deliver_finish+0x2ba/0x610 [ 23.189098][ C3] #2: ff1100001a45d318 (slock-AF_INET/1){+.-.}-{3:3}, at: tcp_v4_rcv+0x1a81/0x2b70 [ 23.189102][ C3] #3: ffffffff97390b00 (rcu_read_lock){....}-{1:3}, at: ovpn_tcp_data_ready+0x62/0x390 [ovpn] [ 23.189109][ C3] #4: ffffffff97379cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 23.189112][ C3] #5: ffffffff97379d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 23.189116][ C3] [ 23.189116][ C3] the shortest dependencies between 2nd lock and 1st lock: [ 23.189120][ C3] -> (fs_reclaim){+.+.}-{0:0} { [ 23.189123][ C3] HARDIRQ-ON-W at: [ 23.189124][ C3] __lock_acquire+0x388/0xc20 [ 23.189127][ C3] lock_acquire.part.0+0xd4/0x280 [ 23.189129][ C3] fs_reclaim_acquire+0xd5/0x120 [ 23.189131][ C3] __kmalloc_cache_noprof+0x6e/0x620 [ 23.189134][ C3] kthread_create_worker_on_node+0xea/0x210 [ 23.189137][ C3] workqueue_init+0x2a/0x680 [ 23.189140][ C3] kernel_init_freeable+0x2fe/0x630 [ 23.189143][ C3] kernel_init+0x21/0x150 [ 23.189146][ C3] ret_from_fork+0x474/0x6b0 [ 23.189149][ C3] ret_from_fork_asm+0x11/0x20 [ 23.189152][ C3] SOFTIRQ-ON-W at: [ 23.189153][ C3] __lock_acquire+0x388/0xc20 [ 23.189154][ C3] lock_acquire.part.0+0xd4/0x280 [ 23.189156][ C3] fs_reclaim_acquire+0xd5/0x120 [ 23.189157][ C3] __kmalloc_cache_noprof+0x6e/0x620 [ 23.189158][ C3] kthread_create_worker_on_node+0xea/0x210 [ 23.189159][ C3] workqueue_init+0x2a/0x680 [ 23.189160][ C3] kernel_init_freeable+0x2fe/0x630 [ 23.189162][ C3] kernel_init+0x21/0x150 [ 23.189163][ C3] ret_from_fork+0x474/0x6b0 [ 23.189164][ C3] ret_from_fork_asm+0x11/0x20 [ 23.189166][ C3] INITIAL USE at: [ 23.189166][ C3] __lock_acquire+0x388/0xc20 [ 23.189168][ C3] lock_acquire.part.0+0xd4/0x280 [ 23.189169][ C3] fs_reclaim_acquire+0xd5/0x120 [ 23.189170][ C3] __kmalloc_cache_noprof+0x6e/0x620 [ 23.189171][ C3] kthread_create_worker_on_node+0xea/0x210 [ 23.189173][ C3] workqueue_init+0x2a/0x680 [ 23.189174][ C3] kernel_init_freeable+0x2fe/0x630 [ 23.189175][ C3] kernel_init+0x21/0x150 [ 23.189177][ C3] ret_from_fork+0x474/0x6b0 [ 23.189178][ C3] ret_from_fork_asm+0x11/0x20 [ 23.189179][ C3] } [ 23.189180][ C3] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 23.189183][ C3] ... acquired at: [ 23.189184][ C3] __lock_acquire+0x518/0xc20 [ 23.189186][ C3] lock_acquire.part.0+0xd4/0x280 [ 23.189187][ C3] fs_reclaim_acquire+0xd5/0x120 [ 23.189188][ C3] __kmalloc_noprof+0xd3/0x760 [ 23.189189][ C3] alloc_buf.isra.0+0x4b/0x260 [ 23.189192][ C3] put_chars+0x1e1/0x2f0 [ 23.189194][ C3] hvc_console_print+0x292/0x780 [ 23.189196][ C3] console_emit_next_record+0x22f/0x4c0 [ 23.189198][ C3] console_flush_one_record+0x46f/0x710 [ 23.189200][ C3] console_unlock+0xee/0x1f0 [ 23.189201][ C3] vprintk_emit+0x37c/0x3e0 [ 23.189203][ C3] dev_vprintk_emit+0x27f/0x2c0 [ 23.189206][ C3] dev_printk_emit+0xb9/0xee [ 23.189208][ C3] _dev_info+0xe2/0x116 [ 23.189210][ C3] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 23.189212][ C3] cmos_do_probe+0x73b/0x98a [ 23.189214][ C3] platform_probe+0xfe/0x1f0 [ 23.189216][ C3] call_driver_probe+0x61/0x1c0 [ 23.189218][ C3] really_probe+0x199/0x760 [ 23.189220][ C3] __driver_probe_device+0x24f/0x440 [ 23.189221][ C3] driver_probe_device+0x4a/0xf0 [ 23.189223][ C3] __driver_attach+0x1b8/0x540 [ 23.189225][ C3] bus_for_each_dev+0x130/0x1e0 [ 23.189226][ C3] bus_add_driver+0x2c8/0x530 [ 23.189228][ C3] driver_register+0x1a3/0x390 [ 23.189229][ C3] __platform_driver_probe+0x13f/0x270 [ 23.189231][ C3] cmos_init+0x31/0x40 [ 23.189233][ C3] do_one_initcall+0x124/0x4f0 [ 23.189235][ C3] kernel_init_freeable+0x596/0x630 [ 23.189237][ C3] kernel_init+0x21/0x150 [ 23.189238][ C3] ret_from_fork+0x474/0x6b0 [ 23.189239][ C3] ret_from_fork_asm+0x11/0x20 [ 23.189240][ C3] [ 23.189241][ C3] -> (console_owner){..-.}-{0:0} { [ 23.189243][ C3] IN-SOFTIRQ-W at: [ 23.189243][ C3] __lock_acquire+0x388/0xc20 [ 23.189245][ C3] lock_acquire.part.0+0xd4/0x280 [ 23.189246][ C3] console_lock_spinning_enable+0x5c/0x60 [ 23.189248][ C3] console_emit_next_record+0x1d1/0x4c0 [ 23.189249][ C3] console_flush_one_record+0x46f/0x710 [ 23.189251][ C3] console_unlock+0xee/0x1f0 [ 23.189252][ C3] vprintk_emit+0x37c/0x3e0 [ 23.189254][ C3] _printk+0xc7/0x100 [ 23.189257][ C3] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 23.189260][ C3] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 23.189262][ C3] __strp_recv+0x20f/0x1c20 [ 23.189265][ C3] __tcp_read_sock+0x1c7/0x850 [ 23.189268][ C3] strp_read_sock+0x20f/0x2b0 [ 23.189270][ C3] strp_data_ready+0x18e/0x2c0 [ 23.189271][ C3] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 23.189273][ C3] tcp_rcv_established+0x1e1d/0x3910 [ 23.189276][ C3] tcp_v4_do_rcv+0x4f6/0xb90 [ 23.189277][ C3] tcp_v4_rcv+0x1caa/0x2b70 [ 23.189279][ C3] ip_protocol_deliver_rcu+0x82/0x350 [ 23.189280][ C3] ip_local_deliver_finish+0x36f/0x610 [ 23.189281][ C3] ip_local_deliver+0x184/0x4c0 [ 23.189283][ C3] ip_rcv+0xdc/0x3d0 [ 23.189284][ C3] __netif_receive_skb_one_core+0xfc/0x180 [ 23.189286][ C3] process_backlog+0x431/0x14c0 [ 23.189287][ C3] __napi_poll+0xa7/0x3b0 [ 23.189289][ C3] net_rx_action+0x513/0xf50 [ 23.189291][ C3] handle_softirqs+0x1d3/0x900 [ 23.189294][ C3] do_softirq+0xac/0xe0 [ 23.189295][ C3] __local_bh_enable_ip+0x118/0x150 [ 23.189296][ C3] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 23.189298][ C3] __sys_sendto+0x2aa/0x400 [ 23.189301][ C3] __x64_sys_sendto+0xe4/0x1f0 [ 23.189303][ C3] do_syscall_64+0xff/0x530 [ 23.189305][ C3] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 23.189307][ C3] INITIAL USE at: [ 23.189308][ C3] } [ 23.189308][ C3] ... key at: [] console_owner_dep_map+0x0/0x60 [ 23.189312][ C3] ... acquired at: [ 23.189312][ C3] mark_lock+0x1d7/0xa00 [ 23.189314][ C3] mark_usage+0x42/0x170 [ 23.189315][ C3] __lock_acquire+0x388/0xc20 [ 23.189316][ C3] lock_acquire.part.0+0xd4/0x280 [ 23.189318][ C3] console_lock_spinning_enable+0x5c/0x60 [ 23.189319][ C3] console_emit_next_record+0x1d1/0x4c0 [ 23.189321][ C3] console_flush_one_record+0x46f/0x710 [ 23.189322][ C3] console_unlock+0xee/0x1f0 [ 23.189324][ C3] vprintk_emit+0x37c/0x3e0 [ 23.189325][ C3] _printk+0xc7/0x100 [ 23.189327][ C3] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 23.189329][ C3] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 23.189331][ C3] __strp_recv+0x20f/0x1c20 [ 23.189333][ C3] __tcp_read_sock+0x1c7/0x850 [ 23.189334][ C3] strp_read_sock+0x20f/0x2b0 [ 23.189336][ C3] strp_data_ready+0x18e/0x2c0 [ 23.189338][ C3] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 23.189340][ C3] tcp_rcv_established+0x1e1d/0x3910 [ 23.189341][ C3] tcp_v4_do_rcv+0x4f6/0xb90 [ 23.189343][ C3] tcp_v4_rcv+0x1caa/0x2b70 [ 23.189344][ C3] ip_protocol_deliver_rcu+0x82/0x350 [ 23.189346][ C3] ip_local_deliver_finish+0x36f/0x610 [ 23.189347][ C3] ip_local_deliver+0x184/0x4c0 [ 23.189348][ C3] ip_rcv+0xdc/0x3d0 [ 23.189349][ C3] __netif_receive_skb_one_core+0xfc/0x180 [ 23.189351][ C3] process_backlog+0x431/0x14c0 [ 23.189353][ C3] __napi_poll+0xa7/0x3b0 [ 23.189354][ C3] net_rx_action+0x513/0xf50 [ 23.189356][ C3] handle_softirqs+0x1d3/0x900 [ 23.189357][ C3] do_softirq+0xac/0xe0 [ 23.189358][ C3] __local_bh_enable_ip+0x118/0x150 [ 23.189360][ C3] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 23.189362][ C3] __sys_sendto+0x2aa/0x400 [ 23.189363][ C3] __x64_sys_sendto+0xe4/0x1f0 [ 23.189365][ C3] do_syscall_64+0xff/0x530 [ 23.189366][ C3] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 23.189367][ C3] [ 23.189368][ C3] [ 23.189368][ C3] stack backtrace: [ 23.189370][ C3] CPU: 3 UID: 0 PID: 414 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 23.189374][ C3] Tainted: [W]=WARN [ 23.189374][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 23.189376][ C3] Call Trace: [ 23.189377][ C3] [ 23.189378][ C3] dump_stack_lvl+0x6f/0xa0 [ 23.189382][ C3] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 23.189385][ C3] mark_lock_irq+0x989/0x9c0 [ 23.189388][ C3] mark_lock+0x1d7/0xa00 [ 23.189389][ C3] mark_usage+0x42/0x170 [ 23.189391][ C3] __lock_acquire+0x388/0xc20 [ 23.189393][ C3] lock_acquire.part.0+0xd4/0x280 [ 23.189395][ C3] ? console_lock_spinning_enable+0x40/0x60 [ 23.189397][ C3] ? rcu_is_watching+0x16/0xd0 [ 23.189401][ C3] ? lock_acquire+0x13c/0x160 [ 23.189403][ C3] console_lock_spinning_enable+0x5c/0x60 [ 23.189404][ C3] ? console_lock_spinning_enable+0x40/0x60 [ 23.189406][ C3] console_emit_next_record+0x1d1/0x4c0 [ 23.189408][ C3] ? devkmsg_read+0x4b0/0x4b0 [ 23.189410][ C3] ? console_flush_one_record+0x106/0x710 [ 23.189412][ C3] ? rcu_is_watching+0x16/0xd0 [ 23.189414][ C3] ? lock_acquire+0x13c/0x160 [ 23.189416][ C3] console_flush_one_record+0x46f/0x710 [ 23.189418][ C3] ? console_emit_next_record+0x4c0/0x4c0 [ 23.189420][ C3] ? __lock_acquire+0x518/0xc20 [ 23.189422][ C3] console_unlock+0xee/0x1f0 [ 23.189424][ C3] ? console_flush_one_record+0x710/0x710 [ 23.189425][ C3] ? rcu_is_watching+0x16/0xd0 [ 23.189427][ C3] ? lock_acquire+0x60/0x160 [ 23.189429][ C3] ? __down_trylock_console_sem+0x5e/0xa0 [ 23.189431][ C3] ? vprintk_emit+0x320/0x3e0 [ 23.189433][ C3] vprintk_emit+0x37c/0x3e0 [ 23.189435][ C3] ? wake_up_klogd_work_func+0x90/0x90 [ 23.189437][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 23.189439][ C3] _printk+0xc7/0x100 [ 23.189441][ C3] ? snapshot_read.cold+0x21/0x21 [ 23.189442][ C3] ? ___ratelimit+0x4e7/0xa00 [ 23.189445][ C3] ? ovpn_netdev_write+0x730/0x730 [ovpn] [ 23.189449][ C3] ? idr_get_free+0x830/0x830 [ 23.189451][ C3] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 23.189454][ C3] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 23.189457][ C3] ? ovpn_tcp_write_space+0x2e0/0x2e0 [ovpn] [ 23.189460][ C3] ? __copy_skb_header+0xb7/0x510 [ 23.189463][ C3] ? ovpn_tcp_disconnect+0x10/0x10 [ovpn] [ 23.189465][ C3] ? sock_queue_err_skb+0xb0/0x680 [ 23.189467][ C3] __strp_recv+0x20f/0x1c20 [ 23.189471][ C3] __tcp_read_sock+0x1c7/0x850 [ 23.189472][ C3] ? strp_process+0xb0/0xb0 [ 23.189474][ C3] ? __tcp_transmit_skb+0x1b6e/0x3c10 [ 23.189476][ C3] ? tcp_cleanup_rbuf+0x1c0/0x1c0 [ 23.189478][ C3] ? mark_usage+0x61/0x170 [ 23.189480][ C3] strp_read_sock+0x20f/0x2b0 [ 23.189482][ C3] ? strp_stop+0x50/0x50 [ 23.189484][ C3] ? rcu_is_watching+0x16/0xd0 [ 23.189486][ C3] ? lock_acquire+0x13c/0x160 [ 23.189488][ C3] strp_data_ready+0x18e/0x2c0 [ 23.189490][ C3] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 23.189492][ C3] tcp_rcv_established+0x1e1d/0x3910 [ 23.189495][ C3] ? __tcp_check_space+0x600/0x600 [ 23.189497][ C3] ? tcp_v4_rcv+0x1a81/0x2b70 [ 23.189499][ C3] ? do_raw_spin_lock+0x131/0x280 [ 23.189501][ C3] tcp_v4_do_rcv+0x4f6/0xb90 [ 23.189503][ C3] tcp_v4_rcv+0x1caa/0x2b70 [ 23.189506][ C3] ? mark_usage+0x61/0x170 [ 23.189508][ C3] ? tcp_add_backlog+0x1e30/0x1e30 [ 23.189510][ C3] ? lock_acquire.part.0+0xd4/0x280 [ 23.189511][ C3] ? ip_local_deliver_finish+0x2ba/0x610 [ 23.189513][ C3] ip_protocol_deliver_rcu+0x82/0x350 [ 23.189515][ C3] ? process_backlog+0x3f1/0x14c0 [ 23.189517][ C3] ip_local_deliver_finish+0x36f/0x610 [ 23.189519][ C3] ip_local_deliver+0x184/0x4c0 [ 23.189521][ C3] ? ip_local_deliver_finish+0x610/0x610 [ 23.189523][ C3] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 23.189525][ C3] ? process_backlog+0x3f1/0x14c0 [ 23.189527][ C3] ip_rcv+0xdc/0x3d0 [ 23.189528][ C3] ? ip_local_deliver+0x4c0/0x4c0 [ 23.189530][ C3] ? __mkroute_output+0x500/0xff0 [ 23.189531][ C3] ? ip_route_output_key_hash+0x120/0x240 [ 23.189533][ C3] ? ip_route_output_flow+0x21/0x150 [ 23.189534][ C3] ? mark_usage+0x61/0x170 [ 23.189536][ C3] ? __lock_acquire+0x518/0xc20 [ 23.189537][ C3] ? copy_msghdr_from_user+0x197/0x420 [ 23.189540][ C3] __netif_receive_skb_one_core+0xfc/0x180 [ 23.189542][ C3] ? lock_acquire.part.0+0xd4/0x280 [ 23.189543][ C3] ? process_backlog+0x3f1/0x14c0 [ 23.189545][ C3] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 23.189547][ C3] ? rcu_is_watching+0x16/0xd0 [ 23.189549][ C3] process_backlog+0x431/0x14c0 [ 23.189552][ C3] __napi_poll+0xa7/0x3b0 [ 23.189554][ C3] net_rx_action+0x513/0xf50 [ 23.189557][ C3] ? __napi_poll+0x3b0/0x3b0 [ 23.189559][ C3] ? _raw_spin_unlock_irq_enable+0x5b/0x90 [ 23.189561][ C3] ? mark_held_locks+0x40/0x70 [ 23.189563][ C3] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 23.189566][ C3] ? mark_held_locks+0x40/0x70 [ 23.189567][ C3] ? rcu_is_watching+0x16/0xd0 [ 23.189569][ C3] handle_softirqs+0x1d3/0x900 [ 23.189571][ C3] ? _local_bh_enable+0xc0/0xc0 [ 23.189573][ C3] ? _local_bh_enable+0xc0/0xc0 [ 23.189575][ C3] do_softirq+0xac/0xe0 [ 23.189576][ C3] [ 23.189577][ C3] [ 23.189577][ C3] __local_bh_enable_ip+0x118/0x150 [ 23.189579][ C3] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 23.189582][ C3] ? ovpn_tcp_recvmsg+0x6d0/0x6d0 [ovpn] [ 23.189586][ C3] __sys_sendto+0x2aa/0x400 [ 23.189588][ C3] ? __ia32_sys_getpeername+0xd0/0xd0 [ 23.189592][ C3] ? fput_close_sync+0xde/0x1b0 [ 23.189594][ C3] ? alloc_file_clone+0xe0/0xe0 [ 23.189596][ C3] __x64_sys_sendto+0xe4/0x1f0 [ 23.189598][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 23.189601][ C3] ? lockdep_hardirqs_on+0x91/0x130 [ 23.189602][ C3] ? do_syscall_64+0xa6/0x530 [ 23.189603][ C3] do_syscall_64+0xff/0x530 [ 23.189605][ C3] ? exc_page_fault+0xee/0x100 [ 23.189606][ C3] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 23.189608][ C3] RIP: 0033:0x7f448631f54e [ 23.189611][ C3] 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 [ 23.189613][ C3] RSP: 002b:00007fffa7712670 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 23.189615][ C3] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f448631f54e [ 23.189617][ C3] RDX: 00000000000003ea RSI: 00007fffa77126e0 RDI: 0000000000000005 [ 23.189618][ C3] RBP: 00007fffa7712680 R08: 0000000000000000 R09: 0000000000000000 [ 23.189619][ C3] R10: 0000000000004000 R11: 0000000000000202 R12: 00007fffa7713008 [ 23.189619][ C3] R13: 0000000000000008 R14: 00007f448660a000 R15: 000000000040bda8 [ 23.189622][ C3] [ 23.189625][ C3] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 23.189627][ C3] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 414, name: ovpn-cli [ 23.189629][ C3] preempt_count: 103, expected: 0 [ 23.189630][ C3] RCU nest depth: 3, expected: 0 [ 23.189631][ C3] INFO: lockdep is turned off. [ 23.189632][ C3] irq event stamp: 40013 [ 23.189633][ C3] hardirqs last enabled at (40012): [] __down_trylock_console_sem+0x86/0xa0 [ 23.189636][ C3] hardirqs last disabled at (40013): [] console_emit_next_record+0x3d4/0x4c0 [ 23.189639][ C3] softirqs last enabled at (39898): [] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 23.189642][ C3] softirqs last disabled at (39899): [] do_softirq+0xac/0xe0 [ 23.189643][ C3] Preemption disabled at: [ 23.189644][ C3] [<0000000000000000>] 0x0 [ 23.189646][ C3] CPU: 3 UID: 0 PID: 414 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 23.189648][ C3] Tainted: [W]=WARN [ 23.189649][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 23.189649][ C3] Call Trace: [ 23.189650][ C3] [ 23.189651][ C3] dump_stack_lvl+0x6f/0xa0 [ 23.189653][ C3] __might_resched.cold+0x1fe/0x2c1 [ 23.189656][ C3] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 23.189660][ C3] ? rcu_is_watching+0x16/0xd0 [ 23.189662][ C3] __kmalloc_noprof+0x443/0x760 [ 23.189664][ C3] ? __rwlock_init+0x150/0x150 [ 23.189665][ C3] ? alloc_buf.isra.0+0x4b/0x260 [ 23.189667][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 23.189669][ C3] alloc_buf.isra.0+0x4b/0x260 [ 23.189671][ C3] put_chars+0x1e1/0x2f0 [ 23.189674][ C3] ? __send_to_port+0x420/0x420 [ 23.189677][ C3] hvc_console_print+0x292/0x780 [ 23.189679][ C3] ? __lock_acquire+0x388/0xc20 [ 23.189681][ C3] ? hvc_write+0x3a0/0x3a0 [ 23.189683][ C3] ? rcu_is_watching+0x16/0xd0 [ 23.189685][ C3] ? lock_acquire+0x13c/0x160 [ 23.189687][ C3] console_emit_next_record+0x22f/0x4c0 [ 23.189689][ C3] ? devkmsg_read+0x4b0/0x4b0 [ 23.189691][ C3] ? console_flush_one_record+0x106/0x710 [ 23.189693][ C3] ? rcu_is_watching+0x16/0xd0 [ 23.189694][ C3] ? lock_acquire+0x13c/0x160 [ 23.189696][ C3] console_flush_one_record+0x46f/0x710 [ 23.189698][ C3] ? console_emit_next_record+0x4c0/0x4c0 [ 23.189700][ C3] ? __lock_acquire+0x518/0xc20 [ 23.189702][ C3] console_unlock+0xee/0x1f0 [ 23.189704][ C3] ? console_flush_one_record+0x710/0x710 [ 23.189706][ C3] ? rcu_is_watching+0x16/0xd0 [ 23.189708][ C3] ? lock_acquire+0x60/0x160 [ 23.189709][ C3] ? __down_trylock_console_sem+0x5e/0xa0 [ 23.189711][ C3] ? vprintk_emit+0x320/0x3e0 [ 23.189713][ C3] vprintk_emit+0x37c/0x3e0 [ 23.189715][ C3] ? wake_up_klogd_work_func+0x90/0x90 [ 23.189717][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 23.189719][ C3] _printk+0xc7/0x100 [ 23.189721][ C3] ? snapshot_read.cold+0x21/0x21 [ 23.189722][ C3] ? ___ratelimit+0x4e7/0xa00 [ 23.189724][ C3] ? ovpn_netdev_write+0x730/0x730 [ovpn] [ 23.189727][ C3] ? idr_get_free+0x830/0x830 [ 23.189729][ C3] ovpn_recv.cold+0x7e/0x94 [ovpn] [ 23.189732][ C3] ovpn_tcp_rcv+0x274/0x9a0 [ovpn] [ 23.189735][ C3] ? ovpn_tcp_write_space+0x2e0/0x2e0 [ovpn] [ 23.189737][ C3] ? __copy_skb_header+0xb7/0x510 [ 23.189739][ C3] ? ovpn_tcp_disconnect+0x10/0x10 [ovpn] [ 23.189741][ C3] ? sock_queue_err_skb+0xb0/0x680 [ 23.189744][ C3] __strp_recv+0x20f/0x1c20 [ 23.189747][ C3] __tcp_read_sock+0x1c7/0x850 [ 23.189749][ C3] ? strp_process+0xb0/0xb0 [ 23.189751][ C3] ? __tcp_transmit_skb+0x1b6e/0x3c10 [ 23.189752][ C3] ? tcp_cleanup_rbuf+0x1c0/0x1c0 [ 23.189754][ C3] ? mark_usage+0x61/0x170 [ 23.189756][ C3] strp_read_sock+0x20f/0x2b0 [ 23.189758][ C3] ? strp_stop+0x50/0x50 [ 23.189760][ C3] ? rcu_is_watching+0x16/0xd0 [ 23.189762][ C3] ? lock_acquire+0x13c/0x160 [ 23.189763][ C3] strp_data_ready+0x18e/0x2c0 [ 23.189766][ C3] ovpn_tcp_data_ready+0xf1/0x390 [ovpn] [ 23.189768][ C3] tcp_rcv_established+0x1e1d/0x3910 [ 23.189771][ C3] ? __tcp_check_space+0x600/0x600 [ 23.189773][ C3] ? tcp_v4_rcv+0x1a81/0x2b70 [ 23.189775][ C3] ? do_raw_spin_lock+0x131/0x280 [ 23.189777][ C3] tcp_v4_do_rcv+0x4f6/0xb90 [ 23.189779][ C3] tcp_v4_rcv+0x1caa/0x2b70 [ 23.189781][ C3] ? mark_usage+0x61/0x170 [ 23.189783][ C3] ? tcp_add_backlog+0x1e30/0x1e30 [ 23.189785][ C3] ? lock_acquire.part.0+0xd4/0x280 [ 23.189787][ C3] ? ip_local_deliver_finish+0x2ba/0x610 [ 23.189789][ C3] ip_protocol_deliver_rcu+0x82/0x350 [ 23.189790][ C3] ? process_backlog+0x3f1/0x14c0 [ 23.189792][ C3] ip_local_deliver_finish+0x36f/0x610 [ 23.189794][ C3] ip_local_deliver+0x184/0x4c0 [ 23.189796][ C3] ? ip_local_deliver_finish+0x610/0x610 [ 23.189797][ C3] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 23.189800][ C3] ? process_backlog+0x3f1/0x14c0 [ 23.189801][ C3] ip_rcv+0xdc/0x3d0 [ 23.189803][ C3] ? ip_local_deliver+0x4c0/0x4c0 [ 23.189805][ C3] ? __mkroute_output+0x500/0xff0 [ 23.189806][ C3] ? ip_route_output_key_hash+0x120/0x240 [ 23.189807][ C3] ? ip_route_output_flow+0x21/0x150 [ 23.189808][ C3] ? mark_usage+0x61/0x170 [ 23.189810][ C3] ? __lock_acquire+0x518/0xc20 [ 23.189811][ C3] ? copy_msghdr_from_user+0x197/0x420 [ 23.189813][ C3] __netif_receive_skb_one_core+0xfc/0x180 [ 23.189815][ C3] ? lock_acquire.part.0+0xd4/0x280 [ 23.189817][ C3] ? process_backlog+0x3f1/0x14c0 [ 23.189819][ C3] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 23.189821][ C3] ? rcu_is_watching+0x16/0xd0 [ 23.189823][ C3] process_backlog+0x431/0x14c0 [ 23.189826][ C3] __napi_poll+0xa7/0x3b0 [ 23.189828][ C3] net_rx_action+0x513/0xf50 [ 23.189831][ C3] ? __napi_poll+0x3b0/0x3b0 [ 23.189832][ C3] ? _raw_spin_unlock_irq_enable+0x5b/0x90 [ 23.189834][ C3] ? mark_held_locks+0x40/0x70 [ 23.189836][ C3] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 23.189838][ C3] ? mark_held_locks+0x40/0x70 [ 23.189840][ C3] ? rcu_is_watching+0x16/0xd0 [ 23.189842][ C3] handle_softirqs+0x1d3/0x900 [ 23.189844][ C3] ? _local_bh_enable+0xc0/0xc0 [ 23.189845][ C3] ? _local_bh_enable+0xc0/0xc0 [ 23.189847][ C3] do_softirq+0xac/0xe0 [ 23.189848][ C3] [ 23.189849][ C3] [ 23.189849][ C3] __local_bh_enable_ip+0x118/0x150 [ 23.189851][ C3] ovpn_tcp_sendmsg+0x2c2/0x7d0 [ovpn] [ 23.189854][ C3] ? ovpn_tcp_recvmsg+0x6d0/0x6d0 [ovpn] [ 23.189857][ C3] __sys_sendto+0x2aa/0x400 [ 23.189859][ C3] ? __ia32_sys_getpeername+0xd0/0xd0 [ 23.189863][ C3] ? fput_close_sync+0xde/0x1b0 [ 23.189865][ C3] ? alloc_file_clone+0xe0/0xe0 [ 23.189866][ C3] __x64_sys_sendto+0xe4/0x1f0 [ 23.189868][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 23.189869][ C3] ? lockdep_hardirqs_on+0x91/0x130 [ 23.189870][ C3] ? do_syscall_64+0xa6/0x530 [ 23.189872][ C3] do_syscall_64+0xff/0x530 [ 23.189874][ C3] ? exc_page_fault+0xee/0x100 [ 23.189875][ C3] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 23.189876][ C3] RIP: 0033:0x7f448631f54e [ 23.189878][ C3] 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 [ 23.189879][ C3] RSP: 002b:00007fffa7712670 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 23.189880][ C3] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f448631f54e [ 23.189881][ C3] RDX: 00000000000003ea RSI: 00007fffa77126e0 RDI: 0000000000000005 [ 23.189881][ C3] RBP: 00007fffa7712680 R08: 0000000000000000 R09: 0000000000000000 [ 23.189882][ C3] R10: 0000000000004000 R11: 0000000000000202 R12: 00007fffa7713008 [ 23.189883][ C3] R13: 0000000000000008 R14: 00007f448660a000 R15: 000000000040bda8 [ 23.189885][ C3] [ 23.345323][ C2] tun0: no available key for peer 4, key-id: 0 [ 23.475316][ C0] tun0: no available key for peer 6, key-id: 0 [ 31.994181][ T624] iperf3 (624) used greatest stack depth: 23024 bytes left [ 31.994199][ T624] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 31.994201][ T624] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 624, name: iperf3 [ 31.994203][ T624] preempt_count: 2, expected: 0 [ 31.994204][ T624] RCU nest depth: 0, expected: 0 [ 31.994205][ T624] INFO: lockdep is turned off. [ 31.994206][ T624] irq event stamp: 0 [ 31.994207][ T624] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 31.994211][ T624] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 31.994218][ T624] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 31.994219][ T624] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 31.994221][ T624] Preemption disabled at: [ 31.994222][ T624] [<0000000000000000>] 0x0 [ 31.994228][ T624] CPU: 3 UID: 0 PID: 624 Comm: iperf3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 31.994231][ T624] Tainted: [W]=WARN [ 31.994232][ T624] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 31.994234][ T624] Call Trace: [ 31.994235][ T624] [ 31.994237][ T624] dump_stack_lvl+0x6f/0xa0 [ 31.994242][ T624] __might_resched.cold+0x1fe/0x2c1 [ 31.994247][ T624] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 31.994251][ T624] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 31.994253][ T624] ? rcu_is_watching+0x16/0xd0 [ 31.994257][ T624] __kmalloc_noprof+0x443/0x760 [ 31.994261][ T624] ? __rwlock_init+0x150/0x150 [ 31.994264][ T624] ? alloc_buf.isra.0+0x4b/0x260 [ 31.994268][ T624] ? do_raw_spin_unlock+0x59/0x250 [ 31.994270][ T624] alloc_buf.isra.0+0x4b/0x260 [ 31.994272][ T624] put_chars+0x1e1/0x2f0 [ 31.994274][ T624] ? prb_final_commit+0x50/0x50 [ 31.994275][ T624] ? __send_to_port+0x420/0x420 [ 31.994277][ T624] ? printk_get_next_message+0x240/0x650 [ 31.994280][ T624] hvc_console_print+0x292/0x780 [ 31.994284][ T624] ? hvc_write+0x3a0/0x3a0 [ 31.994285][ T624] ? do_raw_spin_lock+0x131/0x280 [ 31.994287][ T624] ? vsnprintf+0x668/0x1700 [ 31.994290][ T624] ? __rwlock_init+0x150/0x150 [ 31.994292][ T624] ? rcu_is_watching+0x16/0xd0 [ 31.994293][ T624] ? lock_acquire+0x13c/0x160 [ 31.994296][ T624] console_emit_next_record+0x22f/0x4c0 [ 31.994298][ T624] ? devkmsg_read+0x4b0/0x4b0 [ 31.994300][ T624] ? rcu_is_watching+0x16/0xd0 [ 31.994302][ T624] ? rcu_is_watching+0x16/0xd0 [ 31.994304][ T624] ? rcu_is_watching+0x16/0xd0 [ 31.994305][ T624] ? lock_acquire+0x13c/0x160 [ 31.994307][ T624] ? console_flush_one_record+0x111/0x710 [ 31.994309][ T624] console_flush_one_record+0x46f/0x710 [ 31.994311][ T624] ? console_emit_next_record+0x4c0/0x4c0 [ 31.994314][ T624] console_unlock+0xee/0x1f0 [ 31.994316][ T624] ? lock_acquire+0x13c/0x160 [ 31.994318][ T624] ? console_flush_one_record+0x710/0x710 [ 31.994319][ T624] ? rcu_is_watching+0x16/0xd0 [ 31.994321][ T624] ? lock_release+0x184/0x1f0 [ 31.994322][ T624] ? lock_acquire+0x60/0x160 [ 31.994324][ T624] ? __rcu_read_lock+0x30/0x70 [ 31.994326][ T624] ? __down_trylock_console_sem+0x5e/0xa0 [ 31.994328][ T624] ? vprintk_emit+0x320/0x3e0 [ 31.994330][ T624] vprintk_emit+0x37c/0x3e0 [ 31.994332][ T624] ? wake_up_klogd_work_func+0x90/0x90 [ 31.994335][ T624] _printk+0xc7/0x100 [ 31.994338][ T624] ? snapshot_read.cold+0x21/0x21 [ 31.994340][ T624] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 31.994343][ T624] ? do_raw_spin_lock+0x131/0x280 [ 31.994344][ T624] ? __rwlock_init+0x150/0x150 [ 31.994347][ T624] ? do_raw_spin_lock+0x131/0x280 [ 31.994348][ T624] do_exit.cold+0x82/0x9c [ 31.994352][ T624] ? exit_notify+0x890/0x890 [ 31.994354][ T624] __x64_sys_exit+0x42/0x50 [ 31.994355][ T624] x64_sys_call+0x156c/0x1570 [ 31.994358][ T624] do_syscall_64+0xff/0x530 [ 31.994360][ T624] ? exc_page_fault+0xee/0x100 [ 31.994362][ T624] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 31.994364][ T624] RIP: 0033:0x7fb768d76c49 [ 31.994366][ T624] Code: Unable to access opcode bytes at 0x7fb768d76c1f. [ 31.994367][ T624] RSP: 002b:00007fb768535e60 EFLAGS: 00000246 ORIG_RAX: 000000000000003c [ 31.994371][ T624] RAX: ffffffffffffffda RBX: 00007fb7685366c0 RCX: 00007fb768d76c49 [ 31.994372][ T624] RDX: 0000000000000000 RSI: 0000000000801000 RDI: 0000000000000000 [ 31.994374][ T624] RBP: 00007fb768535f70 R08: 0000000000000001 R09: 00007fb7685366c0 [ 31.994375][ T624] R10: 0000000000000008 R11: 0000000000000246 R12: 00007fb767d36000 [ 31.994375][ T624] R13: 00007ffd41b0fca0 R14: 0000000000000002 R15: 00007ffd41b0fda7 [ 31.994378][ T624] [ 33.229004][ T718] tun0: deleting peer with id 1, reason 1 [ 33.229020][ T718] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 33.229023][ T718] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 718, name: ovpn-cli [ 33.229024][ T718] preempt_count: 202, expected: 0 [ 33.229025][ T718] RCU nest depth: 0, expected: 0 [ 33.229026][ T718] INFO: lockdep is turned off. [ 33.229027][ T718] irq event stamp: 0 [ 33.229028][ T718] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 33.229032][ T718] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 33.229039][ T718] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 33.229040][ T718] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 33.229042][ T718] Preemption disabled at: [ 33.229043][ T718] [<0000000000000000>] 0x0 [ 33.229048][ T718] CPU: 2 UID: 0 PID: 718 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 33.229052][ T718] Tainted: [W]=WARN [ 33.229053][ T718] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 33.229055][ T718] Call Trace: [ 33.229056][ T718] [ 33.229058][ T718] dump_stack_lvl+0x6f/0xa0 [ 33.229063][ T718] __might_resched.cold+0x1fe/0x2c1 [ 33.229067][ T718] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 33.229071][ T718] ? rcu_is_watching+0x16/0xd0 [ 33.229075][ T718] __kmalloc_noprof+0x443/0x760 [ 33.229079][ T718] ? __rwlock_init+0x150/0x150 [ 33.229082][ T718] ? alloc_buf.isra.0+0x4b/0x260 [ 33.229087][ T718] ? do_raw_spin_unlock+0x59/0x250 [ 33.229088][ T718] alloc_buf.isra.0+0x4b/0x260 [ 33.229091][ T718] put_chars+0x1e1/0x2f0 [ 33.229093][ T718] ? __send_to_port+0x420/0x420 [ 33.229095][ T718] ? printk_get_next_message+0x240/0x650 [ 33.229098][ T718] hvc_console_print+0x292/0x780 [ 33.229102][ T718] ? hvc_write+0x3a0/0x3a0 [ 33.229104][ T718] ? __rwlock_init+0x150/0x150 [ 33.229105][ T718] ? rcu_is_watching+0x16/0xd0 [ 33.229107][ T718] ? lock_acquire+0x13c/0x160 [ 33.229110][ T718] console_emit_next_record+0x22f/0x4c0 [ 33.229112][ T718] ? devkmsg_read+0x4b0/0x4b0 [ 33.229114][ T718] ? rcu_is_watching+0x16/0xd0 [ 33.229116][ T718] ? rcu_is_watching+0x16/0xd0 [ 33.229118][ T718] ? rcu_is_watching+0x16/0xd0 [ 33.229119][ T718] ? lock_acquire+0x13c/0x160 [ 33.229121][ T718] ? console_flush_one_record+0x111/0x710 [ 33.229123][ T718] console_flush_one_record+0x46f/0x710 [ 33.229126][ T718] ? console_emit_next_record+0x4c0/0x4c0 [ 33.229128][ T718] console_unlock+0xee/0x1f0 [ 33.229130][ T718] ? lock_acquire+0x13c/0x160 [ 33.229132][ T718] ? console_flush_one_record+0x710/0x710 [ 33.229133][ T718] ? rcu_is_watching+0x16/0xd0 [ 33.229135][ T718] ? lock_release+0x184/0x1f0 [ 33.229137][ T718] ? lock_acquire+0x60/0x160 [ 33.229138][ T718] ? __rcu_read_lock+0x30/0x70 [ 33.229140][ T718] ? __down_trylock_console_sem+0x5e/0xa0 [ 33.229142][ T718] ? vprintk_emit+0x320/0x3e0 [ 33.229144][ T718] vprintk_emit+0x37c/0x3e0 [ 33.229146][ T718] ? wake_up_klogd_work_func+0x90/0x90 [ 33.229148][ T718] ? kernel_text_address+0x149/0x170 [ 33.229151][ T718] ? __kernel_text_address+0x12/0x30 [ 33.229152][ T718] ? write_profile+0xf0/0xf0 [ 33.229154][ T718] ? unwind_get_return_address+0x67/0xd0 [ 33.229157][ T718] _printk+0xc7/0x100 [ 33.229160][ T718] ? snapshot_read.cold+0x21/0x21 [ 33.229163][ T718] ? netdev_name+0x43/0x60 [ 33.229165][ T718] ? __netdev_printk+0x17f/0x1d0 [ 33.229167][ T718] netdev_info+0xe2/0x116 [ 33.229169][ T718] ? netdev_notice+0x120/0x120 [ 33.229170][ T718] ? ovpn_nl_pre_doit+0x44/0x90 [ovpn] [ 33.229176][ T718] ? __module_address+0x36/0x330 [ 33.229179][ T718] ? lock_acquire+0x13c/0x160 [ 33.229181][ T718] ? rcu_is_watching+0x16/0xd0 [ 33.229183][ T718] ? lock_release+0x184/0x1f0 [ 33.229185][ T718] ? ovpn_peer_get_by_id+0x38a/0x7a0 [ovpn] [ 33.229188][ T718] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 33.229192][ T718] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 33.229194][ T718] ? lock_acquire+0x13c/0x160 [ 33.229196][ T718] ? rcu_is_watching+0x16/0xd0 [ 33.229198][ T718] ? lock_release+0x184/0x1f0 [ 33.229200][ T718] ovpn_peer_remove+0x394/0x640 [ovpn] [ 33.229203][ T718] ? do_raw_spin_lock+0x131/0x280 [ 33.229205][ T718] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 33.229208][ T718] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 33.229211][ T718] ? ovpn_peer_add+0x330/0x330 [ovpn] [ 33.229214][ T718] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 33.229217][ T718] ? trace_hardirqs_on+0x36/0x40 [ 33.229220][ T718] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 33.229222][ T718] ? ref_tracker_alloc+0x28d/0x430 [ 33.229228][ T718] ? lock_release+0x184/0x1f0 [ 33.229230][ T718] ? ovpn_get_dev_from_attrs+0x17a/0x660 [ovpn] [ 33.229233][ T718] genl_family_rcv_msg_doit+0x206/0x300 [ 33.229237][ T718] ? genl_family_rcv_msg_attrs_parse.isra.0+0x330/0x330 [ 33.229239][ T718] ? rcu_is_watching+0x16/0xd0 [ 33.229242][ T718] ? rcu_is_watching+0x16/0xd0 [ 33.229244][ T718] ? cap_capable+0x1d7/0x3d0 [ 33.229247][ T718] ? write_profile+0xf0/0xf0 [ 33.229249][ T718] ? unwind_get_return_address+0x67/0xd0 [ 33.229250][ T718] genl_family_rcv_msg+0x3a4/0x640 [ 33.229253][ T718] ? genl_family_rcv_msg_dumpit+0x340/0x340 [ 33.229255][ T718] ? ovpn_nl_send_peer+0x1300/0x1300 [ovpn] [ 33.229257][ T718] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 33.229260][ T718] ? ovpn_nl_pre_doit+0x90/0x90 [ovpn] [ 33.229262][ T718] ? filter_irq_stacks+0xd0/0xd0 [ 33.229264][ T718] ? stack_depot_save_flags+0x1bc/0x790 [ 33.229266][ T718] genl_rcv_msg+0xbb/0x160 [ 33.229268][ T718] netlink_rcv_skb+0x14e/0x3a0 [ 33.229270][ T718] ? genl_family_rcv_msg+0x640/0x640 [ 33.229272][ T718] ? netlink_ack+0xcf0/0xcf0 [ 33.229275][ T718] ? lock_acquire+0x13c/0x160 [ 33.229277][ T718] ? rcu_is_watching+0x16/0xd0 [ 33.229279][ T718] ? lock_release+0x184/0x1f0 [ 33.229280][ T718] genl_rcv+0x28/0x40 [ 33.229282][ T718] netlink_unicast+0x486/0x750 [ 33.229285][ T718] ? netlink_attachskb+0x810/0x810 [ 33.229286][ T718] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 33.229288][ T718] ? trace_hardirqs_on+0x36/0x40 [ 33.229289][ T718] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 33.229293][ T718] netlink_sendmsg+0x735/0xc60 [ 33.229295][ T718] ? netlink_unicast+0x750/0x750 [ 33.229297][ T718] ? rcu_is_watching+0x16/0xd0 [ 33.229299][ T718] ? lock_release+0x184/0x1f0 [ 33.229301][ T718] ____sys_sendmsg+0x415/0x880 [ 33.229305][ T718] ? copy_msghdr_from_user+0x279/0x420 [ 33.229306][ T718] ? get_timestamp.constprop.0+0x390/0x390 [ 33.229308][ T718] ? move_addr_to_kernel+0x40/0x40 [ 33.229311][ T718] ___sys_sendmsg+0x14e/0x1d0 [ 33.229313][ T718] ? copy_msghdr_from_user+0x420/0x420 [ 33.229315][ T718] ? kfree+0x22/0x590 [ 33.229320][ T718] __sys_sendmsg+0x12c/0x1d0 [ 33.229322][ T718] ? __sys_sendmsg_sock+0x20/0x20 [ 33.229325][ T718] ? rcu_is_watching+0x16/0xd0 [ 33.229327][ T718] ? rcu_is_watching+0x16/0xd0 [ 33.229329][ T718] do_syscall_64+0xff/0x530 [ 33.229332][ T718] ? exc_page_fault+0xee/0x100 [ 33.229334][ T718] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 33.229336][ T718] RIP: 0033:0x7f187cd9254e [ 33.229338][ T718] 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.229339][ T718] RSP: 002b:00007ffeda2d5ac0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 33.229343][ T718] RAX: ffffffffffffffda RBX: 000000001eb30130 RCX: 00007f187cd9254e [ 33.229344][ T718] RDX: 0000000000000000 RSI: 00007ffeda2d5b60 RDI: 0000000000000005 [ 33.229345][ T718] RBP: 00007ffeda2d5ad0 R08: 0000000000000000 R09: 0000000000000000 [ 33.229346][ T718] R10: 0000000000000000 R11: 0000000000000202 R12: 000000001eb30200 [ 33.229347][ T718] R13: 00007ffeda2d5b60 R14: 000000001eb31260 R15: 000000000040bda8 [ 33.229349][ T718] [ 33.318474][ T722] tun1: deleting peer with id 10, reason 1 [ 35.869964][ T770] tun0: deleting peer with id 2, reason 1 [ 35.869982][ T770] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 35.869984][ T770] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 770, name: ovpn-cli [ 35.869986][ T770] preempt_count: 202, expected: 0 [ 35.869987][ T770] RCU nest depth: 0, expected: 0 [ 35.869988][ T770] INFO: lockdep is turned off. [ 35.869996][ T770] irq event stamp: 0 [ 35.869997][ T770] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 35.870001][ T770] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 35.870007][ T770] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 35.870009][ T770] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 35.870011][ T770] Preemption disabled at: [ 35.870012][ T770] [<0000000000000000>] 0x0 [ 35.870017][ T770] CPU: 3 UID: 0 PID: 770 Comm: ovpn-cli Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 35.870020][ T770] Tainted: [W]=WARN [ 35.870021][ T770] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 35.870023][ T770] Call Trace: [ 35.870025][ T770] [ 35.870026][ T770] dump_stack_lvl+0x6f/0xa0 [ 35.870032][ T770] __might_resched.cold+0x1fe/0x2c1 [ 35.870036][ T770] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 35.870039][ T770] ? rcu_is_watching+0x16/0xd0 [ 35.870044][ T770] __kmalloc_noprof+0x443/0x760 [ 35.870047][ T770] ? __rwlock_init+0x150/0x150 [ 35.870050][ T770] ? alloc_buf.isra.0+0x4b/0x260 [ 35.870054][ T770] ? do_raw_spin_unlock+0x59/0x250 [ 35.870056][ T770] alloc_buf.isra.0+0x4b/0x260 [ 35.870058][ T770] put_chars+0x1e1/0x2f0 [ 35.870060][ T770] ? __send_to_port+0x420/0x420 [ 35.870062][ T770] ? printk_get_next_message+0x240/0x650 [ 35.870065][ T770] hvc_console_print+0x292/0x780 [ 35.870069][ T770] ? hvc_write+0x3a0/0x3a0 [ 35.870071][ T770] ? __rwlock_init+0x150/0x150 [ 35.870073][ T770] ? rcu_is_watching+0x16/0xd0 [ 35.870075][ T770] ? lock_acquire+0x13c/0x160 [ 35.870077][ T770] console_emit_next_record+0x22f/0x4c0 [ 35.870079][ T770] ? devkmsg_read+0x4b0/0x4b0 [ 35.870082][ T770] ? rcu_is_watching+0x16/0xd0 [ 35.870083][ T770] ? rcu_is_watching+0x16/0xd0 [ 35.870085][ T770] ? rcu_is_watching+0x16/0xd0 [ 35.870086][ T770] ? lock_acquire+0x13c/0x160 [ 35.870088][ T770] ? console_flush_one_record+0x111/0x710 [ 35.870090][ T770] console_flush_one_record+0x46f/0x710 [ 35.870093][ T770] ? console_emit_next_record+0x4c0/0x4c0 [ 35.870095][ T770] console_unlock+0xee/0x1f0 [ 35.870097][ T770] ? lock_acquire+0x13c/0x160 [ 35.870099][ T770] ? console_flush_one_record+0x710/0x710 [ 35.870100][ T770] ? rcu_is_watching+0x16/0xd0 [ 35.870102][ T770] ? lock_release+0x184/0x1f0 [ 35.870103][ T770] ? lock_acquire+0x60/0x160 [ 35.870105][ T770] ? __rcu_read_lock+0x30/0x70 [ 35.870107][ T770] ? __down_trylock_console_sem+0x5e/0xa0 [ 35.870109][ T770] ? vprintk_emit+0x320/0x3e0 [ 35.870111][ T770] vprintk_emit+0x37c/0x3e0 [ 35.870113][ T770] ? wake_up_klogd_work_func+0x90/0x90 [ 35.870115][ T770] ? kernel_text_address+0x149/0x170 [ 35.870117][ T770] ? __kernel_text_address+0x12/0x30 [ 35.870119][ T770] ? write_profile+0xf0/0xf0 [ 35.870121][ T770] ? unwind_get_return_address+0x67/0xd0 [ 35.870124][ T770] _printk+0xc7/0x100 [ 35.870127][ T770] ? snapshot_read.cold+0x21/0x21 [ 35.870129][ T770] ? netdev_name+0x43/0x60 [ 35.870132][ T770] ? __netdev_printk+0x17f/0x1d0 [ 35.870134][ T770] netdev_info+0xe2/0x116 [ 35.870136][ T770] ? netdev_notice+0x120/0x120 [ 35.870137][ T770] ? ovpn_nl_pre_doit+0x44/0x90 [ovpn] [ 35.870143][ T770] ? __module_address+0x36/0x330 [ 35.870146][ T770] ? lock_acquire+0x13c/0x160 [ 35.870148][ T770] ? rcu_is_watching+0x16/0xd0 [ 35.870150][ T770] ? lock_release+0x184/0x1f0 [ 35.870152][ T770] ? ovpn_peer_get_by_id+0x38a/0x7a0 [ovpn] [ 35.870155][ T770] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 35.870159][ T770] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 35.870162][ T770] ? lock_acquire+0x13c/0x160 [ 35.870164][ T770] ? rcu_is_watching+0x16/0xd0 [ 35.870165][ T770] ? lock_release+0x184/0x1f0 [ 35.870167][ T770] ovpn_peer_remove+0x394/0x640 [ovpn] [ 35.870170][ T770] ? do_raw_spin_lock+0x131/0x280 [ 35.870172][ T770] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 35.870175][ T770] ovpn_peer_del+0x1e5/0x590 [ovpn] [ 35.870178][ T770] ? ovpn_peer_add+0x330/0x330 [ovpn] [ 35.870182][ T770] ovpn_nl_peer_del_doit+0x25c/0x6c0 [ovpn] [ 35.870185][ T770] ? trace_hardirqs_on+0x36/0x40 [ 35.870187][ T770] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 35.870190][ T770] ? ref_tracker_alloc+0x28d/0x430 [ 35.870195][ T770] ? lock_release+0x184/0x1f0 [ 35.870197][ T770] ? ovpn_get_dev_from_attrs+0x17a/0x660 [ovpn] [ 35.870200][ T770] genl_family_rcv_msg_doit+0x206/0x300 [ 35.870204][ T770] ? genl_family_rcv_msg_attrs_parse.isra.0+0x330/0x330 [ 35.870206][ T770] ? rcu_is_watching+0x16/0xd0 [ 35.870209][ T770] ? rcu_is_watching+0x16/0xd0 [ 35.870211][ T770] ? cap_capable+0x1d7/0x3d0 [ 35.870214][ T770] ? write_profile+0xf0/0xf0 [ 35.870215][ T770] ? unwind_get_return_address+0x67/0xd0 [ 35.870217][ T770] genl_family_rcv_msg+0x3a4/0x640 [ 35.870219][ T770] ? genl_family_rcv_msg_dumpit+0x340/0x340 [ 35.870221][ T770] ? ovpn_nl_send_peer+0x1300/0x1300 [ovpn] [ 35.870224][ T770] ? ovpn_nl_peer_get_dumpit+0xa40/0xa40 [ovpn] [ 35.870226][ T770] ? ovpn_nl_pre_doit+0x90/0x90 [ovpn] [ 35.870229][ T770] ? filter_irq_stacks+0xd0/0xd0 [ 35.870231][ T770] ? stack_depot_save_flags+0x1bc/0x790 [ 35.870233][ T770] genl_rcv_msg+0xbb/0x160 [ 35.870235][ T770] netlink_rcv_skb+0x14e/0x3a0 [ 35.870237][ T770] ? genl_family_rcv_msg+0x640/0x640 [ 35.870239][ T770] ? netlink_ack+0xcf0/0xcf0 [ 35.870242][ T770] ? lock_acquire+0x13c/0x160 [ 35.870243][ T770] ? rcu_is_watching+0x16/0xd0 [ 35.870245][ T770] ? lock_release+0x184/0x1f0 [ 35.870247][ T770] genl_rcv+0x28/0x40 [ 35.870249][ T770] netlink_unicast+0x486/0x750 [ 35.870252][ T770] ? netlink_attachskb+0x810/0x810 [ 35.870253][ T770] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 35.870255][ T770] ? trace_hardirqs_on+0x36/0x40 [ 35.870256][ T770] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 35.870260][ T770] netlink_sendmsg+0x735/0xc60 [ 35.870262][ T770] ? netlink_unicast+0x750/0x750 [ 35.870264][ T770] ? rcu_is_watching+0x16/0xd0 [ 35.870266][ T770] ? lock_release+0x184/0x1f0 [ 35.870268][ T770] ____sys_sendmsg+0x415/0x880 [ 35.870271][ T770] ? copy_msghdr_from_user+0x279/0x420 [ 35.870273][ T770] ? get_timestamp.constprop.0+0x390/0x390 [ 35.870275][ T770] ? move_addr_to_kernel+0x40/0x40 [ 35.870278][ T770] ___sys_sendmsg+0x14e/0x1d0 [ 35.870280][ T770] ? copy_msghdr_from_user+0x420/0x420 [ 35.870281][ T770] ? kfree+0x22/0x590 [ 35.870286][ T770] __sys_sendmsg+0x12c/0x1d0 [ 35.870289][ T770] ? __sys_sendmsg_sock+0x20/0x20 [ 35.870291][ T770] ? rcu_is_watching+0x16/0xd0 [ 35.870293][ T770] ? rcu_is_watching+0x16/0xd0 [ 35.870295][ T770] do_syscall_64+0xff/0x530 [ 35.870298][ T770] ? exc_page_fault+0xee/0x100 [ 35.870300][ T770] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 35.870302][ T770] RIP: 0033:0x7fd45bd8754e [ 35.870304][ T770] 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.870306][ T770] RSP: 002b:00007ffe263b5870 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 35.870309][ T770] RAX: ffffffffffffffda RBX: 000000003beae130 RCX: 00007fd45bd8754e [ 35.870311][ T770] RDX: 0000000000000000 RSI: 00007ffe263b5910 RDI: 0000000000000005 [ 35.870312][ T770] RBP: 00007ffe263b5880 R08: 0000000000000000 R09: 0000000000000000 [ 35.870312][ T770] R10: 0000000000000000 R11: 0000000000000202 R12: 000000003beae200 [ 35.870313][ T770] R13: 00007ffe263b5910 R14: 000000003beaf260 R15: 000000000040bda8 [ 35.870316][ T770] [ 35.951397][ T774] tun2: deleting peer with id 11, reason 1 [ 41.661707][ T67] tun0: deleting peer with id 4, reason 2 [ 41.661727][ T67] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 41.661730][ T67] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 67, name: kworker/2:2 [ 41.661732][ T67] preempt_count: 202, expected: 0 [ 41.661732][ T67] RCU nest depth: 0, expected: 0 [ 41.661733][ T67] INFO: lockdep is turned off. [ 41.661734][ T67] irq event stamp: 18376 [ 41.661735][ T67] hardirqs last enabled at (18375): [] _raw_spin_unlock_irq+0x28/0x50 [ 41.661743][ T67] hardirqs last disabled at (18376): [] __schedule+0x1246/0x20e0 [ 41.661746][ T67] softirqs last enabled at (17612): [] handle_softirqs+0x67c/0x900 [ 41.661750][ T67] softirqs last disabled at (17573): [] do_softirq+0xac/0xe0 [ 41.661752][ T67] Preemption disabled at: [ 41.661753][ T67] [<0000000000000000>] 0x0 [ 41.661761][ T67] CPU: 2 UID: 0 PID: 67 Comm: kworker/2:2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 41.661764][ T67] Tainted: [W]=WARN [ 41.661765][ T67] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 41.661768][ T67] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 41.661777][ T67] Call Trace: [ 41.661779][ T67] [ 41.661781][ T67] dump_stack_lvl+0x6f/0xa0 [ 41.661786][ T67] __might_resched.cold+0x1fe/0x2c1 [ 41.661790][ T67] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 41.661793][ T67] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 41.661796][ T67] ? rcu_is_watching+0x16/0xd0 [ 41.661800][ T67] __kmalloc_noprof+0x443/0x760 [ 41.661803][ T67] ? __rwlock_init+0x150/0x150 [ 41.661806][ T67] ? alloc_buf.isra.0+0x4b/0x260 [ 41.661810][ T67] ? do_raw_spin_unlock+0x59/0x250 [ 41.661811][ T67] alloc_buf.isra.0+0x4b/0x260 [ 41.661814][ T67] put_chars+0x1e1/0x2f0 [ 41.661815][ T67] ? prb_final_commit+0x50/0x50 [ 41.661817][ T67] ? __send_to_port+0x420/0x420 [ 41.661819][ T67] ? printk_get_next_message+0x240/0x650 [ 41.661822][ T67] hvc_console_print+0x292/0x780 [ 41.661826][ T67] ? hvc_write+0x3a0/0x3a0 [ 41.661827][ T67] ? do_raw_spin_lock+0x131/0x280 [ 41.661829][ T67] ? vsnprintf+0x527/0x1700 [ 41.661831][ T67] ? __rwlock_init+0x150/0x150 [ 41.661832][ T67] ? rcu_is_watching+0x16/0xd0 [ 41.661834][ T67] ? lock_acquire+0x13c/0x160 [ 41.661836][ T67] console_emit_next_record+0x22f/0x4c0 [ 41.661839][ T67] ? devkmsg_read+0x4b0/0x4b0 [ 41.661841][ T67] ? rcu_is_watching+0x16/0xd0 [ 41.661843][ T67] ? rcu_is_watching+0x16/0xd0 [ 41.661844][ T67] ? rcu_is_watching+0x16/0xd0 [ 41.661846][ T67] ? lock_acquire+0x13c/0x160 [ 41.661848][ T67] ? console_flush_one_record+0x111/0x710 [ 41.661850][ T67] console_flush_one_record+0x46f/0x710 [ 41.661852][ T67] ? console_emit_next_record+0x4c0/0x4c0 [ 41.661854][ T67] console_unlock+0xee/0x1f0 [ 41.661856][ T67] ? lock_acquire+0x13c/0x160 [ 41.661858][ T67] ? console_flush_one_record+0x710/0x710 [ 41.661859][ T67] ? rcu_is_watching+0x16/0xd0 [ 41.661861][ T67] ? lock_release+0x184/0x1f0 [ 41.661862][ T67] ? lock_acquire+0x60/0x160 [ 41.661864][ T67] ? __rcu_read_lock+0x30/0x70 [ 41.661866][ T67] ? __down_trylock_console_sem+0x5e/0xa0 [ 41.661867][ T67] ? vprintk_emit+0x320/0x3e0 [ 41.661869][ T67] vprintk_emit+0x37c/0x3e0 [ 41.661872][ T67] ? wake_up_klogd_work_func+0x90/0x90 [ 41.661874][ T67] ? arch_stack_walk+0xd7/0x130 [ 41.661878][ T67] _printk+0xc7/0x100 [ 41.661881][ T67] ? snapshot_read.cold+0x21/0x21 [ 41.661883][ T67] ? stack_trace_save+0x93/0xc0 [ 41.661885][ T67] ? filter_irq_stacks+0xd0/0xd0 [ 41.661886][ T67] ? netdev_name+0x43/0x60 [ 41.661889][ T67] ? __netdev_printk+0x17f/0x1d0 [ 41.661891][ T67] netdev_info+0xe2/0x116 [ 41.661892][ T67] ? netdev_notice+0x120/0x120 [ 41.661894][ T67] ? kasan_save_track+0x14/0x30 [ 41.661897][ T67] ? kmem_cache_free+0xf8/0x550 [ 41.661898][ T67] ? free_object_list.isra.0+0x1b6/0x310 [ 41.661902][ T67] ? kthread+0x367/0x460 [ 41.661905][ T67] ? ret_from_fork+0x474/0x6b0 [ 41.661906][ T67] ? ret_from_fork_asm+0x11/0x20 [ 41.661909][ T67] ? trace_irq_enable.constprop.0+0x30/0x160 [ 41.661912][ T67] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 41.661916][ T67] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 41.661920][ T67] ovpn_peer_remove+0x394/0x640 [ovpn] [ 41.661923][ T67] ? do_raw_spin_lock+0x131/0x280 [ 41.661925][ T67] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 41.661927][ T67] ? __rwlock_init+0x150/0x150 [ 41.661929][ T67] ? rcu_is_watching+0x16/0xd0 [ 41.661931][ T67] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 41.661932][ T67] ? trace_irq_disable.constprop.0+0x9b/0x160 [ 41.661933][ T67] ovpn_peer_keepalive_work_single+0x416/0x600 [ovpn] [ 41.661936][ T67] ? ovpn_peers_release_mp+0x490/0x490 [ovpn] [ 41.661938][ T67] ? __rwlock_init+0x150/0x150 [ 41.661941][ T67] ovpn_peer_keepalive_work+0x253/0x580 [ovpn] [ 41.661944][ T67] ? ovpn_peers_free+0xb0/0xb0 [ovpn] [ 41.661946][ T67] ? rcu_is_watching+0x16/0xd0 [ 41.661948][ T67] ? lock_acquire+0x13c/0x160 [ 41.661949][ T67] ? rcu_is_watching+0x16/0xd0 [ 41.661952][ T67] process_one_work+0xe3e/0x1560 [ 41.661955][ T67] ? __queue_delayed_work+0x470/0x470 [ 41.661957][ T67] ? find_held_lock+0x2b/0x80 [ 41.661959][ T67] ? __rwlock_init+0x150/0x150 [ 41.661961][ T67] worker_thread+0x4f1/0xd60 [ 41.661964][ T67] ? rescuer_thread+0x1340/0x1340 [ 41.661965][ T67] ? __kthread_parkme+0xbd/0x210 [ 41.661967][ T67] ? rescuer_thread+0x1340/0x1340 [ 41.661969][ T67] ? rescuer_thread+0x1340/0x1340 [ 41.661970][ T67] kthread+0x367/0x460 [ 41.661972][ T67] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 41.661973][ T67] ? kthread_affine_preferred+0x4c0/0x4c0 [ 41.661975][ T67] ret_from_fork+0x474/0x6b0 [ 41.661976][ T67] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 41.661978][ T67] ? __switch_to+0x5a3/0xe00 [ 41.661981][ T67] ? kthread_affine_preferred+0x4c0/0x4c0 [ 41.661982][ T67] ret_from_fork_asm+0x11/0x20 [ 41.661985][ T67] [ 41.684849][ T67] tun0: deleting peer with id 3, reason 2 [ 41.685075][ T67] tun0: deleting peer with id 5, reason 2 [ 41.685289][ T67] tun0: deleting peer with id 6, reason 2 [ 46.781739][ T67] tun3: deleting peer with id 12, reason 2 [ 46.781758][ T67] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 46.781761][ T67] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 67, name: kworker/2:2 [ 46.781763][ T67] preempt_count: 202, expected: 0 [ 46.781764][ T67] RCU nest depth: 0, expected: 0 [ 46.781765][ T67] INFO: lockdep is turned off. [ 46.781766][ T67] irq event stamp: 18376 [ 46.781767][ T67] hardirqs last enabled at (18375): [] _raw_spin_unlock_irq+0x28/0x50 [ 46.781775][ T67] hardirqs last disabled at (18376): [] __schedule+0x1246/0x20e0 [ 46.781778][ T67] softirqs last enabled at (17612): [] handle_softirqs+0x67c/0x900 [ 46.781782][ T67] softirqs last disabled at (17573): [] do_softirq+0xac/0xe0 [ 46.781784][ T67] Preemption disabled at: [ 46.781785][ T67] [<0000000000000000>] 0x0 [ 46.781793][ T67] CPU: 2 UID: 0 PID: 67 Comm: kworker/2:2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 46.781796][ T67] Tainted: [W]=WARN [ 46.781797][ T67] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 46.781799][ T67] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 46.781807][ T67] Call Trace: [ 46.781809][ T67] [ 46.781811][ T67] dump_stack_lvl+0x6f/0xa0 [ 46.781816][ T67] __might_resched.cold+0x1fe/0x2c1 [ 46.781820][ T67] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 46.781824][ T67] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 46.781826][ T67] ? rcu_is_watching+0x16/0xd0 [ 46.781830][ T67] __kmalloc_noprof+0x443/0x760 [ 46.781833][ T67] ? __rwlock_init+0x150/0x150 [ 46.781836][ T67] ? alloc_buf.isra.0+0x4b/0x260 [ 46.781840][ T67] ? do_raw_spin_unlock+0x59/0x250 [ 46.781842][ T67] alloc_buf.isra.0+0x4b/0x260 [ 46.781844][ T67] put_chars+0x1e1/0x2f0 [ 46.781846][ T67] ? prb_final_commit+0x50/0x50 [ 46.781847][ T67] ? __send_to_port+0x420/0x420 [ 46.781849][ T67] ? printk_get_next_message+0x240/0x650 [ 46.781852][ T67] hvc_console_print+0x292/0x780 [ 46.781856][ T67] ? hvc_write+0x3a0/0x3a0 [ 46.781858][ T67] ? do_raw_spin_lock+0x131/0x280 [ 46.781859][ T67] ? vsnprintf+0x527/0x1700 [ 46.781861][ T67] ? __rwlock_init+0x150/0x150 [ 46.781863][ T67] ? rcu_is_watching+0x16/0xd0 [ 46.781865][ T67] ? lock_acquire+0x13c/0x160 [ 46.781867][ T67] console_emit_next_record+0x22f/0x4c0 [ 46.781870][ T67] ? devkmsg_read+0x4b0/0x4b0 [ 46.781872][ T67] ? rcu_is_watching+0x16/0xd0 [ 46.781874][ T67] ? rcu_is_watching+0x16/0xd0 [ 46.781875][ T67] ? rcu_is_watching+0x16/0xd0 [ 46.781877][ T67] ? lock_acquire+0x13c/0x160 [ 46.781879][ T67] ? console_flush_one_record+0x111/0x710 [ 46.781880][ T67] console_flush_one_record+0x46f/0x710 [ 46.781883][ T67] ? console_emit_next_record+0x4c0/0x4c0 [ 46.781885][ T67] console_unlock+0xee/0x1f0 [ 46.781887][ T67] ? lock_acquire+0x13c/0x160 [ 46.781889][ T67] ? console_flush_one_record+0x710/0x710 [ 46.781890][ T67] ? rcu_is_watching+0x16/0xd0 [ 46.781892][ T67] ? lock_release+0x184/0x1f0 [ 46.781893][ T67] ? lock_acquire+0x60/0x160 [ 46.781895][ T67] ? __rcu_read_lock+0x30/0x70 [ 46.781897][ T67] ? __down_trylock_console_sem+0x5e/0xa0 [ 46.781899][ T67] ? vprintk_emit+0x320/0x3e0 [ 46.781901][ T67] vprintk_emit+0x37c/0x3e0 [ 46.781903][ T67] ? wake_up_klogd_work_func+0x90/0x90 [ 46.781905][ T67] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 46.781907][ T67] ? rcu_is_watching+0x16/0xd0 [ 46.781908][ T67] ? trace_sched_wakeup+0x9b/0x160 [ 46.781911][ T67] _printk+0xc7/0x100 [ 46.781914][ T67] ? snapshot_read.cold+0x21/0x21 [ 46.781915][ T67] ? try_to_wake_up+0x153/0x1130 [ 46.781917][ T67] ? select_fallback_rq+0x510/0x510 [ 46.781919][ T67] ? netdev_name+0x43/0x60 [ 46.781922][ T67] ? __netdev_printk+0x17f/0x1d0 [ 46.781923][ T67] netdev_info+0xe2/0x116 [ 46.781925][ T67] ? netdev_notice+0x120/0x120 [ 46.781927][ T67] ? rcu_is_watching+0x16/0xd0 [ 46.781929][ T67] ? __queue_work+0x3ab/0xd30 [ 46.781933][ T67] ? trace_irq_enable.constprop.0+0x30/0x160 [ 46.781936][ T67] ovpn_nl_peer_del_notify+0x115/0x503 [ovpn] [ 46.781939][ T67] ? ovpn_nl_key_new_doit.cold+0x24/0x24 [ovpn] [ 46.781942][ T67] ? rcu_is_watching+0x16/0xd0 [ 46.781944][ T67] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 46.781946][ T67] ovpn_peer_remove+0x394/0x640 [ovpn] [ 46.781949][ T67] ? do_raw_spin_lock+0x131/0x280 [ 46.781950][ T67] ? __ovpn_peer_hash_transp_addr+0x650/0x650 [ovpn] [ 46.781953][ T67] ? __rwlock_init+0x150/0x150 [ 46.781955][ T67] ? rcu_is_watching+0x16/0xd0 [ 46.781956][ T67] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 46.781957][ T67] ? trace_irq_disable.constprop.0+0x9b/0x160 [ 46.781959][ T67] ovpn_peer_keepalive_work_single+0x416/0x600 [ovpn] [ 46.781962][ T67] ? ovpn_peers_release_mp+0x490/0x490 [ovpn] [ 46.781964][ T67] ? __rwlock_init+0x150/0x150 [ 46.781967][ T67] ovpn_peer_keepalive_work+0x389/0x580 [ovpn] [ 46.781970][ T67] ? ovpn_peers_free+0xb0/0xb0 [ovpn] [ 46.781972][ T67] ? rcu_is_watching+0x16/0xd0 [ 46.781974][ T67] ? lock_acquire+0x13c/0x160 [ 46.781976][ T67] ? rcu_is_watching+0x16/0xd0 [ 46.781978][ T67] ? process_one_work+0xdfc/0x1560 [ 46.781980][ T67] process_one_work+0xe3e/0x1560 [ 46.781982][ T67] ? __queue_delayed_work+0x470/0x470 [ 46.781984][ T67] ? find_held_lock+0x2b/0x80 [ 46.781986][ T67] ? __rwlock_init+0x150/0x150 [ 46.781989][ T67] worker_thread+0x4f1/0xd60 [ 46.781991][ T67] ? rescuer_thread+0x1340/0x1340 [ 46.781993][ T67] ? __kthread_parkme+0xbd/0x210 [ 46.781995][ T67] ? rescuer_thread+0x1340/0x1340 [ 46.781997][ T67] ? rescuer_thread+0x1340/0x1340 [ 46.781998][ T67] kthread+0x367/0x460 [ 46.782000][ T67] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 46.782001][ T67] ? kthread_affine_preferred+0x4c0/0x4c0 [ 46.782003][ T67] ret_from_fork+0x474/0x6b0 [ 46.782005][ T67] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 46.782007][ T67] ? __switch_to+0x5a3/0xe00 [ 46.782010][ T67] ? kthread_affine_preferred+0x4c0/0x4c0 [ 46.782011][ T67] ret_from_fork_asm+0x11/0x20 [ 46.782015][ T67] [ 46.844724][ T50] tun5: deleting peer with id 14, reason 2 [ 46.845026][ T210] tun4: deleting peer with id 13, reason 2 [ 46.908716][ T67] tun6: deleting peer with id 15, reason 2