early console in setup code Probing EDD (edd=off to disable)... ok early console in decompress_kernel Decompressing Linux... Parsing ELF... No relocation needed... done. Booting the kernel. [ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Linux version 3.14.0-rc4-00097-g4242b70 (kbuild@roam) (gcc version 4.8.1 (Debian 4.8.1-8) ) #112 SMP PREEMPT Sun Mar 2 17:23:43 CST 2014 [ 0.000000] KERNEL supported cpus: [ 0.000000] Intel GenuineIntel [ 0.000000] AMD AuthenticAMD [ 0.000000] UMC UMC UMC UMC [ 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-0x000000000fffdfff] usable [ 0.000000] BIOS-e820: [mem 0x000000000fffe000-0x000000000fffffff] 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 = 0xfffe max_arch_pfn = 0x1000000 [ 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 0x000fdac0-0x000fdacf] mapped at [c00fdac0] [ 0.000000] mpc: fdad0-fdbec [ 0.000000] initial memory mapped: [mem 0x00000000-0x02dfffff] [ 0.000000] Base memory trampoline at [c009b000] 9b000 size 16384 [ 0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff] [ 0.000000] [mem 0x00000000-0x000fffff] page 4k [ 0.000000] init_memory_mapping: [mem 0x0e400000-0x0e5fffff] [ 0.000000] [mem 0x0e400000-0x0e5fffff] page 4k [ 0.000000] BRK [0x0280d000, 0x0280dfff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x0c000000-0x0e3fffff] [ 0.000000] [mem 0x0c000000-0x0e3fffff] page 4k [ 0.000000] BRK [0x0280e000, 0x0280efff] PGTABLE [ 0.000000] BRK [0x0280f000, 0x0280ffff] PGTABLE [ 0.000000] BRK [0x02810000, 0x02810fff] PGTABLE [ 0.000000] BRK [0x02811000, 0x02811fff] PGTABLE [ 0.000000] BRK [0x02812000, 0x02812fff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x00100000-0x0bffffff] [ 0.000000] [mem 0x00100000-0x0bffffff] page 4k [ 0.000000] init_memory_mapping: [mem 0x0e600000-0x0fffdfff] [ 0.000000] [mem 0x0e600000-0x0fffdfff] page 4k [ 0.000000] RAMDISK: [mem 0x0e7ab000-0x0ffeffff] [ 0.000000] ACPI: RSDP 000fd930 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0fffe450 000034 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0fffff80 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0fffe490 0011A9 (v01 BXPC BXDSDT 00000001 INTL 20100528) [ 0.000000] ACPI: FACS 0fffff40 000040 [ 0.000000] ACPI: SSDT 0ffff7a0 000796 (v01 BOCHS BXPCSSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: APIC 0ffff680 000080 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0ffff640 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] 255MB LOWMEM available. [ 0.000000] mapped low ram: 0 - 0fffe000 [ 0.000000] low ram: 0 - 0fffe000 [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: cpu 0, msr 0:fffd001, boot clock [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x00001000-0x00ffffff] [ 0.000000] Normal [mem 0x01000000-0x0fffdfff] [ 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-0x0fffdfff] [ 0.000000] On node 0 totalpages: 65436 [ 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: 540 pages used for memmap [ 0.000000] Normal zone: 61438 pages, LIFO batch:15 [ 0.000000] Using APIC driver default [ 0.000000] ACPI: PM-Timer IO Port: 0xb008 [ 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] ACPI: IRQ2 used by override. [ 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] nr_irqs_gsi: 40 [ 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 0x10000000-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 12 pages/cpu @ce793000 s27360 r0 d21792 u49152 [ 0.000000] pcpu-alloc: s27360 r0 d21792 u49152 alloc=12*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [ 0.000000] kvm-clock: cpu 0, msr 0:fffd001, primary cpu clock [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr e795540 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64860 [ 0.000000] Kernel command line: hung_task_panic=1 earlyprintk=ttyS0,115200 debug apic=debug sysrq_always_enabled panic=10 softlockup_panic=1 nmi_watchdog=panic prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal root=/dev/ram0 rw link=/kernel-tests/run-queue/kvm/i386-randconfig-r5-0302/linux-devel:devel-roam-i386-201403021704/.vmlinuz-4242b70d68f8ba165f125b9b264ae27d51ace686-20140302172454-5-roam branch=linux-devel/devel-roam-i386-201403021704 BOOT_IMAGE=/kernel/i386-randconfig-r5-0302/4242b70d68f8ba165f125b9b264ae27d51ace686/vmlinuz-3.14.0-rc4-00097-g4242b70 [ 0.000000] sysrq: sysrq always enabled. [ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes) [ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes) [ 0.000000] Initializing CPU#0 [ 0.000000] Initializing HighMem for node 0 (00000000:00000000) [ 0.000000] Memory: 206840K/261744K available (10656K kernel code, 1395K rwdata, 3396K rodata, 616K init, 8400K bss, 54904K reserved, 0K highmem) [ 0.000000] virtual kernel memory layout: [ 0.000000] fixmap : 0xfff15000 - 0xfffff000 ( 936 kB) [ 0.000000] pkmap : 0xffc00000 - 0xffe00000 (2048 kB) [ 0.000000] vmalloc : 0xd07fe000 - 0xffbfe000 ( 756 MB) [ 0.000000] lowmem : 0xc0000000 - 0xcfffe000 ( 255 MB) [ 0.000000] .init : 0xc1f23000 - 0xc1fbd000 ( 616 kB) [ 0.000000] .data : 0xc1a686c4 - 0xc1f22e00 (4841 kB) [ 0.000000] .text : 0xc1000000 - 0xc1a686c4 (10657 kB) [ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok. [ 0.000000] Preemptible hierarchical RCU implementation. [ 0.000000] [ 0.000000] [ 0.000000] [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 [ 0.000000] NR_IRQS:2304 nr_irqs:512 16 [ 0.000000] CPU 0 irqstacks, hard=cdc02000 soft=cdc04000 [ 0.000000] ACPI: Core revision 20131218 [ 0.000000] ACPI: All ACPI Tables successfully acquired [ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Linux version 3.14.0-rc4-00097-g4242b70 (kbuild@roam) (gcc version 4.8.1 (Debian 4.8.1-8) ) #112 SMP PREEMPT Sun Mar 2 17:23:43 CST 2014 [ 0.000000] KERNEL supported cpus: [ 0.000000] Intel GenuineIntel [ 0.000000] AMD AuthenticAMD [ 0.000000] UMC UMC UMC UMC [ 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-0x000000000fffdfff] usable [ 0.000000] BIOS-e820: [mem 0x000000000fffe000-0x000000000fffffff] 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 = 0xfffe max_arch_pfn = 0x1000000 [ 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 0x000fdac0-0x000fdacf] mapped at [c00fdac0] [ 0.000000] mpc: fdad0-fdbec [ 0.000000] initial memory mapped: [mem 0x00000000-0x02dfffff] [ 0.000000] Base memory trampoline at [c009b000] 9b000 size 16384 [ 0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff] [ 0.000000] [mem 0x00000000-0x000fffff] page 4k [ 0.000000] init_memory_mapping: [mem 0x0e400000-0x0e5fffff] [ 0.000000] [mem 0x0e400000-0x0e5fffff] page 4k [ 0.000000] BRK [0x0280d000, 0x0280dfff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x0c000000-0x0e3fffff] [ 0.000000] [mem 0x0c000000-0x0e3fffff] page 4k [ 0.000000] BRK [0x0280e000, 0x0280efff] PGTABLE [ 0.000000] BRK [0x0280f000, 0x0280ffff] PGTABLE [ 0.000000] BRK [0x02810000, 0x02810fff] PGTABLE [ 0.000000] BRK [0x02811000, 0x02811fff] PGTABLE [ 0.000000] BRK [0x02812000, 0x02812fff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x00100000-0x0bffffff] [ 0.000000] [mem 0x00100000-0x0bffffff] page 4k [ 0.000000] init_memory_mapping: [mem 0x0e600000-0x0fffdfff] [ 0.000000] [mem 0x0e600000-0x0fffdfff] page 4k [ 0.000000] RAMDISK: [mem 0x0e7ab000-0x0ffeffff] [ 0.000000] ACPI: RSDP 000fd930 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0fffe450 000034 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0fffff80 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0fffe490 0011A9 (v01 BXPC BXDSDT 00000001 INTL 20100528) [ 0.000000] ACPI: FACS 0fffff40 000040 [ 0.000000] ACPI: SSDT 0ffff7a0 000796 (v01 BOCHS BXPCSSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: APIC 0ffff680 000080 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0ffff640 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] 255MB LOWMEM available. [ 0.000000] mapped low ram: 0 - 0fffe000 [ 0.000000] low ram: 0 - 0fffe000 [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: cpu 0, msr 0:fffd001, boot clock [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x00001000-0x00ffffff] [ 0.000000] Normal [mem 0x01000000-0x0fffdfff] [ 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-0x0fffdfff] [ 0.000000] On node 0 totalpages: 65436 [ 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: 540 pages used for memmap [ 0.000000] Normal zone: 61438 pages, LIFO batch:15 [ 0.000000] Using APIC driver default [ 0.000000] ACPI: PM-Timer IO Port: 0xb008 [ 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] ACPI: IRQ2 used by override. [ 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] nr_irqs_gsi: 40 [ 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 0x10000000-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 12 pages/cpu @ce793000 s27360 r0 d21792 u49152 [ 0.000000] pcpu-alloc: s27360 r0 d21792 u49152 alloc=12*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [ 0.000000] kvm-clock: cpu 0, msr 0:fffd001, primary cpu clock [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr e795540 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64860 [ 0.000000] Kernel command line: hung_task_panic=1 earlyprintk=ttyS0,115200 debug apic=debug sysrq_always_enabled panic=10 softlockup_panic=1 nmi_watchdog=panic prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal root=/dev/ram0 rw link=/kernel-tests/run-queue/kvm/i386-randconfig-r5-0302/linux-devel:devel-roam-i386-201403021704/.vmlinuz-4242b70d68f8ba165f125b9b264ae27d51ace686-20140302172454-5-roam branch=linux-devel/devel-roam-i386-201403021704 BOOT_IMAGE=/kernel/i386-randconfig-r5-0302/4242b70d68f8ba165f125b9b264ae27d51ace686/vmlinuz-3.14.0-rc4-00097-g4242b70 [ 0.000000] sysrq: sysrq always enabled. [ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes) [ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes) [ 0.000000] Initializing CPU#0 [ 0.000000] Initializing HighMem for node 0 (00000000:00000000) [ 0.000000] Memory: 206840K/261744K available (10656K kernel code, 1395K rwdata, 3396K rodata, 616K init, 8400K bss, 54904K reserved, 0K highmem) [ 0.000000] virtual kernel memory layout: [ 0.000000] fixmap : 0xfff15000 - 0xfffff000 ( 936 kB) [ 0.000000] pkmap : 0xffc00000 - 0xffe00000 (2048 kB) [ 0.000000] vmalloc : 0xd07fe000 - 0xffbfe000 ( 756 MB) [ 0.000000] lowmem : 0xc0000000 - 0xcfffe000 ( 255 MB) [ 0.000000] .init : 0xc1f23000 - 0xc1fbd000 ( 616 kB) [ 0.000000] .data : 0xc1a686c4 - 0xc1f22e00 (4841 kB) [ 0.000000] .text : 0xc1000000 - 0xc1a686c4 (10657 kB) [ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok. [ 0.000000] Preemptible hierarchical RCU implementation. [ 0.000000] [ 0.000000] [ 0.000000] [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 [ 0.000000] NR_IRQS:2304 nr_irqs:512 16 [ 0.000000] CPU 0 irqstacks, hard=cdc02000 soft=cdc04000 [ 0.000000] ACPI: Core revision 20131218 [ 0.000000] ACPI: All ACPI Tables successfully acquired [ 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: 16384 [ 0.000000] ... MAX_LOCKDEP_ENTRIES: 16384 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 32768 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 32768 [ 0.000000] ... CHAINHASH_SIZE: 16384 [ 0.000000] ... CHAINHASH_SIZE: 16384 [ 0.000000] memory used by lock dependency info: 3567 kB [ 0.000000] memory used by lock dependency info: 3567 kB [ 0.000000] per task-struct memory footprint: 1152 bytes [ 0.000000] per task-struct memory footprint: 1152 bytes [ 0.000000] allocated 1048576 bytes of page_cgroup [ 0.000000] allocated 1048576 bytes of page_cgroup [ 0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups [ 0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups [ 0.000000] hpet clockevent registered [ 0.000000] hpet clockevent registered [ 0.000000] tsc: Detected 2892.998 MHz processor [ 0.000000] tsc: Detected 2892.998 MHz processor [ 0.020000] Calibrating delay loop (skipped) preset value.. [ 0.020000] Calibrating delay loop (skipped) preset value.. 5785.99 BogoMIPS (lpj=28929980) 5785.99 BogoMIPS (lpj=28929980) [ 0.020000] pid_max: default: 4096 minimum: 301 [ 0.020000] pid_max: default: 4096 minimum: 301 [ 0.020000] Security Framework initialized [ 0.020000] Security Framework initialized [ 0.020000] Mount-cache hash table entries: 512 [ 0.020000] Mount-cache hash table entries: 512 [ 0.021085] Initializing cgroup subsys memory [ 0.021085] Initializing cgroup subsys memory [ 0.022463] Initializing cgroup subsys devices [ 0.022463] Initializing cgroup subsys devices [ 0.023715] Initializing cgroup subsys freezer [ 0.023715] Initializing cgroup subsys freezer [ 0.025265] Initializing cgroup subsys blkio [ 0.025265] Initializing cgroup subsys blkio [ 0.026412] Initializing cgroup subsys perf_event [ 0.026412] Initializing cgroup subsys perf_event [ 0.028202] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.028202] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.028202] tlb_flushall_shift: 6 [ 0.028202] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.028202] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.028202] tlb_flushall_shift: 6 [ 0.030710] debug: unmapping init [mem 0xc1fbd000-0xc1fc1fff] [ 0.030710] debug: unmapping init [mem 0xc1fbd000-0xc1fc1fff] [ 0.041220] Getting VERSION: 50014 [ 0.041220] Getting VERSION: 50014 [ 0.042181] Getting VERSION: 50014 [ 0.042181] Getting VERSION: 50014 [ 0.043145] Getting ID: 0 [ 0.043145] Getting ID: 0 [ 0.043986] Getting ID: f000000 [ 0.043986] Getting ID: f000000 [ 0.045136] Getting LVT0: 8700 [ 0.045136] Getting LVT0: 8700 [ 0.045963] Getting LVT1: 8400 [ 0.045963] Getting LVT1: 8400 [ 0.046842] Enabling APIC mode: Flat. Using 1 I/O APICs [ 0.046842] Enabling APIC mode: Flat. Using 1 I/O APICs [ 0.048582] enabled ExtINT on CPU#0 [ 0.048582] enabled ExtINT on CPU#0 [ 0.051275] ENABLING IO-APIC IRQs [ 0.051275] ENABLING IO-APIC IRQs [ 0.052167] init IO_APIC IRQs [ 0.052167] init IO_APIC IRQs [ 0.053232] apic 0 pin 0 not connected [ 0.053232] apic 0 pin 0 not connected [ 0.054684] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1) [ 0.054684] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1) [ 0.056948] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1) [ 0.056948] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1) [ 0.059194] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1) [ 0.059194] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1) [ 0.060058] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1) [ 0.060058] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1) [ 0.062283] IOAPIC[0]: Set routing entry (0-5 -> 0x35 -> IRQ 5 Mode:1 Active:0 Dest:1) [ 0.062283] IOAPIC[0]: Set routing entry (0-5 -> 0x35 -> IRQ 5 Mode:1 Active:0 Dest:1) [ 0.065174] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1) [ 0.065174] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1) [ 0.067519] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1) [ 0.067519] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1) [ 0.070058] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1) [ 0.070058] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1) [ 0.072510] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:1) [ 0.072510] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:1) [ 0.075072] IOAPIC[0]: Set routing entry (0-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:1) [ 0.075072] IOAPIC[0]: Set routing entry (0-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:1) [ 0.078484] IOAPIC[0]: Set routing entry (0-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:1) [ 0.078484] IOAPIC[0]: Set routing entry (0-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:1) [ 0.080060] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1) [ 0.080060] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1) [ 0.082524] IOAPIC[0]: Set routing entry (0-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:1) [ 0.082524] IOAPIC[0]: Set routing entry (0-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:1) [ 0.084842] IOAPIC[0]: Set routing entry (0-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:1) [ 0.084842] IOAPIC[0]: Set routing entry (0-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:1) [ 0.087285] IOAPIC[0]: Set routing entry (0-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:1) [ 0.087285] IOAPIC[0]: Set routing entry (0-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:1) [ 0.090049] apic 0 pin 16 not connected [ 0.090049] apic 0 pin 16 not connected [ 0.091416] apic 0 pin 17 not connected [ 0.091416] apic 0 pin 17 not connected [ 0.092792] apic 0 pin 18 not connected [ 0.092792] apic 0 pin 18 not connected [ 0.093828] apic 0 pin 19 not connected [ 0.093828] apic 0 pin 19 not connected [ 0.094997] apic 0 pin 20 not connected [ 0.094997] apic 0 pin 20 not connected [ 0.096237] apic 0 pin 21 not connected [ 0.096237] apic 0 pin 21 not connected [ 0.097270] apic 0 pin 22 not connected [ 0.097270] apic 0 pin 22 not connected [ 0.100021] apic 0 pin 23 not connected [ 0.100021] apic 0 pin 23 not connected [ 0.101294] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.101294] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.103343] smpboot: CPU0: [ 0.103343] smpboot: CPU0: Intel Intel Common KVM processorCommon KVM processor (fam: 0f, model: 06 (fam: 0f, model: 06, stepping: 01) , stepping: 01) [ 0.106445] Using local APIC timer interrupts. [ 0.106445] calibrating APIC timer ... [ 0.106445] Using local APIC timer interrupts. [ 0.106445] calibrating APIC timer ... [ 0.110000] ... lapic delta = 6250042 [ 0.110000] ... lapic delta = 6250042 [ 0.110000] ... PM-Timer delta = 357961 [ 0.110000] ... PM-Timer delta = 357961 [ 0.110000] ... PM-Timer result ok [ 0.110000] ... PM-Timer result ok [ 0.110000] ..... delta 6250042 [ 0.110000] ..... delta 6250042 [ 0.110000] ..... mult: 268437259 [ 0.110000] ..... mult: 268437259 [ 0.110000] ..... calibration result: 10000067 [ 0.110000] ..... calibration result: 10000067 [ 0.110000] ..... CPU clock speed is 2893.0193 MHz. [ 0.110000] ..... CPU clock speed is 2893.0193 MHz. [ 0.110000] ..... host bus clock speed is 1000.0067 MHz. [ 0.110000] ..... host bus clock speed is 1000.0067 MHz. [ 0.110147] Performance Events: [ 0.110147] 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.170879] CPU 1 irqstacks, hard=cdc58000 soft=cdc5a000 [ 0.170879] CPU 1 irqstacks, hard=cdc58000 soft=cdc5a000 [ 0.172745] x86: Booting SMP configuration: [ 0.172745] x86: Booting SMP configuration: [ 0.174102] .... node #0, CPUs: [ 0.174102] .... node #0, CPUs: #1 #1 [ 0.010000] Initializing CPU#1 [ 0.020000] kvm-clock: cpu 1, msr 0:fffd021, secondary cpu clock [ 0.020000] masked ExtINT on CPU#1 [ 0.200552] x86: Booted up 1 node, 2 CPUs [ 0.200552] x86: Booted up 1 node, 2 CPUs [ 0.201832] smpboot: Total of 2 processors activated (11571.99 BogoMIPS) [ 0.201832] smpboot: Total of 2 processors activated (11571.99 BogoMIPS) [ 0.200412] KVM setup async PF for cpu 1 [ 0.200412] KVM setup async PF for cpu 1 [ 0.205653] gcov: version magic: 0x3430382a [ 0.205653] gcov: version magic: 0x3430382a [ 0.200412] kvm-stealtime: cpu 1, msr e7a1540 [ 0.200412] kvm-stealtime: cpu 1, msr e7a1540 [ 0.208464] prandom: seed boundary self test passed [ 0.208464] prandom: seed boundary self test passed [ 0.210753] prandom: 100 self tests passed [ 0.210753] prandom: 100 self tests passed [ 0.210761] atomic64 test passed for i586+ platform with CX8 and with SSE [ 0.210761] atomic64 test passed for i586+ platform with CX8 and with SSE [ 0.212748] regulator-dummy: no parameters [ 0.212748] regulator-dummy: no parameters [ 0.213204] RTC time: 17:25:13, date: 03/02/14 [ 0.213204] RTC time: 17:25:13, date: 03/02/14 [ 0.213739] NET: Registered protocol family 16 [ 0.213739] NET: Registered protocol family 16 [ 0.214641] EISA bus registered [ 0.214641] EISA bus registered [ 0.214681] cpuidle: using governor menu [ 0.214681] cpuidle: using governor menu [ 0.214781] [ 0.214781] [ 0.214783] ============================================= [ 0.214783] ============================================= [ 0.214784] [ INFO: possible recursive locking detected ] [ 0.214784] [ INFO: possible recursive locking detected ] [ 0.214787] 3.14.0-rc4-00097-g4242b70 #112 Not tainted [ 0.214787] 3.14.0-rc4-00097-g4242b70 #112 Not tainted [ 0.214788] --------------------------------------------- [ 0.214788] --------------------------------------------- [ 0.214790] netns/16 is trying to acquire lock: [ 0.214790] netns/16 is trying to acquire lock: [ 0.214804] (&rq->lock){-.-...}, at: [] balance_sds+0x30f/0xfa0 [ 0.214804] (&rq->lock){-.-...}, at: [] balance_sds+0x30f/0xfa0 [ 0.214805] [ 0.214805] but task is already holding lock: [ 0.214805] [ 0.214805] but task is already holding lock: [ 0.214812] (&rq->lock){-.-...}, at: [] __schedule+0x211/0x1060 [ 0.214812] (&rq->lock){-.-...}, at: [] __schedule+0x211/0x1060 [ 0.214813] [ 0.214813] other info that might help us debug this: [ 0.214813] [ 0.214813] other info that might help us debug this: [ 0.214814] Possible unsafe locking scenario: [ 0.214814] [ 0.214814] Possible unsafe locking scenario: [ 0.214814] [ 0.214815] CPU0 [ 0.214815] CPU0 [ 0.214816] ---- [ 0.214816] ---- [ 0.214818] lock(&rq->lock); [ 0.214818] lock(&rq->lock); [ 0.214820] lock(&rq->lock); [ 0.214820] lock(&rq->lock); [ 0.214820] [ 0.214820] *** DEADLOCK *** [ 0.214820] [ 0.214820] [ 0.214820] *** DEADLOCK *** [ 0.214820] [ 0.214821] May be due to missing lock nesting notation [ 0.214821] [ 0.214821] May be due to missing lock nesting notation [ 0.214821] [ 0.214823] 2 locks held by netns/16: [ 0.214823] 2 locks held by netns/16: [ 0.214829] #0: (&rq->lock){-.-...}, at: [] __schedule+0x211/0x1060 [ 0.214829] #0: (&rq->lock){-.-...}, at: [] __schedule+0x211/0x1060 [ 0.214835] #1: (rcu_read_lock){.+.+..}, at: [] new_idle_balance+0x83/0x8a0 [ 0.214835] #1: (rcu_read_lock){.+.+..}, at: [] new_idle_balance+0x83/0x8a0 [ 0.214836] [ 0.214836] stack backtrace: [ 0.214836] [ 0.214836] stack backtrace: [ 0.214840] CPU: 0 PID: 16 Comm: netns Not tainted 3.14.0-rc4-00097-g4242b70 #112 [ 0.214840] CPU: 0 PID: 16 Comm: netns Not tainted 3.14.0-rc4-00097-g4242b70 #112 [ 0.214854] c22475d0 cdc6fc70 c1a4dcf9 c22475d0 cdc6fccc c11080f7 c1d13608 cdc466f4 [ 0.214854] c22475d0 cdc6fc70 c1a4dcf9 c22475d0 cdc6fccc c11080f7 c1d13608 cdc466f4 [ 0.214861] 00000010 00000000 00000003 0000028f 00000000 c2029328 c22475d0 00000000 [ 0.214861] 00000010 00000000 00000003 0000028f 00000000 c2029328 c22475d0 00000000 [ 0.214868] 00000000 00000000 c222f500 00000000 00000002 00000000 4c028013 cdc46430 [ 0.214868] 00000000 00000000 c222f500 00000000 00000002 00000000 4c028013 cdc46430 [ 0.214869] Call Trace: [ 0.214869] Call Trace: [ 0.214875] [] dump_stack+0xb8/0x157 [ 0.214875] [] dump_stack+0xb8/0x157 [ 0.214880] [] __lock_acquire+0x1757/0x1be0 [ 0.214880] [] __lock_acquire+0x1757/0x1be0 [ 0.214884] [] lock_acquire+0xd1/0x120 [ 0.214884] [] lock_acquire+0xd1/0x120 [ 0.214888] [] ? balance_sds+0x30f/0xfa0 [ 0.214888] [] ? balance_sds+0x30f/0xfa0 [ 0.214892] [] _raw_spin_lock+0x78/0xc0 [ 0.214892] [] _raw_spin_lock+0x78/0xc0 [ 0.214895] [] ? balance_sds+0x30f/0xfa0 [ 0.214895] [] ? balance_sds+0x30f/0xfa0 [ 0.214899] [] balance_sds+0x30f/0xfa0 [ 0.214899] [] balance_sds+0x30f/0xfa0 [ 0.214903] [] ? __lock_acquire+0x71f/0x1be0 [ 0.214903] [] ? __lock_acquire+0x71f/0x1be0 [ 0.214909] [] new_idle_balance+0x6db/0x8a0 [ 0.214909] [] new_idle_balance+0x6db/0x8a0 [ 0.214912] [] ? new_idle_balance+0x83/0x8a0 [ 0.214912] [] ? new_idle_balance+0x83/0x8a0 [ 0.214918] [] __schedule+0x5c5/0x1060 [ 0.214918] [] __schedule+0x5c5/0x1060 [ 0.214921] [] ? enqueue_task_fair+0x678/0x700 [ 0.214921] [] ? enqueue_task_fair+0x678/0x700 [ 0.214926] [] ? _raw_spin_unlock_irq+0x68/0x120 [ 0.214926] [] ? _raw_spin_unlock_irq+0x68/0x120 [ 0.214930] [] ? trace_hardirqs_on_caller+0x2d2/0x420 [ 0.214930] [] ? trace_hardirqs_on_caller+0x2d2/0x420 [ 0.214935] [] ? rescuer_thread+0xc5/0x580 [ 0.214935] [] ? rescuer_thread+0xc5/0x580 [ 0.214964] [] schedule+0xcb/0x120 [ 0.214964] [] schedule+0xcb/0x120 [ 0.214967] [] rescuer_thread+0x4e7/0x580 [ 0.214967] [] rescuer_thread+0x4e7/0x580 [ 0.214971] [] ? _raw_spin_unlock_irqrestore+0x13b/0x160 [ 0.214971] [] ? _raw_spin_unlock_irqrestore+0x13b/0x160 [ 0.214975] [] ? process_one_work+0x800/0x800 [ 0.214975] [] ? process_one_work+0x800/0x800 [ 0.214979] [] kthread+0x143/0x160 [ 0.214979] [] kthread+0x143/0x160 [ 0.214982] [] ? trace_hardirqs_on_caller+0x2d2/0x420 [ 0.214982] [] ? trace_hardirqs_on_caller+0x2d2/0x420 [ 0.214989] [] ret_from_kernel_thread+0x1b/0x30 [ 0.214989] [] ret_from_kernel_thread+0x1b/0x30 [ 0.214992] [] ? kthread_stop+0x120/0x120 [ 0.214992] [] ? kthread_stop+0x120/0x120 [ 0.220000] BUG: spinlock lockup suspected on CPU#0, netns/16 [ 0.220000] BUG: spinlock lockup suspected on CPU#0, netns/16 [ 0.220000] lock: 0xce799380, .magic: dead4ead, .owner: netns/16, .owner_cpu: 0 [ 0.220000] lock: 0xce799380, .magic: dead4ead, .owner: netns/16, .owner_cpu: 0 [ 0.220000] CPU: 0 PID: 16 Comm: netns Not tainted 3.14.0-rc4-00097-g4242b70 #112 [ 0.220000] CPU: 0 PID: 16 Comm: netns Not tainted 3.14.0-rc4-00097-g4242b70 #112 [ 0.220000] ce799380 [ 0.220000] ce799380 cdc6fcb8 cdc6fcb8 c1a4dcf9 c1a4dcf9 cdc466f4 cdc466f4 cdc6fce4 cdc6fce4 c1a49715 c1a49715 c1d19e4c c1d19e4c ce799380 ce799380 [ 0.220000] dead4ead [ 0.220000] dead4ead cdc466f4 cdc466f4 00000010 00000010 00000000 00000000 ce799380 ce799380 ac6fa570 ac6fa570 00000000 00000000 cdc6fcfc cdc6fcfc [ 0.220000] c110ef52 [ 0.220000] c110ef52 ac6fa570 ac6fa570 ce799380 ce799380 ce799380 ce799380 ce799380 ce799380 cdc6fd18 cdc6fd18 c1a64ead c1a64ead 00000000 00000000 [ 0.220000] Call Trace: [ 0.220000] Call Trace: [ 0.220000] [] dump_stack+0xb8/0x157 [ 0.220000] [] dump_stack+0xb8/0x157 [ 0.220000] [] spin_dump+0xe7/0xfd [ 0.220000] [] spin_dump+0xe7/0xfd [ 0.220000] [] do_raw_spin_lock+0x152/0x300 [ 0.220000] [] do_raw_spin_lock+0x152/0x300 [ 0.220000] [] _raw_spin_lock+0x8d/0xc0 [ 0.220000] [] _raw_spin_lock+0x8d/0xc0 [ 0.220000] [] ? balance_sds+0x30f/0xfa0 [ 0.220000] [] ? balance_sds+0x30f/0xfa0 [ 0.220000] [] balance_sds+0x30f/0xfa0 [ 0.220000] [] balance_sds+0x30f/0xfa0 [ 0.220000] [] ? __lock_acquire+0x71f/0x1be0 [ 0.220000] [] ? __lock_acquire+0x71f/0x1be0 [ 0.220000] [] new_idle_balance+0x6db/0x8a0 [ 0.220000] [] new_idle_balance+0x6db/0x8a0 [ 0.220000] [] ? new_idle_balance+0x83/0x8a0 [ 0.220000] [] ? new_idle_balance+0x83/0x8a0 [ 0.220000] [] __schedule+0x5c5/0x1060 [ 0.220000] [] __schedule+0x5c5/0x1060 [ 0.220000] [] ? enqueue_task_fair+0x678/0x700 [ 0.220000] [] ? enqueue_task_fair+0x678/0x700 [ 0.220000] [] ? _raw_spin_unlock_irq+0x68/0x120 [ 0.220000] [] ? _raw_spin_unlock_irq+0x68/0x120 [ 0.220000] [] ? trace_hardirqs_on_caller+0x2d2/0x420 [ 0.220000] [] ? trace_hardirqs_on_caller+0x2d2/0x420 [ 0.220000] [] ? rescuer_thread+0xc5/0x580 [ 0.220000] [] ? rescuer_thread+0xc5/0x580 [ 0.220000] [] schedule+0xcb/0x120 [ 0.220000] [] schedule+0xcb/0x120 [ 0.220000] [] rescuer_thread+0x4e7/0x580 [ 0.220000] [] rescuer_thread+0x4e7/0x580 [ 0.220000] [] ? _raw_spin_unlock_irqrestore+0x13b/0x160 [ 0.220000] [] ? _raw_spin_unlock_irqrestore+0x13b/0x160 [ 0.220000] [] ? process_one_work+0x800/0x800 [ 0.220000] [] ? process_one_work+0x800/0x800 [ 0.220000] [] kthread+0x143/0x160 [ 0.220000] [] kthread+0x143/0x160 [ 0.220000] [] ? trace_hardirqs_on_caller+0x2d2/0x420 [ 0.220000] [] ? trace_hardirqs_on_caller+0x2d2/0x420 [ 0.220000] [] ret_from_kernel_thread+0x1b/0x30 [ 0.220000] [] ret_from_kernel_thread+0x1b/0x30 [ 0.220000] [] ? kthread_stop+0x120/0x120 [ 0.220000] [] ? kthread_stop+0x120/0x120 [ 0.220000] sending NMI to all CPUs: [ 0.220000] sending NMI to all CPUs: [ 0.220000] NMI backtrace for cpu 1 [ 0.220000] NMI backtrace for cpu 1 [ 0.220000] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 3.14.0-rc4-00097-g4242b70 #112 [ 0.220000] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 3.14.0-rc4-00097-g4242b70 #112 [ 0.220000] task: cdc3c000 ti: cdc4e000 task.ti: cdc4e000 [ 0.220000] task: cdc3c000 ti: cdc4e000 task.ti: cdc4e000 [ 0.220000] EIP: 0060:[] EFLAGS: 00200246 CPU: 1 [ 0.220000] EIP: 0060:[] EFLAGS: 00200246 CPU: 1 [ 0.220000] EIP is at native_safe_halt+0x13/0x40 [ 0.220000] EIP is at native_safe_halt+0x13/0x40 [ 0.220000] EAX: c1017456 EBX: cdc4e000 ECX: cdc3c000 EDX: 00000000 [ 0.220000] EAX: c1017456 EBX: cdc4e000 ECX: cdc3c000 EDX: 00000000 [ 0.220000] ESI: c1f1fdf0 EDI: cdc4ff7c EBP: cdc4ff64 ESP: cdc4ff64 [ 0.220000] ESI: c1f1fdf0 EDI: cdc4ff7c EBP: cdc4ff64 ESP: cdc4ff64 [ 0.220000] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 [ 0.220000] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 [ 0.220000] CR0: 8005003b CR2: ffffffff CR3: 01fc5000 CR4: 000006b0 [ 0.220000] CR0: 8005003b CR2: ffffffff CR3: 01fc5000 CR4: 000006b0 [ 0.220000] Stack: [ 0.220000] Stack: [ 0.220000] cdc4ff6c [ 0.220000] cdc4ff6c c1017469 c1017469 cdc4ff74 cdc4ff74 c10189ae c10189ae cdc4ff90 cdc4ff90 c11286d9 c11286d9 e73f57f8 e73f57f8 757e623a 757e623a [ 0.220000] d5dfb4f8 [ 0.220000] d5dfb4f8 00000000 00000000 00000000 00000000 cdc4ffb4 cdc4ffb4 c104d36c c104d36c 00000000 00000000 00000000 00000000 00000000 00000000 [ 0.220000] 00000000 [ 0.220000] 00000000 fcaaecfb fcaaecfb d5dfb4f8 d5dfb4f8 01000800 01000800 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 [ 0.220000] Call Trace: [ 0.220000] Call Trace: [ 0.220000] [] default_idle+0x29/0x40 [ 0.220000] [] default_idle+0x29/0x40 [ 0.220000] [] arch_cpu_idle+0x2e/0x80 [ 0.220000] [] arch_cpu_idle+0x2e/0x80 [ 0.220000] [] cpu_startup_entry+0x299/0x400 [ 0.220000] [] cpu_startup_entry+0x299/0x400 [ 0.220000] [] start_secondary+0x4ec/0x500 [ 0.220000] [] start_secondary+0x4ec/0x500 [ 0.220000] Code: [ 0.220000] Code: 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 55 55 83 83 05 05 f0 f0 60 60 ff ff c1 c1 01 01 89 89 e5 e5 83 83 15 15 f4 f4 60 60 ff ff c1 c1 00 00 fb fb f4 f4 <83> <83> 05 05 f8 f8 60 60 ff ff c1 c1 01 01 83 83 15 15 fc fc 60 60 ff ff c1 c1 00 00 5d 5d c3 c3 eb eb 1b 1b 90 90 90 90 90 90 [ 0.220000] INFO: NMI handler (arch_trigger_all_cpu_backtrace_handler) took too long to run: 77.009 msecs [ 0.220000] INFO: NMI handler (arch_trigger_all_cpu_backtrace_handler) took too long to run: 77.009 msecs [ 0.220000] NMI backtrace for cpu 0 [ 0.220000] NMI backtrace for cpu 0 [ 0.220000] CPU: 0 PID: 16 Comm: netns Not tainted 3.14.0-rc4-00097-g4242b70 #112 [ 0.220000] CPU: 0 PID: 16 Comm: netns Not tainted 3.14.0-rc4-00097-g4242b70 #112 [ 0.220000] task: cdc46430 ti: cdc6e000 task.ti: cdc6e000 [ 0.220000] task: cdc46430 ti: cdc6e000 task.ti: cdc6e000 [ 0.220000] EIP: 0060:[] EFLAGS: 00010046 CPU: 0 [ 0.220000] EIP: 0060:[] EFLAGS: 00010046 CPU: 0 [ 0.220000] EIP is at default_send_IPI_mask_logical+0x1ba/0x260 [ 0.220000] EIP is at default_send_IPI_mask_logical+0x1ba/0x260 [ 0.220000] EAX: fffff000 EBX: 03000000 ECX: fffff000 EDX: 00000c00 [ 0.220000] EAX: fffff000 EBX: 03000000 ECX: fffff000 EDX: 00000c00 [ 0.220000] ESI: 00000046 EDI: 00000002 EBP: cdc6fcc8 ESP: cdc6fcb8 [ 0.220000] ESI: 00000046 EDI: 00000002 EBP: cdc6fcc8 ESP: cdc6fcb8 [ 0.220000] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 [ 0.220000] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 [ 0.220000] CR0: 8005003b CR2: 000000a8 CR3: 01fc5000 CR4: 000006b0 [ 0.220000] CR0: 8005003b CR2: 000000a8 CR3: 01fc5000 CR4: 000006b0 [ 0.220000] Stack: [ 0.220000] Stack: [ 0.220000] 00000800 00002710 ac6fa570 00000000 cdc6fcd4 c105461a 00002710 cdc6fce4 [ 0.220000] 00000800 00002710 ac6fa570 00000000 cdc6fcd4 c105461a 00002710 cdc6fce4 [ 0.220000] c1054c6f c1d0840b ce799380 cdc6fcfc c110ef65 ac6fa570 ce799380 ce799380 [ 0.220000] c1054c6f c1d0840b ce799380 cdc6fcfc c110ef65 ac6fa570 ce799380 ce799380 [ 0.220000] ce799380 cdc6fd18 c1a64ead 00000000 00000002 00000000 c10f05ef ce7a5380 [ 0.220000] ce799380 cdc6fd18 c1a64ead 00000000 00000002 00000000 c10f05ef ce7a5380 [ 0.220000] Call Trace: [ 0.220000] Call Trace: [ 0.220000] [] default_send_IPI_all+0x3a/0x120 [ 0.220000] [] default_send_IPI_all+0x3a/0x120 [ 0.220000] [] arch_trigger_all_cpu_backtrace+0xaf/0x1a0 [ 0.220000] [] arch_trigger_all_cpu_backtrace+0xaf/0x1a0 [ 0.220000] [] do_raw_spin_lock+0x165/0x300 [ 0.220000] [] do_raw_spin_lock+0x165/0x300 [ 0.220000] [] _raw_spin_lock+0x8d/0xc0 [ 0.220000] [] _raw_spin_lock+0x8d/0xc0 [ 0.220000] [] ? balance_sds+0x30f/0xfa0 [ 0.220000] [] ? balance_sds+0x30f/0xfa0 [ 0.220000] [] balance_sds+0x30f/0xfa0 [ 0.220000] [] balance_sds+0x30f/0xfa0 [ 0.220000] [] ? __lock_acquire+0x71f/0x1be0 [ 0.220000] [] ? __lock_acquire+0x71f/0x1be0 [ 0.220000] [] new_idle_balance+0x6db/0x8a0 [ 0.220000] [] new_idle_balance+0x6db/0x8a0 [ 0.220000] [] ? new_idle_balance+0x83/0x8a0 [ 0.220000] [] ? new_idle_balance+0x83/0x8a0 [ 0.220000] [] __schedule+0x5c5/0x1060 [ 0.220000] [] __schedule+0x5c5/0x1060 [ 0.220000] [] ? enqueue_task_fair+0x678/0x700 [ 0.220000] [] ? enqueue_task_fair+0x678/0x700 [ 0.220000] [] ? _raw_spin_unlock_irq+0x68/0x120 [ 0.220000] [] ? _raw_spin_unlock_irq+0x68/0x120 [ 0.220000] [] ? trace_hardirqs_on_caller+0x2d2/0x420 [ 0.220000] [] ? trace_hardirqs_on_caller+0x2d2/0x420 [ 0.220000] [] ? rescuer_thread+0xc5/0x580 [ 0.220000] [] ? rescuer_thread+0xc5/0x580 [ 0.220000] [] schedule+0xcb/0x120 [ 0.220000] [] schedule+0xcb/0x120 [ 0.220000] [] rescuer_thread+0x4e7/0x580 [ 0.220000] [] rescuer_thread+0x4e7/0x580 [ 0.220000] [] ? _raw_spin_unlock_irqrestore+0x13b/0x160 [ 0.220000] [] ? _raw_spin_unlock_irqrestore+0x13b/0x160 [ 0.220000] [] ? process_one_work+0x800/0x800 [ 0.220000] [] ? process_one_work+0x800/0x800 [ 0.220000] [] kthread+0x143/0x160 [ 0.220000] [] kthread+0x143/0x160 [ 0.220000] [] ? trace_hardirqs_on_caller+0x2d2/0x420 [ 0.220000] [] ? trace_hardirqs_on_caller+0x2d2/0x420 [ 0.220000] [] ret_from_kernel_thread+0x1b/0x30 [ 0.220000] [] ret_from_kernel_thread+0x1b/0x30 [ 0.220000] [] ? kthread_stop+0x120/0x120 [ 0.220000] [] ? kthread_stop+0x120/0x120 [ 0.220000] Code: 00 80 ce 04 83 05 10 c0 fe c1 01 83 15 14 c0 fe c1 00 83 05 88 bf fe c1 01 83 15 8c bf fe c1 00 a1 f0 f8 de c1 89 90 00 c3 ff ff <83> 05 90 bf fe c1 01 83 15 94 bf fe c1 00 83 05 18 c0 fe c1 01 [ 0.220000] Code: 00 80 ce 04 83 05 10 c0 fe c1 01 83 15 14 c0 fe c1 00 83 05 88 bf fe c1 01 83 15 8c bf fe c1 00 a1 f0 f8 de c1 89 90 00 c3 ff ff <83> 05 90 bf fe c1 01 83 15 94 bf fe c1 00 83 05 18 c0 fe c1 01 Elapsed time: 215 qemu-system-x86_64 -cpu kvm64 -enable-kvm -kernel /kernel/i386-randconfig-r5-0302/4242b70d68f8ba165f125b9b264ae27d51ace686/vmlinuz-3.14.0-rc4-00097-g4242b70 -append 'hung_task_panic=1 earlyprintk=ttyS0,115200 debug apic=debug sysrq_always_enabled panic=10 softlockup_panic=1 nmi_watchdog=panic prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal root=/dev/ram0 rw link=/kernel-tests/run-queue/kvm/i386-randconfig-r5-0302/linux-devel:devel-roam-i386-201403021704/.vmlinuz-4242b70d68f8ba165f125b9b264ae27d51ace686-20140302172454-5-roam branch=linux-devel/devel-roam-i386-201403021704 BOOT_IMAGE=/kernel/i386-randconfig-r5-0302/4242b70d68f8ba165f125b9b264ae27d51ace686/vmlinuz-3.14.0-rc4-00097-g4242b70' -initrd /kernel-tests/initrd/quantal-core-i386.cgz -m 256 -smp 2 -net nic,vlan=1,model=e1000 -net user,vlan=1,hostfwd=tcp::11032-:22 -boot order=nc -no-reboot -watchdog i6300esb -rtc base=localtime -drive file=/fs/LABEL=KVM/disk0-quantal-roam-10,media=disk,if=virtio -drive file=/fs/LABEL=KVM/disk1-quantal-roam-10,media=disk,if=virtio -drive file=/fs/LABEL=KVM/disk2-quantal-roam-10,media=disk,if=virtio -drive file=/fs/LABEL=KVM/disk3-quantal-roam-10,media=disk,if=virtio -drive file=/fs/LABEL=KVM/disk4-quantal-roam-10,media=disk,if=virtio -drive file=/fs/LABEL=KVM/disk5-quantal-roam-10,media=disk,if=virtio -pidfile /dev/shm/kboot/pid-quantal-roam-10 -serial file:/dev/shm/kboot/serial-quantal-roam-10 -daemonize -display none -monitor null