early console in setup code [ 0.000000] Linux version 3.18.0-rc2-ge754569 (kbuild@lkp-ib03) (gcc version 4.9.1 (Debian 4.9.1-19) ) #16 SMP Thu Dec 11 00:48:31 CST 2014 [ 0.000000] e820: BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x0000000013fdffff] usable [ 0.000000] BIOS-e820: [mem 0x0000000013fe0000-0x0000000013ffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] 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 = 0x13fe0 max_arch_pfn = 0x1000000 [ 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 0x7040600070406, 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 0x000f0eb0-0x000f0ebf] mapped at [400f0eb0] [ 0.000000] mpc: f0ec0-f0fa4 [ 0.000000] initial memory mapped: [mem 0x00000000-0x133fffff] [ 0.000000] Base memory trampoline at [4009b000] 9b000 size 16384 [ 0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff] [ 0.000000] [mem 0x00000000-0x000fffff] page 4k [ 0.000000] init_memory_mapping: [mem 0x10200000-0x103fffff] [ 0.000000] [mem 0x10200000-0x103fffff] page 4k [ 0.000000] init_memory_mapping: [mem 0x10000000-0x101fffff] [ 0.000000] [mem 0x10000000-0x101fffff] page 4k [ 0.000000] init_memory_mapping: [mem 0x0c000000-0x0fffffff] [ 0.000000] [mem 0x0c000000-0x0fffffff] page 4k [ 0.000000] init_memory_mapping: [mem 0x00100000-0x0bffffff] [ 0.000000] [mem 0x00100000-0x0bffffff] page 4k [ 0.000000] init_memory_mapping: [mem 0x10400000-0x13fdffff] [ 0.000000] [mem 0x10400000-0x13fdffff] page 4k [ 0.000000] BRK [0x127b2000, 0x127b2fff] PGTABLE [ 0.000000] RAMDISK: [mem 0x12793000-0x13fd7fff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x000F0C90 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x13FE18BD 000034 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x13FE0B37 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x13FE0040 000AF7 (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x13FE0000 000040 [ 0.000000] ACPI: SSDT 0x13FE0BAB 000C5A (v01 BOCHS BXPCSSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: APIC 0x13FE1805 000080 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x13FE1885 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001) [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffb000 ( fee00000) [ 0.000000] 0MB HIGHMEM available. [ 0.000000] 319MB LOWMEM available. [ 0.000000] mapped low ram: 0 - 13fe0000 [ 0.000000] low ram: 0 - 13fe0000 [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: cpu 0, msr 0:13fdf001, primary cpu clock [ 0.000000] BRK [0x127b3000, 0x127b3fff] PGTABLE [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x00001000-0x00ffffff] [ 0.000000] Normal [mem 0x01000000-0x13fdffff] [ 0.000000] HighMem 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-0x13fdffff] [ 0.000000] Initmem setup node 0 [mem 0x00001000-0x13fdffff] [ 0.000000] On node 0 totalpages: 81790 [ 0.000000] free_area_init_node: node 0, pgdat 51bfbc40, node_mem_map 5012a024 [ 0.000000] DMA zone: 36 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 3998 pages, LIFO batch:0 [ 0.000000] Normal zone: 684 pages used for memmap [ 0.000000] Normal zone: 77792 pages, LIFO batch:15 [ 0.000000] Using APIC driver default [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffb000 ( fee00000) [ 0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled) [ 0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] 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 2 CPUs, 0 hotplug CPUs [ 0.000000] mapped IOAPIC to ffffa000 (fec00000) [ 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:2 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 13 pages/cpu @5010f000 s31072 r0 d22176 u53248 [ 0.000000] pcpu-alloc: s31072 r0 d22176 u53248 alloc=13*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr 10111840 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 81070 [ 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/i386-randconfig-ib0-12102048/linux-devel:devel-lkp-ib03-smoke-201412102113:e754569101f392e1924d8ce6f087ea4cfad91d69:bisect-linux-5/.vmlinuz-e754569101f392e1924d8ce6f087ea4cfad91d69-20141211004901-32-client1 branch=linux-devel/devel-lkp-ib03-smoke-201412102113 BOOT_IMAGE=/kernel/i386-randconfig-ib0-12102048/e754569101f392e1924d8ce6f087ea4cfad91d69/vmlinuz-3.18.0-rc2-ge754569 drbd.minor_count=8 [ 0.000000] PID hash table entries: 2048 (order: 1, 8192 bytes) [ 0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes) [ 0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.000000] Initializing CPU#0 [ 0.000000] Initializing HighMem for node 0 (00000000:00000000) [ 0.000000] Memory: 262372K/327160K available (15292K kernel code, 5217K rwdata, 8304K rodata, 808K init, 6264K bss, 64788K reserved, 0K highmem) [ 0.000000] virtual kernel memory layout: [ 0.000000] fixmap : 0xfff16000 - 0xfffff000 ( 932 kB) [ 0.000000] pkmap : 0xff800000 - 0xffa00000 (2048 kB) [ 0.000000] vmalloc : 0x547e0000 - 0xff7fe000 (2736 MB) [ 0.000000] lowmem : 0x40000000 - 0x53fe0000 ( 319 MB) [ 0.000000] .init : 0x52027000 - 0x520f1000 ( 808 kB) [ 0.000000] .data : 0x512ef71d - 0x52025500 (13527 kB) [ 0.000000] .text : 0x50400000 - 0x512ef71d (15293 kB) [ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok. [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 [ 0.000000] NR_IRQS:2304 nr_irqs:440 0 [ 0.000000] CPU 0 irqstacks, hard=4fc08000 soft=4fc0a000 [ 0.000000] console [ttyS0] enabled [ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.000000] ... MAX_LOCK_DEPTH: 48 [ 0.000000] ... MAX_LOCKDEP_KEYS: 8191 [ 0.000000] ... CLASSHASH_SIZE: 4096 [ 0.000000] ... MAX_LOCKDEP_ENTRIES: 32768 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 65536 [ 0.000000] ... CHAINHASH_SIZE: 32768 [ 0.000000] memory used by lock dependency info: 4895 kB [ 0.000000] per task-struct memory footprint: 1152 bytes [ 0.000000] ------------------------ [ 0.000000] | Locking API testsuite: [ 0.000000] ---------------------------------------------------------------------------- [ 0.000000] | spin |wlock |rlock |mutex | wsem | rsem | [ 0.000000] -------------------------------------------------------------------------- [ 0.000000] A-A deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] A-B-B-A deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] A-B-B-C-C-A deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] A-B-C-A-B-C deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] A-B-B-C-C-D-D-A deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] A-B-C-D-B-D-D-A deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] A-B-C-D-B-C-D-A deadlock:failed|failed| ok |failed|failed|failed| [ 0.000000] double unlock: ok | ok | ok | ok | ok | ok | [ 0.000000] initialize held: ok | ok | ok | ok | ok | ok | [ 0.000000] bad unlock order: ok | ok | ok | ok | ok | ok | [ 0.000000] -------------------------------------------------------------------------- [ 0.000000] recursive read-lock: | ok | |failed| [ 0.000000] recursive read-lock #2: | ok | |failed| [ 0.000000] mixed read-write-lock: |failed| |failed| [ 0.000000] mixed write-read-lock: |failed| |failed| [ 0.000000] -------------------------------------------------------------------------- [ 0.000000] hard-irqs-on + irq-safe-A/12:failed|failed| ok | [ 0.000000] soft-irqs-on + irq-safe-A/12:failed|failed| ok | [ 0.000000] hard-irqs-on + irq-safe-A/21:failed|failed| ok | [ 0.000000] soft-irqs-on + irq-safe-A/21:failed|failed| ok | [ 0.000000] sirq-safe-A => hirqs-on/12:failed|failed| ok | [ 0.000000] sirq-safe-A => hirqs-on/21:failed|failed| ok | [ 0.000000] hard-safe-A + irqs-on/12:failed|failed| ok | [ 0.000000] soft-safe-A + irqs-on/12:failed|failed| ok | [ 0.000000] hard-safe-A + irqs-on/21:failed|failed| ok | [ 0.000000] soft-safe-A + irqs-on/21:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #1/123:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #1/123:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #1/132:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #1/132:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #1/213:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #1/213:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #1/231:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #1/231:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #1/312:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #1/312:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #1/321:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #1/321:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #2/123:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #2/123:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #2/132:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #2/132:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #2/213:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #2/213:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #2/231:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #2/231:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #2/312:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #2/312:failed|failed| ok | [ 0.000000] hard-safe-A + unsafe-B #2/321:failed|failed| ok | [ 0.000000] soft-safe-A + unsafe-B #2/321:failed|failed| ok | [ 0.000000] hard-irq lock-inversion/123:failed|failed| ok | [ 0.000000] soft-irq lock-inversion/123:failed|failed| ok | [ 0.000000] hard-irq lock-inversion/132:failed|failed| ok | [ 0.000000] soft-irq lock-inversion/132:failed|failed| ok | [ 0.000000] hard-irq lock-inversion/213:failed|failed| ok | [ 0.000000] soft-irq lock-inversion/213:failed|failed| ok | [ 0.000000] hard-irq lock-inversion/231:failed|failed| ok | [ 0.000000] soft-irq lock-inversion/231:failed|failed| ok | [ 0.000000] hard-irq lock-inversion/312:failed|failed| ok | [ 0.000000] soft-irq lock-inversion/312:failed|failed| ok | [ 0.000000] hard-irq lock-inversion/321:failed|failed| ok | [ 0.000000] soft-irq lock-inversion/321:failed|failed| ok | [ 0.000000] hard-irq read-recursion/123: ok | [ 0.000000] soft-irq read-recursion/123: ok | [ 0.000000] hard-irq read-recursion/132: ok | [ 0.000000] soft-irq read-recursion/132: ok | [ 0.000000] hard-irq read-recursion/213: ok | [ 0.000000] soft-irq read-recursion/213: ok | [ 0.000000] hard-irq read-recursion/231: ok | [ 0.000000] soft-irq read-recursion/231: ok | [ 0.000000] hard-irq read-recursion/312: ok | [ 0.000000] soft-irq read-recursion/312: ok | [ 0.000000] hard-irq read-recursion/321: ok | [ 0.000000] soft-irq read-recursion/321: ok | [ 0.000000] -------------------------------------------------------------------------- [ 0.000000] | Wound/wait tests | [ 0.000000] --------------------- [ 0.000000] ww api failures: ok | ok | ok | [ 0.000000] ww contexts mixing:failed| ok | [ 0.000000] finishing ww context: ok | ok | ok | ok | [ 0.000000] locking mismatches: ok | ok | ok | [ 0.000000] EDEADLK handling: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | [ 0.000000] spinlock nest unlocked: ok | [ 0.000000] ----------------------------------------------------- [ 0.000000] |block | try |context| [ 0.000000] ----------------------------------------------------- [ 0.000000] context:failed| ok | ok | [ 0.000000] try:failed| ok |failed| [ 0.000000] block:failed| ok |failed| [ 0.000000] spinlock:failed| ok |failed| [ 0.000000] -------------------------------------------------------- [ 0.000000] 141 out of 253 testcases failed, as expected. | [ 0.000000] ---------------------------------------------------- [ 0.000000] hpet clockevent registered [ 0.000000] tsc: Detected 2992.588 MHz processor [ 0.030000] Calibrating delay loop (skipped) preset value.. 5985.17 BogoMIPS (lpj=29925880) [ 0.030000] pid_max: default: 4096 minimum: 301 [ 0.030136] ACPI: Core revision 20140926 [ 0.034876] ACPI: All ACPI Tables successfully acquired [ 0.036034] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes) [ 0.040069] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes) [ 0.042053] mce: CPU supports 10 MCE banks [ 0.042820] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.042820] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.051438] debug: unmapping init [mem 0x520f1000-0x520f9fff] [ 0.073066] Getting VERSION: 1050014 [ 0.073705] Getting VERSION: 1050014 [ 0.074338] Getting ID: 0 [ 0.074801] Getting ID: f000000 [ 0.075340] Getting LVT0: 8700 [ 0.075845] Getting LVT1: 8400 [ 0.076368] Enabling APIC mode: Flat. Using 1 I/O APICs [ 0.080109] enabled ExtINT on CPU#0 [ 0.091151] ENABLING IO-APIC IRQs [ 0.091748] init IO_APIC IRQs [ 0.100007] apic 0 pin 0 not connected [ 0.100648] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1) [ 0.101970] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1) [ 0.110060] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1) [ 0.111363] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1) [ 0.112662] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1) [ 0.113952] IOAPIC[0]: Set routing entry (0-5 -> 0x35 -> IRQ 5 Mode:1 Active:0 Dest:1) [ 0.115246] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1) [ 0.116534] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1) [ 0.117858] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1) [ 0.120028] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:1) [ 0.121351] IOAPIC[0]: Set routing entry (0-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:1) [ 0.130141] IOAPIC[0]: Set routing entry (0-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:1) [ 0.131544] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1) [ 0.140107] IOAPIC[0]: Set routing entry (0-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:1) [ 0.141428] IOAPIC[0]: Set routing entry (0-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:1) [ 0.142802] IOAPIC[0]: Set routing entry (0-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:1) [ 0.150071] apic 0 pin 16 not connected [ 0.150725] apic 0 pin 17 not connected [ 0.151377] apic 0 pin 18 not connected [ 0.152027] apic 0 pin 19 not connected [ 0.152675] apic 0 pin 20 not connected [ 0.153337] apic 0 pin 21 not connected [ 0.153983] apic 0 pin 22 not connected [ 0.154634] apic 0 pin 23 not connected [ 0.160000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.160015] smpboot: CPU0: Intel Common KVM processor (fam: 0f, model: 06, stepping: 01) [ 0.162025] Using local APIC timer interrupts. [ 0.162025] calibrating APIC timer ... [ 0.170000] ... lapic delta = 7563287 [ 0.170000] ... PM-Timer delta = 433173 [ 0.170000] APIC calibration not consistent with PM-Timer: 121ms instead of 100ms [ 0.170000] APIC delta adjusted to PM-Timer: 6249948 (7563287) [ 0.170000] TSC delta adjusted to PM-Timer: 299258833 (362143869) [ 0.170000] ..... delta 6249948 [ 0.170000] ..... mult: 268433222 [ 0.170000] ..... calibration result: 9999916 [ 0.170000] ..... CPU clock speed is 2992.5883 MHz. [ 0.170000] ..... host bus clock speed is 999.9916 MHz. [ 0.170233] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only. [ 0.180282] [ 0.180282] ********************************************************** [ 0.190004] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.191517] ** ** [ 0.193042] ** trace_printk() being used. Allocating extra memory. ** [ 0.194563] ** ** [ 0.197287] ** This means that this is a DEBUG kernel and it is ** [ 0.200005] ** unsafe for produciton use. ** [ 0.205334] ** ** [ 0.210004] ** If you see this message and you are not debugging ** [ 0.220006] ** the kernel, report this immediately to your vendor! ** [ 0.230005] ** ** [ 0.231568] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 0.233138] ********************************************************** [ 0.301585] CPU 1 irqstacks, hard=4ff68000 soft=4ff6a000 [ 0.306904] x86: Booting SMP configuration: [ 0.307897] .... node #0, CPUs: #1 [ 0.030000] Initializing CPU#1 [ 0.030000] kvm-clock: cpu 1, msr 0:13fdf021, secondary cpu clock [ 0.030000] masked ExtINT on CPU#1 [ 0.360194] x86: Booted up 1 node, 2 CPUs [ 0.360130] KVM setup async PF for cpu 1 [ 0.360130] kvm-stealtime: cpu 1, msr 1011e840 [ 0.370742] ---------------- [ 0.371218] | NMI testsuite: [ 0.371706] -------------------- [ 0.372232] remote IPI: ok | [ 0.400225] local IPI: ok | [ 0.460029] -------------------- [ 0.460590] Good, all 2 testcases passed! | [ 0.461299] --------------------------------- [ 0.462008] smpboot: Total of 2 processors activated (11970.35 BogoMIPS) [ 0.470838] devtmpfs: initialized [ 0.502736] xor: measuring software checksum speed [ 0.600014] pIII_sse : 4360.400 MB/sec [ 0.700017] prefetch64-sse: 8184.000 MB/sec [ 0.700757] xor: using function: prefetch64-sse (8184.000 MB/sec) [ 0.701835] atomic64_test: passed for i586+ platform with CX8 and with SSE [ 0.710006] pinctrl core: initialized pinctrl subsystem [ 0.711349] regulator-dummy: no parameters [ 0.712170] RTC time: 0:48:51, date: 12/11/14 [ 0.713397] NET: Registered protocol family 16 [ 0.740021] cpuidle: using governor ladder [ 0.770017] cpuidle: using governor menu [ 0.800017] cpuidle: using governor select [ 0.801613] ACPI: bus type PCI registered [ 0.802291] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.805820] PCI : PCI BIOS area is rw and x. Use pci=nobios if you want it NX. [ 0.806973] PCI: PCI BIOS revision 2.10 entry at 0xfd456, last bus=0 [ 0.881150] Running resizable hashtable tests... [ 0.882000] Adding 2048 keys [ 1.610515] Traversal complete: counted=2048, nelems=2048, entries=2048 [ 1.611868] Table expansion iteration 0... [ 1.730054] Verifying lookups... [ 1.730911] Table expansion iteration 1... [ 1.820071] Verifying lookups... [ 1.821144] Table expansion iteration 2... [ 1.910104] Verifying lookups... [ 1.910974] Table expansion iteration 3... [ 2.000185] Verifying lookups... [ 2.001182] Table shrinkage iteration 0... [ 2.030018] Verifying lookups... [ 2.030915] Table shrinkage iteration 1... [ 2.050024] Verifying lookups... [ 2.050806] Table shrinkage iteration 2... [ 2.080032] Verifying lookups... [ 2.080858] Table shrinkage iteration 3... [ 2.110027] Verifying lookups... [ 2.110838] Deleting 2048 keys [ 2.580017] raid6: mmxx1 2813 MB/s [ 2.750024] raid6: mmxx2 3719 MB/s [ 2.920022] raid6: sse1x1 1461 MB/s [ 3.090037] raid6: sse1x2 745 MB/s [ 3.260033] raid6: sse2x1 1368 MB/s [ 3.430020] raid6: sse2x2 1860 MB/s [ 3.600032] raid6: int32x1 406 MB/s [ 3.770063] raid6: int32x2 423 MB/s [ 3.940075] raid6: int32x4 461 MB/s [ 4.110026] raid6: int32x8 353 MB/s [ 4.110684] raid6: using algorithm mmxx2 (3719 MB/s) [ 4.111538] raid6: using intx1 recovery algorithm [ 4.120033] ACPI: Added _OSI(Module Device) [ 4.120708] ACPI: Added _OSI(Processor Device) [ 4.121482] ACPI: Added _OSI(3.0 _SCP Extensions) [ 4.122300] ACPI: Added _OSI(Processor Aggregator Device) [ 4.131698] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:3) [ 4.140875] ACPI: Interpreter enabled [ 4.141539] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S1_] (20140926/hwxface-580) [ 4.143061] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S2_] (20140926/hwxface-580) [ 4.150903] ACPI: (supports S0 S3 S5) [ 4.151499] ACPI: Using IOAPIC for interrupt routing [ 4.152346] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 4.174709] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 4.175725] acpi PNP0A03:00: _OSC: OS supports [Segments MSI] [ 4.176670] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM [ 4.180704] acpiphp: Slot [3] registered [ 4.181474] acpiphp: Slot [4] registered [ 4.182177] acpiphp: Slot [5] registered [ 4.190065] acpiphp: Slot [6] registered [ 4.190890] acpiphp: Slot [7] registered [ 4.191654] acpiphp: Slot [8] registered [ 4.192421] acpiphp: Slot [9] registered [ 4.193166] acpiphp: Slot [10] registered [ 4.193885] acpiphp: Slot [11] registered [ 4.194608] acpiphp: Slot [12] registered [ 4.195372] acpiphp: Slot [13] registered [ 4.196078] acpiphp: Slot [14] registered [ 4.200080] acpiphp: Slot [15] registered [ 4.200795] acpiphp: Slot [16] registered [ 4.201510] acpiphp: Slot [17] registered [ 4.210121] acpiphp: Slot [18] registered [ 4.210856] acpiphp: Slot [19] registered [ 4.211579] acpiphp: Slot [20] registered [ 4.212308] acpiphp: Slot [21] registered [ 4.213021] acpiphp: Slot [22] registered [ 4.213792] acpiphp: Slot [23] registered [ 4.220072] acpiphp: Slot [24] registered [ 4.220781] acpiphp: Slot [25] registered [ 4.221485] acpiphp: Slot [26] registered [ 4.222200] acpiphp: Slot [27] registered [ 4.230087] acpiphp: Slot [28] registered [ 4.230845] acpiphp: Slot [29] registered [ 4.231566] acpiphp: Slot [30] registered [ 4.232288] acpiphp: Slot [31] registered [ 4.232944] PCI host bridge to bus 0000:00 [ 4.240008] pci_bus 0000:00: root bus resource [bus 00-ff] [ 4.240891] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7] [ 4.250005] pci_bus 0000:00: root bus resource [io 0x0d00-0xadff] [ 4.250998] pci_bus 0000:00: root bus resource [io 0xae0f-0xaeff] [ 4.251987] pci_bus 0000:00: root bus resource [io 0xaf20-0xafdf] [ 4.252983] pci_bus 0000:00: root bus resource [io 0xafe4-0xffff] [ 4.254010] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff] [ 4.255132] pci_bus 0000:00: root bus resource [mem 0x14000000-0xfebfffff] [ 4.256282] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 4.260885] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 4.270405] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 4.273934] pci 0000:00:01.1: reg 0x20: [io 0xc040-0xc04f] [ 4.275795] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 4.280006] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 4.281081] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 4.282230] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 4.290474] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 4.292025] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 4.293193] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 4.294793] pci 0000:00:02.0: [1013:00b8] type 00 class 0x030000 [ 4.300672] pci 0000:00:02.0: reg 0x10: [mem 0xfc000000-0xfdffffff pref] [ 4.310116] pci 0000:00:02.0: reg 0x14: [mem 0xfebf0000-0xfebf0fff] [ 4.320613] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref] [ 4.322749] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000 [ 4.330922] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff] [ 4.332803] pci 0000:00:03.0: reg 0x14: [io 0xc000-0xc03f] [ 4.341314] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 4.350021] pci 0000:00:04.0: [8086:25ab] type 00 class 0x088000 [ 4.351456] pci 0000:00:04.0: reg 0x10: [mem 0xfebf1000-0xfebf100f] [ 4.363437] pci_bus 0000:00: on NUMA node 0 [ 4.370750] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 4.372141] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 4.373362] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 4.374578] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 4.380499] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 4.390000] ACPI: Enabled 16 GPEs in block 00 to 0F [ 4.400137] vgaarb: setting as boot device: PCI:0000:00:02.0 [ 4.400137] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none [ 4.400137] vgaarb: loaded [ 4.400137] vgaarb: bridge control possible 0000:00:02.0 [ 4.400137] sta2x11_scr_init [ 4.400137] sta2x11_apb_soc_regs_init [ 4.400137] sta2x11_sctl_init [ 4.400137] sta2x11_apbreg_init [ 4.400137] SCSI subsystem initialized [ 4.400137] ACPI: bus type USB registered [ 4.400137] usbcore: registered new interface driver usbfs [ 4.401047] usbcore: registered new interface driver hub [ 4.410000] usbcore: registered new device driver usb [ 4.410000] Linux video capture interface: v2.00 [ 4.410000] pps_core: LinuxPPS API ver. 1 registered [ 4.410008] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 4.420282] EDAC MC: Ver: 3.0.0 [ 4.420282] EDAC DEBUG: edac_mc_sysfs_init: device mc created [ 4.427917] Advanced Linux Sound Architecture Driver Initialized. [ 4.427917] PCI: Using ACPI for IRQ routing [ 4.427917] PCI: pci_cache_line_size set to 64 bytes [ 4.427917] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] [ 4.427917] e820: reserve RAM buffer [mem 0x13fe0000-0x13ffffff] [ 4.450762] HPET: 3 timers in total, 0 timers will be used for per-cpu timer [ 4.460088] Switched to clocksource kvm-clock [ 4.461577] Warning: could not register all branches stats [ 4.462693] Warning: could not register annotated branches stats [ 4.702089] FS-Cache: Loaded [ 4.702726] CacheFiles: Loaded [ 4.703309] pnp: PnP ACPI init [ 4.703941] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:3) [ 4.705281] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active) [ 4.706401] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:3) [ 4.707709] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active) [ 4.708825] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:3) [ 4.728396] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active) [ 4.729657] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:3) [ 4.740981] pnp 00:03: [dma 2] [ 4.741564] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active) [ 4.742880] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:3) [ 4.744296] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active) [ 4.745526] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:3) [ 4.746893] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active) [ 4.748605] pnp: PnP ACPI: found 6 devices [ 4.769300] INFO_MDMA: LNW DMA Driver Version 1.1.0 [ 4.806122] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7] [ 4.807038] pci_bus 0000:00: resource 5 [io 0x0d00-0xadff] [ 4.807930] pci_bus 0000:00: resource 6 [io 0xae0f-0xaeff] [ 4.808818] pci_bus 0000:00: resource 7 [io 0xaf20-0xafdf] [ 4.829727] pci_bus 0000:00: resource 8 [io 0xafe4-0xffff] [ 4.830709] pci_bus 0000:00: resource 9 [mem 0x000a0000-0x000bffff] [ 4.831800] pci_bus 0000:00: resource 10 [mem 0x14000000-0xfebfffff] [ 4.832891] NET: Registered protocol family 1 [ 4.833607] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 4.834583] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 4.835525] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 4.836563] pci 0000:00:02.0: Video device with shadowed ROM [ 4.837513] PCI: CLS 0 bytes, default 64 [ 4.838440] Unpacking initramfs... [ 4.859042] Initramfs unpacking failed: junk in compressed archive [ 4.860067] debug: unmapping init [mem 0x52793000-0x53fd7fff] [ 4.861238] BUG: unable to handle kernel paging request at 527b0000 [ 4.862291] IP: [<5044b752>] __change_page_attr_set_clr+0x1a0/0xe18 [ 4.863337] *pdpt = 00000000120fa001 *pde = 00000000127ab063 *pte = 80000000127b0062 [ 4.864641] Oops: 0000 [#1] SMP DEBUG_PAGEALLOC [ 4.865444] CPU: 1 PID: 1 Comm: swapper/0 Not tainted 3.18.0-rc2-ge754569 #16 [ 4.866583] task: 4fc3d2f0 ti: 4fc3e000 task.ti: 4fc3e000 [ 4.867452] EIP: 0060:[<5044b752>] EFLAGS: 00010246 CPU: 1 [ 4.868334] EIP is at __change_page_attr_set_clr+0x1a0/0xe18 [ 4.870989] EAX: 527b0000 EBX: 00000000 ECX: 00000000 EDX: 0001132c [ 4.870989] ESI: 0001132b EDI: 0001132b EBP: 4fc3fe48 ESP: 4fc3fd74 [ 4.870989] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 [ 4.870989] CR0: 8005003b CR2: 527b0000 CR3: 120ff000 CR4: 000006f0 [ 4.870989] Stack: [ 4.870989] 00000000 4fc3d201 00013001 4fc3d728 00000000 51b28be8 00000000 00000000 [ 4.870989] 00000246 00000002 00000000 00000000 51b2e800 51b2e880 00000000 4fc3fdc4 [ 4.870989] 12fff000 00000000 00013000 00000200 51b0d000 00000001 51b2e800 4fc3fe78 [ 4.870989] Call Trace: [ 4.870989] [<5055242a>] ? __purge_vmap_area_lazy+0x3f3/0x3fb [ 4.870989] [<50553df4>] ? vm_unmap_aliases+0x1c1/0x1ca [ 4.870989] [<504a2204>] ? do_raw_spin_unlock+0xd6/0x10b [ 4.870989] [<5044c69c>] change_page_attr_set_clr+0x2d2/0x5c7 [ 4.870989] [<5044d106>] set_memory_np+0x1d/0x1f [ 4.870989] [<50447e68>] free_init_pages+0xcb/0xd6 [ 4.870989] [<520402f3>] free_initrd_mem+0x26/0x2a [ 4.870989] [<5202a4d2>] populate_rootfs+0x176/0x199 [ 4.870989] [<52027efc>] do_one_initcall+0x132/0x217 [ 4.870989] [<5202a35c>] ? do_name+0x344/0x344 [ 4.870989] [<5047cc97>] ? parse_args+0x340/0x407 [ 4.870989] [<520280c4>] kernel_init_freeable+0xe3/0x1a5 [ 4.870989] [<512c837d>] kernel_init+0x9/0x137 [ 4.870989] [<512ede21>] ret_from_kernel_thread+0x21/0x30 [ 4.870989] [<512c8374>] ? rest_init+0xa5/0xa5 [ 4.870989] Code: 89 45 88 e8 3f fe ff ff 85 c0 89 45 b4 0f 94 c0 0f b6 c8 84 c0 8b 3c 8d 00 c4 c8 51 8d 57 01 89 14 8d 00 c4 c8 51 75 3a 8b 45 b4 <8b> 00 89 45 a8 8b 45 b4 8b 40 04 89 45 a0 8b 45 a8 8b 55 a0 8d [ 4.870989] EIP: [<5044b752>] __change_page_attr_set_clr+0x1a0/0xe18 SS:ESP 0068:4fc3fd74 [ 4.870989] CR2: 00000000527b0000 [ 4.870989] ---[ end trace 362599e6ff9cb676 ]--- [ 4.870989] Kernel panic - not syncing: Fatal exception Elapsed time: 15 qemu-system-x86_64 -cpu kvm64 -enable-kvm -kernel /kernel/i386-randconfig-ib0-12102048/e754569101f392e1924d8ce6f087ea4cfad91d69/vmlinuz-3.18.0-rc2-ge754569 -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 link=/kbuild-tests/run-queue/kvm/i386-randconfig-ib0-12102048/linux-devel:devel-lkp-ib03-smoke-201412102113:e754569101f392e1924d8ce6f087ea4cfad91d69:bisect-linux-5/.vmlinuz-e754569101f392e1924d8ce6f087ea4cfad91d69-20141211004901-32-client1 branch=linux-devel/devel-lkp-ib03-smoke-201412102113 BOOT_IMAGE=/kernel/i386-randconfig-ib0-12102048/e754569101f392e1924d8ce6f087ea4cfad91d69/vmlinuz-3.18.0-rc2-ge754569 drbd.minor_count=8' -initrd /kernel-tests/initrd/quantal-core-i386.cgz -m 320 -smp 2 -net nic,vlan=1,model=e1000 -net user,vlan=1 -boot order=nc -no-reboot -watchdog i6300esb -rtc base=localtime -pidfile /dev/shm/kboot/pid-quantal-client1-15 -serial file:/dev/shm/kboot/serial-quantal-client1-15 -daemonize -display none -monitor null