======================================
| [ 18.194650][ C0]
| [ 18.194650][ C0]
| [ 18.194650][ C0] stack backtrace:
| [ 18.194656][ C0] Tainted: [W]=WARN
[ 18.194656][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011
[ 18.194658][ C0] Call Trace:
[ 18.194659][ C0]
[ 18.194660][ C0] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120)
[ 18.194664][ C0] print_irq_inversion_bug.part.0.cold (kernel/locking/lockdep.c:4141)
[ 18.194667][ C0] mark_lock_irq (kernel/locking/lockdep.c:4095 kernel/locking/lockdep.c:4174 kernel/locking/lockdep.c:4310)
[ 18.194669][ C0] mark_lock (kernel/locking/lockdep.c:4769)
[ 18.194671][ C0] mark_usage (kernel/locking/lockdep.c:4658)
[ 18.194673][ C0] __lock_acquire (kernel/locking/lockdep.c:5208)
[ 18.194675][ C0] lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2))
[ 18.194677][ C0] ? console_lock_spinning_enable (kernel/printk/printk.c:1902 (discriminator 2))
[ 18.194679][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 18.194682][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22))
[ 18.194686][ C0] console_lock_spinning_enable (kernel/printk/printk.c:1902 (discriminator 2))
[ 18.194688][ C0] ? console_lock_spinning_enable (kernel/printk/printk.c:1902 (discriminator 2))
[ 18.194690][ C0] console_emit_next_record (kernel/printk/printk.c:3177)
[ 18.194692][ C0] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20)
[ 18.194694][ C0] ? console_flush_one_record (./include/linux/rcupdate.h:314 (discriminator 2) ./include/linux/srcu.h:439 (discriminator 2) kernel/printk/printk.c:291 (discriminator 2) kernel/printk/printk.c:3246 (discriminator 2))
[ 18.194696][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 18.194697][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22))
[ 18.194699][ C0] console_flush_one_record (kernel/printk/printk.c:3268)
[ 18.194702][ C0] ? console_emit_next_record (kernel/printk/printk.c:3150)
[ 18.194703][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254)
[ 18.194706][ C0] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420)
[ 18.194708][ C0] ? console_flush_one_record (kernel/printk/printk.c:3316)
[ 18.194709][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 18.194711][ C0] ? lock_acquire (kernel/locking/lockdep.c:5913)
[ 18.194713][ C0] ? __down_trylock_console_sem (kernel/printk/printk.c:334)
[ 18.194715][ C0] ? vprintk_emit (kernel/printk/printk.c:2478)
[ 18.194717][ C0] vprintk_emit (kernel/printk/printk.c:2479)
[ 18.194719][ C0] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126))
[ 18.194721][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554)
[ 18.194723][ C0] _printk (kernel/printk/printk.c:2504)
[ 18.194725][ C0] ? snapshot_read.cold (user.c:?)
[ 18.194727][ C0] ? ___ratelimit (lib/ratelimit.c:97 (discriminator 3))
[ 18.194730][ C0] ? ovpn_netdev_write (./include/linux/netdevice.h:3107 (discriminator 3)) ovpn
[ 18.194733][ C0] ? idr_get_free (??:?)
[ 18.194736][ C0] ovpn_recv.cold (drivers/net/ovpn/io.c:225 (discriminator 4)) ovpn
[ 18.194739][ C0] ovpn_tcp_rcv (drivers/net/ovpn/tcp.c:148) ovpn
[ 18.194742][ C0] ? ovpn_tcp_write_space (drivers/net/ovpn/tcp.c:488 (discriminator 2)) ovpn
[ 18.194744][ C0] ? __copy_skb_header (net/core/skbuff.c:1564)
[ 18.194747][ C0] ? ovpn_tcp_disconnect (drivers/net/ovpn/tcp.c:467) ovpn
[ 18.194749][ C0] ? sock_queue_err_skb (net/core/skbuff.c:5498 (discriminator 3))
[ 18.194752][ C0] __strp_recv (net/strparser/strparser.c:309)
[ 18.194755][ C0] __tcp_read_sock (net/ipv4/tcp.c:1689)
[ 18.194756][ C0] ? strp_process (net/strparser/strparser.c:335)
[ 18.194759][ C0] ? __tcp_transmit_skb (net/ipv4/tcp_output.c:1716)
[ 18.194760][ C0] ? tcp_cleanup_rbuf (./include/linux/skbuff.h:2196)
[ 18.194762][ C0] ? mark_usage (kernel/locking/lockdep.c:4690)
[ 18.194764][ C0] strp_read_sock (net/strparser/strparser.c:372)
[ 18.194766][ C0] ? strp_stop (net/strparser/strparser.c:527)
[ 18.194768][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 18.194770][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22))
[ 18.194772][ C0] strp_data_ready (net/strparser/strparser.c:402 net/strparser/strparser.c:380)
[ 18.194774][ C0] ovpn_tcp_data_ready (drivers/net/ovpn/tcp.c:478) ovpn
[ 18.194777][ C0] tcp_rcv_established (net/ipv4/tcp_input.c:6654)
[ 18.194780][ C0] ? __tcp_check_space (net/ipv4/tcp_input.c:6059 (discriminator 2))
[ 18.194781][ C0] ? tcp_v4_rcv (net/ipv4/tcp_ipv4.c:2292 (discriminator 1))
[ 18.194783][ C0] ? do_raw_spin_lock (./include/linux/instrumented.h:55 ./include/linux/atomic/atomic-instrumented.h:1301 ./include/asm-generic/qspinlock.h:112 kernel/locking/spinlock_debug.c:116)
[ 18.194786][ C0] tcp_v4_do_rcv (net/ipv4/tcp_ipv4.c:1862)
[ 18.194788][ C0] tcp_v4_rcv (net/ipv4/tcp_ipv4.c:2296)
[ 18.194790][ C0] ? mark_usage (kernel/locking/lockdep.c:4690)
[ 18.194792][ C0] ? tcp_add_backlog (./include/net/net_namespace.h:422 (discriminator 7))
[ 18.194794][ C0] ? lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2))
[ 18.194796][ C0] ? ip_local_deliver_finish (./include/linux/rcupdate.h:309 (discriminator 2) ./include/linux/rcupdate.h:849 (discriminator 2) net/ipv4/ip_input.c:240 (discriminator 2))
[ 18.194798][ C0] ip_protocol_deliver_rcu (net/ipv4/ip_input.c:207)
[ 18.194800][ C0] ? process_backlog (./include/linux/local_lock_internal.h:62 (discriminator 2) net/core/dev.c:6726 (discriminator 2))
[ 18.194802][ C0] ip_local_deliver_finish (net/ipv4/ip_input.c:241 (discriminator 1))
[ 18.194803][ C0] ip_local_deliver (./include/linux/netfilter.h:325 ./include/linux/netfilter.h:319 net/ipv4/ip_input.c:262)
[ 18.194805][ C0] ? ip_local_deliver_finish (net/ipv4/ip_input.c:232 (discriminator 42))
[ 18.194807][ C0] ? ip_rcv_finish_core (./include/linux/skbuff.h:1162 (discriminator 2) ./include/net/route.h:88 (discriminator 2) net/ipv4/ip_input.c:435 (discriminator 2))
[ 18.194809][ C0] ? process_backlog (./include/linux/local_lock_internal.h:62 (discriminator 2) net/core/dev.c:6726 (discriminator 2))
[ 18.194811][ C0] ip_rcv (./include/linux/netfilter.h:325 ./include/linux/netfilter.h:319 net/ipv4/ip_input.c:612)
[ 18.194813][ C0] ? ip_local_deliver (./include/linux/rcupdate.h:878 (discriminator 3))
[ 18.194814][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 18.194816][ C0] ? mark_usage (kernel/locking/lockdep.c:4690)
[ 18.194818][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254)
[ 18.194819][ C0] ? trace_raw_output_rcu_invoke_kfree_bulk_callback (./include/trace/events/rcu.h:655)
[ 18.194822][ C0] __netif_receive_skb_one_core (net/core/dev.c:6264)
[ 18.194824][ C0] ? lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2))
[ 18.194825][ C0] ? process_backlog (./include/linux/local_lock_internal.h:62 (discriminator 2) net/core/dev.c:6726 (discriminator 2))
[ 18.194827][ C0] ? __netif_receive_skb_list_core (net/core/dev.c:6310)
[ 18.194829][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 18.194831][ C0] process_backlog (net/core/dev.c:6728)
[ 18.194834][ C0] __napi_poll (net/core/dev.c:7787)
[ 18.194836][ C0] net_rx_action (net/core/dev.c:7850 net/core/dev.c:8007)
[ 18.194839][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254)
[ 18.194841][ C0] ? __napi_poll (./include/net/gro.h:507)
[ 18.194844][ C0] ? ktime_get_update_offsets_now (kernel/time/timekeeping.c:304 kernel/time/timekeeping.c:482 kernel/time/timekeeping.c:2859)
[ 18.194847][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 18.194849][ C0] handle_softirqs (kernel/softirq.c:645)
[ 18.194851][ C0] ? _local_bh_enable (kernel/softirq.c:428 (discriminator 1))
[ 18.194853][ C0] ? do_raw_spin_unlock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:32 ./include/asm-generic/qspinlock.h:58 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141)
[ 18.194855][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 18.194857][ C0] do_softirq (kernel/softirq.c:546 (discriminator 19) kernel/softirq.c:533 (discriminator 19))
[ 18.194858][ C0]
[ 18.194859][ C0]
[ 18.194859][ C0] __local_bh_enable_ip (kernel/softirq.c:473)
[ 18.194861][ C0] ovpn_tcp_sendmsg (drivers/net/ovpn/tcp.c:459) ovpn
[ 18.194864][ C0] ? ovpn_tcp_recvmsg (drivers/net/ovpn/tcp.c:180 (discriminator 1)) ovpn
[ 18.194868][ C0] __sys_sendto (net/socket.c:800 (discriminator 4) net/socket.c:815 (discriminator 4) net/socket.c:2281 (discriminator 4))
[ 18.194870][ C0] ? __ia32_sys_getpeername (net/socket.c:2235)
[ 18.194874][ C0] ? fput_close_sync (fs/file_table.c:617)
[ 18.194876][ C0] ? alloc_file_clone (fs/file_table.c:479)
[ 18.194878][ C0] __x64_sys_sendto (net/socket.c:2288 net/socket.c:2284 net/socket.c:2284)
[ 18.194880][ C0] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22))
[ 18.194883][ C0] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488)
[ 18.194884][ C0] ? do_syscall_64 (arch/x86/entry/syscall_64.c:81 (discriminator 44))
[ 18.194885][ C0] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84)
[ 18.194887][ C0] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3))
[ 18.194889][ C0] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121)
[ 18.194890][ C0] RIP: 0033:0x7f2e7d9e454e
[ 18.194893][ C0] 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
All code
========
0: 4d 89 d8 mov %r11,%r8
3: e8 b4 bd 00 00 call 0xbdbc
8: 4c 8b 5d f8 mov -0x8(%rbp),%r11
c: 41 8b 93 08 03 00 00 mov 0x308(%r11),%edx
13: 59 pop %rcx
14: 5e pop %rsi
15: 48 83 f8 fc cmp $0xfffffffffffffffc,%rax
19: 74 11 je 0x2c
1b: c9 leave
1c: c3 ret
1d: 0f 1f 80 00 00 00 00 nopl 0x0(%rax)
24: 48 8b 45 10 mov 0x10(%rbp),%rax
28: 0f 05 syscall
2a:* c9 leave <-- trapping instruction
2b: c3 ret
2c: 83 e2 39 and $0x39,%edx
2f: 83 fa 08 cmp $0x8,%edx
32: 75 e7 jne 0x1b
34: e8 03 ff ff ff call 0xffffffffffffff3c
39: 0f 1f 00 nopl (%rax)
3c: f3 0f 1e fa endbr64
Code starting with the faulting instruction
===========================================
0: c9 leave
1: c3 ret
2: 83 e2 39 and $0x39,%edx
5: 83 fa 08 cmp $0x8,%edx
8: 75 e7 jne 0xfffffffffffffff1
a: e8 03 ff ff ff call 0xffffffffffffff12
f: 0f 1f 00 nopl (%rax)
12: f3 0f 1e fa endbr64
[ 18.194895][ C0] RSP: 002b:00007ffe09d5bc50 EFLAGS: 00000202 ORIG_RAX: 000000000000002c
[ 18.194897][ C0] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f2e7d9e454e
[ 18.194899][ C0] RDX: 00000000000003ea RSI: 00007ffe09d5bcc0 RDI: 0000000000000005
[ 18.194900][ C0] RBP: 00007ffe09d5bc60 R08: 0000000000000000 R09: 0000000000000000
[ 18.194901][ C0] R10: 0000000000004000 R11: 0000000000000202 R12: 00007ffe09d5c5e8
[ 18.194901][ C0] R13: 0000000000000008 R14: 00007f2e7dccf000 R15: 000000000040bda8
| [ 18.194920][ C0] softirqs last disabled at (39003): do_softirq (kernel/softirq.c:546 (discriminator 19) kernel/softirq.c:533 (discriminator 19))
| [ 18.194922][ C0] Preemption disabled at:
| [ 18.194922][ C0] 0x0
| [ 18.194927][ C0] Tainted: [W]=WARN
[ 18.194927][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011
[ 18.194928][ C0] Call Trace:
[ 18.194929][ C0]
[ 18.194929][ C0] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120)
[ 18.194932][ C0] __might_resched.cold (kernel/sched/core.c:9234)
[ 18.194934][ C0] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3))
[ 18.194937][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 18.194940][ C0] __kmalloc_noprof (./include/linux/sched/mm.h:322 (discriminator 2) mm/slub.c:4636 (discriminator 2) mm/slub.c:4974 (discriminator 2) mm/slub.c:5413 (discriminator 2) mm/slub.c:5439 (discriminator 2))
[ 18.194941][ C0] ? __rwlock_init (kernel/locking/spinlock_debug.c:48)
[ 18.194943][ C0] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429)
[ 18.194945][ C0] ? do_raw_spin_unlock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:32 ./include/asm-generic/qspinlock.h:58 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141)
[ 18.194946][ C0] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429)
[ 18.194948][ C0] put_chars (drivers/char/virtio_console.c:1176)
[ 18.194950][ C0] ? __send_to_port (drivers/char/virtio_console.c:654)
[ 18.194953][ C0] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2))
[ 18.194955][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5208)
[ 18.194957][ C0] ? hvc_write (drivers/tty/hvc/hvc_console.c:501)
[ 18.194959][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 18.194961][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22))
[ 18.194963][ C0] console_emit_next_record (kernel/printk/printk.c:3183)
[ 18.194965][ C0] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20)
[ 18.194966][ C0] ? console_flush_one_record (./include/linux/rcupdate.h:314 (discriminator 2) ./include/linux/srcu.h:439 (discriminator 2) kernel/printk/printk.c:291 (discriminator 2) kernel/printk/printk.c:3246 (discriminator 2))
[ 18.194968][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 18.194970][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22))
[ 18.194972][ C0] console_flush_one_record (kernel/printk/printk.c:3268)
[ 18.194974][ C0] ? console_emit_next_record (kernel/printk/printk.c:3150)
[ 18.194976][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254)
[ 18.194978][ C0] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420)
[ 18.194980][ C0] ? console_flush_one_record (kernel/printk/printk.c:3316)
[ 18.194982][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 18.194984][ C0] ? lock_acquire (kernel/locking/lockdep.c:5913)
[ 18.194986][ C0] ? __down_trylock_console_sem (kernel/printk/printk.c:334)
[ 18.194987][ C0] ? vprintk_emit (kernel/printk/printk.c:2478)
[ 18.194989][ C0] vprintk_emit (kernel/printk/printk.c:2479)
[ 18.194991][ C0] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126))
[ 18.194993][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554)
[ 18.194995][ C0] _printk (kernel/printk/printk.c:2504)
[ 18.194997][ C0] ? snapshot_read.cold (user.c:?)
[ 18.194999][ C0] ? ___ratelimit (lib/ratelimit.c:97 (discriminator 3))
[ 18.195001][ C0] ? ovpn_netdev_write (./include/linux/netdevice.h:3107 (discriminator 3)) ovpn
[ 18.195003][ C0] ? idr_get_free (??:?)
[ 18.195005][ C0] ovpn_recv.cold (drivers/net/ovpn/io.c:225 (discriminator 4)) ovpn
[ 18.195008][ C0] ovpn_tcp_rcv (drivers/net/ovpn/tcp.c:148) ovpn
[ 18.195011][ C0] ? ovpn_tcp_write_space (drivers/net/ovpn/tcp.c:488 (discriminator 2)) ovpn
[ 18.195013][ C0] ? __copy_skb_header (net/core/skbuff.c:1564)
[ 18.195015][ C0] ? ovpn_tcp_disconnect (drivers/net/ovpn/tcp.c:467) ovpn
[ 18.195018][ C0] ? sock_queue_err_skb (net/core/skbuff.c:5498 (discriminator 3))
[ 18.195020][ C0] __strp_recv (net/strparser/strparser.c:309)
[ 18.195023][ C0] __tcp_read_sock (net/ipv4/tcp.c:1689)
[ 18.195025][ C0] ? strp_process (net/strparser/strparser.c:335)
[ 18.195027][ C0] ? __tcp_transmit_skb (net/ipv4/tcp_output.c:1716)
[ 18.195028][ C0] ? tcp_cleanup_rbuf (./include/linux/skbuff.h:2196)
[ 18.195030][ C0] ? mark_usage (kernel/locking/lockdep.c:4690)
[ 18.195032][ C0] strp_read_sock (net/strparser/strparser.c:372)
[ 18.195034][ C0] ? strp_stop (net/strparser/strparser.c:527)
[ 18.195036][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 18.195038][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22))
[ 18.195039][ C0] strp_data_ready (net/strparser/strparser.c:402 net/strparser/strparser.c:380)
[ 18.195042][ C0] ovpn_tcp_data_ready (drivers/net/ovpn/tcp.c:478) ovpn
[ 18.195044][ C0] tcp_rcv_established (net/ipv4/tcp_input.c:6654)
[ 18.195047][ C0] ? __tcp_check_space (net/ipv4/tcp_input.c:6059 (discriminator 2))
[ 18.195049][ C0] ? tcp_v4_rcv (net/ipv4/tcp_ipv4.c:2292 (discriminator 1))
[ 18.195051][ C0] ? do_raw_spin_lock (./include/linux/instrumented.h:55 ./include/linux/atomic/atomic-instrumented.h:1301 ./include/asm-generic/qspinlock.h:112 kernel/locking/spinlock_debug.c:116)
[ 18.195053][ C0] tcp_v4_do_rcv (net/ipv4/tcp_ipv4.c:1862)
[ 18.195055][ C0] tcp_v4_rcv (net/ipv4/tcp_ipv4.c:2296)
[ 18.195057][ C0] ? mark_usage (kernel/locking/lockdep.c:4690)
[ 18.195059][ C0] ? tcp_add_backlog (./include/net/net_namespace.h:422 (discriminator 7))
[ 18.195061][ C0] ? lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2))
[ 18.195063][ C0] ? ip_local_deliver_finish (./include/linux/rcupdate.h:309 (discriminator 2) ./include/linux/rcupdate.h:849 (discriminator 2) net/ipv4/ip_input.c:240 (discriminator 2))
[ 18.195065][ C0] ip_protocol_deliver_rcu (net/ipv4/ip_input.c:207)
[ 18.195067][ C0] ? process_backlog (./include/linux/local_lock_internal.h:62 (discriminator 2) net/core/dev.c:6726 (discriminator 2))
[ 18.195069][ C0] ip_local_deliver_finish (net/ipv4/ip_input.c:241 (discriminator 1))
[ 18.195071][ C0] ip_local_deliver (./include/linux/netfilter.h:325 ./include/linux/netfilter.h:319 net/ipv4/ip_input.c:262)
[ 18.195072][ C0] ? ip_local_deliver_finish (net/ipv4/ip_input.c:232 (discriminator 42))
[ 18.195074][ C0] ? ip_rcv_finish_core (./include/linux/skbuff.h:1162 (discriminator 2) ./include/net/route.h:88 (discriminator 2) net/ipv4/ip_input.c:435 (discriminator 2))
[ 18.195076][ C0] ? process_backlog (./include/linux/local_lock_internal.h:62 (discriminator 2) net/core/dev.c:6726 (discriminator 2))
[ 18.195078][ C0] ip_rcv (./include/linux/netfilter.h:325 ./include/linux/netfilter.h:319 net/ipv4/ip_input.c:612)
[ 18.195080][ C0] ? ip_local_deliver (./include/linux/rcupdate.h:878 (discriminator 3))
[ 18.195081][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 18.195083][ C0] ? mark_usage (kernel/locking/lockdep.c:4690)
[ 18.195085][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254)
[ 18.195086][ C0] ? trace_raw_output_rcu_invoke_kfree_bulk_callback (./include/trace/events/rcu.h:655)
[ 18.195088][ C0] __netif_receive_skb_one_core (net/core/dev.c:6264)
[ 18.195090][ C0] ? lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2))
[ 18.195092][ C0] ? process_backlog (./include/linux/local_lock_internal.h:62 (discriminator 2) net/core/dev.c:6726 (discriminator 2))
[ 18.195093][ C0] ? __netif_receive_skb_list_core (net/core/dev.c:6310)
[ 18.195095][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 18.195098][ C0] process_backlog (net/core/dev.c:6728)
[ 18.195101][ C0] __napi_poll (net/core/dev.c:7787)
[ 18.195103][ C0] net_rx_action (net/core/dev.c:7850 net/core/dev.c:8007)
[ 18.195105][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254)
[ 18.195107][ C0] ? __napi_poll (./include/net/gro.h:507)
[ 18.195110][ C0] ? ktime_get_update_offsets_now (kernel/time/timekeeping.c:304 kernel/time/timekeeping.c:482 kernel/time/timekeeping.c:2859)
[ 18.195112][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 18.195114][ C0] handle_softirqs (kernel/softirq.c:645)
[ 18.195117][ C0] ? _local_bh_enable (kernel/softirq.c:428 (discriminator 1))
[ 18.195118][ C0] ? do_raw_spin_unlock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:32 ./include/asm-generic/qspinlock.h:58 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141)
[ 18.195119][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 18.195122][ C0] do_softirq (kernel/softirq.c:546 (discriminator 19) kernel/softirq.c:533 (discriminator 19))
[ 18.195123][ C0]
[ 18.195124][ C0]
[ 18.195124][ C0] __local_bh_enable_ip (kernel/softirq.c:473)
[ 18.195126][ C0] ovpn_tcp_sendmsg (drivers/net/ovpn/tcp.c:459) ovpn
[ 18.195129][ C0] ? ovpn_tcp_recvmsg (drivers/net/ovpn/tcp.c:180 (discriminator 1)) ovpn
[ 18.195132][ C0] __sys_sendto (net/socket.c:800 (discriminator 4) net/socket.c:815 (discriminator 4) net/socket.c:2281 (discriminator 4))
[ 18.195134][ C0] ? __ia32_sys_getpeername (net/socket.c:2235)
[ 18.195138][ C0] ? fput_close_sync (fs/file_table.c:617)
[ 18.195139][ C0] ? alloc_file_clone (fs/file_table.c:479)
[ 18.195141][ C0] __x64_sys_sendto (net/socket.c:2288 net/socket.c:2284 net/socket.c:2284)
[ 18.195143][ C0] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22))
[ 18.195144][ C0] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488)
[ 18.195145][ C0] ? do_syscall_64 (arch/x86/entry/syscall_64.c:81 (discriminator 44))
[ 18.195147][ C0] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84)
[ 18.195149][ C0] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3))
[ 18.195150][ C0] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121)
[ 18.195151][ C0] RIP: 0033:0x7f2e7d9e454e
[ 18.195153][ C0] 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
All code
========
0: 4d 89 d8 mov %r11,%r8
3: e8 b4 bd 00 00 call 0xbdbc
8: 4c 8b 5d f8 mov -0x8(%rbp),%r11
c: 41 8b 93 08 03 00 00 mov 0x308(%r11),%edx
13: 59 pop %rcx
14: 5e pop %rsi
15: 48 83 f8 fc cmp $0xfffffffffffffffc,%rax
19: 74 11 je 0x2c
1b: c9 leave
1c: c3 ret
1d: 0f 1f 80 00 00 00 00 nopl 0x0(%rax)
24: 48 8b 45 10 mov 0x10(%rbp),%rax
28: 0f 05 syscall
2a:* c9 leave <-- trapping instruction
2b: c3 ret
2c: 83 e2 39 and $0x39,%edx
2f: 83 fa 08 cmp $0x8,%edx
32: 75 e7 jne 0x1b
34: e8 03 ff ff ff call 0xffffffffffffff3c
39: 0f 1f 00 nopl (%rax)
3c: f3 0f 1e fa endbr64
Code starting with the faulting instruction
===========================================
0: c9 leave
1: c3 ret
2: 83 e2 39 and $0x39,%edx
5: 83 fa 08 cmp $0x8,%edx
8: 75 e7 jne 0xfffffffffffffff1
a: e8 03 ff ff ff call 0xffffffffffffff12
f: 0f 1f 00 nopl (%rax)
12: f3 0f 1e fa endbr64
[ 18.195154][ C0] RSP: 002b:00007ffe09d5bc50 EFLAGS: 00000202 ORIG_RAX: 000000000000002c
[ 18.195155][ C0] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f2e7d9e454e
[ 18.195156][ C0] RDX: 00000000000003ea RSI: 00007ffe09d5bcc0 RDI: 0000000000000005
[ 18.195157][ C0] RBP: 00007ffe09d5bc60 R08: 0000000000000000 R09: 0000000000000000
[ 18.195157][ C0] R10: 0000000000004000 R11: 0000000000000202 R12: 00007ffe09d5c5e8
[ 18.195158][ C0] R13: 0000000000000008 R14: 00007f2e7dccf000 R15: 000000000040bda8
| [ 23.911256][ T479] softirqs last disabled at (0): 0x0
| [ 23.911258][ T479] Preemption disabled at:
| [ 23.911259][ T479] 0x0
| [ 23.911267][ T479] Tainted: [W]=WARN
[ 23.911268][ T479] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011
[ 23.911270][ T479] Call Trace:
[ 23.911271][ T479]
[ 23.911272][ T479] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120)
[ 23.911278][ T479] __might_resched.cold (kernel/sched/core.c:9234)
[ 23.911282][ T479] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3))
[ 23.911286][ T479] ? prb_next_reserve_seq (kernel/printk/printk_ringbuffer.c:2128)
[ 23.911288][ T479] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 23.911292][ T479] __kmalloc_noprof (./include/linux/sched/mm.h:322 (discriminator 2) mm/slub.c:4636 (discriminator 2) mm/slub.c:4974 (discriminator 2) mm/slub.c:5413 (discriminator 2) mm/slub.c:5439 (discriminator 2))
[ 23.911295][ T479] ? __rwlock_init (kernel/locking/spinlock_debug.c:48)
[ 23.911297][ T479] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429)
[ 23.911302][ T479] ? do_raw_spin_unlock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:32 ./include/asm-generic/qspinlock.h:58 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141)
[ 23.911303][ T479] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429)
[ 23.911305][ T479] put_chars (drivers/char/virtio_console.c:1176)
[ 23.911307][ T479] ? prb_final_commit (kernel/printk/printk_ringbuffer.c:1842)
[ 23.911309][ T479] ? __send_to_port (drivers/char/virtio_console.c:654)
[ 23.911310][ T479] ? printk_get_next_message (kernel/printk/printk.c:3072)
[ 23.911313][ T479] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2))
[ 23.911317][ T479] ? hvc_write (drivers/tty/hvc/hvc_console.c:501)
[ 23.911318][ T479] ? do_raw_spin_lock (./include/linux/instrumented.h:55 ./include/linux/atomic/atomic-instrumented.h:1301 ./include/asm-generic/qspinlock.h:112 kernel/locking/spinlock_debug.c:116)
[ 23.911320][ T479] ? vsnprintf (lib/vsprintf.c:2900)
[ 23.911322][ T479] ? __rwlock_init (kernel/locking/spinlock_debug.c:48)
[ 23.911324][ T479] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 23.911326][ T479] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22))
[ 23.911328][ T479] console_emit_next_record (kernel/printk/printk.c:3183)
[ 23.911331][ T479] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20)
[ 23.911332][ T479] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 23.911334][ T479] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 23.911335][ T479] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 23.911337][ T479] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22))
[ 23.911339][ T479] ? console_flush_one_record (kernel/printk/printk.c:3247)
[ 23.911341][ T479] console_flush_one_record (kernel/printk/printk.c:3268)
[ 23.911343][ T479] ? console_emit_next_record (kernel/printk/printk.c:3150)
[ 23.911345][ T479] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420)
[ 23.911347][ T479] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22))
[ 23.911349][ T479] ? console_flush_one_record (kernel/printk/printk.c:3316)
[ 23.911350][ T479] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3))
[ 23.911352][ T479] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22))
[ 23.911353][ T479] ? lock_acquire (kernel/locking/lockdep.c:5913)
[ 23.911354][ T479] ? __rcu_read_lock (kernel/rcu/tree_plugin.h:391 (discriminator 6) kernel/rcu/tree_plugin.h:414 (discriminator 6))
[ 23.911356][ T479] ? __down_trylock_console_sem (kernel/printk/printk.c:334)
[ 23.911358][ T479] ? vprintk_emit (kernel/printk/printk.c:2478)
[ 23.911360][ T479] vprintk_emit (kernel/printk/printk.c:2479)
[ 23.911362][ T479] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126))
[ 23.911365][ T479] _printk (kernel/printk/printk.c:2504)
[ 23.911367][ T479] ? snapshot_read.cold (user.c:?)
[ 23.911369][ T479] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22))
[ 23.911372][ T479] ? do_raw_spin_lock (./include/linux/instrumented.h:55 ./include/linux/atomic/atomic-instrumented.h:1301 ./include/asm-generic/qspinlock.h:112 kernel/locking/spinlock_debug.c:116)
[ 23.911373][ T479] ? __rwlock_init (kernel/locking/spinlock_debug.c:48)
[ 23.911375][ T479] ? do_raw_spin_lock (./include/linux/instrumented.h:55 ./include/linux/atomic/atomic-instrumented.h:1301 ./include/asm-generic/qspinlock.h:112 kernel/locking/spinlock_debug.c:116)
[ 23.911377][ T479] do_exit.cold (kernel/exit.c:889 (discriminator 4) kernel/exit.c:1043 (discriminator 4))
[ 23.911380][ T479] ? exit_notify (kernel/exit.c:780)
[ 23.911382][ T479] __x64_sys_exit (kernel/exit.c:1118 kernel/exit.c:1116 kernel/exit.c:1116)
[ 23.911384][ T479] x64_sys_call (./arch/x86/include/generated/asm/syscalls_64.h:61)
[ 23.911386][ T479] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84)
[ 23.911388][ T479] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3))
[ 23.911390][ T479] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121)
[ 23.911392][ T479] RIP: 0033:0x7f6df331bc49
[ 23.911394][ T479] Code: Unable to access opcode bytes at 0x7f6df331bc1f.
Code starting with the faulting instruction
===========================================
[ 23.911395][ T479] RSP: 002b:00007f6df2adae60 EFLAGS: 00000246 ORIG_RAX: 000000000000003c
[ 23.911399][ T479] RAX: ffffffffffffffda RBX: 00007f6df2adb6c0 RCX: 00007f6df331bc49
[ 23.911400][ T479] RDX: 0000000000000000 RSI: 0000000000801000 RDI: 0000000000000000
[ 23.911401][ T479] RBP: 00007f6df2adaf70 R08: 0000000000000001 R09: 00007f6df2adb6c0
[ 23.911402][ T479] R10: 0000000000000008 R11: 0000000000000246 R12: 00007f6df22db000
Finger prints:
mark_lock_irq:mark_lock:mark_usage:__lock_acquire:console_lock_spinning_enable
__kmalloc_noprof:put_chars:hvc_console_print:console_emit_next_record:console_flush_one_record
do_softirq:dump_stack_lvl:__kmalloc_noprof:put_chars:hvc_console_print