====================================== | [ 21.071302][ C0] | [ 21.071303][ C0] | [ 21.071303][ C0] stack backtrace: | [ 21.071309][ C0] Tainted: [W]=WARN [ 21.071310][ C0] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 21.071312][ C0] Call Trace: [ 21.071313][ C0] [ 21.071314][ C0] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 21.071318][ C0] print_irq_inversion_bug.part.0.cold (kernel/locking/lockdep.c:4141) [ 21.071321][ C0] mark_lock_irq (kernel/locking/lockdep.c:4095 kernel/locking/lockdep.c:4174 kernel/locking/lockdep.c:4310) [ 21.071322][ C0] ? add_lock_to_list (./include/linux/find.h:391 kernel/locking/lockdep.c:1419 kernel/locking/lockdep.c:1450) [ 21.071326][ C0] mark_lock (kernel/locking/lockdep.c:4769) [ 21.071327][ C0] mark_usage (kernel/locking/lockdep.c:4658) [ 21.071329][ C0] __lock_acquire (kernel/locking/lockdep.c:5208) [ 21.071331][ C0] lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2)) [ 21.071333][ C0] ? console_lock_spinning_enable (kernel/printk/printk.c:1902 (discriminator 2)) [ 21.071335][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 21.071338][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 21.071340][ C0] console_lock_spinning_enable (kernel/printk/printk.c:1902 (discriminator 2)) [ 21.071342][ C0] ? console_lock_spinning_enable (kernel/printk/printk.c:1902 (discriminator 2)) [ 21.071344][ C0] console_emit_next_record (kernel/printk/printk.c:3177) [ 21.071346][ C0] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 21.071348][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 21.071350][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 21.071352][ C0] console_flush_one_record (kernel/printk/printk.c:3268) [ 21.071354][ C0] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 21.071356][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 21.071358][ C0] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 21.071360][ C0] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 21.071362][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 21.071364][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 18) ./include/trace/events/lock.h:23 (discriminator 18) kernel/locking/lockdep.c:5871 (discriminator 18)) [ 21.071366][ C0] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 21.071367][ C0] ? vprintk_emit (kernel/printk/printk.c:2478) [ 21.071369][ C0] vprintk_emit (kernel/printk/printk.c:2479) [ 21.071372][ C0] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 21.071374][ C0] ? clocksource_watchdog.part.0 (kernel/time/clocksource.c:434 kernel/time/clocksource.c:664) [ 21.071376][ C0] _printk (kernel/printk/printk.c:2504) [ 21.071378][ C0] ? snapshot_read.cold (user.c:?) [ 21.071380][ C0] ? clocksource_watchdog.part.0 (kernel/time/clocksource.c:434 kernel/time/clocksource.c:664) [ 21.071381][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 21.071384][ 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)) [ 21.071385][ C0] ? clocksource_watchdog.part.0 (./include/linux/find.h:67 (discriminator 4)) [ 21.071387][ C0] ? clocksource_watchdog.part.0 (./include/linux/find.h:67 (discriminator 4)) [ 21.071389][ C0] call_timer_fn (kernel/time/timer.c:1748) [ 21.071391][ C0] ? detach_if_pending (./include/linux/list.h:1159) [ 21.071392][ C0] ? debug_object_active_state (lib/debugobjects.c:1122) [ 21.071395][ C0] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 21.071397][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 21.071399][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 21.071401][ C0] __run_timers (kernel/time/timer.c:1799 kernel/time/timer.c:2374) [ 21.071403][ C0] ? clocksource_watchdog.part.0 (./include/linux/find.h:67 (discriminator 4)) [ 21.071405][ C0] ? __bpf_trace_itimer_expire (./include/trace/events/timer.h:407) [ 21.071407][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 21.071410][ C0] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 21.071413][ C0] run_timer_softirq (kernel/time/timer.c:2386 kernel/time/timer.c:2395 kernel/time/timer.c:2403) [ 21.071415][ C0] ? __run_timers (./include/trace/events/timer.h:138 (discriminator 19)) [ 21.071416][ C0] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 21.071419][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 21.071421][ C0] handle_softirqs (kernel/softirq.c:645) [ 21.071423][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 21.071425][ C0] ? _local_bh_enable (kernel/softirq.c:428 (discriminator 1)) [ 21.071427][ C0] __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) [ 21.071428][ C0] irq_exit_rcu (kernel/softirq.c:784) [ 21.071430][ C0] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1062 (discriminator 37) arch/x86/kernel/apic/apic.c:1062 (discriminator 37)) [ 21.071432][ C0] [ 21.071433][ C0] [ 21.071433][ C0] ? lockdep_hardirqs_on_prepare.part.0 (kernel/locking/lockdep.c:470 (discriminator 2) kernel/locking/lockdep.c:4427 (discriminator 2)) [ 21.071435][ C0] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:674) [ 21.071437][ C0] RIP: 0010:pv_native_safe_halt (./arch/x86/include/asm/irqflags.h:48 arch/x86/kernel/paravirt.c:63) [ 21.071439][ C0] Code: 48 8b 3d 94 52 73 02 e8 1f 00 00 00 48 2b 05 58 e3 ae 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 76 1e 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 52 73 02 mov 0x2735294(%rip),%rdi # 0x273529b 7: e8 1f 00 00 00 call 0x2b c: 48 2b 05 58 e3 ae 00 sub 0xaee358(%rip),%rax # 0xaee36b 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 76 1e 00 verw 0x1e7613(%rip) # 0x1e763b 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 [ 21.071441][ C0] RSP: 0018:ffffffffa3c07cf8 EFLAGS: 00000296 [ 21.071444][ C0] RAX: 0000000000082daf RBX: ffffffffa3c1c600 RCX: ffffffffa03103a7 [ 21.071445][ C0] RDX: ffffffffa3c1c600 RSI: ffffffffa34f7c2a RDI: ffffffffa2e913e0 [ 21.071446][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 21.071447][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff4780fa2 [ 21.071448][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 21.071450][ C0] ? cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 21.071452][ C0] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488) [ 21.071454][ C0] default_idle (./arch/x86/include/asm/paravirt.h:62 arch/x86/kernel/process.c:768) [ 21.071456][ C0] default_idle_call (kernel/sched/idle.c:122) [ 21.071457][ C0] cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 21.071459][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 21.071461][ C0] ? mark_tsc_async_resets (arch/x86/kernel/tsc_sync.c:49) [ 21.071463][ C0] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 21.071465][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 21.071467][ C0] do_idle (kernel/sched/idle.c:355) [ 21.071468][ C0] cpu_startup_entry (kernel/sched/idle.c:454) [ 21.071470][ C0] rest_init (init/main.c:727) [ 21.071471][ C0] ? __cpuidle_text_end (??:?) [ 21.071474][ C0] ? rest_init (init/main.c:727) [ 21.071475][ C0] ? acpi_hw_write_port (drivers/acpi/acpica/hwvalid.c:264) [ 21.071479][ C0] ? acpi_enable (drivers/acpi/acpica/evxfevnt.c:74) [ 21.071481][ C0] start_kernel (init/main.c:1185) [ 21.071483][ C0] x86_64_start_reservations (arch/x86/kernel/head64.c:310) [ 21.071485][ C0] x86_64_start_kernel (arch/x86/kernel/head64.c:291) [ 21.071488][ C0] common_startup_64 (arch/x86/kernel/head_64.S:418) | [ 21.071507][ C0] softirqs last disabled at (535985): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 21.071508][ C0] Preemption disabled at: | [ 21.071509][ C0] schedule_preempt_disabled (kernel/sched/core.c:7420) | [ 21.071514][ C0] Tainted: [W]=WARN [ 21.071514][ C0] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 21.071515][ C0] Call Trace: [ 21.071516][ C0] [ 21.071517][ C0] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 21.071519][ C0] ? schedule_preempt_disabled (kernel/sched/core.c:7420) [ 21.071520][ C0] __might_resched.cold (kernel/sched/core.c:9234) [ 21.071523][ C0] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 21.071526][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 21.071528][ C0] __kmalloc_noprof (./include/linux/sched/mm.h:322 (discriminator 2) mm/slub.c:4636 (discriminator 2) mm/slub.c:4974 (discriminator 2) mm/slub.c:5413 (discriminator 2) mm/slub.c:5439 (discriminator 2)) [ 21.071530][ C0] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 21.071532][ C0] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 21.071534][ C0] ? do_raw_spin_unlock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:32 ./include/asm-generic/qspinlock.h:58 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 21.071536][ C0] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 21.071539][ C0] put_chars (drivers/char/virtio_console.c:1176) [ 21.071541][ C0] ? __send_to_port (drivers/char/virtio_console.c:654) [ 21.071544][ C0] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 21.071546][ C0] ? mark_usage (kernel/locking/lockdep.c:4658) [ 21.071548][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5208) [ 21.071550][ C0] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 21.071552][ C0] ? lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2)) [ 21.071554][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 21.071556][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 21.071558][ C0] console_emit_next_record (kernel/printk/printk.c:3183) [ 21.071560][ C0] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 21.071562][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 21.071564][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 21.071566][ C0] console_flush_one_record (kernel/printk/printk.c:3268) [ 21.071568][ C0] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 21.071570][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 21.071572][ C0] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 21.071574][ C0] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 21.071576][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 21.071578][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 18) ./include/trace/events/lock.h:23 (discriminator 18) kernel/locking/lockdep.c:5871 (discriminator 18)) [ 21.071580][ C0] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 21.071581][ C0] ? vprintk_emit (kernel/printk/printk.c:2478) [ 21.071583][ C0] vprintk_emit (kernel/printk/printk.c:2479) [ 21.071585][ C0] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 21.071588][ C0] ? clocksource_watchdog.part.0 (kernel/time/clocksource.c:434 kernel/time/clocksource.c:664) [ 21.071590][ C0] _printk (kernel/printk/printk.c:2504) [ 21.071591][ C0] ? snapshot_read.cold (user.c:?) [ 21.071593][ C0] ? clocksource_watchdog.part.0 (kernel/time/clocksource.c:434 kernel/time/clocksource.c:664) [ 21.071595][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 21.071597][ 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)) [ 21.071599][ C0] ? clocksource_watchdog.part.0 (./include/linux/find.h:67 (discriminator 4)) [ 21.071601][ C0] ? clocksource_watchdog.part.0 (./include/linux/find.h:67 (discriminator 4)) [ 21.071602][ C0] call_timer_fn (kernel/time/timer.c:1748) [ 21.071604][ C0] ? detach_if_pending (./include/linux/list.h:1159) [ 21.071606][ C0] ? debug_object_active_state (lib/debugobjects.c:1122) [ 21.071607][ C0] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 21.071609][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 21.071611][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 21.071613][ C0] __run_timers (kernel/time/timer.c:1799 kernel/time/timer.c:2374) [ 21.071615][ C0] ? clocksource_watchdog.part.0 (./include/linux/find.h:67 (discriminator 4)) [ 21.071617][ C0] ? __bpf_trace_itimer_expire (./include/trace/events/timer.h:407) [ 21.071619][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 21.071621][ C0] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 21.071624][ C0] run_timer_softirq (kernel/time/timer.c:2386 kernel/time/timer.c:2395 kernel/time/timer.c:2403) [ 21.071626][ C0] ? __run_timers (./include/trace/events/timer.h:138 (discriminator 19)) [ 21.071628][ C0] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 21.071629][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 21.071631][ C0] handle_softirqs (kernel/softirq.c:645) [ 21.071633][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 21.071634][ C0] ? _local_bh_enable (kernel/softirq.c:428 (discriminator 1)) [ 21.071636][ C0] __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) [ 21.071638][ C0] irq_exit_rcu (kernel/softirq.c:784) [ 21.071639][ C0] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1062 (discriminator 37) arch/x86/kernel/apic/apic.c:1062 (discriminator 37)) [ 21.071641][ C0] [ 21.071642][ C0] [ 21.071642][ C0] ? lockdep_hardirqs_on_prepare.part.0 (kernel/locking/lockdep.c:470 (discriminator 2) kernel/locking/lockdep.c:4427 (discriminator 2)) [ 21.071644][ C0] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:674) [ 21.071645][ C0] RIP: 0010:pv_native_safe_halt (./arch/x86/include/asm/irqflags.h:48 arch/x86/kernel/paravirt.c:63) [ 21.071648][ C0] Code: 48 8b 3d 94 52 73 02 e8 1f 00 00 00 48 2b 05 58 e3 ae 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 76 1e 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 52 73 02 mov 0x2735294(%rip),%rdi # 0x273529b 7: e8 1f 00 00 00 call 0x2b c: 48 2b 05 58 e3 ae 00 sub 0xaee358(%rip),%rax # 0xaee36b 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 76 1e 00 verw 0x1e7613(%rip) # 0x1e763b 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 [ 21.071649][ C0] RSP: 0018:ffffffffa3c07cf8 EFLAGS: 00000296 [ 21.071650][ C0] RAX: 0000000000082daf RBX: ffffffffa3c1c600 RCX: ffffffffa03103a7 [ 21.071651][ C0] RDX: ffffffffa3c1c600 RSI: ffffffffa34f7c2a RDI: ffffffffa2e913e0 [ 21.071652][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 21.071652][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff4780fa2 [ 21.071653][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 21.071654][ C0] ? cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 21.071657][ C0] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488) [ 21.071659][ C0] default_idle (./arch/x86/include/asm/paravirt.h:62 arch/x86/kernel/process.c:768) [ 21.071661][ C0] default_idle_call (kernel/sched/idle.c:122) [ 21.071662][ C0] cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 21.071663][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 21.071665][ C0] ? mark_tsc_async_resets (arch/x86/kernel/tsc_sync.c:49) [ 21.071666][ C0] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 21.071668][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 21.071670][ C0] do_idle (kernel/sched/idle.c:355) [ 21.071671][ C0] cpu_startup_entry (kernel/sched/idle.c:454) [ 21.071673][ C0] rest_init (init/main.c:727) [ 21.071674][ C0] ? __cpuidle_text_end (??:?) [ 21.071677][ C0] ? rest_init (init/main.c:727) [ 21.071678][ C0] ? acpi_hw_write_port (drivers/acpi/acpica/hwvalid.c:264) [ 21.071683][ C0] ? acpi_enable (drivers/acpi/acpica/evxfevnt.c:74) [ 21.071685][ C0] start_kernel (init/main.c:1185) [ 21.071688][ C0] x86_64_start_reservations (arch/x86/kernel/head64.c:310) [ 21.071690][ C0] x86_64_start_kernel (arch/x86/kernel/head64.c:291) [ 21.071693][ C0] common_startup_64 (arch/x86/kernel/head_64.S:418) | [ 49.190028][ T39] softirqs last disabled at (0): 0x0 | [ 49.190031][ T39] Preemption disabled at: | [ 49.190031][ T39] vprintk_emit (kernel/printk/printk.c:2471) | [ 49.190043][ T39] Tainted: [W]=WARN [ 49.190044][ T39] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 49.190046][ T39] Workqueue: events_power_efficient phylink_resolve [ 49.190052][ T39] Call Trace: [ 49.190054][ T39] [ 49.190056][ T39] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 49.190061][ T39] ? vprintk_emit (kernel/printk/printk.c:2471) [ 49.190063][ T39] __might_resched.cold (kernel/sched/core.c:9234) [ 49.190067][ T39] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 49.190070][ T39] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 49.190074][ T39] __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)) [ 49.190078][ T39] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 49.190080][ T39] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 49.190085][ T39] ? 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) [ 49.190087][ T39] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 49.190089][ T39] put_chars (drivers/char/virtio_console.c:1176) [ 49.190092][ T39] ? __send_to_port (drivers/char/virtio_console.c:654) [ 49.190094][ T39] ? printk_get_next_message (kernel/printk/printk.c:3072) [ 49.190096][ T39] ? console_prepend_replay (kernel/printk/printk.c:3005) [ 49.190098][ T39] ? desc_read (./include/linux/instrumented.h:97 ./include/linux/atomic/atomic-instrumented.h:3223 kernel/printk/printk_ringbuffer.c:552) [ 49.190101][ T39] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 49.190105][ T39] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 49.190107][ T39] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 49.190109][ T39] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 49.190110][ T39] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 49.190112][ T39] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 49.190114][ T39] console_emit_next_record (kernel/printk/printk.c:3183) [ 49.190117][ T39] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 49.190120][ T39] ? _prb_read_valid (kernel/printk/printk_ringbuffer.c:1996) [ 49.190122][ T39] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 49.190125][ T39] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 49.190127][ T39] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 49.190129][ T39] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 49.190132][ T39] ? console_flush_one_record (kernel/printk/printk.c:3247) [ 49.190135][ T39] console_flush_one_record (kernel/printk/printk.c:3268) [ 49.190138][ T39] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 49.190142][ T39] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 49.190144][ T39] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 49.190147][ T39] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 49.190149][ T39] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 49.190151][ T39] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 49.190153][ T39] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 18) ./include/trace/events/lock.h:23 (discriminator 18) kernel/locking/lockdep.c:5871 (discriminator 18)) [ 49.190155][ T39] ? sync_exp_reset_tree_hotplug (kernel/rcu/tree_exp.h:96) [ 49.190158][ T39] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 49.190161][ T39] ? vprintk_emit (kernel/printk/printk.c:2478) [ 49.190163][ T39] vprintk_emit (kernel/printk/printk.c:2479) [ 49.190165][ T39] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 49.190167][ T39] ? wakeup_preempt_fair (kernel/sched/fair.c:1142 kernel/sched/fair.c:10033) [ 49.190170][ T39] dev_vprintk_emit (drivers/base/core.c:5000) [ 49.190175][ T39] ? device_rename.cold (drivers/base/core.c:4612 (discriminator 13)) [ 49.190177][ T39] ? trace_sched_wakeup (./include/trace/events/sched.h:178 (discriminator 22)) [ 49.190179][ T39] ? _raw_spin_unlock_irq_enable (./include/linux/spinlock_api_smp.h:229 (discriminator 1) kernel/locking/spinlock.c:237 (discriminator 1)) [ 49.190181][ T39] ? try_to_wake_up (./include/linux/preempt.h:500 (discriminator 1) kernel/sched/core.c:4263 (discriminator 1)) [ 49.190183][ T39] dev_printk_emit (drivers/base/core.c:5011) [ 49.190185][ T39] ? dev_vprintk_emit (drivers/base/core.c:5001) [ 49.190187][ T39] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 49.190189][ T39] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 49.190191][ T39] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 49.190194][ T39] ? rcu_irq_exit_check_preempt (kernel/rcu/tree.c:631) [ 49.190196][ T39] ? trace_hardirqs_on (kernel/trace/trace_preemptirq.c:78) [ 49.190197][ T39] ? irqentry_exit (./include/linux/irq-entry-common.h:507 ./include/linux/irq-entry-common.h:542 kernel/entry/common.c:167) [ 49.190201][ T39] __netdev_printk (net/core/dev.c:13140 (discriminator 4)) [ 49.190205][ T39] netdev_printk (net/core/dev.c:13166) [ 49.190207][ T39] ? __netdev_printk (net/core/dev.c:13151 (discriminator 1)) [ 49.190208][ T39] ? fbnic_rd32 (./arch/x86/include/asm/io.h:59 (discriminator 1) drivers/net/ethernet/meta/fbnic/fbnic_pci.c:45 (discriminator 1)) [ 49.190211][ T39] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 49.190212][ T39] ? fbnic_mac_link_down_asic (drivers/net/ethernet/meta/fbnic/fbnic_mac.c:708) [ 49.190215][ T39] ? trace_hardirqs_on (kernel/trace/trace_preemptirq.c:78) [ 49.190217][ T39] ? fbnic_phylink_mac_link_down (drivers/net/ethernet/meta/fbnic/fbnic_phylink.c:156) [ 49.190219][ T39] phylink_resolve (drivers/net/phy/phylink.c:1720) [ 49.190220][ T39] ? _raw_spin_unlock_irqrestore (./include/linux/spinlock_api_smp.h:211 (discriminator 1) kernel/locking/spinlock.c:221 (discriminator 1)) [ 49.190222][ T39] ? debug_object_deactivate (lib/debugobjects.c:946) [ 49.190226][ T39] ? phylink_ethtool_ksettings_set (drivers/net/phy/phylink.c:189 (discriminator 1)) [ 49.190228][ T39] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 49.190229][ T39] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 49.190231][ T39] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 49.190232][ T39] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 49.190234][ T39] process_one_work (kernel/workqueue.c:3387) [ 49.190238][ T39] ? __queue_delayed_work (kernel/workqueue.c:2622) [ 49.190240][ T39] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 49.190242][ T39] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 49.190243][ T39] ? 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) [ 49.190245][ T39] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 49.190247][ T39] worker_thread (kernel/workqueue.c:3470 kernel/workqueue.c:3551) [ 49.190250][ T39] ? rescuer_thread (./include/linux/list.h:419 (discriminator 3)) [ 49.190252][ T39] kthread (kernel/kthread.c:436) [ 49.190255][ T39] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 49.190256][ T39] ? kthread_affine_preferred (kernel/kthread.c:857) [ 49.190258][ T39] ret_from_fork (arch/x86/kernel/process.c:158) [ 49.190261][ T39] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/vdso/vma.c:80 (discriminator 1)) [ 49.190263][ T39] ? __switch_to (arch/x86/kernel/process_64.c:403 arch/x86/kernel/process_64.c:663) [ 49.190266][ T39] ? kthread_affine_preferred (kernel/kthread.c:857) Finger prints: mark_lock_irq:mark_lock:mark_usage:__lock_acquire:console_lock_spinning_enable vprintk_emit:dump_stack_lvl:__kmalloc_noprof:put_chars:hvc_console_print __irq_exit_rcu:schedule_preempt_disabled:dump_stack_lvl:__kmalloc_noprof:put_chars