early console in setup code
[    0.000000] Linux version 4.19.0-rc3-00054-g8762c83 (kbuild@lkp-wsm-ep2) (gcc version 6.4.0 20171026 (Debian 6.4.0-9)) #1 Tue Sep 18 19:38:05 CST 2018
[    0.000000] Command line: ip=::::vm-lkp-hsw-4ep1-4G-38::dhcp root=/dev/ram0 user=lkp job=/lkp/jobs/scheduled/vm-lkp-hsw-4ep1-4G-38/trinity-300s-debian-x86_64-2018-04-03.cgz-8762c83c14e566226b11c68bf01ce7d5d70fee29-20180918-65542-1suc4r7-3.yaml ARCH=x86_64 kconfig=x86_64-randconfig-s1-09121400 branch=linux-devel/devel-catchup-201809121519 commit=8762c83c14e566226b11c68bf01ce7d5d70fee29 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-s1-09121400/gcc-6/8762c83c14e566226b11c68bf01ce7d5d70fee29/vmlinuz-4.19.0-rc3-00054-g8762c83 max_uptime=1500 RESULT_ROOT=/result/trinity/300s/vm-lkp-hsw-4ep1-4G/debian-x86_64-2018-04-03.cgz/x86_64-randconfig-s1-09121400/gcc-6/8762c83c14e566226b11c68bf01ce7d5d70fee29/3 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=tty0 earlyprintk=ttyS0,115200
[    0.000000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
[    0.000000] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
[    0.000000] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
[    0.000000] x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
[    0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format.
[    0.000000] 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-0x00000000bffd1fff] usable
[    0.000000] BIOS-e820: [mem 0x00000000bffd2000-0x00000000bfffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[    0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000013fffffff] usable
[    0.000000] debug: ignoring loglevel setting.
[    0.000000] NX (Execute Disable) protection: active
[    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] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000007] kvm-clock: cpu 0, msr 28fd001, primary cpu clock
[    0.000008] kvm-clock: using sched offset of 9086339894 cycles
[    0.000054] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[    0.000164] tsc: Detected 1999.998 MHz processor
[    0.006403] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.006508] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.006564] last_pfn = 0x140000 max_arch_pfn = 0x400000000
[    0.006879] MTRR default type: write-back
[    0.006898] MTRR fixed ranges enabled:
[    0.006947]   00000-9FFFF write-back
[    0.006959]   A0000-BFFFF uncachable
[    0.006989]   C0000-FFFFF write-protect
[    0.007009] MTRR variable ranges enabled:
[    0.007024]   0 base 00C0000000 mask FFC0000000 uncachable
[    0.007040]   1 disabled
[    0.007051]   2 disabled
[    0.007063]   3 disabled
[    0.007073]   4 disabled
[    0.007084]   5 disabled
[    0.007095]   6 disabled
[    0.007109]   7 disabled
[    0.007448] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT  
[    0.007578] last_pfn = 0xbffd2 max_arch_pfn = 0x400000000
[    0.007592] Scan for SMP in [mem 0x00000000-0x000003ff]
[    0.007740] Scan for SMP in [mem 0x0009fc00-0x0009ffff]
[    0.008016] Scan for SMP in [mem 0x000f0000-0x000fffff]
[    0.026706] found SMP MP-table at [mem 0x000f6a50-0x000f6a5f] mapped at [(____ptrval____)]
[    0.026895]   mpc: f6a60-f6b7c
[    0.027366] Base memory trampoline at [(____ptrval____)] 99000 size 24576
[    0.028681] BRK [0x037de000, 0x037defff] PGTABLE
[    0.028823] BRK [0x037df000, 0x037dffff] PGTABLE
[    0.028885] BRK [0x037e0000, 0x037e0fff] PGTABLE
[    0.029403] BRK [0x037e1000, 0x037e1fff] PGTABLE
[    0.047982] RAMDISK: [mem 0x7bab3000-0x7fffffff]
[    0.048746] ACPI: Early table checksum verification disabled
[    0.050269] ACPI: RSDP 0x00000000000F6820 000014 (v00 BOCHS )
[    0.050814] ACPI: RSDT 0x00000000BFFE1628 000030 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.050954] ACPI: FACP 0x00000000BFFE147C 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.051061] ACPI: DSDT 0x00000000BFFE0040 00143C (v01 BOCHS  BXPCDSDT 00000001 BXPC 00000001)
[    0.051097] ACPI: FACS 0x00000000BFFE0000 000040
[    0.051126] ACPI: APIC 0x00000000BFFE1570 000080 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.051160] ACPI: HPET 0x00000000BFFE15F0 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
[    0.051419] ACPI: Local APIC address 0xfee00000
[    0.051551] mapped APIC to ffffffffff5fd000 (        fee00000)
[    0.068490] Zone ranges:
[    0.068579]   DMA32    [mem 0x0000000000001000-0x00000000ffffffff]
[    0.068595]   Normal   [mem 0x0000000100000000-0x000000013fffffff]
[    0.068625] Movable zone start for each node
[    0.068636] Early memory node ranges
[    0.068654]   node   0: [mem 0x0000000000001000-0x000000000009efff]
[    0.068663]   node   0: [mem 0x0000000000100000-0x00000000bffd1fff]
[    0.068671]   node   0: [mem 0x0000000100000000-0x000000013fffffff]
[    0.096561] Reserved but unavailable: 144 pages
[    0.096706] Initmem setup node 0 [mem 0x0000000000001000-0x000000013fffffff]
[    0.096855] On node 0 totalpages: 1048432
[    0.096959]   DMA32 zone: 12286 pages used for memmap
[    0.096968]   DMA32 zone: 21 pages reserved
[    0.096997]   DMA32 zone: 786288 pages, LIFO batch:63
[    0.701624]   Normal zone: 4096 pages used for memmap
[    0.701998]   Normal zone: 262144 pages, LIFO batch:63
[    0.861351] ACPI: PM-Timer IO Port: 0x608
[    0.861511] ACPI: Local APIC address 0xfee00000
[    0.861629] APIC: NR_CPUS/possible_cpus limit of 1 reached. Processor 1/0x1 ignored.
[    0.861666] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[    0.862332] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
[    0.862497] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[    0.862529] Int: type 0, pol 0, trig 0, bus 00, IRQ 00, APIC ID 0, APIC INT 02
[    0.862539] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[    0.862548] Int: type 0, pol 1, trig 3, bus 00, IRQ 05, APIC ID 0, APIC INT 05
[    0.862557] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[    0.862566] Int: type 0, pol 1, trig 3, bus 00, IRQ 09, APIC ID 0, APIC INT 09
[    0.862580] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[    0.862591] Int: type 0, pol 1, trig 3, bus 00, IRQ 0a, APIC ID 0, APIC INT 0a
[    0.862600] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[    0.862609] Int: type 0, pol 1, trig 3, bus 00, IRQ 0b, APIC ID 0, APIC INT 0b
[    0.862627] ACPI: IRQ0 used by override.
[    0.862636] Int: type 0, pol 0, trig 0, bus 00, IRQ 01, APIC ID 0, APIC INT 01
[    0.862645] Int: type 0, pol 0, trig 0, bus 00, IRQ 03, APIC ID 0, APIC INT 03
[    0.862654] Int: type 0, pol 0, trig 0, bus 00, IRQ 04, APIC ID 0, APIC INT 04
[    0.862663] ACPI: IRQ5 used by override.
[    0.862671] Int: type 0, pol 0, trig 0, bus 00, IRQ 06, APIC ID 0, APIC INT 06
[    0.862680] Int: type 0, pol 0, trig 0, bus 00, IRQ 07, APIC ID 0, APIC INT 07
[    0.862690] Int: type 0, pol 0, trig 0, bus 00, IRQ 08, APIC ID 0, APIC INT 08
[    0.862698] ACPI: IRQ9 used by override.
[    0.862706] ACPI: IRQ10 used by override.
[    0.862714] ACPI: IRQ11 used by override.
[    0.862723] Int: type 0, pol 0, trig 0, bus 00, IRQ 0c, APIC ID 0, APIC INT 0c
[    0.862732] Int: type 0, pol 0, trig 0, bus 00, IRQ 0d, APIC ID 0, APIC INT 0d
[    0.862741] Int: type 0, pol 0, trig 0, bus 00, IRQ 0e, APIC ID 0, APIC INT 0e
[    0.862751] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 0, APIC INT 0f
[    0.862779] Using ACPI (MADT) for SMP configuration information
[    0.862828] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[    0.862941] mapped IOAPIC to ffffffffff5fc000 (fec00000)
[    0.863560] KVM setup async PF for cpu 0
[    0.863596] kvm-stealtime: cpu 0, msr 27cc2c0
[    0.863772] [mem 0xc0000000-0xfeffbfff] available for PCI devices
[    0.863784] Booting paravirtualized kernel on KVM
[    0.863898] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns
[    0.864534] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[    0.864560] pcpu-alloc: [0] 0 
[    0.864864] Built 1 zonelists, mobility grouping on.  Total pages: 1032029
[    0.864918] Kernel command line: ip=::::vm-lkp-hsw-4ep1-4G-38::dhcp root=/dev/ram0 user=lkp job=/lkp/jobs/scheduled/vm-lkp-hsw-4ep1-4G-38/trinity-300s-debian-x86_64-2018-04-03.cgz-8762c83c14e566226b11c68bf01ce7d5d70fee29-20180918-65542-1suc4r7-3.yaml ARCH=x86_64 kconfig=x86_64-randconfig-s1-09121400 branch=linux-devel/devel-catchup-201809121519 commit=8762c83c14e566226b11c68bf01ce7d5d70fee29 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-s1-09121400/gcc-6/8762c83c14e566226b11c68bf01ce7d5d70fee29/vmlinuz-4.19.0-rc3-00054-g8762c83 max_uptime=1500 RESULT_ROOT=/result/trinity/300s/vm-lkp-hsw-4ep1-4G/debian-x86_64-2018-04-03.cgz/x86_64-randconfig-s1-09121400/gcc-6/8762c83c14e566226b11c68bf01ce7d5d70fee29/3 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=tty0 earlyprintk=ttyS0
[    0.868665] sysrq: sysrq always enabled.
[    0.905649] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes)
[    0.923742] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes)
[   11.659039] Memory: 3944036K/4193728K available (12312K kernel code, 3888K rwdata, 5480K rodata, 1036K init, 15336K bss, 249692K reserved, 0K cma-reserved)
[   11.672009] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[   11.672091] Kernel/User page tables isolation: enabled
[   11.673100] 
[   11.673109] **********************************************************
[   11.673117] **   NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE   **
[   11.673125] **                                                      **
[   11.673132] ** trace_printk() being used. Allocating extra memory.  **
[   11.673140] **                                                      **
[   11.673147] ** This means that this is a DEBUG kernel and it is     **
[   11.673155] ** unsafe for production use.                           **
[   11.673163] **                                                      **
[   11.673170] ** If you see this message and you are not debugging    **
[   11.673178] ** the kernel, report this immediately to your vendor!  **
[   11.673188] **                                                      **
[   11.673196] **   NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE   **
[   11.673204] **********************************************************
[   11.689000] Running RCU self tests
[   11.695243] NR_IRQS: 4352, nr_irqs: 48, preallocated irqs: 16
[   12.217675] console [ttyS0] enabled
[   12.219118] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[   12.223429] ... MAX_LOCKDEP_SUBCLASSES:  8
[   12.228059] ... MAX_LOCK_DEPTH:          48
[   12.232975] ... MAX_LOCKDEP_KEYS:        8191
[   12.239599] ... CLASSHASH_SIZE:          4096
[   12.248351] ... MAX_LOCKDEP_ENTRIES:     32768
[   12.252737] ... MAX_LOCKDEP_CHAINS:      65536
[   12.256227] ... CHAINHASH_SIZE:          32768
[   12.259697]  memory used by lock dependency info: 7903 kB
[   12.263802]  per task-struct memory footprint: 2688 bytes
[   12.287468] ODEBUG: selftest passed
[   12.290716] ACPI: Core revision 20180810
[   12.298376] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
[   12.307871] hpet clockevent registered
[   12.318278] APIC: Switch to symmetric I/O mode setup
[   12.325598] enabled ExtINT on CPU#0
[   12.337666] ENABLING IO-APIC IRQs
[   12.341344] init IO_APIC IRQs
[   12.344227]  apic 0 pin 0 not connected
[   12.347281] IOAPIC[0]: Set routing entry (0-1 -> 0xef -> IRQ 1 Mode:0 Active:0 Dest:1)
[   12.354071] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1)
[   12.359701] IOAPIC[0]: Set routing entry (0-3 -> 0xef -> IRQ 3 Mode:0 Active:0 Dest:1)
[   12.365687] IOAPIC[0]: Set routing entry (0-4 -> 0xef -> IRQ 4 Mode:0 Active:0 Dest:1)
[   12.371515] IOAPIC[0]: Set routing entry (0-5 -> 0xef -> IRQ 5 Mode:1 Active:0 Dest:1)
[   12.379054] IOAPIC[0]: Set routing entry (0-6 -> 0xef -> IRQ 6 Mode:0 Active:0 Dest:1)
[   12.384628] IOAPIC[0]: Set routing entry (0-7 -> 0xef -> IRQ 7 Mode:0 Active:0 Dest:1)
[   12.390418] IOAPIC[0]: Set routing entry (0-8 -> 0xef -> IRQ 8 Mode:0 Active:0 Dest:1)
[   12.398665] IOAPIC[0]: Set routing entry (0-9 -> 0xef -> IRQ 9 Mode:1 Active:0 Dest:1)
[   12.403634] IOAPIC[0]: Set routing entry (0-10 -> 0xef -> IRQ 10 Mode:1 Active:0 Dest:1)
[   12.409348] IOAPIC[0]: Set routing entry (0-11 -> 0xef -> IRQ 11 Mode:1 Active:0 Dest:1)
[   12.413601] IOAPIC[0]: Set routing entry (0-12 -> 0xef -> IRQ 12 Mode:0 Active:0 Dest:1)
[   12.419406] IOAPIC[0]: Set routing entry (0-13 -> 0xef -> IRQ 13 Mode:0 Active:0 Dest:1)
[   12.425728] IOAPIC[0]: Set routing entry (0-14 -> 0xef -> IRQ 14 Mode:0 Active:0 Dest:1)
[   12.431992] IOAPIC[0]: Set routing entry (0-15 -> 0xef -> IRQ 15 Mode:0 Active:0 Dest:1)
[   12.438360]  apic 0 pin 16 not connected
[   12.442098]  apic 0 pin 17 not connected
[   12.446496]  apic 0 pin 18 not connected
[   12.449993]  apic 0 pin 19 not connected
[   12.452602]  apic 0 pin 20 not connected
[   12.455115]  apic 0 pin 21 not connected
[   12.458367]  apic 0 pin 22 not connected
[   12.460613]  apic 0 pin 23 not connected
[   12.463224] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[   12.470017] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x39a8595ce59, max_idle_ns: 881590778713 ns
[   12.477867] Calibrating delay loop (skipped) preset value.. 3999.99 BogoMIPS (lpj=7999992)
[   12.481558] pid_max: default: 32768 minimum: 301
[   12.486751] Security Framework initialized
[   12.489899] Smack:  Initializing.
[   12.493524] Smack:  IPv6 port labeling enabled.
[   12.501579] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes)
[   12.505777] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes)
[   12.519009] *** VALIDATE proc ***
[   12.523762] *** VALIDATE cgroup1 ***
[   12.525501] *** VALIDATE cgroup2 ***
[   12.530576] mce: CPU supports 10 MCE banks
[   12.533931] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[   12.537520] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[   12.541461] CPU: Intel(R) Xeon(R) CPU E5-4667 v3 @ 2.00GHz (family: 0x6, model: 0x3f, stepping: 0x2)
[   12.545581] Spectre V2 : Vulnerable: Minimal generic ASM retpoline
[   12.549458] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
[   12.553501] Speculative Store Bypass: Vulnerable
[   12.578621] Performance Events: Haswell events, Intel PMU driver.
[   12.581783] ... version:                2
[   12.585459] ... bit width:              48
[   12.589492] ... generic registers:      4
[   12.592797] ... value mask:             0000ffffffffffff
[   12.593466] ... max period:             000000007fffffff
[   12.597459] ... fixed-purpose events:   3
[   12.599949] ... event mask:             000000070000000f
[   12.610428] random: crng done (trusting CPU's manufacturer)
[   12.614274] TSC deadline timer enabled
[   12.632017] devtmpfs: initialized
[   12.648983] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[   12.649764] futex hash table entries: 256 (order: 2, 24576 bytes)
[   12.655418] prandom: seed boundary self test passed
[   12.659081] prandom: 100 self tests passed
[   12.660812] pinctrl core: initialized pinctrl subsystem
[   12.670843] NET: Registered protocol family 16
[   12.678637] audit: initializing netlink subsys (disabled)
[   12.685598] audit: type=2000 audit(1537274459.222:1): state=initialized audit_enabled=0 res=1
[   12.689941] cpuidle: using governor menu
[   12.696080] ACPI: bus type PCI registered
[   12.698862] PCI: Using configuration type 1 for base access
[   12.704684] core: PMU erratum BJ122, BV98, HSD29 workaround disabled, HT off
[   12.790333] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
[   12.793271] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[   12.794786] cryptd: max_cpu_qlen set to 1000
[   12.799096] ACPI: Added _OSI(Module Device)
[   12.800553] ACPI: Added _OSI(Processor Device)
[   12.801494] ACPI: Added _OSI(3.0 _SCP Extensions)
[   12.803296] ACPI: Added _OSI(Processor Aggregator Device)
[   12.804980] ACPI: Added _OSI(Linux-Dell-Video)
[   12.805463] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
[   12.817592] ACPI: 1 ACPI AML tables successfully acquired and loaded
[   12.836147] ACPI: Interpreter enabled
[   12.837724] ACPI: (supports S0 S5)
[   12.841000] ACPI: Using IOAPIC for interrupt routing
[   12.842186] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[   12.847539] ACPI: Enabled 2 GPEs in block 00 to 0F
[   12.900687] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[   12.901599] acpi PNP0A03:00: _OSC: OS supports [Segments]
[   12.906411] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[   12.910244] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
[   12.915816] PCI host bridge to bus 0000:00
[   12.917489] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
[   12.921435] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
[   12.925470] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[   12.929511] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]
[   12.933492] pci_bus 0000:00: root bus resource [bus 00-ff]
[   12.938561] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[   12.947801] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[   12.951739] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[   13.009887] pci 0000:00:01.1: reg 0x20: [io  0xc200-0xc20f]
[   13.038102] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
[   13.041519] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
[   13.045541] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
[   13.048527] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
[   13.056205] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[   13.063495] pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI
[   13.065813] pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB
[   13.074971] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
[   13.090066] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
[   13.122086] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff]
[   13.186576] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[   13.198574] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[   13.214063] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff]
[   13.229975] pci 0000:00:03.0: reg 0x14: [io  0xc000-0xc03f]
[   13.314354] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
[   13.324370] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000
[   13.338210] pci 0000:00:04.0: reg 0x10: [io  0xc040-0xc07f]
[   13.354287] pci 0000:00:04.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff]
[   13.402519] pci 0000:00:04.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref]
[   13.436075] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000
[   13.450567] pci 0000:00:05.0: reg 0x10: [io  0xc080-0xc0bf]
[   13.466711] pci 0000:00:05.0: reg 0x14: [mem 0xfebf2000-0xfebf2fff]
[   13.514523] pci 0000:00:05.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref]
[   13.546181] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000
[   13.562576] pci 0000:00:06.0: reg 0x10: [io  0xc0c0-0xc0ff]
[   13.578259] pci 0000:00:06.0: reg 0x14: [mem 0xfebf3000-0xfebf3fff]
[   13.626162] pci 0000:00:06.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref]
[   13.654766] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000
[   13.670231] pci 0000:00:07.0: reg 0x10: [io  0xc100-0xc13f]
[   13.686002] pci 0000:00:07.0: reg 0x14: [mem 0xfebf4000-0xfebf4fff]
[   13.734386] pci 0000:00:07.0: reg 0x20: [mem 0xfe00c000-0xfe00ffff 64bit pref]
[   13.761862] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000
[   13.778111] pci 0000:00:08.0: reg 0x10: [io  0xc140-0xc17f]
[   13.794274] pci 0000:00:08.0: reg 0x14: [mem 0xfebf5000-0xfebf5fff]
[   13.842319] pci 0000:00:08.0: reg 0x20: [mem 0xfe010000-0xfe013fff 64bit pref]
[   13.871610] pci 0000:00:09.0: [1af4:1001] type 00 class 0x010000
[   13.886455] pci 0000:00:09.0: reg 0x10: [io  0xc180-0xc1bf]
[   13.901960] pci 0000:00:09.0: reg 0x14: [mem 0xfebf6000-0xfebf6fff]
[   13.953983] pci 0000:00:09.0: reg 0x20: [mem 0xfe014000-0xfe017fff 64bit pref]
[   13.987497] pci 0000:00:0a.0: [1af4:1001] type 00 class 0x010000
[   14.002135] pci 0000:00:0a.0: reg 0x10: [io  0xc1c0-0xc1ff]
[   14.018122] pci 0000:00:0a.0: reg 0x14: [mem 0xfebf7000-0xfebf7fff]
[   14.065906] pci 0000:00:0a.0: reg 0x20: [mem 0xfe018000-0xfe01bfff 64bit pref]
[   14.099835] pci 0000:00:0b.0: [8086:25ab] type 00 class 0x088000
[   14.109990] pci 0000:00:0b.0: reg 0x10: [mem 0xfebf8000-0xfebf800f]
[   14.194705] pci_bus 0000:00: on NUMA node 0
[   14.216102] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[   14.223237] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[   14.228965] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[   14.232763] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[   14.235517] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
[   14.262325] pci 0000:00:02.0: vgaarb: setting as boot VGA device
[   14.265435] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[   14.265772] pci 0000:00:02.0: vgaarb: bridge control possible
[   14.269498] vgaarb: loaded
[   14.282008] videodev: Linux video capture interface: v2.00
[   14.287891] pps_core: LinuxPPS API ver. 1 registered
[   14.289526] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[   14.303129] FPGA manager framework
[   14.307368] Advanced Linux Sound Architecture Driver Initialized.
[   14.310272] PCI: Using ACPI for IRQ routing
[   14.313586] PCI: pci_cache_line_size set to 64 bytes
[   14.320544] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[   14.321658] e820: reserve RAM buffer [mem 0xbffd2000-0xbfffffff]
[   14.334295] Bluetooth: Core ver 2.22
[   14.338464] NET: Registered protocol family 31
[   14.341681] Bluetooth: HCI device and connection manager initialized
[   14.345757] Bluetooth: HCI socket layer initialized
[   14.349611] Bluetooth: L2CAP socket layer initialized
[   14.354373] NetLabel: Initializing
[   14.357555] NetLabel:  domain hash size = 128
[   14.361534] NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO
[   14.366543] NetLabel:  unlabeled traffic allowed by default
[   14.377435] dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.2)
[   14.390338] clocksource: Switched to clocksource kvm-clock
[   14.961232] VFS: Disk quotas dquot_6.6.0
[   14.968144] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[   14.978715] FS-Cache: Loaded
[   14.981192] *** VALIDATE hugetlbfs ***
[   14.990358] pnp: PnP ACPI init
[   14.996609] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
[   15.004515] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
[   15.010646] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
[   15.016740] pnp 00:03: [dma 2]
[   15.019727] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
[   15.026581] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active)
[   15.032881] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
[   15.039137] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active)
[   15.051034] pnp: PnP ACPI: found 7 devices
[   15.071558] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[   15.080078] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
[   15.084984] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
[   15.089420] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
[   15.094383] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window]
[   15.106761] NET: Registered protocol family 2
[   15.127427] tcp_listen_portaddr_hash hash table entries: 2048 (order: 5, 180224 bytes)
[   15.144359] TCP established hash table entries: 32768 (order: 6, 262144 bytes)
[   15.165833] TCP bind hash table entries: 32768 (order: 9, 2621440 bytes)
[   15.226421] TCP: Hash tables configured (established 32768 bind 32768)
[   15.240576] UDP hash table entries: 2048 (order: 6, 393216 bytes)
[   15.262883] UDP-Lite hash table entries: 2048 (order: 6, 393216 bytes)
[   15.273124] NET: Registered protocol family 1
[   15.279310] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[   15.286817] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[   15.292202] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[   15.298804] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[   15.308711] PCI: CLS 0 bytes, default 64
[   15.321035] Unpacking initramfs...
[   35.294151] Freeing initrd memory: 70964K
[   35.321389] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
[   35.327349] software IO TLB: mapped [mem 0xbbfd2000-0xbffd2000] (64MB)
[   35.339116] kvm: no hardware support
[   35.342875] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x39a8595ce59, max_idle_ns: 881590778713 ns
[   35.467040] 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
[   35.491813] spin_lock-torture: Creating torture_shuffle task
[   35.503588] spin_lock-torture: Creating torture_stutter task
[   35.508099] spin_lock-torture: torture_shuffle task started
[   35.514444] spin_lock-torture: Creating lock_torture_writer task
[   35.520697] spin_lock-torture: torture_stutter task started
[   35.529936] spin_lock-torture: Creating lock_torture_writer task
[   35.537515] spin_lock-torture: lock_torture_writer task started
[   35.544717] spin_lock-torture: Creating lock_torture_stats task
[   35.552612] spin_lock-torture: lock_torture_writer task started
[   35.570112] spin_lock-torture: lock_torture_stats task started
[   35.577582] torture_init_begin: Refusing rcu init: spin_lock running.
[   35.586030] torture_init_begin: One torture test at a time!
[   35.618457] Key type blacklist registered
[   35.627095] workingset: timestamp_bits=62 max_order=20 bucket_order=0
[   35.701179] DLM installed
[   35.716923] romfs: ROMFS MTD (C) 2007 Red Hat, Inc.
[   35.724320] pstore: using lz4hc compression
[   35.818042] NET: Registered protocol family 38
[   35.832988] xz_dec_test: module loaded
[   35.836293] xz_dec_test: Create a device node with 'mknod xz_dec_test c 246 0' and write .xz files to it.
[   35.849381] glob: 64 self-tests passed, 0 failed
[   35.864330] gpio_it87: no device
[   35.889071] hgafb: HGA card not detected.
[   35.897963] hgafb: probe of hgafb.0 failed with error -22
[   35.920871] uvesafb: failed to execute /sbin/v86d
[   35.926686] uvesafb: make sure that the v86d helper is installed and executable
[   35.936622] uvesafb: Getting VBE info block failed (eax=0x4f00, err=-2)
[   35.945240] uvesafb: vbe_init() failed with -22
[   35.951037] uvesafb: probe of uvesafb.0 failed with error -22
[   35.961118] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[   35.970467] ACPI: Power Button [PWRF]
[   35.977020] Warning: Processor Platform Limit event detected, but not handled.
[   35.987289] Consider compiling CPUfreq support into your kernel.
[   36.281245] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[   36.340602] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[   36.406356] 00:06: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
[   36.441991] lp: driver loaded but no devices found
[   36.450050] Non-volatile memory driver v1.3
[   36.458769] ppdev: user-space parallel port driver
[   36.464267] telclk_interrupt = 0xf non-mcpbl0010 hw.
[   36.475488] Hangcheck: starting hangcheck timer 0.9.1 (tick is 180 seconds, margin is 60 seconds).
[   36.490784] drm_mm: Testing DRM range manger (struct drm_mm), with random_seed=0x5f74e3f1 max_iterations=8192 max_prime=128
[   36.504240] drm_mm: igt_sanitycheck - ok!
[   36.509833] igt_debug 0x0000000000000000-0x0000000000000200: 512: free
[   36.518389] igt_debug 0x0000000000000200-0x0000000000000600: 1024: used
[   36.523693] igt_debug 0x0000000000000600-0x0000000000000a00: 1024: free
[   36.528552] igt_debug 0x0000000000000a00-0x0000000000000e00: 1024: used
[   36.535070] igt_debug 0x0000000000000e00-0x0000000000001000: 512: free
[   36.541029] igt_debug total: 4096, used 2048 free 2048
[   97.782505] Writes:  Total: 335247  Max/Min: 0/0   Fail: 0 
[  159.149963] Writes:  Total: 691304  Max/Min: 0/0   Fail: 0 
[  189.340520] [drm] Initialized vgem 1.0.0 20120112 for virtual device on minor 0
[  189.406737] parport_pc 00:04: reported by Plug and Play ACPI
[  189.414108] parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE]
[  189.528841] lp0: using parport0 (interrupt-driven).
[  189.532668] lp0: console ready
[  189.537894] parport_pc parport_pc.956: Unable to set coherent dma mask: disabling DMA
[  189.544739] parport_pc parport_pc.888: Unable to set coherent dma mask: disabling DMA
[  189.554399] parport_pc parport_pc.632: Unable to set coherent dma mask: disabling DMA
[  189.563993] dummy-irq: no IRQ given.  Use irq=N
[  189.567435] Silicon Labs C2 port support v. 0.51.0 - (C) 2007 Rodolfo Giometti
[  189.573745] c2port c2port0: C2 port uc added
[  189.576477] c2port c2port0: uc flash has 30 blocks x 512 bytes (15360 bytes total)
[  189.591616] L440GX flash mapping: failed to find PIIX4 ISA bridge, cannot continue
[  189.597701] slram: not enough parameters.
[  189.622779] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[  189.627906] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[  189.633280] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[  189.637662] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[  189.643729] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[  189.648732] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[  189.654312] nand: device found, Manufacturer ID: 0x98, Chip ID: 0x39
[  189.657284] nand: Toshiba NAND 128MiB 1,8V 8-bit
[  189.659571] nand: 128 MiB, SLC, erase size: 16 KiB, page size: 512, OOB size: 16
[  189.664399] flash size: 128 MiB
[  189.666496] page size: 512 bytes
[  189.668670] OOB area size: 16 bytes
[  189.670893] sector size: 16 KiB
[  189.673316] pages number: 262144
[  189.675022] pages per sector: 32
[  189.676826] bus width: 8
[  189.678489] bits in sector size: 14
[  189.680202] bits in page size: 9
[  189.681798] bits in OOB size: 4
[  189.683384] flash size with OOB: 135168 KiB
[  189.685315] page address bytes: 4
[  189.687735] sector address bytes: 3
[  189.689623] options: 0x42
[  189.723256] Scanning device for bad blocks
[  189.879413] Creating 1 MTD partitions on "NAND 128MiB 1,8V 8-bit":
[  189.886260] 0x000000000000-0x000008000000 : "NAND simulator partition 0"
[  189.938728] parport0: powerup/reset Butterfly
[  190.068426] parport_pc 00:04: registered master spi42
[  190.078365] spi spi42.1: spi_bitbang_setup, 66 nsec/bit
[  190.083289] spi spi42.1: setup mode 0, 8 bits/w, 15000000 Hz max --> 0
[  190.095131] parport_pc 00:04: registered child spi42.1
[  190.097429] parport0: dataflash at spi42.1
[  190.098782] parport0: AVR Butterfly
[  190.103153] e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-NAPI
[  190.106417] e1000: Copyright (c) 1999-2006 Intel Corporation.
[  190.844052] PCI Interrupt Link [LNKC] enabled at IRQ 11
[  191.636363] e1000 0000:00:03.0 eth0: (PCI:33MHz:32-bit) 52:54:00:12:34:56
[  191.640723] e1000 0000:00:03.0 eth0: Intel(R) PRO/1000 Network Connection
[  191.645245] e1000e: Intel(R) PRO/1000 Network Driver - 3.2.6-k
[  191.647867] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
[  191.653989] igb: Intel(R) Gigabit Ethernet Network Driver - version 5.4.0-k
[  191.656751] igb: Copyright (c) 2007-2014 Intel Corporation.
[  191.659915] ixgbe: Intel(R) 10 Gigabit PCI Express Network Driver - version 5.1.0-k
[  191.663193] ixgbe: Copyright (c) 1999-2016 Intel Corporation.
[  191.678104] NET3 PLIP version 2.4-parport gniibe@mri.co.jp
[  191.680773] plip0: Parallel port at 0x378, using IRQ 7.
[  191.690181] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[  191.703524] serio: i8042 KBD port at 0x60,0x64 irq 1
[  191.706122] serio: i8042 AUX port at 0x60,0x64 irq 12
[  191.714389] mousedev: PS/2 mouse device common for all mice
[  191.719139] evbug: Connected device: input0 (Power Button at LNXPWRBN/button/input0)
[  191.728554] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
[  191.736101] rtc_cmos 00:00: RTC can wake from S4
[  191.744341] evbug: Connected device: input1 (AT Translated Set 2 keyboard at isa0060/serio0/input0)
[  191.749277] rtc rtc0: alarm rollover: day
[  191.752527] rtc_cmos 00:00: char device (0:0)
[  191.758590] rtc_cmos 00:00: registered as rtc0
[  191.760662] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs
[  191.770876] i2c-parport: adapter type unspecified
[  191.774715] i2c-parport-light: adapter type unspecified
[  191.783400] vivid-000: using single planar format API
[  191.823378] vivid-000: V4L2 capture device registered as video0
[  191.827410] vivid-000: V4L2 output device registered as video1
[  191.830518] vivid-000: V4L2 capture device registered as vbi0, supports raw and sliced VBI
[  191.834854] vivid-000: V4L2 output device registered as vbi1, supports raw and sliced VBI
[  191.839044] vivid-000: V4L2 capture device registered as swradio0
[  191.842418] vivid-000: V4L2 receiver device registered as radio0
[  191.846041] vivid-000: V4L2 transmitter device registered as radio1
[  191.850185] smssdio: Siano SMS1xxx SDIO driver
[  191.853422] smssdio: Copyright Pierre Ossman
[  191.861076] pps pps0: new PPS source ktimer
[  191.865356] pps pps0: ktimer PPS source registered
[  191.872163] Driver for 1-wire Dallas network protocol.
[  191.880191] w1_f0d_init()
[  191.890978] applesmc: supported laptop not found!
[  191.895792] applesmc: driver init failed (ret=-19)!
[  191.902501] f71882fg: Not a Fintek device
[  191.907177] f71882fg: Not a Fintek device
[  191.919786] pc87360: PC8736x not detected, module not inserted
[  191.926016] sch56xx_common: Unsupported device id: 0xff
[  191.928942] sch56xx_common: Unsupported device id: 0xff
[  191.936211] intel_powerclamp: CPU does not support MWAIT
[  191.941371] acquirewdt: WDT driver for Acquire single board computer initialising
[  191.948178] acquirewdt: I/O address 0x0043 already in use
[  191.950115] acquirewdt: probe of acquirewdt failed with error -5
[  191.952125] advantechwdt: WDT driver for Advantech single board computer initialising
[  191.957843] advantechwdt: initialized. timeout=60 sec (nowayout=0)
[  191.961038] it87_wdt: no device
[  191.962463] sc1200wdt: build 20020303
[  191.964398] sc1200wdt: io parameter must be specified
[  191.966424] sbc60xxwdt: I/O address 0x0443 already in use
[  191.969026] smsc37b787_wdt: SMsC 37B787 watchdog component driver 1.1 initialising...
[  191.974818] smsc37b787_wdt: Unable to register miscdev on minor 130
[  191.977051] w83877f_wdt: I/O address 0x0443 already in use
[  191.978908] w83977f_wdt: driver v1.00
[  191.980245] w83977f_wdt: cannot register miscdev on minor=130 (err=-16)
[  191.982148] machzwd: MachZ ZF-Logic Watchdog driver initializing
[  191.985058] machzwd: no ZF-Logic found
[  191.989843] watchdog: Software Watchdog: cannot register miscdev on minor=130 (err=-16).
[  191.994043] watchdog: Software Watchdog: a legacy watchdog module is probably present.
[  192.001061] softdog: initialized. soft_noboot=0 soft_margin=60 sec soft_panic=0 (nowayout=0)
[  192.009711] Bluetooth: Generic Bluetooth SDIO driver ver 0.1
[  192.014628] wbsd: Winbond W83L51xD SD/MMC card interface driver
[  192.018005] wbsd: Copyright(c) Pierre Ossman
[  192.032825] OPA Virtual Network Driver - v1.0
[  192.040898] hdaps: supported laptop not found!
[  192.043179] hdaps: driver init failed (ret=-19)!
[  192.057141] parport0: cannot grant exclusive access for device MTS64
[  192.060836] ALSA mts64.c:956 Cannot register pardevice
[  192.065763] snd_mts64: probe of snd_mts64.0 failed with error -5
[  192.071387] parport0: cannot grant exclusive access for device portman
[  192.073941] ALSA portman2x4.c:754 Cannot register pardevice
[  192.076777] snd_portman2x4: probe of snd_portman2x4.0 failed with error -5
[  192.100908] oprofile: using NMI interrupt.
[  192.105608] drop_monitor: Initializing network drop monitor service
[  192.111866] NET: Registered protocol family 26
[  192.117814] netem: version 1.3
[  192.120382] gre: GRE over IPv4 demultiplexor driver
[  192.122270] ip_gre: GRE over IPv4 tunneling driver
[  192.132260] IPv4 over IPsec tunneling driver
[  192.136863] Initializing XFRM netlink socket
[  192.142005] NET: Registered protocol family 10
[  192.167404] Segment Routing with IPv6
[  192.171748] mip6: Mobile IPv6
[  192.179436] NET: Registered protocol family 15
[  192.182293] NET: Registered protocol family 5
[  192.185185] NET: Registered protocol family 9
[  192.187157] X25: Linux Version 0.2
[  192.192257] NET4: DECnet for Linux: V.2.5.68s (C) 1995-2003 Linux DECnet Project Team
[  192.200569] DECnet: Routing cache hash table of 1024 buckets, 80Kbytes
[  192.206745] NET: Registered protocol family 12
[  192.212035] NET: Registered protocol family 35
[  192.220618] 8021q: 802.1Q VLAN Support v1.8
[  192.226548] sctp: Hash tables configured (bind 32/51)
[  192.234014] tipc: Activated (version 2.0.0)
[  192.238465] NET: Registered protocol family 30
[  192.243987] tipc: Started in single node mode
[  192.247299] NET: Registered protocol family 43
[  192.250595] 9pnet: Installing 9P2000 support
[  192.254748] Key type dns_resolver registered
[  192.256766] Key type ceph registered
[  192.261173] libceph: loaded (mon/osd proto 15/24)
[  192.264504] openvswitch: Open vSwitch switching datapath
[  192.269331] mpls_gso: MPLS GSO support
[  192.272100] start plist test
[  192.277090] end plist test
[  192.284977] ... APIC ID:      00000000 (0)
[  192.285469] ... APIC VERSION: 01050014
[  192.285469] 0000000000000000000000000000000000000000000000000000000000000000
[  192.285469] 0000000000000000000000000000000000000000000000000000000000000000
[  192.285469] 0000000000000000000000000000000000000000000000000000000000001000
[  192.296676] number of MP IRQ sources: 15.
[  192.298411] number of IO-APIC #0 registers: 24.
[  192.300155] testing the IO APIC.......................
[  192.303188] IO APIC #0......
[  192.304419] .... register #00: 00000000
[  192.306129] .......    : physical APIC id: 00
[  192.307921] .......    : Delivery Type: 0
[  192.310020] .......    : LTS          : 0
[  192.311974] .... register #01: 00170011
[  192.314500] .......     : max redirection entries: 17
[  192.318833] .......     : PRQ implemented: 0
[  192.322292] .......     : IO APIC version: 11
[  192.325263] .... register #02: 00000000
[  192.328162] .......     : arbitration: 00
[  192.331141] .... IRQ redirection table:
[  192.334354] IOAPIC 0:
[  192.336287]  pin00, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  192.341592]  pin01, enabled , edge , high, V(23), IRR(0), S(0), logical , D(01), M(0)
[  192.348329]  pin02, enabled , edge , high, V(30), IRR(0), S(0), logical , D(01), M(0)
[  192.353409]  pin03, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  192.358462]  pin04, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  192.364909]  pin05, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  192.372079]  pin06, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  192.378858]  pin07, enabled , edge , high, V(21), IRR(0), S(0), logical , D(01), M(0)
[  192.384165]  pin08, enabled , edge , high, V(24), IRR(0), S(0), logical , D(01), M(0)
[  192.390666]  pin09, enabled , level, high, V(20), IRR(0), S(0), logical , D(01), M(0)
[  192.397898]  pin0a, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  192.402944]  pin0b, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  192.408109]  pin0c, enabled , edge , high, V(22), IRR(0), S(0), logical , D(01), M(0)
[  192.412321]  pin0d, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  192.417202]  pin0e, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  192.424597]  pin0f, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  192.429549]  pin10, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  192.436755]  pin11, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  192.441738]  pin12, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  192.447707]  pin13, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  192.454039]  pin14, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  192.458771]  pin15, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  192.465168]  pin16, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  192.471381]  pin17, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  192.475643] IRQ to pin mappings:
[  192.477668] IRQ0 -> 0:2
[  192.479504] IRQ1 -> 0:1
[  192.481118] IRQ3 -> 0:3
[  192.482867] IRQ4 -> 0:4
[  192.484918] IRQ5 -> 0:5
[  192.486509] IRQ6 -> 0:6
[  192.488350] IRQ7 -> 0:7
[  192.490066] IRQ8 -> 0:8
[  192.491488] IRQ9 -> 0:9
[  192.492749] IRQ10 -> 0:10
[  192.494584] IRQ11 -> 0:11
[  192.496109] IRQ12 -> 0:12
[  192.498380] IRQ13 -> 0:13
[  192.499942] IRQ14 -> 0:14
[  192.501735] IRQ15 -> 0:15
[  192.503037] .................................... done.
[  192.510878] AVX2 version of gcm_enc/dec engaged.
[  192.514519] AES CTR mode by8 optimization enabled
[  192.543898] sched_clock: Marking stable (191801078402, 740551324)->(206335715669, -13794085943)
[  192.560121] registered taskstats version 1
[  192.572781] ima: No TPM chip found, activating TPM-bypass!
[  192.576435] ima: Allocated hash algorithm: sha1
[  192.614932] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[  192.619765] e1000: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX
[  192.629399] 8021q: adding VLAN 0 to HW filter on device eth0
[  192.632582] IP-Config: Failed to open plip0
[  192.634960] IP-Config: Failed to open gretap0
[  192.636758] IP-Config: Failed to open erspan0
[  192.638999] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[  192.661614] Sending DHCP requests ., OK
[  192.672830] IP-Config: Got DHCP answer from 10.0.2.2, my address is 10.0.2.15
[  192.676272] IP-Config: Complete:
[  192.677923]      device=eth0, hwaddr=52:54:00:12:34:56, ipaddr=10.0.2.15, mask=255.255.255.0, gw=10.0.2.2
[  192.683639]      host=vm-lkp-hsw-4ep1-4G-38, domain=, nis-domain=(none)
[  192.686859]      bootserver=10.0.2.2, rootserver=10.0.2.2, rootpath=
[  192.686865]      nameserver0=10.0.2.3
[  192.711171] Bluetooth: Starting self testing
[  192.743086] Bluetooth: ECDH test passed in 26420 usecs
[  192.750766] Bluetooth: Finished self testing
[  192.760695] ALSA device list:
[  192.765045]   No soundcards found.
[  192.803541] Freeing unused kernel image memory: 1036K
[  192.810528] Write protecting the kernel read-only data: 20480k
[  192.840186] Freeing unused kernel image memory: 2000K
[  192.854092] Freeing unused kernel image memory: 664K
[  192.860385] Run /init as init process
[  193.029936] systemd[1]: RTC configured in localtime, applying delta of 0 minutes to system time.
[  193.072545] tmpfs: Bad mount option smackfsroot
[  193.078276] systemd[1]: Failed to mount tmpfs at /dev/shm: Invalid argument
[  193.093022] tmpfs: Bad mount option smackfsroot
[  193.095997] systemd[1]: Failed to mount tmpfs at /run: Invalid argument
[  193.155499] systemd[1]: Freezing execution.
[  220.278014] Writes:  Total: 5186110  Max/Min: 0/0   Fail: 0 
[  281.718628] Writes:  Total: 15783659  Max/Min: 0/0   Fail: 0 
[  343.252933] Writes:  Total: 25942761  Max/Min: 0/0   Fail: 0 
[  404.598433] Writes:  Total: 37830142  Max/Min: 0/0   Fail: 0 
[  466.038422] Writes:  Total: 49407918  Max/Min: 0/0   Fail: 0 
[  527.478023] Writes:  Total: 62488561  Max/Min: 0/0   Fail: 0 
[  589.012609] Writes:  Total: 75191252  Max/Min: 0/0   Fail: 0 
[  650.357633] Writes:  Total: 88887191  Max/Min: 0/0   Fail: 0 
[  711.797854] Writes:  Total: 101502152  Max/Min: 0/0   Fail: 0 
[  773.239048] Writes:  Total: 113681723  Max/Min: 0/0   Fail: 0 
[  834.678380] Writes:  Total: 125868473  Max/Min: 0/0   Fail: 0 
[  896.117737] Writes:  Total: 138691064  Max/Min: 0/0   Fail: 0 
[  957.604107] Writes:  Total: 151519605  Max/Min: 0/0   Fail: 0 
[ 1018.997967] Writes:  Total: 165836147  Max/Min: 0/0   Fail: 0 
[ 1080.439730] Writes:  Total: 178990538  Max/Min: 0/0   Fail: 0 
[ 1141.878798] Writes:  Total: 191815170  Max/Min: 0/0   Fail: 0 
[ 1203.318687] Writes:  Total: 204377894  Max/Min: 0/0   Fail: 0 
[ 1264.758492] Writes:  Total: 216200362  Max/Min: 0/0   Fail: 0 
[ 1326.198164] Writes:  Total: 228590575  Max/Min: 0/0   Fail: 0 
[ 1387.638593] Writes:  Total: 240413452  Max/Min: 0/0   Fail: 0 
[ 1449.078848] Writes:  Total: 252618489  Max/Min: 0/0   Fail: 0 
[ 1510.519328] Writes:  Total: 264794446  Max/Min: 0/0   Fail: 0 
[ 1571.958297] Writes:  Total: 276281071  Max/Min: 0/0   Fail: 0 
[ 1633.398919] Writes:  Total: 288305735  Max/Min: 0/0   Fail: 0 
[ 1694.838395] Writes:  Total: 299760052  Max/Min: 0/0   Fail: 0 
[ 1756.278820] Writes:  Total: 311253294  Max/Min: 0/0   Fail: 0 
[ 1817.719622] Writes:  Total: 322560707  Max/Min: 0/0   Fail: 0 
[ 1879.158097] Writes:  Total: 334655210  Max/Min: 0/0   Fail: 0 
[ 1940.598471] Writes:  Total: 347072468  Max/Min: 0/0   Fail: 0 
[ 2002.038144] Writes:  Total: 359241724  Max/Min: 0/0   Fail: 0 
[ 2063.478966] Writes:  Total: 372053970  Max/Min: 0/0   Fail: 0 
[ 2124.918886] Writes:  Total: 384546152  Max/Min: 0/0   Fail: 0 
[ 2186.358214] Writes:  Total: 396967637  Max/Min: 0/0   Fail: 0 
[ 2247.798608] Writes:  Total: 409089503  Max/Min: 0/0   Fail: 0 
[ 2309.242994] Writes:  Total: 420824933  Max/Min: 0/0   Fail: 0 
[ 2370.677861] Writes:  Total: 432288082  Max/Min: 0/0   Fail: 0 
[ 2432.120045] Writes:  Total: 443901340  Max/Min: 0/0   Fail: 0 
[ 2493.558520] Writes:  Total: 454808781  Max/Min: 0/0   Fail: 0 
[ 2555.028062] Writes:  Total: 466382884  Max/Min: 0/0   Fail: 0 
[ 2616.438626] Writes:  Total: 477022512  Max/Min: 0/0   Fail: 0 
BUG: kernel hang in test stage

Elapsed time: 2620

#!/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/debian/debian-x86_64-2018-04-03.cgz
	/lkp/lkp/lkp-x86_64.cgz
	/osimage/deps/debian-x86_64-2018-04-03.cgz/run-ipconfig_2018-04-03.cgz
	/osimage/deps/debian-x86_64-2018-04-03.cgz/lkp_2018-04-03.cgz
	/osimage/deps/debian-x86_64-2018-04-03.cgz/rsync-rootfs_2018-04-03.cgz
	/osimage/pkg/debian-x86_64-2018-04-03.cgz/trinity-x86_64-1b2d43cb_2018-06-12.cgz
)

HTTP_PREFIX=https://download.01.org/0day-ci/lkp-qemu
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-hsw-4ep1-4G-38-0 256G
qemu-img create -f qcow2 disk-vm-lkp-hsw-4ep1-4G-38-1 256G
qemu-img create -f qcow2 disk-vm-lkp-hsw-4ep1-4G-38-2 256G
qemu-img create -f qcow2 disk-vm-lkp-hsw-4ep1-4G-38-3 256G
qemu-img create -f qcow2 disk-vm-lkp-hsw-4ep1-4G-38-4 256G
qemu-img create -f qcow2 disk-vm-lkp-hsw-4ep1-4G-38-5 256G
qemu-img create -f qcow2 disk-vm-lkp-hsw-4ep1-4G-38-6 256G

kvm=(
	qemu-system-x86_64
	-enable-kvm
	-cpu host
	-kernel $kernel
	-initrd initrd.img
	-m 4096
	-smp 2
	-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-hsw-4ep1-4G-38-0,media=disk,if=virtio
	-drive file=disk-vm-lkp-hsw-4ep1-4G-38-1,media=disk,if=virtio
	-drive file=disk-vm-lkp-hsw-4ep1-4G-38-2,media=disk,if=virtio
	-drive file=disk-vm-lkp-hsw-4ep1-4G-38-3,media=disk,if=virtio
	-drive file=disk-vm-lkp-hsw-4ep1-4G-38-4,media=disk,if=virtio
	-drive file=disk-vm-lkp-hsw-4ep1-4G-38-5,media=disk,if=virtio
	-drive file=disk-vm-lkp-hsw-4ep1-4G-38-6,media=disk,if=virtio
	-serial stdio
	-display none
	-monitor null
)

append=(
	ip=::::vm-lkp-hsw-4ep1-4G-38::dhcp
	root=/dev/ram0
	user=lkp
	job=/job-script
	ARCH=x86_64
	kconfig=x86_64-randconfig-s1-09121400
	branch=linux-devel/devel-catchup-201809121519
	commit=8762c83c14e566226b11c68bf01ce7d5d70fee29
	BOOT_IMAGE=/pkg/linux/x86_64-randconfig-s1-09121400/gcc-6/8762c83c14e566226b11c68bf01ce7d5d70fee29/vmlinuz-4.19.0-rc3-00054-g8762c83
	max_uptime=1500
	RESULT_ROOT=/result/trinity/300s/vm-lkp-hsw-4ep1-4G/debian-x86_64-2018-04-03.cgz/x86_64-randconfig-s1-09121400/gcc-6/8762c83c14e566226b11c68bf01ce7d5d70fee29/3
	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
	rcuperf.shutdown=0
)

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