====================================== | [ 9.733058][ T188] softirqs last disabled at (31665): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 9.733061][ T188] Preemption disabled at: | [ 9.733061][ T188] 0x0 | [ 9.733071][ T188] Tainted: [W]=WARN [ 9.733072][ T188] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.733074][ T188] Call Trace: [ 9.733076][ T188] [ 9.733077][ T188] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 9.733083][ T188] __might_resched.cold (kernel/sched/core.c:9234) [ 9.733088][ T188] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 9.733092][ T188] ? __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.733096][ T188] __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.733099][ T188] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 9.733104][ T188] ? 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.733107][ T188] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 9.733110][ T188] put_chars (drivers/char/virtio_console.c:1176) [ 9.733113][ T188] ? __send_to_port (drivers/char/virtio_console.c:654) [ 9.733114][ T188] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 9.733119][ T188] ? validate_chain (kernel/locking/lockdep.c:3817 (discriminator 2) kernel/locking/lockdep.c:3837 (discriminator 2) kernel/locking/lockdep.c:3892 (discriminator 2)) [ 9.733124][ T188] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 9.733130][ T188] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 9.733132][ T188] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 9.733134][ T188] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 9.733138][ T188] console_emit_next_record (kernel/printk/printk.c:3183) [ 9.733142][ T188] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 9.733144][ T188] ? 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.733147][ T188] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 9.733149][ T188] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 9.733153][ T188] console_flush_one_record (kernel/printk/printk.c:3268) [ 9.733157][ T188] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 9.733159][ T188] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 9.733164][ T188] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 9.733166][ T188] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 9.733168][ T188] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 9.733170][ T188] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 9.733174][ T188] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 9.733176][ T188] ? vprintk_emit (kernel/printk/printk.c:2478) [ 9.733179][ T188] vprintk_emit (kernel/printk/printk.c:2479) [ 9.733182][ T188] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 9.733186][ T188] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 9.733189][ T188] _printk (kernel/printk/printk.c:2504) [ 9.733193][ T188] ? snapshot_read.cold (user.c:?) [ 9.733196][ T188] ? 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.733198][ T188] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 9.733202][ T188] ? 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.733205][ T188] do_exit.cold (kernel/exit.c:889 (discriminator 4) kernel/exit.c:1043 (discriminator 4)) [ 9.733208][ T188] ? exit_notify (kernel/exit.c:780) [ 9.733210][ T188] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 9.733213][ T188] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 9.733217][ T188] do_group_exit (kernel/exit.c:1151) [ 9.733219][ T188] __x64_sys_exit_group (kernel/exit.c:1162 kernel/exit.c:1160 kernel/exit.c:1160) [ 9.733221][ T188] x64_sys_call (./arch/x86/include/generated/asm/syscalls_64.h:232) [ 9.733223][ T188] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 9.733226][ T188] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 9.733229][ T188] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 9.733232][ T188] RIP: 0033:0x7fa1b54641b8 [ 9.733234][ T188] Code: Unable to access opcode bytes at 0x7fa1b546418e. Code starting with the faulting instruction =========================================== [ 9.733235][ T188] RSP: 002b:00007fff295fced8 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 9.733237][ T188] RAX: ffffffffffffffda RBX: 00007fa1b5594f88 RCX: 00007fa1b54641b8 [ 9.733239][ T188] RDX: 00007fa1b51aefc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 9.733240][ T188] RBP: 00007fff295fcf30 R08: 0000000000000000 R09: 0000000000008010 [ 9.733241][ T188] R10: 00007fff295fccf0 R11: 0000000000000246 R12: 0000000000000001 [ 9.733241][ T188] R13: 0000000000000000 R14: 00007fa1b5593680 R15: 00007fa1b5594fa0 | [ 10.830705][ T246] softirqs last disabled at (36773): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 10.830707][ T246] Preemption disabled at: | [ 10.830708][ T246] vprintk_emit (kernel/printk/printk.c:2471) | [ 10.830717][ T246] Tainted: [W]=WARN [ 10.830718][ T246] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.830720][ T246] Call Trace: [ 10.830721][ T246] [ 10.830723][ T246] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 10.830728][ T246] ? vprintk_emit (kernel/printk/printk.c:2471) [ 10.830730][ T246] __might_resched.cold (kernel/sched/core.c:9234) [ 10.830735][ T246] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 10.830739][ T246] ? __kmalloc_noprof (./include/linux/sched/mm.h:317 mm/slub.c:4636 mm/slub.c:4974 mm/slub.c:5413 mm/slub.c:5439) [ 10.830744][ T246] __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)) [ 10.830746][ T246] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 10.830752][ T246] ? 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) [ 10.830754][ T246] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 10.830757][ T246] put_chars (drivers/char/virtio_console.c:1176) [ 10.830760][ T246] ? __send_to_port (drivers/char/virtio_console.c:654) [ 10.830761][ T246] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 10.830766][ T246] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 10.830768][ T246] ? validate_chain (kernel/locking/lockdep.c:3817 (discriminator 2) kernel/locking/lockdep.c:3837 (discriminator 2) kernel/locking/lockdep.c:3892 (discriminator 2)) [ 10.830773][ T246] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 10.830775][ T246] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 10.830780][ T246] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 10.830783][ T246] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 10.830788][ T246] console_emit_next_record (kernel/printk/printk.c:3183) [ 10.830792][ T246] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 10.830794][ T246] ? 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)) [ 10.830797][ T246] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 10.830799][ T246] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 10.830803][ T246] console_flush_one_record (kernel/printk/printk.c:3268) [ 10.830807][ T246] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 10.830808][ T246] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 10.830813][ T246] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 10.830816][ T246] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 10.830818][ T246] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 10.830820][ T246] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 10.830824][ T246] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 10.830825][ T246] ? vprintk_emit (kernel/printk/printk.c:2478) [ 10.830828][ T246] vprintk_emit (kernel/printk/printk.c:2479) [ 10.830832][ T246] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 10.830838][ T246] ? vlan_netlink_fini (./include/linux/etherdevice.h:306 net/8021q/vlan.c:316 net/8021q/vlan.c:416) 8021q [ 10.830842][ T246] _printk (kernel/printk/printk.c:2504) [ 10.830845][ T246] ? snapshot_read.cold (user.c:?) [ 10.830851][ T246] ? 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) [ 10.830854][ T246] vlan_proto_init (./include/linux/rcupdate.h:309 (discriminator 2) ./include/linux/rcupdate.h:849 (discriminator 2) ./include/net/netns/generic.h:45 (discriminator 2)) 8021q [ 10.830857][ T246] do_one_initcall (init/main.c:1357) [ 10.830860][ T246] ? trace_event_raw_event_initcall_level (./include/trace/events/initcall.h:10) [ 10.830865][ T246] ? do_init_module (./include/linux/slab.h:991 (discriminator 1) kernel/module/main.c:3105 (discriminator 1)) [ 10.830867][ T246] ? kasan_unpoison (mm/kasan/shadow.c:146 mm/kasan/shadow.c:178) [ 10.830872][ T246] do_init_module (kernel/module/main.c:3117) [ 10.830876][ T246] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488) [ 10.830880][ T246] ? free_module (./include/trace/events/module.h:50 (discriminator 19)) [ 10.830883][ T246] ? kfree (./include/linux/kasan.h:235 mm/slub.c:2748 mm/slub.c:6499 mm/slub.c:6792) [ 10.830887][ T246] load_module (kernel/module/main.c:3593) [ 10.830894][ T246] ? layout_and_allocate.isra.0 (kernel/module/main.c:3016) [ 10.830898][ T246] ? __ia32_sys_fsconfig (??:?) [ 10.830901][ T246] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 10.830903][ T246] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 10.830907][ T246] init_module_from_file (kernel/module/main.c:3790) [ 10.830910][ T246] ? __do_sys_init_module (kernel/module/main.c:3664) [ 10.830918][ T246] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 10.830922][ T246] ? 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) [ 10.830925][ T246] idempotent_init_module (kernel/module/main.c:3802) [ 10.830928][ T246] ? init_module_from_file (kernel/module/main.c:3791) [ 10.830934][ T246] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 10.830937][ T246] ? cap_capable (./include/trace/events/capability.h:26 (discriminator 22) security/commoncap.c:130 (discriminator 22)) [ 10.830943][ T246] __x64_sys_finit_module (kernel/module/main.c:3828 kernel/module/main.c:3812 kernel/module/main.c:3812) [ 10.830945][ T246] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 10.830948][ T246] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 10.830950][ T246] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 10.830953][ T246] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 10.830955][ T246] RIP: 0033:0x7f084076a37d [ 10.830958][ T246] 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 [ 10.830960][ T246] RSP: 002b:00007ffca3923728 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 10.830963][ T246] RAX: ffffffffffffffda RBX: 000055c662f27810 RCX: 00007f084076a37d [ 10.830964][ T246] RDX: 0000000000000000 RSI: 000055c650e65ffd RDI: 0000000000000000 [ 10.830965][ T246] RBP: 00007ffca39237c0 R08: 0000000000000000 R09: 0000000000000000 [ 10.830966][ T246] R10: 0000000000000000 R11: 0000000000000246 R12: 000055c650e65ffd [ 10.830967][ T246] R13: 000055c662f27960 R14: 0000000000040000 R15: 0000000000000000 | [ 12.151567][ T316] softirqs last disabled at (20213): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 12.151570][ T316] Preemption disabled at: | [ 12.151570][ T316] vprintk_emit (kernel/printk/printk.c:2471) | [ 12.151580][ T316] Tainted: [W]=WARN [ 12.151581][ T316] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.151583][ T316] Call Trace: [ 12.151585][ T316] [ 12.151586][ T316] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 12.151591][ T316] ? vprintk_emit (kernel/printk/printk.c:2471) [ 12.151594][ T316] __might_resched.cold (kernel/sched/core.c:9234) [ 12.151598][ T316] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 12.151602][ T316] ? __kmalloc_noprof (./include/linux/sched/mm.h:317 mm/slub.c:4636 mm/slub.c:4974 mm/slub.c:5413 mm/slub.c:5439) [ 12.151607][ T316] __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)) [ 12.151610][ T316] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 12.151615][ T316] ? 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) [ 12.151618][ T316] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 12.151621][ T316] put_chars (drivers/char/virtio_console.c:1176) [ 12.151623][ T316] ? desc_read_finalized_seq (kernel/printk/printk_ringbuffer.c:1934) [ 12.151625][ T316] ? __send_to_port (drivers/char/virtio_console.c:654) [ 12.151628][ T316] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 12.151631][ T316] ? validate_chain (kernel/locking/lockdep.c:3817 (discriminator 2) kernel/locking/lockdep.c:3837 (discriminator 2) kernel/locking/lockdep.c:3892 (discriminator 2)) [ 12.151635][ T316] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 12.151638][ T316] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 12.151639][ T316] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 12.151644][ T316] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 12.151645][ T316] ? console_emit_next_record (kernel/printk/printk.c:3095 (discriminator 2) kernel/printk/printk.c:3182 (discriminator 2)) [ 12.151648][ T316] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 12.151651][ T316] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 12.151655][ T316] console_emit_next_record (kernel/printk/printk.c:3183) [ 12.151659][ T316] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 12.151660][ T316] ? 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)) [ 12.151664][ T316] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 12.151666][ T316] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 12.151670][ T316] console_flush_one_record (kernel/printk/printk.c:3268) [ 12.151674][ T316] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 12.151675][ T316] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 12.151680][ T316] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 12.151683][ T316] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 12.151685][ T316] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 12.151687][ T316] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 12.151690][ T316] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 12.151692][ T316] ? vprintk_emit (kernel/printk/printk.c:2478) [ 12.151695][ T316] vprintk_emit (kernel/printk/printk.c:2479) [ 12.151700][ T316] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 12.151706][ T316] ? gact_cleanup_module (net/sched/act_gact.c:192) act_gact [ 12.151709][ T316] _printk (kernel/printk/printk.c:2504) [ 12.151712][ T316] ? snapshot_read.cold (user.c:?) [ 12.151718][ T316] ? 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) [ 12.151721][ T316] gact_init_module (net/sched/act_gact.c:180) act_gact [ 12.151723][ T316] do_one_initcall (init/main.c:1357) [ 12.151726][ T316] ? trace_event_raw_event_initcall_level (./include/trace/events/initcall.h:10) [ 12.151730][ T316] ? do_init_module (./include/linux/slab.h:991 (discriminator 1) kernel/module/main.c:3105 (discriminator 1)) [ 12.151733][ T316] ? kasan_unpoison (mm/kasan/shadow.c:146 mm/kasan/shadow.c:178) [ 12.151738][ T316] do_init_module (kernel/module/main.c:3117) [ 12.151742][ T316] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488) [ 12.151744][ T316] ? free_module (./include/trace/events/module.h:50 (discriminator 19)) [ 12.151747][ T316] ? kfree (./include/linux/kasan.h:235 mm/slub.c:2748 mm/slub.c:6499 mm/slub.c:6792) [ 12.151751][ T316] load_module (kernel/module/main.c:3593) [ 12.151758][ T316] ? layout_and_allocate.isra.0 (kernel/module/main.c:3016) [ 12.151762][ T316] ? __ia32_sys_fsconfig (??:?) [ 12.151765][ T316] ? ovl_real_file (fs/overlayfs/file.c:195) [ 12.151769][ T316] ? backing_file_read_iter (fs/backing-file.c:211) [ 12.151772][ T316] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 12.151776][ T316] init_module_from_file (kernel/module/main.c:3790) [ 12.151779][ T316] ? __do_sys_init_module (kernel/module/main.c:3664) [ 12.151788][ T316] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 12.151792][ T316] ? 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) [ 12.151795][ T316] idempotent_init_module (kernel/module/main.c:3802) [ 12.151798][ T316] ? init_module_from_file (kernel/module/main.c:3791) [ 12.151804][ T316] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 12.151806][ T316] ? cap_capable (./include/trace/events/capability.h:26 (discriminator 22) security/commoncap.c:130 (discriminator 22)) [ 12.151812][ T316] __x64_sys_finit_module (kernel/module/main.c:3828 kernel/module/main.c:3812 kernel/module/main.c:3812) [ 12.151814][ T316] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 12.151818][ T316] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 12.151820][ T316] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 12.151822][ T316] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 12.151825][ T316] RIP: 0033:0x7f184bb7537d [ 12.151829][ T316] 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 [ 12.151830][ T316] RSP: 002b:00007ffe8572bfb8 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 12.151833][ T316] RAX: ffffffffffffffda RBX: 000055f7de3a8810 RCX: 00007f184bb7537d [ 12.151834][ T316] RDX: 0000000000000000 RSI: 000055f7db1acffd RDI: 0000000000000000 [ 12.151835][ T316] RBP: 00007ffe8572c050 R08: 0000000000000000 R09: 0000000000000000 [ 12.151836][ T316] R10: 0000000000000000 R11: 0000000000000246 R12: 000055f7db1acffd [ 12.151837][ T316] R13: 000055f7de3a8960 R14: 0000000000040000 R15: 0000000000000000 | [ 13.307735][ T400] softirqs last disabled at (17863): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 13.307737][ T400] Preemption disabled at: | [ 13.307738][ T400] vprintk_emit (kernel/printk/printk.c:2471) | [ 13.307747][ T400] Tainted: [W]=WARN [ 13.307748][ T400] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.307749][ T400] Call Trace: [ 13.307751][ T400] [ 13.307753][ T400] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 13.307758][ T400] ? vprintk_emit (kernel/printk/printk.c:2471) [ 13.307761][ T400] __might_resched.cold (kernel/sched/core.c:9234) [ 13.307765][ T400] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 13.307769][ T400] ? __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.307774][ T400] __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.307776][ T400] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 13.307781][ T400] ? 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.307784][ T400] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 13.307787][ T400] put_chars (drivers/char/virtio_console.c:1176) [ 13.307789][ T400] ? prb_final_commit (kernel/printk/printk_ringbuffer.c:1842) [ 13.307791][ T400] ? __send_to_port (drivers/char/virtio_console.c:654) [ 13.307793][ T400] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 13.307797][ T400] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 13.307800][ T400] ? validate_chain (kernel/locking/lockdep.c:3817 (discriminator 2) kernel/locking/lockdep.c:3837 (discriminator 2) kernel/locking/lockdep.c:3892 (discriminator 2)) [ 13.307803][ T400] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 13.307806][ T400] ? mark_usage (kernel/locking/lockdep.c:4690) [ 13.307808][ T400] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 13.307809][ T400] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 13.307813][ T400] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 13.307815][ T400] ? console_emit_next_record (kernel/printk/printk.c:3095 (discriminator 2) kernel/printk/printk.c:3182 (discriminator 2)) [ 13.307818][ T400] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 13.307820][ T400] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 13.307824][ T400] console_emit_next_record (kernel/printk/printk.c:3183) [ 13.307828][ T400] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 13.307830][ T400] ? 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.307833][ T400] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 13.307835][ T400] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 13.307839][ T400] console_flush_one_record (kernel/printk/printk.c:3268) [ 13.307843][ T400] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 13.307844][ T400] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 13.307849][ T400] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 13.307852][ T400] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 13.307854][ T400] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 13.307856][ T400] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 13.307860][ T400] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 13.307861][ T400] ? vprintk_emit (kernel/printk/printk.c:2478) [ 13.307865][ T400] vprintk_emit (kernel/printk/printk.c:2479) [ 13.307868][ T400] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 13.307871][ T400] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 13.307876][ T400] _printk (kernel/printk/printk.c:2504) [ 13.307879][ T400] ? snapshot_read.cold (user.c:?) [ 13.307883][ T400] ? br_multicast_flood (??:?) bridge [ 13.307895][ T400] ? do_setlink.isra.0 (net/core/rtnetlink.c:3273 (discriminator 1)) [ 13.307896][ T400] ? rtnl_newlink (net/core/rtnetlink.c:4215) [ 13.307897][ T400] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:7132) [ 13.307902][ T400] br_set_state (net/bridge/br_stp.c:57 (discriminator 2)) bridge [ 13.307912][ T400] br_init_port (net/bridge/br_stp_if.c:39) bridge [ 13.307920][ T400] new_nbp (net/bridge/br_if.c:449) bridge [ 13.307929][ T400] br_add_if (net/bridge/br_if.c:592) bridge [ 13.307936][ T400] ? is_bpf_text_address (./include/linux/rcupdate.h:882 kernel/bpf/core.c:751) [ 13.307940][ T400] ? kernel_text_address (kernel/extable.c:125 kernel/extable.c:94) [ 13.307943][ T400] ? __kernel_text_address (kernel/extable.c:79) [ 13.307946][ T400] do_set_master (net/core/rtnetlink.c:3071) [ 13.307951][ T400] do_setlink.isra.0 (net/core/rtnetlink.c:3273 (discriminator 1)) [ 13.307954][ T400] ? stack_trace_save (kernel/stacktrace.c:122 (discriminator 1)) [ 13.307957][ T400] ? rtnl_link_get_size (net/core/rtnetlink.c:747) [ 13.307958][ T400] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:388 kernel/rcu/update.c:380) [ 13.307960][ T400] ? stack_depot_save_flags (lib/stackdepot.c:609 (discriminator 2) lib/stackdepot.c:676 (discriminator 2)) [ 13.307963][ T400] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 13.307966][ T400] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 13.307967][ T400] ? validate_chain (kernel/locking/lockdep.c:3817 (discriminator 2) kernel/locking/lockdep.c:3837 (discriminator 2) kernel/locking/lockdep.c:3892 (discriminator 2)) [ 13.307970][ T400] ? kasan_save_stack (mm/kasan/common.c:58) [ 13.307973][ T400] ? kasan_save_stack (mm/kasan/common.c:57) [ 13.307974][ T400] ? kasan_save_track (mm/kasan/common.c:78) [ 13.307977][ T400] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 13.307979][ T400] ? netlink_seq_next (net/netlink/af_netlink.c:2684) [ 13.307982][ T400] ? ___sys_sendmsg (net/socket.c:2757) [ 13.307986][ T400] ? lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2)) [ 13.307988][ T400] ? rtnl_newlink (net/core/rtnetlink.c:80 net/core/rtnetlink.c:366 net/core/rtnetlink.c:4214) [ 13.307991][ T400] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 13.307993][ T400] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 13.307994][ T400] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 13.307996][ T400] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 13.307998][ T400] ? trace_contention_end (./include/trace/events/lock.h:121 (discriminator 22)) [ 13.308002][ T400] ? __mutex_lock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:3188 kernel/locking/mutex.c:89 kernel/locking/mutex.c:134 kernel/locking/mutex.c:649 kernel/locking/mutex.c:821) [ 13.308005][ T400] ? __mutex_lock (kernel/locking/mutex.c:656 (discriminator 1) kernel/locking/mutex.c:821 (discriminator 1)) [ 13.308007][ T400] ? rtnl_newlink (net/core/rtnetlink.c:80 net/core/rtnetlink.c:366 net/core/rtnetlink.c:4214) [ 13.308010][ T400] ? ww_mutex_lock (kernel/locking/mutex.c:934) [ 13.308012][ T400] ? nla_get_range_signed (lib/nlattr.c:270) [ 13.308017][ T400] ? __rtnl_newlink (net/core/rtnetlink.c:4063) [ 13.308022][ T400] rtnl_newlink (net/core/rtnetlink.c:4215) [ 13.308027][ T400] ? rtnl_bridge_getlink (net/core/rtnetlink.c:5558) [ 13.308029][ T400] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 13.308033][ T400] ? lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2)) [ 13.308035][ T400] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 13.308037][ T400] ? rtnl_bridge_getlink (net/core/rtnetlink.c:5558) [ 13.308038][ T400] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 13.308042][ T400] ? rtnl_bridge_getlink (net/core/rtnetlink.c:5558) [ 13.308044][ T400] rtnetlink_rcv_msg (net/core/rtnetlink.c:7132) [ 13.308047][ T400] ? rtnl_link_fill (./include/net/netlink.h:1107 (discriminator 1)) [ 13.308048][ T400] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 13.308053][ T400] ? lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2)) [ 13.308054][ T400] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 13.308058][ T400] netlink_rcv_skb (net/netlink/af_netlink.c:2556) [ 13.308059][ T400] ? rtnl_link_fill (./include/net/netlink.h:1107 (discriminator 1)) [ 13.308062][ T400] ? netlink_ack (./include/linux/skbuff.h:2718) [ 13.308068][ T400] ? 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)) [ 13.308070][ T400] ? 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)) [ 13.308074][ T400] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1345) [ 13.308077][ T400] ? netlink_attachskb (./arch/x86/include/asm/bitops.h:202 (discriminator 1)) [ 13.308080][ T400] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 13.308084][ T400] netlink_sendmsg (net/netlink/af_netlink.c:1900) [ 13.308088][ T400] ? netlink_unicast (./include/net/net_namespace.h:422 (discriminator 7)) [ 13.308091][ T400] ? __might_fault (mm/memory.c:7482 (discriminator 5)) [ 13.308097][ T400] ____sys_sendmsg (net/socket.c:800 (discriminator 4) net/socket.c:815 (discriminator 4) net/socket.c:2713 (discriminator 4)) [ 13.308099][ T400] ? copy_msghdr_from_user (net/socket.c:2650) [ 13.308101][ T400] ? get_timestamp.constprop.0 (./include/linux/netdevice.h:5399) [ 13.308102][ T400] ? move_addr_to_kernel (net/socket.c:258) [ 13.308110][ T400] ___sys_sendmsg (net/socket.c:2767) [ 13.308112][ T400] ? copy_msghdr_from_user (net/socket.c:2619) [ 13.308127][ T400] __sys_sendmsg (net/socket.c:2799) [ 13.308130][ T400] ? __sys_sendmsg_sock (net/socket.c:2780) [ 13.308136][ T400] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 13.308140][ T400] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 13.308142][ T400] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 13.308145][ T400] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 13.308147][ T400] RIP: 0033:0x7fd7343e954e [ 13.308151][ T400] 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 [ 13.308153][ T400] RSP: 002b:00007ffebaf6e1f0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 13.308155][ T400] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fd7343e954e [ 13.308157][ T400] RDX: 0000000000000000 RSI: 00007ffebaf6e2a0 RDI: 0000000000000005 [ 13.308157][ T400] RBP: 00007ffebaf6e200 R08: 0000000000000000 R09: 0000000000000000 [ 13.308158][ T400] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a91a971 [ 13.308159][ T400] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffebaf6e960 | [ 29.105620][ C3] softirqs last disabled at (725559): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 29.105622][ C3] Preemption disabled at: | [ 29.105623][ C3] 0x0 | [ 29.105634][ C3] Tainted: [W]=WARN [ 29.105635][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 29.105637][ C3] Call Trace: [ 29.105639][ C3] [ 29.105641][ C3] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 29.105646][ C3] __might_resched.cold (kernel/sched/core.c:9234) [ 29.105650][ C3] ? validate_chain (kernel/locking/lockdep.c:157 kernel/locking/lockdep.c:202 kernel/locking/lockdep.c:3329 kernel/locking/lockdep.c:3924) [ 29.105652][ C3] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 29.105655][ C3] ? __asan_memcpy (mm/kasan/shadow.c:106 (discriminator 1)) [ 29.105658][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 29.105662][ C3] __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.105665][ C3] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 29.105667][ C3] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 29.105670][ C3] ? 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.105671][ C3] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 29.105673][ C3] put_chars (drivers/char/virtio_console.c:1176) [ 29.105676][ C3] ? __send_to_port (drivers/char/virtio_console.c:654) [ 29.105677][ C3] ? console_prepend_replay (kernel/printk/printk.c:3005) [ 29.105680][ C3] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 29.105684][ C3] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 29.105685][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 29.105687][ C3] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 29.105689][ C3] console_emit_next_record (kernel/printk/printk.c:3183) [ 29.105692][ C3] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 29.105693][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 29.105695][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 29.105697][ C3] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 29.105699][ C3] ? console_flush_one_record (kernel/printk/printk.c:3247) [ 29.105700][ C3] console_flush_one_record (kernel/printk/printk.c:3268) [ 29.105703][ C3] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 29.105705][ C3] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 29.105707][ C3] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 29.105709][ C3] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 29.105710][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 29.105712][ C3] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 29.105713][ C3] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 29.105715][ C3] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 29.105717][ C3] ? vprintk_emit (kernel/printk/printk.c:2478) [ 29.105719][ C3] vprintk_emit (kernel/printk/printk.c:2479) [ 29.105721][ C3] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 29.105723][ C3] ? br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 29.105735][ C3] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 29.105737][ C3] ? br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 29.105743][ C3] ? br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 29.105749][ C3] ? is_module_text_address (./include/linux/rcupdate.h:882 ./include/linux/rcupdate.h:1216 kernel/module/main.c:3934) [ 29.105752][ C3] _printk (kernel/printk/printk.c:2504) [ 29.105756][ C3] ? snapshot_read.cold (user.c:?) [ 29.105757][ C3] ? arch_stack_walk (arch/x86/kernel/stacktrace.c:25) [ 29.105761][ C3] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 29.105764][ C3] ? nbcon_cpu_emergency_enter (./include/linux/instrumented.h:112 ./include/linux/atomic/atomic-instrumented.h:435 kernel/printk/nbcon.c:1723) [ 29.105765][ C3] print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4097 (discriminator 1)) [ 29.105768][ C3] mark_lock_irq (kernel/locking/lockdep.c:4095 kernel/locking/lockdep.c:4174 kernel/locking/lockdep.c:4310) [ 29.105771][ C3] mark_lock (kernel/locking/lockdep.c:4769) [ 29.105772][ C3] mark_usage (kernel/locking/lockdep.c:4658) [ 29.105774][ C3] __lock_acquire (kernel/locking/lockdep.c:5208) [ 29.105776][ C3] lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2)) [ 29.105778][ C3] ? br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 29.105784][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 29.105786][ C3] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 29.105788][ C3] ? br_message_age_timer_expired (net/bridge/br_stp_timer.c:54) bridge [ 29.105794][ C3] _raw_spin_lock (./include/linux/spinlock_api_smp.h:190 (discriminator 1) kernel/locking/spinlock.c:173 (discriminator 1)) [ 29.105796][ C3] ? br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 29.105802][ C3] br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 29.105808][ C3] ? br_message_age_timer_expired (net/bridge/br_stp_timer.c:54) bridge [ 29.105814][ C3] call_timer_fn (kernel/time/timer.c:1748) [ 29.105817][ C3] ? detach_if_pending (./include/linux/list.h:1159) [ 29.105819][ C3] ? debug_object_active_state (lib/debugobjects.c:1122) [ 29.105822][ C3] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 29.105824][ C3] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 29.105826][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 29.105828][ C3] __run_timers (kernel/time/timer.c:1799 kernel/time/timer.c:2374) [ 29.105830][ C3] ? br_message_age_timer_expired (net/bridge/br_stp_timer.c:54) bridge [ 29.105836][ C3] ? __bpf_trace_itimer_expire (./include/trace/events/timer.h:407) [ 29.105838][ C3] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 29.105841][ C3] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 29.105843][ C3] run_timer_softirq (kernel/time/timer.c:2386 kernel/time/timer.c:2395 kernel/time/timer.c:2403) [ 29.105845][ C3] ? __run_timers (./include/trace/events/timer.h:138 (discriminator 19)) [ 29.105847][ C3] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 29.105849][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 29.105851][ C3] handle_softirqs (kernel/softirq.c:645) [ 29.105852][ C3] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 29.105854][ C3] ? _local_bh_enable (kernel/softirq.c:428 (discriminator 1)) [ 29.105856][ C3] __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) [ 29.105858][ C3] irq_exit_rcu (kernel/softirq.c:784) [ 29.105859][ C3] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1062 (discriminator 37) arch/x86/kernel/apic/apic.c:1062 (discriminator 37)) [ 29.105862][ C3] [ 29.105863][ C3] [ 29.105863][ C3] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488) [ 29.105865][ C3] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:674) [ 29.105867][ C3] RIP: 0010:pv_native_safe_halt (./arch/x86/include/asm/irqflags.h:48 arch/x86/kernel/paravirt.c:63) [ 29.105870][ C3] Code: 48 8b 3d 94 d2 f5 01 e8 1f 00 00 00 48 2b 05 58 93 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 86 11 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 All code ======== 0: 48 8b 3d 94 d2 f5 01 mov 0x1f5d294(%rip),%rdi # 0x1f5d29b 7: e8 1f 00 00 00 call 0x2b c: 48 2b 05 58 93 95 00 sub 0x959358(%rip),%rax # 0x95936b 13: c3 ret 14: 0f 1f 80 00 00 00 00 nopl 0x0(%rax) 1b: f3 0f 1e fa endbr64 1f: eb 07 jmp 0x28 21: 0f 00 2d 13 86 11 00 verw 0x118613(%rip) # 0x11863b 28: fb sti 29: f4 hlt 2a:* c3 ret <-- trapping instruction 2b: 0f 1f 40 d6 nopl -0x2a(%rax) 2f: 48 83 ec 20 sub $0x20,%rsp 33: 8b 17 mov (%rdi),%edx 35: 49 89 f8 mov %rdi,%r8 38: 83 e2 fe and $0xfffffffe,%edx 3b: 41 89 d2 mov %edx,%r10d 3e: 0f .byte 0xf 3f: 01 .byte 0x1 Code starting with the faulting instruction =========================================== 0: c3 ret 1: 0f 1f 40 d6 nopl -0x2a(%rax) 5: 48 83 ec 20 sub $0x20,%rsp 9: 8b 17 mov (%rdi),%edx b: 49 89 f8 mov %rdi,%r8 e: 83 e2 fe and $0xfffffffe,%edx 11: 41 89 d2 mov %edx,%r10d 14: 0f .byte 0xf 15: 01 .byte 0x1 [ 29.105872][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000282 [ 29.105875][ C3] RAX: 00000000000b1235 RBX: ff11000001c88040 RCX: ffffffffa38f0307 [ 29.105876][ C3] RDX: ff11000001c88040 RSI: ffffffffa6638af6 RDI: ffffffffa608d8e0 [ 29.105877][ C3] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 29.105878][ C3] R10: 0000000000000003 R11: 0000000000000001 R12: 1ff400000002cfc3 [ 29.105879][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 29.105880][ C3] ? cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 29.105883][ C3] default_idle (./arch/x86/include/asm/paravirt.h:62 arch/x86/kernel/process.c:768) [ 29.105885][ C3] default_idle_call (kernel/sched/idle.c:122) [ 29.105887][ C3] cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 29.105888][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 29.105890][ C3] ? mark_tsc_async_resets (arch/x86/kernel/tsc_sync.c:49) [ 29.105892][ C3] ? default_idle_call (kernel/sched/idle.c:129) [ 29.105894][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 29.105896][ C3] do_idle (kernel/sched/idle.c:355) [ 29.105897][ C3] cpu_startup_entry (kernel/sched/idle.c:454) [ 29.105899][ C3] start_secondary (arch/x86/kernel/smpboot.c:312) [ 29.105901][ C3] ? set_cpu_sibling_map (arch/x86/kernel/smpboot.c:733 (discriminator 4)) [ 29.105903][ C3] common_startup_64 (arch/x86/kernel/head_64.S:418) | [ 29.202332][ C3] | [ 29.202434][ C3] | [ 29.202434][ C3] stack backtrace: | [ 29.202767][ C3] Tainted: [W]=WARN [ 29.202768][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 29.202770][ C3] Call Trace: [ 29.202772][ C3] [ 29.202775][ C3] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 29.202781][ C3] print_irq_inversion_bug.part.0.cold (kernel/locking/lockdep.c:4141) [ 29.202786][ C3] mark_lock_irq (kernel/locking/lockdep.c:4095 kernel/locking/lockdep.c:4174 kernel/locking/lockdep.c:4310) [ 29.202791][ C3] mark_lock (kernel/locking/lockdep.c:4769) [ 29.202794][ C3] mark_usage (kernel/locking/lockdep.c:4658) [ 29.202796][ C3] __lock_acquire (kernel/locking/lockdep.c:5208) [ 29.202800][ C3] lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2)) [ 29.202802][ C3] ? br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 29.202815][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 29.202819][ C3] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 29.202822][ C3] ? br_message_age_timer_expired (net/bridge/br_stp_timer.c:54) bridge [ 29.202833][ C3] _raw_spin_lock (./include/linux/spinlock_api_smp.h:190 (discriminator 1) kernel/locking/spinlock.c:173 (discriminator 1)) [ 29.202836][ C3] ? br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 29.202846][ C3] br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 29.202857][ C3] ? br_message_age_timer_expired (net/bridge/br_stp_timer.c:54) bridge [ 29.202868][ C3] call_timer_fn (kernel/time/timer.c:1748) [ 29.202872][ C3] ? detach_if_pending (./include/linux/list.h:1159) [ 29.202874][ C3] ? debug_object_active_state (lib/debugobjects.c:1122) [ 29.202878][ C3] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 29.202881][ C3] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 29.202884][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 29.202887][ C3] __run_timers (kernel/time/timer.c:1799 kernel/time/timer.c:2374) [ 29.202890][ C3] ? br_message_age_timer_expired (net/bridge/br_stp_timer.c:54) bridge [ 29.202901][ C3] ? __bpf_trace_itimer_expire (./include/trace/events/timer.h:407) [ 29.202904][ C3] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 29.202908][ C3] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 29.202912][ C3] run_timer_softirq (kernel/time/timer.c:2386 kernel/time/timer.c:2395 kernel/time/timer.c:2403) [ 29.202914][ C3] ? __run_timers (./include/trace/events/timer.h:138 (discriminator 19)) [ 29.202917][ C3] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 29.202920][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 29.202923][ C3] handle_softirqs (kernel/softirq.c:645) [ 29.202926][ C3] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 29.202928][ C3] ? _local_bh_enable (kernel/softirq.c:428 (discriminator 1)) [ 29.202931][ C3] __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) [ 29.202934][ C3] irq_exit_rcu (kernel/softirq.c:784) [ 29.202936][ C3] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1062 (discriminator 37) arch/x86/kernel/apic/apic.c:1062 (discriminator 37)) [ 29.202938][ C3] [ 29.202939][ C3] [ 29.202940][ C3] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488) [ 29.202943][ C3] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:674) [ 29.202945][ C3] RIP: 0010:pv_native_safe_halt (./arch/x86/include/asm/irqflags.h:48 arch/x86/kernel/paravirt.c:63) [ 29.202949][ C3] Code: 48 8b 3d 94 d2 f5 01 e8 1f 00 00 00 48 2b 05 58 93 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 86 11 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 All code ======== 0: 48 8b 3d 94 d2 f5 01 mov 0x1f5d294(%rip),%rdi # 0x1f5d29b 7: e8 1f 00 00 00 call 0x2b c: 48 2b 05 58 93 95 00 sub 0x959358(%rip),%rax # 0x95936b 13: c3 ret 14: 0f 1f 80 00 00 00 00 nopl 0x0(%rax) 1b: f3 0f 1e fa endbr64 1f: eb 07 jmp 0x28 21: 0f 00 2d 13 86 11 00 verw 0x118613(%rip) # 0x11863b 28: fb sti 29: f4 hlt 2a:* c3 ret <-- trapping instruction 2b: 0f 1f 40 d6 nopl -0x2a(%rax) 2f: 48 83 ec 20 sub $0x20,%rsp 33: 8b 17 mov (%rdi),%edx 35: 49 89 f8 mov %rdi,%r8 38: 83 e2 fe and $0xfffffffe,%edx 3b: 41 89 d2 mov %edx,%r10d 3e: 0f .byte 0xf 3f: 01 .byte 0x1 Code starting with the faulting instruction =========================================== 0: c3 ret 1: 0f 1f 40 d6 nopl -0x2a(%rax) 5: 48 83 ec 20 sub $0x20,%rsp 9: 8b 17 mov (%rdi),%edx b: 49 89 f8 mov %rdi,%r8 e: 83 e2 fe and $0xfffffffe,%edx 11: 41 89 d2 mov %edx,%r10d 14: 0f .byte 0xf 15: 01 .byte 0x1 [ 29.202951][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000282 [ 29.202955][ C3] RAX: 00000000000b1235 RBX: ff11000001c88040 RCX: ffffffffa38f0307 [ 29.202957][ C3] RDX: ff11000001c88040 RSI: ffffffffa6638af6 RDI: ffffffffa608d8e0 [ 29.202958][ C3] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 29.202959][ C3] R10: 0000000000000003 R11: 0000000000000001 R12: 1ff400000002cfc3 [ 29.202960][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 29.202963][ C3] ? cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 29.202967][ C3] default_idle (./arch/x86/include/asm/paravirt.h:62 arch/x86/kernel/process.c:768) [ 29.202969][ C3] default_idle_call (kernel/sched/idle.c:122) [ 29.202971][ C3] cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 29.202974][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 29.202976][ C3] ? mark_tsc_async_resets (arch/x86/kernel/tsc_sync.c:49) [ 29.202979][ C3] ? default_idle_call (kernel/sched/idle.c:129) [ 29.202981][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 29.202984][ C3] do_idle (kernel/sched/idle.c:355) [ 29.202986][ C3] cpu_startup_entry (kernel/sched/idle.c:454) [ 29.202989][ C3] start_secondary (arch/x86/kernel/smpboot.c:312) [ 29.202991][ C3] ? set_cpu_sibling_map (arch/x86/kernel/smpboot.c:733 (discriminator 4)) [ 29.202994][ C3] common_startup_64 (arch/x86/kernel/head_64.S:418) | [ 87.397465][ T785] softirqs last disabled at (0): 0x0 | [ 87.397467][ T785] Preemption disabled at: | [ 87.397468][ T785] 0x0 | [ 87.397477][ T785] Tainted: [W]=WARN [ 87.397478][ T785] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 87.397480][ T785] Call Trace: [ 87.397481][ T785] [ 87.397482][ T785] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 87.397488][ T785] __might_resched.cold (kernel/sched/core.c:9234) [ 87.397492][ T785] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 87.397496][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397500][ T785] __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)) [ 87.397503][ T785] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 87.397509][ T785] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 87.397513][ T785] ? 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) [ 87.397515][ T785] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 87.397517][ T785] put_chars (drivers/char/virtio_console.c:1176) [ 87.397519][ T785] ? desc_read_finalized_seq (kernel/printk/printk_ringbuffer.c:1934) [ 87.397522][ T785] ? __send_to_port (drivers/char/virtio_console.c:654) [ 87.397525][ T785] ? console_prepend_replay (kernel/printk/printk.c:3005) [ 87.397528][ T785] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 87.397533][ T785] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 87.397534][ T785] ? 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) [ 87.397537][ T785] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 87.397539][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397541][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397544][ T785] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 87.397547][ T785] console_emit_next_record (kernel/printk/printk.c:3183) [ 87.397550][ T785] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 87.397552][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397555][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397557][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397559][ T785] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 87.397562][ T785] ? console_flush_one_record (kernel/printk/printk.c:3247) [ 87.397564][ T785] console_flush_one_record (kernel/printk/printk.c:3268) [ 87.397567][ T785] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 87.397570][ T785] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 87.397573][ T785] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 87.397575][ T785] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 87.397577][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397579][ T785] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 87.397581][ T785] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 87.397583][ T785] ? __rcu_read_lock (kernel/rcu/tree_plugin.h:391 (discriminator 6) kernel/rcu/tree_plugin.h:414 (discriminator 6)) [ 87.397585][ T785] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 87.397588][ T785] ? vprintk_emit (kernel/printk/printk.c:2478) [ 87.397590][ T785] vprintk_emit (kernel/printk/printk.c:2479) [ 87.397596][ T785] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 87.397598][ T785] ? debug_object_assert_init (lib/debugobjects.c:1072 (discriminator 3)) [ 87.397602][ T785] ? debug_object_activate (lib/debugobjects.c:884) [ 87.397605][ T785] _printk (kernel/printk/printk.c:2504) [ 87.397609][ T785] ? snapshot_read.cold (user.c:?) [ 87.397612][ T785] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 87.397615][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397617][ T785] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 87.397621][ T785] br_set_state (net/bridge/br_stp.c:57 (discriminator 2)) bridge [ 87.397640][ T785] br_stp_disable_port (net/bridge/br_stp_if.c:106) bridge [ 87.397653][ T785] br_stp_disable_bridge (net/bridge/br_stp_if.c:76) bridge [ 87.397664][ T785] br_dev_stop (net/bridge/br_device.c:193) bridge [ 87.397678][ T785] ? rtnl_is_locked (net/core/rtnetlink.c:169) [ 87.397683][ T785] __dev_close_many (net/core/dev.c:1798) [ 87.397686][ T785] ? netif_open (net/core/dev.c:1755) [ 87.397689][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397692][ T785] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 87.397695][ T785] __dev_change_flags (net/core/dev.c:1811 net/core/dev.c:9810) [ 87.397698][ T785] ? netif_set_allmulti (./include/net/netdev_lock.h:30 (discriminator 1)) [ 87.397701][ T785] ? __kernel_text_address (kernel/extable.c:79) [ 87.397704][ T785] ? write_profile (profile.c:?) [ 87.397706][ T785] ? unwind_get_return_address (arch/x86/kernel/unwind_orc.c:385 arch/x86/kernel/unwind_orc.c:380) [ 87.397709][ T785] netif_change_flags (net/core/dev.c:9877) [ 87.397712][ T785] do_setlink.isra.0 (net/core/rtnetlink.c:3266 (discriminator 1)) [ 87.397714][ T785] ? stack_trace_save (kernel/stacktrace.c:122 (discriminator 1)) [ 87.397716][ T785] ? rtnl_link_get_size (net/core/rtnetlink.c:747) [ 87.397717][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397719][ T785] ? stack_depot_save_flags (lib/stackdepot.c:609 lib/stackdepot.c:676) [ 87.397723][ T785] ? kasan_save_stack (mm/kasan/common.c:58) [ 87.397726][ T785] ? kasan_save_stack (mm/kasan/common.c:57) [ 87.397727][ T785] ? kasan_save_track (mm/kasan/common.c:78) [ 87.397729][ T785] ? __kasan_kmalloc (mm/kasan/common.c:398 mm/kasan/common.c:415) [ 87.397731][ T785] ? __kmalloc_cache_noprof (./include/linux/kasan.h:263 mm/slub.c:5563) [ 87.397733][ T785] ? rtnl_newlink (./include/linux/slab.h:991 (discriminator 1) net/core/rtnetlink.c:4113 (discriminator 1)) [ 87.397734][ T785] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:7132) [ 87.397735][ T785] ? netlink_rcv_skb (net/netlink/af_netlink.c:2556) [ 87.397739][ T785] ? netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1345) [ 87.397740][ T785] ? netlink_sendmsg (net/netlink/af_netlink.c:1900) [ 87.397742][ T785] ? ____sys_sendmsg (net/socket.c:800 (discriminator 4) net/socket.c:815 (discriminator 4) net/socket.c:2713 (discriminator 4)) [ 87.397744][ T785] ? ___sys_sendmsg (net/socket.c:2767) [ 87.397746][ T785] ? __sys_sendmsg (net/socket.c:2799) [ 87.397748][ T785] ? do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 87.397751][ T785] ? entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 87.397754][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397756][ T785] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 87.397758][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397760][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397762][ T785] ? trace_contention_end (./include/trace/events/lock.h:121 (discriminator 22)) [ 87.397765][ T785] ? __mutex_lock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:3188 kernel/locking/mutex.c:89 kernel/locking/mutex.c:134 kernel/locking/mutex.c:649 kernel/locking/mutex.c:821) [ 87.397768][ T785] ? __mutex_lock (kernel/locking/mutex.c:656 (discriminator 1) kernel/locking/mutex.c:821 (discriminator 1)) [ 87.397769][ T785] ? rtnl_newlink (net/core/rtnetlink.c:80 net/core/rtnetlink.c:366 net/core/rtnetlink.c:4214) [ 87.397771][ T785] ? ww_mutex_lock (kernel/locking/mutex.c:934) [ 87.397774][ T785] ? __rtnl_newlink (net/core/rtnetlink.c:4063) [ 87.397776][ T785] rtnl_newlink (net/core/rtnetlink.c:4215) [ 87.397779][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397781][ T785] ? rtnl_bridge_getlink (net/core/rtnetlink.c:5558) [ 87.397782][ T785] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 87.397783][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397785][ T785] ? is_bpf_text_address (./include/linux/rcupdate.h:850 kernel/bpf/core.c:749) [ 87.397789][ T785] ? is_bpf_text_address (./include/linux/rcupdate.h:882 kernel/bpf/core.c:751) [ 87.397791][ T785] ? kernel_text_address (kernel/extable.c:125 kernel/extable.c:94) [ 87.397792][ T785] ? __kernel_text_address (kernel/extable.c:79) [ 87.397793][ T785] ? write_profile (profile.c:?) [ 87.397795][ T785] ? unwind_get_return_address (arch/x86/kernel/unwind_orc.c:385 arch/x86/kernel/unwind_orc.c:380) [ 87.397796][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397798][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397800][ T785] ? cap_capable (./include/trace/events/capability.h:26 (discriminator 22) security/commoncap.c:130 (discriminator 22)) [ 87.397803][ T785] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 87.397805][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397807][ T785] ? rtnl_bridge_getlink (net/core/rtnetlink.c:5558) [ 87.397808][ T785] rtnetlink_rcv_msg (net/core/rtnetlink.c:7132) [ 87.397810][ T785] ? rtnl_link_fill (./include/net/netlink.h:1107 (discriminator 1)) [ 87.397811][ T785] ? filter_irq_stacks (kernel/stacktrace.c:402) [ 87.397813][ T785] ? stack_depot_save_flags (lib/stackdepot.c:609 lib/stackdepot.c:676) [ 87.397815][ T785] netlink_rcv_skb (net/netlink/af_netlink.c:2556) [ 87.397817][ T785] ? rtnl_link_fill (./include/net/netlink.h:1107 (discriminator 1)) [ 87.397819][ T785] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 87.397820][ T785] ? netlink_ack (./include/linux/skbuff.h:2718) [ 87.397822][ T785] ? __netlink_lookup (./include/linux/rcupdate.h:850 ./include/linux/rhashtable.h:709 net/netlink/af_netlink.c:499) [ 87.397824][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397826][ T785] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 87.397829][ T785] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1345) [ 87.397831][ T785] ? netlink_attachskb (./arch/x86/include/asm/bitops.h:202 (discriminator 1)) [ 87.397833][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397835][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397837][ T785] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 87.397839][ T785] netlink_sendmsg (net/netlink/af_netlink.c:1900) [ 87.397841][ T785] ? netlink_unicast (./include/net/net_namespace.h:422 (discriminator 7)) [ 87.397843][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397845][ T785] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 87.397847][ T785] ____sys_sendmsg (net/socket.c:800 (discriminator 4) net/socket.c:815 (discriminator 4) net/socket.c:2713 (discriminator 4)) [ 87.397849][ T785] ? copy_msghdr_from_user (net/socket.c:2650) [ 87.397851][ T785] ? get_timestamp.constprop.0 (./include/linux/netdevice.h:5399) [ 87.397852][ T785] ? move_addr_to_kernel (net/socket.c:258) [ 87.397854][ T785] ? filter_irq_stacks (kernel/stacktrace.c:402) [ 87.397857][ T785] ___sys_sendmsg (net/socket.c:2767) [ 87.397859][ T785] ? copy_msghdr_from_user (net/socket.c:2619) [ 87.397865][ T785] __sys_sendmsg (net/socket.c:2799) [ 87.397867][ T785] ? __sys_sendmsg_sock (net/socket.c:2780) [ 87.397871][ T785] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 87.397873][ T785] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 87.397874][ T785] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 87.397877][ T785] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 87.397879][ T785] RIP: 0033:0x7f488828654e [ 87.397881][ T785] 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 [ 87.397883][ T785] RSP: 002b:00007ffccd307a80 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 87.397887][ T785] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f488828654e [ 87.397889][ T785] RDX: 0000000000000000 RSI: 00007ffccd307b30 RDI: 0000000000000005 [ 87.397890][ T785] RBP: 00007ffccd307a90 R08: 0000000000000000 R09: 0000000000000000 [ 87.397891][ T785] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a91a9bb Finger prints: mark_lock_irq:mark_lock:mark_usage:__lock_acquire:_raw_spin_lock __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 __kmalloc_noprof:put_chars:hvc_console_print:console_emit_next_record:console_flush_one_record