====================================== | [ 9.595829][ T187] softirqs last disabled at (46667): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 9.595832][ T187] Preemption disabled at: | [ 9.595833][ T187] 0x0 | [ 9.595845][ T187] Tainted: [W]=WARN [ 9.595846][ T187] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.595848][ T187] Call Trace: [ 9.595849][ T187] [ 9.595851][ T187] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 9.595857][ T187] __might_resched.cold (kernel/sched/core.c:9234) [ 9.595861][ T187] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 9.595865][ 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.595870][ 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.595873][ T187] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 9.595878][ 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.595881][ T187] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 9.595884][ T187] put_chars (drivers/char/virtio_console.c:1176) [ 9.595887][ T187] ? __send_to_port (drivers/char/virtio_console.c:654) [ 9.595888][ T187] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 9.595893][ 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.595898][ T187] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 9.595904][ T187] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 9.595906][ T187] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 9.595909][ T187] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 9.595912][ T187] console_emit_next_record (kernel/printk/printk.c:3183) [ 9.595916][ T187] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 9.595918][ 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.595921][ T187] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 9.595923][ T187] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 9.595927][ T187] console_flush_one_record (kernel/printk/printk.c:3268) [ 9.595931][ T187] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 9.595933][ T187] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 9.595938][ T187] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 9.595940][ T187] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 9.595942][ T187] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 9.595944][ T187] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 9.595948][ T187] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 9.595950][ T187] ? vprintk_emit (kernel/printk/printk.c:2478) [ 9.595953][ T187] vprintk_emit (kernel/printk/printk.c:2479) [ 9.595959][ T187] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 9.595962][ T187] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 9.595966][ T187] _printk (kernel/printk/printk.c:2504) [ 9.595969][ T187] ? snapshot_read.cold (user.c:?) [ 9.595972][ 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.595975][ T187] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 9.595978][ 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.595981][ T187] do_exit.cold (kernel/exit.c:889 (discriminator 4) kernel/exit.c:1043 (discriminator 4)) [ 9.595984][ T187] ? exit_notify (kernel/exit.c:780) [ 9.595986][ T187] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 9.595989][ T187] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 9.595993][ T187] do_group_exit (kernel/exit.c:1151) [ 9.595996][ T187] __x64_sys_exit_group (kernel/exit.c:1162 kernel/exit.c:1160 kernel/exit.c:1160) [ 9.595997][ T187] x64_sys_call (./arch/x86/include/generated/asm/syscalls_64.h:232) [ 9.596000][ T187] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 9.596003][ T187] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 9.596006][ T187] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 9.596008][ T187] RIP: 0033:0x7fba487621b8 [ 9.596010][ T187] Code: Unable to access opcode bytes at 0x7fba4876218e. Code starting with the faulting instruction =========================================== [ 9.596011][ T187] RSP: 002b:00007ffc528e7a58 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 9.596013][ T187] RAX: ffffffffffffffda RBX: 00007fba48892f88 RCX: 00007fba487621b8 [ 9.596015][ T187] RDX: 00007fba484acfc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 9.596015][ T187] RBP: 00007ffc528e7ab0 R08: 0000000000000000 R09: 0000000000008010 [ 9.596016][ T187] R10: 00007ffc528e7870 R11: 0000000000000246 R12: 0000000000000001 [ 9.596017][ T187] R13: 0000000000000000 R14: 00007fba48891680 R15: 00007fba48892fa0 | [ 10.615822][ T233] softirqs last disabled at (25303): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 10.615825][ T233] Preemption disabled at: | [ 10.615826][ T233] vprintk_emit (kernel/printk/printk.c:2471) | [ 10.615835][ T233] Tainted: [W]=WARN [ 10.615836][ T233] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.615838][ T233] Call Trace: [ 10.615839][ T233] [ 10.615841][ T233] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 10.615846][ T233] ? vprintk_emit (kernel/printk/printk.c:2471) [ 10.615849][ T233] __might_resched.cold (kernel/sched/core.c:9234) [ 10.615853][ T233] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 10.615857][ T233] ? __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.615863][ T233] __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.615865][ T233] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 10.615870][ T233] ? 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.615873][ T233] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 10.615876][ T233] put_chars (drivers/char/virtio_console.c:1176) [ 10.615879][ T233] ? __send_to_port (drivers/char/virtio_console.c:654) [ 10.615880][ T233] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 10.615885][ T233] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 10.615887][ T233] ? validate_chain (kernel/locking/lockdep.c:3817 (discriminator 2) kernel/locking/lockdep.c:3837 (discriminator 2) kernel/locking/lockdep.c:3892 (discriminator 2)) [ 10.615892][ T233] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 10.615895][ T233] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 10.615900][ T233] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 10.615902][ T233] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 10.615907][ T233] console_emit_next_record (kernel/printk/printk.c:3183) [ 10.615911][ T233] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 10.615913][ T233] ? 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.615916][ T233] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 10.615918][ T233] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 10.615922][ T233] console_flush_one_record (kernel/printk/printk.c:3268) [ 10.615926][ T233] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 10.615928][ T233] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 10.615933][ T233] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 10.615936][ T233] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 10.615937][ T233] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 10.615940][ T233] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 10.615943][ T233] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 10.615945][ T233] ? vprintk_emit (kernel/printk/printk.c:2478) [ 10.615948][ T233] vprintk_emit (kernel/printk/printk.c:2479) [ 10.615952][ T233] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 10.615958][ T233] ? vlan_netlink_fini (./include/linux/etherdevice.h:306 net/8021q/vlan.c:316 net/8021q/vlan.c:416) 8021q [ 10.615961][ T233] _printk (kernel/printk/printk.c:2504) [ 10.615965][ T233] ? snapshot_read.cold (user.c:?) [ 10.615971][ T233] ? 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.615974][ T233] 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.615977][ T233] do_one_initcall (init/main.c:1357) [ 10.615980][ T233] ? trace_event_raw_event_initcall_level (./include/trace/events/initcall.h:10) [ 10.615985][ T233] ? do_init_module (./include/linux/slab.h:991 (discriminator 1) kernel/module/main.c:3105 (discriminator 1)) [ 10.615988][ T233] ? kasan_unpoison (mm/kasan/shadow.c:146 mm/kasan/shadow.c:178) [ 10.615993][ T233] do_init_module (kernel/module/main.c:3117) [ 10.615997][ T233] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488) [ 10.616001][ T233] ? free_module (./include/trace/events/module.h:50 (discriminator 19)) [ 10.616004][ T233] ? kfree (./include/linux/kasan.h:235 mm/slub.c:2748 mm/slub.c:6499 mm/slub.c:6792) [ 10.616008][ T233] load_module (kernel/module/main.c:3593) [ 10.616015][ T233] ? layout_and_allocate.isra.0 (kernel/module/main.c:3016) [ 10.616019][ T233] ? __ia32_sys_fsconfig (??:?) [ 10.616021][ T233] ? ovl_real_file (fs/overlayfs/file.c:195) [ 10.616026][ T233] ? backing_file_read_iter (fs/backing-file.c:211) [ 10.616029][ T233] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 10.616032][ T233] init_module_from_file (kernel/module/main.c:3790) [ 10.616036][ T233] ? __do_sys_init_module (kernel/module/main.c:3664) [ 10.616044][ T233] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 10.616047][ T233] ? 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.616050][ T233] idempotent_init_module (kernel/module/main.c:3802) [ 10.616054][ T233] ? init_module_from_file (kernel/module/main.c:3791) [ 10.616060][ T233] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 10.616062][ T233] ? cap_capable (./include/trace/events/capability.h:26 (discriminator 22) security/commoncap.c:130 (discriminator 22)) [ 10.616068][ T233] __x64_sys_finit_module (kernel/module/main.c:3828 kernel/module/main.c:3812 kernel/module/main.c:3812) [ 10.616070][ T233] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 10.616074][ T233] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 10.616076][ T233] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 10.616078][ T233] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 10.616081][ T233] RIP: 0033:0x7f31a788237d [ 10.616084][ T233] 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.616086][ T233] RSP: 002b:00007ffec7580988 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 10.616089][ T233] RAX: ffffffffffffffda RBX: 000055e928155810 RCX: 00007f31a788237d [ 10.616090][ T233] RDX: 0000000000000000 RSI: 000055e900799ffd RDI: 0000000000000000 [ 10.616091][ T233] RBP: 00007ffec7580a20 R08: 0000000000000000 R09: 0000000000000000 [ 10.616092][ T233] R10: 0000000000000000 R11: 0000000000000246 R12: 000055e900799ffd [ 10.616092][ T233] R13: 000055e928155960 R14: 0000000000040000 R15: 0000000000000000 | [ 12.059093][ T282] softirqs last disabled at (39427): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 12.059095][ T282] Preemption disabled at: | [ 12.059096][ T282] vprintk_emit (kernel/printk/printk.c:2471) | [ 12.059104][ T282] Tainted: [W]=WARN [ 12.059105][ T282] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.059107][ T282] Call Trace: [ 12.059108][ T282] [ 12.059110][ T282] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 12.059115][ T282] ? vprintk_emit (kernel/printk/printk.c:2471) [ 12.059117][ T282] __might_resched.cold (kernel/sched/core.c:9234) [ 12.059122][ T282] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 12.059126][ T282] ? __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.059131][ T282] __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.059133][ T282] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 12.059139][ T282] ? 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.059141][ T282] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 12.059144][ T282] put_chars (drivers/char/virtio_console.c:1176) [ 12.059146][ T282] ? desc_read_finalized_seq (kernel/printk/printk_ringbuffer.c:1934) [ 12.059148][ T282] ? __send_to_port (drivers/char/virtio_console.c:654) [ 12.059151][ T282] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 12.059154][ T282] ? validate_chain (kernel/locking/lockdep.c:3817 (discriminator 2) kernel/locking/lockdep.c:3837 (discriminator 2) kernel/locking/lockdep.c:3892 (discriminator 2)) [ 12.059158][ T282] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 12.059161][ T282] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 12.059163][ T282] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 12.059167][ T282] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 12.059168][ T282] ? console_emit_next_record (kernel/printk/printk.c:3095 (discriminator 2) kernel/printk/printk.c:3182 (discriminator 2)) [ 12.059171][ T282] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 12.059174][ T282] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 12.059178][ T282] console_emit_next_record (kernel/printk/printk.c:3183) [ 12.059182][ T282] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 12.059183][ T282] ? 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.059186][ T282] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 12.059189][ T282] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 12.059192][ T282] console_flush_one_record (kernel/printk/printk.c:3268) [ 12.059196][ T282] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 12.059198][ T282] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 12.059203][ T282] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 12.059205][ T282] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 12.059207][ T282] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 12.059217][ T282] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 12.059221][ T282] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 12.059223][ T282] ? vprintk_emit (kernel/printk/printk.c:2478) [ 12.059226][ T282] vprintk_emit (kernel/printk/printk.c:2479) [ 12.059230][ T282] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 12.059235][ T282] ? gre_exit (net/ipv4/gre_demux.c:73) gre [ 12.059238][ T282] _printk (kernel/printk/printk.c:2504) [ 12.059242][ T282] ? snapshot_read.cold (user.c:?) [ 12.059248][ T282] ? 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.059251][ T282] gre_init (gre.mod.c:?) gre [ 12.059253][ T282] do_one_initcall (init/main.c:1357) [ 12.059255][ T282] ? trace_event_raw_event_initcall_level (./include/trace/events/initcall.h:10) [ 12.059260][ T282] ? do_init_module (./include/linux/slab.h:991 (discriminator 1) kernel/module/main.c:3105 (discriminator 1)) [ 12.059263][ T282] ? kasan_unpoison (mm/kasan/shadow.c:146 mm/kasan/shadow.c:178) [ 12.059268][ T282] do_init_module (kernel/module/main.c:3117) [ 12.059271][ T282] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488) [ 12.059275][ T282] ? free_module (./include/trace/events/module.h:50 (discriminator 19)) [ 12.059278][ T282] ? kfree (./include/linux/kasan.h:235 mm/slub.c:2748 mm/slub.c:6499 mm/slub.c:6792) [ 12.059282][ T282] load_module (kernel/module/main.c:3593) [ 12.059289][ T282] ? layout_and_allocate.isra.0 (kernel/module/main.c:3016) [ 12.059294][ T282] ? backing_file_read_iter (fs/backing-file.c:211) [ 12.059298][ T282] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 12.059302][ T282] init_module_from_file (kernel/module/main.c:3790) [ 12.059305][ T282] ? __do_sys_init_module (kernel/module/main.c:3664) [ 12.059313][ T282] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 12.059316][ T282] ? 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.059319][ T282] idempotent_init_module (kernel/module/main.c:3802) [ 12.059322][ T282] ? init_module_from_file (kernel/module/main.c:3791) [ 12.059328][ T282] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 12.059331][ T282] ? cap_capable (./include/trace/events/capability.h:26 (discriminator 22) security/commoncap.c:130 (discriminator 22)) [ 12.059336][ T282] __x64_sys_finit_module (kernel/module/main.c:3828 kernel/module/main.c:3812 kernel/module/main.c:3812) [ 12.059338][ T282] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 12.059342][ T282] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 12.059344][ T282] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 12.059346][ T282] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 12.059348][ T282] RIP: 0033:0x7f415223e37d [ 12.059352][ T282] 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.059354][ T282] RSP: 002b:00007ffcc68e8148 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 12.059356][ T282] RAX: ffffffffffffffda RBX: 0000557ae8cada40 RCX: 00007f415223e37d [ 12.059358][ T282] RDX: 0000000000000000 RSI: 0000557ad851effd RDI: 0000000000000001 [ 12.059359][ T282] RBP: 00007ffcc68e81e0 R08: 0000000000000000 R09: 0000000000000000 [ 12.059359][ T282] R10: 0000000000000000 R11: 0000000000000246 R12: 0000557ad851effd [ 12.059360][ T282] R13: 0000557ae8cada00 R14: 0000000000040000 R15: 0000000000000000 | [ 13.065196][ T321] softirqs last disabled at (15533): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 13.065199][ T321] Preemption disabled at: | [ 13.065200][ T321] vprintk_emit (kernel/printk/printk.c:2471) | [ 13.065209][ T321] Tainted: [W]=WARN [ 13.065210][ T321] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.065217][ T321] Call Trace: [ 13.065218][ T321] [ 13.065220][ T321] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 13.065226][ T321] ? vprintk_emit (kernel/printk/printk.c:2471) [ 13.065228][ T321] __might_resched.cold (kernel/sched/core.c:9234) [ 13.065233][ T321] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 13.065237][ T321] ? __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.065242][ T321] __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.065245][ T321] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 13.065250][ T321] ? 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.065253][ T321] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 13.065256][ T321] put_chars (drivers/char/virtio_console.c:1176) [ 13.065258][ T321] ? desc_read_finalized_seq (kernel/printk/printk_ringbuffer.c:1934) [ 13.065260][ T321] ? __send_to_port (drivers/char/virtio_console.c:654) [ 13.065263][ T321] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 13.065267][ T321] ? validate_chain (kernel/locking/lockdep.c:3817 (discriminator 2) kernel/locking/lockdep.c:3837 (discriminator 2) kernel/locking/lockdep.c:3892 (discriminator 2)) [ 13.065271][ T321] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 13.065274][ T321] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 13.065275][ T321] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 13.065280][ T321] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 13.065281][ T321] ? console_emit_next_record (kernel/printk/printk.c:3095 (discriminator 2) kernel/printk/printk.c:3182 (discriminator 2)) [ 13.065284][ T321] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 13.065287][ T321] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 13.065291][ T321] console_emit_next_record (kernel/printk/printk.c:3183) [ 13.065295][ T321] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 13.065297][ T321] ? 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.065300][ T321] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 13.065302][ T321] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 13.065306][ T321] console_flush_one_record (kernel/printk/printk.c:3268) [ 13.065310][ T321] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 13.065312][ T321] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 13.065317][ T321] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 13.065320][ T321] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 13.065322][ T321] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 13.065324][ T321] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 13.065328][ T321] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 13.065330][ T321] ? vprintk_emit (kernel/printk/printk.c:2478) [ 13.065333][ T321] vprintk_emit (kernel/printk/printk.c:2479) [ 13.065337][ T321] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 13.065343][ T321] ? gre_exit (net/ipv4/gre_demux.c:73) gre [ 13.065345][ T321] _printk (kernel/printk/printk.c:2504) [ 13.065349][ T321] ? snapshot_read.cold (user.c:?) [ 13.065355][ T321] ? 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.065358][ T321] gact_init_module (net/sched/act_gact.c:180) act_gact [ 13.065360][ T321] do_one_initcall (init/main.c:1357) [ 13.065363][ T321] ? trace_event_raw_event_initcall_level (./include/trace/events/initcall.h:10) [ 13.065368][ T321] ? do_init_module (./include/linux/slab.h:991 (discriminator 1) kernel/module/main.c:3105 (discriminator 1)) [ 13.065371][ T321] ? kasan_unpoison (mm/kasan/shadow.c:146 mm/kasan/shadow.c:178) [ 13.065376][ T321] do_init_module (kernel/module/main.c:3117) [ 13.065380][ T321] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488) [ 13.065384][ T321] ? free_module (./include/trace/events/module.h:50 (discriminator 19)) [ 13.065388][ T321] ? kfree (./include/linux/kasan.h:235 mm/slub.c:2748 mm/slub.c:6499 mm/slub.c:6792) [ 13.065392][ T321] load_module (kernel/module/main.c:3593) [ 13.065399][ T321] ? layout_and_allocate.isra.0 (kernel/module/main.c:3016) [ 13.065403][ T321] ? __ia32_sys_fsconfig (??:?) [ 13.065406][ T321] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 13.065409][ T321] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 13.065413][ T321] init_module_from_file (kernel/module/main.c:3790) [ 13.065416][ T321] ? __do_sys_init_module (kernel/module/main.c:3664) [ 13.065424][ T321] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 13.065428][ T321] ? 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.065431][ T321] idempotent_init_module (kernel/module/main.c:3802) [ 13.065434][ T321] ? init_module_from_file (kernel/module/main.c:3791) [ 13.065441][ T321] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 13.065443][ T321] ? cap_capable (./include/trace/events/capability.h:26 (discriminator 22) security/commoncap.c:130 (discriminator 22)) [ 13.065449][ T321] __x64_sys_finit_module (kernel/module/main.c:3828 kernel/module/main.c:3812 kernel/module/main.c:3812) [ 13.065451][ T321] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 13.065455][ T321] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 13.065457][ T321] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 13.065459][ T321] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 13.065462][ T321] RIP: 0033:0x7f23140fa37d [ 13.065465][ T321] 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.065467][ T321] RSP: 002b:00007fff3a434338 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 13.065470][ T321] RAX: ffffffffffffffda RBX: 0000562bf5a82810 RCX: 00007f23140fa37d [ 13.065471][ T321] RDX: 0000000000000000 RSI: 0000562be0519ffd RDI: 0000000000000000 [ 13.065472][ T321] RBP: 00007fff3a4343d0 R08: 0000000000000000 R09: 0000000000000000 [ 13.065473][ T321] R10: 0000000000000000 R11: 0000000000000246 R12: 0000562be0519ffd [ 13.065474][ T321] R13: 0000562bf5a82960 R14: 0000000000040000 R15: 0000000000000000 | [ 18.629062][ T354] softirqs last disabled at (17957): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 18.629065][ T354] Preemption disabled at: | [ 18.629065][ T354] vprintk_emit (kernel/printk/printk.c:2471) | [ 18.629074][ T354] Tainted: [W]=WARN [ 18.629075][ T354] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 18.629077][ T354] Call Trace: [ 18.629079][ T354] [ 18.629080][ T354] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 18.629086][ T354] ? vprintk_emit (kernel/printk/printk.c:2471) [ 18.629088][ T354] __might_resched.cold (kernel/sched/core.c:9234) [ 18.629092][ T354] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 18.629097][ T354] ? __kmalloc_noprof (./include/linux/sched/mm.h:317 mm/slub.c:4636 mm/slub.c:4974 mm/slub.c:5413 mm/slub.c:5439) [ 18.629102][ T354] __kmalloc_noprof (./include/linux/sched/mm.h:322 (discriminator 2) mm/slub.c:4636 (discriminator 2) mm/slub.c:4974 (discriminator 2) mm/slub.c:5413 (discriminator 2) mm/slub.c:5439 (discriminator 2)) [ 18.629104][ T354] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 18.629110][ T354] ? do_raw_spin_unlock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:32 ./include/asm-generic/qspinlock.h:58 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 18.629112][ T354] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 18.629115][ T354] put_chars (drivers/char/virtio_console.c:1176) [ 18.629118][ T354] ? __send_to_port (drivers/char/virtio_console.c:654) [ 18.629119][ T354] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 18.629124][ T354] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 18.629127][ T354] ? validate_chain (kernel/locking/lockdep.c:3817 (discriminator 2) kernel/locking/lockdep.c:3837 (discriminator 2) kernel/locking/lockdep.c:3892 (discriminator 2)) [ 18.629131][ T354] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 18.629134][ T354] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 18.629139][ T354] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 18.629141][ T354] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 18.629146][ T354] console_emit_next_record (kernel/printk/printk.c:3183) [ 18.629150][ T354] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 18.629152][ T354] ? console_flush_one_record (./include/linux/rcupdate.h:314 (discriminator 2) ./include/linux/srcu.h:439 (discriminator 2) kernel/printk/printk.c:291 (discriminator 2) kernel/printk/printk.c:3246 (discriminator 2)) [ 18.629155][ T354] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 18.629157][ T354] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 18.629161][ T354] console_flush_one_record (kernel/printk/printk.c:3268) [ 18.629165][ T354] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 18.629167][ T354] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 18.629172][ T354] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 18.629174][ T354] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 18.629176][ T354] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 18.629178][ T354] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 18.629182][ T354] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 18.629183][ T354] ? vprintk_emit (kernel/printk/printk.c:2478) [ 18.629187][ T354] vprintk_emit (kernel/printk/printk.c:2479) [ 18.629191][ T354] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 18.629193][ T354] ? netdev_run_todo (net/core/dev.c:11776) [ 18.629198][ T354] ? mirred_device_event (net/sched/act_mirred.c:559 (discriminator 1)) act_mirred [ 18.629200][ T354] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 18.629204][ T354] ? gre_exit (net/ipv4/gre_demux.c:73) gre [ 18.629206][ T354] _printk (kernel/printk/printk.c:2504) [ 18.629210][ T354] ? snapshot_read.cold (user.c:?) [ 18.629212][ T354] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 18.629215][ T354] ? gre_exit (net/ipv4/gre_demux.c:73) gre [ 18.629216][ T354] ? __up_write (kernel/locking/rwsem.c:1415) [ 18.629218][ T354] ? __up_write (kernel/locking/rwsem.c:1422 (discriminator 1)) [ 18.629221][ T354] ? __up_write (./include/linux/instrumented.h:112 ./include/linux/atomic/atomic-instrumented.h:3390 kernel/locking/rwsem.c:1417) [ 18.629224][ T354] mirred_init_module (net/sched/act_mirred.c:508) act_mirred [ 18.629226][ T354] do_one_initcall (init/main.c:1357) [ 18.629235][ T354] ? trace_event_raw_event_initcall_level (./include/trace/events/initcall.h:10) [ 18.629240][ T354] ? do_init_module (./include/linux/slab.h:991 (discriminator 1) kernel/module/main.c:3105 (discriminator 1)) [ 18.629243][ T354] ? kasan_unpoison (mm/kasan/shadow.c:146 mm/kasan/shadow.c:178) [ 18.629247][ T354] do_init_module (kernel/module/main.c:3117) [ 18.629251][ T354] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488) [ 18.629255][ T354] ? free_module (./include/trace/events/module.h:50 (discriminator 19)) [ 18.629258][ T354] ? kfree (./include/linux/kasan.h:235 mm/slub.c:2748 mm/slub.c:6499 mm/slub.c:6792) [ 18.629262][ T354] load_module (kernel/module/main.c:3593) [ 18.629269][ T354] ? layout_and_allocate.isra.0 (kernel/module/main.c:3016) [ 18.629273][ T354] ? __ia32_sys_fsconfig (??:?) [ 18.629276][ T354] ? ovl_real_file (fs/overlayfs/file.c:195) [ 18.629280][ T354] ? backing_file_read_iter (fs/backing-file.c:211) [ 18.629283][ T354] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 18.629286][ T354] init_module_from_file (kernel/module/main.c:3790) [ 18.629289][ T354] ? __do_sys_init_module (kernel/module/main.c:3664) [ 18.629297][ T354] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 18.629301][ T354] ? do_raw_spin_unlock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:32 ./include/asm-generic/qspinlock.h:58 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 18.629304][ T354] idempotent_init_module (kernel/module/main.c:3802) [ 18.629307][ T354] ? init_module_from_file (kernel/module/main.c:3791) [ 18.629313][ T354] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 18.629315][ T354] ? cap_capable (./include/trace/events/capability.h:26 (discriminator 22) security/commoncap.c:130 (discriminator 22)) [ 18.629321][ T354] __x64_sys_finit_module (kernel/module/main.c:3828 kernel/module/main.c:3812 kernel/module/main.c:3812) [ 18.629323][ T354] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 18.629327][ T354] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 18.629328][ T354] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 18.629331][ T354] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 18.629333][ T354] RIP: 0033:0x7f55aaa1337d [ 18.629336][ T354] 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 [ 18.629338][ T354] RSP: 002b:00007ffd1b77f598 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 18.629341][ T354] RAX: ffffffffffffffda RBX: 000055e938668810 RCX: 00007f55aaa1337d [ 18.629342][ T354] RDX: 0000000000000000 RSI: 000055e9277b9ffd RDI: 0000000000000000 [ 18.629343][ T354] RBP: 00007ffd1b77f630 R08: 0000000000000000 R09: 0000000000000000 [ 18.629344][ T354] R10: 0000000000000000 R11: 0000000000000246 R12: 000055e9277b9ffd [ 18.629345][ T354] R13: 000055e938668960 R14: 0000000000040000 R15: 0000000000000000 | [ 28.020841][ C3] softirqs last disabled at (706315): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 28.020843][ C3] Preemption disabled at: | [ 28.020843][ C3] 0x0 | [ 28.020853][ C3] Tainted: [W]=WARN [ 28.020854][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 28.020856][ C3] Call Trace: [ 28.020858][ C3] [ 28.020860][ C3] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 28.020865][ C3] __might_resched.cold (kernel/sched/core.c:9234) [ 28.020869][ C3] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 28.020873][ C3] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 28.020876][ C3] ? __asan_memcpy (mm/kasan/shadow.c:106 (discriminator 1)) [ 28.020878][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.020880][ 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)) [ 28.020883][ C3] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 28.020886][ C3] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 28.020890][ 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) [ 28.020891][ C3] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 28.020893][ C3] put_chars (drivers/char/virtio_console.c:1176) [ 28.020895][ C3] ? __send_to_port (drivers/char/virtio_console.c:654) [ 28.020896][ C3] ? console_prepend_replay (kernel/printk/printk.c:3005) [ 28.020900][ C3] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 28.020903][ C3] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 28.020905][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.020906][ C3] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 28.020908][ C3] console_emit_next_record (kernel/printk/printk.c:3183) [ 28.020911][ C3] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 28.020913][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.020914][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.020916][ C3] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 28.020918][ C3] ? console_flush_one_record (kernel/printk/printk.c:3247) [ 28.020919][ C3] console_flush_one_record (kernel/printk/printk.c:3268) [ 28.020922][ C3] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 28.020924][ C3] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 28.020926][ C3] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 28.020927][ C3] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 28.020929][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.020930][ C3] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 28.020932][ C3] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 28.020933][ C3] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 28.020935][ C3] ? vprintk_emit (kernel/printk/printk.c:2478) [ 28.020937][ C3] vprintk_emit (kernel/printk/printk.c:2479) [ 28.020939][ C3] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 28.020941][ C3] ? br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 28.020953][ C3] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 28.020954][ C3] ? br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 28.020961][ C3] ? br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 28.020967][ C3] ? is_module_text_address (./include/linux/rcupdate.h:882 ./include/linux/rcupdate.h:1216 kernel/module/main.c:3934) [ 28.020970][ C3] _printk (kernel/printk/printk.c:2504) [ 28.020973][ C3] ? snapshot_read.cold (user.c:?) [ 28.020975][ C3] ? arch_stack_walk (arch/x86/kernel/stacktrace.c:25) [ 28.020979][ C3] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 28.020981][ C3] ? nbcon_cpu_emergency_enter (./include/linux/instrumented.h:112 ./include/linux/atomic/atomic-instrumented.h:435 kernel/printk/nbcon.c:1723) [ 28.020983][ C3] print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4097 (discriminator 1)) [ 28.020985][ C3] mark_lock_irq (kernel/locking/lockdep.c:4095 kernel/locking/lockdep.c:4174 kernel/locking/lockdep.c:4310) [ 28.020988][ C3] mark_lock (kernel/locking/lockdep.c:4769) [ 28.020989][ C3] mark_usage (kernel/locking/lockdep.c:4658) [ 28.020991][ C3] __lock_acquire (kernel/locking/lockdep.c:5208) [ 28.020993][ C3] lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2)) [ 28.020995][ C3] ? br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 28.021001][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.021003][ C3] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 28.021004][ C3] ? br_message_age_timer_expired (net/bridge/br_stp_timer.c:54) bridge [ 28.021010][ C3] _raw_spin_lock (./include/linux/spinlock_api_smp.h:190 (discriminator 1) kernel/locking/spinlock.c:173 (discriminator 1)) [ 28.021012][ C3] ? br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 28.021018][ C3] br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 28.021024][ C3] ? br_message_age_timer_expired (net/bridge/br_stp_timer.c:54) bridge [ 28.021030][ C3] call_timer_fn (kernel/time/timer.c:1748) [ 28.021033][ C3] ? detach_if_pending (./include/linux/list.h:1159) [ 28.021034][ C3] ? debug_object_active_state (lib/debugobjects.c:1122) [ 28.021038][ C3] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 28.021039][ C3] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 28.021041][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.021043][ C3] __run_timers (kernel/time/timer.c:1799 kernel/time/timer.c:2374) [ 28.021045][ C3] ? br_message_age_timer_expired (net/bridge/br_stp_timer.c:54) bridge [ 28.021052][ C3] ? __bpf_trace_itimer_expire (./include/trace/events/timer.h:407) [ 28.021053][ C3] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 28.021056][ C3] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 28.021058][ C3] run_timer_softirq (kernel/time/timer.c:2386 kernel/time/timer.c:2395 kernel/time/timer.c:2403) [ 28.021060][ C3] ? __run_timers (./include/trace/events/timer.h:138 (discriminator 19)) [ 28.021062][ C3] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 28.021064][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.021065][ C3] handle_softirqs (kernel/softirq.c:645) [ 28.021067][ C3] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 28.021069][ C3] ? _local_bh_enable (kernel/softirq.c:428 (discriminator 1)) [ 28.021071][ C3] __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) [ 28.021072][ C3] irq_exit_rcu (kernel/softirq.c:784) [ 28.021073][ C3] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1062 (discriminator 37) arch/x86/kernel/apic/apic.c:1062 (discriminator 37)) [ 28.021076][ C3] [ 28.021077][ C3] [ 28.021077][ C3] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488) [ 28.021079][ C3] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:674) [ 28.021081][ C3] RIP: 0010:pv_native_safe_halt (./arch/x86/include/asm/irqflags.h:48 arch/x86/kernel/paravirt.c:63) [ 28.021084][ 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 [ 28.021086][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000282 [ 28.021089][ C3] RAX: 00000000000ac709 RBX: ff11000001c88040 RCX: ffffffff9cef0307 [ 28.021090][ C3] RDX: ff11000001c88040 RSI: ffffffff9fc38af6 RDI: ffffffff9f68d8e0 [ 28.021091][ C3] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 28.021092][ C3] R10: 0000000000000003 R11: 0000000000000001 R12: 1ff400000002cfc3 [ 28.021092][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 28.021094][ C3] ? cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 28.021097][ C3] default_idle (./arch/x86/include/asm/paravirt.h:62 arch/x86/kernel/process.c:768) [ 28.021099][ C3] default_idle_call (kernel/sched/idle.c:122) [ 28.021101][ C3] cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 28.021102][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 28.021103][ C3] ? mark_tsc_async_resets (arch/x86/kernel/tsc_sync.c:49) [ 28.021106][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.021108][ C3] do_idle (kernel/sched/idle.c:355) [ 28.021109][ C3] cpu_startup_entry (kernel/sched/idle.c:454) [ 28.021111][ C3] start_secondary (arch/x86/kernel/smpboot.c:312) [ 28.021113][ C3] ? set_cpu_sibling_map (arch/x86/kernel/smpboot.c:733 (discriminator 4)) [ 28.021115][ C3] common_startup_64 (arch/x86/kernel/head_64.S:418) | [ 28.079945][ C3] | [ 28.080013][ C3] | [ 28.080013][ C3] stack backtrace: | [ 28.080221][ C3] Tainted: [W]=WARN [ 28.080222][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 28.080223][ C3] Call Trace: [ 28.080224][ C3] [ 28.080225][ C3] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 28.080228][ C3] print_irq_inversion_bug.part.0.cold (kernel/locking/lockdep.c:4141) [ 28.080230][ C3] mark_lock_irq (kernel/locking/lockdep.c:4095 kernel/locking/lockdep.c:4174 kernel/locking/lockdep.c:4310) [ 28.080233][ C3] mark_lock (kernel/locking/lockdep.c:4769) [ 28.080235][ C3] mark_usage (kernel/locking/lockdep.c:4658) [ 28.080237][ C3] __lock_acquire (kernel/locking/lockdep.c:5208) [ 28.080239][ C3] lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2)) [ 28.080240][ C3] ? br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 28.080247][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.080250][ C3] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 28.080252][ C3] ? br_message_age_timer_expired (net/bridge/br_stp_timer.c:54) bridge [ 28.080257][ C3] _raw_spin_lock (./include/linux/spinlock_api_smp.h:190 (discriminator 1) kernel/locking/spinlock.c:173 (discriminator 1)) [ 28.080263][ C3] ? br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 28.080269][ C3] br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 28.080275][ C3] ? br_message_age_timer_expired (net/bridge/br_stp_timer.c:54) bridge [ 28.080281][ C3] call_timer_fn (kernel/time/timer.c:1748) [ 28.080284][ C3] ? detach_if_pending (./include/linux/list.h:1159) [ 28.080285][ C3] ? debug_object_active_state (lib/debugobjects.c:1122) [ 28.080288][ C3] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 28.080290][ C3] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 28.080291][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.080294][ C3] __run_timers (kernel/time/timer.c:1799 kernel/time/timer.c:2374) [ 28.080295][ C3] ? br_message_age_timer_expired (net/bridge/br_stp_timer.c:54) bridge [ 28.080302][ C3] ? __bpf_trace_itimer_expire (./include/trace/events/timer.h:407) [ 28.080304][ C3] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 28.080306][ C3] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 28.080309][ C3] run_timer_softirq (kernel/time/timer.c:2386 kernel/time/timer.c:2395 kernel/time/timer.c:2403) [ 28.080311][ C3] ? __run_timers (./include/trace/events/timer.h:138 (discriminator 19)) [ 28.080312][ C3] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 28.080314][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.080316][ C3] handle_softirqs (kernel/softirq.c:645) [ 28.080318][ C3] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 28.080319][ C3] ? _local_bh_enable (kernel/softirq.c:428 (discriminator 1)) [ 28.080321][ C3] __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) [ 28.080322][ C3] irq_exit_rcu (kernel/softirq.c:784) [ 28.080324][ C3] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1062 (discriminator 37) arch/x86/kernel/apic/apic.c:1062 (discriminator 37)) [ 28.080325][ C3] [ 28.080326][ C3] [ 28.080327][ C3] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488) [ 28.080328][ C3] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:674) [ 28.080330][ C3] RIP: 0010:pv_native_safe_halt (./arch/x86/include/asm/irqflags.h:48 arch/x86/kernel/paravirt.c:63) [ 28.080332][ 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 [ 28.080334][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000282 [ 28.080336][ C3] RAX: 00000000000ac709 RBX: ff11000001c88040 RCX: ffffffff9cef0307 [ 28.080337][ C3] RDX: ff11000001c88040 RSI: ffffffff9fc38af6 RDI: ffffffff9f68d8e0 [ 28.080337][ C3] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 28.080338][ C3] R10: 0000000000000003 R11: 0000000000000001 R12: 1ff400000002cfc3 [ 28.080339][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 28.080340][ C3] ? cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 28.080342][ C3] default_idle (./arch/x86/include/asm/paravirt.h:62 arch/x86/kernel/process.c:768) [ 28.080344][ C3] default_idle_call (kernel/sched/idle.c:122) [ 28.080345][ C3] cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 28.080347][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 28.080349][ C3] ? mark_tsc_async_resets (arch/x86/kernel/tsc_sync.c:49) [ 28.080350][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.080352][ C3] do_idle (kernel/sched/idle.c:355) [ 28.080354][ C3] cpu_startup_entry (kernel/sched/idle.c:454) [ 28.080355][ C3] start_secondary (arch/x86/kernel/smpboot.c:312) [ 28.080356][ C3] ? set_cpu_sibling_map (arch/x86/kernel/smpboot.c:733 (discriminator 4)) [ 28.080358][ C3] common_startup_64 (arch/x86/kernel/head_64.S:418) | [ 32.463311][ T36] softirqs last disabled at (68721): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 32.463313][ T36] Preemption disabled at: | [ 32.463314][ T36] 0x0 | [ 32.463324][ T36] Tainted: [W]=WARN [ 32.463325][ T36] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 32.463327][ T36] Workqueue: events_unbound linkwatch_event [ 32.463333][ T36] Call Trace: [ 32.463335][ T36] [ 32.463336][ T36] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 32.463341][ T36] __might_resched.cold (kernel/sched/core.c:9234) [ 32.463345][ T36] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 32.463348][ T36] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 32.463352][ T36] __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)) [ 32.463355][ T36] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 32.463358][ T36] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 32.463362][ T36] ? 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) [ 32.463363][ T36] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 32.463365][ T36] put_chars (drivers/char/virtio_console.c:1176) [ 32.463367][ T36] ? __send_to_port (drivers/char/virtio_console.c:654) [ 32.463368][ T36] ? printk_get_next_message (kernel/printk/printk.c:3072) [ 32.463372][ T36] ? console_prepend_replay (kernel/printk/printk.c:3005) [ 32.463374][ T36] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 32.463377][ T36] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 32.463378][ T36] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 32.463380][ T36] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 32.463381][ T36] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 32.463383][ T36] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 32.463385][ T36] console_emit_next_record (kernel/printk/printk.c:3183) [ 32.463388][ T36] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 32.463390][ T36] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 32.463391][ T36] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 32.463393][ T36] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 32.463394][ T36] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 32.463396][ T36] ? console_flush_one_record (kernel/printk/printk.c:3247) [ 32.463398][ T36] console_flush_one_record (kernel/printk/printk.c:3268) [ 32.463400][ T36] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 32.463403][ T36] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 32.463404][ T36] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 32.463406][ T36] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 32.463407][ T36] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 32.463409][ T36] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 32.463410][ T36] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 32.463412][ T36] ? __rcu_read_lock (kernel/rcu/tree_plugin.h:391 (discriminator 6) kernel/rcu/tree_plugin.h:414 (discriminator 6)) [ 32.463414][ T36] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 32.463416][ T36] ? vprintk_emit (kernel/printk/printk.c:2478) [ 32.463418][ T36] vprintk_emit (kernel/printk/printk.c:2479) [ 32.463420][ T36] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 32.463422][ T36] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 32.463424][ T36] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 32.463427][ T36] _printk (kernel/printk/printk.c:2504) [ 32.463430][ T36] ? snapshot_read.cold (user.c:?) [ 32.463432][ T36] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 32.463434][ T36] ? fib6_del (net/ipv6/ip6_fib.c:2069) [ 32.463438][ T36] br_set_state (net/bridge/br_stp.c:57 (discriminator 2)) bridge [ 32.463450][ T36] br_stp_disable_port (net/bridge/br_stp_if.c:106) bridge [ 32.463458][ T36] br_port_carrier_check (net/bridge/br_if.c:95) bridge [ 32.463466][ T36] br_device_event (net/bridge/br.c:101) bridge [ 32.463474][ T36] ? _sub_I_65535_1+0x4d0/0x4d0 stp [ 32.463476][ T36] ? addrconf_notify (net/ipv6/addrconf.c:3749) [ 32.463480][ T36] notifier_call_chain (kernel/notifier.c:85) [ 32.463483][ T36] netif_state_change (net/core/dev.c:1625) [ 32.463486][ T36] ? dev_deactivate (net/sched/sch_generic.c:1419) [ 32.463488][ T36] ? call_netdevice_notifiers_info (./include/net/net_namespace.h:422 (discriminator 7)) [ 32.463490][ T36] ? rfc2863_policy (net/core/link_watch.c:52 net/core/link_watch.c:76) [ 32.463492][ T36] ? linkwatch_do_dev (net/core/link_watch.c:184 net/core/link_watch.c:166) [ 32.463493][ T36] __linkwatch_run_queue (net/core/link_watch.c:240) [ 32.463495][ T36] ? linkwatch_do_dev (./arch/x86/include/asm/bitops.h:202 (discriminator 1)) [ 32.463496][ T36] ? debug_object_active_state (lib/debugobjects.c:1122) [ 32.463500][ T36] linkwatch_event (net/core/link_watch.c:314 (discriminator 11)) [ 32.463502][ T36] ? __linkwatch_run_queue (./include/linux/list.h:577) [ 32.463504][ T36] process_one_work (kernel/workqueue.c:3387) [ 32.463507][ T36] ? __queue_delayed_work (kernel/workqueue.c:2622) [ 32.463509][ T36] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 32.463511][ T36] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 32.463513][ T36] worker_thread (kernel/workqueue.c:3470 kernel/workqueue.c:3551) [ 32.463516][ T36] ? rescuer_thread (./include/linux/list.h:419 (discriminator 3)) [ 32.463517][ T36] kthread (kernel/kthread.c:436) [ 32.463519][ T36] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 32.463521][ T36] ? kthread_affine_preferred (kernel/kthread.c:857) [ 32.463522][ T36] ret_from_fork (arch/x86/kernel/process.c:158) [ 32.463525][ T36] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/vdso/vma.c:80 (discriminator 1)) [ 32.463527][ T36] ? __switch_to (arch/x86/kernel/process_64.c:403 arch/x86/kernel/process_64.c:663) [ 32.463530][ T36] ? kthread_affine_preferred (kernel/kthread.c:857) [ 32.463531][ T36] ret_from_fork_asm (arch/x86/entry/entry_64.S:245) | [ 37.658524][ T189] softirqs last disabled at (70908): kernel_fpu_begin_mask (./include/linux/bottom_half.h:20 (discriminator 2) ./arch/x86/include/asm/fpu/api.h:69 (discriminator 2) arch/x86/kernel/fpu/core.c:475 (discriminator 2)) | [ 37.658526][ T189] Preemption disabled at: | [ 37.658527][ T189] 0x0 | [ 37.658537][ T189] Tainted: [W]=WARN [ 37.658538][ T189] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 37.658539][ T189] Workqueue: events_unbound linkwatch_event [ 37.658546][ T189] Call Trace: [ 37.658547][ T189] [ 37.658549][ T189] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 37.658553][ T189] __might_resched.cold (kernel/sched/core.c:9234) [ 37.658557][ T189] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 37.658562][ T189] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 37.658566][ T189] __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)) [ 37.658569][ T189] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 37.658572][ T189] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 37.658576][ T189] ? 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) [ 37.658577][ T189] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 37.658579][ T189] put_chars (drivers/char/virtio_console.c:1176) [ 37.658581][ T189] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 37.658583][ T189] ? __send_to_port (drivers/char/virtio_console.c:654) [ 37.658584][ T189] ? printk_get_next_message (kernel/printk/printk.c:3072) [ 37.658587][ T189] ? kvm_clock_get_cycles (arch/x86/kernel/kvmclock.c:80 (discriminator 1) arch/x86/kernel/kvmclock.c:87 (discriminator 1)) [ 37.658590][ T189] ? ktime_get (kernel/time/timekeeping.c:304 kernel/time/timekeeping.c:482 kernel/time/timekeeping.c:1004) [ 37.658593][ T189] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 37.658597][ T189] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 37.658598][ T189] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 37.658600][ T189] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 37.658601][ T189] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 37.658604][ T189] console_emit_next_record (kernel/printk/printk.c:3183) [ 37.658606][ T189] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 37.658608][ T189] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 37.658610][ T189] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 37.658611][ T189] ? console_flush_one_record (kernel/printk/printk.c:3247) [ 37.658613][ T189] console_flush_one_record (kernel/printk/printk.c:3268) [ 37.658615][ T189] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 37.658618][ T189] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 37.658620][ T189] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 37.658621][ T189] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 37.658623][ T189] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 37.658624][ T189] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 37.658626][ T189] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 37.658627][ T189] ? __rcu_read_lock (kernel/rcu/tree_plugin.h:391 (discriminator 6) kernel/rcu/tree_plugin.h:414 (discriminator 6)) [ 37.658629][ T189] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 37.658631][ T189] ? vprintk_emit (kernel/printk/printk.c:2478) [ 37.658633][ T189] vprintk_emit (kernel/printk/printk.c:2479) [ 37.658636][ T189] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 37.658637][ T189] ? do_raw_read_unlock (kernel/locking/spinlock_debug.c:180) [ 37.658639][ T189] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 37.658641][ T189] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 37.658643][ T189] _printk (kernel/printk/printk.c:2504) [ 37.658646][ T189] ? snapshot_read.cold (user.c:?) [ 37.658647][ T189] ? netif_get_link_ksettings (net/ethtool/ioctl.c:450) [ 37.658650][ T189] ? port_cost (net/bridge/br_if.c:40) bridge [ 37.658662][ T189] ? br_multicast_flood (??:?) bridge [ 37.658670][ T189] br_set_state (net/bridge/br_stp.c:57 (discriminator 2)) bridge [ 37.658678][ T189] br_init_port (net/bridge/br_stp_if.c:39) bridge [ 37.658685][ T189] br_stp_enable_port (net/bridge/br_stp_if.c:93) bridge [ 37.658692][ T189] br_port_carrier_check (net/bridge/br_if.c:90) bridge [ 37.658700][ T189] br_device_event (net/bridge/br.c:101) bridge [ 37.658708][ T189] ? fib6_ifdown (net/ipv6/route.c:4976) [ 37.658711][ T189] ? _sub_I_65535_1+0x4d0/0x4d0 stp [ 37.658713][ T189] ? addrconf_notify (net/ipv6/addrconf.c:3764) [ 37.658717][ T189] notifier_call_chain (kernel/notifier.c:85) [ 37.658720][ T189] netif_state_change (net/core/dev.c:1625) [ 37.658723][ T189] ? call_netdevice_notifiers_info (./include/net/net_namespace.h:422 (discriminator 7)) [ 37.658725][ T189] ? linkwatch_do_dev (net/core/link_watch.c:182 net/core/link_watch.c:166) [ 37.658727][ T189] __linkwatch_run_queue (net/core/link_watch.c:240) [ 37.658729][ T189] ? linkwatch_do_dev (./arch/x86/include/asm/bitops.h:202 (discriminator 1)) [ 37.658730][ T189] ? debug_object_active_state (lib/debugobjects.c:1122) [ 37.658734][ T189] linkwatch_event (net/core/link_watch.c:314 (discriminator 11)) [ 37.658735][ T189] ? __linkwatch_run_queue (./include/linux/list.h:577) [ 37.658737][ T189] process_one_work (kernel/workqueue.c:3387) [ 37.658741][ T189] ? __queue_delayed_work (kernel/workqueue.c:2622) [ 37.658743][ T189] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 37.658744][ T189] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 37.658747][ T189] worker_thread (kernel/workqueue.c:3470 kernel/workqueue.c:3551) [ 37.658751][ T189] ? rescuer_thread (./include/linux/list.h:419 (discriminator 3)) [ 37.658753][ T189] ? __kthread_parkme (./include/linux/instrumented.h:82 ./include/asm-generic/bitops/instrumented-non-atomic.h:141 kernel/kthread.c:272) [ 37.658755][ T189] ? rescuer_thread (./include/linux/list.h:419 (discriminator 3)) [ 37.658756][ T189] ? rescuer_thread (./include/linux/list.h:419 (discriminator 3)) [ 37.658758][ T189] kthread (kernel/kthread.c:436) [ 37.658759][ T189] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 37.658762][ T189] ? kthread_affine_preferred (kernel/kthread.c:857) [ 37.658763][ T189] ret_from_fork (arch/x86/kernel/process.c:158) [ 37.658765][ T189] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/vdso/vma.c:80 (discriminator 1)) [ 37.658767][ T189] ? __switch_to (arch/x86/kernel/process_64.c:403 arch/x86/kernel/process_64.c:663) [ 37.658769][ T189] ? kthread_affine_preferred (kernel/kthread.c:857) [ 37.658771][ T189] ret_from_fork_asm (arch/x86/entry/entry_64.S:245) | [ 51.523785][ T189] softirqs last disabled at (70908): kernel_fpu_begin_mask (./include/linux/bottom_half.h:20 (discriminator 2) ./arch/x86/include/asm/fpu/api.h:69 (discriminator 2) arch/x86/kernel/fpu/core.c:475 (discriminator 2)) | [ 51.523787][ T189] Preemption disabled at: | [ 51.523788][ T189] 0x0 | [ 51.523798][ T189] Tainted: [W]=WARN [ 51.523799][ T189] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 51.523801][ T189] Workqueue: events_unbound linkwatch_event [ 51.523807][ T189] Call Trace: [ 51.523809][ T189] [ 51.523810][ T189] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 51.523815][ T189] __might_resched.cold (kernel/sched/core.c:9234) [ 51.523819][ T189] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 51.523823][ T189] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 51.523827][ T189] __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)) [ 51.523831][ T189] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 51.523834][ T189] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 51.523837][ T189] ? 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) [ 51.523839][ T189] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 51.523841][ T189] put_chars (drivers/char/virtio_console.c:1176) [ 51.523843][ T189] ? __send_to_port (drivers/char/virtio_console.c:654) [ 51.523844][ T189] ? printk_get_next_message (kernel/printk/printk.c:3072) [ 51.523847][ T189] ? kvm_clock_get_cycles (./arch/x86/include/asm/kvmclock.h:11 (discriminator 6) arch/x86/kernel/kvmclock.c:80 (discriminator 6) arch/x86/kernel/kvmclock.c:87 (discriminator 6)) [ 51.523851][ T189] ? ktime_get (kernel/time/timekeeping.c:304 kernel/time/timekeeping.c:482 kernel/time/timekeeping.c:1004) [ 51.523853][ T189] ? console_prepend_replay (kernel/printk/printk.c:3005) [ 51.523856][ T189] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 51.523859][ T189] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 51.523860][ T189] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 51.523862][ T189] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 51.523864][ T189] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 51.523865][ T189] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 51.523868][ T189] console_emit_next_record (kernel/printk/printk.c:3183) [ 51.523870][ T189] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 51.523872][ T189] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 51.523874][ T189] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 51.523876][ T189] ? console_flush_one_record (kernel/printk/printk.c:3247) [ 51.523878][ T189] console_flush_one_record (kernel/printk/printk.c:3268) [ 51.523880][ T189] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 51.523883][ T189] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 51.523885][ T189] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 51.523886][ T189] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 51.523888][ T189] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 51.523889][ T189] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 51.523891][ T189] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 51.523892][ T189] ? __rcu_read_lock (kernel/rcu/tree_plugin.h:391 (discriminator 6) kernel/rcu/tree_plugin.h:414 (discriminator 6)) [ 51.523894][ T189] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 51.523896][ T189] ? vprintk_emit (kernel/printk/printk.c:2478) [ 51.523898][ T189] vprintk_emit (kernel/printk/printk.c:2479) [ 51.523902][ T189] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 51.523904][ T189] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 51.523905][ T189] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 51.523908][ T189] _printk (kernel/printk/printk.c:2504) [ 51.523911][ T189] ? snapshot_read.cold (user.c:?) [ 51.523913][ T189] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 51.523915][ T189] ? fib6_del (net/ipv6/ip6_fib.c:2069) [ 51.523919][ T189] br_set_state (net/bridge/br_stp.c:57 (discriminator 2)) bridge [ 51.523933][ T189] br_stp_disable_port (net/bridge/br_stp_if.c:106) bridge [ 51.523941][ T189] br_port_carrier_check (net/bridge/br_if.c:95) bridge [ 51.523950][ T189] br_device_event (net/bridge/br.c:101) bridge [ 51.523961][ T189] ? _sub_I_65535_1+0x4d0/0x4d0 stp [ 51.523963][ T189] ? addrconf_notify (net/ipv6/addrconf.c:3749) [ 51.523967][ T189] notifier_call_chain (kernel/notifier.c:85) [ 51.523970][ T189] netif_state_change (net/core/dev.c:1625) [ 51.523973][ T189] ? dev_deactivate (net/sched/sch_generic.c:1419) [ 51.523976][ T189] ? call_netdevice_notifiers_info (./include/net/net_namespace.h:422 (discriminator 7)) [ 51.523978][ T189] ? rfc2863_policy (net/core/link_watch.c:52 net/core/link_watch.c:76) [ 51.523980][ T189] ? linkwatch_do_dev (net/core/link_watch.c:184 net/core/link_watch.c:166) [ 51.523981][ T189] __linkwatch_run_queue (net/core/link_watch.c:240) [ 51.523983][ T189] ? linkwatch_do_dev (./arch/x86/include/asm/bitops.h:202 (discriminator 1)) [ 51.523984][ T189] ? debug_object_active_state (lib/debugobjects.c:1122) [ 51.523989][ T189] linkwatch_event (net/core/link_watch.c:314 (discriminator 11)) [ 51.523990][ T189] ? __linkwatch_run_queue (./include/linux/list.h:577) [ 51.523992][ T189] process_one_work (kernel/workqueue.c:3387) [ 51.523996][ T189] ? __queue_delayed_work (kernel/workqueue.c:2622) [ 51.523998][ T189] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 51.523999][ T189] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 51.524002][ T189] worker_thread (kernel/workqueue.c:3470 kernel/workqueue.c:3551) [ 51.524004][ T189] ? rescuer_thread (./include/linux/list.h:419 (discriminator 3)) [ 51.524006][ T189] ? __kthread_parkme (./include/linux/instrumented.h:82 ./include/asm-generic/bitops/instrumented-non-atomic.h:141 kernel/kthread.c:272) [ 51.524007][ T189] ? rescuer_thread (./include/linux/list.h:419 (discriminator 3)) [ 51.524009][ T189] ? rescuer_thread (./include/linux/list.h:419 (discriminator 3)) [ 51.524011][ T189] kthread (kernel/kthread.c:436) [ 51.524012][ T189] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 51.524014][ T189] ? kthread_affine_preferred (kernel/kthread.c:857) [ 51.524015][ T189] ret_from_fork (arch/x86/kernel/process.c:158) [ 51.524017][ T189] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/vdso/vma.c:80 (discriminator 1)) [ 51.524019][ T189] ? __switch_to (arch/x86/kernel/process_64.c:403 arch/x86/kernel/process_64.c:663) [ 51.524022][ T189] ? kthread_affine_preferred (kernel/kthread.c:857) [ 51.524024][ T189] ret_from_fork_asm (arch/x86/entry/entry_64.S:245) | [ 56.750545][ T38] softirqs last disabled at (89865): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 56.750547][ T38] Preemption disabled at: | [ 56.750548][ T38] 0x0 | [ 56.750558][ T38] Tainted: [W]=WARN [ 56.750559][ T38] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 56.750561][ T38] Workqueue: events_unbound linkwatch_event [ 56.750567][ T38] Call Trace: [ 56.750568][ T38] [ 56.750570][ T38] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 56.750575][ T38] __might_resched.cold (kernel/sched/core.c:9234) [ 56.750579][ T38] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 56.750583][ T38] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 56.750586][ T38] __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)) [ 56.750590][ T38] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 56.750593][ T38] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 56.750596][ T38] ? 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) [ 56.750598][ T38] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 56.750600][ T38] put_chars (drivers/char/virtio_console.c:1176) [ 56.750602][ T38] ? __send_to_port (drivers/char/virtio_console.c:654) [ 56.750603][ T38] ? printk_get_next_message (kernel/printk/printk.c:3072) [ 56.750606][ T38] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 56.750610][ T38] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 56.750612][ T38] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 56.750613][ T38] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 56.750615][ T38] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 56.750617][ T38] console_emit_next_record (kernel/printk/printk.c:3183) [ 56.750620][ T38] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 56.750622][ T38] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 56.750624][ T38] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 56.750625][ T38] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 56.750627][ T38] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 56.750629][ T38] ? console_flush_one_record (kernel/printk/printk.c:3247) [ 56.750631][ T38] console_flush_one_record (kernel/printk/printk.c:3268) [ 56.750633][ T38] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 56.750636][ T38] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 56.750637][ T38] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 56.750639][ T38] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 56.750641][ T38] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 56.750642][ T38] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 56.750644][ T38] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 56.750645][ T38] ? __rcu_read_lock (kernel/rcu/tree_plugin.h:391 (discriminator 6) kernel/rcu/tree_plugin.h:414 (discriminator 6)) [ 56.750647][ T38] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 56.750649][ T38] ? vprintk_emit (kernel/printk/printk.c:2478) [ 56.750651][ T38] vprintk_emit (kernel/printk/printk.c:2479) [ 56.750654][ T38] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 56.750656][ T38] ? do_raw_read_unlock (kernel/locking/spinlock_debug.c:180) [ 56.750657][ T38] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 56.750659][ T38] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 56.750661][ T38] _printk (kernel/printk/printk.c:2504) [ 56.750664][ T38] ? snapshot_read.cold (user.c:?) [ 56.750666][ T38] ? netif_get_link_ksettings (net/ethtool/ioctl.c:450) [ 56.750669][ T38] ? port_cost (net/bridge/br_if.c:40) bridge [ 56.750682][ T38] ? br_multicast_flood (??:?) bridge [ 56.750690][ T38] br_set_state (net/bridge/br_stp.c:57 (discriminator 2)) bridge [ 56.750698][ T38] br_init_port (net/bridge/br_stp_if.c:39) bridge [ 56.750706][ T38] br_stp_enable_port (net/bridge/br_stp_if.c:93) bridge [ 56.750712][ T38] br_port_carrier_check (net/bridge/br_if.c:90) bridge [ 56.750720][ T38] br_device_event (net/bridge/br.c:101) bridge [ 56.750727][ T38] ? fib6_ifdown (net/ipv6/route.c:4976) [ 56.750731][ T38] ? _sub_I_65535_1+0x4d0/0x4d0 stp [ 56.750733][ T38] ? addrconf_notify (net/ipv6/addrconf.c:3764) [ 56.750737][ T38] notifier_call_chain (kernel/notifier.c:85) [ 56.750740][ T38] netif_state_change (net/core/dev.c:1625) [ 56.750744][ T38] ? call_netdevice_notifiers_info (./include/net/net_namespace.h:422 (discriminator 7)) [ 56.750746][ T38] ? linkwatch_do_dev (net/core/link_watch.c:182 net/core/link_watch.c:166) [ 56.750751][ T38] __linkwatch_run_queue (net/core/link_watch.c:240) [ 56.750753][ T38] ? linkwatch_do_dev (./arch/x86/include/asm/bitops.h:202 (discriminator 1)) [ 56.750754][ T38] ? debug_object_active_state (lib/debugobjects.c:1122) [ 56.750759][ T38] linkwatch_event (net/core/link_watch.c:314 (discriminator 11)) [ 56.750760][ T38] ? __linkwatch_run_queue (./include/linux/list.h:577) [ 56.750762][ T38] process_one_work (kernel/workqueue.c:3387) [ 56.750766][ T38] ? __queue_delayed_work (kernel/workqueue.c:2622) [ 56.750768][ T38] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 56.750770][ T38] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 56.750772][ T38] worker_thread (kernel/workqueue.c:3470 kernel/workqueue.c:3551) [ 56.750775][ T38] ? rescuer_thread (./include/linux/list.h:419 (discriminator 3)) [ 56.750776][ T38] kthread (kernel/kthread.c:436) [ 56.750778][ T38] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 56.750781][ T38] ? kthread_affine_preferred (kernel/kthread.c:857) [ 56.750783][ T38] ret_from_fork (arch/x86/kernel/process.c:158) [ 56.750786][ T38] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/vdso/vma.c:80 (discriminator 1)) [ 56.750788][ T38] ? __switch_to (arch/x86/kernel/process_64.c:403 arch/x86/kernel/process_64.c:663) [ 56.750790][ T38] ? kthread_affine_preferred (kernel/kthread.c:857) Finger prints: mark_lock_irq:mark_lock:mark_usage:__lock_acquire:_raw_spin_lock kernel_fpu_begin_mask:dump_stack_lvl:__kmalloc_noprof:put_chars:hvc_console_print __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