====================================== | [ 9.615878][ T179] softirqs last disabled at (22279): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 9.615880][ T179] Preemption disabled at: | [ 9.615881][ T179] 0x0 | [ 9.615891][ T179] Tainted: [W]=WARN [ 9.615892][ T179] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.615893][ T179] Call Trace: [ 9.615895][ T179] [ 9.615897][ T179] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 9.615902][ T179] __might_resched.cold (kernel/sched/core.c:9234) [ 9.615907][ T179] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 9.615911][ T179] ? __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.615916][ T179] __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.615918][ T179] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 9.615924][ T179] ? 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.615927][ T179] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 9.615930][ T179] put_chars (drivers/char/virtio_console.c:1176) [ 9.615933][ T179] ? __send_to_port (drivers/char/virtio_console.c:654) [ 9.615935][ T179] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 9.615940][ T179] ? validate_chain (kernel/locking/lockdep.c:3817 (discriminator 2) kernel/locking/lockdep.c:3837 (discriminator 2) kernel/locking/lockdep.c:3892 (discriminator 2)) [ 9.615945][ T179] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 9.615952][ T179] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 9.615954][ T179] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 9.615957][ T179] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 9.615961][ T179] console_emit_next_record (kernel/printk/printk.c:3183) [ 9.615965][ T179] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 9.615966][ T179] ? 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.615970][ T179] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 9.615972][ T179] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 9.615976][ T179] console_flush_one_record (kernel/printk/printk.c:3268) [ 9.615980][ T179] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 9.615982][ T179] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 9.615987][ T179] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 9.615989][ T179] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 9.615991][ T179] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 9.615994][ T179] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 9.615997][ T179] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 9.615999][ T179] ? vprintk_emit (kernel/printk/printk.c:2478) [ 9.616003][ T179] vprintk_emit (kernel/printk/printk.c:2479) [ 9.616007][ T179] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 9.616011][ T179] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 9.616014][ T179] _printk (kernel/printk/printk.c:2504) [ 9.616018][ T179] ? snapshot_read.cold (user.c:?) [ 9.616020][ T179] ? 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.616023][ T179] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 9.616027][ T179] ? 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.616029][ T179] do_exit.cold (kernel/exit.c:889 (discriminator 4) kernel/exit.c:1043 (discriminator 4)) [ 9.616033][ T179] ? exit_notify (kernel/exit.c:780) [ 9.616034][ T179] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 9.616037][ T179] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 9.616041][ T179] do_group_exit (kernel/exit.c:1151) [ 9.616044][ T179] __x64_sys_exit_group (kernel/exit.c:1162 kernel/exit.c:1160 kernel/exit.c:1160) [ 9.616046][ T179] x64_sys_call (./arch/x86/include/generated/asm/syscalls_64.h:232) [ 9.616049][ T179] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 9.616053][ T179] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 9.616056][ T179] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 9.616058][ T179] RIP: 0033:0x7f735cf241b8 [ 9.616060][ T179] Code: Unable to access opcode bytes at 0x7f735cf2418e. Code starting with the faulting instruction =========================================== [ 9.616061][ T179] RSP: 002b:00007ffd0059cba8 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 9.616064][ T179] RAX: ffffffffffffffda RBX: 00007f735d054f88 RCX: 00007f735cf241b8 [ 9.616065][ T179] RDX: 00007f735cc6efc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 9.616066][ T179] RBP: 00007ffd0059cc00 R08: 0000000000000000 R09: 0000000000000050 [ 9.616067][ T179] R10: 00007ffd0059c9c0 R11: 0000000000000246 R12: 0000000000000001 [ 9.616067][ T179] R13: 0000000000000000 R14: 00007f735d053680 R15: 00007f735d054fa0 | [ 10.413751][ C0] | [ 10.413751][ C0] | [ 10.413751][ C0] stack backtrace: | [ 10.413757][ C0] Tainted: [W]=WARN [ 10.413758][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.413760][ C0] Call Trace: [ 10.413761][ C0] [ 10.413763][ C0] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 10.413767][ C0] print_irq_inversion_bug.part.0.cold (kernel/locking/lockdep.c:4141) [ 10.413769][ C0] mark_lock_irq (kernel/locking/lockdep.c:4095 kernel/locking/lockdep.c:4174 kernel/locking/lockdep.c:4310) [ 10.413770][ C0] ? add_lock_to_list (./include/linux/find.h:391 kernel/locking/lockdep.c:1419 kernel/locking/lockdep.c:1450) [ 10.413773][ C0] mark_lock (kernel/locking/lockdep.c:4769) [ 10.413775][ C0] mark_usage (kernel/locking/lockdep.c:4658) [ 10.413777][ C0] __lock_acquire (kernel/locking/lockdep.c:5208) [ 10.413779][ C0] lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2)) [ 10.413780][ C0] ? console_lock_spinning_enable (kernel/printk/printk.c:1902 (discriminator 2)) [ 10.413782][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 10.413786][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 10.413788][ C0] console_lock_spinning_enable (kernel/printk/printk.c:1902 (discriminator 2)) [ 10.413789][ C0] ? console_lock_spinning_enable (kernel/printk/printk.c:1902 (discriminator 2)) [ 10.413791][ C0] console_emit_next_record (kernel/printk/printk.c:3177) [ 10.413793][ C0] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 10.413795][ C0] ? console_flush_one_record (./include/linux/rcupdate.h:314 (discriminator 2) ./include/linux/srcu.h:439 (discriminator 2) kernel/printk/printk.c:291 (discriminator 2) kernel/printk/printk.c:3246 (discriminator 2)) [ 10.413797][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 10.413798][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 10.413800][ C0] console_flush_one_record (kernel/printk/printk.c:3268) [ 10.413802][ C0] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 10.413804][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 10.413806][ C0] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 10.413808][ C0] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 10.413810][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 10.413811][ C0] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 10.413813][ C0] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 10.413815][ C0] ? vprintk_emit (kernel/printk/printk.c:2478) [ 10.413817][ C0] vprintk_emit (kernel/printk/printk.c:2479) [ 10.413819][ C0] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 10.413821][ C0] ? clocksource_watchdog.part.0 (kernel/time/clocksource.c:531 (discriminator 1) kernel/time/clocksource.c:608 (discriminator 1) kernel/time/clocksource.c:667 (discriminator 1)) [ 10.413823][ C0] _printk (kernel/printk/printk.c:2504) [ 10.413824][ C0] ? snapshot_read.cold (user.c:?) [ 10.413826][ C0] ? clocksource_watchdog.part.0 (kernel/time/clocksource.c:531 (discriminator 1) kernel/time/clocksource.c:608 (discriminator 1) kernel/time/clocksource.c:667 (discriminator 1)) [ 10.413828][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 10.413830][ C0] clocksource_watchdog.part.0.cold (kernel/time/clocksource.c:589 (discriminator 10) kernel/time/clocksource.c:632 (discriminator 10) kernel/time/clocksource.c:667 (discriminator 10)) [ 10.413831][ C0] ? clocksource_watchdog.part.0 (./include/linux/find.h:67 (discriminator 4)) [ 10.413833][ C0] ? clocksource_watchdog.part.0 (./include/linux/find.h:67 (discriminator 4)) [ 10.413835][ C0] call_timer_fn (kernel/time/timer.c:1748) [ 10.413837][ C0] ? detach_if_pending (./include/linux/list.h:1159) [ 10.413838][ C0] ? debug_object_active_state (lib/debugobjects.c:1122) [ 10.413842][ C0] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 10.413844][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 10.413845][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 10.413848][ C0] __run_timers (kernel/time/timer.c:1799 kernel/time/timer.c:2374) [ 10.413849][ C0] ? clocksource_watchdog.part.0 (./include/linux/find.h:67 (discriminator 4)) [ 10.413851][ C0] ? __bpf_trace_itimer_expire (./include/trace/events/timer.h:407) [ 10.413853][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 10.413856][ C0] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 10.413858][ C0] run_timer_softirq (kernel/time/timer.c:2386 kernel/time/timer.c:2395 kernel/time/timer.c:2403) [ 10.413860][ C0] ? __run_timers (./include/trace/events/timer.h:138 (discriminator 19)) [ 10.413862][ C0] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 10.413864][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 10.413866][ C0] handle_softirqs (kernel/softirq.c:645) [ 10.413868][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 10.413869][ C0] ? _local_bh_enable (kernel/softirq.c:428 (discriminator 1)) [ 10.413871][ C0] __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) [ 10.413872][ C0] irq_exit_rcu (kernel/softirq.c:784) [ 10.413874][ C0] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1062 (discriminator 37) arch/x86/kernel/apic/apic.c:1062 (discriminator 37)) [ 10.413875][ C0] [ 10.413876][ C0] [ 10.413876][ C0] ? lockdep_hardirqs_on_prepare.part.0 (kernel/locking/lockdep.c:470 (discriminator 2) kernel/locking/lockdep.c:4427 (discriminator 2)) [ 10.413878][ C0] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:674) [ 10.413880][ C0] RIP: 0010:pv_native_safe_halt (./arch/x86/include/asm/irqflags.h:48 arch/x86/kernel/paravirt.c:63) [ 10.413882][ C0] Code: 48 8b 3d 94 12 06 02 e8 1f 00 00 00 48 2b 05 58 13 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 b6 17 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 12 06 02 mov 0x2061294(%rip),%rdi # 0x206129b 7: e8 1f 00 00 00 call 0x2b c: 48 2b 05 58 13 a0 00 sub 0xa01358(%rip),%rax # 0xa0136b 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 b6 17 00 verw 0x17b613(%rip) # 0x17b63b 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 [ 10.413884][ C0] RSP: 0018:ffffffffa9c07cf8 EFLAGS: 00000296 [ 10.413886][ C0] RAX: 000000000003db05 RBX: ffffffffa9c2c600 RCX: ffffffffa6afa307 [ 10.413887][ C0] RDX: ffffffffa9c2c600 RSI: ffffffffa9a78e7e RDI: ffffffffa948dce0 [ 10.413888][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 10.413889][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff5380fa2 [ 10.413890][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 10.413891][ C0] ? cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 10.413894][ C0] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488) [ 10.413895][ C0] default_idle (./arch/x86/include/asm/paravirt.h:62 arch/x86/kernel/process.c:768) [ 10.413896][ C0] default_idle_call (kernel/sched/idle.c:122) [ 10.413897][ C0] cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 10.413899][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 10.413900][ C0] ? mark_tsc_async_resets (arch/x86/kernel/tsc_sync.c:49) [ 10.413903][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 10.413905][ C0] do_idle (kernel/sched/idle.c:355) [ 10.413906][ C0] cpu_startup_entry (kernel/sched/idle.c:454) [ 10.413908][ C0] rest_init (init/main.c:727) [ 10.413909][ C0] ? __cpuidle_text_end (??:?) [ 10.413912][ C0] ? rest_init (init/main.c:727) [ 10.413913][ C0] ? acpi_hw_set_mode (drivers/acpi/acpica/hwacpi.c:72 (discriminator 1)) [ 10.413916][ C0] ? cpus_read_unlock (./include/linux/percpu-rwsem.h:125 (discriminator 1) kernel/cpu.c:502 (discriminator 1)) [ 10.413918][ C0] ? acpi_enable (drivers/acpi/acpica/evxfevnt.c:47) [ 10.413921][ C0] start_kernel (init/main.c:1185) [ 10.413923][ C0] x86_64_start_reservations (arch/x86/kernel/head64.c:310) [ 10.413925][ C0] x86_64_start_kernel (arch/x86/kernel/head64.c:291) [ 10.413927][ C0] common_startup_64 (arch/x86/kernel/head_64.S:418) | [ 14.995719][ T250] softirqs last disabled at (0): 0x0 | [ 14.995720][ T250] Preemption disabled at: | [ 14.995721][ T250] vprintk_emit (kernel/printk/printk.c:2471) | [ 14.995732][ T250] Tainted: [W]=WARN [ 14.995733][ T250] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.995734][ T250] Call Trace: [ 14.995736][ T250] [ 14.995737][ T250] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 14.995742][ T250] ? vprintk_emit (kernel/printk/printk.c:2471) [ 14.995744][ T250] __might_resched.cold (kernel/sched/core.c:9234) [ 14.995748][ T250] ? prb_next_reserve_seq (kernel/printk/printk_ringbuffer.c:2128) [ 14.995750][ T250] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 14.995753][ T250] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 14.995757][ T250] __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)) [ 14.995760][ T250] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 14.995763][ T250] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 14.995767][ T250] ? 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) [ 14.995769][ T250] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 14.995771][ T250] put_chars (drivers/char/virtio_console.c:1176) [ 14.995773][ T250] ? __send_to_port (drivers/char/virtio_console.c:654) [ 14.995775][ T250] ? console_prepend_replay (kernel/printk/printk.c:3005) [ 14.995777][ T250] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 14.995781][ T250] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 14.995782][ T250] ? vsnprintf (lib/vsprintf.c:2900) [ 14.995785][ T250] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 14.995787][ T250] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 14.995788][ T250] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 14.995791][ T250] console_emit_next_record (kernel/printk/printk.c:3183) [ 14.995793][ T250] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 14.995795][ T250] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 14.995797][ T250] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 14.995799][ T250] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 14.995800][ T250] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 14.995802][ T250] ? console_flush_one_record (kernel/printk/printk.c:3247) [ 14.995804][ T250] console_flush_one_record (kernel/printk/printk.c:3268) [ 14.995806][ T250] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 14.995809][ T250] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 14.995811][ T250] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 14.995812][ T250] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 14.995814][ T250] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 14.995815][ T250] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 14.995817][ T250] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 14.995818][ T250] ? __rcu_read_lock (kernel/rcu/tree_plugin.h:391 (discriminator 6) kernel/rcu/tree_plugin.h:414 (discriminator 6)) [ 14.995820][ T250] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 14.995822][ T250] ? vprintk_emit (kernel/printk/printk.c:2478) [ 14.995824][ T250] vprintk_emit (kernel/printk/printk.c:2479) [ 14.995827][ T250] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 14.995829][ T250] ? vlan_netlink_fini (./include/linux/etherdevice.h:306 net/8021q/vlan.c:316 net/8021q/vlan.c:416) 8021q [ 14.995832][ T250] _printk (kernel/printk/printk.c:2504) [ 14.995835][ T250] ? snapshot_read.cold (user.c:?) [ 14.995838][ T250] ? 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) [ 14.995841][ T250] 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 [ 14.995843][ T250] do_one_initcall (init/main.c:1357) [ 14.995845][ T250] ? trace_event_raw_event_initcall_level (./include/trace/events/initcall.h:10) [ 14.995847][ T250] ? do_init_module (./include/linux/slab.h:991 (discriminator 1) kernel/module/main.c:3105 (discriminator 1)) [ 14.995850][ T250] ? kasan_unpoison (mm/kasan/shadow.c:146 mm/kasan/shadow.c:178) [ 14.995853][ T250] do_init_module (kernel/module/main.c:3117) [ 14.995856][ T250] ? free_module (./include/trace/events/module.h:50 (discriminator 19)) [ 14.995858][ T250] ? kfree (./include/linux/kasan.h:235 mm/slub.c:2748 mm/slub.c:6499 mm/slub.c:6792) [ 14.995860][ T250] load_module (kernel/module/main.c:3593) [ 14.995863][ T250] ? layout_and_allocate.isra.0 (kernel/module/main.c:3016) [ 14.995865][ T250] ? __ia32_sys_fsconfig (??:?) [ 14.995868][ T250] ? ovl_real_file (fs/overlayfs/file.c:195) [ 14.995871][ T250] ? backing_file_read_iter (fs/backing-file.c:211) [ 14.995874][ T250] init_module_from_file (kernel/module/main.c:3790) [ 14.995877][ T250] ? __do_sys_init_module (kernel/module/main.c:3664) [ 14.995879][ T250] ? ovl_mmap (fs/overlayfs/file.c:477) [ 14.995881][ T250] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 14.995883][ T250] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 14.995885][ T250] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 14.995886][ T250] ? 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) [ 14.995888][ T250] idempotent_init_module (kernel/module/main.c:3802) [ 14.995890][ T250] ? init_module_from_file (kernel/module/main.c:3791) [ 14.995893][ T250] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 14.995895][ T250] ? cap_capable (./include/trace/events/capability.h:26 (discriminator 22) security/commoncap.c:130 (discriminator 22)) [ 14.995899][ T250] __x64_sys_finit_module (kernel/module/main.c:3828 kernel/module/main.c:3812 kernel/module/main.c:3812) [ 14.995900][ T250] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 14.995903][ T250] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 14.995906][ T250] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 14.995908][ T250] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 14.995910][ T250] RIP: 0033:0x7f1b448c637d [ 14.995912][ T250] 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 [ 14.995914][ T250] RSP: 002b:00007fffc3fdc888 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 14.995918][ T250] RAX: ffffffffffffffda RBX: 0000558419a19810 RCX: 00007f1b448c637d [ 14.995919][ T250] RDX: 0000000000000000 RSI: 0000558413435ffd RDI: 0000000000000000 [ 14.995920][ T250] RBP: 00007fffc3fdc920 R08: 0000000000000000 R09: 0000000000000000 [ 14.995921][ T250] R10: 0000000000000000 R11: 0000000000000246 R12: 0000558413435ffd [ 14.995922][ T250] R13: 0000558419a19960 R14: 0000000000040000 R15: 0000000000000000 | [ 19.794085][ T12] softirqs last disabled at (6672): addrconf_dad_begin (net/ipv6/addrconf.c:4137) | [ 19.794088][ T12] Preemption disabled at: | [ 19.794088][ T12] vprintk_emit (kernel/printk/printk.c:2471) | [ 19.794099][ T12] Tainted: [W]=WARN [ 19.794100][ T12] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 19.794102][ T12] Workqueue: netns cleanup_net [ 19.794108][ T12] Call Trace: [ 19.794110][ T12] [ 19.794111][ T12] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 19.794116][ T12] ? vprintk_emit (kernel/printk/printk.c:2471) [ 19.794118][ T12] __might_resched.cold (kernel/sched/core.c:9234) [ 19.794121][ T12] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 19.794124][ T12] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 19.794128][ T12] __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)) [ 19.794131][ T12] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 19.794134][ T12] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 19.794137][ T12] ? 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) [ 19.794139][ T12] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 19.794141][ T12] put_chars (drivers/char/virtio_console.c:1176) [ 19.794143][ T12] ? __send_to_port (drivers/char/virtio_console.c:654) [ 19.794145][ T12] ? console_prepend_replay (kernel/printk/printk.c:3005) [ 19.794148][ T12] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 19.794151][ T12] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 19.794153][ T12] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 19.794154][ T12] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 19.794156][ T12] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 19.794158][ T12] console_emit_next_record (kernel/printk/printk.c:3183) [ 19.794161][ T12] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 19.794166][ T12] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 19.794167][ T12] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 19.794169][ T12] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 19.794170][ T12] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 19.794172][ T12] ? console_flush_one_record (kernel/printk/printk.c:3247) [ 19.794174][ T12] console_flush_one_record (kernel/printk/printk.c:3268) [ 19.794176][ T12] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 19.794179][ T12] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 19.794181][ T12] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 19.794182][ T12] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 19.794184][ T12] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 19.794185][ T12] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 19.794187][ T12] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 19.794188][ T12] ? __rcu_read_lock (kernel/rcu/tree_plugin.h:391 (discriminator 6) kernel/rcu/tree_plugin.h:414 (discriminator 6)) [ 19.794190][ T12] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 19.794192][ T12] ? vprintk_emit (kernel/printk/printk.c:2478) [ 19.794194][ T12] vprintk_emit (kernel/printk/printk.c:2479) [ 19.794196][ T12] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 19.794198][ T12] ? _raw_spin_unlock (./include/linux/spinlock_api_smp.h:201 (discriminator 1) kernel/locking/spinlock.c:213 (discriminator 1)) [ 19.794199][ T12] ? trace_hardirqs_on (kernel/trace/trace_preemptirq.c:78) [ 19.794202][ T12] ? finish_task_switch.isra.0 (kernel/sched/sched.h:1698 kernel/sched/core.c:5251 kernel/sched/core.c:5369) [ 19.794203][ T12] _printk (kernel/printk/printk.c:2504) [ 19.794206][ T12] ? snapshot_read.cold (user.c:?) [ 19.794208][ T12] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 19.794210][ T12] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 19.794211][ T12] ? netdev_name (./include/linux/netdevice.h:5709 (discriminator 1)) [ 19.794214][ T12] ? __netdev_printk (net/core/dev.c:13148 (discriminator 2)) [ 19.794216][ T12] netdev_info (net/core/dev.c:13195 (discriminator 3)) [ 19.794217][ T12] ? netdev_notice (net/core/dev.c:13194) [ 19.794219][ T12] ? synchronize_rcu_expedited (kernel/rcu/tree_exp.h:985) [ 19.794220][ T12] ? netif_set_mtu_ext (net/core/dev.c:9910 (discriminator 2)) [ 19.794222][ T12] ? synchronize_rcu_normal (kernel/rcu/tree.c:3360) [ 19.794224][ T12] ? mutex_is_locked (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:3188 kernel/locking/mutex.h:48 kernel/locking/mutex.c:65) [ 19.794227][ T12] __dev_set_promiscuity.cold (net/core/dev.c:9672 (discriminator 3)) [ 19.794229][ T12] ? sync_rcu_exp_select_cpus (./include/linux/list.h:54 (discriminator 2)) [ 19.794231][ T12] ? netdev_sync_lower_features (net/core/dev.c:10949) [ 19.794233][ T12] netif_set_promiscuity (net/core/dev.c:9699) [ 19.794236][ T12] dev_set_promiscuity (net/core/dev_api.c:288) [ 19.794238][ T12] hsr_del_port (net/hsr/hsr_slave.c:244) [ 19.794241][ T12] hsr_del_ports (net/hsr/hsr_device.c:498) [ 19.794243][ T12] hsr_dellink (net/hsr/hsr_netlink.c:141) [ 19.794245][ T12] default_device_exit_batch (net/core/dev.c:13280) [ 19.794246][ T12] ? generic_xdp_install (./include/linux/netdevice.h:5716 (discriminator 3)) [ 19.794248][ T12] ? unregister_netdevice_queue (./include/linux/list.h:173) [ 19.794249][ T12] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 19.794251][ T12] ? mutex_is_locked (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:3188 kernel/locking/mutex.h:48 kernel/locking/mutex.c:65) [ 19.794253][ T12] ops_undo_list (net/core/net_namespace.c:206 net/core/net_namespace.c:253) [ 19.794256][ T12] ? rtnl_net_dumpid_one (net/core/net_namespace.c:1098) [ 19.794257][ T12] ? idr_destroy (lib/radix-tree.c:310 lib/radix-tree.c:674 lib/radix-tree.c:1563) [ 19.794260][ T12] cleanup_net (net/core/net_namespace.c:706) [ 19.794262][ T12] ? net_passive_dec (./include/linux/llist.h:241) [ 19.794264][ T12] ? update_load_avg (kernel/sched/fair.c:5864) [ 19.794266][ T12] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 19.794267][ T12] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 19.794270][ T12] process_one_work (kernel/workqueue.c:3387) [ 19.794273][ T12] ? __queue_delayed_work (kernel/workqueue.c:2622) [ 19.794275][ T12] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 19.794277][ T12] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 19.794279][ T12] worker_thread (kernel/workqueue.c:3470 kernel/workqueue.c:3551) [ 19.794282][ T12] ? rescuer_thread (./include/linux/list.h:419 (discriminator 3)) [ 19.794284][ T12] kthread (kernel/kthread.c:436) [ 19.794286][ T12] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 19.794288][ T12] ? kthread_affine_preferred (kernel/kthread.c:857) [ 19.794289][ T12] ret_from_fork (arch/x86/kernel/process.c:158) [ 19.794292][ T12] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/vdso/vma.c:80 (discriminator 1)) [ 19.794294][ T12] ? __switch_to (arch/x86/kernel/process_64.c:403 arch/x86/kernel/process_64.c:663) [ 19.794297][ T12] ? kthread_affine_preferred (kernel/kthread.c:857) Finger prints: mark_lock_irq:mark_lock:mark_usage:__lock_acquire:console_lock_spinning_enable addrconf_dad_begin:vprintk_emit:dump_stack_lvl:__kmalloc_noprof:put_chars __irq_exit_rcu:dump_stack_lvl:__kmalloc_noprof:put_chars:hvc_console_print vprintk_emit:dump_stack_lvl:__kmalloc_noprof:put_chars:hvc_console_print