early console in setup code
[    0.000000] Linux version 4.12.0-rc4-00017-gd52d163 (kbuild@lkp-wsx02) (gcc version 6.2.0 20160901 (Debian 6.2.0-3) ) #1 SMP PREEMPT Thu Jun 8 11:05:49 CST 2017
[    0.000000] KERNEL supported cpus:
[    0.000000]   Intel GenuineIntel
[    0.000000]   Centaur CentaurHauls
[    0.000000]   UMC UMC UMC UMC
[    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-0x0000000013fddfff] usable
[    0.000000] BIOS-e820: [mem 0x0000000013fde000-0x0000000013ffffff] 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] Notice: NX (Execute Disable) protection missing in CPU!
[    0.000000] Hypervisor detected: KVM
[    0.000000] tsc: Fast TSC calibration using PIT
[    0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.000000] e820: last_pfn = 0x13fde max_arch_pfn = 0x100000
[    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 0x000f6b80-0x000f6b8f] mapped at [780f6b80]
[    0.000000]   mpc: f6b90-f6c7c
[    0.000000] initial memory mapped: [mem 0x00000000-0x03bfffff]
[    0.000000] Base memory trampoline at [7809b000] 9b000 size 16384
[    0.000000] BRK [0x034d9000, 0x034d9fff] PGTABLE
[    0.000000] BRK [0x034da000, 0x034dbfff] PGTABLE
[    0.000000] RAMDISK: [mem 0x12d11000-0x13fcffff]
[    0.000000] ACPI: Early table checksum verification disabled
[    0.000000] ACPI: RSDP 0x00000000000F6960 000014 (v00 BOCHS )
[    0.000000] ACPI: RSDT 0x0000000013FE1936 000030 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACP 0x0000000013FE180A 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.000000] ACPI: DSDT 0x0000000013FE0040 0017CA (v01 BOCHS  BXPCDSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACS 0x0000000013FE0000 000040
[    0.000000] ACPI: APIC 0x0000000013FE187E 000080 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.000000] ACPI: HPET 0x0000000013FE18FE 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] mapped APIC to         ffffc000 (        fee00000)
[    0.000000] 0MB HIGHMEM available.
[    0.000000] 319MB LOWMEM available.
[    0.000000]   mapped low ram: 0 - 13fde000
[    0.000000]   low ram: 0 - 13fde000
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000000] kvm-clock: cpu 0, msr 0:13fdd001, primary cpu clock
[    0.000000] kvm-clock: using sched offset of 962663375 cycles
[    0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[    0.000000] BRK [0x034dc000, 0x034dcfff] PGTABLE
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.000000]   Normal   [mem 0x0000000001000000-0x0000000013fddfff]
[    0.000000]   HighMem  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-0x0000000013fddfff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000013fddfff]
[    0.000000] On node 0 totalpages: 81788
[    0.000000]   DMA zone: 32 pages used for memmap
[    0.000000]   DMA zone: 0 pages reserved
[    0.000000]   DMA zone: 3998 pages, LIFO batch:0
[    0.000000]   Normal zone: 608 pages used for memmap
[    0.000000]   Normal zone: 77790 pages, LIFO batch:15
[    0.000000] Using APIC driver default
[    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] smpboot: Allowing 2 CPUs, 0 hotplug CPUs
[    0.000000] mapped IOAPIC to ffffb000 (fec00000)
[    0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
[    0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
[    0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
[    0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
[    0.000000] e820: [mem 0x14000000-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: 1910969940391419 ns
[    0.000000] setup_percpu: NR_CPUS:32 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1
[    0.000000] percpu: Embedded 21 pages/cpu @8aa67000 s54592 r0 d31424 u86016
[    0.000000] pcpu-alloc: s54592 r0 d31424 u86016 alloc=21*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 
[    0.000000] KVM setup async PF for cpu 0
[    0.000000] kvm-stealtime: cpu 0, msr 12a69b40
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 81148
[    0.000000] Kernel command line: ip=::::vm-ivb41-yocto-i386-14::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-ivb41-yocto-i386-14/trinity-300s-yocto-tiny-i386-2016-04-22.cgz-d52d163f428136feb592f7546cb2333cfad775bf-20170608-34093-192kerz-0.yaml ARCH=i386 kconfig=i386-randconfig-h1-06060528 branch=luto/x86/pcid commit=d52d163f428136feb592f7546cb2333cfad775bf BOOT_IMAGE=/pkg/linux/i386-randconfig-h1-06060528/gcc-6/d52d163f428136feb592f7546cb2333cfad775bf/vmlinuz-4.12.0-rc4-00017-gd52d163 max_uptime=1500 RESULT_ROOT=/result/trinity/300s/vm-ivb41-yocto-i386/yocto-tiny-i386-2016-04-22.cgz/i386-randconfig-h1-06060528/gcc-6/d52d163f428136feb592f7546cb2333cfad775bf/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 earlyprintk=ttyS0,115200 console=ttyS0,115200 console=tty0 vg
[    0.000000] sysrq: sysrq always enabled.
[    0.000000] PID hash table entries: 2048 (order: 1, 8192 bytes)
[    0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
[    0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
[    0.000000] Initializing CPU#0
[    0.000000] Initializing HighMem for node 0 (00000000:00000000)
[    0.000000] Memory: 266992K/327152K available (9739K kernel code, 1131K rwdata, 6292K rodata, 560K init, 19776K bss, 60160K reserved, 0K cma-reserved, 0K highmem)
[    0.000000] virtual kernel memory layout:
[    0.000000]     fixmap  : 0xffa77000 - 0xfffff000   (5664 kB)
[    0.000000]     pkmap   : 0xff400000 - 0xff800000   (4096 kB)
[    0.000000]     vmalloc : 0x8c7de000 - 0xff3fe000   (1836 MB)
[    0.000000]     lowmem  : 0x78000000 - 0x8bfde000   ( 319 MB)
[    0.000000]       .init : 0x7a0e6000 - 0x7a172000   ( 560 kB)
[    0.000000]       .data : 0x79982c06 - 0x7a0c3f00   (7428 kB)
[    0.000000]       .text : 0x79000000 - 0x79982c06   (9739 kB)
[    0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[    0.001000] Running RCU self tests
[    0.001000] Preemptible hierarchical RCU implementation.
[    0.001000] 	RCU lockdep checking is enabled.
[    0.001000] 	RCU restricting CPUs from NR_CPUS=32 to nr_cpu_ids=2.
[    0.001000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[    0.001000] NR_IRQS:2304 nr_irqs:440 16
[    0.001000] CPU 0 irqstacks, hard=8a436000 soft=8a438000
[    0.001000] console [ttyS0] enabled
[    0.001000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[    0.001000] ... MAX_LOCKDEP_SUBCLASSES:  8
[    0.001000] ... MAX_LOCK_DEPTH:          48
[    0.001000] ... MAX_LOCKDEP_KEYS:        8191
[    0.001000] ... CLASSHASH_SIZE:          4096
[    0.001000] ... MAX_LOCKDEP_ENTRIES:     32768
[    0.001000] ... MAX_LOCKDEP_CHAINS:      65536
[    0.001000] ... CHAINHASH_SIZE:          32768
[    0.001000]  memory used by lock dependency info: 4911 kB
[    0.001000]  per task-struct memory footprint: 1344 bytes
[    0.001000] ------------------------
[    0.001000] | Locking API testsuite:
[    0.001000] ----------------------------------------------------------------------------
[    0.001000]                                  | spin |wlock |rlock |mutex | wsem | rsem |
[    0.001000]   --------------------------------------------------------------------------
[    0.001000]                      A-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.001000]                  A-B-B-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.001000]              A-B-B-C-C-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.001000]              A-B-C-A-B-C deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.001000]          A-B-B-C-C-D-D-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.001000]          A-B-C-D-B-D-D-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.001000]          A-B-C-D-B-C-D-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.001000]                     double unlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.001000]                   initialize held:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.001000]                  bad unlock order:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.001000]   --------------------------------------------------------------------------
[    0.001000]               recursive read-lock:             |  ok  |             |  ok  |
[    0.001000]            recursive read-lock #2:             |  ok  |             |  ok  |
[    0.001000]             mixed read-write-lock:             |  ok  |             |  ok  |
[    0.001000]             mixed write-read-lock:             |  ok  |             |  ok  |
[    0.001000]   --------------------------------------------------------------------------
[    0.001000]      hard-irqs-on + irq-safe-A/12:  ok  |  ok  |  ok  |
[    0.001000]      soft-irqs-on + irq-safe-A/12:  ok  |  ok  |  ok  |
[    0.001000]      hard-irqs-on + irq-safe-A/21:  ok  |  ok  |  ok  |
[    0.001000]      soft-irqs-on + irq-safe-A/21:  ok  |  ok  |  ok  |
[    0.001000]        sirq-safe-A => hirqs-on/12:  ok  |  ok  |  ok  |
[    0.001000]        sirq-safe-A => hirqs-on/21:  ok  |  ok  |  ok  |
[    0.001000]          hard-safe-A + irqs-on/12:  ok  |  ok  |  ok  |
[    0.001000]          soft-safe-A + irqs-on/12:  ok  |  ok  |  ok  |
[    0.001000]          hard-safe-A + irqs-on/21:  ok  |  ok  |  ok  |
[    0.001000]          soft-safe-A + irqs-on/21:  ok  |  ok  |  ok  |
[    0.001000]     hard-safe-A + unsafe-B #1/123:  ok  |  ok  |  ok  |
[    0.001000]     soft-safe-A + unsafe-B #1/123:  ok  |  ok  |  ok  |
[    0.001000]     hard-safe-A + unsafe-B #1/132:  ok  |  ok  |  ok  |
[    0.001000]     soft-safe-A + unsafe-B #1/132:  ok  |  ok  |  ok  |
[    0.001000]     hard-safe-A + unsafe-B #1/213:  ok  |  ok  |  ok  |
[    0.001000]     soft-safe-A + unsafe-B #1/213:  ok  |  ok  |  ok  |
[    0.001000]     hard-safe-A + unsafe-B #1/231:  ok  |  ok  |  ok  |
[    0.001000]     soft-safe-A + unsafe-B #1/231:  ok  |  ok  |  ok  |
[    0.001000]     hard-safe-A + unsafe-B #1/312:  ok  |  ok  |  ok  |
[    0.001000]     soft-safe-A + unsafe-B #1/312:  ok  |  ok  |  ok  |
[    0.001000]     hard-safe-A + unsafe-B #1/321:  ok  |  ok  |  ok  |
[    0.001000]     soft-safe-A + unsafe-B #1/321:  ok  |  ok  |  ok  |
[    0.001000]     hard-safe-A + unsafe-B #2/123:  ok  |  ok  |  ok  |
[    0.001000]     soft-safe-A + unsafe-B #2/123:  ok  |  ok  |  ok  |
[    0.001000]     hard-safe-A + unsafe-B #2/132:  ok  |  ok  |  ok  |
[    0.001000]     soft-safe-A + unsafe-B #2/132:  ok  |  ok  |  ok  |
[    0.001000]     hard-safe-A + unsafe-B #2/213:  ok  |  ok  |  ok  |
[    0.001000]     soft-safe-A + unsafe-B #2/213:  ok  |  ok  |  ok  |
[    0.001000]     hard-safe-A + unsafe-B #2/231:  ok  |  ok  |  ok  |
[    0.001000]     soft-safe-A + unsafe-B #2/231:  ok  |  ok  |  ok  |
[    0.001000]     hard-safe-A + unsafe-B #2/312:  ok  |  ok  |  ok  |
[    0.001000]     soft-safe-A + unsafe-B #2/312:  ok  |  ok  |  ok  |
[    0.001000]     hard-safe-A + unsafe-B #2/321:  ok  |  ok  |  ok  |
[    0.001000]     soft-safe-A + unsafe-B #2/321:  ok  |  ok  |  ok  |
[    0.001000]       hard-irq lock-inversion/123:  ok  |  ok  |  ok  |
[    0.001000]       soft-irq lock-inversion/123:  ok  |  ok  |  ok  |
[    0.001000]       hard-irq lock-inversion/132:  ok  |  ok  |  ok  |
[    0.001000]       soft-irq lock-inversion/132:  ok  |  ok  |  ok  |
[    0.001000]       hard-irq lock-inversion/213:  ok  |  ok  |  ok  |
[    0.001000]       soft-irq lock-inversion/213:  ok  |  ok  |  ok  |
[    0.001000]       hard-irq lock-inversion/231:  ok  |  ok  |  ok  |
[    0.001000]       soft-irq lock-inversion/231:  ok  |  ok  |  ok  |
[    0.001000]       hard-irq lock-inversion/312:  ok  |  ok  |  ok  |
[    0.001000]       soft-irq lock-inversion/312:  ok  |  ok  |  ok  |
[    0.001000]       hard-irq lock-inversion/321:  ok  |  ok  |  ok  |
[    0.001000]       soft-irq lock-inversion/321:  ok  |  ok  |  ok  |
[    0.001000]       hard-irq read-recursion/123:  ok  |
[    0.001000]       soft-irq read-recursion/123:  ok  |
[    0.001000]       hard-irq read-recursion/132:  ok  |
[    0.001000]       soft-irq read-recursion/132:  ok  |
[    0.001000]       hard-irq read-recursion/213:  ok  |
[    0.001000]       soft-irq read-recursion/213:  ok  |
[    0.001000]       hard-irq read-recursion/231:  ok  |
[    0.001000]       soft-irq read-recursion/231:  ok  |
[    0.001000]       hard-irq read-recursion/312:  ok  |
[    0.001000]       soft-irq read-recursion/312:  ok  |
[    0.001000]       hard-irq read-recursion/321:  ok  |
[    0.001000]       soft-irq read-recursion/321:  ok  |
[    0.001000]   --------------------------------------------------------------------------
[    0.001000]   | Wound/wait tests |
[    0.001000]   ---------------------
[    0.001000]                   ww api failures:  ok  |  ok  |  ok  |
[    0.001000]                ww contexts mixing:  ok  |  ok  |
[    0.001000]              finishing ww context:  ok  |  ok  |  ok  |  ok  |
[    0.001000]                locking mismatches:  ok  |  ok  |  ok  |
[    0.001000]                  EDEADLK handling:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.001000]            spinlock nest unlocked:  ok  |
[    0.001000]   -----------------------------------------------------
[    0.001000]                                  |block | try  |context|
[    0.001000]   -----------------------------------------------------
[    0.001000]                           context:  ok  |  ok  |  ok  |
[    0.001000]                               try:  ok  |  ok  |  ok  |
[    0.001000]                             block:  ok  |  ok  |  ok  |
[    0.001000]                          spinlock:  ok  |  ok  |  ok  |
[    0.001000] -------------------------------------------------------
[    0.001000] Good, all 253 testcases passed! |
[    0.001000] ---------------------------------
[    0.001000] allocated 327680 bytes of page_ext
[    0.001000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
[    0.001000] hpet clockevent registered
[    0.001023] tsc: Detected 2693.508 MHz processor
[    0.002009] Calibrating delay loop (skipped) preset value.. 5387.01 BogoMIPS (lpj=2693508)
[    0.003013] pid_max: default: 32768 minimum: 301
[    0.004039] ACPI: Core revision 20170303
[    0.007630] ACPI: 1 ACPI AML tables successfully acquired and loaded
[    0.008090] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.009012] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.011292] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    0.012010] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[    0.013317] Freeing SMP alternatives memory: 32K
[    0.015271] smpboot: Max logical packages: 2
[    0.015909] Enabling APIC mode:  Flat.  Using 1 I/O APICs
[    0.016045] enabled ExtINT on CPU#0
[    0.018379] ENABLING IO-APIC IRQs
[    0.018883] init IO_APIC IRQs
[    0.019011]  apic 0 pin 0 not connected
[    0.020029] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1)
[    0.021034] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1)
[    0.022000] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1)
[    0.022000] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1)
[    0.022000] IOAPIC[0]: Set routing entry (0-5 -> 0x35 -> IRQ 5 Mode:1 Active:0 Dest:1)
[    0.022000] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1)
[    0.022000] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1)
[    0.022000] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1)
[    0.022000] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:1)
[    0.022000] IOAPIC[0]: Set routing entry (0-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:1)
[    0.022000] IOAPIC[0]: Set routing entry (0-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:1)
[    0.022000] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1)
[    0.022000] IOAPIC[0]: Set routing entry (0-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:1)
[    0.022000] IOAPIC[0]: Set routing entry (0-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:1)
[    0.022000] IOAPIC[0]: Set routing entry (0-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:1)
[    0.022000]  apic 0 pin 16 not connected
[    0.022000]  apic 0 pin 17 not connected
[    0.022000]  apic 0 pin 18 not connected
[    0.022000]  apic 0 pin 19 not connected
[    0.022000]  apic 0 pin 20 not connected
[    0.022000]  apic 0 pin 21 not connected
[    0.022000]  apic 0 pin 22 not connected
[    0.022000]  apic 0 pin 23 not connected
[    0.022000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.022000] Using local APIC timer interrupts.
[    0.022000] calibrating APIC timer ...
[    0.023000] ... lapic delta = 6248890
[    0.023000] ... PM-Timer delta = 357887
[    0.023000] ... PM-Timer result ok
[    0.023000] ..... delta 6248890
[    0.023000] ..... mult: 268387781
[    0.023000] ..... calibration result: 999822
[    0.023000] ..... CPU clock speed is 2693.0000 MHz.
[    0.023000] ..... host bus clock speed is 999.0822 MHz.
[    0.023053] smpboot: CPU0: Intel QEMU Virtual CPU version 2.5+ (family: 0x6, model: 0x6, stepping: 0x3)
[    0.028031] Performance Events: PMU not available due to virtualization, using software events only.
[    0.038014] smp: Bringing up secondary CPUs ...
[    0.046216] CPU 1 irqstacks, hard=8a53e000 soft=8a540000
[    0.047020] x86: Booting SMP configuration:
[    0.048012] .... node  #0, CPUs:      #1
[    0.000000] Initializing CPU#1
[    0.001000] kvm-clock: cpu 1, msr 0:13fdd041, secondary cpu clock
[    0.001000] masked ExtINT on CPU#1
[    0.050743] KVM setup async PF for cpu 1
[    0.050743] kvm-stealtime: cpu 1, msr 12a7eb40
[    0.053013] smp: Brought up 1 node, 2 CPUs
[    0.054009] smpboot: Total of 2 processors activated (10774.03 BogoMIPS)
[    0.056013] sched_clock: Marking stable (56000000, 0)->(547763794, -491763794)
[    0.058763] devtmpfs: initialized
[    0.073206] workqueue: round-robin CPU selection forced, expect performance impact
[    0.086258] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
[    0.087667] futex hash table entries: 512 (order: 3, 32768 bytes)
[    0.088689] xor: measuring software checksum speed
[    0.098997]    pIII_sse  : 12740.000 MB/sec
[    0.108994]    prefetch64-sse: 14536.000 MB/sec
[    0.109651] xor: using function: prefetch64-sse (14536.000 MB/sec)
[    0.110536] prandom: seed boundary self test passed
[    0.112011] prandom: 100 self tests passed
[    0.112606] pinctrl core: initialized pinctrl subsystem
[    0.113674] regulator-dummy: no parameters
[    0.114755] NET: Registered protocol family 16
[    0.129519] cpuidle: using governor ladder
[    0.130144] PCCT header not found.
[    0.131749] ACPI: bus type PCI registered
[    0.132494] PCI: Using configuration type 1 for base access
[    0.174994] raid6: mmxx1    gen()  3167 MB/s
[    0.191986] raid6: mmxx2    gen()  3429 MB/s
[    0.208988] raid6: sse1x1   gen()  2539 MB/s
[    0.225976] raid6: sse1x2   gen()  3304 MB/s
[    0.242982] raid6: sse2x1   gen()  5066 MB/s
[    0.259967] raid6: sse2x1   xor()  3980 MB/s
[    0.276964] raid6: sse2x2   gen()  6867 MB/s
[    0.293962] raid6: sse2x2   xor()  4568 MB/s
[    0.294584] raid6: using algorithm sse2x2 gen() 6867 MB/s
[    0.295357] raid6: .... xor() 4568 MB/s, rmw enabled
[    0.296080] raid6: using intx1 recovery algorithm
[    0.309491] ACPI: Added _OSI(Module Device)
[    0.310105] ACPI: Added _OSI(Processor Device)
[    0.310743] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.311425] ACPI: Added _OSI(Processor Aggregator Device)
[    0.317206] ACPI: Interpreter enabled
[    0.317793] ACPI: (supports S0 S3 S4 S5)
[    0.318368] ACPI: Using IOAPIC for interrupt routing
[    0.319127] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.333727] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.334642] acpi PNP0A03:00: _OSC: OS supports [Segments MSI]
[    0.335499] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[    0.337774] PCI host bridge to bus 0000:00
[    0.338380] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
[    0.339351] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
[    0.340321] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[    0.341397] pci_bus 0000:00: root bus resource [mem 0x14000000-0xfebfffff window]
[    0.342472] pci_bus 0000:00: root bus resource [bus 00-ff]
[    0.343328] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[    0.345059] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[    0.346894] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[    0.353355] pci 0000:00:01.1: reg 0x20: [io  0xc080-0xc08f]
[    0.357117] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
[    0.358643] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
[    0.359582] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
[    0.360598] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
[    0.362008] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[    0.363375] pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI
[    0.364428] pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB
[    0.366016] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
[    0.369399] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
[    0.374818] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff]
[    0.384960] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[    0.386455] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[    0.389114] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff]
[    0.392216] pci 0000:00:03.0: reg 0x14: [io  0xc000-0xc03f]
[    0.404086] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
[    0.405649] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000
[    0.409280] pci 0000:00:04.0: reg 0x10: [io  0xc040-0xc07f]
[    0.412687] pci 0000:00:04.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff]
[    0.421934] pci 0000:00:04.0: reg 0x20: [mem 0xfe000000-0xfe7fffff 64bit pref]
[    0.427165] pci 0000:00:05.0: [8086:25ab] type 00 class 0x088000
[    0.428950] pci 0000:00:05.0: reg 0x10: [mem 0xfebf2000-0xfebf200f]
[    0.436363] pci_bus 0000:00: on NUMA node 0
[    0.438392] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[    0.439565] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[    0.440663] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[    0.441756] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[    0.442706] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
[    0.453038] pci 0000:00:02.0: vgaarb: setting as boot VGA device
[    0.453946] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[    0.455180] pci 0000:00:02.0: vgaarb: bridge control possible
[    0.456042] vgaarb: loaded
[    0.456992] Linux cec interface: v0.10
[    0.457576] media: Linux media interface: v0.10
[    0.458285] Linux video capture interface: v2.00
[    0.459025] pps_core: LinuxPPS API ver. 1 registered
[    0.459771] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.473210] FPGA manager framework
[    0.473787] Advanced Linux Sound Architecture Driver Initialized.
[    0.474711] PCI: Using ACPI for IRQ routing
[    0.475316] PCI: pci_cache_line_size set to 32 bytes
[    0.476202] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[    0.477074] e820: reserve RAM buffer [mem 0x13fde000-0x13ffffff]
[    0.478404] NET: Registered protocol family 23
[    0.479119] NET: Registered protocol family 8
[    0.479756] NET: Registered protocol family 20
[    0.481292] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
[    0.488530] clocksource: Switched to clocksource kvm-clock
[    0.561671] pnp: PnP ACPI init
[    0.562326] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
[    0.563370] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
[    0.564407] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
[    0.565376] pnp 00:03: [dma 2]
[    0.565884] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
[    0.566982] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active)
[    0.568056] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
[    0.569144] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active)
[    0.570731] pnp: PnP ACPI: found 7 devices
[    0.607045] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[    0.608397] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
[    0.609289] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
[    0.610181] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
[    0.611161] pci_bus 0000:00: resource 7 [mem 0x14000000-0xfebfffff window]
[    0.612301] NET: Registered protocol family 1
[    0.612959] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[    0.613813] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[    0.614663] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[    0.615608] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[    0.616840] PCI: CLS 0 bytes, default 32
[    0.617616] Unpacking initramfs...
[    1.953945] Freeing initrd memory: 19196K
[    1.954569] sta2x11_mfd_init
[    1.990740] rcu-torture:--- Start of test: nreaders=1 nfakewriters=4 stat_interval=60 verbose=1 test_no_idle_hz=1 shuffle_interval=3 stutter=5 irqreader=1 fqs_duration=0 fqs_holdoff=0 fqs_stutter=3 test_boost=1/0 test_boost_interval=7 test_boost_duration=4 shutdown_secs=0 stall_cpu=0 stall_cpu_holdoff=10 n_barrier_cbs=0 onoff_interval=0 onoff_holdoff=0
[    1.995134] rcu-torture: Creating rcu_torture_writer task
[    1.995998] rcu-torture: Creating rcu_torture_fakewriter task
[    1.996874] rcu-torture: rcu_torture_writer task started
[    1.997641] rcu-torture: GP expediting controlled from boot/sysfs for rcu,
[    1.998618] rcu-torture: Disabled dynamic grace-period expediting.
[    1.999523] rcu-torture: Creating rcu_torture_fakewriter task
[    2.000383] rcu-torture: rcu_torture_fakewriter task started
[    2.001224] rcu-torture: Creating rcu_torture_fakewriter task
[    2.002089] rcu-torture: rcu_torture_fakewriter task started
[    2.003073] rcu-torture: rcu_torture_fakewriter task started
[    2.016358] rcu-torture: Creating rcu_torture_fakewriter task
[    2.017257] rcu-torture: Creating rcu_torture_reader task
[    2.018086] rcu-torture: rcu_torture_fakewriter task started
[    2.018937] rcu-torture: Creating rcu_torture_stats task
[    2.020107] rcu-torture: rcu_torture_reader task started
[    2.021729] rcu-torture: Creating torture_shuffle task
[    2.022511] rcu-torture: rcu_torture_stats task started
[    2.023501] rcu-torture: Creating torture_stutter task
[    2.024297] rcu-torture: torture_shuffle task started
[    2.026095] rcu-torture: torture_stutter task started
[    2.026114] rcu-torture: Creating rcu_torture_cbflood task
[    2.040555] audit: initializing netlink subsys (disabled)
[    2.041519] rcu-torture: rcu_torture_cbflood task started
[    2.042409] audit: type=2000 audit(1496893103.395:1): state=initialized audit_enabled=0 res=1
[    2.042680] Initialise system trusted keyrings
[    2.042806] workingset: timestamp_bits=30 max_order=17 bucket_order=0
[    2.060431] ntfs: driver 2.1.32 [Flags: R/W DEBUG].
[    2.061180] fuse init (API version 7.26)
[    2.061973] NILFS version 2 loaded
[    2.082473] NET: Registered protocol family 38
[    2.083163] Key type asymmetric registered
[    2.083788] Asymmetric key parser 'x509' registered
[    2.089470] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
[    2.090576] io scheduler noop registered
[    2.092480] io scheduler cfq registered (default)
[    2.093186] io scheduler mq-deadline registered
[    2.104553] io scheduler kyber registered
[    2.105147] start plist test
[    2.107721] end plist test
[    2.109560] test_hexdump: all 1184 tests passed
[    2.110229] Running rhashtable test nelem=8, max_size=0, shrinking=0
[    2.111281] Test 00:
[    2.118530]   Adding 50000 keys
[    2.290227]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    2.387644]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    2.388892]   Deleting 50000 keys
[    2.468894]   Duration of test: 349883521 ns
[    2.469619] Test 01:
[    2.471272]   Adding 50000 keys
[    2.656403]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    2.762186]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    2.763275]   Deleting 50000 keys
[    2.833754]   Duration of test: 361971556 ns
[    2.834385] Test 02:
[    2.835954]   Adding 50000 keys
[    3.042493]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    3.166050]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    3.167281]   Deleting 50000 keys
[    3.235271]   Duration of test: 398892002 ns
[    3.235963] Test 03:
[    3.237793]   Adding 50000 keys
[    3.382997] tsc: Refined TSC clocksource calibration: 2693.506 MHz
[    3.383968] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x26d347b2dd9, max_idle_ns: 440795223616 ns
[    3.468487]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    3.586837]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    3.588057]   Deleting 50000 keys
[    3.655761]   Duration of test: 417476591 ns
[    3.656469] Average test time: 382055917
[    3.657029] Testing concurrent rhashtable access from 10 threads
[    7.517303] Started 10 threads, 0 failed
[    7.521144] test passed
[    7.569452] test_bitmap: all 460506 tests passed
[    7.570033] test_uuid: all 18 tests passed
[    7.572089] gpio_it87: no device
[    7.572669] gpio-mockup: probe of gpio-mockup failed with error -22
[    7.573722] switchtec: loaded.
[    7.574399] no IO addresses supplied
[    7.575016] intel_idle: does not run on family 6 model 6
[    7.575787] Warning: Processor Platform Limit event detected, but not handled.
[    7.576670] Consider compiling CPUfreq support into your kernel.
[    7.759692] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
[    7.798200] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[    7.823864] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[    7.849309] 00:06: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
[    7.851240] Applicom driver: $Id: ac.c,v 1.30 2000/03/22 16:03:57 dwmw2 Exp $
[    7.852119] ac.o: No PCI boards found.
[    7.852599] ac.o: For an ISA board you must supply memory and irq parameters.
[    7.853455] sonypi: Sony Programmable I/O Controller Driver v1.26.
[    7.854215] telclk_interrupt = 0xf non-mcpbl0010 hw.
[    7.854914] [drm] radeon kernel modesetting enabled.
[    7.855606] [drm] amdgpu kernel modesetting enabled.
[    7.856876] dummy-irq: no IRQ given.  Use irq=N
[    7.857479] Phantom Linux Driver, version n0.9.8, init OK
[    7.858876] eql: Equalizer2002: Simon Janes (simon@ncm.com) and David S. Miller (davem@redhat.com)
[    7.860172] MACsec IEEE 802.1AE
[    7.861277] libphy: Fixed MDIO Bus: probed
[    7.861948] CAN device driver interface
[    7.862553] ena: Elastic Network Adapter (ENA) v1.1.2
[    7.863371] bnx2x: QLogic 5771x/578xx 10/20-Gigabit Ethernet Driver bnx2x 1.712.30-0 (2014/02/10)
[    7.864643] vxge: Copyright(c) 2002-2010 Exar Corp.
[    7.865233] vxge: Driver version: 2.5.3.22640-k
[    7.865830] ixgbe: Intel(R) 10 Gigabit PCI Express Network Driver - version 5.0.0-k
[    7.866757] ixgbe: Copyright (c) 1999-2016 Intel Corporation.
[    7.867580] ixgbevf: Intel(R) 10 Gigabit PCI Express Virtual Function Network Driver - version 3.2.2-k
[    7.868696] ixgbevf: Copyright (c) 2009 - 2015 Intel Corporation.
[    7.870090] hdlc: HDLC support module revision 1.22
[    7.870738] DLCI driver v0.35, 4 Jan 1997, mike.mclagan@linux.org.
[    7.871620] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[    7.873436] serio: i8042 KBD port at 0x60,0x64 irq 1
[    7.874073] serio: i8042 AUX port at 0x60,0x64 irq 12
[    7.875756] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
[    7.876582] pps pps0: new PPS source ktimer
[    7.876585] pps pps0: ktimer PPS source registered
[    7.876621] Driver for 1-wire Dallas network protocol.
[    7.877609] intel_powerclamp: CPU does not support MWAIT
[    7.878515] ledtrig-cpu: registered to indicate activity on CPUs
[    7.878628] Driver for HIFN 795x crypto accelerator chip has been successfully registered.
[    7.882179] evbug: Connected device: input0 (AT Translated Set 2 keyboard at isa0060/serio0/input0)
[    7.905157] no UART detected at 0x1
[    7.906593] oprofile: using NMI interrupt.
[    7.907176] NET: Registered protocol family 17
[    7.907756] NET: Registered protocol family 4
[    7.908312] NET: Registered protocol family 9
[    7.908874] X25: Linux Version 0.2
[    7.909288] can: controller area network core (rev 20170425 abi 9)
[    7.910073] NET: Registered protocol family 29
[    7.910639] can: raw protocol (rev 20170425)
[    7.911166] can: netlink gateway (rev 20170425) max_hops=1
[    7.911867] Key type dns_resolver registered
[    7.912575] batman_adv: B.A.T.M.A.N. advanced 2017.1 (compatibility version 15) loaded
[    7.914365] ... APIC ID:      00000000 (0)
[    7.914872] ... APIC VERSION: 01050014
[    7.915326] 0000000000000000000000000000000000000000000000000000000000000000
[    7.916174] 0000000000000000000000000000000000000000000000000000000000000000
[    7.917024] 0000000000000000000000000000000000000000000000000000000000008000
[    7.917892] number of MP IRQ sources: 15.
[    7.918372] number of IO-APIC #0 registers: 24.
[    7.918935] testing the IO APIC.......................
[    7.919580] IO APIC #0......
[    7.919930] .... register #00: 00000000
[    7.920386] .......    : physical APIC id: 00
[    7.920918] .......    : Delivery Type: 0
[    7.921396] .......    : LTS          : 0
[    7.921888] .... register #01: 00170011
[    7.922351] .......     : max redirection entries: 17
[    7.922963] .......     : PRQ implemented: 0
[    7.923489] .......     : IO APIC version: 11
[    7.924009] .... register #02: 00000000
[    7.924471] .......     : arbitration: 00
[    7.924957] .... IRQ redirection table:
[    7.925423] IOAPIC 0:
[    7.925729]  pin00, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[    7.926677]  pin01, enabled , edge , high, V(31), IRR(0), S(0), logical , D(03), M(1)
[    7.927623]  pin02, enabled , edge , high, V(30), IRR(0), S(0), logical , D(03), M(1)
[    7.928568]  pin03, disabled, edge , high, V(33), IRR(0), S(0), logical , D(03), M(1)
[    7.929519]  pin04, disabled, edge , high, V(34), IRR(0), S(0), logical , D(03), M(1)
[    7.930453]  pin05, disabled, level, high, V(35), IRR(0), S(0), logical , D(03), M(1)
[    7.931388]  pin06, enabled , edge , high, V(36), IRR(0), S(0), logical , D(03), M(1)
[    7.932334]  pin07, enabled , edge , high, V(37), IRR(0), S(0), logical , D(03), M(1)
[    7.933280]  pin08, enabled , edge , high, V(38), IRR(0), S(0), logical , D(03), M(1)
[    7.934224]  pin09, disabled, level, high, V(39), IRR(0), S(0), logical , D(03), M(1)
[    7.935166]  pin0a, disabled, level, high, V(3A), IRR(0), S(0), logical , D(03), M(1)
[    7.936111]  pin0b, disabled, level, high, V(3B), IRR(0), S(0), logical , D(03), M(1)
[    7.937055]  pin0c, enabled , edge , high, V(3C), IRR(0), S(0), logical , D(03), M(1)
[    7.937999]  pin0d, enabled , edge , high, V(3D), IRR(0), S(0), logical , D(03), M(1)
[    7.938949]  pin0e, enabled , edge , high, V(3E), IRR(0), S(0), logical , D(03), M(1)
[    7.939894]  pin0f, enabled , edge , high, V(3F), IRR(0), S(0), logical , D(03), M(1)
[    7.940839]  pin10, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[    7.941782]  pin11, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[    7.942731]  pin12, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[    7.943676]  pin13, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[    7.944620]  pin14, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[    7.945571]  pin15, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[    7.946518]  pin16, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[    7.947460]  pin17, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[    7.948387] IRQ to pin mappings:
[    7.948796] IRQ0 -> 0:2
[    7.949100] IRQ1 -> 0:1
[    7.949400] IRQ3 -> 0:3
[    7.949720] IRQ4 -> 0:4
[    7.950024] IRQ5 -> 0:5
[    7.950326] IRQ6 -> 0:6
[    7.950645] IRQ7 -> 0:7
[    7.950950] IRQ8 -> 0:8
[    7.951249] IRQ9 -> 0:9
[    7.951567] IRQ10 -> 0:10
[    7.951890] IRQ11 -> 0:11
[    7.952213] IRQ12 -> 0:12
[    7.952551] IRQ13 -> 0:13
[    7.952871] IRQ14 -> 0:14
[    7.953190] IRQ15 -> 0:15
[    7.953530] .................................... done.
[    7.954141] Using IPI No-Shortcut mode
[    7.954894] Loading compiled-in X.509 certificates
[    7.955504] page_owner is disabled
[    7.956330] Btrfs loaded, crc32c=crc32c-generic, debug=on, integrity-checker=on
[    7.975984] Key type encrypted registered
[    7.981074] Unregister pv shared memory for cpu 0
[    7.984923] ------------[ cut here ]------------
[    7.985468] WARNING: CPU: 0 PID: 0 at arch/x86/mm/tlb.c:83 switch_mm_irqs_off+0x23/0x393
[    7.986572] Modules linked in:
[    7.986920] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 4.12.0-rc4-00017-gd52d163 #1
[    7.987754] task: 79fb4a40 task.stack: 79faa000
[    7.988257] EIP: switch_mm_irqs_off+0x23/0x393
[    7.988761] EFLAGS: 00010203 CPU: 0
[    7.989157] EAX: 00000202 EBX: 79fe5260 ECX: 00000000 EDX: 79e4aa05
[    7.989854] ESI: 8b0959c0 EDI: 79fe5498 EBP: 79fabf18 ESP: 79fabf08
[    7.990552]  DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[    7.991159] CR0: 80050033 CR2: 6f6f79c0 CR3: 0c453000 CR4: 00000690
[    7.991858] Call Trace:
[    7.992145]  idle_task_exit+0x45/0x55
[    7.992565]  play_dead_common+0x8/0x1a
[    7.992988]  native_play_dead+0xa/0xd2
[    7.993407]  arch_cpu_idle_dead+0x9/0xb
[    7.993847]  do_idle+0x42/0x166
[    7.994206]  cpu_startup_entry+0x56/0x58
[    7.994654]  rest_init+0x108/0x10d
[    7.995039]  start_kernel+0x3fe/0x406
[    7.995463]  i386_start_kernel+0x9a/0x9e
[    7.995902]  startup_32_smp+0x166/0x168
[    7.996333] Code: e5 e8 02 fd ff ff 5d c3 55 89 e5 57 56 53 51 89 d3 e8 fc e7 36 00 64 8b 35 00 04 17 7a 89 c1 9c 58 8d 74 26 00 0f ba e0 09 73 02 <0f> ff 39 de a1 5c 02 0c 7a 0f 85 3c 01 00 00 39 c1 8b 93 bc 01
[    7.998498] ---[ end trace 67c561e2f6b242ff ]---
[    8.004766] CPU 0 is now offline
[    8.005314] ALSA device list:
[    8.005764]   #0: Dummy 1
[    8.006149]   #1: Loopback 1
[    8.007582] Freeing unused kernel memory: 560K
[    8.008570] Write protecting the kernel text: 9740k
[    8.009963] Write protecting the kernel read-only data: 6296k
ifconfig: socket: Address family not supported by protocol
mkdir: can't create directory '/var/lock': No such file or directory
mkdir: can't create directory '/var/lock/lkp-bootstrap.lock': No such file or directory
sleep: invalid number '333.3'
/ # PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lkp/lkp/src/bin
LKP: HOSTNAME vm-ivb41-yocto-i386-14, MAC , kernel 4.12.0-rc4-00017-gd52d163 1, serial console /dev/ttyS0
[    9.050089] Kernel tests: Boot OK!
[    9.050089] LKP: waiting for network...
[   25.170606] random: fast init done
[   26.064809] ls /sys/class/net
[   26.064809] eql
[   26.064809] lo
[   26.064809] /lkp/lkp/src/bin/run-lkp
[   26.064809] RESULT_ROOT=/result/trinity/300s/vm-ivb41-yocto-i386/yocto-tiny-i386-2016-04-22.cgz/i386-randconfig-h1-06060528/gcc-6/d52d163f428136feb592f7546cb2333cfad775bf/0
[   26.064809] job=/lkp/scheduled/vm-ivb41-yocto-i386-14/trinity-300s-yocto-tiny-i386-2016-04-22.cgz-d52d163f428136feb592f7546cb2333cfad775bf-20170608-34093-192kerz-0.yaml
[   26.064809] run-job /lkp/scheduled/vm-ivb41-yocto-i386-14/trinity-300s-yocto-tiny-i386-2016-04-22.cgz-d52d163f428136feb592f7546cb2333cfad775bf-20170608-34093-192kerz-0.yaml
[   26.064809] skip http request: cgi-bin/lkp-jobfile-append-var?job_file=/lkp/scheduled/vm-ivb41-yocto-i386-14/trinity-300s-yocto-tiny-i386-2016-04-22.cgz-d52d163f428136feb592f7546cb2333cfad775bf-20170608-34093-192kerz-0.yaml&job_state=running -O /dev/null
[   36.866855] trinity-main uses obsolete (PF_INET,SOCK_PACKET)
[   36.958875] NET: Registered protocol family 5
[   37.068213] NET4: DECnet for Linux: V.2.5.68s (C) 1995-2003 Linux DECnet Project Team
[   37.069541] DECnet: Routing cache hash table of 256 buckets, 9Kbytes
[   37.072450] NET: Registered protocol family 12
[   37.107870] SCSI subsystem initialized
[   37.110088] Loading iSCSI transport class v2.0-870.
[   37.172163] PPP generic driver version 2.4.2
[   37.173296] NET: Registered protocol family 24
[   37.248004] can: broadcast manager protocol (rev 20170425 t)
[   37.341013] NET: Registered protocol family 35
[   37.484636] VFS: Warning: trinity-c1 using old stat() call. Recompile your binary.
[   37.507636] warning: process `trinity-c1' used the deprecated sysctl system call with 
[   37.632602] VFS: Warning: trinity-c2 using old stat() call. Recompile your binary.
[   37.656069] VFS: Warning: trinity-c0 using old stat() call. Recompile your binary.
[   38.371554] VFS: Warning: trinity-c0 using old stat() call. Recompile your binary.
[   38.817416] VFS: Warning: trinity-c2 using old stat() call. Recompile your binary.
[   41.272940] NET: Registered protocol family 15
[   64.029512] rcu-torture: rtc: 7a8f5840 ver: 1 tfle: 0 rta: 1 rtaf: 0 rtf: 0 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 1 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 cbflood: 1
[   64.034163] rcu-torture: Reader Pipe:  2 0 0 0 0 0 0 0 0 0 0
[   64.037861] rcu-torture: Reader Batch:  0 2 0 0 0 0 0 0 0 0 0
[   64.039597] rcu-torture: Free-Block Circulation:  0 0 0 0 0 0 0 0 0 0 0
[  128.163205] rcu-torture: rtc: 7a8f5840 ver: 1 tfle: 0 rta: 1 rtaf: 0 rtf: 0 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 1 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 cbflood: 1
[  128.167011] rcu-torture: Reader Pipe:  2 0 0 0 0 0 0 0 0 0 0
[  128.170407] rcu-torture: Reader Batch:  0 2 0 0 0 0 0 0 0 0 0
[  128.172066] rcu-torture: Free-Block Circulation:  0 0 0 0 0 0 0 0 0 0 0
[  128.173940] ??? Writer stall state RTWS_STUTTER(8) g5149 c5149 f0x2 ->state 0x1
[  128.175979] rcu_preempt: wait state: 1 ->state: 0x1
[  128.179457] rcu_sched: wait state: 1 ->state: 0x1
[  128.181856] rcu_bh: wait state: 1 ->state: 0x1
[  128.185480] Dumping ftrace buffer:
[  128.186035]    (ftrace buffer empty)
[  190.410146] rcu-torture: rtc: 7a8f5840 ver: 1 tfle: 0 rta: 1 rtaf: 0 rtf: 0 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 1 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 cbflood: 1
[  190.414821] rcu-torture: Reader Pipe:  2 0 0 0 0 0 0 0 0 0 0
[  190.418361] rcu-torture: Reader Batch:  0 2 0 0 0 0 0 0 0 0 0
[  190.422157] rcu-torture: Free-Block Circulation:  0 0 0 0 0 0 0 0 0 0 0
[  190.426159] ??? Writer stall state RTWS_STUTTER(8) g5307 c5307 f0x2 ->state 0x0
[  190.431156] rcu_preempt: wait state: 1 ->state: 0x1
[  190.431867] rcu_sched: wait state: 1 ->state: 0x1
[  190.436155] rcu_bh: wait state: 1 ->state: 0x1
[  252.688917] rcu-torture: rtc: 7a8f5840 ver: 1 tfle: 0 rta: 1 rtaf: 0 rtf: 0 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 1 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 cbflood: 1
[  252.694133] rcu-torture: Reader Pipe:  2 0 0 0 0 0 0 0 0 0 0
[  252.702219] rcu-torture: Reader Batch:  0 2 0 0 0 0 0 0 0 0 0
[  252.705003] rcu-torture: Free-Block Circulation:  0 0 0 0 0 0 0 0 0 0 0
[  252.707091] ??? Writer stall state RTWS_STUTTER(8) g5472 c5472 f0x2 ->state 0x1
[  252.710096] rcu_preempt: wait state: 1 ->state: 0x1
[  252.713606] rcu_sched: wait state: 1 ->state: 0x1
[  252.715066] rcu_bh: wait state: 1 ->state: 0x1
[  316.053125] rcu-torture: rtc: 7a8f5840 ver: 1 tfle: 0 rta: 1 rtaf: 0 rtf: 0 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 1 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 cbflood: 1
[  316.057620] rcu-torture: Reader Pipe:  2 0 0 0 0 0 0 0 0 0 0
[  316.061190] rcu-torture: Reader Batch:  0 2 0 0 0 0 0 0 0 0 0
[  316.062813] rcu-torture: Free-Block Circulation:  0 0 0 0 0 0 0 0 0 0 0
[  316.064780] ??? Writer stall state RTWS_STUTTER(8) g5628 c5628 f0x2 ->state 0x1
[  316.070401] rcu_preempt: wait state: 1 ->state: 0x1
[  316.071620] rcu_sched: wait state: 1 ->state: 0x1
[  316.073258] rcu_bh: wait state: 1 ->state: 0x1
[  329.324877] sysrq: SysRq : Emergency Sync
[  329.326385] sysrq: SysRq : Resetting
[  329.328321] Emergency Sync complete

Elapsed time: 330

initrds=(
	/osimage/yocto/yocto-tiny-i386-2016-04-22.cgz
	/lkp/scheduled/vm-ivb41-yocto-i386-14/trinity-300s-yocto-tiny-i386-2016-04-22.cgz-d52d163f428136feb592f7546cb2333cfad775bf-20170608-34093-192kerz-0.cgz
	/lkp/lkp/lkp-i386.cgz
	/osimage/deps/debian-x86_64-2016-08-31.cgz/run-ipconfig.i386_2016-09-03.cgz
	/osimage/pkg/static/trinity-i386.cgz
	/pkg/linux/i386-randconfig-h1-06060528/gcc-6/d52d163f428136feb592f7546cb2333cfad775bf/modules.cgz
)

cat "${initrds[@]}" > /fs/sda5/initrd-vm-ivb41-yocto-i386-14

kvm=(
	qemu-system-i386
	-enable-kvm
	-kernel /pkg/linux/i386-randconfig-h1-06060528/gcc-6/d52d163f428136feb592f7546cb2333cfad775bf/vmlinuz-4.12.0-rc4-00017-gd52d163
	-initrd /fs/sda5/initrd-vm-ivb41-yocto-i386-14
	-m 320
	-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=/fs/sda5/disk0-vm-ivb41-yocto-i386-14,media=disk,if=virtio
	-pidfile /dev/shm/kboot/pid-vm-ivb41-yocto-i386-14
	-serial file:/dev/shm/kboot/vm-ivb41-yocto-i386-14/serial
	-serial file:/dev/shm/kboot/vm-ivb41-yocto-i386-14/kmsg
	-daemonize
	-display none
	-monitor null
)

append=(
	ip=::::vm-ivb41-yocto-i386-14::dhcp
	root=/dev/ram0
	user=lkp
	job=/lkp/scheduled/vm-ivb41-yocto-i386-14/trinity-300s-yocto-tiny-i386-2016-04-22.cgz-d52d163f428136feb592f7546cb2333cfad775bf-20170608-34093-192kerz-0.yaml
	ARCH=i386
	kconfig=i386-randconfig-h1-06060528
	branch=luto/x86/pcid
	commit=d52d163f428136feb592f7546cb2333cfad775bf
	BOOT_IMAGE=/pkg/linux/i386-randconfig-h1-06060528/gcc-6/d52d163f428136feb592f7546cb2333cfad775bf/vmlinuz-4.12.0-rc4-00017-gd52d163
	max_uptime=1500
	RESULT_ROOT=/result/trinity/300s/vm-ivb41-yocto-i386/yocto-tiny-i386-2016-04-22.cgz/i386-randconfig-h1-06060528/gcc-6/d52d163f428136feb592f7546cb2333cfad775bf/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
	earlyprintk=ttyS0,115200
	console=ttyS0,115200
	console=tty0
	vga=normal
	rw
	drbd.minor_count=8
)

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