====================================== | [ 9.653112][ T187] softirqs last disabled at (33587): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 9.653116][ T187] Preemption disabled at: | [ 9.653117][ T187] 0x0 | [ 9.653131][ T187] Tainted: [W]=WARN [ 9.653132][ T187] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.653134][ T187] Call Trace: [ 9.653136][ T187] [ 9.653138][ T187] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 9.653147][ T187] __might_resched.cold (kernel/sched/core.c:9234) [ 9.653153][ T187] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 9.653159][ T187] ? __kmalloc_noprof (./include/linux/sched/mm.h:317 mm/slub.c:4636 mm/slub.c:4974 mm/slub.c:5413 mm/slub.c:5439) [ 9.653167][ T187] __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)) [ 9.653171][ T187] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 9.653180][ T187] ? 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) [ 9.653184][ T187] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 9.653190][ T187] put_chars (drivers/char/virtio_console.c:1176) [ 9.653195][ T187] ? __send_to_port (drivers/char/virtio_console.c:654) [ 9.653197][ T187] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 9.653204][ T187] ? validate_chain (kernel/locking/lockdep.c:3817 (discriminator 2) kernel/locking/lockdep.c:3837 (discriminator 2) kernel/locking/lockdep.c:3892 (discriminator 2)) [ 9.653214][ T187] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 9.653225][ T187] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 9.653229][ T187] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 9.653234][ T187] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 9.653242][ T187] console_emit_next_record (kernel/printk/printk.c:3183) [ 9.653249][ T187] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 9.653252][ T187] ? 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)) [ 9.653258][ T187] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 9.653262][ T187] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 9.653269][ T187] console_flush_one_record (kernel/printk/printk.c:3268) [ 9.653277][ T187] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 9.653280][ T187] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 9.653291][ T187] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 9.653296][ T187] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 9.653299][ T187] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 9.653303][ T187] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 9.653310][ T187] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 9.653313][ T187] ? vprintk_emit (kernel/printk/printk.c:2478) [ 9.653319][ T187] vprintk_emit (kernel/printk/printk.c:2479) [ 9.653326][ T187] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 9.653332][ T187] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 9.653339][ T187] _printk (kernel/printk/printk.c:2504) [ 9.653344][ T187] ? snapshot_read.cold (user.c:?) [ 9.653349][ T187] ? 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) [ 9.653354][ T187] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 9.653362][ T187] ? 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) [ 9.653366][ T187] do_exit.cold (kernel/exit.c:889 (discriminator 4) kernel/exit.c:1043 (discriminator 4)) [ 9.653372][ T187] ? exit_notify (kernel/exit.c:780) [ 9.653375][ T187] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 9.653380][ T187] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 9.653388][ T187] do_group_exit (kernel/exit.c:1151) [ 9.653394][ T187] __x64_sys_exit_group (kernel/exit.c:1162 kernel/exit.c:1160 kernel/exit.c:1160) [ 9.653397][ T187] x64_sys_call (./arch/x86/include/generated/asm/syscalls_64.h:232) [ 9.653400][ T187] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 9.653405][ T187] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 9.653410][ T187] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 9.653414][ T187] RIP: 0033:0x7f4abe60b1b8 [ 9.653417][ T187] Code: Unable to access opcode bytes at 0x7f4abe60b18e. Code starting with the faulting instruction =========================================== [ 9.653419][ T187] RSP: 002b:00007ffffeb948c8 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 9.653422][ T187] RAX: ffffffffffffffda RBX: 00007f4abe73bf88 RCX: 00007f4abe60b1b8 [ 9.653424][ T187] RDX: 00007f4abe355fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 9.653426][ T187] RBP: 00007ffffeb94920 R08: 0000000000000000 R09: 0000000000008010 [ 9.653428][ T187] R10: 00007ffffeb946e0 R11: 0000000000000246 R12: 0000000000000001 [ 9.653429][ T187] R13: 0000000000000000 R14: 00007f4abe73a680 R15: 00007f4abe73bfa0 | [ 11.711193][ T265] softirqs last disabled at (22203): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 11.711195][ T265] Preemption disabled at: | [ 11.711196][ T265] vprintk_emit (kernel/printk/printk.c:2471) | [ 11.711205][ T265] Tainted: [W]=WARN [ 11.711206][ T265] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.711208][ T265] Call Trace: [ 11.711209][ T265] [ 11.711211][ T265] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 11.711217][ T265] ? vprintk_emit (kernel/printk/printk.c:2471) [ 11.711219][ T265] __might_resched.cold (kernel/sched/core.c:9234) [ 11.711224][ T265] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 11.711228][ T265] ? __kmalloc_noprof (./include/linux/sched/mm.h:317 mm/slub.c:4636 mm/slub.c:4974 mm/slub.c:5413 mm/slub.c:5439) [ 11.711233][ T265] __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)) [ 11.711235][ T265] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 11.711241][ T265] ? 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) [ 11.711244][ T265] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 11.711247][ T265] put_chars (drivers/char/virtio_console.c:1176) [ 11.711249][ T265] ? desc_read_finalized_seq (kernel/printk/printk_ringbuffer.c:1934) [ 11.711251][ T265] ? __send_to_port (drivers/char/virtio_console.c:654) [ 11.711254][ T265] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 11.711257][ T265] ? validate_chain (kernel/locking/lockdep.c:3817 (discriminator 2) kernel/locking/lockdep.c:3837 (discriminator 2) kernel/locking/lockdep.c:3892 (discriminator 2)) [ 11.711262][ T265] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 11.711264][ T265] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 11.711266][ T265] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 11.711270][ T265] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 11.711272][ T265] ? console_emit_next_record (kernel/printk/printk.c:3095 (discriminator 2) kernel/printk/printk.c:3182 (discriminator 2)) [ 11.711275][ T265] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 11.711278][ T265] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 11.711282][ T265] console_emit_next_record (kernel/printk/printk.c:3183) [ 11.711286][ T265] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 11.711288][ T265] ? 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)) [ 11.711291][ T265] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 11.711293][ T265] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 11.711297][ T265] console_flush_one_record (kernel/printk/printk.c:3268) [ 11.711301][ T265] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 11.711303][ T265] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 11.711308][ T265] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 11.711311][ T265] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 11.711313][ T265] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 11.711316][ T265] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 11.711319][ T265] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 11.711321][ T265] ? vprintk_emit (kernel/printk/printk.c:2478) [ 11.711324][ T265] vprintk_emit (kernel/printk/printk.c:2479) [ 11.711328][ T265] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 11.711334][ T265] ? gre_exit (net/ipv4/gre_demux.c:73) gre [ 11.711337][ T265] _printk (kernel/printk/printk.c:2504) [ 11.711341][ T265] ? snapshot_read.cold (user.c:?) [ 11.711347][ T265] ? do_one_initcall (./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/initcall.h:27 init/main.c:1356) [ 11.711350][ T265] gre_init (gre.mod.c:?) gre [ 11.711352][ T265] do_one_initcall (init/main.c:1357) [ 11.711355][ T265] ? trace_event_raw_event_initcall_level (./include/trace/events/initcall.h:10) [ 11.711360][ T265] ? do_init_module (./include/linux/slab.h:991 (discriminator 1) kernel/module/main.c:3105 (discriminator 1)) [ 11.711363][ T265] ? kasan_unpoison (mm/kasan/shadow.c:146 mm/kasan/shadow.c:178) [ 11.711367][ T265] do_init_module (kernel/module/main.c:3117) [ 11.711371][ T265] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488) [ 11.711375][ T265] ? free_module (./include/trace/events/module.h:50 (discriminator 19)) [ 11.711379][ T265] ? kfree (./include/linux/kasan.h:235 mm/slub.c:2748 mm/slub.c:6499 mm/slub.c:6792) [ 11.711383][ T265] load_module (kernel/module/main.c:3593) [ 11.711390][ T265] ? layout_and_allocate.isra.0 (kernel/module/main.c:3016) [ 11.711395][ T265] ? backing_file_read_iter (fs/backing-file.c:211) [ 11.711399][ T265] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 11.711403][ T265] init_module_from_file (kernel/module/main.c:3790) [ 11.711406][ T265] ? __do_sys_init_module (kernel/module/main.c:3664) [ 11.711414][ T265] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 11.711418][ T265] ? 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) [ 11.711421][ T265] idempotent_init_module (kernel/module/main.c:3802) [ 11.711424][ T265] ? init_module_from_file (kernel/module/main.c:3791) [ 11.711431][ T265] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 11.711433][ T265] ? cap_capable (./include/trace/events/capability.h:26 (discriminator 22) security/commoncap.c:130 (discriminator 22)) [ 11.711439][ T265] __x64_sys_finit_module (kernel/module/main.c:3828 kernel/module/main.c:3812 kernel/module/main.c:3812) [ 11.711441][ T265] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 11.711445][ T265] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 11.711447][ T265] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 11.711450][ T265] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 11.711452][ T265] RIP: 0033:0x7f9d030db37d [ 11.711455][ T265] Code: ff c3 66 2e 0f 1f 84 00 00 00 00 00 90 f3 0f 1e fa 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 4b aa 0f 00 f7 d8 64 89 01 48 All code ======== 0: ff c3 inc %ebx 2: 66 2e 0f 1f 84 00 00 cs nopw 0x0(%rax,%rax,1) 9: 00 00 00 c: 90 nop d: f3 0f 1e fa endbr64 11: 48 89 f8 mov %rdi,%rax 14: 48 89 f7 mov %rsi,%rdi 17: 48 89 d6 mov %rdx,%rsi 1a: 48 89 ca mov %rcx,%rdx 1d: 4d 89 c2 mov %r8,%r10 20: 4d 89 c8 mov %r9,%r8 23: 4c 8b 4c 24 08 mov 0x8(%rsp),%r9 28: 0f 05 syscall 2a:* 48 3d 01 f0 ff ff cmp $0xfffffffffffff001,%rax <-- trapping instruction 30: 73 01 jae 0x33 32: c3 ret 33: 48 8b 0d 4b aa 0f 00 mov 0xfaa4b(%rip),%rcx # 0xfaa85 3a: f7 d8 neg %eax 3c: 64 89 01 mov %eax,%fs:(%rcx) 3f: 48 rex.W Code starting with the faulting instruction =========================================== 0: 48 3d 01 f0 ff ff cmp $0xfffffffffffff001,%rax 6: 73 01 jae 0x9 8: c3 ret 9: 48 8b 0d 4b aa 0f 00 mov 0xfaa4b(%rip),%rcx # 0xfaa5b 10: f7 d8 neg %eax 12: 64 89 01 mov %eax,%fs:(%rcx) 15: 48 rex.W [ 11.711457][ T265] RSP: 002b:00007ffc2df23da8 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 11.711460][ T265] RAX: ffffffffffffffda RBX: 00005630dffd0a40 RCX: 00007f9d030db37d [ 11.711461][ T265] RDX: 0000000000000000 RSI: 00005630bedc9ffd RDI: 0000000000000001 [ 11.711462][ T265] RBP: 00007ffc2df23e40 R08: 0000000000000000 R09: 0000000000000000 [ 11.711463][ T265] R10: 0000000000000000 R11: 0000000000000246 R12: 00005630bedc9ffd [ 11.711464][ T265] R13: 00005630dffd0a00 R14: 0000000000040000 R15: 0000000000000000 | [ 13.654457][ T328] softirqs last disabled at (17519): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 13.654459][ T328] Preemption disabled at: | [ 13.654460][ T328] vprintk_emit (kernel/printk/printk.c:2471) | [ 13.654469][ T328] Tainted: [W]=WARN [ 13.654470][ T328] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.654473][ T328] Call Trace: [ 13.654474][ T328] [ 13.654476][ T328] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 13.654482][ T328] ? vprintk_emit (kernel/printk/printk.c:2471) [ 13.654484][ T328] __might_resched.cold (kernel/sched/core.c:9234) [ 13.654489][ T328] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 13.654493][ T328] ? __kmalloc_noprof (./include/linux/sched/mm.h:317 mm/slub.c:4636 mm/slub.c:4974 mm/slub.c:5413 mm/slub.c:5439) [ 13.654498][ T328] __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)) [ 13.654500][ T328] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 13.654506][ T328] ? 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) [ 13.654509][ T328] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 13.654512][ T328] put_chars (drivers/char/virtio_console.c:1176) [ 13.654514][ T328] ? desc_read_finalized_seq (kernel/printk/printk_ringbuffer.c:1934) [ 13.654517][ T328] ? __send_to_port (drivers/char/virtio_console.c:654) [ 13.654519][ T328] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 13.654523][ T328] ? validate_chain (kernel/locking/lockdep.c:3817 (discriminator 2) kernel/locking/lockdep.c:3837 (discriminator 2) kernel/locking/lockdep.c:3892 (discriminator 2)) [ 13.654527][ T328] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 13.654530][ T328] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 13.654531][ T328] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 13.654536][ T328] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 13.654537][ T328] ? console_emit_next_record (kernel/printk/printk.c:3095 (discriminator 2) kernel/printk/printk.c:3182 (discriminator 2)) [ 13.654540][ T328] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 13.654544][ T328] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 13.654547][ T328] console_emit_next_record (kernel/printk/printk.c:3183) [ 13.654551][ T328] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 13.654553][ T328] ? 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)) [ 13.654556][ T328] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 13.654559][ T328] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 13.654563][ T328] console_flush_one_record (kernel/printk/printk.c:3268) [ 13.654567][ T328] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 13.654569][ T328] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 13.654574][ T328] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 13.654576][ T328] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 13.654578][ T328] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 13.654581][ T328] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 13.654584][ T328] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 13.654586][ T328] ? vprintk_emit (kernel/printk/printk.c:2478) [ 13.654589][ T328] vprintk_emit (kernel/printk/printk.c:2479) [ 13.654593][ T328] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 13.654599][ T328] ? gre_exit (net/ipv4/gre_demux.c:73) gre [ 13.654602][ T328] _printk (kernel/printk/printk.c:2504) [ 13.654605][ T328] ? snapshot_read.cold (user.c:?) [ 13.654611][ T328] ? do_one_initcall (./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/initcall.h:27 init/main.c:1356) [ 13.654615][ T328] gact_init_module (net/sched/act_gact.c:180) act_gact [ 13.654617][ T328] do_one_initcall (init/main.c:1357) [ 13.654620][ T328] ? trace_event_raw_event_initcall_level (./include/trace/events/initcall.h:10) [ 13.654625][ T328] ? do_init_module (./include/linux/slab.h:991 (discriminator 1) kernel/module/main.c:3105 (discriminator 1)) [ 13.654628][ T328] ? kasan_unpoison (mm/kasan/shadow.c:146 mm/kasan/shadow.c:178) [ 13.654632][ T328] do_init_module (kernel/module/main.c:3117) [ 13.654636][ T328] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488) [ 13.654641][ T328] ? free_module (./include/trace/events/module.h:50 (discriminator 19)) [ 13.654644][ T328] ? kfree (./include/linux/kasan.h:235 mm/slub.c:2748 mm/slub.c:6499 mm/slub.c:6792) [ 13.654648][ T328] load_module (kernel/module/main.c:3593) [ 13.654655][ T328] ? layout_and_allocate.isra.0 (kernel/module/main.c:3016) [ 13.654659][ T328] ? __ia32_sys_fsconfig (??:?) [ 13.654662][ T328] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 13.654665][ T328] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 13.654669][ T328] init_module_from_file (kernel/module/main.c:3790) [ 13.654672][ T328] ? __do_sys_init_module (kernel/module/main.c:3664) [ 13.654680][ T328] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 13.654683][ T328] ? 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) [ 13.654686][ T328] idempotent_init_module (kernel/module/main.c:3802) [ 13.654690][ T328] ? init_module_from_file (kernel/module/main.c:3791) [ 13.654696][ T328] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 13.654698][ T328] ? cap_capable (./include/trace/events/capability.h:26 (discriminator 22) security/commoncap.c:130 (discriminator 22)) [ 13.654705][ T328] __x64_sys_finit_module (kernel/module/main.c:3828 kernel/module/main.c:3812 kernel/module/main.c:3812) [ 13.654707][ T328] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 13.654711][ T328] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 13.654712][ T328] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 13.654715][ T328] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 13.654718][ T328] RIP: 0033:0x7f671833a37d [ 13.654721][ T328] Code: ff c3 66 2e 0f 1f 84 00 00 00 00 00 90 f3 0f 1e fa 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 4b aa 0f 00 f7 d8 64 89 01 48 All code ======== 0: ff c3 inc %ebx 2: 66 2e 0f 1f 84 00 00 cs nopw 0x0(%rax,%rax,1) 9: 00 00 00 c: 90 nop d: f3 0f 1e fa endbr64 11: 48 89 f8 mov %rdi,%rax 14: 48 89 f7 mov %rsi,%rdi 17: 48 89 d6 mov %rdx,%rsi 1a: 48 89 ca mov %rcx,%rdx 1d: 4d 89 c2 mov %r8,%r10 20: 4d 89 c8 mov %r9,%r8 23: 4c 8b 4c 24 08 mov 0x8(%rsp),%r9 28: 0f 05 syscall 2a:* 48 3d 01 f0 ff ff cmp $0xfffffffffffff001,%rax <-- trapping instruction 30: 73 01 jae 0x33 32: c3 ret 33: 48 8b 0d 4b aa 0f 00 mov 0xfaa4b(%rip),%rcx # 0xfaa85 3a: f7 d8 neg %eax 3c: 64 89 01 mov %eax,%fs:(%rcx) 3f: 48 rex.W Code starting with the faulting instruction =========================================== 0: 48 3d 01 f0 ff ff cmp $0xfffffffffffff001,%rax 6: 73 01 jae 0x9 8: c3 ret 9: 48 8b 0d 4b aa 0f 00 mov 0xfaa4b(%rip),%rcx # 0xfaa5b 10: f7 d8 neg %eax 12: 64 89 01 mov %eax,%fs:(%rcx) 15: 48 rex.W [ 13.654723][ T328] RSP: 002b:00007ffc0dbdc568 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 13.654730][ T328] RAX: ffffffffffffffda RBX: 000055ea80f78810 RCX: 00007f671833a37d [ 13.654731][ T328] RDX: 0000000000000000 RSI: 000055ea624fdffd RDI: 0000000000000000 [ 13.654732][ T328] RBP: 00007ffc0dbdc600 R08: 0000000000000000 R09: 0000000000000000 [ 13.654733][ T328] R10: 0000000000000000 R11: 0000000000000246 R12: 000055ea624fdffd [ 13.654734][ T328] R13: 000055ea80f78960 R14: 0000000000040000 R15: 0000000000000000 | [ 286.414402][ C0] | [ 286.414402][ C0] | [ 286.414402][ C0] stack backtrace: | [ 286.414408][ C0] Tainted: [W]=WARN [ 286.414409][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 286.414410][ C0] Call Trace: [ 286.414411][ C0] [ 286.414413][ C0] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 286.414418][ C0] print_irq_inversion_bug.part.0.cold (kernel/locking/lockdep.c:4141) [ 286.414420][ C0] mark_lock_irq (kernel/locking/lockdep.c:4095 kernel/locking/lockdep.c:4174 kernel/locking/lockdep.c:4310) [ 286.414422][ C0] ? add_lock_to_list (./include/linux/find.h:391 kernel/locking/lockdep.c:1419 kernel/locking/lockdep.c:1450) [ 286.414425][ C0] mark_lock (kernel/locking/lockdep.c:4769) [ 286.414426][ C0] mark_usage (kernel/locking/lockdep.c:4658) [ 286.414428][ C0] __lock_acquire (kernel/locking/lockdep.c:5208) [ 286.414430][ C0] lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2)) [ 286.414432][ C0] ? console_lock_spinning_enable (kernel/printk/printk.c:1902 (discriminator 2)) [ 286.414434][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 286.414437][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 286.414439][ C0] console_lock_spinning_enable (kernel/printk/printk.c:1902 (discriminator 2)) [ 286.414440][ C0] ? console_lock_spinning_enable (kernel/printk/printk.c:1902 (discriminator 2)) [ 286.414442][ C0] console_emit_next_record (kernel/printk/printk.c:3177) [ 286.414444][ C0] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 286.414446][ 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)) [ 286.414448][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 286.414449][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 286.414451][ C0] console_flush_one_record (kernel/printk/printk.c:3268) [ 286.414453][ C0] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 286.414455][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 286.414457][ C0] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 286.414459][ C0] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 286.414461][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 286.414462][ C0] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 286.414464][ C0] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 286.414466][ C0] ? vprintk_emit (kernel/printk/printk.c:2478) [ 286.414468][ C0] vprintk_emit (kernel/printk/printk.c:2479) [ 286.414470][ C0] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 286.414472][ C0] ? clocksource_watchdog.part.0 (kernel/time/clocksource.c:531 (discriminator 1) kernel/time/clocksource.c:608 (discriminator 1) kernel/time/clocksource.c:667 (discriminator 1)) [ 286.414474][ C0] _printk (kernel/printk/printk.c:2504) [ 286.414476][ C0] ? snapshot_read.cold (user.c:?) [ 286.414478][ C0] ? clocksource_watchdog.part.0 (kernel/time/clocksource.c:531 (discriminator 1) kernel/time/clocksource.c:608 (discriminator 1) kernel/time/clocksource.c:667 (discriminator 1)) [ 286.414479][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 286.414482][ C0] clocksource_watchdog.part.0.cold (kernel/time/clocksource.c:589 (discriminator 10) kernel/time/clocksource.c:632 (discriminator 10) kernel/time/clocksource.c:667 (discriminator 10)) [ 286.414483][ C0] ? clocksource_watchdog.part.0 (./include/linux/find.h:67 (discriminator 4)) [ 286.414485][ C0] ? clocksource_watchdog.part.0 (./include/linux/find.h:67 (discriminator 4)) [ 286.414486][ C0] call_timer_fn (kernel/time/timer.c:1748) [ 286.414488][ C0] ? detach_if_pending (./include/linux/list.h:1159) [ 286.414490][ C0] ? debug_object_active_state (lib/debugobjects.c:1122) [ 286.414493][ C0] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 286.414495][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 286.414496][ C0] ? mark_held_locks (kernel/locking/lockdep.c:4341) [ 286.414498][ C0] __run_timers (kernel/time/timer.c:1799 kernel/time/timer.c:2374) [ 286.414500][ C0] ? clocksource_watchdog.part.0 (./include/linux/find.h:67 (discriminator 4)) [ 286.414502][ C0] ? __bpf_trace_itimer_expire (./include/trace/events/timer.h:407) [ 286.414504][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 286.414507][ C0] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 286.414509][ C0] run_timer_softirq (kernel/time/timer.c:2386 kernel/time/timer.c:2395 kernel/time/timer.c:2403) [ 286.414511][ C0] ? __run_timers (./include/trace/events/timer.h:138 (discriminator 19)) [ 286.414513][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 286.414514][ C0] handle_softirqs (kernel/softirq.c:645) [ 286.414516][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 286.414518][ C0] ? _local_bh_enable (kernel/softirq.c:428 (discriminator 1)) [ 286.414520][ C0] __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) [ 286.414521][ C0] irq_exit_rcu (kernel/softirq.c:784) [ 286.414522][ C0] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1062 (discriminator 37) arch/x86/kernel/apic/apic.c:1062 (discriminator 37)) [ 286.414524][ C0] [ 286.414525][ C0] [ 286.414525][ C0] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:674) [ 286.414527][ C0] RIP: 0010:lock_acquire.part.0 (./arch/x86/include/asm/irqflags.h:158 (discriminator 1) kernel/locking/lockdep.c:5912 (discriminator 1)) [ 286.414529][ C0] Code: ff 65 0f c1 05 ff a7 38 04 83 f8 01 4c 8b 14 24 0f 85 35 01 00 00 9c 58 f6 c4 02 0f 85 52 01 00 00 4d 85 d2 0f 85 1b 01 00 00 <48> 8b 44 24 30 65 48 2b 05 d1 62 38 04 0f 85 48 01 00 00 48 83 c4 All code ======== 0: ff 65 0f jmp *0xf(%rbp) 3: c1 05 ff a7 38 04 83 roll $0x83,0x438a7ff(%rip) # 0x438a809 a: f8 clc b: 01 4c 8b 14 add %ecx,0x14(%rbx,%rcx,4) f: 24 0f and $0xf,%al 11: 85 35 01 00 00 9c test %esi,-0x63ffffff(%rip) # 0xffffffff9c000018 17: 58 pop %rax 18: f6 c4 02 test $0x2,%ah 1b: 0f 85 52 01 00 00 jne 0x173 21: 4d 85 d2 test %r10,%r10 24: 0f 85 1b 01 00 00 jne 0x145 2a:* 48 8b 44 24 30 mov 0x30(%rsp),%rax <-- trapping instruction 2f: 65 48 2b 05 d1 62 38 sub %gs:0x43862d1(%rip),%rax # 0x4386308 36: 04 37: 0f 85 48 01 00 00 jne 0x185 3d: 48 rex.W 3e: 83 .byte 0x83 3f: c4 .byte 0xc4 Code starting with the faulting instruction =========================================== 0: 48 8b 44 24 30 mov 0x30(%rsp),%rax 5: 65 48 2b 05 d1 62 38 sub %gs:0x43862d1(%rip),%rax # 0x43862de c: 04 d: 0f 85 48 01 00 00 jne 0x15b 13: 48 rex.W 14: 83 .byte 0x83 15: c4 .byte 0xc4 [ 286.414531][ C0] RSP: 0018:ffa000002465f4a0 EFLAGS: 00000206 [ 286.414534][ C0] RAX: 0000000000000046 RBX: 0000000000000000 RCX: 5eaeee35fd653602 [ 286.414535][ C0] RDX: 0000000000000000 RSI: ffffffff9e221b20 RDI: ffffffff9dc8d8e0 [ 286.414536][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ff1100001df2d1f8 [ 286.414537][ C0] R10: 0000000000000200 R11: 0000000000000001 R12: ffffffff9e780b00 [ 286.414538][ C0] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000002 [ 286.414540][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 286.414542][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 286.414544][ C0] unwind_next_frame (./include/linux/rcupdate.h:309 (discriminator 2) ./include/linux/rcupdate.h:849 (discriminator 2) ./include/linux/rcupdate.h:1216 (discriminator 2) arch/x86/kernel/unwind_orc.c:495 (discriminator 2)) [ 286.414545][ C0] ? unwind_next_frame (./include/linux/rcupdate.h:309 (discriminator 2) ./include/linux/rcupdate.h:849 (discriminator 2) ./include/linux/rcupdate.h:1216 (discriminator 2) arch/x86/kernel/unwind_orc.c:495 (discriminator 2)) [ 286.414546][ C0] ? __unwind_start (arch/x86/kernel/unwind_orc.c:741) [ 286.414548][ C0] ? stack_access_ok (./arch/x86/include/asm/stacktrace.h:55) [ 286.414550][ C0] ? get_stack_info_noinstr (arch/x86/kernel/dumpstack_64.c:173) [ 286.414552][ C0] __unwind_start (arch/x86/kernel/unwind_orc.c:787) [ 286.414553][ C0] ? write_profile (profile.c:?) [ 286.414555][ C0] arch_stack_walk (./arch/x86/include/asm/unwind.h:64 arch/x86/kernel/stacktrace.c:24) [ 286.414557][ C0] ? __unwind_start (arch/x86/kernel/unwind_orc.c:741) [ 286.414559][ C0] stack_trace_save (kernel/stacktrace.c:122 (discriminator 1)) [ 286.414560][ C0] ? filter_irq_stacks (kernel/stacktrace.c:402) [ 286.414563][ C0] set_track_prepare (mm/slub.c:1074) [ 286.414565][ C0] free_to_partial_list (mm/slub.c:5627) [ 286.414566][ C0] ? qlist_free_all (mm/kasan/quarantine.c:163 (discriminator 2) mm/kasan/quarantine.c:179 (discriminator 2)) [ 286.414568][ C0] qlist_free_all (mm/kasan/quarantine.c:163 (discriminator 2) mm/kasan/quarantine.c:179 (discriminator 2)) [ 286.414570][ C0] kasan_quarantine_reduce (mm/kasan/quarantine.c:286) [ 286.414571][ C0] __kasan_slab_alloc (mm/kasan/common.c:350) [ 286.414573][ C0] __kmalloc_cache_noprof (./include/linux/kasan.h:253 mm/slub.c:4683 mm/slub.c:4996 mm/slub.c:5559) [ 286.414575][ C0] ? ovl_open (./include/linux/slab.h:991 (discriminator 1) ./include/linux/slab.h:1312 (discriminator 1) fs/overlayfs/file.c:99 (discriminator 1) fs/overlayfs/file.c:226 (discriminator 1)) [ 286.414577][ C0] ovl_open (./include/linux/slab.h:991 (discriminator 1) ./include/linux/slab.h:1312 (discriminator 1) fs/overlayfs/file.c:99 (discriminator 1) fs/overlayfs/file.c:226 (discriminator 1)) [ 286.414579][ C0] ? ovl_llseek (fs/overlayfs/file.c:255) [ 286.414581][ 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) [ 286.414582][ C0] ? ovl_llseek (fs/overlayfs/file.c:255) [ 286.414584][ C0] do_dentry_open (fs/open.c:996) [ 286.414586][ C0] vfs_open (fs/open.c:1101) [ 286.414588][ C0] ? may_open (fs/namei.c:4269) [ 286.414590][ C0] do_open (fs/namei.c:4837) [ 286.414591][ C0] ? open_last_lookups (fs/namei.c:2152 fs/namei.c:4780) [ 286.414593][ C0] path_openat (fs/namei.c:5000) [ 286.414594][ C0] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 286.414596][ C0] ? kernel_tmpfile_open (fs/namei.c:4942) [ 286.414598][ C0] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 286.414601][ C0] do_file_open (fs/namei.c:5029) [ 286.414602][ C0] ? path_openat (./include/linux/mount.h:68 (discriminator 3)) [ 286.414604][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 286.414606][ C0] ? page_get_link_raw (fs/namei.c:6482) [ 286.414608][ C0] ? _raw_spin_unlock (./include/linux/spinlock_api_smp.h:201 (discriminator 1) kernel/locking/spinlock.c:213 (discriminator 1)) [ 286.414611][ C0] ? alloc_fd (./include/linux/spinlock.h:401 fs/file.c:610) [ 286.414614][ C0] do_sys_openat2 (fs/open.c:1417 (discriminator 5)) [ 286.414616][ C0] ? build_open_flags (fs/open.c:1319 (discriminator 3)) [ 286.414619][ C0] __x64_sys_openat (fs/open.c:1423 fs/open.c:1439 fs/open.c:1434 fs/open.c:1434) [ 286.414621][ C0] ? __ia32_sys_open (fs/open.c:1427) [ 286.414622][ C0] ? fpregs_restore_userregs (./include/linux/instrumented.h:97 ./include/asm-generic/bitops/instrumented-atomic.h:41 ./include/linux/thread_info.h:109 arch/x86/kernel/fpu/context.h:79) [ 286.414624][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 286.414625][ C0] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 286.414628][ C0] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 286.414629][ C0] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 286.414631][ C0] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 286.414632][ C0] RIP: 0033:0x7f98833536e5 [ 286.414635][ C0] Code: 48 89 e5 48 89 55 e0 41 83 e2 40 75 28 89 f2 f7 d2 81 e2 00 00 41 00 74 1c 89 f2 bf 9c ff ff ff 48 89 c6 b8 01 01 00 00 0f 05 <48> 3d 00 f0 ff ff 77 23 5d c3 90 48 8d 4d 10 c7 45 b8 10 00 00 00 All code ======== 0: 48 89 e5 mov %rsp,%rbp 3: 48 89 55 e0 mov %rdx,-0x20(%rbp) 7: 41 83 e2 40 and $0x40,%r10d b: 75 28 jne 0x35 d: 89 f2 mov %esi,%edx f: f7 d2 not %edx 11: 81 e2 00 00 41 00 and $0x410000,%edx 17: 74 1c je 0x35 19: 89 f2 mov %esi,%edx 1b: bf 9c ff ff ff mov $0xffffff9c,%edi 20: 48 89 c6 mov %rax,%rsi 23: b8 01 01 00 00 mov $0x101,%eax 28: 0f 05 syscall 2a:* 48 3d 00 f0 ff ff cmp $0xfffffffffffff000,%rax <-- trapping instruction 30: 77 23 ja 0x55 32: 5d pop %rbp 33: c3 ret 34: 90 nop 35: 48 8d 4d 10 lea 0x10(%rbp),%rcx 39: c7 45 b8 10 00 00 00 movl $0x10,-0x48(%rbp) Code starting with the faulting instruction =========================================== 0: 48 3d 00 f0 ff ff cmp $0xfffffffffffff000,%rax 6: 77 23 ja 0x2b 8: 5d pop %rbp 9: c3 ret a: 90 nop b: 48 8d 4d 10 lea 0x10(%rbp),%rcx f: c7 45 b8 10 00 00 00 movl $0x10,-0x48(%rbp) [ 286.414636][ C0] RSP: 002b:00007ffd3d4c6130 EFLAGS: 00000206 ORIG_RAX: 0000000000000101 [ 286.414638][ C0] RAX: ffffffffffffffda RBX: 00007ffd3d4c63c0 RCX: 00007f98833536e5 [ 286.414638][ C0] RDX: 0000000000080000 RSI: 00007ffd3d4c61b0 RDI: 00000000ffffff9c [ 286.414639][ C0] RBP: 00007ffd3d4c6130 R08: 00007ffd3d4c63a7 R09: 0000000000000000 [ 286.414640][ C0] R10: 0000000000000000 R11: 0000000000000206 R12: 00007ffd3d4c61b0 [ 286.414641][ C0] R13: 00007ffd3d4c61b0 R14: 00007f9883325000 R15: 0000000000000000 | [ 286.414658][ C0] softirqs last disabled at (7989): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 286.414659][ C0] Preemption disabled at: | [ 286.414660][ C0] handle_softirqs (kernel/softirq.c:486 (discriminator 1) kernel/softirq.c:621 (discriminator 1)) | [ 286.414664][ C0] Tainted: [W]=WARN [ 286.414665][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 286.414665][ C0] Call Trace: [ 286.414666][ C0] [ 286.414667][ C0] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 286.414669][ C0] ? handle_softirqs (kernel/softirq.c:486 (discriminator 1) kernel/softirq.c:621 (discriminator 1)) [ 286.414670][ C0] __might_resched.cold (kernel/sched/core.c:9234) [ 286.414673][ C0] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 286.414676][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 286.414678][ 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)) [ 286.414680][ C0] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 286.414681][ C0] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 286.414683][ 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) [ 286.414685][ C0] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 286.414687][ C0] put_chars (drivers/char/virtio_console.c:1176) [ 286.414688][ C0] ? __send_to_port (drivers/char/virtio_console.c:654) [ 286.414690][ C0] ? mark_lock (kernel/locking/lockdep.c:4769) [ 286.414692][ C0] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 286.414694][ C0] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 286.414696][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 286.414697][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 286.414700][ C0] console_emit_next_record (kernel/printk/printk.c:3183) [ 286.414702][ C0] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 286.414703][ 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)) [ 286.414706][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 286.414707][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 286.414709][ C0] console_flush_one_record (kernel/printk/printk.c:3268) [ 286.414711][ C0] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 286.414713][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 286.414715][ C0] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 286.414717][ C0] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 286.414719][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 286.414720][ C0] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 286.414722][ C0] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 286.414724][ C0] ? vprintk_emit (kernel/printk/printk.c:2478) [ 286.414726][ C0] vprintk_emit (kernel/printk/printk.c:2479) [ 286.414728][ C0] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 286.414730][ C0] ? clocksource_watchdog.part.0 (kernel/time/clocksource.c:531 (discriminator 1) kernel/time/clocksource.c:608 (discriminator 1) kernel/time/clocksource.c:667 (discriminator 1)) [ 286.414732][ C0] _printk (kernel/printk/printk.c:2504) [ 286.414734][ C0] ? snapshot_read.cold (user.c:?) [ 286.414736][ C0] ? clocksource_watchdog.part.0 (kernel/time/clocksource.c:531 (discriminator 1) kernel/time/clocksource.c:608 (discriminator 1) kernel/time/clocksource.c:667 (discriminator 1)) [ 286.414737][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 286.414740][ C0] clocksource_watchdog.part.0.cold (kernel/time/clocksource.c:589 (discriminator 10) kernel/time/clocksource.c:632 (discriminator 10) kernel/time/clocksource.c:667 (discriminator 10)) [ 286.414741][ C0] ? clocksource_watchdog.part.0 (./include/linux/find.h:67 (discriminator 4)) [ 286.414743][ C0] ? clocksource_watchdog.part.0 (./include/linux/find.h:67 (discriminator 4)) [ 286.414744][ C0] call_timer_fn (kernel/time/timer.c:1748) [ 286.414746][ C0] ? detach_if_pending (./include/linux/list.h:1159) [ 286.414748][ C0] ? debug_object_active_state (lib/debugobjects.c:1122) [ 286.414749][ C0] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 286.414753][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 286.414755][ C0] ? mark_held_locks (kernel/locking/lockdep.c:4341) [ 286.414757][ C0] __run_timers (kernel/time/timer.c:1799 kernel/time/timer.c:2374) [ 286.414758][ C0] ? clocksource_watchdog.part.0 (./include/linux/find.h:67 (discriminator 4)) [ 286.414761][ C0] ? __bpf_trace_itimer_expire (./include/trace/events/timer.h:407) [ 286.414763][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 286.414766][ C0] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 286.414768][ C0] run_timer_softirq (kernel/time/timer.c:2386 kernel/time/timer.c:2395 kernel/time/timer.c:2403) [ 286.414770][ C0] ? __run_timers (./include/trace/events/timer.h:138 (discriminator 19)) [ 286.414772][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 286.414774][ C0] handle_softirqs (kernel/softirq.c:645) [ 286.414775][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 286.414777][ C0] ? _local_bh_enable (kernel/softirq.c:428 (discriminator 1)) [ 286.414779][ C0] __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) [ 286.414780][ C0] irq_exit_rcu (kernel/softirq.c:784) [ 286.414782][ C0] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1062 (discriminator 37) arch/x86/kernel/apic/apic.c:1062 (discriminator 37)) [ 286.414783][ C0] [ 286.414784][ C0] [ 286.414785][ C0] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:674) [ 286.414786][ C0] RIP: 0010:lock_acquire.part.0 (./arch/x86/include/asm/irqflags.h:158 (discriminator 1) kernel/locking/lockdep.c:5912 (discriminator 1)) [ 286.414788][ C0] Code: ff 65 0f c1 05 ff a7 38 04 83 f8 01 4c 8b 14 24 0f 85 35 01 00 00 9c 58 f6 c4 02 0f 85 52 01 00 00 4d 85 d2 0f 85 1b 01 00 00 <48> 8b 44 24 30 65 48 2b 05 d1 62 38 04 0f 85 48 01 00 00 48 83 c4 All code ======== 0: ff 65 0f jmp *0xf(%rbp) 3: c1 05 ff a7 38 04 83 roll $0x83,0x438a7ff(%rip) # 0x438a809 a: f8 clc b: 01 4c 8b 14 add %ecx,0x14(%rbx,%rcx,4) f: 24 0f and $0xf,%al 11: 85 35 01 00 00 9c test %esi,-0x63ffffff(%rip) # 0xffffffff9c000018 17: 58 pop %rax 18: f6 c4 02 test $0x2,%ah 1b: 0f 85 52 01 00 00 jne 0x173 21: 4d 85 d2 test %r10,%r10 24: 0f 85 1b 01 00 00 jne 0x145 2a:* 48 8b 44 24 30 mov 0x30(%rsp),%rax <-- trapping instruction 2f: 65 48 2b 05 d1 62 38 sub %gs:0x43862d1(%rip),%rax # 0x4386308 36: 04 37: 0f 85 48 01 00 00 jne 0x185 3d: 48 rex.W 3e: 83 .byte 0x83 3f: c4 .byte 0xc4 Code starting with the faulting instruction =========================================== 0: 48 8b 44 24 30 mov 0x30(%rsp),%rax 5: 65 48 2b 05 d1 62 38 sub %gs:0x43862d1(%rip),%rax # 0x43862de c: 04 d: 0f 85 48 01 00 00 jne 0x15b 13: 48 rex.W 14: 83 .byte 0x83 15: c4 .byte 0xc4 [ 286.414789][ C0] RSP: 0018:ffa000002465f4a0 EFLAGS: 00000206 [ 286.414790][ C0] RAX: 0000000000000046 RBX: 0000000000000000 RCX: 5eaeee35fd653602 [ 286.414791][ C0] RDX: 0000000000000000 RSI: ffffffff9e221b20 RDI: ffffffff9dc8d8e0 [ 286.414792][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ff1100001df2d1f8 [ 286.414792][ C0] R10: 0000000000000200 R11: 0000000000000001 R12: ffffffff9e780b00 [ 286.414793][ C0] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000002 [ 286.414795][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 286.414797][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 286.414799][ C0] unwind_next_frame (./include/linux/rcupdate.h:309 (discriminator 2) ./include/linux/rcupdate.h:849 (discriminator 2) ./include/linux/rcupdate.h:1216 (discriminator 2) arch/x86/kernel/unwind_orc.c:495 (discriminator 2)) [ 286.414800][ C0] ? unwind_next_frame (./include/linux/rcupdate.h:309 (discriminator 2) ./include/linux/rcupdate.h:849 (discriminator 2) ./include/linux/rcupdate.h:1216 (discriminator 2) arch/x86/kernel/unwind_orc.c:495 (discriminator 2)) [ 286.414801][ C0] ? __unwind_start (arch/x86/kernel/unwind_orc.c:741) [ 286.414803][ C0] ? stack_access_ok (./arch/x86/include/asm/stacktrace.h:55) [ 286.414805][ C0] ? get_stack_info_noinstr (arch/x86/kernel/dumpstack_64.c:173) [ 286.414807][ C0] __unwind_start (arch/x86/kernel/unwind_orc.c:787) [ 286.414808][ C0] ? write_profile (profile.c:?) [ 286.414810][ C0] arch_stack_walk (./arch/x86/include/asm/unwind.h:64 arch/x86/kernel/stacktrace.c:24) [ 286.414812][ C0] ? __unwind_start (arch/x86/kernel/unwind_orc.c:741) [ 286.414814][ C0] stack_trace_save (kernel/stacktrace.c:122 (discriminator 1)) [ 286.414815][ C0] ? filter_irq_stacks (kernel/stacktrace.c:402) [ 286.414817][ C0] set_track_prepare (mm/slub.c:1074) [ 286.414820][ C0] free_to_partial_list (mm/slub.c:5627) [ 286.414821][ C0] ? qlist_free_all (mm/kasan/quarantine.c:163 (discriminator 2) mm/kasan/quarantine.c:179 (discriminator 2)) [ 286.414823][ C0] qlist_free_all (mm/kasan/quarantine.c:163 (discriminator 2) mm/kasan/quarantine.c:179 (discriminator 2)) [ 286.414824][ C0] kasan_quarantine_reduce (mm/kasan/quarantine.c:286) [ 286.414826][ C0] __kasan_slab_alloc (mm/kasan/common.c:350) [ 286.414828][ C0] __kmalloc_cache_noprof (./include/linux/kasan.h:253 mm/slub.c:4683 mm/slub.c:4996 mm/slub.c:5559) [ 286.414830][ C0] ? ovl_open (./include/linux/slab.h:991 (discriminator 1) ./include/linux/slab.h:1312 (discriminator 1) fs/overlayfs/file.c:99 (discriminator 1) fs/overlayfs/file.c:226 (discriminator 1)) [ 286.414832][ C0] ovl_open (./include/linux/slab.h:991 (discriminator 1) ./include/linux/slab.h:1312 (discriminator 1) fs/overlayfs/file.c:99 (discriminator 1) fs/overlayfs/file.c:226 (discriminator 1)) [ 286.414834][ C0] ? ovl_llseek (fs/overlayfs/file.c:255) [ 286.414835][ 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) [ 286.414837][ C0] ? ovl_llseek (fs/overlayfs/file.c:255) [ 286.414839][ C0] do_dentry_open (fs/open.c:996) [ 286.414841][ C0] vfs_open (fs/open.c:1101) [ 286.414843][ C0] ? may_open (fs/namei.c:4269) [ 286.414844][ C0] do_open (fs/namei.c:4837) [ 286.414846][ C0] ? open_last_lookups (fs/namei.c:2152 fs/namei.c:4780) [ 286.414847][ C0] path_openat (fs/namei.c:5000) [ 286.414849][ C0] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 286.414850][ C0] ? kernel_tmpfile_open (fs/namei.c:4942) [ 286.414852][ C0] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 286.414855][ C0] do_file_open (fs/namei.c:5029) [ 286.414856][ C0] ? path_openat (./include/linux/mount.h:68 (discriminator 3)) [ 286.414858][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 286.414860][ C0] ? page_get_link_raw (fs/namei.c:6482) [ 286.414862][ C0] ? _raw_spin_unlock (./include/linux/spinlock_api_smp.h:201 (discriminator 1) kernel/locking/spinlock.c:213 (discriminator 1)) [ 286.414864][ C0] ? alloc_fd (./include/linux/spinlock.h:401 fs/file.c:610) [ 286.414866][ C0] do_sys_openat2 (fs/open.c:1417 (discriminator 5)) [ 286.414868][ C0] ? build_open_flags (fs/open.c:1319 (discriminator 3)) [ 286.414871][ C0] __x64_sys_openat (fs/open.c:1423 fs/open.c:1439 fs/open.c:1434 fs/open.c:1434) [ 286.414873][ C0] ? __ia32_sys_open (fs/open.c:1427) [ 286.414875][ C0] ? fpregs_restore_userregs (./include/linux/instrumented.h:97 ./include/asm-generic/bitops/instrumented-atomic.h:41 ./include/linux/thread_info.h:109 arch/x86/kernel/fpu/context.h:79) [ 286.414876][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 286.414878][ C0] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 286.414879][ C0] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 286.414880][ C0] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 286.414882][ C0] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 286.414883][ C0] RIP: 0033:0x7f98833536e5 [ 286.414884][ C0] Code: 48 89 e5 48 89 55 e0 41 83 e2 40 75 28 89 f2 f7 d2 81 e2 00 00 41 00 74 1c 89 f2 bf 9c ff ff ff 48 89 c6 b8 01 01 00 00 0f 05 <48> 3d 00 f0 ff ff 77 23 5d c3 90 48 8d 4d 10 c7 45 b8 10 00 00 00 All code ======== 0: 48 89 e5 mov %rsp,%rbp 3: 48 89 55 e0 mov %rdx,-0x20(%rbp) 7: 41 83 e2 40 and $0x40,%r10d b: 75 28 jne 0x35 d: 89 f2 mov %esi,%edx f: f7 d2 not %edx 11: 81 e2 00 00 41 00 and $0x410000,%edx 17: 74 1c je 0x35 19: 89 f2 mov %esi,%edx 1b: bf 9c ff ff ff mov $0xffffff9c,%edi 20: 48 89 c6 mov %rax,%rsi 23: b8 01 01 00 00 mov $0x101,%eax 28: 0f 05 syscall 2a:* 48 3d 00 f0 ff ff cmp $0xfffffffffffff000,%rax <-- trapping instruction 30: 77 23 ja 0x55 32: 5d pop %rbp 33: c3 ret 34: 90 nop 35: 48 8d 4d 10 lea 0x10(%rbp),%rcx 39: c7 45 b8 10 00 00 00 movl $0x10,-0x48(%rbp) Code starting with the faulting instruction =========================================== 0: 48 3d 00 f0 ff ff cmp $0xfffffffffffff000,%rax 6: 77 23 ja 0x2b 8: 5d pop %rbp 9: c3 ret a: 90 nop b: 48 8d 4d 10 lea 0x10(%rbp),%rcx f: c7 45 b8 10 00 00 00 movl $0x10,-0x48(%rbp) [ 286.414885][ C0] RSP: 002b:00007ffd3d4c6130 EFLAGS: 00000206 ORIG_RAX: 0000000000000101 [ 286.414886][ C0] RAX: ffffffffffffffda RBX: 00007ffd3d4c63c0 RCX: 00007f98833536e5 [ 286.414887][ C0] RDX: 0000000000080000 RSI: 00007ffd3d4c61b0 RDI: 00000000ffffff9c [ 286.414888][ C0] RBP: 00007ffd3d4c6130 R08: 00007ffd3d4c63a7 R09: 0000000000000000 [ 286.414889][ C0] R10: 0000000000000000 R11: 0000000000000206 R12: 00007ffd3d4c61b0 Finger prints: mark_lock_irq:mark_lock:mark_usage:__lock_acquire:console_lock_spinning_enable __irq_exit_rcu:vprintk_emit:dump_stack_lvl:__kmalloc_noprof:put_chars __irq_exit_rcu:dump_stack_lvl:__kmalloc_noprof:put_chars:hvc_console_print __irq_exit_rcu:handle_softirqs:dump_stack_lvl:__kmalloc_noprof:put_chars