====================================== | [ 29.040232][ T740] softirqs last disabled at (7687026): fpu__clear_user_states (./include/linux/bottom_half.h:20 (discriminator 2) ./arch/x86/include/asm/fpu/api.h:69 (discriminator 2) arch/x86/kernel/fpu/core.c:835 (discriminator 2)) | [ 29.040235][ T740] Preemption disabled at: | [ 29.040235][ T740] 0x0 | [ 29.040246][ T740] Tainted: [W]=WARN [ 29.040247][ T740] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 29.040249][ T740] Call Trace: [ 29.040250][ T740] [ 29.040252][ T740] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 29.040257][ T740] __might_resched.cold (kernel/sched/core.c:9234) [ 29.040262][ T740] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 29.040266][ T740] ? __kmalloc_noprof (./include/linux/sched/mm.h:317 mm/slub.c:4636 mm/slub.c:4974 mm/slub.c:5413 mm/slub.c:5439) [ 29.040271][ T740] __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)) [ 29.040273][ T740] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 29.040279][ T740] ? 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) [ 29.040282][ T740] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 29.040285][ T740] put_chars (drivers/char/virtio_console.c:1176) [ 29.040287][ T740] ? prb_final_commit (kernel/printk/printk_ringbuffer.c:1842) [ 29.040289][ T740] ? __send_to_port (drivers/char/virtio_console.c:654) [ 29.040292][ T740] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 29.040297][ T740] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 29.040299][ T740] ? validate_chain (kernel/locking/lockdep.c:3817 (discriminator 2) kernel/locking/lockdep.c:3837 (discriminator 2) kernel/locking/lockdep.c:3892 (discriminator 2)) [ 29.040303][ T740] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 29.040306][ T740] ? mark_usage (kernel/locking/lockdep.c:4690) [ 29.040308][ T740] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 29.040309][ T740] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 29.040313][ T740] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 29.040315][ T740] ? console_emit_next_record (kernel/printk/printk.c:3095 (discriminator 2) kernel/printk/printk.c:3182 (discriminator 2)) [ 29.040318][ T740] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 29.040321][ T740] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 29.040325][ T740] console_emit_next_record (kernel/printk/printk.c:3183) [ 29.040328][ T740] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 29.040330][ T740] ? 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)) [ 29.040333][ T740] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 29.040335][ T740] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 29.040339][ T740] console_flush_one_record (kernel/printk/printk.c:3268) [ 29.040343][ T740] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 29.040345][ T740] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 29.040350][ T740] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 29.040352][ T740] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 29.040354][ T740] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 29.040356][ T740] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 29.040360][ T740] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 29.040361][ T740] ? vprintk_emit (kernel/printk/printk.c:2478) [ 29.040365][ T740] vprintk_emit (kernel/printk/printk.c:2479) [ 29.040368][ T740] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 29.040372][ T740] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 29.040375][ T740] _printk (kernel/printk/printk.c:2504) [ 29.040379][ T740] ? snapshot_read.cold (user.c:?) [ 29.040381][ T740] ? 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) [ 29.040384][ T740] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 29.040387][ T740] ? 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) [ 29.040390][ T740] do_exit.cold (kernel/exit.c:889 (discriminator 4) kernel/exit.c:1043 (discriminator 4)) [ 29.040394][ T740] ? exit_notify (kernel/exit.c:780) [ 29.040399][ T740] __x64_sys_exit (kernel/exit.c:1118 kernel/exit.c:1116 kernel/exit.c:1116) [ 29.040401][ T740] x64_sys_call (./arch/x86/include/generated/asm/syscalls_64.h:61) [ 29.040403][ T740] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 29.040407][ T740] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 29.040410][ T740] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 29.040412][ T740] RIP: 0033:0x7fd62dc60c49 [ 29.040414][ T740] Code: Unable to access opcode bytes at 0x7fd62dc60c1f. Code starting with the faulting instruction =========================================== [ 29.040415][ T740] RSP: 002b:00007fd62d41fe60 EFLAGS: 00000246 ORIG_RAX: 000000000000003c [ 29.040418][ T740] RAX: ffffffffffffffda RBX: 00007fd62d4206c0 RCX: 00007fd62dc60c49 [ 29.040419][ T740] RDX: 0000000000000000 RSI: 0000000000801000 RDI: 0000000000000000 [ 29.040420][ T740] RBP: 00007fd62d41ff70 R08: 0000000000000001 R09: 00007fd62d4206c0 [ 29.040421][ T740] R10: 0000000000000008 R11: 0000000000000246 R12: 00007fd62cc20000 [ 29.040422][ T740] R13: 00007fff60ea10c0 R14: 0000000000000002 R15: 00007fff60ea11c7 | [ 30.772348][ T835] | [ 30.772348][ T835] | [ 30.772348][ T835] stack backtrace: | [ 30.772354][ T835] Tainted: [W]=WARN [ 30.772355][ T835] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 30.772356][ T835] Call Trace: [ 30.772358][ T835] [ 30.772359][ T835] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 30.772363][ T835] print_bad_irq_dependency (kernel/locking/lockdep.c:2632) [ 30.772365][ T835] check_irq_usage (kernel/locking/lockdep.c:2873 (discriminator 1)) [ 30.772367][ T835] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 30.772371][ T835] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 30.772374][ T835] ? check_path.constprop.0 (kernel/locking/lockdep.c:1864 kernel/locking/lockdep.c:2147) [ 30.772376][ T835] ? check_prev_add (kernel/locking/lockdep.c:3185) [ 30.772377][ T835] check_prev_add (kernel/locking/lockdep.c:3185) [ 30.772379][ T835] validate_chain (kernel/locking/lockdep.c:3300 kernel/locking/lockdep.c:3924) [ 30.772381][ T835] __lock_acquire (kernel/locking/lockdep.c:5254) [ 30.772383][ T835] lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2)) [ 30.772385][ T835] ? console_lock_spinning_enable (kernel/printk/printk.c:1902 (discriminator 2)) [ 30.772387][ T835] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 30.772389][ T835] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 30.772391][ T835] console_lock_spinning_enable (kernel/printk/printk.c:1902 (discriminator 2)) [ 30.772393][ T835] ? console_lock_spinning_enable (kernel/printk/printk.c:1902 (discriminator 2)) [ 30.772394][ T835] console_emit_next_record (kernel/printk/printk.c:3177) [ 30.772397][ T835] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 30.772398][ T835] ? 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)) [ 30.772400][ T835] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 30.772402][ T835] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 30.772404][ T835] console_flush_one_record (kernel/printk/printk.c:3268) [ 30.772406][ T835] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 30.772408][ T835] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 30.772410][ T835] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 30.772412][ T835] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 30.772413][ T835] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 30.772415][ T835] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 30.772417][ T835] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 30.772419][ T835] ? vprintk_emit (kernel/printk/printk.c:2478) [ 30.772421][ T835] vprintk_emit (kernel/printk/printk.c:2479) [ 30.772423][ T835] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 30.772424][ T835] ? kernel_text_address (kernel/extable.c:125 kernel/extable.c:94) [ 30.772426][ T835] ? __kernel_text_address (kernel/extable.c:79) [ 30.772427][ T835] ? write_profile (profile.c:?) [ 30.772429][ T835] ? unwind_get_return_address (arch/x86/kernel/unwind_orc.c:385 arch/x86/kernel/unwind_orc.c:380) [ 30.772432][ T835] _printk (kernel/printk/printk.c:2504) [ 30.772434][ T835] ? snapshot_read.cold (user.c:?) [ 30.772436][ T835] ? mark_usage (kernel/locking/lockdep.c:4690) [ 30.772438][ T835] ? netdev_name (./include/linux/netdevice.h:5709 (discriminator 1)) [ 30.772439][ T835] ? __netdev_printk (net/core/dev.c:13148 (discriminator 2)) [ 30.772441][ T835] netdev_info (net/core/dev.c:13195 (discriminator 3)) [ 30.772442][ T835] ? netdev_notice (net/core/dev.c:13194) [ 30.772443][ T835] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 30.772444][ T835] ? mark_usage (kernel/locking/lockdep.c:4690) [ 30.772446][ T835] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 30.772448][ T835] ovpn_nl_peer_del_notify (drivers/net/ovpn/netlink.c:1173) ovpn [ 30.772451][ T835] ? ovpn_nl_key_new_doit.cold (drivers/net/ovpn/netlink.c:958 (discriminator 13)) ovpn [ 30.772454][ T835] ? ovpn_peer_get_by_id (./include/linux/rcupdate.h:319 (discriminator 2) ./include/linux/rcupdate.h:880 (discriminator 2) drivers/net/ovpn/peer.c:680 (discriminator 2)) ovpn [ 30.772457][ T835] ovpn_peer_remove (drivers/net/ovpn/peer.c:716) ovpn [ 30.772459][ T835] ? 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) [ 30.772461][ T835] ? __ovpn_peer_hash_transp_addr (drivers/net/ovpn/peer.c:943) ovpn [ 30.772464][ T835] ovpn_peer_del (drivers/net/ovpn/peer.c:1166 drivers/net/ovpn/peer.c:1217) ovpn [ 30.772467][ T835] ? ovpn_peer_add (drivers/net/ovpn/peer.c:1097 (discriminator 9)) ovpn [ 30.772470][ T835] ovpn_nl_peer_del_doit (drivers/net/ovpn/netlink.c:823) ovpn [ 30.772473][ T835] ? _raw_spin_unlock_irqrestore (./include/linux/spinlock_api_smp.h:210 (discriminator 6) kernel/locking/spinlock.c:221 (discriminator 6)) [ 30.772474][ T835] ? ovpn_nl_peer_get_dumpit (drivers/net/ovpn/netlink.c:790) ovpn [ 30.772476][ T835] ? ref_tracker_alloc (./include/linux/spinlock.h:425 (discriminator 3) lib/ref_tracker.c:281 (discriminator 3)) [ 30.772482][ T835] ? ovpn_get_dev_from_attrs (./include/linux/rcupdate.h:319 (discriminator 2) ./include/linux/rcupdate.h:880 (discriminator 2) drivers/net/ovpn/netlink.c:67 (discriminator 2)) ovpn [ 30.772484][ T835] ? ovpn_get_dev_from_attrs (./include/linux/rcupdate.h:882 drivers/net/ovpn/netlink.c:67) ovpn [ 30.772487][ T835] genl_family_rcv_msg_doit (net/netlink/genetlink.c:1114) [ 30.772490][ T835] ? genl_family_rcv_msg_attrs_parse.isra.0 (./include/net/netlink.h:785 (discriminator 2)) [ 30.772492][ T835] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 30.772494][ T835] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 30.772496][ T835] ? cap_capable (./include/trace/events/capability.h:26 (discriminator 22) security/commoncap.c:130 (discriminator 22)) [ 30.772500][ T835] ? write_profile (profile.c:?) [ 30.772501][ T835] ? unwind_get_return_address (arch/x86/kernel/unwind_orc.c:385 arch/x86/kernel/unwind_orc.c:380) [ 30.772502][ T835] genl_family_rcv_msg (net/netlink/genetlink.c:1194) [ 30.772504][ T835] ? genl_family_rcv_msg_dumpit (net/netlink/genetlink.c:1079) [ 30.772506][ T835] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 30.772508][ T835] ? ovpn_nl_send_peer (drivers/net/ovpn/netlink.c:606) ovpn [ 30.772510][ T835] ? ovpn_nl_peer_get_dumpit (drivers/net/ovpn/netlink.c:790) ovpn [ 30.772512][ T835] ? ovpn_nl_pre_doit (drivers/net/ovpn/netlink.c:82) ovpn [ 30.772515][ T835] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 30.772517][ T835] genl_rcv_msg (net/netlink/genetlink.c:1209) [ 30.772519][ T835] netlink_rcv_skb (net/netlink/af_netlink.c:2556) [ 30.772521][ T835] ? genl_family_rcv_msg (net/netlink/genetlink.c:1136 (discriminator 2)) [ 30.772523][ T835] ? netlink_ack (./include/linux/skbuff.h:2718) [ 30.772526][ T835] ? netlink_deliver_tap (./include/linux/rcupdate.h:319 (discriminator 2) ./include/linux/rcupdate.h:880 (discriminator 2) ./include/net/netns/generic.h:48 (discriminator 2) net/netlink/af_netlink.c:334 (discriminator 2)) [ 30.772527][ T835] ? netlink_deliver_tap (./include/linux/rcupdate.h:319 (discriminator 2) ./include/linux/rcupdate.h:880 (discriminator 2) net/netlink/af_netlink.c:341 (discriminator 2)) [ 30.772530][ T835] genl_rcv (net/netlink/genetlink.c:1218) [ 30.772531][ T835] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1345) [ 30.772533][ T835] ? netlink_attachskb (./arch/x86/include/asm/bitops.h:202 (discriminator 1)) [ 30.772535][ T835] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 30.772537][ T835] netlink_sendmsg (net/netlink/af_netlink.c:1900) [ 30.772539][ T835] ? netlink_unicast (./include/net/net_namespace.h:422 (discriminator 7)) [ 30.772541][ T835] ? __might_fault (mm/memory.c:7482 (discriminator 5)) [ 30.772545][ T835] ____sys_sendmsg (net/socket.c:800 (discriminator 4) net/socket.c:815 (discriminator 4) net/socket.c:2713 (discriminator 4)) [ 30.772546][ T835] ? copy_msghdr_from_user (net/socket.c:2650) [ 30.772548][ T835] ? get_timestamp.constprop.0 (./include/linux/netdevice.h:5399) [ 30.772550][ T835] ? move_addr_to_kernel (net/socket.c:258) [ 30.772553][ T835] ___sys_sendmsg (net/socket.c:2767) [ 30.772554][ T835] ? copy_msghdr_from_user (net/socket.c:2619) [ 30.772556][ T835] ? kfree (mm/slub.c:6778 (discriminator 1)) [ 30.772561][ T835] __sys_sendmsg (net/socket.c:2799) [ 30.772562][ T835] ? __sys_sendmsg_sock (net/socket.c:2780) [ 30.772565][ T835] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 30.772567][ T835] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 30.772569][ T835] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 30.772570][ T835] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 30.772572][ T835] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 30.772573][ T835] RIP: 0033:0x7fcb1df7b54e [ 30.772576][ 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 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 [ 30.772578][ T835] RSP: 002b:00007ffda74e55c0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 30.772581][ T835] RAX: ffffffffffffffda RBX: 000000001cdd8130 RCX: 00007fcb1df7b54e [ 30.772582][ T835] RDX: 0000000000000000 RSI: 00007ffda74e5660 RDI: 0000000000000005 [ 30.772583][ T835] RBP: 00007ffda74e55d0 R08: 0000000000000000 R09: 0000000000000000 [ 30.772584][ T835] R10: 0000000000000000 R11: 0000000000000202 R12: 000000001cdd8200 [ 30.772585][ T835] R13: 00007ffda74e5660 R14: 000000001cdd9260 R15: 000000000040bda8 | [ 30.772603][ T835] softirqs last disabled at (35290): ovpn_peer_del (./include/linux/spinlock.h:353 drivers/net/ovpn/peer.c:1214) ovpn | [ 30.772605][ T835] Preemption disabled at: | [ 30.772606][ T835] 0x0 | [ 30.772610][ T835] Tainted: [W]=WARN [ 30.772610][ T835] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 30.772611][ T835] Call Trace: [ 30.772612][ T835] [ 30.772612][ T835] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 30.772614][ T835] __might_resched.cold (kernel/sched/core.c:9234) [ 30.772617][ T835] ? check_irq_usage (kernel/locking/lockdep.c:2873 (discriminator 1)) [ 30.772618][ T835] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 30.772621][ T835] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 30.772623][ T835] __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)) [ 30.772625][ T835] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 30.772626][ T835] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 30.772628][ T835] ? 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) [ 30.772630][ T835] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 30.772632][ T835] put_chars (drivers/char/virtio_console.c:1176) [ 30.772633][ T835] ? __send_to_port (drivers/char/virtio_console.c:654) [ 30.772635][ T835] ? check_prev_add (kernel/locking/lockdep.c:3185) [ 30.772637][ T835] ? validate_chain (kernel/locking/lockdep.c:3300 kernel/locking/lockdep.c:3924) [ 30.772638][ T835] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 30.772640][ T835] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 30.772642][ T835] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 30.772644][ T835] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 30.772646][ T835] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 30.772648][ T835] console_emit_next_record (kernel/printk/printk.c:3183) [ 30.772650][ T835] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 30.772651][ T835] ? 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)) [ 30.772653][ T835] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 30.772655][ T835] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 30.772657][ T835] console_flush_one_record (kernel/printk/printk.c:3268) [ 30.772659][ T835] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 30.772660][ T835] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 30.772663][ T835] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 30.772664][ T835] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 30.772666][ T835] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 30.772668][ T835] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 30.772669][ T835] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 30.772671][ T835] ? vprintk_emit (kernel/printk/printk.c:2478) [ 30.772673][ T835] vprintk_emit (kernel/printk/printk.c:2479) [ 30.772675][ T835] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 30.772676][ T835] ? kernel_text_address (kernel/extable.c:125 kernel/extable.c:94) [ 30.772678][ T835] ? __kernel_text_address (kernel/extable.c:79) [ 30.772679][ T835] ? write_profile (profile.c:?) [ 30.772680][ T835] ? unwind_get_return_address (arch/x86/kernel/unwind_orc.c:385 arch/x86/kernel/unwind_orc.c:380) [ 30.772682][ T835] _printk (kernel/printk/printk.c:2504) [ 30.772683][ T835] ? snapshot_read.cold (user.c:?) [ 30.772685][ T835] ? mark_usage (kernel/locking/lockdep.c:4690) [ 30.772687][ T835] ? netdev_name (./include/linux/netdevice.h:5709 (discriminator 1)) [ 30.772688][ T835] ? __netdev_printk (net/core/dev.c:13148 (discriminator 2)) [ 30.772689][ T835] netdev_info (net/core/dev.c:13195 (discriminator 3)) [ 30.772691][ T835] ? netdev_notice (net/core/dev.c:13194) [ 30.772692][ T835] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 30.772693][ T835] ? mark_usage (kernel/locking/lockdep.c:4690) [ 30.772695][ T835] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 30.772697][ T835] ovpn_nl_peer_del_notify (drivers/net/ovpn/netlink.c:1173) ovpn [ 30.772700][ T835] ? ovpn_nl_key_new_doit.cold (drivers/net/ovpn/netlink.c:958 (discriminator 13)) ovpn [ 30.772702][ T835] ? ovpn_peer_get_by_id (./include/linux/rcupdate.h:319 (discriminator 2) ./include/linux/rcupdate.h:880 (discriminator 2) drivers/net/ovpn/peer.c:680 (discriminator 2)) ovpn [ 30.772705][ T835] ovpn_peer_remove (drivers/net/ovpn/peer.c:716) ovpn [ 30.772708][ T835] ? 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) [ 30.772710][ T835] ? __ovpn_peer_hash_transp_addr (drivers/net/ovpn/peer.c:943) ovpn [ 30.772713][ T835] ovpn_peer_del (drivers/net/ovpn/peer.c:1166 drivers/net/ovpn/peer.c:1217) ovpn [ 30.772715][ T835] ? ovpn_peer_add (drivers/net/ovpn/peer.c:1097 (discriminator 9)) ovpn [ 30.772718][ T835] ovpn_nl_peer_del_doit (drivers/net/ovpn/netlink.c:823) ovpn [ 30.772720][ T835] ? _raw_spin_unlock_irqrestore (./include/linux/spinlock_api_smp.h:210 (discriminator 6) kernel/locking/spinlock.c:221 (discriminator 6)) [ 30.772722][ T835] ? ovpn_nl_peer_get_dumpit (drivers/net/ovpn/netlink.c:790) ovpn [ 30.772724][ T835] ? ref_tracker_alloc (./include/linux/spinlock.h:425 (discriminator 3) lib/ref_tracker.c:281 (discriminator 3)) [ 30.772727][ T835] ? ovpn_get_dev_from_attrs (./include/linux/rcupdate.h:319 (discriminator 2) ./include/linux/rcupdate.h:880 (discriminator 2) drivers/net/ovpn/netlink.c:67 (discriminator 2)) ovpn [ 30.772730][ T835] ? ovpn_get_dev_from_attrs (./include/linux/rcupdate.h:882 drivers/net/ovpn/netlink.c:67) ovpn [ 30.772733][ T835] genl_family_rcv_msg_doit (net/netlink/genetlink.c:1114) [ 30.772735][ T835] ? genl_family_rcv_msg_attrs_parse.isra.0 (./include/net/netlink.h:785 (discriminator 2)) [ 30.772737][ T835] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 30.772739][ T835] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 30.772741][ T835] ? cap_capable (./include/trace/events/capability.h:26 (discriminator 22) security/commoncap.c:130 (discriminator 22)) [ 30.772742][ T835] ? write_profile (profile.c:?) [ 30.772744][ T835] ? unwind_get_return_address (arch/x86/kernel/unwind_orc.c:385 arch/x86/kernel/unwind_orc.c:380) [ 30.772745][ T835] genl_family_rcv_msg (net/netlink/genetlink.c:1194) [ 30.772747][ T835] ? genl_family_rcv_msg_dumpit (net/netlink/genetlink.c:1079) [ 30.772749][ T835] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 30.772751][ T835] ? ovpn_nl_send_peer (drivers/net/ovpn/netlink.c:606) ovpn [ 30.772753][ T835] ? ovpn_nl_peer_get_dumpit (drivers/net/ovpn/netlink.c:790) ovpn [ 30.772755][ T835] ? ovpn_nl_pre_doit (drivers/net/ovpn/netlink.c:82) ovpn [ 30.772757][ T835] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 30.772760][ T835] genl_rcv_msg (net/netlink/genetlink.c:1209) [ 30.772762][ T835] netlink_rcv_skb (net/netlink/af_netlink.c:2556) [ 30.772763][ T835] ? genl_family_rcv_msg (net/netlink/genetlink.c:1136 (discriminator 2)) [ 30.772766][ T835] ? netlink_ack (./include/linux/skbuff.h:2718) [ 30.772768][ T835] ? netlink_deliver_tap (./include/linux/rcupdate.h:319 (discriminator 2) ./include/linux/rcupdate.h:880 (discriminator 2) ./include/net/netns/generic.h:48 (discriminator 2) net/netlink/af_netlink.c:334 (discriminator 2)) [ 30.772770][ T835] ? netlink_deliver_tap (./include/linux/rcupdate.h:319 (discriminator 2) ./include/linux/rcupdate.h:880 (discriminator 2) net/netlink/af_netlink.c:341 (discriminator 2)) [ 30.772772][ T835] genl_rcv (net/netlink/genetlink.c:1218) [ 30.772774][ T835] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1345) [ 30.772776][ T835] ? netlink_attachskb (./arch/x86/include/asm/bitops.h:202 (discriminator 1)) [ 30.772778][ T835] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 30.772779][ T835] netlink_sendmsg (net/netlink/af_netlink.c:1900) [ 30.772782][ T835] ? netlink_unicast (./include/net/net_namespace.h:422 (discriminator 7)) [ 30.772784][ T835] ? __might_fault (mm/memory.c:7482 (discriminator 5)) [ 30.772786][ T835] ____sys_sendmsg (net/socket.c:800 (discriminator 4) net/socket.c:815 (discriminator 4) net/socket.c:2713 (discriminator 4)) [ 30.772787][ T835] ? copy_msghdr_from_user (net/socket.c:2650) [ 30.772789][ T835] ? get_timestamp.constprop.0 (./include/linux/netdevice.h:5399) [ 30.772791][ T835] ? move_addr_to_kernel (net/socket.c:258) [ 30.772793][ T835] ___sys_sendmsg (net/socket.c:2767) [ 30.772795][ T835] ? copy_msghdr_from_user (net/socket.c:2619) [ 30.772797][ T835] ? kfree (mm/slub.c:6778 (discriminator 1)) [ 30.772801][ T835] __sys_sendmsg (net/socket.c:2799) [ 30.772803][ T835] ? __sys_sendmsg_sock (net/socket.c:2780) [ 30.772806][ T835] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 30.772807][ T835] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 30.772809][ T835] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 30.772811][ T835] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 30.772812][ T835] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 30.772814][ T835] RIP: 0033:0x7fcb1df7b54e [ 30.772815][ 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 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 [ 30.772816][ T835] RSP: 002b:00007ffda74e55c0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 30.772817][ T835] RAX: ffffffffffffffda RBX: 000000001cdd8130 RCX: 00007fcb1df7b54e [ 30.772818][ T835] RDX: 0000000000000000 RSI: 00007ffda74e5660 RDI: 0000000000000005 [ 30.772818][ T835] RBP: 00007ffda74e55d0 R08: 0000000000000000 R09: 0000000000000000 [ 30.772819][ T835] R10: 0000000000000000 R11: 0000000000000202 R12: 000000001cdd8200 [ 30.772820][ T835] R13: 00007ffda74e5660 R14: 000000001cdd9260 R15: 000000000040bda8 | [ 33.462793][ T887] softirqs last disabled at (0): 0x0 | [ 33.462795][ T887] Preemption disabled at: | [ 33.462795][ T887] 0x0 | [ 33.462804][ T887] Tainted: [W]=WARN [ 33.462805][ T887] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 33.462806][ T887] Call Trace: [ 33.462808][ T887] [ 33.462809][ T887] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 33.462814][ T887] __might_resched.cold (kernel/sched/core.c:9234) [ 33.462818][ T887] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 33.462822][ T887] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 33.462826][ T887] __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)) [ 33.462829][ T887] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 33.462832][ T887] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 33.462836][ T887] ? 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) [ 33.462838][ T887] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 33.462839][ T887] put_chars (drivers/char/virtio_console.c:1176) [ 33.462842][ T887] ? __send_to_port (drivers/char/virtio_console.c:654) [ 33.462843][ T887] ? printk_get_next_message (kernel/printk/printk.c:3072) [ 33.462847][ T887] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 33.462850][ T887] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 33.462852][ T887] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 33.462853][ T887] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 33.462855][ T887] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 33.462857][ T887] console_emit_next_record (kernel/printk/printk.c:3183) [ 33.462859][ T887] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 33.462861][ T887] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 33.462863][ T887] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 33.462864][ T887] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 33.462866][ T887] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 33.462868][ T887] ? console_flush_one_record (kernel/printk/printk.c:3247) [ 33.462869][ T887] console_flush_one_record (kernel/printk/printk.c:3268) [ 33.462872][ T887] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 33.462874][ T887] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 33.462876][ T887] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 33.462877][ T887] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 33.462879][ T887] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 33.462880][ T887] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 33.462882][ T887] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 33.462883][ T887] ? __rcu_read_lock (kernel/rcu/tree_plugin.h:391 (discriminator 6) kernel/rcu/tree_plugin.h:414 (discriminator 6)) [ 33.462885][ T887] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 33.462887][ T887] ? vprintk_emit (kernel/printk/printk.c:2478) [ 33.462889][ T887] vprintk_emit (kernel/printk/printk.c:2479) [ 33.462891][ T887] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 33.462893][ T887] ? kernel_text_address (kernel/extable.c:125 kernel/extable.c:94) [ 33.462895][ T887] ? __kernel_text_address (kernel/extable.c:79) [ 33.462896][ T887] ? write_profile (profile.c:?) [ 33.462899][ T887] ? unwind_get_return_address (arch/x86/kernel/unwind_orc.c:385 arch/x86/kernel/unwind_orc.c:380) [ 33.462901][ T887] _printk (kernel/printk/printk.c:2504) [ 33.462904][ T887] ? snapshot_read.cold (user.c:?) [ 33.462906][ T887] ? netdev_name (./include/linux/netdevice.h:5709 (discriminator 1)) [ 33.462909][ T887] ? __netdev_printk (net/core/dev.c:13148 (discriminator 2)) [ 33.462911][ T887] netdev_info (net/core/dev.c:13195 (discriminator 3)) [ 33.462912][ T887] ? netdev_notice (net/core/dev.c:13194) [ 33.462913][ T887] ? ovpn_nl_pre_doit (drivers/net/ovpn/netlink.c:76 (discriminator 1)) ovpn [ 33.462919][ T887] ? __module_address (kernel/module/main.c:3915) [ 33.462922][ T887] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 33.462923][ T887] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 33.462925][ T887] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 33.462927][ T887] ? ovpn_peer_get_by_id (./include/linux/instrumented.h:55 ./include/linux/atomic/atomic-instrumented.h:1346 ./include/linux/refcount.h:181 ./include/linux/refcount.h:317 ./include/linux/refcount.h:335 ./include/linux/kref.h:133 drivers/net/ovpn/peer.h:127 drivers/net/ovpn/peer.c:674) ovpn [ 33.462930][ T887] ovpn_nl_peer_del_notify (drivers/net/ovpn/netlink.c:1173) ovpn [ 33.462934][ T887] ? ovpn_nl_key_new_doit.cold (drivers/net/ovpn/netlink.c:958 (discriminator 13)) ovpn [ 33.462936][ T887] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 33.462937][ T887] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 33.462939][ T887] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 33.462941][ T887] ovpn_peer_remove (drivers/net/ovpn/peer.c:716) ovpn [ 33.462944][ T887] ? 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) [ 33.462945][ T887] ? __ovpn_peer_hash_transp_addr (drivers/net/ovpn/peer.c:943) ovpn [ 33.462949][ T887] ovpn_peer_del (drivers/net/ovpn/peer.c:1166 drivers/net/ovpn/peer.c:1217) ovpn [ 33.462951][ T887] ? ovpn_peer_add (drivers/net/ovpn/peer.c:1097 (discriminator 9)) ovpn [ 33.462954][ T887] ovpn_nl_peer_del_doit (drivers/net/ovpn/netlink.c:823) ovpn [ 33.462957][ T887] ? trace_hardirqs_on (kernel/trace/trace_preemptirq.c:78) [ 33.462960][ T887] ? ovpn_nl_peer_get_dumpit (drivers/net/ovpn/netlink.c:790) ovpn [ 33.462962][ T887] ? ref_tracker_alloc (./include/linux/spinlock.h:425 (discriminator 3) lib/ref_tracker.c:281 (discriminator 3)) [ 33.462967][ T887] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 33.462969][ T887] ? ovpn_get_dev_from_attrs (./include/linux/rcupdate.h:882 drivers/net/ovpn/netlink.c:67) ovpn [ 33.462972][ T887] genl_family_rcv_msg_doit (net/netlink/genetlink.c:1114) [ 33.462982][ T887] ? genl_family_rcv_msg_attrs_parse.isra.0 (./include/net/netlink.h:785 (discriminator 2)) [ 33.462984][ T887] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 33.462986][ T887] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 33.462988][ T887] ? cap_capable (./include/trace/events/capability.h:26 (discriminator 22) security/commoncap.c:130 (discriminator 22)) [ 33.462991][ T887] ? write_profile (profile.c:?) [ 33.462993][ T887] ? unwind_get_return_address (arch/x86/kernel/unwind_orc.c:385 arch/x86/kernel/unwind_orc.c:380) [ 33.462994][ T887] genl_family_rcv_msg (net/netlink/genetlink.c:1194) [ 33.462996][ T887] ? genl_family_rcv_msg_dumpit (net/netlink/genetlink.c:1079) [ 33.462998][ T887] ? ovpn_nl_send_peer (drivers/net/ovpn/netlink.c:606) ovpn [ 33.463001][ T887] ? ovpn_nl_peer_get_dumpit (drivers/net/ovpn/netlink.c:790) ovpn [ 33.463003][ T887] ? ovpn_nl_pre_doit (drivers/net/ovpn/netlink.c:82) ovpn [ 33.463005][ T887] ? filter_irq_stacks (kernel/stacktrace.c:402) [ 33.463007][ T887] ? stack_depot_save_flags (lib/stackdepot.c:609 lib/stackdepot.c:676) [ 33.463009][ T887] genl_rcv_msg (net/netlink/genetlink.c:1209) [ 33.463011][ T887] netlink_rcv_skb (net/netlink/af_netlink.c:2556) [ 33.463013][ T887] ? genl_family_rcv_msg (net/netlink/genetlink.c:1136 (discriminator 2)) [ 33.463015][ T887] ? netlink_ack (./include/linux/skbuff.h:2718) [ 33.463018][ T887] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 33.463019][ T887] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 33.463021][ T887] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 33.463022][ T887] genl_rcv (net/netlink/genetlink.c:1218) [ 33.463024][ T887] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1345) [ 33.463026][ T887] ? netlink_attachskb (./arch/x86/include/asm/bitops.h:202 (discriminator 1)) [ 33.463028][ T887] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 33.463029][ T887] ? trace_hardirqs_on (kernel/trace/trace_preemptirq.c:78) [ 33.463030][ T887] ? _raw_spin_unlock_irqrestore (./include/linux/spinlock_api_smp.h:211 (discriminator 1) kernel/locking/spinlock.c:221 (discriminator 1)) [ 33.463034][ T887] netlink_sendmsg (net/netlink/af_netlink.c:1900) [ 33.463036][ T887] ? netlink_unicast (./include/net/net_namespace.h:422 (discriminator 7)) [ 33.463038][ T887] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 33.463040][ T887] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 33.463041][ T887] ____sys_sendmsg (net/socket.c:800 (discriminator 4) net/socket.c:815 (discriminator 4) net/socket.c:2713 (discriminator 4)) [ 33.463045][ T887] ? copy_msghdr_from_user (net/socket.c:2650) [ 33.463046][ T887] ? get_timestamp.constprop.0 (./include/linux/netdevice.h:5399) [ 33.463048][ T887] ? move_addr_to_kernel (net/socket.c:258) [ 33.463051][ T887] ___sys_sendmsg (net/socket.c:2767) [ 33.463053][ T887] ? copy_msghdr_from_user (net/socket.c:2619) [ 33.463054][ T887] ? kfree (mm/slub.c:6778 (discriminator 1)) [ 33.463059][ T887] __sys_sendmsg (net/socket.c:2799) [ 33.463061][ T887] ? __sys_sendmsg_sock (net/socket.c:2780) [ 33.463063][ T887] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 33.463065][ T887] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 33.463067][ T887] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 33.463070][ T887] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 33.463072][ T887] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 33.463074][ T887] RIP: 0033:0x7f3149b2c54e [ 33.463075][ 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 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 [ 33.463077][ T887] RSP: 002b:00007ffec518c340 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 33.463081][ T887] RAX: ffffffffffffffda RBX: 000000002eeb9130 RCX: 00007f3149b2c54e [ 33.463082][ T887] RDX: 0000000000000000 RSI: 00007ffec518c3e0 RDI: 0000000000000005 [ 33.463083][ T887] RBP: 00007ffec518c350 R08: 0000000000000000 R09: 0000000000000000 [ 33.463084][ T887] R10: 0000000000000000 R11: 0000000000000202 R12: 000000002eeb9200 [ 33.463085][ T887] R13: 00007ffec518c3e0 R14: 000000002eeba260 R15: 000000000040bda8 | [ 38.177273][ T64] softirqs last disabled at (13188): ovpn_peer_keepalive_work (./include/linux/spinlock.h:353 drivers/net/ovpn/peer.c:1449) ovpn | [ 38.177277][ T64] Preemption disabled at: | [ 38.177278][ T64] 0x0 | [ 38.177286][ T64] Tainted: [W]=WARN [ 38.177288][ T64] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 38.177289][ T64] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 38.177294][ T64] Call Trace: [ 38.177296][ T64] [ 38.177297][ T64] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 38.177303][ T64] __might_resched.cold (kernel/sched/core.c:9234) [ 38.177307][ T64] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 38.177310][ T64] ? prb_next_reserve_seq (kernel/printk/printk_ringbuffer.c:2128) [ 38.177313][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 38.177317][ T64] __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)) [ 38.177320][ T64] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 38.177322][ T64] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 38.177326][ T64] ? 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) [ 38.177328][ T64] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 38.177330][ T64] put_chars (drivers/char/virtio_console.c:1176) [ 38.177332][ T64] ? prb_final_commit (kernel/printk/printk_ringbuffer.c:1842) [ 38.177333][ T64] ? __send_to_port (drivers/char/virtio_console.c:654) [ 38.177335][ T64] ? printk_get_next_message (kernel/printk/printk.c:3072) [ 38.177338][ T64] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 38.177342][ T64] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 38.177343][ T64] ? 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) [ 38.177345][ T64] ? vsnprintf (lib/vsprintf.c:2953 (discriminator 1)) [ 38.177347][ T64] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 38.177348][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 38.177350][ T64] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 38.177352][ T64] console_emit_next_record (kernel/printk/printk.c:3183) [ 38.177355][ T64] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 38.177357][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 38.177358][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 38.177360][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 38.177362][ T64] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 38.177363][ T64] ? console_flush_one_record (kernel/printk/printk.c:3247) [ 38.177365][ T64] console_flush_one_record (kernel/printk/printk.c:3268) [ 38.177367][ T64] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 38.177370][ T64] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 38.177372][ T64] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 38.177373][ T64] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 38.177375][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 38.177376][ T64] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 38.177378][ T64] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 38.177379][ T64] ? __rcu_read_lock (kernel/rcu/tree_plugin.h:391 (discriminator 6) kernel/rcu/tree_plugin.h:414 (discriminator 6)) [ 38.177381][ T64] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 38.177383][ T64] ? vprintk_emit (kernel/printk/printk.c:2478) [ 38.177385][ T64] vprintk_emit (kernel/printk/printk.c:2479) [ 38.177387][ T64] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 38.177389][ T64] ? ret_from_fork_asm (arch/x86/entry/entry_64.S:245) [ 38.177391][ T64] ? queued_spin_lock_slowpath (./include/linux/instrumented.h:55 ./include/linux/atomic/atomic-instrumented.h:1279 ./arch/x86/include/asm/paravirt-spinlock.h:144 kernel/locking/qspinlock.c:163) [ 38.177393][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 38.177394][ T64] ? stack_access_ok (./arch/x86/include/asm/stacktrace.h:55) [ 38.177397][ T64] _printk (kernel/printk/printk.c:2504) [ 38.177400][ T64] ? snapshot_read.cold (user.c:?) [ 38.177402][ T64] ? __add_to_free_list (mm/page_alloc.c:447 mm/page_alloc.c:801) [ 38.177404][ T64] ? 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) [ 38.177406][ T64] ? netdev_name (./include/linux/netdevice.h:5709 (discriminator 1)) [ 38.177408][ T64] ? __netdev_printk (net/core/dev.c:13148 (discriminator 2)) [ 38.177410][ T64] netdev_info (net/core/dev.c:13195 (discriminator 3)) [ 38.177411][ T64] ? netdev_notice (net/core/dev.c:13194) [ 38.177413][ T64] ? debug_object_free (lib/debugobjects.c:1033) [ 38.177417][ T64] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 38.177419][ T64] ? trace_irq_enable.constprop.0 (./include/linux/instrumented.h:82 ./include/asm-generic/bitops/instrumented-non-atomic.h:141 ./include/linux/cpumask.h:650 ./include/linux/cpumask.h:1232 ./include/trace/events/preemptirq.h:40) [ 38.177422][ T64] ovpn_nl_peer_del_notify (drivers/net/ovpn/netlink.c:1173) ovpn [ 38.177426][ T64] ? ovpn_nl_key_new_doit.cold (drivers/net/ovpn/netlink.c:958 (discriminator 13)) ovpn [ 38.177428][ T64] ? remove_and_enqueue_same_base (kernel/time/hrtimer.c:1293) [ 38.177432][ T64] ? 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) [ 38.177434][ T64] ovpn_peer_remove (drivers/net/ovpn/peer.c:716) ovpn [ 38.177436][ T64] ? 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) [ 38.177438][ T64] ? __ovpn_peer_hash_transp_addr (drivers/net/ovpn/peer.c:943) ovpn [ 38.177440][ T64] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 38.177442][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 38.177443][ T64] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 38.177445][ T64] ? trace_irq_disable.constprop.0 (./include/trace/events/preemptirq.h:36 (discriminator 22)) [ 38.177446][ T64] ovpn_peer_keepalive_work_single (drivers/net/ovpn/peer.c:1347) ovpn [ 38.177449][ T64] ? ovpn_peers_release_mp (drivers/net/ovpn/peer.c:1290) ovpn [ 38.177451][ T64] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 38.177454][ T64] ovpn_peer_keepalive_work (drivers/net/ovpn/peer.c:1396 drivers/net/ovpn/peer.c:1452) ovpn [ 38.177457][ T64] ? ovpn_peers_free (drivers/net/ovpn/peer.c:1307) ovpn [ 38.177459][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 38.177461][ T64] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 38.177462][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 38.177464][ T64] process_one_work (kernel/workqueue.c:3387) [ 38.177468][ T64] ? __queue_delayed_work (kernel/workqueue.c:2622) [ 38.177470][ T64] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 38.177472][ T64] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 38.177474][ T64] worker_thread (kernel/workqueue.c:3470 kernel/workqueue.c:3551) [ 38.177476][ T64] ? rescuer_thread (./include/linux/list.h:419 (discriminator 3)) [ 38.177478][ T64] ? __kthread_parkme (./include/linux/instrumented.h:82 ./include/asm-generic/bitops/instrumented-non-atomic.h:141 kernel/kthread.c:272) [ 38.177481][ T64] ? rescuer_thread (./include/linux/list.h:419 (discriminator 3)) [ 38.177482][ T64] ? rescuer_thread (./include/linux/list.h:419 (discriminator 3)) [ 38.177484][ T64] kthread (kernel/kthread.c:436) [ 38.177486][ T64] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 38.177487][ T64] ? kthread_affine_preferred (kernel/kthread.c:857) [ 38.177489][ T64] ret_from_fork (arch/x86/kernel/process.c:158) [ 38.177491][ T64] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/vdso/vma.c:80 (discriminator 1)) [ 38.177493][ T64] ? __switch_to (arch/x86/kernel/process_64.c:403 arch/x86/kernel/process_64.c:663) [ 38.177495][ T64] ? kthread_affine_preferred (kernel/kthread.c:857) [ 38.177497][ T64] ret_from_fork_asm (arch/x86/entry/entry_64.S:245) | [ 39.201257][ T64] softirqs last disabled at (13188): ovpn_peer_keepalive_work (./include/linux/spinlock.h:353 drivers/net/ovpn/peer.c:1449) ovpn | [ 39.201261][ T64] Preemption disabled at: | [ 39.201262][ T64] 0x0 | [ 39.201268][ T64] Tainted: [W]=WARN [ 39.201269][ T64] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 39.201270][ T64] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 39.201274][ T64] Call Trace: [ 39.201275][ T64] [ 39.201276][ T64] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 39.201280][ T64] __might_resched.cold (kernel/sched/core.c:9234) [ 39.201283][ T64] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 39.201286][ T64] ? prb_next_reserve_seq (kernel/printk/printk_ringbuffer.c:2128) [ 39.201288][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 39.201291][ T64] __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)) [ 39.201294][ T64] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 39.201296][ T64] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 39.201298][ T64] ? 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) [ 39.201300][ T64] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 39.201302][ T64] put_chars (drivers/char/virtio_console.c:1176) [ 39.201303][ T64] ? prb_final_commit (kernel/printk/printk_ringbuffer.c:1842) [ 39.201305][ T64] ? __send_to_port (drivers/char/virtio_console.c:654) [ 39.201307][ T64] ? printk_get_next_message (kernel/printk/printk.c:3072) [ 39.201309][ T64] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 39.201312][ T64] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 39.201314][ T64] ? 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) [ 39.201315][ T64] ? vsnprintf (lib/vsprintf.c:2953 (discriminator 1)) [ 39.201316][ T64] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 39.201318][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 39.201320][ T64] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 39.201322][ T64] console_emit_next_record (kernel/printk/printk.c:3183) [ 39.201324][ T64] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 39.201326][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 39.201327][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 39.201329][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 39.201331][ T64] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 39.201332][ T64] ? console_flush_one_record (kernel/printk/printk.c:3247) [ 39.201334][ T64] console_flush_one_record (kernel/printk/printk.c:3268) [ 39.201336][ T64] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 39.201338][ T64] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 39.201340][ T64] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 39.201341][ T64] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 39.201343][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 39.201344][ T64] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 39.201346][ T64] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 39.201347][ T64] ? __rcu_read_lock (kernel/rcu/tree_plugin.h:391 (discriminator 6) kernel/rcu/tree_plugin.h:414 (discriminator 6)) [ 39.201349][ T64] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 39.201351][ T64] ? vprintk_emit (kernel/printk/printk.c:2478) [ 39.201353][ T64] vprintk_emit (kernel/printk/printk.c:2479) [ 39.201355][ T64] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 39.201356][ T64] ? arch_stack_walk (arch/x86/kernel/stacktrace.c:25) [ 39.201359][ T64] ? queued_spin_lock_slowpath (./include/linux/instrumented.h:55 ./include/linux/atomic/atomic-instrumented.h:1279 ./arch/x86/include/asm/paravirt-spinlock.h:144 kernel/locking/qspinlock.c:163) [ 39.201360][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 39.201362][ T64] _printk (kernel/printk/printk.c:2504) [ 39.201364][ T64] ? snapshot_read.cold (user.c:?) [ 39.201366][ T64] ? __add_to_free_list (mm/page_alloc.c:447 mm/page_alloc.c:801) [ 39.201368][ T64] ? __mod_zone_page_state (mm/vmstat.c:371) [ 39.201370][ T64] ? netdev_name (./include/linux/netdevice.h:5709 (discriminator 1)) [ 39.201372][ T64] ? __netdev_printk (net/core/dev.c:13148 (discriminator 2)) [ 39.201374][ T64] netdev_info (net/core/dev.c:13195 (discriminator 3)) [ 39.201375][ T64] ? netdev_notice (net/core/dev.c:13194) [ 39.201377][ T64] ? free_pcppages_bulk (./include/trace/events/kmem.h:246 (discriminator 22) mm/page_alloc.c:1516 (discriminator 22)) [ 39.201379][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 39.201380][ T64] ? trace_irq_enable.constprop.0 (./include/linux/instrumented.h:82 ./include/asm-generic/bitops/instrumented-non-atomic.h:141 ./include/linux/cpumask.h:650 ./include/linux/cpumask.h:1232 ./include/trace/events/preemptirq.h:40) [ 39.201382][ T64] ovpn_nl_peer_del_notify (drivers/net/ovpn/netlink.c:1173) ovpn [ 39.201386][ T64] ? ovpn_nl_key_new_doit.cold (drivers/net/ovpn/netlink.c:958 (discriminator 13)) ovpn [ 39.201389][ T64] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 39.201391][ T64] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 39.201392][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 39.201394][ T64] ovpn_peer_remove (drivers/net/ovpn/peer.c:716) ovpn [ 39.201397][ T64] ? 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) [ 39.201398][ T64] ? __ovpn_peer_hash_transp_addr (drivers/net/ovpn/peer.c:943) ovpn [ 39.201400][ T64] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 39.201402][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 39.201404][ T64] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 39.201405][ T64] ? trace_irq_disable.constprop.0 (./include/trace/events/preemptirq.h:36 (discriminator 22)) [ 39.201406][ T64] ovpn_peer_keepalive_work_single (drivers/net/ovpn/peer.c:1347) ovpn [ 39.201409][ T64] ? ovpn_peers_release_mp (drivers/net/ovpn/peer.c:1290) ovpn [ 39.201411][ T64] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 39.201413][ T64] ovpn_peer_keepalive_work (drivers/net/ovpn/peer.c:1396 drivers/net/ovpn/peer.c:1452) ovpn [ 39.201416][ T64] ? ovpn_peers_free (drivers/net/ovpn/peer.c:1307) ovpn [ 39.201419][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 39.201420][ T64] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 39.201422][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 39.201424][ T64] process_one_work (kernel/workqueue.c:3387) [ 39.201427][ T64] ? __queue_delayed_work (kernel/workqueue.c:2622) [ 39.201429][ T64] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 39.201431][ T64] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 39.201433][ T64] worker_thread (kernel/workqueue.c:3470 kernel/workqueue.c:3551) [ 39.201435][ T64] ? rescuer_thread (./include/linux/list.h:419 (discriminator 3)) [ 39.201436][ T64] ? __kthread_parkme (./include/linux/instrumented.h:82 ./include/asm-generic/bitops/instrumented-non-atomic.h:141 kernel/kthread.c:272) [ 39.201438][ T64] ? rescuer_thread (./include/linux/list.h:419 (discriminator 3)) [ 39.201440][ T64] ? rescuer_thread (./include/linux/list.h:419 (discriminator 3)) [ 39.201441][ T64] kthread (kernel/kthread.c:436) [ 39.201443][ T64] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 39.201444][ T64] ? kthread_affine_preferred (kernel/kthread.c:857) [ 39.201446][ T64] ret_from_fork (arch/x86/kernel/process.c:158) [ 39.201447][ T64] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/vdso/vma.c:80 (discriminator 1)) [ 39.201449][ T64] ? __switch_to (arch/x86/kernel/process_64.c:403 arch/x86/kernel/process_64.c:663) [ 39.201451][ T64] ? kthread_affine_preferred (kernel/kthread.c:857) [ 39.201452][ T64] ret_from_fork_asm (arch/x86/entry/entry_64.S:245) | [ 44.257295][ T64] softirqs last disabled at (13188): ovpn_peer_keepalive_work (./include/linux/spinlock.h:353 drivers/net/ovpn/peer.c:1449) ovpn | [ 44.257298][ T64] Preemption disabled at: | [ 44.257298][ T64] 0x0 | [ 44.257307][ T64] Tainted: [W]=WARN [ 44.257308][ T64] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 44.257309][ T64] Workqueue: ovpn ovpn_peer_keepalive_work [ovpn] [ 44.257313][ T64] Call Trace: [ 44.257315][ T64] [ 44.257316][ T64] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 44.257321][ T64] __might_resched.cold (kernel/sched/core.c:9234) [ 44.257325][ T64] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 44.257328][ T64] ? prb_next_reserve_seq (kernel/printk/printk_ringbuffer.c:2128) [ 44.257330][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 44.257334][ T64] __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)) [ 44.257337][ T64] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 44.257339][ T64] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 44.257343][ T64] ? 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) [ 44.257344][ T64] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 44.257346][ T64] put_chars (drivers/char/virtio_console.c:1176) [ 44.257348][ T64] ? prb_final_commit (kernel/printk/printk_ringbuffer.c:1842) [ 44.257349][ T64] ? __send_to_port (drivers/char/virtio_console.c:654) [ 44.257351][ T64] ? printk_get_next_message (kernel/printk/printk.c:3072) [ 44.257354][ T64] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 44.257358][ T64] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 44.257359][ T64] ? 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) [ 44.257360][ T64] ? vsnprintf (lib/vsprintf.c:2953 (discriminator 1)) [ 44.257362][ T64] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 44.257363][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 44.257365][ T64] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 44.257367][ T64] console_emit_next_record (kernel/printk/printk.c:3183) [ 44.257370][ T64] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 44.257372][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 44.257373][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 44.257375][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 44.257376][ T64] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 44.257378][ T64] ? console_flush_one_record (kernel/printk/printk.c:3247) [ 44.257380][ T64] console_flush_one_record (kernel/printk/printk.c:3268) [ 44.257382][ T64] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 44.257385][ T64] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 44.257386][ T64] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 44.257388][ T64] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 44.257389][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 44.257391][ T64] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 44.257392][ T64] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 44.257394][ T64] ? __rcu_read_lock (kernel/rcu/tree_plugin.h:391 (discriminator 6) kernel/rcu/tree_plugin.h:414 (discriminator 6)) [ 44.257396][ T64] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 44.257397][ T64] ? vprintk_emit (kernel/printk/printk.c:2478) [ 44.257399][ T64] vprintk_emit (kernel/printk/printk.c:2479) [ 44.257402][ T64] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 44.257403][ T64] ? _raw_spin_unlock_irqrestore (./include/linux/spinlock_api_smp.h:211 (discriminator 1) kernel/locking/spinlock.c:221 (discriminator 1)) [ 44.257405][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 44.257406][ T64] ? trace_sched_wakeup (./include/trace/events/sched.h:178 (discriminator 22)) [ 44.257409][ T64] _printk (kernel/printk/printk.c:2504) [ 44.257411][ T64] ? snapshot_read.cold (user.c:?) [ 44.257413][ T64] ? try_to_wake_up (./include/linux/preempt.h:500 (discriminator 1) kernel/sched/core.c:4263 (discriminator 1)) [ 44.257414][ T64] ? select_fallback_rq (kernel/sched/sched.h:1424) [ 44.257416][ T64] ? netdev_name (./include/linux/netdevice.h:5709 (discriminator 1)) [ 44.257418][ T64] ? __netdev_printk (net/core/dev.c:13148 (discriminator 2)) [ 44.257420][ T64] netdev_info (net/core/dev.c:13195 (discriminator 3)) [ 44.257421][ T64] ? netdev_notice (net/core/dev.c:13194) [ 44.257423][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 44.257425][ T64] ? __queue_work (./include/linux/rcupdate.h:882 kernel/workqueue.c:2459) [ 44.257428][ T64] ? trace_irq_enable.constprop.0 (./include/linux/instrumented.h:82 ./include/asm-generic/bitops/instrumented-non-atomic.h:141 ./include/linux/cpumask.h:650 ./include/linux/cpumask.h:1232 ./include/trace/events/preemptirq.h:40) [ 44.257431][ T64] ovpn_nl_peer_del_notify (drivers/net/ovpn/netlink.c:1173) ovpn [ 44.257434][ T64] ? ovpn_nl_key_new_doit.cold (drivers/net/ovpn/netlink.c:958 (discriminator 13)) ovpn [ 44.257436][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 44.257438][ T64] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 44.257440][ T64] ovpn_peer_remove (drivers/net/ovpn/peer.c:716) ovpn [ 44.257442][ T64] ? 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) [ 44.257444][ T64] ? __ovpn_peer_hash_transp_addr (drivers/net/ovpn/peer.c:943) ovpn [ 44.257446][ T64] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 44.257448][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 44.257450][ T64] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 44.257451][ T64] ? trace_irq_disable.constprop.0 (./include/trace/events/preemptirq.h:36 (discriminator 22)) [ 44.257452][ T64] ovpn_peer_keepalive_work_single (drivers/net/ovpn/peer.c:1347) ovpn [ 44.257455][ T64] ? ovpn_peers_release_mp (drivers/net/ovpn/peer.c:1290) ovpn [ 44.257457][ T64] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 44.257459][ T64] ovpn_peer_keepalive_work (drivers/net/ovpn/peer.c:1423 drivers/net/ovpn/peer.c:1456) ovpn [ 44.257462][ T64] ? ovpn_peers_free (drivers/net/ovpn/peer.c:1307) ovpn [ 44.257465][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 44.257467][ T64] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 44.257468][ T64] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 44.257470][ T64] ? process_one_work (kernel/workqueue.c:3363 (discriminator 2)) [ 44.257471][ T64] process_one_work (kernel/workqueue.c:3387) [ 44.257474][ T64] ? __queue_delayed_work (kernel/workqueue.c:2622) [ 44.257476][ T64] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 44.257478][ T64] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 44.257480][ T64] worker_thread (kernel/workqueue.c:3470 kernel/workqueue.c:3551) [ 44.257482][ T64] ? rescuer_thread (./include/linux/list.h:419 (discriminator 3)) [ 44.257484][ T64] ? __kthread_parkme (./include/linux/instrumented.h:82 ./include/asm-generic/bitops/instrumented-non-atomic.h:141 kernel/kthread.c:272) [ 44.257486][ T64] ? rescuer_thread (./include/linux/list.h:419 (discriminator 3)) [ 44.257487][ T64] ? rescuer_thread (./include/linux/list.h:419 (discriminator 3)) [ 44.257489][ T64] kthread (kernel/kthread.c:436) [ 44.257490][ T64] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 44.257492][ T64] ? kthread_affine_preferred (kernel/kthread.c:857) [ 44.257493][ T64] ret_from_fork (arch/x86/kernel/process.c:158) [ 44.257496][ T64] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/vdso/vma.c:80 (discriminator 1)) [ 44.257498][ T64] ? __switch_to (arch/x86/kernel/process_64.c:403 arch/x86/kernel/process_64.c:663) [ 44.257500][ T64] ? kthread_affine_preferred (kernel/kthread.c:857) Finger prints: __kmalloc_noprof:put_chars:hvc_console_print:console_emit_next_record:console_flush_one_record print_bad_irq_dependency:check_irq_usage:check_prev_add:validate_chain:__lock_acquire ovpn_peer_del:dump_stack_lvl:__kmalloc_noprof:put_chars:hvc_console_print fpu__clear_user_states:dump_stack_lvl:__kmalloc_noprof:put_chars:hvc_console_print ovpn_peer_keepalive_work:dump_stack_lvl:__kmalloc_noprof:put_chars:hvc_console_print