All of lore.kernel.org
 help / color / mirror / Atom feed
* [x86, irq] INFO: task swapper/0:1 blocked for more than 120 seconds.
@ 2014-11-13 12:39 ` Fengguang Wu
  0 siblings, 0 replies; 7+ messages in thread
From: Fengguang Wu @ 2014-11-13 12:39 UTC (permalink / raw)
  To: lkp

[-- Attachment #1: Type: text/plain, Size: 5419 bytes --]

Hi Jiang,

0day kernel testing robot got the below dmesg and the first bad commit is

https://github.com/jiangliu/linux.git irqdomain/p4v2

commit b8c2d075135a41f69254a75c4f26162559503ab4
Author:     Jiang Liu <jiang.liu@linux.intel.com>
AuthorDate: Sun Nov 2 22:16:02 2014 +0800
Commit:     Jiang Liu <jiang.liu@linux.intel.com>
CommitDate: Tue Nov 11 21:10:49 2014 +0800

    x86, irq: Use cached IOAPIC entry instead of reading from hardware
    
    Use cahced IOAPIC entry instead of reading data from IOAPIC hardware
    registers to improve performance.
    
    Signed-off-by: Jiang Liu <jiang.liu@linux.intel.com>

+--------------------------------------------------+------------+------------+------------+
|                                                  | 384c30d19a | b8c2d07513 | 349d0daa5e |
+--------------------------------------------------+------------+------------+------------+
| boot_successes                                   | 1000       | 34         | 10         |
| boot_failures                                    | 0          | 31         | 15         |
| BUG:kernel_test_hang                             | 0          | 5          |            |
| INFO:task_blocked_for_more_than#seconds          | 0          | 26         | 15         |
| RIP:native_apic_mem_write                        | 0          | 26         | 15         |
| RIP:native_safe_halt                             | 0          | 6          | 5          |
| Kernel_panic-not_syncing:hung_task:blocked_tasks | 0          | 26         | 15         |
| backtrace:init                                   | 0          | 26         | 15         |
| backtrace:kernel_init_freeable                   | 0          | 26         | 15         |
| backtrace:watchdog                               | 0          | 26         | 15         |
| backtrace:cpu_startup_entry                      | 0          | 6          | 5          |
+--------------------------------------------------+------------+------------+------------+

[  120.948052] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  180.948037] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  180.948037] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  240.224080] INFO: task swapper/0:1 blocked for more than 120 seconds.
[  240.224080] INFO: task swapper/0:1 blocked for more than 120 seconds.
[  240.225192]       Not tainted 3.18.0-rc3-gb8c2d07 #8
[  240.225192]       Not tainted 3.18.0-rc3-gb8c2d07 #8
[  240.226050] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

git bisect start 349d0daa5e14b9b402a2dea3e602ef1cb109173b 0df1f2487d2f0d04703f142813d53615d62a1da4 --
git bisect good 71d00938cba8f46d6cd7af0577a19ee256989c80  # 14:42    390+      0  x86, PCI, MSI: Use hierarchy irqdomain to manage MSI interrupts
git bisect good 08076214697dcf740059247de8e40a76404c98ce  # 15:27    390+      0  x86: irq_remapping: Clean up unused interfaces
git bisect  bad 62995ecf6bad313d8925906aad7202c586d6abf8  # 15:27      0-     11  ACPI, irq, x86: Kill private function mp_register_gsi()/ mp_unregister_gsi()
git bisect good 384c30d19a855f8c2df40e4627baece3f815792c  # 15:27    780+      0  x86, irq: Clean up io_apic.h
git bisect  bad 73b43c2b87de413c0297c029cc193f2919f75e29  # 15:27      0-     14  x86, irq: Kill function apic_set_affinity()
git bisect  bad c07b9f681c75ae000e986b38ddb59cfc867e181c  # 15:27      0-     28  x86, irq: Kill unused alloc_irq_and_cfg_at()
git bisect  bad b8c2d075135a41f69254a75c4f26162559503ab4  # 15:27      0-     31  x86, irq: Use cached IOAPIC entry instead of reading from hardware
# first bad commit: [b8c2d075135a41f69254a75c4f26162559503ab4] x86, irq: Use cached IOAPIC entry instead of reading from hardware
git bisect good 384c30d19a855f8c2df40e4627baece3f815792c  # 16:23   1000+      0  x86, irq: Clean up io_apic.h
git bisect  bad ed233b3515062f426278aa6c87594e7f0c38e39f  # 16:23      0-     31  0day head guard for 'devel-lkp-ib04-smoke-201411130604'
git bisect good 04689e749b7ec156291446028a0ce2e685bf3855  # 17:34   1000+      0  Merge tag 'for-linus' of git://git.kernel.org/pub/scm/virt/kvm/kvm
git bisect good bbdef57970d5e1887de755474ff1562baa17ef11  # 18:03   1000+      0  Add linux-next specific files for 20141113


This script may reproduce the error.

----------------------------------------------------------------------------
#!/bin/bash

kernel=$1
initrd=yocto-minimal-x86_64.cgz

wget --no-clobber https://github.com/fengguang/reproduce-kernel-bug/raw/master/initrd/$initrd

kvm=(
	qemu-system-x86_64
	-cpu kvm64
	-enable-kvm
	-kernel $kernel
	-initrd $initrd
	-m 320
	-smp 1
	-net nic,vlan=1,model=e1000
	-net user,vlan=1
	-boot order=nc
	-no-reboot
	-watchdog i6300esb
	-rtc base=localtime
	-serial stdio
	-display none
	-monitor null 
)

append=(
	hung_task_panic=1
	earlyprintk=ttyS0,115200
	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
	root=/dev/ram0
	rw
	drbd.minor_count=8
)

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

Thanks,
Fengguang

_______________________________________________
LKP mailing list
LKP(a)linux.intel.com

[-- Attachment #2: 3.18.0-rc3-gb8c2d078 --]
[-- Type: text/plain, Size: 66666 bytes --]

early console in setup code
early console in decompress_kernel

Decompressing Linux... Parsing ELF... done.
Booting the kernel.
[    0.000000] Linux version 3.18.0-rc3-gb8c2d07 (kbuild@lkp-ib04) (gcc version 4.9.1 (Debian 4.9.1-19) ) #8 SMP Thu Nov 13 04:49:51 CST 2014
[    0.000000] Command line: hung_task_panic=1 earlyprintk=ttyS0,115200 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  root=/dev/ram0 rw link=/kbuild-tests/run-queue/kvm/x86_64-randconfig-ib0-11122254/arm-platforms:irq:stacked-its-v2:b8c2d075135a41f69254a75c4f26162559503ab4:bisect-linux-7/.vmlinuz-b8c2d075135a41f69254a75c4f26162559503ab4-20141113045005-43-vp branch=arm-platforms/irq/stacked-its-v2 BOOT_IMAGE=/kernel/x86_64-randconfig-ib0-11122254/b8c2d075135a41f69254a75c4f26162559503ab4/vmlinuz-3.18.0-rc3-gb8c2d07 drbd.minor_count=8
[    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-0x0000000013ffdfff] usable
[    0.000000] BIOS-e820: [mem 0x0000000013ffe000-0x0000000013ffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[    0.000000] bootconsole [earlyser0] enabled
[    0.000000] NX (Execute Disable) protection: active
[    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 = 0x13ffe max_arch_pfn = 0x400000000
[    0.000000] Base memory trampoline at [ffff880000099000] 99000 size 24576
[    0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff]
[    0.000000]  [mem 0x00000000-0x000fffff] page 4k
[    0.000000] BRK [0x024e2000, 0x024e2fff] PGTABLE
[    0.000000] BRK [0x024e3000, 0x024e3fff] PGTABLE
[    0.000000] BRK [0x024e4000, 0x024e4fff] PGTABLE
[    0.000000] init_memory_mapping: [mem 0x13a00000-0x13bfffff]
[    0.000000]  [mem 0x13a00000-0x13bfffff] page 4k
[    0.000000] BRK [0x024e5000, 0x024e5fff] PGTABLE
[    0.000000] init_memory_mapping: [mem 0x10000000-0x139fffff]
[    0.000000]  [mem 0x10000000-0x139fffff] page 4k
[    0.000000] BRK [0x024e6000, 0x024e6fff] PGTABLE
[    0.000000] BRK [0x024e7000, 0x024e7fff] PGTABLE
[    0.000000] init_memory_mapping: [mem 0x00100000-0x0fffffff]
[    0.000000]  [mem 0x00100000-0x0fffffff] page 4k
[    0.000000] init_memory_mapping: [mem 0x13c00000-0x13ffdfff]
[    0.000000]  [mem 0x13c00000-0x13ffdfff] page 4k
[    0.000000] RAMDISK: [mem 0x13ce6000-0x13feffff]
[    0.000000] ACPI: Early table checksum verification disabled
[    0.000000] ACPI: RSDP 0x00000000000FD970 000014 (v00 BOCHS )
[    0.000000] ACPI: RSDT 0x0000000013FFE4B0 000034 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACP 0x0000000013FFFF80 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.000000] ACPI: DSDT 0x0000000013FFE4F0 0011A9 (v01 BXPC   BXDSDT   00000001 INTL 20100528)
[    0.000000] ACPI: FACS 0x0000000013FFFF40 000040
[    0.000000] ACPI: SSDT 0x0000000013FFF800 000735 (v01 BOCHS  BXPCSSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: APIC 0x0000000013FFF6E0 000078 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.000000] ACPI: HPET 0x0000000013FFF6A0 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] mapped APIC to ffffffffff5fc000 (        fee00000)
[    0.000000] No NUMA configuration found
[    0.000000] Faking a node at [mem 0x0000000000000000-0x0000000013ffdfff]
[    0.000000] NODE_DATA(0) allocated [mem 0x13ff0000-0x13ffdfff]
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000000] kvm-clock: cpu 0, msr 0:13ce5001, primary cpu clock
[    0.000000]  [ffffea0000000000-ffffea00005fffff] PMD -> [ffff880012c00000-ffff8800131fffff] on node 0
[    0.000000] Zone ranges:
[    0.000000]   DMA32    [mem 0x00001000-0xffffffff]
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x00001000-0x0009efff]
[    0.000000]   node   0: [mem 0x00100000-0x13ffdfff]
[    0.000000] Initmem setup node 0 [mem 0x00001000-0x13ffdfff]
[    0.000000] On node 0 totalpages: 81820
[    0.000000]   DMA32 zone: 1280 pages used for memmap
[    0.000000]   DMA32 zone: 21 pages reserved
[    0.000000]   DMA32 zone: 81820 pages, LIFO batch:15
[    0.000000] ACPI: PM-Timer IO Port: 0xb008
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] mapped APIC to ffffffffff5fc000 (        fee00000)
[    0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
[    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[    0.000000] ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0])
[    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 1 CPUs, 0 hotplug CPUs
[    0.000000] mapped IOAPIC to ffffffffff5fb000 (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] setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:1 nr_node_ids:1
[    0.000000] PERCPU: Embedded 29 pages/cpu @ffff880013800000 s79424 r8192 d31168 u2097152
[    0.000000] pcpu-alloc: s79424 r8192 d31168 u2097152 alloc=1*2097152
[    0.000000] pcpu-alloc: [0] 0 
[    0.000000] KVM setup async PF for cpu 0
[    0.000000] kvm-stealtime: cpu 0, msr 1380de00
[    0.000000] Built 1 zonelists in Node order, mobility grouping on.  Total pages: 80519
[    0.000000] Policy zone: DMA32
[    0.000000] Kernel command line: hung_task_panic=1 earlyprintk=ttyS0,115200 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  root=/dev/ram0 rw link=/kbuild-tests/run-queue/kvm/x86_64-randconfig-ib0-11122254/arm-platforms:irq:stacked-its-v2:b8c2d075135a41f69254a75c4f26162559503ab4:bisect-linux-7/.vmlinuz-b8c2d075135a41f69254a75c4f26162559503ab4-20141113045005-43-vp branch=arm-platforms/irq/stacked-its-v2 BOOT_IMAGE=/kernel/x86_64-randconfig-ib0-11122254/b8c2d075135a41f69254a75c4f26162559503ab4/vmlinuz-3.18.0-rc3-gb8c2d07 drbd.minor_count=8
[    0.000000] sysrq: sysrq always enabled.
[    0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes)
[    0.000000] Memory: 295404K/327280K available (5458K kernel code, 996K rwdata, 3396K rodata, 732K init, 10776K bss, 31876K reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.000000] Hierarchical RCU implementation.
[    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
[    0.000000] NR_IRQS:4352 nr_irqs:256 16
[    0.000000] Linux version 3.18.0-rc3-gb8c2d07 (kbuild@lkp-ib04) (gcc version 4.9.1 (Debian 4.9.1-19) ) #8 SMP Thu Nov 13 04:49:51 CST 2014
[    0.000000] Command line: hung_task_panic=1 earlyprintk=ttyS0,115200 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  root=/dev/ram0 rw link=/kbuild-tests/run-queue/kvm/x86_64-randconfig-ib0-11122254/arm-platforms:irq:stacked-its-v2:b8c2d075135a41f69254a75c4f26162559503ab4:bisect-linux-7/.vmlinuz-b8c2d075135a41f69254a75c4f26162559503ab4-20141113045005-43-vp branch=arm-platforms/irq/stacked-its-v2 BOOT_IMAGE=/kernel/x86_64-randconfig-ib0-11122254/b8c2d075135a41f69254a75c4f26162559503ab4/vmlinuz-3.18.0-rc3-gb8c2d07 drbd.minor_count=8
[    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-0x0000000013ffdfff] usable
[    0.000000] BIOS-e820: [mem 0x0000000013ffe000-0x0000000013ffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[    0.000000] bootconsole [earlyser0] enabled
[    0.000000] NX (Execute Disable) protection: active
[    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 = 0x13ffe max_arch_pfn = 0x400000000
[    0.000000] Base memory trampoline at [ffff880000099000] 99000 size 24576
[    0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff]
[    0.000000]  [mem 0x00000000-0x000fffff] page 4k
[    0.000000] BRK [0x024e2000, 0x024e2fff] PGTABLE
[    0.000000] BRK [0x024e3000, 0x024e3fff] PGTABLE
[    0.000000] BRK [0x024e4000, 0x024e4fff] PGTABLE
[    0.000000] init_memory_mapping: [mem 0x13a00000-0x13bfffff]
[    0.000000]  [mem 0x13a00000-0x13bfffff] page 4k
[    0.000000] BRK [0x024e5000, 0x024e5fff] PGTABLE
[    0.000000] init_memory_mapping: [mem 0x10000000-0x139fffff]
[    0.000000]  [mem 0x10000000-0x139fffff] page 4k
[    0.000000] BRK [0x024e6000, 0x024e6fff] PGTABLE
[    0.000000] BRK [0x024e7000, 0x024e7fff] PGTABLE
[    0.000000] init_memory_mapping: [mem 0x00100000-0x0fffffff]
[    0.000000]  [mem 0x00100000-0x0fffffff] page 4k
[    0.000000] init_memory_mapping: [mem 0x13c00000-0x13ffdfff]
[    0.000000]  [mem 0x13c00000-0x13ffdfff] page 4k
[    0.000000] RAMDISK: [mem 0x13ce6000-0x13feffff]
[    0.000000] ACPI: Early table checksum verification disabled
[    0.000000] ACPI: RSDP 0x00000000000FD970 000014 (v00 BOCHS )
[    0.000000] ACPI: RSDT 0x0000000013FFE4B0 000034 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACP 0x0000000013FFFF80 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.000000] ACPI: DSDT 0x0000000013FFE4F0 0011A9 (v01 BXPC   BXDSDT   00000001 INTL 20100528)
[    0.000000] ACPI: FACS 0x0000000013FFFF40 000040
[    0.000000] ACPI: SSDT 0x0000000013FFF800 000735 (v01 BOCHS  BXPCSSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: APIC 0x0000000013FFF6E0 000078 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.000000] ACPI: HPET 0x0000000013FFF6A0 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] mapped APIC to ffffffffff5fc000 (        fee00000)
[    0.000000] No NUMA configuration found
[    0.000000] Faking a node at [mem 0x0000000000000000-0x0000000013ffdfff]
[    0.000000] NODE_DATA(0) allocated [mem 0x13ff0000-0x13ffdfff]
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000000] kvm-clock: cpu 0, msr 0:13ce5001, primary cpu clock
[    0.000000]  [ffffea0000000000-ffffea00005fffff] PMD -> [ffff880012c00000-ffff8800131fffff] on node 0
[    0.000000] Zone ranges:
[    0.000000]   DMA32    [mem 0x00001000-0xffffffff]
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x00001000-0x0009efff]
[    0.000000]   node   0: [mem 0x00100000-0x13ffdfff]
[    0.000000] Initmem setup node 0 [mem 0x00001000-0x13ffdfff]
[    0.000000] On node 0 totalpages: 81820
[    0.000000]   DMA32 zone: 1280 pages used for memmap
[    0.000000]   DMA32 zone: 21 pages reserved
[    0.000000]   DMA32 zone: 81820 pages, LIFO batch:15
[    0.000000] ACPI: PM-Timer IO Port: 0xb008
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] mapped APIC to ffffffffff5fc000 (        fee00000)
[    0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
[    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[    0.000000] ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0])
[    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 1 CPUs, 0 hotplug CPUs
[    0.000000] mapped IOAPIC to ffffffffff5fb000 (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] setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:1 nr_node_ids:1
[    0.000000] PERCPU: Embedded 29 pages/cpu @ffff880013800000 s79424 r8192 d31168 u2097152
[    0.000000] pcpu-alloc: s79424 r8192 d31168 u2097152 alloc=1*2097152
[    0.000000] pcpu-alloc: [0] 0 
[    0.000000] KVM setup async PF for cpu 0
[    0.000000] kvm-stealtime: cpu 0, msr 1380de00
[    0.000000] Built 1 zonelists in Node order, mobility grouping on.  Total pages: 80519
[    0.000000] Policy zone: DMA32
[    0.000000] Kernel command line: hung_task_panic=1 earlyprintk=ttyS0,115200 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  root=/dev/ram0 rw link=/kbuild-tests/run-queue/kvm/x86_64-randconfig-ib0-11122254/arm-platforms:irq:stacked-its-v2:b8c2d075135a41f69254a75c4f26162559503ab4:bisect-linux-7/.vmlinuz-b8c2d075135a41f69254a75c4f26162559503ab4-20141113045005-43-vp branch=arm-platforms/irq/stacked-its-v2 BOOT_IMAGE=/kernel/x86_64-randconfig-ib0-11122254/b8c2d075135a41f69254a75c4f26162559503ab4/vmlinuz-3.18.0-rc3-gb8c2d07 drbd.minor_count=8
[    0.000000] sysrq: sysrq always enabled.
[    0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes)
[    0.000000] Memory: 295404K/327280K available (5458K kernel code, 996K rwdata, 3396K rodata, 732K init, 10776K bss, 31876K reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.000000] Hierarchical RCU implementation.
[    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
[    0.000000] NR_IRQS:4352 nr_irqs:256 16
[    0.000000] console [ttyS0] enabled
[    0.000000] console [ttyS0] enabled
[    0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[    0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[    0.000000] ... MAX_LOCKDEP_SUBCLASSES:  8
[    0.000000] ... MAX_LOCKDEP_SUBCLASSES:  8
[    0.000000] ... MAX_LOCK_DEPTH:          48
[    0.000000] ... MAX_LOCK_DEPTH:          48
[    0.000000] ... MAX_LOCKDEP_KEYS:        8191
[    0.000000] ... MAX_LOCKDEP_KEYS:        8191
[    0.000000] ... CLASSHASH_SIZE:          4096
[    0.000000] ... CLASSHASH_SIZE:          4096
[    0.000000] ... MAX_LOCKDEP_ENTRIES:     32768
[    0.000000] ... MAX_LOCKDEP_ENTRIES:     32768
[    0.000000] ... MAX_LOCKDEP_CHAINS:      65536
[    0.000000] ... MAX_LOCKDEP_CHAINS:      65536
[    0.000000] ... CHAINHASH_SIZE:          32768
[    0.000000] ... CHAINHASH_SIZE:          32768
[    0.000000]  memory used by lock dependency info: 8127 kB
[    0.000000]  memory used by lock dependency info: 8127 kB
[    0.000000]  per task-struct memory footprint: 1920 bytes
[    0.000000]  per task-struct memory footprint: 1920 bytes
[    0.000000] ------------------------
[    0.000000] ------------------------
[    0.000000] | Locking API testsuite:
[    0.000000] | Locking API testsuite:
[    0.000000] ----------------------------------------------------------------------------
[    0.000000] ----------------------------------------------------------------------------
[    0.000000]                                  | spin |wlock |rlock |mutex | wsem | rsem |
[    0.000000]                                  | spin |wlock |rlock |mutex | wsem | rsem |
[    0.000000]   --------------------------------------------------------------------------
[    0.000000]   --------------------------------------------------------------------------
[    0.000000]                      A-A deadlock:
[    0.000000]                      A-A deadlock:failed|failed|failed|failed|  ok  |  ok  |failed|failed|failed|failed|failed|failed|

[    0.000000]                  A-B-B-A deadlock:
[    0.000000]                  A-B-B-A deadlock:failed|failed|failed|failed|  ok  |  ok  |failed|failed|failed|failed|failed|failed|

[    0.000000]              A-B-B-C-C-A deadlock:
[    0.000000]              A-B-B-C-C-A deadlock:failed|failed|failed|failed|  ok  |  ok  |failed|failed|failed|failed|failed|failed|

[    0.000000]              A-B-C-A-B-C deadlock:
[    0.000000]              A-B-C-A-B-C deadlock:failed|failed|failed|failed|  ok  |  ok  |failed|failed|failed|failed|failed|failed|

[    0.000000]          A-B-B-C-C-D-D-A deadlock:
[    0.000000]          A-B-B-C-C-D-D-A deadlock:failed|failed|failed|failed|  ok  |  ok  |failed|failed|failed|failed|failed|failed|

[    0.000000]          A-B-C-D-B-D-D-A deadlock:
[    0.000000]          A-B-C-D-B-D-D-A deadlock:failed|failed|failed|failed|  ok  |  ok  |failed|failed|failed|failed|failed|failed|

[    0.000000]          A-B-C-D-B-C-D-A deadlock:
[    0.000000]          A-B-C-D-B-C-D-A deadlock:failed|failed|failed|failed|  ok  |  ok  |failed|failed|failed|failed|failed|failed|

[    0.000000]                     double unlock:
[    0.000000]                     double unlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |

[    0.000000]                   initialize held:
[    0.000000]                   initialize held:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |

[    0.000000]                  bad unlock order:
[    0.000000]                  bad unlock order:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |

[    0.000000]   --------------------------------------------------------------------------
[    0.000000]   --------------------------------------------------------------------------
[    0.000000]               recursive read-lock:
[    0.000000]               recursive read-lock:             |             |  ok  |  ok  |             |             |failed|failed|

[    0.000000]            recursive read-lock #2:
[    0.000000]            recursive read-lock #2:             |             |  ok  |  ok  |             |             |failed|failed|

[    0.000000]             mixed read-write-lock:
[    0.000000]             mixed read-write-lock:             |             |failed|failed|             |             |failed|failed|

[    0.000000]             mixed write-read-lock:
[    0.000000]             mixed write-read-lock:             |             |failed|failed|             |             |failed|failed|

[    0.000000]   --------------------------------------------------------------------------
[    0.000000]   --------------------------------------------------------------------------
[    0.000000]      hard-irqs-on + irq-safe-A/12:
[    0.000000]      hard-irqs-on + irq-safe-A/12:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]      soft-irqs-on + irq-safe-A/12:
[    0.000000]      soft-irqs-on + irq-safe-A/12:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]      hard-irqs-on + irq-safe-A/21:
[    0.000000]      hard-irqs-on + irq-safe-A/21:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]      soft-irqs-on + irq-safe-A/21:
[    0.000000]      soft-irqs-on + irq-safe-A/21:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]        sirq-safe-A => hirqs-on/12:
[    0.000000]        sirq-safe-A => hirqs-on/12:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]        sirq-safe-A => hirqs-on/21:
[    0.000000]        sirq-safe-A => hirqs-on/21:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]          hard-safe-A + irqs-on/12:
[    0.000000]          hard-safe-A + irqs-on/12:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]          soft-safe-A + irqs-on/12:
[    0.000000]          soft-safe-A + irqs-on/12:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]          hard-safe-A + irqs-on/21:
[    0.000000]          hard-safe-A + irqs-on/21:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]          soft-safe-A + irqs-on/21:
[    0.000000]          soft-safe-A + irqs-on/21:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     hard-safe-A + unsafe-B #1/123:
[    0.000000]     hard-safe-A + unsafe-B #1/123:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     soft-safe-A + unsafe-B #1/123:
[    0.000000]     soft-safe-A + unsafe-B #1/123:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     hard-safe-A + unsafe-B #1/132:
[    0.000000]     hard-safe-A + unsafe-B #1/132:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     soft-safe-A + unsafe-B #1/132:
[    0.000000]     soft-safe-A + unsafe-B #1/132:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     hard-safe-A + unsafe-B #1/213:
[    0.000000]     hard-safe-A + unsafe-B #1/213:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     soft-safe-A + unsafe-B #1/213:
[    0.000000]     soft-safe-A + unsafe-B #1/213:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     hard-safe-A + unsafe-B #1/231:
[    0.000000]     hard-safe-A + unsafe-B #1/231:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     soft-safe-A + unsafe-B #1/231:
[    0.000000]     soft-safe-A + unsafe-B #1/231:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     hard-safe-A + unsafe-B #1/312:
[    0.000000]     hard-safe-A + unsafe-B #1/312:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     soft-safe-A + unsafe-B #1/312:
[    0.000000]     soft-safe-A + unsafe-B #1/312:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     hard-safe-A + unsafe-B #1/321:
[    0.000000]     hard-safe-A + unsafe-B #1/321:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     soft-safe-A + unsafe-B #1/321:
[    0.000000]     soft-safe-A + unsafe-B #1/321:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     hard-safe-A + unsafe-B #2/123:
[    0.000000]     hard-safe-A + unsafe-B #2/123:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     soft-safe-A + unsafe-B #2/123:
[    0.000000]     soft-safe-A + unsafe-B #2/123:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     hard-safe-A + unsafe-B #2/132:
[    0.000000]     hard-safe-A + unsafe-B #2/132:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     soft-safe-A + unsafe-B #2/132:
[    0.000000]     soft-safe-A + unsafe-B #2/132:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     hard-safe-A + unsafe-B #2/213:
[    0.000000]     hard-safe-A + unsafe-B #2/213:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     soft-safe-A + unsafe-B #2/213:
[    0.000000]     soft-safe-A + unsafe-B #2/213:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     hard-safe-A + unsafe-B #2/231:
[    0.000000]     hard-safe-A + unsafe-B #2/231:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     soft-safe-A + unsafe-B #2/231:
[    0.000000]     soft-safe-A + unsafe-B #2/231:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     hard-safe-A + unsafe-B #2/312:
[    0.000000]     hard-safe-A + unsafe-B #2/312:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     soft-safe-A + unsafe-B #2/312:
[    0.000000]     soft-safe-A + unsafe-B #2/312:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     hard-safe-A + unsafe-B #2/321:
[    0.000000]     hard-safe-A + unsafe-B #2/321:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]     soft-safe-A + unsafe-B #2/321:
[    0.000000]     soft-safe-A + unsafe-B #2/321:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]       hard-irq lock-inversion/123:
[    0.000000]       hard-irq lock-inversion/123:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]       soft-irq lock-inversion/123:
[    0.000000]       soft-irq lock-inversion/123:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]       hard-irq lock-inversion/132:
[    0.000000]       hard-irq lock-inversion/132:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]       soft-irq lock-inversion/132:
[    0.000000]       soft-irq lock-inversion/132:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]       hard-irq lock-inversion/213:
[    0.000000]       hard-irq lock-inversion/213:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]       soft-irq lock-inversion/213:
[    0.000000]       soft-irq lock-inversion/213:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]       hard-irq lock-inversion/231:
[    0.000000]       hard-irq lock-inversion/231:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]       soft-irq lock-inversion/231:
[    0.000000]       soft-irq lock-inversion/231:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]       hard-irq lock-inversion/312:
[    0.000000]       hard-irq lock-inversion/312:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]       soft-irq lock-inversion/312:
[    0.000000]       soft-irq lock-inversion/312:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]       hard-irq lock-inversion/321:
[    0.000000]       hard-irq lock-inversion/321:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]       soft-irq lock-inversion/321:
[    0.000000]       soft-irq lock-inversion/321:failed|failed|failed|failed|  ok  |  ok  |

[    0.000000]       hard-irq read-recursion/123:
[    0.000000]       hard-irq read-recursion/123:  ok  |  ok  |

[    0.000000]       soft-irq read-recursion/123:
[    0.000000]       soft-irq read-recursion/123:  ok  |  ok  |

[    0.000000]       hard-irq read-recursion/132:
[    0.000000]       hard-irq read-recursion/132:  ok  |  ok  |

[    0.000000]       soft-irq read-recursion/132:
[    0.000000]       soft-irq read-recursion/132:  ok  |  ok  |

[    0.000000]       hard-irq read-recursion/213:
[    0.000000]       hard-irq read-recursion/213:  ok  |  ok  |

[    0.000000]       soft-irq read-recursion/213:
[    0.000000]       soft-irq read-recursion/213:  ok  |  ok  |

[    0.000000]       hard-irq read-recursion/231:
[    0.000000]       hard-irq read-recursion/231:  ok  |  ok  |

[    0.000000]       soft-irq read-recursion/231:
[    0.000000]       soft-irq read-recursion/231:  ok  |  ok  |

[    0.000000]       hard-irq read-recursion/312:
[    0.000000]       hard-irq read-recursion/312:  ok  |  ok  |

[    0.000000]       soft-irq read-recursion/312:
[    0.000000]       soft-irq read-recursion/312:  ok  |  ok  |

[    0.000000]       hard-irq read-recursion/321:
[    0.000000]       hard-irq read-recursion/321:  ok  |  ok  |

[    0.000000]       soft-irq read-recursion/321:
[    0.000000]       soft-irq read-recursion/321:  ok  |  ok  |

[    0.000000]   --------------------------------------------------------------------------
[    0.000000]   --------------------------------------------------------------------------
[    0.000000]   | Wound/wait tests |
[    0.000000]   | Wound/wait tests |
[    0.000000]   ---------------------
[    0.000000]   ---------------------
[    0.000000]                   ww api failures:
[    0.000000]                   ww api failures:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |

[    0.000000]                ww contexts mixing:
[    0.000000]                ww contexts mixing:failed|failed|  ok  |  ok  |

[    0.000000]              finishing ww context:
[    0.000000]              finishing ww context:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |

[    0.000000]                locking mismatches:
[    0.000000]                locking mismatches:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |

[    0.000000]                  EDEADLK handling:
[    0.000000]                  EDEADLK handling:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |

[    0.000000]            spinlock nest unlocked:
[    0.000000]            spinlock nest unlocked:  ok  |  ok  |

[    0.000000]   -----------------------------------------------------
[    0.000000]   -----------------------------------------------------
[    0.000000]                                  |block | try  |context|
[    0.000000]                                  |block | try  |context|
[    0.000000]   -----------------------------------------------------
[    0.000000]   -----------------------------------------------------
[    0.000000]                           context:
[    0.000000]                           context:failed|failed|  ok  |  ok  |  ok  |  ok  |

[    0.000000]                               try:
[    0.000000]                               try:failed|failed|  ok  |  ok  |failed|failed|

[    0.000000]                             block:
[    0.000000]                             block:failed|failed|  ok  |  ok  |failed|failed|

[    0.000000]                          spinlock:
[    0.000000]                          spinlock:failed|failed|  ok  |  ok  |failed|failed|

[    0.000000] --------------------------------------------------------
[    0.000000] --------------------------------------------------------
[    0.000000] 141 out of 253 testcases failed, as expected. |
[    0.000000] 141 out of 253 testcases failed, as expected. |
[    0.000000] ----------------------------------------------------
[    0.000000] ----------------------------------------------------
[    0.000000] hpet clockevent registered
[    0.000000] hpet clockevent registered
[    0.000000] tsc: Detected 2693.562 MHz processor
[    0.000000] tsc: Detected 2693.562 MHz processor
[    0.008000] Calibrating delay loop (skipped) preset value.. 
[    0.008000] Calibrating delay loop (skipped) preset value.. 5387.12 BogoMIPS (lpj=10774248)
5387.12 BogoMIPS (lpj=10774248)
[    0.008000] pid_max: default: 4096 minimum: 301
[    0.008000] pid_max: default: 4096 minimum: 301
[    0.008047] ACPI: Core revision 20140926
[    0.008047] ACPI: Core revision 20140926
[    0.039761] ACPI: 
[    0.039761] ACPI: All ACPI Tables successfully acquiredAll ACPI Tables successfully acquired

[    0.041075] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
[    0.041075] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
[    0.042586] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
[    0.042586] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
[    0.044083] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
[    0.044083] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
[    0.045353] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
[    0.045353] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
[    0.047565] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    0.047565] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[    0.047565] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    0.047565] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[    0.055448] debug: unmapping init [mem 0xffffffff81a58000-0xffffffff81a5afff]
[    0.055448] debug: unmapping init [mem 0xffffffff81a58000-0xffffffff81a5afff]
[    0.057166] Getting VERSION: 50014
[    0.057166] Getting VERSION: 50014
[    0.057827] Getting VERSION: 50014
[    0.057827] Getting VERSION: 50014
[    0.058471] Getting ID: 0
[    0.058471] Getting ID: 0
[    0.058981] Getting ID: ff000000
[    0.058981] Getting ID: ff000000
[    0.060011] Getting LVT0: 8700
[    0.060011] Getting LVT0: 8700
[    0.060601] Getting LVT1: 8400
[    0.060601] Getting LVT1: 8400
[    0.061237] enabled ExtINT on CPU#0
[    0.061237] enabled ExtINT on CPU#0
[    0.062629] ENABLING IO-APIC IRQs
[    0.062629] ENABLING IO-APIC IRQs
[    0.063275] init IO_APIC IRQs
[    0.063275] init IO_APIC IRQs
[    0.064005]  apic 0 pin 0 not connected
[    0.064005]  apic 0 pin 0 not connected
[    0.064762] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1)
[    0.064762] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1)
[    0.066284] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1)
[    0.066284] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1)
[    0.067832] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1)
[    0.067832] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-5 -> 0x35 -> IRQ 5 Mode:1 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-5 -> 0x35 -> IRQ 5 Mode:1 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:1)
[    0.068000] IOAPIC[0]: Set routing entry (0-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:1)
[    0.068000]  apic 0 pin 16 not connected
[    0.068000]  apic 0 pin 16 not connected
[    0.068000]  apic 0 pin 17 not connected
[    0.068000]  apic 0 pin 17 not connected
[    0.068000]  apic 0 pin 18 not connected
[    0.068000]  apic 0 pin 18 not connected
[    0.068000]  apic 0 pin 19 not connected
[    0.068000]  apic 0 pin 19 not connected
[    0.068000]  apic 0 pin 20 not connected
[    0.068000]  apic 0 pin 20 not connected
[    0.068000]  apic 0 pin 21 not connected
[    0.068000]  apic 0 pin 21 not connected
[    0.068000]  apic 0 pin 22 not connected
[    0.068000]  apic 0 pin 22 not connected
[    0.068000]  apic 0 pin 23 not connected
[    0.068000]  apic 0 pin 23 not connected
[    0.068000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.068000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.068000] smpboot: CPU0: 
[    0.068000] smpboot: CPU0: Intel Intel Common KVM processorCommon KVM processor (fam: 0f, model: 06 (fam: 0f, model: 06, stepping: 01)
, stepping: 01)
[    0.068625] Using local APIC timer interrupts.
[    0.068625] calibrating APIC timer ...
[    0.068625] Using local APIC timer interrupts.
[    0.068625] calibrating APIC timer ...
[    0.072000] ... lapic delta = 6250028
[    0.072000] ... lapic delta = 6250028
[    0.072000] ... PM-Timer delta = 357918
[    0.072000] ... PM-Timer delta = 357918
[    0.072000] ... PM-Timer result ok
[    0.072000] ... PM-Timer result ok
[    0.072000] ..... delta 6250028
[    0.072000] ..... delta 6250028
[    0.072000] ..... mult: 268436658
[    0.072000] ..... mult: 268436658
[    0.072000] ..... calibration result: 4000017
[    0.072000] ..... calibration result: 4000017
[    0.072000] ..... CPU clock speed is 2693.0879 MHz.
[    0.072000] ..... CPU clock speed is 2693.0879 MHz.
[    0.072000] ..... host bus clock speed is 1000.0017 MHz.
[    0.072000] ..... host bus clock speed is 1000.0017 MHz.
[    0.072088] Performance Events: 
[    0.072088] Performance Events: unsupported Netburst CPU model 6 unsupported Netburst CPU model 6 no PMU driver, software events only.
no PMU driver, software events only.
[    0.076381] x86: Booted up 1 node, 1 CPUs
[    0.076381] x86: Booted up 1 node, 1 CPUs
[    0.077131] smpboot: Total of 1 processors activated (5387.12 BogoMIPS)
[    0.077131] smpboot: Total of 1 processors activated (5387.12 BogoMIPS)
[    0.078496] NMI watchdog: disabled (cpu0): hardware events not enabled
[    0.078496] NMI watchdog: disabled (cpu0): hardware events not enabled
[    0.087711] xor: measuring software checksum speed
[    0.087711] xor: measuring software checksum speed
[    0.128006]    prefetch64-sse: 11750.000 MB/sec
[    0.128006]    prefetch64-sse: 11750.000 MB/sec
[    0.168002]    generic_sse:  9797.000 MB/sec
[    0.168002]    generic_sse:  9797.000 MB/sec
[    0.168794] xor: using function: prefetch64-sse (11750.000 MB/sec)
[    0.168794] xor: using function: prefetch64-sse (11750.000 MB/sec)
[    0.169968] prandom: seed boundary self test passed
[    0.169968] prandom: seed boundary self test passed
[    0.171298] prandom: 100 self tests passed
[    0.171298] prandom: 100 self tests passed
[    0.172031] atomic64_test: passed for x86-64 platform with CX8 and with SSE
[    0.172031] atomic64_test: passed for x86-64 platform with CX8 and with SSE
[    0.173317] pinctrl core: initialized pinctrl subsystem
[    0.173317] pinctrl core: initialized pinctrl subsystem
[    0.175346] regulator-dummy: no parameters
[    0.175346] regulator-dummy: no parameters
[    0.176258] RTC time:  4:56:51, date: 11/13/14
[    0.176258] RTC time:  4:56:51, date: 11/13/14
[    0.177597] NET: Registered protocol family 16
[    0.177597] NET: Registered protocol family 16
[    0.180373] cpuidle: using governor menu
[    0.180373] cpuidle: using governor menu
[    0.181453] ACPI: bus type PCI registered
[    0.181453] ACPI: bus type PCI registered
[    0.182287] PCI: Using configuration type 1 for base access
[    0.182287] PCI: Using configuration type 1 for base access
[    0.227697] Running resizable hashtable tests...
[    0.227697] Running resizable hashtable tests...
[    0.228010]   Adding 2048 keys
[    0.228010]   Adding 2048 keys
[    0.236607]   Traversal complete: counted=2048, nelems=2048, entries=2048
[    0.236607]   Traversal complete: counted=2048, nelems=2048, entries=2048
[    0.237973]   Table expansion iteration 0...
[    0.237973]   Table expansion iteration 0...
[    0.239100]   Verifying lookups...
[    0.239100]   Verifying lookups...
[    0.239847]   Table expansion iteration 1...
[    0.239847]   Table expansion iteration 1...
[    0.240459]   Verifying lookups...
[    0.240459]   Verifying lookups...
[    0.241196]   Table expansion iteration 2...
[    0.241196]   Table expansion iteration 2...
[    0.242689]   Verifying lookups...
[    0.242689]   Verifying lookups...
[    0.244092]   Table expansion iteration 3...
[    0.244092]   Table expansion iteration 3...
[    0.246095]   Verifying lookups...
[    0.246095]   Verifying lookups...
[    0.246839]   Table shrinkage iteration 0...
[    0.246839]   Table shrinkage iteration 0...
[    0.247817]   Verifying lookups...
[    0.247817]   Verifying lookups...
[    0.248104]   Table shrinkage iteration 1...
[    0.248104]   Table shrinkage iteration 1...
[    0.248967]   Verifying lookups...
[    0.248967]   Verifying lookups...
[    0.249704]   Table shrinkage iteration 2...
[    0.249704]   Table shrinkage iteration 2...
[    0.250528]   Verifying lookups...
[    0.250528]   Verifying lookups...
[    0.251265]   Table shrinkage iteration 3...
[    0.251265]   Table shrinkage iteration 3...
[    0.252033]   Verifying lookups...
[    0.252033]   Verifying lookups...
[    0.252778]   Deleting 2048 keys
[    0.252778]   Deleting 2048 keys
[    0.328012] raid6: sse2x1    7893 MB/s
[    0.328012] raid6: sse2x1    7893 MB/s
[    0.396003] raid6: sse2x2    9951 MB/s
[    0.396003] raid6: sse2x2    9951 MB/s
[    0.464004] raid6: sse2x4   11565 MB/s
[    0.464004] raid6: sse2x4   11565 MB/s
[    0.464709] raid6: using algorithm sse2x4 (11565 MB/s)
[    0.464709] raid6: using algorithm sse2x4 (11565 MB/s)
[    0.465657] raid6: using intx1 recovery algorithm
[    0.465657] raid6: using intx1 recovery algorithm
[    0.467333] ACPI: Added _OSI(Module Device)
[    0.467333] ACPI: Added _OSI(Module Device)
[    0.468003] ACPI: Added _OSI(Processor Device)
[    0.468003] ACPI: Added _OSI(Processor Device)
[    0.468825] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.468825] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.469690] ACPI: Added _OSI(Processor Aggregator Device)
[    0.469690] ACPI: Added _OSI(Processor Aggregator Device)
[    0.508228] ACPI: Interpreter enabled
[    0.508228] ACPI: Interpreter enabled
[    0.508971] ACPI: (supports S0 S4 S5)
[    0.508971] ACPI: (supports S0 S4 S5)
[    0.509651] ACPI: Using IOAPIC for interrupt routing
[    0.509651] ACPI: Using IOAPIC for interrupt routing
[    0.510747] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.510747] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.571301] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.571301] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.572026] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments]
[    0.572026] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments]
[    0.573322] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[    0.573322] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[    0.578548] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
[    0.578548] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
[    0.587724] PCI host bridge to bus 0000:00
[    0.587724] PCI host bridge to bus 0000:00
[    0.588010] pci_bus 0000:00: root bus resource [bus 00-ff]
[    0.588010] pci_bus 0000:00: root bus resource [bus 00-ff]
[    0.589025] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7]
[    0.589025] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7]
[    0.590161] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff]
[    0.590161] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff]
[    0.591292] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff]
[    0.591292] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff]
[    0.592009] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff]
[    0.592009] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff]
[    0.593310] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[    0.593310] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[    0.597536] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[    0.597536] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[    0.600950] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[    0.600950] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[    0.604511] pci 0000:00:01.1: reg 0x20: [io  0xc1c0-0xc1cf]
[    0.604511] pci 0000:00:01.1: reg 0x20: [io  0xc1c0-0xc1cf]
[    0.606573] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
[    0.606573] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
[    0.608003] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
[    0.608003] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
[    0.609197] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
[    0.609197] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
[    0.610497] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
[    0.610497] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
[    0.613630] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[    0.613630] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[    0.615120] pci 0000:00:01.3: quirk: [io  0xb000-0xb03f] claimed by PIIX4 ACPI
[    0.615120] pci 0000:00:01.3: quirk: [io  0xb000-0xb03f] claimed by PIIX4 ACPI
[    0.616013] pci 0000:00:01.3: quirk: [io  0xb100-0xb10f] claimed by PIIX4 SMB
[    0.616013] pci 0000:00:01.3: quirk: [io  0xb100-0xb10f] claimed by PIIX4 SMB
[    0.619262] pci 0000:00:02.0: [1013:00b8] type 00 class 0x030000
[    0.619262] pci 0000:00:02.0: [1013:00b8] type 00 class 0x030000
[    0.622281] pci 0000:00:02.0: reg 0x10: [mem 0xfc000000-0xfdffffff pref]
[    0.622281] pci 0000:00:02.0: reg 0x10: [mem 0xfc000000-0xfdffffff pref]
[    0.625285] pci 0000:00:02.0: reg 0x14: [mem 0xfebf0000-0xfebf0fff]
[    0.625285] pci 0000:00:02.0: reg 0x14: [mem 0xfebf0000-0xfebf0fff]
[    0.632621] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[    0.632621] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[    0.636671] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[    0.636671] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[    0.638752] pci 0000:00:03.0: reg 0x10: [mem 0xfeba0000-0xfebbffff]
[    0.638752] pci 0000:00:03.0: reg 0x10: [mem 0xfeba0000-0xfebbffff]
[    0.640493] pci 0000:00:03.0: reg 0x14: [io  0xc000-0xc03f]
[    0.640493] pci 0000:00:03.0: reg 0x14: [io  0xc000-0xc03f]
[    0.646377] pci 0000:00:03.0: reg 0x30: [mem 0xfebc0000-0xfebdffff pref]
[    0.646377] pci 0000:00:03.0: reg 0x30: [mem 0xfebc0000-0xfebdffff pref]
[    0.649861] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000
[    0.649861] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000
[    0.651967] pci 0000:00:04.0: reg 0x10: [io  0xc040-0xc07f]
[    0.651967] pci 0000:00:04.0: reg 0x10: [io  0xc040-0xc07f]
[    0.652974] pci 0000:00:04.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff]
[    0.652974] pci 0000:00:04.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff]
[    0.662064] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000
[    0.662064] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000
[    0.664004] pci 0000:00:05.0: reg 0x10: [io  0xc080-0xc0bf]
[    0.664004] pci 0000:00:05.0: reg 0x10: [io  0xc080-0xc0bf]
[    0.665999] pci 0000:00:05.0: reg 0x14: [mem 0xfebf2000-0xfebf2fff]
[    0.665999] pci 0000:00:05.0: reg 0x14: [mem 0xfebf2000-0xfebf2fff]
[    0.674101] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000
[    0.674101] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000
[    0.676004] pci 0000:00:06.0: reg 0x10: [io  0xc0c0-0xc0ff]
[    0.676004] pci 0000:00:06.0: reg 0x10: [io  0xc0c0-0xc0ff]
[    0.678001] pci 0000:00:06.0: reg 0x14: [mem 0xfebf3000-0xfebf3fff]
[    0.678001] pci 0000:00:06.0: reg 0x14: [mem 0xfebf3000-0xfebf3fff]
[    0.686085] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000
[    0.686085] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000
[    0.688505] pci 0000:00:07.0: reg 0x10: [io  0xc100-0xc13f]
[    0.688505] pci 0000:00:07.0: reg 0x10: [io  0xc100-0xc13f]
[    0.690494] pci 0000:00:07.0: reg 0x14: [mem 0xfebf4000-0xfebf4fff]
[    0.690494] pci 0000:00:07.0: reg 0x14: [mem 0xfebf4000-0xfebf4fff]
[    0.698565] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000
[    0.698565] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000
[    0.700505] pci 0000:00:08.0: reg 0x10: [io  0xc140-0xc17f]
[    0.700505] pci 0000:00:08.0: reg 0x10: [io  0xc140-0xc17f]
[    0.702502] pci 0000:00:08.0: reg 0x14: [mem 0xfebf5000-0xfebf5fff]
[    0.702502] pci 0000:00:08.0: reg 0x14: [mem 0xfebf5000-0xfebf5fff]
[    0.710558] pci 0000:00:09.0: [1af4:1001] type 00 class 0x010000
[    0.710558] pci 0000:00:09.0: [1af4:1001] type 00 class 0x010000
[    0.713000] pci 0000:00:09.0: reg 0x10: [io  0xc180-0xc1bf]
[    0.713000] pci 0000:00:09.0: reg 0x10: [io  0xc180-0xc1bf]
[    0.714993] pci 0000:00:09.0: reg 0x14: [mem 0xfebf6000-0xfebf6fff]
[    0.714993] pci 0000:00:09.0: reg 0x14: [mem 0xfebf6000-0xfebf6fff]
[    0.723015] pci 0000:00:0a.0: [8086:25ab] type 00 class 0x088000
[    0.723015] pci 0000:00:0a.0: [8086:25ab] type 00 class 0x088000
[    0.724531] pci 0000:00:0a.0: reg 0x10: [mem 0xfebf7000-0xfebf700f]
[    0.724531] pci 0000:00:0a.0: reg 0x10: [mem 0xfebf7000-0xfebf700f]
[    0.730835] pci_bus 0000:00: on NUMA node 0
[    0.730835] pci_bus 0000:00: on NUMA node 0
[    0.737328] ACPI: PCI Interrupt Link [LNKA] (IRQs
[    0.737328] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 5 *10 *10 11 11))

[    0.739779] ACPI: PCI Interrupt Link [LNKB] (IRQs
[    0.739779] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 5 *10 *10 11 11))

[    0.741609] ACPI: PCI Interrupt Link [LNKC] (IRQs
[    0.741609] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 5 10 10 *11 *11))

[    0.744682] ACPI: PCI Interrupt Link [LNKD] (IRQs
[    0.744682] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 5 10 10 *11 *11))

[    0.746290] ACPI: PCI Interrupt Link [LNKS] (IRQs
[    0.746290] ACPI: PCI Interrupt Link [LNKS] (IRQs *9 *9))

[    0.749860] ACPI: 
[    0.749860] ACPI: Enabled 16 GPEs in block 00 to 0FEnabled 16 GPEs in block 00 to 0F

[    0.752728] vgaarb: setting as boot device: PCI:0000:00:02.0
[    0.752728] vgaarb: setting as boot device: PCI:0000:00:02.0
[    0.753767] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
[    0.753767] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
[    0.755241] vgaarb: loaded
[    0.755241] vgaarb: loaded
[    0.755744] vgaarb: bridge control possible 0000:00:02.0
[    0.755744] vgaarb: bridge control possible 0000:00:02.0
[    0.758668] SCSI subsystem initialized
[    0.758668] SCSI subsystem initialized
[    0.761155] Advanced Linux Sound Architecture Driver Initialized.
[    0.761155] Advanced Linux Sound Architecture Driver Initialized.
[    0.762291] PCI: Using ACPI for IRQ routing
[    0.762291] PCI: Using ACPI for IRQ routing
[    0.763063] PCI: pci_cache_line_size set to 64 bytes
[    0.763063] PCI: pci_cache_line_size set to 64 bytes
[    0.764195] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[    0.764195] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[    0.765312] e820: reserve RAM buffer [mem 0x13ffe000-0x13ffffff]
[    0.765312] e820: reserve RAM buffer [mem 0x13ffe000-0x13ffffff]
[    0.768567] hpet0: at MMIO 0xfed00000, IRQs
[    0.768567] hpet0: at MMIO 0xfed00000, IRQs 2 2, 8, 8, 0, 0

[    0.769529] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
[    0.769529] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
[    0.773121] Switched to clocksource kvm-clock
[    0.773121] Switched to clocksource kvm-clock
[    0.774651] FS-Cache: Loaded
[    0.774651] FS-Cache: Loaded
[    0.774651] pnp: PnP ACPI init
[    0.774651] pnp: PnP ACPI init
[    0.775567] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
[    0.775567] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
[    0.777322] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
[    0.777322] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
[    0.779040] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
[    0.779040] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
[    0.780715] pnp 00:03: [dma 2]
[    0.780715] pnp 00:03: [dma 2]
[    0.781577] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
[    0.781577] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
[    0.783529] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active)
[    0.783529] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active)
[    0.785495] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
[    0.785495] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
[    0.787446] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active)
[    0.787446] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active)
[    0.791647] pnp: PnP ACPI: found 7 devices
[    0.791647] pnp: PnP ACPI: found 7 devices
[    0.800281] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7]
[    0.800281] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7]
[    0.801307] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff]
[    0.801307] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff]
[    0.802325] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff]
[    0.802325] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff]
[    0.803472] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff]
[    0.803472] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff]
[    0.804703] NET: Registered protocol family 1
[    0.804703] NET: Registered protocol family 1
[    0.805560] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[    0.805560] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[    0.806663] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[    0.806663] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[    0.807736] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[    0.807736] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[    0.808893] pci 0000:00:02.0: Video device with shadowed ROM
[    0.808893] pci 0000:00:02.0: Video device with shadowed ROM
[    0.809989] PCI: CLS 0 bytes, default 64
[    0.809989] PCI: CLS 0 bytes, default 64
[    0.811128] Unpacking initramfs...
[    0.811128] Unpacking initramfs...
[    0.919054] debug: unmapping init [mem 0xffff880013ce6000-0xffff880013feffff]
[    0.919054] debug: unmapping init [mem 0xffff880013ce6000-0xffff880013feffff]
[    0.921653] microcode: CPU0 sig=0xf61, pf=0x1, revision=0x1
[    0.921653] microcode: CPU0 sig=0xf61, pf=0x1, revision=0x1
[    0.922977] microcode: Microcode Update Driver: v2.00 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
[    0.922977] microcode: Microcode Update Driver: v2.00 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
[    0.925187] cryptomgr_test (20) used greatest stack depth: 14768 bytes left
[    0.925187] cryptomgr_test (20) used greatest stack depth: 14768 bytes left
[    0.927312] sha256_ssse3: Neither AVX nor SSSE3 is available/usable.
[    0.927312] sha256_ssse3: Neither AVX nor SSSE3 is available/usable.
[    0.928628] 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
[    0.928628] 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
[    0.931795] spin_lock-torture: Creating torture_shuffle task
[    0.931795] spin_lock-torture: Creating torture_shuffle task
[    0.932949] spin_lock-torture: Creating torture_stutter task
[    0.932949] spin_lock-torture: Creating torture_stutter task
[    0.934045] spin_lock-torture: torture_shuffle task started
[    0.934045] spin_lock-torture: torture_shuffle task started
[    0.935086] spin_lock-torture: Creating lock_torture_writer task
[    0.935086] spin_lock-torture: Creating lock_torture_writer task
[    0.936396] spin_lock-torture: torture_stutter task started
[    0.936396] spin_lock-torture: torture_stutter task started
[    0.937435] spin_lock-torture: Creating lock_torture_writer task
[    0.937435] spin_lock-torture: Creating lock_torture_writer task
[    0.938573] spin_lock-torture: lock_torture_writer task started
[    0.938573] spin_lock-torture: lock_torture_writer task started
[    0.939673] spin_lock-torture: Creating lock_torture_stats task
[    0.939673] spin_lock-torture: Creating lock_torture_stats task
[    0.940816] spin_lock-torture: lock_torture_writer task started
[    0.940816] spin_lock-torture: lock_torture_writer task started
[    0.942209] torture_init_begin: refusing rcu init: spin_lock running
[    0.942209] torture_init_begin: refusing rcu init: spin_lock running

[    0.945297] futex hash table entries: 16 (order: -1, 2048 bytes)
[    0.945297] futex hash table entries: 16 (order: -1, 2048 bytes)
[    0.946472] Initialise system trusted keyring
[    0.946472] Initialise system trusted keyring
[    0.947619] Kprobe smoke test: started
[    0.947619] Kprobe smoke test: started
[    0.948955] spin_lock-torture: lock_torture_stats task started
[    0.948955] spin_lock-torture: lock_torture_stats task started
[    0.956559] Kprobe smoke test: passed successfully
[    0.956559] Kprobe smoke test: passed successfully
[    0.991780] zpool: loaded
[    0.991780] zpool: loaded
[    1.004182] efs: 1.0a - http://aeschi.ch.eu.org/efs/
[    1.004182] efs: 1.0a - http://aeschi.ch.eu.org/efs/
[    1.005631] befs: version: 0.9.3
[    1.005631] befs: version: 0.9.3
[    1.006819] msgmni has been set to 576
[    1.006819] msgmni has been set to 576
[    1.011118] Key type asymmetric registered
[    1.011118] Key type asymmetric registered
[    1.011902] Asymmetric key parser 'x509' registered
[    1.011902] Asymmetric key parser 'x509' registered
[    1.013432] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
[    1.013432] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
[    1.014797] io scheduler noop registered (default)
[    1.014797] io scheduler noop registered (default)
[    1.019794] test_firmware: interface ready
[    1.019794] test_firmware: interface ready
[    1.021317] crc32: CRC_LE_BITS = 64, CRC_BE BITS = 64
[    1.021317] crc32: CRC_LE_BITS = 64, CRC_BE BITS = 64
[    1.022254] crc32: self tests passed, processed 225944 bytes in 144523 nsec
[    1.022254] crc32: self tests passed, processed 225944 bytes in 144523 nsec
[    1.023672] crc32c: CRC_LE_BITS = 64
[    1.023672] crc32c: CRC_LE_BITS = 64
[    1.024348] crc32c: self tests passed, processed 225944 bytes in 72175 nsec
[    1.024348] crc32c: self tests passed, processed 225944 bytes in 72175 nsec
[    1.037070] crc32_combine: 8373 self tests passed
[    1.037070] crc32_combine: 8373 self tests passed
[    1.049217] crc32c_combine: 8373 self tests passed
[    1.049217] crc32c_combine: 8373 self tests passed
[    1.050216] rbtree testing
[    1.050216] rbtree testing -> 9037 cycles
 -> 9037 cycles
[    1.417046] augmented rbtree testing
[    1.417046] augmented rbtree testing -> 12816 cycles
 -> 12816 cycles
[    1.934826] tsc: Refined TSC clocksource calibration: 2693.410 MHz
[    1.934826] tsc: Refined TSC clocksource calibration: 2693.410 MHz
[    1.938229] VIA Graphics Integration Chipset framebuffer 2.4 initializing
[    1.938229] VIA Graphics Integration Chipset framebuffer 2.4 initializing
[    1.940871] cirrusfb 0000:00:02.0: Cirrus Logic chipset on PCI bus, RAM (4096 kB) at 0xfc000000
[    1.940871] cirrusfb 0000:00:02.0: Cirrus Logic chipset on PCI bus, RAM (4096 kB) at 0xfc000000
[    1.942440] CL Picasso4: enable CONFIG_FB_LITTLE_ENDIAN to support this framebuffer
[    1.942440] CL Picasso4: enable CONFIG_FB_LITTLE_ENDIAN to support this framebuffer
[    1.943838] cirrusfb 0000:00:02.0: could not register fb device; err = -38!
[    1.943838] cirrusfb 0000:00:02.0: could not register fb device; err = -38!
[    1.945198] cirrusfb: probe of 0000:00:02.0 failed with error -38
[    1.945198] cirrusfb: probe of 0000:00:02.0 failed with error -38
[    1.947052] ipmi message handler version 39.2
[    1.947052] ipmi message handler version 39.2
[    1.956438] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
[    1.956438] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
[    1.965820] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
[    1.965820] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
[    1.975405] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 10
[    1.975405] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 10
[    1.985410] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11
[    1.985410] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11
[    2.129095] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[    2.129095] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[    2.155666] serial 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[    2.155666] serial 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[    2.161536] Applicom driver: $Id: ac.c,v 1.30 2000/03/22 16:03:57 dwmw2 Exp $
[    2.161536] Applicom driver: $Id: ac.c,v 1.30 2000/03/22 16:03:57 dwmw2 Exp $
[    2.162843] ac.o: No PCI boards found.
[    2.162843] ac.o: No PCI boards found.
[    2.163525] ac.o: For an ISA board you must supply memory and irq parameters.
[    2.163525] ac.o: For an ISA board you must supply memory and irq parameters.
[    2.165377] Linux agpgart interface v0.103
[    2.165377] Linux agpgart interface v0.103
[    2.167520] parport_pc 00:04: reported by Plug and Play ACPI
[    2.167520] parport_pc 00:04: reported by Plug and Play ACPI
[    2.168716] parport0: PC-style at 0x378
[    2.168716] parport0: PC-style at 0x378, irq 7, irq 7 [ [PCSPPPCSPP,TRISTATE,TRISTATE]
]
[    2.266153] HP CISS Driver (v 3.6.26)
[    2.266153] HP CISS Driver (v 3.6.26)
[   60.948050] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[   60.948050] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  120.948052] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  120.948052] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  180.948037] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  180.948037] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  240.224080] INFO: task swapper/0:1 blocked for more than 120 seconds

^ permalink raw reply	[flat|nested] 7+ messages in thread
* [x86, irq] BUG: kernel boot hang
@ 2014-11-10  5:39 lkp
  0 siblings, 0 replies; 7+ messages in thread
From: lkp @ 2014-11-10  5:39 UTC (permalink / raw)
  To: lkp

[-- Attachment #1: Type: text/plain, Size: 2241 bytes --]

FYI, we noticed the below changes on

https://github.com/jiangliu/linux.git irqdomain/p4v1
commit e530b4be849e7c865c95f25008eb52b72ec96341 ("x86, irq: Use cached IOAPIC entry instead of reading from hardware")


+----------------------+------------+------------+
|                      | ff34368973 | e530b4be84 |
+----------------------+------------+------------+
| boot_successes       | 10         | 1          |
| boot_failures        | 0          | 14         |
| BUG:kernel_boot_hang | 0          | 14         |
+----------------------+------------+------------+


[  302.136037] Waiting up to 20 more seconds for network.
[  312.136042] Waiting up to 10 more seconds for network.

BUG: kernel boot hang
Elapsed time: 310
qemu-system-x86_64 -enable-kvm -cpu Westmere -kernel /kernel/x86_64-lkp/dfc6ac916357d686ca861cb0a996ed85413d5d00/vmlinuz-3.18.0-rc3-00128-gdfc6ac9 -append 'user=lkp job=/lkp/scheduled/vm-kbuild-yocto-ia32-31/rand_boot-1-yocto-minimal-i386.cgz-x86_64-lkp-dfc6ac916357d686ca861cb0a996ed85413d5d00-1.yaml ARCH=x86_64 BOOT_IMAGE=/kernel/x86_64-lkp/dfc6ac916357d686ca861cb0a996ed85413d5d00/vmlinuz-3.18.0-rc3-00128-gdfc6ac9 kconfig=x86_64-lkp commit=dfc6ac916357d686ca861cb0a996ed85413d5d00 branch=linux-devel/devel-roam-lkp-201411081809 root=/dev/ram0 max_uptime=3600 RESULT_ROOT=/result/vm-kbuild-yocto-ia32/boot/1/yocto-minimal-i386.cgz/x86_64-lkp/dfc6ac916357d686ca861cb0a996ed85413d5d00/0 ip=::::vm-kbuild-yocto-ia32-31::dhcp earlyprintk=ttyS0,115200 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 drbd.minor_count=8'  -initrd /fs/sdh1/initrd-vm-kbuild-yocto-ia32-31 -m 320 -smp 1 -net nic,vlan=1,model=e1000 -net user,vlan=1 -boot order=nc -no-reboot -watchdog i6300esb -rtc base=localtime -drive file=/fs/sdh1/disk0-vm-kbuild-yocto-ia32-31,media=disk,if=virtio -pidfile /dev/shm/kboot/pid-vm-kbuild-yocto-ia32-31 -serial file:/dev/shm/kboot/serial-vm-kbuild-yocto-ia32-31 -daemonize -display none -monitor null 

Thanks,
Fengguang

_______________________________________________
LKP mailing list
LKP(a)linux.intel.com

[-- Attachment #2: dmesg.ksh --]
[-- Type: text/plain, Size: 35339 bytes --]

early console in setup code
Probing EDD (edd=off to disable)... ok
early console in decompress_kernel

Decompressing Linux... Parsing ELF... done.
Booting the kernel.
[    0.000000] Initializing cgroup subsys cpuset
[    0.000000] Initializing cgroup subsys cpu
[    0.000000] Linux version 3.18.0-rc3-00128-gdfc6ac9 (kbuild@roam) (gcc version 4.9.1 (Debian 4.9.1-19) ) #41 SMP Sat Nov 8 18:13:44 CST 2014
[    0.000000] Command line: user=lkp job=/lkp/scheduled/vm-kbuild-yocto-ia32-31/rand_boot-1-yocto-minimal-i386.cgz-x86_64-lkp-dfc6ac916357d686ca861cb0a996ed85413d5d00-1.yaml ARCH=x86_64 BOOT_IMAGE=/kernel/x86_64-lkp/dfc6ac916357d686ca861cb0a996ed85413d5d00/vmlinuz-3.18.0-rc3-00128-gdfc6ac9 kconfig=x86_64-lkp commit=dfc6ac916357d686ca861cb0a996ed85413d5d00 branch=linux-devel/devel-roam-lkp-201411081809 root=/dev/ram0 max_uptime=3600 RESULT_ROOT=/result/vm-kbuild-yocto-ia32/boot/1/yocto-minimal-i386.cgz/x86_64-lkp/dfc6ac916357d686ca861cb0a996ed85413d5d00/0 ip=::::vm-kbuild-yocto-ia32-31::dhcp earlyprintk=ttyS0,115200 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 drbd.minor_count=8
[    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-0x0000000013ffdfff] usable
[    0.000000] BIOS-e820: [mem 0x0000000013ffe000-0x0000000013ffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[    0.000000] bootconsole [earlyser0] enabled
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] SMBIOS 2.4 present.
[    0.000000] DMI: Bochs Bochs, BIOS Bochs 01/01/2011
[    0.000000] Hypervisor detected: KVM
[    0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.000000] AGP: No AGP bridge found
[    0.000000] e820: last_pfn = 0x13ffe max_arch_pfn = 0x400000000
[    0.000000] MTRR default type: write-back
[    0.000000] MTRR fixed ranges enabled:
[    0.000000]   00000-9FFFF write-back
[    0.000000]   A0000-BFFFF uncachable
[    0.000000]   C0000-FFFFF write-protect
[    0.000000] MTRR variable ranges enabled:
[    0.000000]   0 base 0080000000 mask FF80000000 uncachable
[    0.000000]   1 disabled
[    0.000000]   2 disabled
[    0.000000]   3 disabled
[    0.000000]   4 disabled
[    0.000000]   5 disabled
[    0.000000]   6 disabled
[    0.000000]   7 disabled
[    0.000000] x86 PAT enabled: cpu 0, old 0x70406, new 0x7010600070106
[    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 0x000fdaf0-0x000fdaff] mapped at [ffff8800000fdaf0]
[    0.000000]   mpc: fdb00-fdbe8
[    0.000000] Scanning 1 areas for low memory corruption
[    0.000000] Base memory trampoline at [ffff880000099000] 99000 size 24576
[    0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff]
[    0.000000]  [mem 0x00000000-0x000fffff] page 4k
[    0.000000] BRK [0x02468000, 0x02468fff] PGTABLE
[    0.000000] BRK [0x02469000, 0x02469fff] PGTABLE
[    0.000000] BRK [0x0246a000, 0x0246afff] PGTABLE
[    0.000000] init_memory_mapping: [mem 0x13800000-0x139fffff]
[    0.000000]  [mem 0x13800000-0x139fffff] page 2M
[    0.000000] init_memory_mapping: [mem 0x10000000-0x137fffff]
[    0.000000]  [mem 0x10000000-0x137fffff] page 2M
[    0.000000] init_memory_mapping: [mem 0x00100000-0x0fffffff]
[    0.000000]  [mem 0x00100000-0x001fffff] page 4k
[    0.000000]  [mem 0x00200000-0x0fffffff] page 2M
[    0.000000] init_memory_mapping: [mem 0x13a00000-0x13ffdfff]
[    0.000000]  [mem 0x13a00000-0x13dfffff] page 2M
[    0.000000]  [mem 0x13e00000-0x13ffdfff] page 4k
[    0.000000] BRK [0x0246b000, 0x0246bfff] PGTABLE
[    0.000000] RAMDISK: [mem 0x13b20000-0x13feffff]
[    0.000000] ACPI: Early table checksum verification disabled
[    0.000000] ACPI: RSDP 0x00000000000FD990 000014 (v00 BOCHS )
[    0.000000] ACPI: RSDT 0x0000000013FFE4B0 000034 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACP 0x0000000013FFFF80 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.000000] ACPI: DSDT 0x0000000013FFE4F0 0011A9 (v01 BXPC   BXDSDT   00000001 INTL 20100528)
[    0.000000] ACPI: FACS 0x0000000013FFFF40 000040
[    0.000000] ACPI: SSDT 0x0000000013FFF800 000735 (v01 BOCHS  BXPCSSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: APIC 0x0000000013FFF6E0 000078 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.000000] ACPI: HPET 0x0000000013FFF6A0 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] mapped APIC to ffffffffff5f5000 (        fee00000)
[    0.000000] No NUMA configuration found
[    0.000000] Faking a node at [mem 0x0000000000000000-0x0000000013ffdfff]
[    0.000000] NODE_DATA(0) allocated [mem 0x13ffa000-0x13ffdfff]
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000000] kvm-clock: cpu 0, msr 0:13ff2001, primary cpu clock
[    0.000000]  [ffffea0000000000-ffffea00005fffff] PMD -> [ffff880012c00000-ffff8800131fffff] on node 0
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x00001000-0x00ffffff]
[    0.000000]   DMA32    [mem 0x01000000-0xffffffff]
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x00001000-0x0009efff]
[    0.000000]   node   0: [mem 0x00100000-0x13ffdfff]
[    0.000000] Initmem setup node 0 [mem 0x00001000-0x13ffdfff]
[    0.000000] On node 0 totalpages: 81820
[    0.000000]   DMA zone: 64 pages used for memmap
[    0.000000]   DMA zone: 21 pages reserved
[    0.000000]   DMA zone: 3998 pages, LIFO batch:0
[    0.000000]   DMA32 zone: 1216 pages used for memmap
[    0.000000]   DMA32 zone: 77822 pages, LIFO batch:15
[    0.000000] ACPI: PM-Timer IO Port: 0xb008
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] mapped APIC to ffffffffff5f5000 (        fee00000)
[    0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
[    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[    0.000000] ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0])
[    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 1 CPUs, 0 hotplug CPUs
[    0.000000] mapped IOAPIC to ffffffffff5f4000 (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] setup_percpu: NR_CPUS:512 nr_cpumask_bits:512 nr_cpu_ids:1 nr_node_ids:1
[    0.000000] PERCPU: Embedded 29 pages/cpu @ffff880013800000 s81920 r8192 d28672 u2097152
[    0.000000] pcpu-alloc: s81920 r8192 d28672 u2097152 alloc=1*2097152
[    0.000000] pcpu-alloc: [0] 0 
[    0.000000] KVM setup async PF for cpu 0
[    0.000000] kvm-stealtime: cpu 0, msr 1380d140
[    0.000000] Built 1 zonelists in Node order, mobility grouping on.  Total pages: 80519
[    0.000000] Policy zone: DMA32
[    0.000000] Kernel command line: user=lkp job=/lkp/scheduled/vm-kbuild-yocto-ia32-31/rand_boot-1-yocto-minimal-i386.cgz-x86_64-lkp-dfc6ac916357d686ca861cb0a996ed85413d5d00-1.yaml ARCH=x86_64 BOOT_IMAGE=/kernel/x86_64-lkp/dfc6ac916357d686ca861cb0a996ed85413d5d00/vmlinuz-3.18.0-rc3-00128-gdfc6ac9 kconfig=x86_64-lkp commit=dfc6ac916357d686ca861cb0a996ed85413d5d00 branch=linux-devel/devel-roam-lkp-201411081809 root=/dev/ram0 max_uptime=3600 RESULT_ROOT=/result/vm-kbuild-yocto-ia32/boot/1/yocto-minimal-i386.cgz/x86_64-lkp/dfc6ac916357d686ca861cb0a996ed85413d5d00/0 ip=::::vm-kbuild-yocto-ia32-31::dhcp earlyprintk=ttyS0,115200 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 drbd.minor_count=8
[    0.000000] sysrq: sysrq always enabled.
[    0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes)
[    0.000000] AGP: Checking aperture...
[    0.000000] AGP: No AGP bridge found
[    0.000000] Memory: 294804K/327280K available (10213K kernel code, 1385K rwdata, 4324K rodata, 1448K init, 1624K bss, 32476K reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.000000] Hierarchical RCU implementation.
[    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
[    0.000000] NR_IRQS:33024 nr_irqs:256 16
[    0.000000] Console: colour VGA+ 80x25
[    0.000000] console [tty0] enabled
[    0.000000] bootconsole [earlyser0] disabled
[    0.000000] Initializing cgroup subsys cpuset
[    0.000000] Initializing cgroup subsys cpu
[    0.000000] Linux version 3.18.0-rc3-00128-gdfc6ac9 (kbuild@roam) (gcc version 4.9.1 (Debian 4.9.1-19) ) #41 SMP Sat Nov 8 18:13:44 CST 2014
[    0.000000] Command line: user=lkp job=/lkp/scheduled/vm-kbuild-yocto-ia32-31/rand_boot-1-yocto-minimal-i386.cgz-x86_64-lkp-dfc6ac916357d686ca861cb0a996ed85413d5d00-1.yaml ARCH=x86_64 BOOT_IMAGE=/kernel/x86_64-lkp/dfc6ac916357d686ca861cb0a996ed85413d5d00/vmlinuz-3.18.0-rc3-00128-gdfc6ac9 kconfig=x86_64-lkp commit=dfc6ac916357d686ca861cb0a996ed85413d5d00 branch=linux-devel/devel-roam-lkp-201411081809 root=/dev/ram0 max_uptime=3600 RESULT_ROOT=/result/vm-kbuild-yocto-ia32/boot/1/yocto-minimal-i386.cgz/x86_64-lkp/dfc6ac916357d686ca861cb0a996ed85413d5d00/0 ip=::::vm-kbuild-yocto-ia32-31::dhcp earlyprintk=ttyS0,115200 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 drbd.minor_count=8
[    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-0x0000000013ffdfff] usable
[    0.000000] BIOS-e820: [mem 0x0000000013ffe000-0x0000000013ffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[    0.000000] bootconsole [earlyser0] enabled
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] SMBIOS 2.4 present.
[    0.000000] DMI: Bochs Bochs, BIOS Bochs 01/01/2011
[    0.000000] Hypervisor detected: KVM
[    0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.000000] AGP: No AGP bridge found
[    0.000000] e820: last_pfn = 0x13ffe max_arch_pfn = 0x400000000
[    0.000000] MTRR default type: write-back
[    0.000000] MTRR fixed ranges enabled:
[    0.000000]   00000-9FFFF write-back
[    0.000000]   A0000-BFFFF uncachable
[    0.000000]   C0000-FFFFF write-protect
[    0.000000] MTRR variable ranges enabled:
[    0.000000]   0 base 0080000000 mask FF80000000 uncachable
[    0.000000]   1 disabled
[    0.000000]   2 disabled
[    0.000000]   3 disabled
[    0.000000]   4 disabled
[    0.000000]   5 disabled
[    0.000000]   6 disabled
[    0.000000]   7 disabled
[    0.000000] x86 PAT enabled: cpu 0, old 0x70406, new 0x7010600070106
[    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 0x000fdaf0-0x000fdaff] mapped at [ffff8800000fdaf0]
[    0.000000]   mpc: fdb00-fdbe8
[    0.000000] Scanning 1 areas for low memory corruption
[    0.000000] Base memory trampoline at [ffff880000099000] 99000 size 24576
[    0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff]
[    0.000000]  [mem 0x00000000-0x000fffff] page 4k
[    0.000000] BRK [0x02468000, 0x02468fff] PGTABLE
[    0.000000] BRK [0x02469000, 0x02469fff] PGTABLE
[    0.000000] BRK [0x0246a000, 0x0246afff] PGTABLE
[    0.000000] init_memory_mapping: [mem 0x13800000-0x139fffff]
[    0.000000]  [mem 0x13800000-0x139fffff] page 2M
[    0.000000] init_memory_mapping: [mem 0x10000000-0x137fffff]
[    0.000000]  [mem 0x10000000-0x137fffff] page 2M
[    0.000000] init_memory_mapping: [mem 0x00100000-0x0fffffff]
[    0.000000]  [mem 0x00100000-0x001fffff] page 4k
[    0.000000]  [mem 0x00200000-0x0fffffff] page 2M
[    0.000000] init_memory_mapping: [mem 0x13a00000-0x13ffdfff]
[    0.000000]  [mem 0x13a00000-0x13dfffff] page 2M
[    0.000000]  [mem 0x13e00000-0x13ffdfff] page 4k
[    0.000000] BRK [0x0246b000, 0x0246bfff] PGTABLE
[    0.000000] RAMDISK: [mem 0x13b20000-0x13feffff]
[    0.000000] ACPI: Early table checksum verification disabled
[    0.000000] ACPI: RSDP 0x00000000000FD990 000014 (v00 BOCHS )
[    0.000000] ACPI: RSDT 0x0000000013FFE4B0 000034 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACP 0x0000000013FFFF80 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.000000] ACPI: DSDT 0x0000000013FFE4F0 0011A9 (v01 BXPC   BXDSDT   00000001 INTL 20100528)
[    0.000000] ACPI: FACS 0x0000000013FFFF40 000040
[    0.000000] ACPI: SSDT 0x0000000013FFF800 000735 (v01 BOCHS  BXPCSSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: APIC 0x0000000013FFF6E0 000078 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.000000] ACPI: HPET 0x0000000013FFF6A0 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] mapped APIC to ffffffffff5f5000 (        fee00000)
[    0.000000] No NUMA configuration found
[    0.000000] Faking a node at [mem 0x0000000000000000-0x0000000013ffdfff]
[    0.000000] NODE_DATA(0) allocated [mem 0x13ffa000-0x13ffdfff]
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000000] kvm-clock: cpu 0, msr 0:13ff2001, primary cpu clock
[    0.000000]  [ffffea0000000000-ffffea00005fffff] PMD -> [ffff880012c00000-ffff8800131fffff] on node 0
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x00001000-0x00ffffff]
[    0.000000]   DMA32    [mem 0x01000000-0xffffffff]
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x00001000-0x0009efff]
[    0.000000]   node   0: [mem 0x00100000-0x13ffdfff]
[    0.000000] Initmem setup node 0 [mem 0x00001000-0x13ffdfff]
[    0.000000] On node 0 totalpages: 81820
[    0.000000]   DMA zone: 64 pages used for memmap
[    0.000000]   DMA zone: 21 pages reserved
[    0.000000]   DMA zone: 3998 pages, LIFO batch:0
[    0.000000]   DMA32 zone: 1216 pages used for memmap
[    0.000000]   DMA32 zone: 77822 pages, LIFO batch:15
[    0.000000] ACPI: PM-Timer IO Port: 0xb008
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] mapped APIC to ffffffffff5f5000 (        fee00000)
[    0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
[    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[    0.000000] ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0])
[    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 1 CPUs, 0 hotplug CPUs
[    0.000000] mapped IOAPIC to ffffffffff5f4000 (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] setup_percpu: NR_CPUS:512 nr_cpumask_bits:512 nr_cpu_ids:1 nr_node_ids:1
[    0.000000] PERCPU: Embedded 29 pages/cpu @ffff880013800000 s81920 r8192 d28672 u2097152
[    0.000000] pcpu-alloc: s81920 r8192 d28672 u2097152 alloc=1*2097152
[    0.000000] pcpu-alloc: [0] 0 
[    0.000000] KVM setup async PF for cpu 0
[    0.000000] kvm-stealtime: cpu 0, msr 1380d140
[    0.000000] Built 1 zonelists in Node order, mobility grouping on.  Total pages: 80519
[    0.000000] Policy zone: DMA32
[    0.000000] Kernel command line: user=lkp job=/lkp/scheduled/vm-kbuild-yocto-ia32-31/rand_boot-1-yocto-minimal-i386.cgz-x86_64-lkp-dfc6ac916357d686ca861cb0a996ed85413d5d00-1.yaml ARCH=x86_64 BOOT_IMAGE=/kernel/x86_64-lkp/dfc6ac916357d686ca861cb0a996ed85413d5d00/vmlinuz-3.18.0-rc3-00128-gdfc6ac9 kconfig=x86_64-lkp commit=dfc6ac916357d686ca861cb0a996ed85413d5d00 branch=linux-devel/devel-roam-lkp-201411081809 root=/dev/ram0 max_uptime=3600 RESULT_ROOT=/result/vm-kbuild-yocto-ia32/boot/1/yocto-minimal-i386.cgz/x86_64-lkp/dfc6ac916357d686ca861cb0a996ed85413d5d00/0 ip=::::vm-kbuild-yocto-ia32-31::dhcp earlyprintk=ttyS0,115200 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 drbd.minor_count=8
[    0.000000] sysrq: sysrq always enabled.
[    0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes)
[    0.000000] AGP: Checking aperture...
[    0.000000] AGP: No AGP bridge found
[    0.000000] Memory: 294804K/327280K available (10213K kernel code, 1385K rwdata, 4324K rodata, 1448K init, 1624K bss, 32476K reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.000000] Hierarchical RCU implementation.
[    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
[    0.000000] NR_IRQS:33024 nr_irqs:256 16
[    0.000000] Console: colour VGA+ 80x25
[    0.000000] console [tty0] enabled
[    0.000000] bootconsole [earlyser0] disabled
[    0.000000] console [ttyS0] enabled
[    0.000000] allocated 1572864 bytes of page_cgroup
[    0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups
[    0.000000] hpet clockevent registered
[    0.000000] tsc: Detected 2693.452 MHz processor
[    0.008000] Calibrating delay loop (skipped) preset value.. 5386.90 BogoMIPS (lpj=10773808)
[    0.008785] pid_max: default: 32768 minimum: 301
[    0.009872] ACPI: Core revision 20140926
[    0.013827] ACPI: All ACPI Tables successfully acquired
[    0.017038] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
[    0.018869] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
[    0.020081] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
[    0.021983] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
[    0.024300] Initializing cgroup subsys memory
[    0.028016] Initializing cgroup subsys devices
[    0.032011] Initializing cgroup subsys freezer
[    0.036020] Initializing cgroup subsys blkio
[    0.040013] Initializing cgroup subsys perf_event
[    0.044016] Initializing cgroup subsys hugetlb
[    0.048149] mce: CPU supports 10 MCE banks
[    0.049844] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    0.049844] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[    0.104245] Freeing SMP alternatives memory: 40K (ffffffff822c6000 - ffffffff822d0000)
[    0.117071] ftrace: allocating 39716 entries in 156 pages
[    0.140123] Getting VERSION: 50014
[    0.141703] Getting VERSION: 50014
[    0.143070] Getting ID: 0
[    0.144018] Getting ID: ff000000
[    0.145418] Getting LVT0: 8700
[    0.146773] Getting LVT1: 8400
[    0.148096] enabled ExtINT on CPU#0
[    0.150635] ENABLING IO-APIC IRQs
[    0.152024] init IO_APIC IRQs
[    0.156008]  apic 0 pin 0 not connected
[    0.157403] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1)
[    0.160016] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1)
[    0.164000] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1)
[    0.164000] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1)
[    0.164000] IOAPIC[0]: Set routing entry (0-5 -> 0x35 -> IRQ 5 Mode:1 Active:0 Dest:1)
[    0.164000] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1)
[    0.164000] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1)
[    0.164000] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1)
[    0.164000] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:1)
[    0.164000] IOAPIC[0]: Set routing entry (0-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:1)
[    0.164000] IOAPIC[0]: Set routing entry (0-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:1)
[    0.164000] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1)
[    0.164000] IOAPIC[0]: Set routing entry (0-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:1)
[    0.164000] IOAPIC[0]: Set routing entry (0-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:1)
[    0.164000] IOAPIC[0]: Set routing entry (0-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:1)
[    0.164000]  apic 0 pin 16 not connected
[    0.164000]  apic 0 pin 17 not connected
[    0.164000]  apic 0 pin 18 not connected
[    0.164000]  apic 0 pin 19 not connected
[    0.164000]  apic 0 pin 20 not connected
[    0.164000]  apic 0 pin 21 not connected
[    0.164000]  apic 0 pin 22 not connected
[    0.164000]  apic 0 pin 23 not connected
[    0.164000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.164000] smpboot: CPU0: Intel Westmere E56xx/L56xx/X56xx (Nehalem-C) (fam: 06, model: 2c, stepping: 01)
[    0.164010] Using local APIC timer interrupts.
[    0.164010] calibrating APIC timer ...
[    0.172000] ... lapic delta = 6667326
[    0.172000] ... PM-Timer delta = 381833
[    0.172000] APIC calibration not consistent with PM-Timer: 106ms instead of 100ms
[    0.172000] APIC delta adjusted to PM-Timer: 6250366 (6667326)
[    0.172000] TSC delta adjusted to PM-Timer: 263157460 (280712613)
[    0.172000] ..... delta 6250366
[    0.172000] ..... mult: 268451175
[    0.172000] ..... calibration result: 4000234
[    0.172000] ..... CPU clock speed is 2631.2298 MHz.
[    0.172000] ..... host bus clock speed is 1000.0234 MHz.
[    0.172097] Performance Events: unsupported p6 CPU model 44 no PMU driver, software events only.
[    0.177263] x86: Booted up 1 node, 1 CPUs
[    0.178751] smpboot: Total of 1 processors activated (5386.90 BogoMIPS)
[    0.180231] devtmpfs: initialized
[    0.194344] xor: measuring software checksum speed
[    0.248041]    prefetch64-sse:   113.000 MB/sec
[    0.296028]    generic_sse:   111.000 MB/sec
[    0.297566] xor: using function: prefetch64-sse (113.000 MB/sec)
[    0.299497] atomic64_test: passed for x86-64 platform with CX8 and with SSE
[    0.300413] NET: Registered protocol family 16
[    0.304983] cpuidle: using governor ladder
[    0.308094] cpuidle: using governor menu
[    0.310210] ACPI: bus type PCI registered
[    0.312009] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[    0.316994] PCI: Using configuration type 1 for base access
[    0.400013] raid6: sse2x1    3621 MB/s
[    0.468017] raid6: sse2x2    6303 MB/s
[    0.536014] raid6: sse2x4    7383 MB/s
[    0.537503] raid6: using algorithm sse2x4 (7383 MB/s)
[    0.539230] raid6: using ssse3x2 recovery algorithm
[    0.540577] ACPI: Added _OSI(Module Device)
[    0.542148] ACPI: Added _OSI(Processor Device)
[    0.544006] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.545705] ACPI: Added _OSI(Processor Aggregator Device)
[    0.550821] ACPI: Interpreter enabled
[    0.552161] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S1_] (20140926/hwxface-580)
[    0.556182] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S2_] (20140926/hwxface-580)
[    0.564324] ACPI: (supports S0 S3 S4 S5)
[    0.568006] ACPI: Using IOAPIC for interrupt routing
[    0.569938] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.578236] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.580013] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
[    0.582077] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[    0.588223] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
[    0.592550] acpiphp: Slot [3] registered
[    0.594111] acpiphp: Slot [4] registered
[    0.596076] acpiphp: Slot [5] registered
[    0.600309] acpiphp: Slot [6] registered
[    0.604057] acpiphp: Slot [7] registered
[    0.605611] acpiphp: Slot [8] registered
[    0.608183] acpiphp: Slot [9] registered
[    0.609741] acpiphp: Slot [10] registered
[    0.612077] acpiphp: Slot [11] registered
[    0.616231] acpiphp: Slot [12] registered
[    0.618302] acpiphp: Slot [13] registered
[    0.620057] acpiphp: Slot [14] registered
[    0.621639] acpiphp: Slot [15] registered
[    0.624292] acpiphp: Slot [24] registered
[    0.625850] acpiphp: Slot [25] registered
[    0.628170] acpiphp: Slot [26] registered
[    0.632075] acpiphp: Slot [27] registered
[    0.633630] acpiphp: Slot [28] registered
[    0.636147] acpiphp: Slot [29] registered
[    0.637718] acpiphp: Slot [30] registered
[    0.639299] acpiphp: Slot [31] registered
[    0.640045] PCI host bridge to bus 0000:00
[    0.644100] pci_bus 0000:00: root bus resource [bus 00-ff]
[    0.645909] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7]
[    0.648133] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff]
[    0.650073] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff]
[    0.652145] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff]
[    0.654756] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[    0.656697] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[    0.660885] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[    0.669246] pci 0000:00:01.1: reg 0x20: [io  0xc080-0xc08f]
[    0.672375] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
[    0.674484] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
[    0.676025] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
[    0.680019] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
[    0.684468] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[    0.688017] pci 0000:00:01.3: quirk: [io  0xb000-0xb03f] claimed by PIIX4 ACPI
[    0.690817] pci 0000:00:01.3: quirk: [io  0xb100-0xb10f] claimed by PIIX4 SMB
[    0.692383] pci 0000:00:02.0: [1013:00b8] type 00 class 0x030000
[    0.696943] pci 0000:00:02.0: reg 0x10: [mem 0xfc000000-0xfdffffff pref]
[    0.701697] pci 0000:00:02.0: reg 0x14: [mem 0xfebf0000-0xfebf0fff]
[    0.713782] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[    0.718148] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[    0.721523] pci 0000:00:03.0: reg 0x10: [mem 0xfeba0000-0xfebbffff]
[    0.725189] pci 0000:00:03.0: reg 0x14: [io  0xc000-0xc03f]
[    0.733201] pci 0000:00:03.0: reg 0x30: [mem 0xfebc0000-0xfebdffff pref]
[    0.735665] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000
[    0.737361] pci 0000:00:04.0: reg 0x10: [io  0xc040-0xc07f]
[    0.741322] pci 0000:00:04.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff]
[    0.750824] pci 0000:00:05.0: [8086:25ab] type 00 class 0x088000
[    0.752678] pci 0000:00:05.0: reg 0x10: [mem 0xfebf2000-0xfebf200f]
[    0.760549] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[    0.763225] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[    0.765850] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[    0.768273] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[    0.770748] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
[    0.773761] ACPI: Enabled 16 GPEs in block 00 to 0F
[    0.776406] vgaarb: setting as boot device: PCI:0000:00:02.0
[    0.780000] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
[    0.780034] vgaarb: loaded
[    0.781334] vgaarb: bridge control possible 0000:00:02.0
[    0.784447] SCSI subsystem initialized
[    0.786195] libata version 3.00 loaded.
[    0.788143] ACPI: bus type USB registered
[    0.789961] usbcore: registered new interface driver usbfs
[    0.792106] usbcore: registered new interface driver hub
[    0.794002] usbcore: registered new device driver usb
[    0.795826] pps_core: LinuxPPS API ver. 1 registered
[    0.796021] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.800059] PTP clock support registered
[    0.808307] EDAC MC: Ver: 3.0.0
[    0.810094] PCI: Using ACPI for IRQ routing
[    0.812019] PCI: pci_cache_line_size set to 64 bytes
[    0.813895] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[    0.816020] e820: reserve RAM buffer [mem 0x13ffe000-0x13ffffff]
[    0.821398] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
[    0.824169] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
[    0.828022] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
[    0.840688] Switched to clocksource kvm-clock
[    0.889267] pnp: PnP ACPI init
[    0.890766] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
[    0.893089] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
[    0.895229] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
[    0.897415] pnp 00:03: [dma 2]
[    0.898809] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
[    0.901003] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active)
[    0.909421] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
[    0.911589] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active)
[    0.913950] pnp: PnP ACPI: found 7 devices
[    0.923987] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7]
[    0.925859] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff]
[    0.927685] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff]
[    0.929684] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff]
[    0.931743] NET: Registered protocol family 2
[    0.933801] TCP established hash table entries: 4096 (order: 3, 32768 bytes)
[    0.935950] TCP bind hash table entries: 4096 (order: 4, 65536 bytes)
[    0.938005] TCP: Hash tables configured (established 4096 bind 4096)
[    0.940161] TCP: reno registered
[    0.941556] UDP hash table entries: 256 (order: 1, 8192 bytes)
[    0.943419] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
[    0.945621] NET: Registered protocol family 1
[    0.947472] RPC: Registered named UNIX socket transport module.
[    0.949395] RPC: Registered udp transport module.
[    0.951029] RPC: Registered tcp transport module.
[    0.953370] RPC: Registered tcp NFSv4.1 backchannel transport module

^ permalink raw reply	[flat|nested] 7+ messages in thread
end of thread, other threads:[~2014-11-13 14:08 UTC | newest]

Thread overview: 7+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2014-11-13 12:39 [x86, irq] INFO: task swapper/0:1 blocked for more than 120 seconds Fengguang Wu
2014-11-13 12:39 ` Fengguang Wu
2014-11-13 13:41 ` [x86, irq] BUG: kernel boot hang Fengguang Wu
2014-11-13 13:41   ` Fengguang Wu
2014-11-13 14:08   ` Jiang Liu
2014-11-13 14:08     ` Jiang Liu
  -- strict thread matches above, loose matches on Subject: below --
2014-11-10  5:39 lkp

This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.