early console in setup code
early console in extract_kernel
input_data: 0x000000000262a255
input_len: 0x0000000000425310
output: 0x0000000001000000
output_len: 0x000000000126e4f0
kernel_total_size: 0x0000000001a6f000

Decompressing Linux... Parsing ELF... done.
Booting the kernel.
[    0.000000] Linux version 4.15.0-rc2-00005-g3e6e512 (kbuild@ivb42) (gcc version 7.2.1 20171025 (Debian 7.2.0-12)) #1 PREEMPT Tue Dec 5 17:01:34 CST 2017
[    0.000000] Command line: ip=::::vm-lkp-nex04-yocto-x86_64-32::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-nex04-yocto-x86_64-32/trinity-300s-yocto-minimal-x86_64-2016-04-22.cgz-3e6e51217dd14dcda10d4bc9a38b1440e2d42c14-20171205-41529-1h3sayh-0.yaml ARCH=x86_64 kconfig=x86_64-randconfig-b0-12042212 branch=linux-devel/devel-spot-201712041942 commit=3e6e51217dd14dcda10d4bc9a38b1440e2d42c14 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-b0-12042212/gcc-7/3e6e51217dd14dcda10d4bc9a38b1440e2d42c14/vmlinuz-4.15.0-rc2-00005-g3e6e512 max_uptime=1500 RESULT_ROOT=/result/trinity/300s/vm-lkp-nex04-yocto-x86_64/yocto-minimal-x86_64-2016-04-22.cgz/x86_64-randconfig-b0-12042212/gcc-7/3e6e51217dd14dcda10d4bc9a38b1440e2d42c14/0 LKP_SERVER=inn debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 drbd.minor_count=8 systemd.log_level=err ignore_loglevel console=tt
[    0.000000] KERNEL supported cpus:
[    0.000000]   Intel GenuineIntel
[    0.000000]   Centaur CentaurHauls
[    0.000000] x86/fpu: x87 FPU will use FXSAVE
[    0.000000] e820: BIOS-provided physical RAM map:
[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
[    0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000001ffddfff] usable
[    0.000000] BIOS-e820: [mem 0x000000001ffde000-0x000000001fffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[    0.000000] debug: ignoring loglevel setting.
[    0.000000] bootconsole [earlyser0] enabled
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] random: fast init done
[    0.000000] SMBIOS 2.8 present.
[    0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[    0.000000] Hypervisor detected: KVM
[    0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.000000] e820: last_pfn = 0x1ffde max_arch_pfn = 0x400000000
[    0.000000] x86/PAT: Configuration [0-7]: WB  WT  UC- UC  WB  WT  UC- UC  
[    0.000000] Scan for SMP in [mem 0x00000000-0x000003ff]
[    0.000000] Scan for SMP in [mem 0x0009fc00-0x0009ffff]
[    0.000000] Scan for SMP in [mem 0x000f0000-0x000fffff]
[    0.000000] found SMP MP-table at [mem 0x000f6a90-0x000f6a9f] mapped at [        (ptrval)]
[    0.000000]   mpc: f6aa0-f6b78
[    0.000000] Base memory trampoline at [        (ptrval)] 99000 size 24576
[    0.000000] BRK [0x02a4a000, 0x02a4afff] PGTABLE
[    0.000000] BRK [0x02a4b000, 0x02a4bfff] PGTABLE
[    0.000000] BRK [0x02a4c000, 0x02a4cfff] PGTABLE
[    0.000000] BRK [0x02a4d000, 0x02a4dfff] PGTABLE
[    0.000000] RAMDISK: [mem 0x1f99d000-0x1ffcffff]
[    0.000000] ACPI: Early table checksum verification disabled
[    0.000000] ACPI: RSDP 0x00000000000F68C0 000014 (v00 BOCHS )
[    0.000000] ACPI: RSDT 0x000000001FFE15CE 000030 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACP 0x000000001FFE142A 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.000000] ACPI: DSDT 0x000000001FFE0040 0013EA (v01 BOCHS  BXPCDSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACS 0x000000001FFE0000 000040
[    0.000000] ACPI: APIC 0x000000001FFE151E 000078 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.000000] ACPI: HPET 0x000000001FFE1596 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] mapped APIC to ffffffffff5fd000 (        fee00000)
[    0.000000] kvm-clock: cpu 0, msr 0:1ffdc001, primary cpu clock
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000000] kvm-clock: using sched offset of 1312794178 cycles
[    0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.000000]   DMA32    [mem 0x0000000001000000-0x000000001ffddfff]
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000001000-0x000000000009efff]
[    0.000000]   node   0: [mem 0x0000000000100000-0x000000001ffddfff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000001ffddfff]
[    0.000000] On node 0 totalpages: 130940
[    0.000000]   DMA zone: 56 pages used for memmap
[    0.000000]   DMA zone: 21 pages reserved
[    0.000000]   DMA zone: 3998 pages, LIFO batch:0
[    0.000000]   DMA32 zone: 1736 pages used for memmap
[    0.000000]   DMA32 zone: 126942 pages, LIFO batch:31
[    0.000000] Reserved but unavailable: 98 pages
[    0.000000] ACPI: PM-Timer IO Port: 0x608
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[    0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 00, APIC ID 0, APIC INT 02
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[    0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 05, APIC ID 0, APIC INT 05
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[    0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 09, APIC ID 0, APIC INT 09
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[    0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0a, APIC ID 0, APIC INT 0a
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[    0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0b, APIC ID 0, APIC INT 0b
[    0.000000] ACPI: IRQ0 used by override.
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 01, APIC ID 0, APIC INT 01
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 03, APIC ID 0, APIC INT 03
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 04, APIC ID 0, APIC INT 04
[    0.000000] ACPI: IRQ5 used by override.
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 06, APIC ID 0, APIC INT 06
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 07, APIC ID 0, APIC INT 07
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 08, APIC ID 0, APIC INT 08
[    0.000000] ACPI: IRQ9 used by override.
[    0.000000] ACPI: IRQ10 used by override.
[    0.000000] ACPI: IRQ11 used by override.
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0c, APIC ID 0, APIC INT 0c
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0d, APIC ID 0, APIC INT 0d
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0e, APIC ID 0, APIC INT 0e
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 0, APIC INT 0f
[    0.000000] Using ACPI (MADT) for SMP configuration information
[    0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[    0.000000] mapped IOAPIC to ffffffffff5fc000 (fec00000)
[    0.000000] KVM setup async PF for cpu 0
[    0.000000] kvm-stealtime: cpu 0, msr 1e3abc0
[    0.000000] e820: [mem 0x20000000-0xfeffbfff] available for PCI devices
[    0.000000] Booting paravirtualized kernel on KVM
[    0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 6370452778343963 ns
[    0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[    0.000000] pcpu-alloc: [0] 0 
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 129127
[    0.000000] Kernel command line: ip=::::vm-lkp-nex04-yocto-x86_64-32::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-nex04-yocto-x86_64-32/trinity-300s-yocto-minimal-x86_64-2016-04-22.cgz-3e6e51217dd14dcda10d4bc9a38b1440e2d42c14-20171205-41529-1h3sayh-0.yaml ARCH=x86_64 kconfig=x86_64-randconfig-b0-12042212 branch=linux-devel/devel-spot-201712041942 commit=3e6e51217dd14dcda10d4bc9a38b1440e2d42c14 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-b0-12042212/gcc-7/3e6e51217dd14dcda10d4bc9a38b1440e2d42c14/vmlinuz-4.15.0-rc2-00005-g3e6e512 max_uptime=1500 RESULT_ROOT=/result/trinity/300s/vm-lkp-nex04-yocto-x86_64/yocto-minimal-x86_64-2016-04-22.cgz/x86_64-randconfig-b0-12042212/gcc-7/3e6e51217dd14dcda10d4bc9a38b1440e2d42c14/0 LKP_SERVER=inn debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 drbd.minor_count=8 systemd.log_level=err ignore_loglevel con
[    0.000000] sysrq: sysrq always enabled.
[    0.000000] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
[    0.000000] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
[    0.000000] Memory: 481232K/523760K available (8922K kernel code, 1343K rwdata, 3788K rodata, 1072K init, 10092K bss, 42528K reserved, 0K cma-reserved)
[    0.000000] 
[    0.000000] **********************************************************
[    0.000000] **   NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE   **
[    0.000000] **                                                      **
[    0.000000] ** trace_printk() being used. Allocating extra memory.  **
[    0.000000] **                                                      **
[    0.000000] ** This means that this is a DEBUG kernel and it is     **
[    0.000000] ** unsafe for production use.                           **
[    0.000000] **                                                      **
[    0.000000] ** If you see this message and you are not debugging    **
[    0.000000] ** the kernel, report this immediately to your vendor!  **
[    0.000000] **                                                      **
[    0.000000] **   NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE   **
[    0.000000] **********************************************************
[    0.003333] Preemptible hierarchical RCU implementation.
[    0.003333] 	RCU event tracing is enabled.
[    0.003333] 	RCU priority boosting: priority 1 delay 500 ms.
[    0.003333] 	RCU callback double-/use-after-free debug enabled.
[    0.003333] 	RCU debug extended QS entry/exit.
[    0.003333] 	RCU CPU stall warnings timeout set to 100 (rcu_cpu_stall_timeout).
[    0.003333] 	Tasks RCU enabled.
[    0.003333] NR_IRQS: 4352, nr_irqs: 48, preallocated irqs: 16
[    0.003333] 	Offload RCU callbacks from CPUs: .
[    0.003333] console [ttyS0] enabled
[    0.003333] console [ttyS0] enabled
[    0.003333] bootconsole [earlyser0] disabled
[    0.003333] bootconsole [earlyser0] disabled
[    0.003333] ------------------------
[    0.003333] | Locking API testsuite:
[    0.003333] ----------------------------------------------------------------------------
[    0.003333]                                  | spin |wlock |rlock |mutex | wsem | rsem |
[    0.003333]   --------------------------------------------------------------------------
[    0.003333]                      A-A deadlock:failed|failed|  ok  |failed|failed|failed|failed|
[    0.003333]                  A-B-B-A deadlock:failed|failed|  ok  |failed|failed|failed|failed|
[    0.003333]              A-B-B-C-C-A deadlock:failed|failed|  ok  |failed|failed|failed|failed|
[    0.003333]              A-B-C-A-B-C deadlock:failed|failed|  ok  |failed|failed|failed|failed|
[    0.003333]          A-B-B-C-C-D-D-A deadlock:failed|failed|  ok  |failed|failed|failed|failed|
[    0.003333]          A-B-C-D-B-D-D-A deadlock:failed|failed|  ok  |failed|failed|failed|failed|
[    0.003333]          A-B-C-D-B-C-D-A deadlock:failed|failed|  ok  |failed|failed|failed|failed|
[    0.003333]                     double unlock:  ok  |  ok  |failed|failed|failed|failed|  ok  |
[    0.003333]                   initialize held:failed|failed|failed|failed|failed|failed|failed|
[    0.003333]   --------------------------------------------------------------------------
[    0.003333]               recursive read-lock:             |  ok  |             |failed|
[    0.003333]            recursive read-lock #2:             |  ok  |             |failed|
[    0.003333]             mixed read-write-lock:             |failed|             |failed|
[    0.003333]             mixed write-read-lock:             |failed|             |failed|
[    0.003333]   mixed read-lock/lock-write ABBA:             |failed|             |failed|
[    0.003333]    mixed read-lock/lock-read ABBA:             |  ok  |             |failed|
[    0.003333]  mixed write-lock/lock-write ABBA:             |failed|             |failed|
[    0.003333]   --------------------------------------------------------------------------
[    0.003333]      hard-irqs-on + irq-safe-A/12:failed|failed|  ok  |
[    0.003333]      soft-irqs-on + irq-safe-A/12:failed|failed|  ok  |
[    0.003333]      hard-irqs-on + irq-safe-A/21:failed|failed|  ok  |
[    0.003333]      soft-irqs-on + irq-safe-A/21:failed|failed|  ok  |
[    0.003333]        sirq-safe-A => hirqs-on/12:failed|failed|  ok  |
[    0.003333]        sirq-safe-A => hirqs-on/21:failed|failed|  ok  |
[    0.003333]          hard-safe-A + irqs-on/12:failed|failed|  ok  |
[    0.003333]          soft-safe-A + irqs-on/12:failed|failed|  ok  |
[    0.003333]          hard-safe-A + irqs-on/21:failed|failed|  ok  |
[    0.003333]          soft-safe-A + irqs-on/21:failed|failed|  ok  |
[    0.003333]     hard-safe-A + unsafe-B #1/123:failed|failed|  ok  |
[    0.003333]     soft-safe-A + unsafe-B #1/123:failed|failed|  ok  |
[    0.003333]     hard-safe-A + unsafe-B #1/132:failed|failed|  ok  |
[    0.003333]     soft-safe-A + unsafe-B #1/132:failed|failed|  ok  |
[    0.003333]     hard-safe-A + unsafe-B #1/213:failed|failed|  ok  |
[    0.003333]     soft-safe-A + unsafe-B #1/213:failed|failed|  ok  |
[    0.003333]     hard-safe-A + unsafe-B #1/231:failed|failed|  ok  |
[    0.003333]     soft-safe-A + unsafe-B #1/231:failed|failed|  ok  |
[    0.003333]     hard-safe-A + unsafe-B #1/312:failed|failed|  ok  |
[    0.003333]     soft-safe-A + unsafe-B #1/312:failed|failed|  ok  |
[    0.003333]     hard-safe-A + unsafe-B #1/321:failed|failed|  ok  |
[    0.003333]     soft-safe-A + unsafe-B #1/321:failed|failed|  ok  |
[    0.003333]     hard-safe-A + unsafe-B #2/123:failed|failed|  ok  |
[    0.003333]     soft-safe-A + unsafe-B #2/123:failed|failed|  ok  |
[    0.003333]     hard-safe-A + unsafe-B #2/132:failed|failed|  ok  |
[    0.003333]     soft-safe-A + unsafe-B #2/132:failed|failed|  ok  |
[    0.003333]     hard-safe-A + unsafe-B #2/213:failed|failed|  ok  |
[    0.003333]     soft-safe-A + unsafe-B #2/213:failed|failed|  ok  |
[    0.003333]     hard-safe-A + unsafe-B #2/231:failed|failed|  ok  |
[    0.003333]     soft-safe-A + unsafe-B #2/231:failed|failed|  ok  |
[    0.003333]     hard-safe-A + unsafe-B #2/312:failed|failed|  ok  |
[    0.003333]     soft-safe-A + unsafe-B #2/312:failed|failed|  ok  |
[    0.003333]     hard-safe-A + unsafe-B #2/321:failed|failed|  ok  |
[    0.003333]     soft-safe-A + unsafe-B #2/321:failed|failed|  ok  |
[    0.003333]       hard-irq lock-inversion/123:failed|failed|  ok  |
[    0.003333]       soft-irq lock-inversion/123:failed|failed|  ok  |
[    0.003333]       hard-irq lock-inversion/132:failed|failed|  ok  |
[    0.003333]       soft-irq lock-inversion/132:failed|failed|  ok  |
[    0.003333]       hard-irq lock-inversion/213:failed|failed|  ok  |
[    0.003333]       soft-irq lock-inversion/213:failed|failed|  ok  |
[    0.003333]       hard-irq lock-inversion/231:failed|failed|  ok  |
[    0.003333]       soft-irq lock-inversion/231:failed|failed|  ok  |
[    0.003333]       hard-irq lock-inversion/312:failed|failed|  ok  |
[    0.003333]       soft-irq lock-inversion/312:failed|failed|  ok  |
[    0.003333]       hard-irq lock-inversion/321:failed|failed|  ok  |
[    0.003333]       soft-irq lock-inversion/321:failed|failed|  ok  |
[    0.003333]       hard-irq read-recursion/123:  ok  |
[    0.003333]       soft-irq read-recursion/123:  ok  |
[    0.003333]       hard-irq read-recursion/132:  ok  |
[    0.003333]       soft-irq read-recursion/132:  ok  |
[    0.003333]       hard-irq read-recursion/213:  ok  |
[    0.003333]       soft-irq read-recursion/213:  ok  |
[    0.003333]       hard-irq read-recursion/231:  ok  |
[    0.003333]       soft-irq read-recursion/231:  ok  |
[    0.003333]       hard-irq read-recursion/312:  ok  |
[    0.003333]       soft-irq read-recursion/312:  ok  |
[    0.003333]       hard-irq read-recursion/321:  ok  |
[    0.003333]       soft-irq read-recursion/321:  ok  |
[    0.003333]   --------------------------------------------------------------------------
[    0.003333]   | Wound/wait tests |
[    0.003333]   ---------------------
[    0.003333]                   ww api failures:  ok  |  ok  |failed|
[    0.003333]                ww contexts mixing:failed|failed|
[    0.003333]              finishing ww context:failed|failed|failed|failed|
[    0.003333]                locking mismatches:failed|failed|failed|
[    0.003333]                  EDEADLK handling:  ok  |  ok  |failed|failed|failed|failed|failed|failed|failed|failed|
[    0.003333]            spinlock nest unlocked:failed|
[    0.003333]   -----------------------------------------------------
[    0.003333]                                  |block | try  |context|
[    0.003333]   -----------------------------------------------------
[    0.003333]                           context:failed|  ok  |  ok  |
[    0.003333]                               try:failed|  ok  |failed|
[    0.003333]                             block:failed|  ok  |failed|
[    0.003333]                          spinlock:failed|  ok  |failed|
[    0.003333] --------------------------------------------------------
[    0.003333] 182 out of 262 testcases failed, as expected. |
[    0.003333] ----------------------------------------------------
[    0.003333] ODEBUG: selftest passed
[    0.003333] ACPI: Core revision 20170831
[    0.003333] ACPI: 1 ACPI AML tables successfully acquired and loaded
[    0.003333] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
[    0.003333] hpet clockevent registered
[    0.003351] APIC: Switch to symmetric I/O mode setup
[    0.004444] enabled ExtINT on CPU#0
[    0.007444] ENABLING IO-APIC IRQs
[    0.008143] init IO_APIC IRQs
[    0.008767]  apic 0 pin 0 not connected
[    0.009563] IOAPIC[0]: Set routing entry (0-1 -> 0xef -> IRQ 1 Mode:0 Active:0 Dest:1)
[    0.010031] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1)
[    0.011624] IOAPIC[0]: Set routing entry (0-3 -> 0xef -> IRQ 3 Mode:0 Active:0 Dest:1)
[    0.013259] IOAPIC[0]: Set routing entry (0-4 -> 0xef -> IRQ 4 Mode:0 Active:0 Dest:1)
[    0.013333] IOAPIC[0]: Set routing entry (0-5 -> 0xef -> IRQ 5 Mode:1 Active:0 Dest:1)
[    0.013333] IOAPIC[0]: Set routing entry (0-6 -> 0xef -> IRQ 6 Mode:0 Active:0 Dest:1)
[    0.013333] IOAPIC[0]: Set routing entry (0-7 -> 0xef -> IRQ 7 Mode:0 Active:0 Dest:1)
[    0.013333] IOAPIC[0]: Set routing entry (0-8 -> 0xef -> IRQ 8 Mode:0 Active:0 Dest:1)
[    0.013333] IOAPIC[0]: Set routing entry (0-9 -> 0xef -> IRQ 9 Mode:1 Active:0 Dest:1)
[    0.013333] IOAPIC[0]: Set routing entry (0-10 -> 0xef -> IRQ 10 Mode:1 Active:0 Dest:1)
[    0.013333] IOAPIC[0]: Set routing entry (0-11 -> 0xef -> IRQ 11 Mode:1 Active:0 Dest:1)
[    0.013333] IOAPIC[0]: Set routing entry (0-12 -> 0xef -> IRQ 12 Mode:0 Active:0 Dest:1)
[    0.013333] IOAPIC[0]: Set routing entry (0-13 -> 0xef -> IRQ 13 Mode:0 Active:0 Dest:1)
[    0.013333] IOAPIC[0]: Set routing entry (0-14 -> 0xef -> IRQ 14 Mode:0 Active:0 Dest:1)
[    0.013333] IOAPIC[0]: Set routing entry (0-15 -> 0xef -> IRQ 15 Mode:0 Active:0 Dest:1)
[    0.013333]  apic 0 pin 16 not connected
[    0.013333]  apic 0 pin 17 not connected
[    0.013333]  apic 0 pin 18 not connected
[    0.013333]  apic 0 pin 19 not connected
[    0.013333]  apic 0 pin 20 not connected
[    0.013333]  apic 0 pin 21 not connected
[    0.013333]  apic 0 pin 22 not connected
[    0.013333]  apic 0 pin 23 not connected
[    0.013333] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.013333] tsc: Detected 2260.998 MHz processor
[    0.013343] Calibrating delay loop (skipped) preset value.. 4523.41 BogoMIPS (lpj=7536660)
[    0.014940] pid_max: default: 4096 minimum: 301
[    0.015916] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
[    0.016682] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
[    0.018554] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    0.020010] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[    0.021143] CPU: Intel QEMU Virtual CPU version 2.5+ (family: 0x6, model: 0x6, stepping: 0x3)
[    0.024142] Performance Events: PMU not available due to virtualization, using software events only.
[    0.030166] Hierarchical SRCU implementation.
[    0.031090] NMI watchdog: Perf event create on CPU 0 failed with -2
[    0.031954] NMI watchdog: Perf NMI watchdog permanently disabled
[    0.033408] Using local APIC timer interrupts.
[    0.033408] calibrating APIC timer ...
[    0.036666] ... lapic delta = 6253383
[    0.036666] ... PM-Timer delta = 358166
[    0.036666] ... PM-Timer result ok
[    0.036666] ..... delta 6253383
[    0.036666] ..... mult: 268580781
[    0.036666] ..... calibration result: 3335137
[    0.036666] ..... CPU clock speed is 2262.2188 MHz.
[    0.036666] ..... host bus clock speed is 1000.2137 MHz.
[    0.037017] pgdatinit0 (14) used greatest stack depth: 15480 bytes left
[    0.038237] devtmpfs: initialized
[    0.038911] x86/mm: Memory block size: 128MB
[    0.043728] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 6370867519511994 ns
[    0.045753] futex hash table entries: 16 (order: -3, 768 bytes)
[    0.047192] NET: Registered protocol family 16
[    0.050759] cpuidle: using governor menu
[    0.052958] ACPI: bus type PCI registered
[    0.053528] PCI: Using configuration type 1 for base access
[    0.077300] gpio-f7188x: Not a Fintek device at 0x0000002e
[    0.078060] gpio-f7188x: Not a Fintek device at 0x0000004e
[    0.079081] ACPI: Added _OSI(Module Device)
[    0.079667] ACPI: Added _OSI(Processor Device)
[    0.080214] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.081091] ACPI: Added _OSI(Processor Aggregator Device)
[    0.090683] ACPI: Interpreter enabled
[    0.091227] ACPI: (supports S0 S5)
[    0.091691] ACPI: Using IOAPIC for interrupt routing
[    0.092468] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.094239] ACPI: Enabled 2 GPEs in block 00 to 0F
[    0.113690] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.115104] acpi PNP0A03:00: _OSC: OS supports [Segments]
[    0.115950] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[    0.116845] PCI host bridge to bus 0000:00
[    0.117417] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
[    0.118310] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
[    0.119306] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[    0.120015] pci_bus 0000:00: root bus resource [mem 0x20000000-0xfebfffff window]
[    0.121003] pci_bus 0000:00: root bus resource [bus 00-ff]
[    0.121800] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[    0.124308] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[    0.126738] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[    0.135011] pci 0000:00:01.1: reg 0x20: [io  0xc080-0xc08f]
[    0.139400] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
[    0.140012] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
[    0.140880] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
[    0.141849] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
[    0.144027] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[    0.145345] pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI
[    0.146320] pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB
[    0.147309] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
[    0.151500] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
[    0.160028] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff]
[    0.176695] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[    0.179135] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[    0.183351] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff]
[    0.188196] pci 0000:00:03.0: reg 0x14: [io  0xc000-0xc03f]
[    0.201926] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
[    0.204109] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000
[    0.208727] pci 0000:00:04.0: reg 0x10: [io  0xc040-0xc07f]
[    0.211315] pci 0000:00:04.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff]
[    0.221302] pci 0000:00:04.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref]
[    0.227335] pci 0000:00:05.0: [8086:25ab] type 00 class 0x088000
[    0.229042] pci 0000:00:05.0: reg 0x10: [mem 0xfebf2000-0xfebf200f]
[    0.236397] pci_bus 0000:00: on NUMA node 0
[    0.238321] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[    0.240009] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[    0.241595] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[    0.242745] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[    0.243520] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
[    0.245653] pci 0000:00:02.0: vgaarb: setting as boot VGA device
[    0.246666] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[    0.246683] pci 0000:00:02.0: vgaarb: bridge control possible
[    0.247801] vgaarb: loaded
[    0.250774] Linux video capture interface: v2.00
[    0.251846] EDAC MC: Ver: 3.0.0
[    0.253983] PCI: Using ACPI for IRQ routing
[    0.254900] PCI: pci_cache_line_size set to 64 bytes
[    0.256219] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[    0.256682] e820: reserve RAM buffer [mem 0x1ffde000-0x1fffffff]
[    0.260235] clocksource: Switched to clocksource kvm-clock
[    0.305380] VFS: Disk quotas dquot_6.6.0
[    0.306283] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.307975] pnp: PnP ACPI init
[    0.308853] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
[    0.309971] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
[    0.311173] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
[    0.312265] pnp 00:03: [dma 2]
[    0.313158] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
[    0.315100] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active)
[    0.316986] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
[    0.318866] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active)
[    0.321934] pnp: PnP ACPI: found 7 devices
[    0.329333] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[    0.330962] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
[    0.331786] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
[    0.332615] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
[    0.333539] pci_bus 0000:00: resource 7 [mem 0x20000000-0xfebfffff window]
[    0.334636] NET: Registered protocol family 1
[    0.335254] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[    0.336067] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[    0.336869] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[    0.337762] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[    0.338933] PCI: CLS 0 bytes, default 64
[    0.339601] Unpacking initramfs...
[    1.381168] Freeing initrd memory: 6348K
[    1.384643] cryptomgr_test (26) used greatest stack depth: 15392 bytes left
[    1.386807] AVX or AES-NI instructions are not detected.
[    1.387539] CPU feature 'AVX registers' is not supported.
[    1.388263] CPU feature 'AVX registers' is not supported.
[    1.388995] AVX2 or AES-NI instructions are not detected.
[    1.389715] AVX2 instructions are not detected.
[    1.390380] cryptomgr_test (38) used greatest stack depth: 15136 bytes left
[    1.391342] spin_lock-torture:--- Start of test [debug]: nwriters_stress=2 nreaders_stress=0 stat_interval=60 verbose=1 shuffle_interval=3 stutter=5 shutdown_secs=0 onoff_interval=0 onoff_holdoff=0
[    1.393692] spin_lock-torture: Creating torture_shuffle task
[    1.394476] spin_lock-torture: Creating torture_stutter task
[    1.395254] spin_lock-torture: torture_shuffle task started
[    1.396000] spin_lock-torture: Creating lock_torture_writer task
[    1.396839] spin_lock-torture: torture_stutter task started
[    1.397601] spin_lock-torture: Creating lock_torture_writer task
[    1.398428] spin_lock-torture: lock_torture_writer task started
[    1.399237] spin_lock-torture: Creating lock_torture_stats task
[    1.400098] spin_lock-torture: lock_torture_writer task started
[    1.400927] torture_init_begin: Refusing rcu init: spin_lock running.
[    1.401778] torture_init_begin: One torture test at a time!
[    1.403610] spin_lock-torture: lock_torture_stats task started
[    1.404810] Initialise system trusted keyrings
[    1.406856] workingset: timestamp_bits=62 max_order=17 bucket_order=0
[    1.407740] zbud: loaded
[    1.409441] romfs: ROMFS MTD (C) 2007 Red Hat, Inc.
[    1.410381] orangefs_debugfs_init: called with debug mask: :none: :0:
[    1.411594] orangefs_init: module version upstream loaded
[    1.427715] Key type asymmetric registered
[    1.428439] Asymmetric key parser 'x509' registered
[    2.403342] tsc: Refined TSC clocksource calibration: 2260.995 MHz
[    2.410904] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x209746ac25a, max_idle_ns: 440795298337 ns
[    4.405755] String selftests succeeded
[    4.415206] test_hexdump: all 1184 tests passed
[    4.416179] 
[    4.416179] Start testing find_bit() with random-filled bitmap
[    4.427959] find_next_bit:		22014197 cycles,	163250 iterations
[    4.441870] find_next_zero_bit:	22633481 cycles,	164431 iterations
[    4.450536] find_last_bit:		16666720 cycles,	163250 iterations
[   13.295632] find_first_bit:		19995954246 cycles,	163251 iterations
[   13.297523] 
[   13.297523] Start testing find_bit() with sparse bitmap
[   13.299342] find_next_bit:		389071 cycles,	655 iterations
[   13.323016] find_next_zero_bit:	50500492 cycles,	327026 iterations
[   13.324644] find_last_bit:		273960 cycles,	655 iterations
[   13.358302] find_first_bit:		73235836 cycles,	655 iterations
[   13.359991] test_firmware: interface ready
[   13.403694] test_hash: __hash_32() has no arch implementation to test.
[   13.404648] test_hash: hash_32() has no arch implementation to test.
[   13.405505] test_hash: hash_64() has no arch implementation to test.
[   13.406424] test_hash: 33152 tests passed.
[   13.407325] test_siphash: self-tests: pass
[   13.411711] Running rhashtable test nelem=8, max_size=0, shrinking=0
[   13.413046] Test 00:
[   13.413726]   Adding 50000 keys
[   13.502193]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   13.531636]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   13.532811]   Deleting 50000 keys
[   13.577419]   Duration of test: 163068148 ns
[   13.578485] Test 01:
[   13.579106]   Adding 50000 keys
[   13.684308]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   13.718638]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   13.720397]   Deleting 50000 keys
[   13.766357]   Duration of test: 186627059 ns
[   13.767349] Test 02:
[   13.767928]   Adding 50000 keys
[   13.876597]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   13.908907]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   13.910653]   Deleting 50000 keys
[   13.955565]   Duration of test: 186928906 ns
[   13.956648] Test 03:
[   13.957346]   Adding 50000 keys
[   14.071006]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   14.096618]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[   14.097748]   Deleting 50000 keys
[   14.131757]   Duration of test: 173745670 ns
[   14.152538] test if its possible to exceed max_size 8192: no, ok
[   14.155720] Average test time: 177592445
[   14.156735] Testing concurrent rhashtable access from 10 threads
[   20.416763] rhashtable_thra (123) used greatest stack depth: 15056 bytes left
[   20.437531] rhashtable_thra (132) used greatest stack depth: 14952 bytes left
[   20.442259] test 3125 add/delete pairs into rhlist
[   20.649101] test 3125 random rhlist add/delete operations
[   20.759183] Started 10 threads, 0 failed, rhltable test returns 0
[   20.761423] test passed
[   20.762856] test_printf: all 240 tests passed
[   20.766991] crc32: CRC_LE_BITS = 32, CRC_BE BITS = 32
[   20.768315] crc32: self tests passed, processed 225944 bytes in 1091529 nsec
[   20.771239] crc32c: CRC_LE_BITS = 32
[   20.772189] crc32c: self tests passed, processed 225944 bytes in 550565 nsec
[   20.880685] crc32_combine: 8373 self tests passed
[   20.985073] crc32c_combine: 8373 self tests passed
[   20.986959] rbtree testing
[   21.015484]  -> test 1 (latency of nnodes insert+delete): 64459 cycles
[   21.044266]  -> test 2 (latency of nnodes cached insert+delete): 60558 cycles
[   21.048190]  -> test 3 (latency of inorder traversal): 6602 cycles
[   21.049060]  -> test 4 (latency to fetch first node)
[   21.049753]         non-cached: 48 cycles
[   21.050345]         cached: 25 cycles
[   21.295392] augmented rbtree testing
[   21.351485]  -> test 1 (latency of nnodes insert+delete): 126793 cycles
[   21.409271]  -> test 2 (latency of nnodes cached insert+delete): 125705 cycles
[   21.716866] interval tree insert/remove
[   21.779841]  -> 142287 cycles
[   21.780859] interval tree search
[   22.177702]  -> 897159 cycles (2692 results)
[   22.180342] gpio-mockup: probe of gpio-mockup failed with error -22
[   22.183522] intel_idle: does not run on family 6 model 6
[   22.184669] ipmi message handler version 39.2
[   22.185594] ipmi device interface
[   22.186326] IPMI System Interface driver.
[   22.187435] ipmi_si: Unable to find any System Interface(s)
[   22.188208] IPMI SSIF Interface driver
[   22.188754] Copyright (C) 2004 MontaVista Software - IPMI Powerdown via sys_reboot.
[   22.190407] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[   22.191465] ACPI: Power Button [PWRF]
[   22.192187] Warning: Processor Platform Limit event detected, but not handled.
[   22.193189] Consider compiling CPUfreq support into your kernel.
[   22.291648] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[   22.316373] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[   22.341767] 00:06: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
[   22.345991] lp: driver loaded but no devices found
[   22.346908] Non-volatile memory driver v1.3
[   22.347966] ppdev: user-space parallel port driver
[   22.348724] telclk_interrupt = 0xf non-mcpbl0010 hw.
[   22.349439] Hangcheck: starting hangcheck timer 0.9.1 (tick is 180 seconds, margin is 60 seconds).
[   22.351694] drm_mm: Testing DRM range manger (struct drm_mm), with random_seed=0x46d7056f max_iterations=8192 max_prime=128
[   22.354103] drm_mm: igt_sanitycheck - ok!
[   62.773373] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  124.213370] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  185.653360] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  247.093363] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  278.196918] ------------[ cut here ]------------
[  278.198746] Stack depot reached limit capacity
[  278.198833] WARNING: CPU: 0 PID: 1 at lib/stackdepot.c:119 depot_save_stack+0x22e/0x353
[  278.199990] CPU: 0 PID: 1 Comm: swapper Not tainted 4.15.0-rc2-00005-g3e6e512 #1
[  278.199990] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[  278.199990] task: 000000009f2da405 task.stack: 0000000018ee505d
[  278.199990] RIP: 0010:depot_save_stack+0x22e/0x353
[  278.199990] RSP: 0000:ffff88001f5bb9d8 EFLAGS: 00010086
[  278.199990] RAX: 0000000000000022 RBX: 00000000ae4fc5be RCX: ffff88001f5a8000
[  278.199990] RDX: 000000221f5a8000 RSI: ffffffff810eb77c RDI: 0000000000000093
[  278.199990] RBP: 0000000000000020 R08: 00000000e272d5c3 R09: 0000000000000004
[  278.199990] R10: 0000000000000000 R11: 0000000065e7cb07 R12: 00000000000fc5be
[  278.199990] R13: ffff88001f5bba30 R14: 0000000000000000 R15: 0000000000000286
[  278.199990] FS:  0000000000000000(0000) GS:ffffffff81e36000(0000) knlGS:0000000000000000
[  278.199990] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  278.199990] CR2: 0000000000000000 CR3: 0000000001e11000 CR4: 00000000000006b0
[  278.199990] Call Trace:
[  278.199990]  ? save_stack+0x7c/0x89
[  278.199990]  ? drm_mm_interval_tree_add_node+0xf6/0x137
[  278.199990]  ? drm_mm_interval_tree_add_node+0xf6/0x137
[  278.199990]  ? add_hole+0x12d/0x155
[  278.199990]  ? add_hole+0x12d/0x155
[  278.199990]  ? drm_mm_interval_tree_add_node+0xf6/0x137
[  278.199990]  ? add_hole+0x12d/0x155
[  278.199990]  ? drm_mm_interval_tree_compute_subtree_last+0x54/0x5c
[  278.199990]  ? drm_mm_interval_tree_augment_copy+0x18/0x18
[  278.199990]  ? add_hole+0x12d/0x155
[  278.199990]  ? drm_mm_reserve_node+0x13f/0x155
[  278.199990]  ? evict_something+0x244/0x2d1
[  278.199990]  ? drm_mm_interval_tree_add_node+0xf6/0x137
[  278.199990]  ? drm_mm_interval_tree_compute_subtree_last+0x54/0x5c
[  278.199990]  ? drm_mm_interval_tree_augment_copy+0x18/0x18
[  278.199990]  ? add_hole+0x12d/0x155
[  278.199990]  ? drm_mm_reserve_node+0x13f/0x155
[  278.199990]  ? drm_mm_interval_tree_compute_subtree_last+0x54/0x5c
[  278.199990]  ? drm_mm_interval_tree_augment_copy+0x18/0x18
[  278.199990]  ? drm_mm_interval_tree_augment_rotate+0x23/0x2a
[  278.199990]  ? drm_mm_interval_tree_compute_subtree_last+0x54/0x5c
[  278.199990]  ? rb_erase+0x146/0x270
[  278.199990]  ? drm_mm_interval_tree_add_node+0xf6/0x137
[  278.199990]  ? add_hole+0x12d/0x155
[  278.199990]  ? drm_mm_interval_tree_add_node+0xf6/0x137
[  278.199990]  ? drm_mm_interval_tree_add_node+0xf6/0x137
[  278.199990]  ? add_hole+0x12d/0x155
[  278.199990]  ? drm_mm_reserve_node+0x13f/0x155
[  278.199990]  ? evict_something+0x244/0x2d1
[  278.199990]  ? igt_evict+0x63d/0x75f
[  278.199990]  ? test_drm_mm_init+0xb5/0x111
[  278.199990]  ? drm_fb_helper_modinit+0xd/0xd
[  278.199990]  ? do_early_param+0xbe/0xbe
[  278.199990]  ? drm_mm_reserve_node+0x13f/0x155
[  278.199990]  ? evict_something+0x244/0x2d1
[  278.199990]  ? igt_evict+0x63d/0x75f
[  278.199990]  ? test_drm_mm_init+0xb5/0x111
[  278.199990]  ? drm_fb_helper_modinit+0xd/0xd
[  278.199990]  ? do_early_param+0xbe/0xbe
[  278.199990]  ? do_one_initcall+0x9d/0x158
[  278.199990]  ? do_early_param+0xbe/0xbe
[  278.199990]  ? do_early_param+0xbe/0xbe
[  278.199990]  ? kernel_init_freeable+0x11c/0x1cc
[  278.199990]  ? rest_init+0xbb/0xbb
[  278.199990]  ? kernel_init+0x10/0x13d
[  278.199990]  ? rest_init+0xbb/0xbb
[  278.199990]  ? ret_from_fork+0x24/0x30
[  278.199990] Code: 8d 50 01 81 fa ff 1f 00 00 7e 27 80 3d 52 04 c0 00 00 0f 85 fd 00 00 00 48 c7 c7 e2 9e d0 81 c6 05 3e 04 c0 00 01 e8 f1 53 d7 ff <0f> ff e9 e3 00 00 00 83 c0 02 89 15 64 7c 6d 01 48 c7 05 4d 7c 
[  278.199990] ---[ end trace 4dd271b4182c6be2 ]---
[  301.034863] [drm] Initialized vgem 1.0.0 20120112 for virtual device on minor 0
[  301.037550] parport_pc 00:04: reported by Plug and Play ACPI
[  301.038817] parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE]
[  301.120742] lp0: using parport0 (interrupt-driven).
[  301.121823] lp0: console ready
[  301.129040] dummy-irq: no IRQ given.  Use irq=N
[  301.130066] Silicon Labs C2 port support v. 0.51.0 - (C) 2007 Rodolfo Giometti
[  301.135190] mtdoops: mtd device (mtddev=name/number) must be supplied
[  301.136573] L440GX flash mapping: failed to find PIIX4 ISA bridge, cannot continue
[  301.264598] panel: panel driver registered on parport0 (io=0x378).
[  301.267015] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[  301.269324] serio: i8042 KBD port at 0x60,0x64 irq 1
[  301.273540] serio: i8042 AUX port at 0x60,0x64 irq 12
[  301.274996] parport0: cannot grant exclusive access for device parkbd
[  301.277349] mousedev: PS/2 mouse device common for all mice
[  301.279663] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
[  301.284118] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4
[  301.287579] ideapad_slidebar: DMI does not match
[  301.289403] i2c-parport: adapter type unspecified
[  301.291325] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3
[  301.293750] i2c-parport-light: adapter type unspecified
[  301.297065] smssdio: Siano SMS1xxx SDIO driver
[  301.297720] smssdio: Copyright Pierre Ossman
[  301.298769] __power_supply_register: Expected proper parent device for 'test_ac'
[  301.300304] __power_supply_register: Expected proper parent device for 'test_battery'
[  301.302487] (NULL device *): hwmon_device_register() is deprecated. Please convert the driver to use hwmon_device_register_with_info().
[  301.305211] __power_supply_register: Expected proper parent device for 'test_usb'
[  301.308513] applesmc: supported laptop not found!
[  301.309168] applesmc: driver init failed (ret=-19)!
[  301.312971] acquirewdt: WDT driver for Acquire single board computer initialising
[  301.314920] acquirewdt: I/O address 0x0043 already in use
[  301.316101] acquirewdt: probe of acquirewdt failed with error -5
[  301.317708] advantechwdt: WDT driver for Advantech single board computer initialising
[  301.319983] advantechwdt: initialized. timeout=60 sec (nowayout=1)
[  301.321076] ib700wdt: WDT driver for IB700 single board computer initialising
[  301.322291] ib700wdt: START method I/O 443 is not available
[  301.323231] ib700wdt: probe of ib700wdt failed with error -5
[  301.324285] it87_wdt: no device
[  301.324931] sc1200wdt: build 20020303
[  301.325580] sc1200wdt: io parameter must be specified
[  301.326765] pc87413_wdt: Version 1.1 at io 0x2E
[  301.327750] pc87413_wdt: cannot register miscdev on minor=130 (err=-16)
[  301.329164] sbc60xxwdt: I/O address 0x0443 already in use
[  301.330380] cpu5wdt: misc_register failed
[  301.331348] smsc37b787_wdt: SMsC 37B787 watchdog component driver 1.1 initialising...
[  301.333933] smsc37b787_wdt: Unable to register miscdev on minor 130
[  301.334994] w83877f_wdt: I/O address 0x0443 already in use
[  301.335774] machzwd: MachZ ZF-Logic Watchdog driver initializing
[  301.337102] machzwd: no ZF-Logic found
[  301.338007] sbc_epx_c3: cannot register miscdev on minor=130 (err=-16)
[  301.339740] watchdog: Software Watchdog: cannot register miscdev on minor=130 (err=-16).
[  301.341623] watchdog: Software Watchdog: a legacy watchdog module is probably present.
[  301.343659] softdog: initialized. soft_noboot=0 soft_margin=60 sec soft_panic=0 (nowayout=1)
[  301.345416] sdhci: Secure Digital Host Controller Interface driver
[  301.346712] sdhci: Copyright(c) Pierre Ossman
[  301.347647] sdhci-pltfm: SDHCI platform and OF driver helper
[  301.350465] ledtrig-cpu: registered to indicate activity on CPUs
[  301.352231] dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.2)
[  301.357688] hdaps: supported laptop not found!
[  301.358613] hdaps: driver init failed (ret=-19)!
[  301.378457] start plist test
[  301.399493] end plist test
[  301.401464] ... APIC ID:      00000000 (0)
[  301.402038] ... APIC VERSION: 01050014
[  301.402558] 0000000000000000000000000000000000000000000000000000000000000000
[  301.403315] 0000000000000000000000000000000000000000000000000000000000000000
[  301.403315] 0000000000000000000000000000000000000000000000000000000000004000
[  301.405559] number of MP IRQ sources: 15.
[  301.406105] number of IO-APIC #0 registers: 24.
[  301.406728] testing the IO APIC.......................
[  301.407847] IO APIC #0......
[  301.408470] .... register #00: 00000000
[  301.409226] .......    : physical APIC id: 00
[  301.413361] .......    : Delivery Type: 0
[  301.414168] .......    : LTS          : 0
[  301.414955] .... register #01: 00170011
[  301.415695] .......     : max redirection entries: 17
[  301.416720] .......     : PRQ implemented: 0
[  301.417574] .......     : IO APIC version: 11
[  301.418433] .... register #02: 00000000
[  301.419208] .......     : arbitration: 00
[  301.420036] .... IRQ redirection table:
[  301.420779] IOAPIC 0:
[  301.421279]  pin00, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  301.422825]  pin01, enabled , edge , high, V(23), IRR(0), S(0), logical , D(01), M(1)
[  301.424417]  pin02, enabled , edge , high, V(30), IRR(0), S(0), logical , D(01), M(1)
[  301.425945]  pin03, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  301.427553]  pin04, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  301.429116]  pin05, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  301.430692]  pin06, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  301.432237]  pin07, enabled , edge , high, V(21), IRR(0), S(0), logical , D(01), M(1)
[  301.433792]  pin08, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  301.435335]  pin09, enabled , level, high, V(20), IRR(0), S(0), logical , D(01), M(1)
[  301.436921]  pin0a, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  301.438453]  pin0b, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  301.440031]  pin0c, enabled , edge , high, V(22), IRR(0), S(0), logical , D(01), M(1)
[  301.441571]  pin0d, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  301.443119]  pin0e, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  301.444708]  pin0f, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  301.446259]  pin10, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  301.447820]  pin11, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  301.449352]  pin12, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  301.451005]  pin13, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  301.452531]  pin14, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  301.454102]  pin15, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  301.455634]  pin16, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  301.457205]  pin17, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  301.458704] IRQ to pin mappings:
[  301.459359] IRQ0 -> 0:2
[  301.459852] IRQ1 -> 0:1
[  301.460383] IRQ3 -> 0:3
[  301.460887] IRQ4 -> 0:4
[  301.461398] IRQ5 -> 0:5
[  301.461892] IRQ6 -> 0:6
[  301.462419] IRQ7 -> 0:7
[  301.462919] IRQ8 -> 0:8
[  301.463470] IRQ9 -> 0:9
[  301.463984] IRQ10 -> 0:10
[  301.464511] IRQ11 -> 0:11
[  301.465053] IRQ12 -> 0:12
[  301.465576] IRQ13 -> 0:13
[  301.466114] IRQ14 -> 0:14
[  301.466637] IRQ15 -> 0:15
[  301.467216] .................................... done.
[  301.468253] sched_clock: Marking stable (301466656351, 0)->(301930880977, -464224626)
[  301.472042] Loading compiled-in X.509 certificates
[  301.473048] page_owner is disabled
[  301.476116] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found
[  301.477350] EDD information not available.
[  301.492646] Freeing unused kernel memory: 1072K
[  301.493656] Write protecting the kernel read-only data: 14336k
[  301.498311] Freeing unused kernel memory: 1308K
[  301.509360] Freeing unused kernel memory: 308K
[  301.528520] mount (140) used greatest stack depth: 14544 bytes left
/etc/rcS.d/S00fbsetup: line 3: /sbin/modprobe: not found
[  301.537413] S00fbsetup (142) used greatest stack depth: 14448 bytes left

Please wait: booting...
Starting udev
[  301.592237] udevd[165]: starting version 3.1.5
[  302.261851] cat (197) used greatest stack depth: 14256 bytes left
LKP: HOSTNAME vm-lkp-nex04-yocto-x86_64-32, MAC , kernel 4.15.0-rc2-00005-g3e6e512 1, serial console /dev/ttyS0
Poky (Yocto Project Reference Distro) 2.1 vm-lkp-nex04-yocto-x86_64-32 /dev/ttyS0
[  303.890585] LKP: waiting for network...
[  308.533380] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  320.894288] /lkp/lkp/src/bin/run-lkp
[  320.894288] RESULT_ROOT=/result/trinity/300s/vm-lkp-nex04-yocto-x86_64/yocto-minimal-x86_64-2016-04-22.cgz/x86_64-randconfig-b0-12042212/gcc-7/3e6e51217dd14dcda10d4bc9a38b1440e2d42c14/0
[  320.894288] job=/lkp/scheduled/vm-lkp-nex04-yocto-x86_64-32/trinity-300s-yocto-minimal-x86_64-2016-04-22.cgz-3e6e51217dd14dcda10d4bc9a38b1440e2d42c14-20171205-41529-1h3sayh-0.yaml
[  320.894288] run-job /lkp/scheduled/vm-lkp-nex04-yocto-x86_64-32/trinity-300s-yocto-minimal-x86_64-2016-04-22.cgz-3e6e51217dd14dcda10d4bc9a38b1440e2d42c14-20171205-41529-1h3sayh-0.yaml
[  320.894288] skip http request: cgi-bin/lkp-jobfile-append-var?job_file=/lkp/scheduled/vm-lkp-nex04-yocto-x86_64-32/trinity-300s-yocto-minimal-x86_64-2016-04-22.cgz-3e6e51217dd14dcda10d4bc9a38b1440e2d42c14-20171205-41529-1h3sayh-0.yaml&job_state=running -O /dev/null
[  332.515304] trinity-main uses obsolete (PF_INET,SOCK_PACKET)
[  333.306736] trinity-c3 (576) used greatest stack depth: 14136 bytes left
[  335.716891] trinity-c2 (1187) used greatest stack depth: 14072 bytes left
[  336.034536] trinity-c0 (1287) used greatest stack depth: 14008 bytes left
[  345.756943] trinity-c0 (3926) used greatest stack depth: 13816 bytes left
[  369.973556] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  431.413416] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  492.853428] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  554.293309] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  615.734603] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  624.975358] sysrq: SysRq : Emergency Sync
[  624.976000] sysrq: SysRq : Resetting

Elapsed time: 610

#!/bin/bash

# To reproduce,
# 1) save job-script and this script (both are attached in 0day report email)
# 2) run this script with your compiled kernel and optional env $INSTALL_MOD_PATH

kernel=$1

initrds=(
	/osimage/yocto/yocto-minimal-x86_64-2016-04-22.cgz
	/lkp/lkp/lkp-x86_64.cgz
	/osimage/pkg/debian-x86_64-2016-08-31.cgz/trinity-static-x86_64-x86_64-6ddabfd2_2017-11-10.cgz
)

HTTP_PREFIX=https://github.com/0day-ci/lkp-qemu/raw/master
wget --timestamping "${initrds[@]/#/$HTTP_PREFIX}"

{
	cat "${initrds[@]//*\//}"
	[[ $INSTALL_MOD_PATH ]] && (
		cd "$INSTALL_MOD_PATH"
		find lib | cpio -o -H newc --quiet | gzip
	)
	echo  job-script | cpio -o -H newc --quiet | gzip
} > initrd.img

qemu-img create -f qcow2 disk-vm-lkp-nex04-yocto-x86_64-32-0 256G

kvm=(
	qemu-system-x86_64
	-enable-kvm
	-kernel $kernel
	-initrd initrd.img
	-m 512
	-smp 1
	-device e1000,netdev=net0
	-netdev user,id=net0
	-boot order=nc
	-no-reboot
	-watchdog i6300esb
	-watchdog-action debug
	-rtc base=localtime
	-drive file=disk-vm-lkp-nex04-yocto-x86_64-32-0,media=disk,if=virtio
	-serial stdio
	-display none
	-monitor null
)

append=(
	ip=::::vm-lkp-nex04-yocto-x86_64-32::dhcp
	root=/dev/ram0
	user=lkp
	job=/job-script
	ARCH=x86_64
	kconfig=x86_64-randconfig-b0-12042212
	branch=linux-devel/devel-spot-201712041942
	commit=3e6e51217dd14dcda10d4bc9a38b1440e2d42c14
	BOOT_IMAGE=/pkg/linux/x86_64-randconfig-b0-12042212/gcc-7/3e6e51217dd14dcda10d4bc9a38b1440e2d42c14/vmlinuz-4.15.0-rc2-00005-g3e6e512
	max_uptime=1500
	RESULT_ROOT=/result/trinity/300s/vm-lkp-nex04-yocto-x86_64/yocto-minimal-x86_64-2016-04-22.cgz/x86_64-randconfig-b0-12042212/gcc-7/3e6e51217dd14dcda10d4bc9a38b1440e2d42c14/0
	result_service=tmpfs
	debug
	apic=debug
	sysrq_always_enabled
	rcupdate.rcu_cpu_stall_timeout=100
	net.ifnames=0
	printk.devkmsg=on
	panic=-1
	softlockup_panic=1
	nmi_watchdog=panic
	oops=panic
	load_ramdisk=2
	prompt_ramdisk=0
	drbd.minor_count=8
	systemd.log_level=err
	ignore_loglevel
	console=tty0
	earlyprintk=ttyS0,115200
	console=ttyS0,115200
	vga=normal
	rw
	drbd.minor_count=8
)

"${kvm[@]}" -append "${append[*]}"
