early console in setup code
Probing EDD (edd=off to disable)... ok
[    0.000000] Linux version 4.6.0-rc4-00032-gcc73660 (kbuild@cairo) (gcc version 6.1.1 20160430 (Debian 6.1.1-1) ) #2 SMP PREEMPT Thu May 26 17:58:54 CST 2016
[    0.000000] x86/fpu: Legacy x87 FPU detected.
[    0.000000] x86/fpu: Using 'eager' FPU context switches.
[    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-0x0000000013fdffff] usable
[    0.000000] BIOS-e820: [mem 0x0000000013fe0000-0x0000000013ffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[    0.000000] Notice: NX (Execute Disable) protection missing in CPU!
[    0.000000] Hypervisor detected: KVM
[    0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.000000] e820: last_pfn = 0x13fe0 max_arch_pfn = 0x100000
[    0.000000] MTRR: Disabled
[    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 0x000f6620-0x000f662f] mapped at [c00f6620]
[    0.000000]   mpc: f6630-f671c
[    0.000000] Scanning 1 areas for low memory corruption
[    0.000000] initial memory mapped: [mem 0x00000000-0x03ffffff]
[    0.000000] Base memory trampoline at [c009b000] 9b000 size 16384
[    0.000000] BRK [0x03ae3000, 0x03ae3fff] PGTABLE
[    0.000000] RAMDISK: [mem 0x13a99000-0x13fdffff]
[    0.000000] ACPI: Early table checksum verification disabled
[    0.000000] ACPI: RSDP 0x00000000000F6410 000014 (v00 BOCHS )
[    0.000000] ACPI: RSDT 0x0000000013FE1737 000034 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACP 0x0000000013FE0C14 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.000000] ACPI: DSDT 0x0000000013FE0040 000BD4 (v01 BOCHS  BXPCDSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACS 0x0000000013FE0000 000040
[    0.000000] ACPI: SSDT 0x0000000013FE0C88 0009F7 (v01 BOCHS  BXPCSSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: APIC 0x0000000013FE167F 000080 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.000000] ACPI: HPET 0x0000000013FE16FF 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 - 13fe0000
[    0.000000]   low ram: 0 - 13fe0000
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000000] kvm-clock: cpu 0, msr 0:13a98001, primary cpu clock
[    0.000000] kvm-clock: using sched offset of 10326444194 cycles
[    0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[    0.000000] BRK [0x03ae4000, 0x03ae4fff] PGTABLE
[    0.000000] Zone ranges:
[    0.000000]   Normal   [mem 0x0000000000001000-0x0000000013fdffff]
[    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-0x0000000013fdffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000013fdffff]
[    0.000000] On node 0 totalpages: 81790
[    0.000000] free_area_init_node: node 0, pgdat c283edc0, node_mem_map d3818020
[    0.000000]   Normal zone: 640 pages used for memmap
[    0.000000]   Normal zone: 0 pages reserved
[    0.000000]   Normal zone: 81790 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] mapped APIC to         ffffc000 (        fee00000)
[    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] 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: 19112604462750000 ns
[    0.000000] setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:2 nr_node_ids:1
[    0.000000] percpu: Embedded 334 pages/cpu @d3573000 s1347280 r0 d20784 u1368064
[    0.000000] pcpu-alloc: s1347280 r0 d20784 u1368064 alloc=334*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 13575ac0
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 81150
[    0.000000] Kernel command line: root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-kbuild-yocto-i386-27/bisect_boot-1-yocto-minimal-i386.cgz-i386-randconfig-b0-05261412-cc736607c86d39ea078519af0de6ee0fbf3096a6-20160526-98636-1416dgc-0.yaml ARCH=i386 kconfig=i386-randconfig-b0-05261412 branch=linux-devel/devel-spot-201605261344 commit=cc736607c86d39ea078519af0de6ee0fbf3096a6 BOOT_IMAGE=/pkg/linux/i386-randconfig-b0-05261412/gcc-6/cc736607c86d39ea078519af0de6ee0fbf3096a6/vmlinuz-4.6.0-rc4-00032-gcc73660 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-kbuild-yocto-i386/yocto-minimal-i386.cgz/i386-randconfig-b0-05261412/gcc-6/cc736607c86d39ea078519af0de6ee0fbf3096a6/0 LKP_SERVER=inn earlyprintk=ttyS0,115200 systemd.log_level=err debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal rw ip=::::vm-kbuild-yocto-i386-27::dhcp drbd.minor_count=8
[    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] allocated 4311372 bytes of page_ext
[    0.000000] Initializing HighMem for node 0 (00000000:00000000)
[    0.000000] Memory: 267872K/327160K available (17008K kernel code, 1593K rwdata, 6444K rodata, 1896K init, 16860K bss, 59288K reserved, 0K cma-reserved, 0K highmem)
[    0.000000] virtual kernel memory layout:
[    0.000000]     fixmap  : 0xffe6e000 - 0xfffff000   (1604 kB)
[    0.000000]     pkmap   : 0xff800000 - 0xffc00000   (4096 kB)
[    0.000000]     vmalloc : 0xd47e0000 - 0xff7fe000   ( 688 MB)
[    0.000000]     lowmem  : 0xc0000000 - 0xd3fe0000   ( 319 MB)
[    0.000000]       .init : 0xc2879000 - 0xc2a53000   (1896 kB)
[    0.000000]       .data : 0xc209c72c - 0xc2877640   (8043 kB)
[    0.000000]       .text : 0xc1000000 - 0xc209c72c   (17009 kB)
[    0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[    0.000000] Running RCU self tests
[    0.000000] Preemptible hierarchical RCU implementation.
[    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=32, nr_cpu_ids=2
[    0.000000] NR_IRQS:2304 nr_irqs:440 16
[    0.000000] CPU 0 irqstacks, hard=c0090000 soft=c0092000
[    0.000000] console [ttyS0] enabled
[    0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[    0.000000] ... MAX_LOCKDEP_SUBCLASSES:  8
[    0.000000] ... MAX_LOCK_DEPTH:          48
[    0.000000] ... MAX_LOCKDEP_KEYS:        8191
[    0.000000] ... CLASSHASH_SIZE:          4096
[    0.000000] ... MAX_LOCKDEP_ENTRIES:     32768
[    0.000000] ... MAX_LOCKDEP_CHAINS:      65536
[    0.000000] ... CHAINHASH_SIZE:          32768
[    0.000000]  memory used by lock dependency info: 5167 kB
[    0.000000]  per task-struct memory footprint: 2112 bytes
[    0.000000] ------------------------
[    0.000000] | Locking API testsuite:
[    0.000000] ----------------------------------------------------------------------------
[    0.000000]                                  | spin |wlock |rlock |mutex | wsem | rsem |
[    0.000000]   --------------------------------------------------------------------------
[    0.000000]                      A-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.000000]                  A-B-B-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.000000]              A-B-B-C-C-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.000000]              A-B-C-A-B-C deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.000000]          A-B-B-C-C-D-D-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.000000]          A-B-C-D-B-D-D-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.000000]          A-B-C-D-B-C-D-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.000000]                     double unlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.000000]                   initialize held:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.000000]                  bad unlock order:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.000000]   --------------------------------------------------------------------------
[    0.000000]               recursive read-lock:             |  ok  |             |  ok  |
[    0.000000]            recursive read-lock #2:             |  ok  |             |  ok  |
[    0.000000]             mixed read-write-lock:             |  ok  |             |  ok  |
[    0.000000]             mixed write-read-lock:             |  ok  |             |  ok  |
[    0.000000]   --------------------------------------------------------------------------
[    0.000000]      hard-irqs-on + irq-safe-A/12:  ok  |  ok  |  ok  |
[    0.000000]      soft-irqs-on + irq-safe-A/12:  ok  |  ok  |  ok  |
[    0.000000]      hard-irqs-on + irq-safe-A/21:  ok  |  ok  |  ok  |
[    0.000000]      soft-irqs-on + irq-safe-A/21:  ok  |  ok  |  ok  |
[    0.000000]        sirq-safe-A => hirqs-on/12:  ok  |  ok  |  ok  |
[    0.000000]        sirq-safe-A => hirqs-on/21:  ok  |  ok  |  ok  |
[    0.000000]          hard-safe-A + irqs-on/12:  ok  |  ok  |  ok  |
[    0.000000]          soft-safe-A + irqs-on/12:  ok  |  ok  |  ok  |
[    0.000000]          hard-safe-A + irqs-on/21:  ok  |  ok  |  ok  |
[    0.000000]          soft-safe-A + irqs-on/21:  ok  |  ok  |  ok  |
[    0.000000]     hard-safe-A + unsafe-B #1/123:  ok  |  ok  |  ok  |
[    0.000000]     soft-safe-A + unsafe-B #1/123:  ok  |  ok  |  ok  |
[    0.000000]     hard-safe-A + unsafe-B #1/132:  ok  |  ok  |  ok  |
[    0.000000]     soft-safe-A + unsafe-B #1/132:  ok  |  ok  |  ok  |
[    0.000000]     hard-safe-A + unsafe-B #1/213:  ok  |  ok  |  ok  |
[    0.000000]     soft-safe-A + unsafe-B #1/213:  ok  |  ok  |  ok  |
[    0.000000]     hard-safe-A + unsafe-B #1/231:  ok  |  ok  |  ok  |
[    0.000000]     soft-safe-A + unsafe-B #1/231:  ok  |  ok  |  ok  |
[    0.000000]     hard-safe-A + unsafe-B #1/312:  ok  |  ok  |  ok  |
[    0.000000]     soft-safe-A + unsafe-B #1/312:  ok  |  ok  |  ok  |
[    0.000000]     hard-safe-A + unsafe-B #1/321:  ok  |  ok  |  ok  |
[    0.000000]     soft-safe-A + unsafe-B #1/321:  ok  |  ok  |  ok  |
[    0.000000]     hard-safe-A + unsafe-B #2/123:  ok  |  ok  |  ok  |
[    0.000000]     soft-safe-A + unsafe-B #2/123:  ok  |  ok  |  ok  |
[    0.000000]     hard-safe-A + unsafe-B #2/132:  ok  |  ok  |  ok  |
[    0.000000]     soft-safe-A + unsafe-B #2/132:  ok  |  ok  |  ok  |
[    0.000000]     hard-safe-A + unsafe-B #2/213:  ok  |  ok  |  ok  |
[    0.000000]     soft-safe-A + unsafe-B #2/213:  ok  |  ok  |  ok  |
[    0.000000]     hard-safe-A + unsafe-B #2/231:  ok  |  ok  |  ok  |
[    0.000000]     soft-safe-A + unsafe-B #2/231:  ok  |  ok  |  ok  |
[    0.000000]     hard-safe-A + unsafe-B #2/312:  ok  |  ok  |  ok  |
[    0.000000]     soft-safe-A + unsafe-B #2/312:  ok  |  ok  |  ok  |
[    0.000000]     hard-safe-A + unsafe-B #2/321:  ok  |  ok  |  ok  |
[    0.000000]     soft-safe-A + unsafe-B #2/321:  ok  |  ok  |  ok  |
[    0.000000]       hard-irq lock-inversion/123:  ok  |  ok  |  ok  |
[    0.000000]       soft-irq lock-inversion/123:  ok  |  ok  |  ok  |
[    0.000000]       hard-irq lock-inversion/132:  ok  |  ok  |  ok  |
[    0.000000]       soft-irq lock-inversion/132:  ok  |  ok  |  ok  |
[    0.000000]       hard-irq lock-inversion/213:  ok  |  ok  |  ok  |
[    0.000000]       soft-irq lock-inversion/213:  ok  |  ok  |  ok  |
[    0.000000]       hard-irq lock-inversion/231:  ok  |  ok  |  ok  |
[    0.000000]       soft-irq lock-inversion/231:  ok  |  ok  |  ok  |
[    0.000000]       hard-irq lock-inversion/312:  ok  |  ok  |  ok  |
[    0.000000]       soft-irq lock-inversion/312:  ok  |  ok  |  ok  |
[    0.000000]       hard-irq lock-inversion/321:  ok  |  ok  |  ok  |
[    0.000000]       soft-irq lock-inversion/321:  ok  |  ok  |  ok  |
[    0.000000]       hard-irq read-recursion/123:  ok  |
[    0.000000]       soft-irq read-recursion/123:  ok  |
[    0.000000]       hard-irq read-recursion/132:  ok  |
[    0.000000]       soft-irq read-recursion/132:  ok  |
[    0.000000]       hard-irq read-recursion/213:  ok  |
[    0.000000]       soft-irq read-recursion/213:  ok  |
[    0.000000]       hard-irq read-recursion/231:  ok  |
[    0.000000]       soft-irq read-recursion/231:  ok  |
[    0.000000]       hard-irq read-recursion/312:  ok  |
[    0.000000]       soft-irq read-recursion/312:  ok  |
[    0.000000]       hard-irq read-recursion/321:  ok  |
[    0.000000]       soft-irq read-recursion/321:  ok  |
[    0.000000]   --------------------------------------------------------------------------
[    0.000000]   | Wound/wait tests |
[    0.000000]   ---------------------
[    0.000000]                   ww api failures:  ok  |  ok  |  ok  |
[    0.000000]                ww contexts mixing:  ok  |  ok  |
[    0.000000]              finishing ww context:  ok  |  ok  |  ok  |  ok  |
[    0.000000]                locking mismatches:  ok  |  ok  |  ok  |
[    0.000000]                  EDEADLK handling:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.000000]            spinlock nest unlocked:  ok  |
[    0.000000]   -----------------------------------------------------
[    0.000000]                                  |block | try  |context|
[    0.000000]   -----------------------------------------------------
[    0.000000]                           context:  ok  |  ok  |  ok  |
[    0.000000]                               try:  ok  |  ok  |  ok  |
[    0.000000]                             block:  ok  |  ok  |  ok  |
[    0.000000]                          spinlock:  ok  |  ok  |  ok  |
[    0.000000] -------------------------------------------------------
[    0.000000] Good, all 253 testcases passed! |
[    0.000000] ---------------------------------
[    0.000000] ODEBUG: selftest passed
[    0.000000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
[    0.000000] hpet clockevent registered
[    0.000000] tsc: Detected 2693.510 MHz processor
[    1.253609] Calibrating delay loop (skipped) preset value.. 5387.02 BogoMIPS (lpj=26935100)
[    1.254603] pid_max: default: 32768 minimum: 301
[    1.255161] ACPI: Core revision 20160108
[    1.277066] ACPI: 2 ACPI AML tables successfully acquired and loaded
[    1.277977] 
[    1.278242] Security Framework initialized
[    1.278839] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    1.283370] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    1.285615] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    1.286396] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[    1.299842] Freeing SMP alternatives memory: 36K (c2a53000 - c2a5c000)
[    1.306141] smpboot: Max logical packages: 2
[    1.306664] smpboot: APIC(0) Converting physical 0 to logical package 0
[    1.307451] smpboot: APIC(1) Converting physical 1 to logical package 1
[    1.308234] Enabling APIC mode:  Flat.  Using 1 I/O APICs
[    1.308944] enabled ExtINT on CPU#0
[    1.319456] ENABLING IO-APIC IRQs
[    1.319974] init IO_APIC IRQs
[    1.320400]  apic 0 pin 0 not connected
[    1.321006] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1)
[    1.322108] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1)
[    1.323184] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1)
[    1.324257] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1)
[    1.325336] IOAPIC[0]: Set routing entry (0-5 -> 0x35 -> IRQ 5 Mode:1 Active:0 Dest:1)
[    1.326412] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1)
[    1.327480] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1)
[    1.338366] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1)
[    1.339473] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:1)
[    1.340579] IOAPIC[0]: Set routing entry (0-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:1)
[    1.341746] IOAPIC[0]: Set routing entry (0-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:1)
[    1.342918] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1)
[    1.344091] IOAPIC[0]: Set routing entry (0-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:1)
[    1.345289] IOAPIC[0]: Set routing entry (0-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:1)
[    1.346481] IOAPIC[0]: Set routing entry (0-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:1)
[    1.347691]  apic 0 pin 16 not connected
[    1.348248]  apic 0 pin 17 not connected
[    1.348794]  apic 0 pin 18 not connected
[    1.359358]  apic 0 pin 19 not connected
[    1.359831]  apic 0 pin 20 not connected
[    1.360293]  apic 0 pin 21 not connected
[    1.360752]  apic 0 pin 22 not connected
[    1.361218]  apic 0 pin 23 not connected
[    1.361844] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    1.363030] Using local APIC timer interrupts.
[    1.363030] calibrating APIC timer ...
[    1.539122] ... lapic delta = 8124355
[    1.539829] ... PM-Timer delta = 465303
[    1.540523] APIC calibration not consistent with PM-Timer: 129ms instead of 100ms
[    1.541910] APIC delta adjusted to PM-Timer: 6250003 (8124355)
[    1.543005] TSC delta adjusted to PM-Timer: 269350981 (350128284)
[    1.562256] ..... delta 6250003
[    1.562937] ..... mult: 268435584
[    1.563656] ..... calibration result: 10000004
[    1.564608] ..... CPU clock speed is 2693.5098 MHz.
[    1.569215] ..... host bus clock speed is 1000.0004 MHz.
[    1.570576] smpboot: CPU0: Intel QEMU Virtual CPU version 2.4.0 (family: 0x6, model: 0x6, stepping: 0x3)
[    1.580207] Performance Events: Broken PMU hardware detected, using software events only.
[    1.625525] CPU 1 irqstacks, hard=c0112000 soft=c0114000
[    1.643969] x86: Booting SMP configuration:
[    1.644880] .... node  #0, CPUs:      #1
[1266874879.383107] Initializing CPU#1
[    1.659422] kvm-clock: cpu 1, msr 0:13a98021, secondary cpu clock
[    1.660471] masked ExtINT on CPU#1
[    1.700935] KVM setup async PF for cpu 1
[    1.701398] kvm-stealtime: cpu 1, msr 136c3ac0
[    1.701956] x86: Booted up 1 node, 2 CPUs
[    1.702483] smpboot: Total of 2 processors activated (10774.04 BogoMIPS)
[    1.723340] devtmpfs: initialized
[    1.733063] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    1.734732] atomic64_test: passed for i386+ platform with CX8 and with SSE
[    1.741511] regulator-dummy: no parameters
[    1.742271] RTC time: 18:00:48, date: 05/26/16
[    1.743366] NET: Registered protocol family 16
[    1.770639] cpuidle: using governor ladder
[    1.778906] ACPI: bus type PCI registered
[    1.779844] PCI: Using configuration type 1 for base access
[    2.001323] HugeTLB registered 4 MB page size, pre-allocated 0 pages
[    2.003172] ACPI: Added _OSI(Module Device)
[    2.003707] ACPI: Added _OSI(Processor Device)
[    2.004262] ACPI: Added _OSI(3.0 _SCP Extensions)
[    2.004861] ACPI: Added _OSI(Processor Aggregator Device)
[    2.012569] ACPI: Interpreter enabled
[    2.013124] ACPI: (supports S0 S3 S5)
[    2.013589] ACPI: Using IOAPIC for interrupt routing
[    2.014323] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    2.083985] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    2.084782] acpi PNP0A03:00: _OSC: OS supports [Segments MSI]
[    2.085602] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[    2.086502] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
[    2.088382] PCI host bridge to bus 0000:00
[    2.088918] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
[    2.109835] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
[    2.110745] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[    2.111761] pci_bus 0000:00: root bus resource [mem 0x14000000-0xfebfffff window]
[    2.112746] pci_bus 0000:00: root bus resource [bus 00-ff]
[    2.113566] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[    2.115614] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[    2.117546] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[    2.143409] pci 0000:00:01.1: reg 0x20: [io  0xc080-0xc08f]
[    2.146301] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
[    2.147299] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
[    2.148129] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
[    2.170085] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
[    2.171739] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[    2.172991] pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI
[    2.173905] pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB
[    2.175583] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
[    2.188515] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
[    2.199305] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff]
[    2.218219] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[    2.241219] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[    2.243622] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff]
[    2.245835] pci 0000:00:03.0: reg 0x14: [io  0xc000-0xc03f]
[    2.274307] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
[    2.276092] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000
[    2.278254] pci 0000:00:04.0: reg 0x10: [io  0xc040-0xc07f]
[    2.301122] pci 0000:00:04.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff]
[    2.321817] pci 0000:00:05.0: [8086:25ab] type 00 class 0x088000
[    2.331558] pci 0000:00:05.0: reg 0x10: [mem 0xfebf2000-0xfebf200f]
[    2.345955] pci_bus 0000:00: on NUMA node 0
[    2.348837] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[    2.370994] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[    2.372243] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[    2.373641] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[    2.374698] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
[    2.376975] ACPI: Enabled 16 GPEs in block 00 to 0F
[    2.432140] ACPI: bus type USB registered
[    2.432853] usbcore: registered new interface driver usbfs
[    2.433632] usbcore: registered new interface driver hub
[    2.434425] usbcore: registered new device driver usb
[    2.435553] media: Linux media interface: v0.10
[    2.441351] Linux video capture interface: v2.00
[    2.442109] pps_core: LinuxPPS API ver. 1 registered
[    2.442788] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    2.444018] PTP clock support registered
[    2.444598] EDAC MC: Ver: 3.0.0
[    2.486962] Unable to find dmi tokens
[    2.487524] wmi: Mapper loaded
[    2.488292] Advanced Linux Sound Architecture Driver Initialized.
[    2.489190] PCI: Using ACPI for IRQ routing
[    2.489715] PCI: pci_cache_line_size set to 32 bytes
[    2.490595] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[    2.491422] e820: reserve RAM buffer [mem 0x13fe0000-0x13ffffff]
[    2.508732] workqueue: round-robin CPU selection forced, expect performance impact
[    2.510014] NetLabel: Initializing
[    2.510416] NetLabel:  domain hash size = 128
[    2.510940] NetLabel:  protocols = UNLABELED CIPSOv4
[    2.511579] NetLabel:  unlabeled traffic allowed by default
[    2.529987] nfc: nfc_init: NFC Core ver 0.1
[    2.530648] NET: Registered protocol family 39
[    2.545537] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
[    2.577850] clocksource: Switched to clocksource kvm-clock
[    2.578870] VFS: Disk quotas dquot_6.6.0
[    2.579463] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    2.580762] FS-Cache: Loaded
[    2.581527] pnp: PnP ACPI init
[    2.582339] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
[    2.583499] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
[    2.584589] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
[    2.585607] pnp 00:03: [dma 2]
[    2.586278] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
[    2.587365] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active)
[    2.588444] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
[    2.610356] pnp: PnP ACPI: found 6 devices
[    2.647585] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[    2.648931] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
[    2.649725] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
[    2.670616] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
[    2.671606] pci_bus 0000:00: resource 7 [mem 0x14000000-0xfebfffff window]
[    2.672634] NET: Registered protocol family 2
[    2.699202] TCP established hash table entries: 4096 (order: 2, 16384 bytes)
[    2.700147] TCP bind hash table entries: 4096 (order: 5, 180224 bytes)
[    2.701292] TCP: Hash tables configured (established 4096 bind 4096)
[    2.702145] UDP hash table entries: 256 (order: 2, 24576 bytes)
[    2.702950] UDP-Lite hash table entries: 256 (order: 2, 24576 bytes)
[    2.704046] NET: Registered protocol family 1
[    2.704633] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[    2.705400] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[    2.706164] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[    2.707003] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[    2.726168] PCI: CLS 0 bytes, default 32
[    2.727049] Unpacking initramfs...
[    4.684950] Freeing initrd memory: 5404K (d3a99000 - d3fe0000)
[    4.686622] sta2x11_mfd_init
[    4.709821] has_svm: not amd
[    4.710261] kvm: no hardware support
[    4.716368] apm: BIOS version 1.2 Flags 0x03 (Driver version 1.16ac)
[    4.717218] apm: disabled - APM is not SMP safe.
[    4.717979] Scanning for low memory corruption every 60 seconds
[    4.741503] PCLMULQDQ-NI instructions are not detected.
[    4.742239] The force parameter has not been set to 1. The Iris poweroff handler will not be installed.
[    4.743483] NatSemi SCx200 Driver
[    4.744085] spin_lock-torture:--- Start of test [debug]: nwriters_stress=4 nreaders_stress=0 stat_interval=60 verbose=1 shuffle_interval=3 stutter=5 shutdown_secs=0 onoff_interval=0 onoff_holdoff=0
[    4.758594] spin_lock-torture: Creating torture_shuffle task
[    4.759527] spin_lock-torture: Creating torture_stutter task
[    4.760353] spin_lock-torture: torture_shuffle task started
[    4.761176] spin_lock-torture: Creating lock_torture_writer task
[    4.762110] spin_lock-torture: torture_stutter task started
[    4.762937] spin_lock-torture: Creating lock_torture_writer task
[    4.763822] spin_lock-torture: lock_torture_writer task started
[    4.771346] spin_lock-torture: Creating lock_torture_writer task
[    4.772201] spin_lock-torture: lock_torture_writer task started
[    4.773019] spin_lock-torture: Creating lock_torture_writer task
[    4.773863] spin_lock-torture: lock_torture_writer task started
[    4.774682] spin_lock-torture: Creating lock_torture_stats task
[    4.775502] spin_lock-torture: lock_torture_writer task started
[    4.781400] torture_init_begin: refusing rcu init: spin_lock running
[    4.783674] futex hash table entries: 512 (order: 3, 32768 bytes)
[    4.784526] audit: initializing netlink subsys (disabled)
[    4.785268] audit: type=2000 audit(1464256849.622:1): initialized
[    4.785787] spin_lock-torture: lock_torture_stats task started
[    4.837581] workingset: timestamp_bits=28 max_order=17 bucket_order=0
[    4.838429] zbud: loaded
[    4.841356] DLM installed
[    4.856017] romfs: ROMFS MTD (C) 2007 Red Hat, Inc.
[    4.856915] fuse init (API version 7.24)
[    4.863895] orangefs_init: called with debug mask: :none: :0:
[    4.864890] orangefs: module version upstream loaded
[    4.877760] NET: Registered protocol family 38
[    4.878438] Key type asymmetric registered
[    4.901148] test_firmware: interface ready
[    4.901781] Running rhashtable test nelem=8, max_size=0, shrinking=0
[    4.902617] Test 00:
[    4.903988]   Adding 50000 keys
[    5.467556]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    5.729879] tsc: Refined TSC clocksource calibration: 2693.510 MHz
[    5.730700] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x26d34b60feb, max_idle_ns: 440795225049 ns
[    5.908218]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    5.909408]   Deleting 50000 keys
[    6.203428]   Duration of test: 1299011697 ns
[    6.204148] Test 01:
[    6.205515]   Adding 50000 keys
[    6.928321]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    7.373441]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    7.374526]   Deleting 50000 keys
[    7.660729]   Duration of test: 1454777088 ns
[    7.661552] Test 02:
[    7.662975]   Adding 50000 keys
[    8.076061] Info: encountered resize
[    8.127973]   Traversal complete: counted=55649, nelems=50000, entries=50000, table-jumps=1
[    8.128955] Test failed: Total count mismatch ^^^
[    8.512448]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    8.513628]   Deleting 50000 keys
[    8.732973]   Duration of test: 1069551622 ns
[    8.733576] Test 03:
[    8.734882]   Adding 50000 keys
[    9.301071]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    9.704779]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    9.706681]   Deleting 50000 keys
[    9.938389]   Duration of test: 1203134533 ns
[    9.939109] Average test time: 1256618735
[    9.939638] Testing concurrent rhashtable access from 10 threads
[   24.437830] Started 10 threads, 0 failed
[   24.441082] test_printf: all 260 tests passed
[   24.470847] crc32: CRC_LE_BITS = 1, CRC_BE BITS = 1
[   24.471465] crc32: self tests passed, processed 225944 bytes in 2398916 nsec
[   24.482609] crc32c: CRC_LE_BITS = 1
[   24.483040] crc32c: self tests passed, processed 225944 bytes in 8917150 nsec
[   24.956888] crc32_combine: 8373 self tests passed
[   25.431839] crc32c_combine: 8373 self tests passed
[   25.433696] rbtree testing -> 28301 cycles
[   26.544836] augmented rbtree testing -> 42740 cycles
[   28.246337] ------------[ cut here ]------------
[   28.246942] kernel BUG at drivers/base/driver.c:153!
[   28.247784] invalid opcode: 0000 [#1] PREEMPT SMP 
[   28.248433] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.6.0-rc4-00032-gcc73660 #2
[   28.249361] task: c0030000 ti: c0032000 task.ti: c0032000
[   28.250038] EIP: 0060:[<c1755cfa>] EFLAGS: 00010246 CPU: 0
[   28.250738] EIP is at driver_register+0xa/0xe0
[   28.280022] EAX: c272a298 EBX: 00000000 ECX: 00000000 EDX: c276a800
[   28.280780] ESI: c272a280 EDI: 00000000 EBP: c0033f14 ESP: c0033eec
[   28.281620]  DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068
[   28.282282] CR0: 80050033 CR2: 00000000 CR3: 02a5f000 CR4: 00000690
[   28.283045] Stack:
[   28.283298]  c176aca6 000e3f00 d0d4b000 00000286 d0d4b000 d3818000 00000000 c28a143b
[   28.284428]  d0d4b308 00000000 c0033f1c c28a144e c0033f78 c2879b8e c10ab791 00000000
[   28.285512]  00000000 c0033f38 c10d7aab c0033f48 00060006 00000000 c26e1b34 c259e774
[   28.296719] Call Trace:
[   28.297044]  [<c176aca6>] ? isa_register_driver+0x26/0x150
[   28.297840]  [<c28a143b>] ? wm8994_gpio_init+0x11/0x11
[   28.298463]  [<c28a144e>] ws16c48_driver_init+0x13/0x15
[   28.299105]  [<c2879b8e>] do_one_initcall+0xdf/0x174
[   28.299704]  [<c10ab791>] ? parse_args+0x331/0x540
[   28.300291]  [<c10d7aab>] ? trace_hardirqs_on+0xb/0x10
[   28.300915]  [<c2879d8c>] ? kernel_init_freeable+0x169/0x208
[   28.311797]  [<c2879da5>] kernel_init_freeable+0x182/0x208
[   28.312479]  [<c2093f2b>] kernel_init+0xb/0x120
[   28.313052]  [<c10b4f9c>] ? schedule_tail+0xc/0x90
[   28.313669]  [<c209ac91>] ret_from_kernel_thread+0x21/0x40
[   28.314359]  [<c2093f20>] ? rest_init+0x110/0x110
[   28.314951] Code: b9 ff 8b 43 70 eb 0c 8d 76 00 8d bc 27 00 00 00 00 31 c0 5b 5d c3 8d 74 26 00 8d bc 27 00 00 00 00 8b 50 04 8b 4a 48 85 c9 75 06 <0f> 0b 8d 74 26 00 55 89 e5 56 53 83 ec 08 89 c3 8b 42 24 85 c0
[   28.328199] EIP: [<c1755cfa>] driver_register+0xa/0xe0 SS:ESP 0068:c0033eec
[   28.329049] ---[ end trace 4ee2a401683f9ad5 ]---
[   28.329576] Kernel panic - not syncing: Fatal exception
[   28.341319] Kernel Offset: disabled

Elapsed time: 40
qemu-system-i386 -enable-kvm -kernel /pkg/linux/i386-randconfig-b0-05261412/gcc-6/cc736607c86d39ea078519af0de6ee0fbf3096a6/vmlinuz-4.6.0-rc4-00032-gcc73660 -append 'root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-kbuild-yocto-i386-27/bisect_boot-1-yocto-minimal-i386.cgz-i386-randconfig-b0-05261412-cc736607c86d39ea078519af0de6ee0fbf3096a6-20160526-98636-1416dgc-0.yaml ARCH=i386 kconfig=i386-randconfig-b0-05261412 branch=linux-devel/devel-spot-201605261344 commit=cc736607c86d39ea078519af0de6ee0fbf3096a6 BOOT_IMAGE=/pkg/linux/i386-randconfig-b0-05261412/gcc-6/cc736607c86d39ea078519af0de6ee0fbf3096a6/vmlinuz-4.6.0-rc4-00032-gcc73660 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-kbuild-yocto-i386/yocto-minimal-i386.cgz/i386-randconfig-b0-05261412/gcc-6/cc736607c86d39ea078519af0de6ee0fbf3096a6/0 LKP_SERVER=inn earlyprintk=ttyS0,115200 systemd.log_level=err debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal rw ip=::::vm-kbuild-yocto-i386-27::dhcp drbd.minor_count=8'  -initrd /fs/sde1/initrd-vm-kbuild-yocto-i386-27 -m 320 -smp 2 -device e1000,netdev=net0 -netdev user,id=net0 -boot order=nc -no-reboot -watchdog i6300esb -rtc base=localtime -drive file=/fs/sde1/disk0-vm-kbuild-yocto-i386-27,media=disk,if=virtio -pidfile /dev/shm/kboot/pid-vm-kbuild-yocto-i386-27 -serial file:/dev/shm/kboot/serial-vm-kbuild-yocto-i386-27 -daemonize -display none -monitor null 
