====================================== | [ 8.404983][ T167] softirqs last disabled at (0): 0x0 | [ 8.404985][ T167] Preemption disabled at: | [ 8.404986][ T167] vprintk_emit (kernel/printk/printk.c:2471) | [ 8.404997][ T167] Tainted: [W]=WARN [ 8.404998][ T167] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 8.405000][ T167] Call Trace: [ 8.405001][ T167] [ 8.405003][ T167] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 8.405008][ T167] ? vprintk_emit (kernel/printk/printk.c:2471) [ 8.405010][ T167] __might_resched.cold (kernel/sched/core.c:9234) [ 8.405014][ T167] ? tcp_ao_key_cmp (net/ipv4/tcp_ao.c:254 net/ipv4/tcp_ao.c:295) [ 8.405018][ T167] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 8.405021][ T167] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 8.405025][ T167] __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)) [ 8.405029][ T167] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 8.405031][ T167] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 8.405035][ T167] ? 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) [ 8.405037][ T167] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 8.405039][ T167] put_chars (drivers/char/virtio_console.c:1176) [ 8.405041][ T167] ? __send_to_port (drivers/char/virtio_console.c:654) [ 8.405043][ T167] ? console_prepend_replay (kernel/printk/printk.c:3005) [ 8.405045][ T167] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 8.405049][ T167] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 8.405051][ T167] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 8.405052][ T167] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 8.405054][ T167] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 8.405056][ T167] console_emit_next_record (kernel/printk/printk.c:3183) [ 8.405059][ T167] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 8.405061][ T167] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 8.405063][ T167] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 8.405064][ T167] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 8.405066][ T167] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 8.405068][ T167] ? console_flush_one_record (kernel/printk/printk.c:3247) [ 8.405069][ T167] console_flush_one_record (kernel/printk/printk.c:3268) [ 8.405072][ T167] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 8.405074][ T167] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 8.405076][ T167] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 8.405077][ T167] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 8.405079][ T167] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 8.405081][ T167] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 8.405082][ T167] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 8.405084][ T167] ? __rcu_read_lock (kernel/rcu/tree_plugin.h:391 (discriminator 6) kernel/rcu/tree_plugin.h:414 (discriminator 6)) [ 8.405086][ T167] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 8.405087][ T167] ? vprintk_emit (kernel/printk/printk.c:2478) [ 8.405089][ T167] vprintk_emit (kernel/printk/printk.c:2479) [ 8.405092][ T167] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 8.405093][ T167] ? do_raw_spin_trylock (./include/linux/instrumented.h:55 ./include/linux/atomic/atomic-instrumented.h:1301 ./include/asm-generic/qspinlock.h:98 kernel/locking/spinlock_debug.c:123) [ 8.405095][ T167] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 8.405097][ T167] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 8.405099][ T167] _printk (kernel/printk/printk.c:2504) [ 8.405102][ T167] ? snapshot_read.cold (user.c:?) [ 8.405103][ T167] ? ___ratelimit (lib/ratelimit.c:97 (discriminator 3)) [ 8.405107][ T167] ? tcp_ao_key_cmp (net/ipv4/tcp_ao.c:252 (discriminator 1)) [ 8.405108][ T167] ? idr_get_free (??:?) [ 8.405110][ T167] ? 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) [ 8.405113][ T167] tcp_ao_add_cmd.cold (net/ipv4/tcp_ao.c:1646 (discriminator 3)) [ 8.405116][ T167] ? tcp_ao_cache_traffic_keys.isra.0 (net/ipv4/tcp_ao.c:473 (discriminator 1)) [ 8.405118][ T167] ? __x64_sys_bind (net/socket.c:1981 net/socket.c:1979 net/socket.c:1979) [ 8.405122][ T167] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 8.405123][ T167] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 8.405125][ T167] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 8.405126][ T167] ? 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) [ 8.405130][ T167] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 8.405132][ T167] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 8.405134][ T167] do_tcp_setsockopt (net/ipv4/tcp.c:4088) [ 8.405138][ T167] ? tcp_sock_set_maxseg (net/ipv4/tcp.c:3832) [ 8.405139][ T167] ? _copy_from_user (./include/linux/instrumented.h:146 ./include/linux/uaccess.h:184 lib/usercopy.c:18) [ 8.405143][ T167] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 8.405144][ T167] ? trace_irq_enable.constprop.0 (./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 ./include/trace/events/preemptirq.h:40) [ 8.405146][ T167] ? sock_poll (net/socket.c:1514) [ 8.405147][ T167] ? inet_csk_get_port (./include/linux/spinlock.h:407 net/ipv4/inet_connection_sock.c:592) [ 8.405149][ T167] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 8.405151][ T167] ? trace_kfree (./include/trace/events/kmem.h:97 (discriminator 22)) [ 8.405152][ T167] ? 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) [ 8.405154][ T167] ? kfree (mm/slub.c:6778 (discriminator 1)) [ 8.405155][ T167] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 8.405157][ T167] do_sock_setsockopt (net/socket.c:2397) [ 8.405159][ T167] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 8.405161][ T167] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 8.405162][ T167] ? put_user_ifreq (./arch/x86/include/asm/compat.h:94 (discriminator 1)) [ 8.405164][ T167] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 8.405165][ T167] ? __fget_files (./include/linux/rcupdate.h:882 fs/file.c:1100) [ 8.405168][ T167] __sys_setsockopt (net/socket.c:2422) [ 8.405171][ T167] __x64_sys_setsockopt (net/socket.c:2428 net/socket.c:2425 net/socket.c:2425) [ 8.405173][ T167] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 8.405174][ T167] ? trace_hardirqs_off_finish (./include/trace/events/preemptirq.h:36 (discriminator 22) kernel/trace/trace_preemptirq.c:95 (discriminator 22) kernel/trace/trace_preemptirq.c:90 (discriminator 22)) [ 8.405175][ T167] ? trace_hardirqs_on (kernel/trace/trace_preemptirq.c:78) [ 8.405176][ T167] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 8.405179][ T167] ? irq_exit_rcu (kernel/softirq.c:786) [ 8.405181][ T167] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 8.405183][ T167] RIP: 0033:0x7f48a7c0b2de [ 8.405185][ T167] Code: 55 48 63 c9 48 63 ff 45 89 c9 48 89 e5 48 83 ec 08 6a 2c e8 94 72 f7 ff c9 c3 66 90 f3 0f 1e fa 49 89 ca b8 36 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 0a c3 66 0f 1f 84 00 00 00 00 00 48 8b 15 e1 All code ======== 0: 55 push %rbp 1: 48 63 c9 movslq %ecx,%rcx 4: 48 63 ff movslq %edi,%rdi 7: 45 89 c9 mov %r9d,%r9d a: 48 89 e5 mov %rsp,%rbp d: 48 83 ec 08 sub $0x8,%rsp 11: 6a 2c push $0x2c 13: e8 94 72 f7 ff call 0xfffffffffff772ac 18: c9 leave 19: c3 ret 1a: 66 90 xchg %ax,%ax 1c: f3 0f 1e fa endbr64 20: 49 89 ca mov %rcx,%r10 23: b8 36 00 00 00 mov $0x36,%eax 28: 0f 05 syscall 2a:* 48 3d 00 f0 ff ff cmp $0xfffffffffffff000,%rax <-- trapping instruction 30: 77 0a ja 0x3c 32: c3 ret 33: 66 0f 1f 84 00 00 00 nopw 0x0(%rax,%rax,1) 3a: 00 00 3c: 48 rex.W 3d: 8b .byte 0x8b 3e: 15 .byte 0x15 3f: e1 .byte 0xe1 Code starting with the faulting instruction =========================================== 0: 48 3d 00 f0 ff ff cmp $0xfffffffffffff000,%rax 6: 77 0a ja 0x12 8: c3 ret 9: 66 0f 1f 84 00 00 00 nopw 0x0(%rax,%rax,1) 10: 00 00 12: 48 rex.W 13: 8b .byte 0x8b 14: 15 .byte 0x15 15: e1 .byte 0xe1 [ 8.405187][ T167] RSP: 002b:00007ffc3efa6e68 EFLAGS: 00000246 ORIG_RAX: 0000000000000036 [ 8.405191][ T167] RAX: ffffffffffffffda RBX: 0000000000412632 RCX: 00007f48a7c0b2de [ 8.405192][ T167] RDX: 0000000000000026 RSI: 0000000000000006 RDI: 0000000000000009 [ 8.405193][ T167] RBP: 0000000000000009 R08: 0000000000000120 R09: 0000000000000000 [ 8.405194][ T167] R10: 00007ffc3efa6e80 R11: 0000000000000246 R12: 00000000000000c8 Finger prints: vprintk_emit:dump_stack_lvl:__kmalloc_noprof:put_chars:hvc_console_print