[ 0.000000] Linux version 3.12.0-10888-g60d253c (kbuild@xian) (gcc version 4.8.1 (Debian 4.8.1-8) ) #1482 SMP Thu Nov 21 09:29:31 CST 2013 [ 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] debug: ignoring loglevel setting. [ 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] e820: last_pfn = 0xfffe 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 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 0x000fdac0-0x000fdacf] mapped at [c00fdac0] [ 0.000000] mpc: fdad0-fdbec [ 0.000000] initial memory mapped: [mem 0x00000000-0x037fffff] [ 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 0x0fa00000-0x0fbfffff] [ 0.000000] [mem 0x0fa00000-0x0fbfffff] page 2M [ 0.000000] init_memory_mapping: [mem 0x0c000000-0x0f9fffff] [ 0.000000] [mem 0x0c000000-0x0f9fffff] page 2M [ 0.000000] init_memory_mapping: [mem 0x00100000-0x0bffffff] [ 0.000000] [mem 0x00100000-0x001fffff] page 4k [ 0.000000] [mem 0x00200000-0x0bffffff] page 2M [ 0.000000] init_memory_mapping: [mem 0x0fc00000-0x0fffdfff] [ 0.000000] [mem 0x0fc00000-0x0fdfffff] page 2M [ 0.000000] [mem 0x0fe00000-0x0fffdfff] page 4k [ 0.000000] BRK [0x03298000, 0x03298fff] PGTABLE [ 0.000000] cma: CMA: reserved 28 MiB at 0e000000 [ 0.000000] log_buf_len: 8388608 [ 0.000000] early log buf free: 128036(97%) [ 0.000000] RAMDISK: [mem 0x0fce4000-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 ffffa000 ( fee00000) [ 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] 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] free_area_init_node: node 0, pgdat c26a9000, node_mem_map cd600020 [ 0.000000] DMA zone: 32 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 3998 pages, LIFO batch:0 [ 0.000000] Normal zone: 480 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 ffffa000 ( 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 ffff9000 (fec00000) [ 0.000000] nr_irqs_gsi: 40 [ 0.000000] e820: [mem 0x10000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] setup_percpu: NR_CPUS:32 nr_cpumask_bits:32 nr_cpu_ids:2 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 331 pages/cpu @cd36a000 s1342312 r0 d13464 u1355776 [ 0.000000] pcpu-alloc: s1342312 r0 d13464 u1355776 alloc=331*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 d36c600 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64924 [ 0.000000] Kernel command line: hung_task_panic=1 rcutree.rcu_cpu_stall_timeout=100 log_buf_len=8M ignore_loglevel debug sched_debug apic=debug dynamic_printk sysrq_always_enabled panic=10 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal root=/dev/ram0 rw link=/kernel-tests/run-queue/kvm/i386-randconfig-x1-1121/pm:bleeding-edge/.vmlinuz-60d253cd38fac5dca15d6d71e931e840f6c08e6e-20131121093014-7-athens branch=pm/bleeding-edge BOOT_IMAGE=/kernel/i386-randconfig-x1-1121/60d253cd38fac5dca15d6d71e931e840f6c08e6e/vmlinuz-3.12.0-10888-g60d253c [ 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] Memory: 181320K/261744K available (15348K kernel code, 4497K rwdata, 6724K rodata, 2220K init, 6484K bss, 80424K reserved) [ 0.000000] virtual kernel memory layout: [ 0.000000] fixmap : 0xffd34000 - 0xfffff000 (2860 kB) [ 0.000000] vmalloc : 0xd07fe000 - 0xffd32000 ( 757 MB) [ 0.000000] lowmem : 0xc0000000 - 0xcfffe000 ( 255 MB) [ 0.000000] .init : 0xc29f5000 - 0xc2c20000 (2220 kB) [ 0.000000] .data : 0xc1efd487 - 0xc29f4400 (11227 kB) [ 0.000000] .text : 0xc1000000 - 0xc1efd487 (15349 kB) [ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok. [ 0.000000] SLUB: HWalign=128, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 [ 0.000000] Hierarchical RCU implementation. [ 0.000000] [ 0.000000] [ 0.000000] [ 0.000000] NR_IRQS:2304 nr_irqs:512 16 [ 0.000000] CPU 0 irqstacks, hard=ccc08000 soft=ccc0a000 [ 0.000000] Console: colour VGA+ 80x25 [ 0.000000] console [tty0] enabled [ 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: 16384 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 32768 [ 0.000000] ... CHAINHASH_SIZE: 16384 [ 0.000000] memory used by lock dependency info: 3823 kB [ 0.000000] per task-struct memory footprint: 1920 bytes [ 0.000000] ------------------------ [ 0.000000] | Locking API testsuite: [ 0.000000] ---------------------------------------------------------------------------- [ 0.000000] | spin |wlock |rlock |mutex | wsem | rsem | [ 0.000000] -------------------------------------------------------------------------- [ 0.000000] A-A deadlock: ok | ok | ok | ok | ok | ok | [ 0.000000] A-B-B-A deadlock: ok | ok | ok | ok | ok | ok | [ 0.000000] A-B-B-C-C-A deadlock: ok | ok | ok | ok | ok | ok | [ 0.000000] A-B-C-A-B-C deadlock: ok | ok | ok | ok | ok | ok | [ 0.000000] A-B-B-C-C-D-D-A deadlock: ok | ok | ok | ok | ok | ok | [ 0.000000] A-B-C-D-B-D-D-A deadlock: ok | ok | ok | ok | ok | ok | [ 0.000000] A-B-C-D-B-C-D-A deadlock: ok | ok | ok | ok | ok | ok | [ 0.000000] double unlock: ok | ok | ok | ok | ok | ok | [ 0.000000] initialize held: ok | ok | ok | ok | ok | ok | [ 0.000000] bad unlock order: ok | ok | ok | ok | ok | ok | [ 0.000000] -------------------------------------------------------------------------- [ 0.000000] recursive read-lock: | ok | | ok | [ 0.000000] recursive read-lock #2: | ok | | ok | [ 0.000000] mixed read-write-lock: | ok | | ok | [ 0.000000] mixed write-read-lock: | ok | | ok | [ 0.000000] -------------------------------------------------------------------------- [ 0.000000] hard-irqs-on + irq-safe-A/12: ok | ok | ok | [ 0.000000] soft-irqs-on + irq-safe-A/12: ok | ok | ok | [ 0.000000] hard-irqs-on + irq-safe-A/21: ok | ok | ok | [ 0.000000] soft-irqs-on + irq-safe-A/21: ok | ok | ok | [ 0.000000] sirq-safe-A => hirqs-on/12: ok | ok | ok | [ 0.000000] sirq-safe-A => hirqs-on/21: ok | ok | ok | [ 0.000000] hard-safe-A + irqs-on/12: ok | ok | ok | [ 0.000000] soft-safe-A + irqs-on/12: ok | ok | ok | [ 0.000000] hard-safe-A + irqs-on/21: ok | ok | ok | [ 0.000000] soft-safe-A + irqs-on/21: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #1/123: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #1/123: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #1/132: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #1/132: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #1/213: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #1/213: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #1/231: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #1/231: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #1/312: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #1/312: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #1/321: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #1/321: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #2/123: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #2/123: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #2/132: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #2/132: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #2/213: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #2/213: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #2/231: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #2/231: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #2/312: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #2/312: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #2/321: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #2/321: ok | ok | ok | [ 0.000000] hard-irq lock-inversion/123: ok | ok | ok | [ 0.000000] soft-irq lock-inversion/123: ok | ok | ok | [ 0.000000] hard-irq lock-inversion/132: ok | ok | ok | [ 0.000000] soft-irq lock-inversion/132: ok | ok | ok | [ 0.000000] hard-irq lock-inversion/213: ok | ok | ok | [ 0.000000] soft-irq lock-inversion/213: ok | ok | ok | [ 0.000000] hard-irq lock-inversion/231: ok | ok | ok | [ 0.000000] soft-irq lock-inversion/231: ok | ok | ok | [ 0.000000] hard-irq lock-inversion/312: ok | ok | ok | [ 0.000000] soft-irq lock-inversion/312: ok | ok | ok | [ 0.000000] hard-irq lock-inversion/321: ok | ok | ok | [ 0.000000] soft-irq lock-inversion/321: ok | ok | ok | [ 0.000000] hard-irq read-recursion/123: ok | [ 0.000000] soft-irq read-recursion/123: ok | [ 0.000000] hard-irq read-recursion/132: ok | [ 0.000000] soft-irq read-recursion/132: ok | [ 0.000000] hard-irq read-recursion/213: ok | [ 0.000000] soft-irq read-recursion/213: ok | [ 0.000000] hard-irq read-recursion/231: ok | [ 0.000000] soft-irq read-recursion/231: ok | [ 0.000000] hard-irq read-recursion/312: ok | [ 0.000000] soft-irq read-recursion/312: ok | [ 0.000000] hard-irq read-recursion/321: ok | [ 0.000000] soft-irq read-recursion/321: ok | [ 0.000000] -------------------------------------------------------------------------- [ 0.000000] | Wound/wait tests | [ 0.000000] --------------------- [ 0.000000] ww api failures: ok | ok | ok | [ 0.000000] ww contexts mixing: ok | ok | [ 0.000000] finishing ww context: ok | ok | ok | ok | [ 0.000000] locking mismatches: ok | ok | ok | [ 0.000000] EDEADLK handling: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | [ 0.000000] spinlock nest unlocked: ok | [ 0.000000] ----------------------------------------------------- [ 0.000000] |block | try |context| [ 0.000000] ----------------------------------------------------- [ 0.000000] context: ok | ok | ok | [ 0.000000] try: ok | ok | ok | [ 0.000000] block: ok | ok | ok | [ 0.000000] spinlock: ok | ok | ok | [ 0.000000] ------------------------------------------------------- [ 0.000000] Good, all 253 testcases passed! | [ 0.000000] --------------------------------- [ 0.000000] ODEBUG: 8 of 8 active objects replaced [ 0.000000] ODEBUG: selftest passed [ 0.000000] hpet clockevent registered [ 0.000000] tsc: Detected 2893.018 MHz processor [ 0.008000] Calibrating delay loop (skipped) preset value.. 5786.03 BogoMIPS (lpj=11572072) [ 0.008020] pid_max: default: 32768 minimum: 301 [ 0.009501] Security Framework initialized [ 0.010740] Yama: becoming mindful. [ 0.012098] Mount-cache hash table entries: 512 [ 0.014800] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.014800] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.014800] tlb_flushall_shift: 6 [ 0.021044] Freeing SMP alternatives memory: 24K (c2c20000 - c2c26000) [ 0.030280] ACPI: Core revision 20130927 [ 0.037737] ACPI: All ACPI Tables successfully acquired [ 0.039969] Getting VERSION: 50014 [ 0.040024] Getting VERSION: 50014 [ 0.041135] Getting ID: 0 [ 0.042092] Getting ID: f000000 [ 0.044025] Getting LVT0: 8700 [ 0.045071] Getting LVT1: 8400 [ 0.046124] Enabling APIC mode: Flat. Using 1 I/O APICs [ 0.048141] enabled ExtINT on CPU#0 [ 0.050960] ENABLING IO-APIC IRQs [ 0.052019] init IO_APIC IRQs [ 0.053021] apic 0 pin 0 not connected [ 0.054244] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1) [ 0.056057] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1) [ 0.058403] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1) [ 0.060047] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1) [ 0.064024] IOAPIC[0]: Set routing entry (0-5 -> 0x35 -> IRQ 5 Mode:1 Active:0 Dest:1) [ 0.066364] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1) [ 0.068054] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1) [ 0.070351] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1) [ 0.072064] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:1) [ 0.074382] IOAPIC[0]: Set routing entry (0-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:1) [ 0.076051] IOAPIC[0]: Set routing entry (0-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:1) [ 0.077491] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1) [ 0.080028] IOAPIC[0]: Set routing entry (0-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:1) [ 0.081470] IOAPIC[0]: Set routing entry (0-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:1) [ 0.082917] IOAPIC[0]: Set routing entry (0-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:1) [ 0.084028] apic 0 pin 16 not connected [ 0.084757] apic 0 pin 17 not connected [ 0.085477] apic 0 pin 18 not connected [ 0.086193] apic 0 pin 19 not connected [ 0.086944] apic 0 pin 20 not connected [ 0.088006] apic 0 pin 21 not connected [ 0.088722] apic 0 pin 22 not connected [ 0.089444] apic 0 pin 23 not connected [ 0.090312] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.092007] smpboot: CPU0: Intel Common KVM processor (fam: 0f, model: 06, stepping: 01) [ 0.093851] Using local APIC timer interrupts. [ 0.093851] calibrating APIC timer ... [ 0.096000] ... lapic delta = 6250471 [ 0.096000] ... PM-Timer delta = 357983 [ 0.096000] ... PM-Timer result ok [ 0.096000] ..... delta 6250471 [ 0.096000] ..... mult: 268455685 [ 0.096000] ..... calibration result: 4000301 [ 0.096000] ..... CPU clock speed is 2893.0724 MHz. [ 0.096000] ..... host bus clock speed is 1000.0301 MHz. [ 0.096103] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only. [ 0.098832] ftrace: Allocated trace_printk buffers [ 0.101445] CPU 1 irqstacks, hard=ccf70000 soft=ccf72000 [ 0.102524] x86: Booting SMP configuration: [ 0.103406] .... node #0, CPUs: #1 [ 0.004000] Initializing CPU#1 [ 0.008000] kvm-clock: cpu 1, msr 0:fffd021, secondary cpu clock [ 0.008000] masked ExtINT on CPU#1 [ 0.120203] x86: Booted up 1 node, 2 CPUs [ 0.120136] KVM setup async PF for cpu 1 [ 0.120136] kvm-stealtime: cpu 1, msr d4b7600 [ 0.123611] smpboot: Total of 2 processors activated (11572.07 BogoMIPS) [ 0.124398] CPU0 attaching sched-domain: [ 0.125129] domain 0: span 0-1 level CPU [ 0.125916] groups: 0 1 [ 0.126705] CPU1 attaching sched-domain: [ 0.128009] domain 0: span 0-1 level CPU [ 0.128808] groups: 1 0 [ 0.129935] devtmpfs: initialized [ 0.132886] EVM: security.ima [ 0.133495] EVM: security.capability [ 0.136137] xor: measuring software checksum speed [ 0.176015] pIII_sse : 10849.000 MB/sec [ 0.216018] prefetch64-sse: 11544.000 MB/sec [ 0.216859] xor: using function: prefetch64-sse (11544.000 MB/sec) [ 0.217853] atomic64 test passed for i586+ platform with CX8 and with SSE [ 0.219486] regulator-dummy: no parameters [ 0.225385] NET: Registered protocol family 16 [ 0.227359] EISA bus registered [ 0.228021] cpuidle: using governor ladder [ 0.228760] cpuidle: using governor menu [ 0.230297] ACPI: bus type PCI registered [ 0.231352] PCI : PCI BIOS area is rw and x. Use pci=nobios if you want it NX. [ 0.232011] PCI: PCI BIOS revision 2.10 entry at 0xfc6d5, last bus=0 [ 0.233012] PCI: Using configuration type 1 for base access [ 0.249232] bio: create slab at 0 [ 0.316026] raid6: mmxx1 4385 MB/s [ 0.384026] raid6: mmxx2 4483 MB/s [ 0.452018] raid6: sse1x1 2240 MB/s [ 0.520026] raid6: sse1x2 4171 MB/s [ 0.588019] raid6: sse2x1 6428 MB/s [ 0.656021] raid6: sse2x2 6746 MB/s [ 0.656763] raid6: using algorithm sse2x2 (6746 MB/s) [ 0.657602] raid6: using intx1 recovery algorithm [ 0.658991] ACPI: Added _OSI(Module Device) [ 0.659758] ACPI: Added _OSI(Processor Device) [ 0.660007] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.660814] ACPI: Added _OSI(Processor Aggregator Device) [ 0.673877] ACPI: Interpreter enabled [ 0.674612] ACPI: (supports S0 S5) [ 0.675268] ACPI: Using IOAPIC for interrupt routing [ 0.676067] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.694270] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.695293] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI] [ 0.696080] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM [ 0.697739] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.700123] PCI host bridge to bus 0000:00 [ 0.700871] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.701769] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7] [ 0.702752] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff] [ 0.703732] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff] [ 0.704010] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff] [ 0.705156] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.706923] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.708862] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.713552] pci 0000:00:01.1: reg 0x20: [io 0xc1c0-0xc1cf] [ 0.716506] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.717863] pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI [ 0.719161] pci 0000:00:01.3: quirk: [io 0xb100-0xb10f] claimed by PIIX4 SMB [ 0.720596] pci 0000:00:02.0: [1013:00b8] type 00 class 0x030000 [ 0.723086] pci 0000:00:02.0: reg 0x10: [mem 0xfc000000-0xfdffffff pref] [ 0.725376] pci 0000:00:02.0: reg 0x14: [mem 0xfebf0000-0xfebf0fff] [ 0.734020] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref] [ 0.736070] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000 [ 0.738237] pci 0000:00:03.0: reg 0x10: [mem 0xfeba0000-0xfebbffff] [ 0.740012] pci 0000:00:03.0: reg 0x14: [io 0xc000-0xc03f] [ 0.746930] pci 0000:00:03.0: reg 0x30: [mem 0xfebc0000-0xfebdffff pref] [ 0.748648] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 [ 0.750891] pci 0000:00:04.0: reg 0x10: [io 0xc040-0xc07f] [ 0.753181] pci 0000:00:04.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff] [ 0.760759] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.762951] pci 0000:00:05.0: reg 0x10: [io 0xc080-0xc0bf] [ 0.764614] pci 0000:00:05.0: reg 0x14: [mem 0xfebf2000-0xfebf2fff] [ 0.772774] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.774965] pci 0000:00:06.0: reg 0x10: [io 0xc0c0-0xc0ff] [ 0.776607] pci 0000:00:06.0: reg 0x14: [mem 0xfebf3000-0xfebf3fff] [ 0.784665] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 [ 0.786842] pci 0000:00:07.0: reg 0x10: [io 0xc100-0xc13f] [ 0.788607] pci 0000:00:07.0: reg 0x14: [mem 0xfebf4000-0xfebf4fff] [ 0.796522] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 [ 0.798704] pci 0000:00:08.0: reg 0x10: [io 0xc140-0xc17f] [ 0.800608] pci 0000:00:08.0: reg 0x14: [mem 0xfebf5000-0xfebf5fff] [ 0.808421] pci 0000:00:09.0: [1af4:1001] type 00 class 0x010000 [ 0.810604] pci 0000:00:09.0: reg 0x10: [io 0xc180-0xc1bf] [ 0.812607] pci 0000:00:09.0: reg 0x14: [mem 0xfebf6000-0xfebf6fff] [ 0.820255] pci 0000:00:0a.0: [8086:25ab] type 00 class 0x088000 [ 0.821920] pci 0000:00:0a.0: reg 0x10: [mem 0xfebf7000-0xfebf700f] [ 0.829378] pci_bus 0000:00: on NUMA node 0 [ 0.831896] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 0.832960] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 0.834518] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 0.836650] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 0.838055] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 0.840336] ACPI: Enabled 16 GPEs in block 00 to 0F [ 0.841311] ACPI: \_SB_.PCI0: notify handler is installed [ 0.842356] Found 1 acpi root devices [ 0.843911] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none [ 0.844016] vgaarb: loaded [ 0.844584] vgaarb: bridge control possible 0000:00:02.0 [ 0.845645] ACPI: bus type USB registered [ 0.848052] usbcore: registered new interface driver usbfs [ 0.848967] usbcore: registered new interface driver hub [ 0.850301] usbcore: registered new device driver usb [ 0.852231] media: Linux media interface: v0.10 [ 0.853058] Linux video capture interface: v2.00 [ 0.854035] wmi: Mapper loaded [ 0.854771] PCI: Using ACPI for IRQ routing [ 0.854771] PCI: pci_cache_line_size set to 64 bytes [ 0.856241] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] [ 0.857198] e820: reserve RAM buffer [mem 0x0fffe000-0x0fffffff] [ 0.859387] HPET: 3 timers in total, 0 timers will be used for per-cpu timer [ 0.860244] Switched to clocksource kvm-clock [ 0.861446] Warning: could not register all branches stats [ 0.862356] Warning: could not register annotated branches stats [ 0.909138] FS-Cache: Loaded [ 0.910453] CacheFiles: Loaded [ 0.911476] pnp: PnP ACPI init [ 0.912498] ACPI: bus type PNP registered [ 0.913808] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:3) [ 0.916125] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active) [ 0.917264] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:3) [ 0.919106] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active) [ 0.920835] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:3) [ 0.923252] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active) [ 0.925149] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:3) [ 0.927416] pnp 00:03: [dma 2] [ 0.928434] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active) [ 0.929575] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:3) [ 0.931009] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active) [ 0.932168] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:3) [ 0.935751] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active) [ 0.937615] pnp 00:06: Plug and Play ACPI device, IDs PNP0103 (active) [ 0.939707] pnp: PnP ACPI: found 7 devices [ 0.941107] ACPI: bus type PNP unregistered [ 0.942454] PnPBIOS: Disabled [ 1.318170] mdacon: MDA with 8K of memory detected. [ 1.318371] Console: switching consoles 13-16 to MDA-2 [ 1.356046] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7] [ 1.356964] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff] [ 1.357860] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff] [ 1.358850] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff] [ 1.359878] NET: Registered protocol family 1 [ 1.360701] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 1.361654] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 1.362596] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 1.363592] pci 0000:00:02.0: Boot video device [ 1.364474] PCI: CLS 0 bytes, default 64 [ 1.365629] Unpacking initramfs... [ 1.505396] Freeing initrd memory: 3120K (cfce4000 - cfff0000) [ 1.521082] DMA-API: preallocated 65536 debug entries [ 1.521947] DMA-API: debugging enabled by kernel config [ 1.524970] microcode: CPU0 sig=0xf61, pf=0x1, revision=0x1 [ 1.525929] microcode: CPU1 sig=0xf61, pf=0x1, revision=0x1 [ 1.527212] microcode: Microcode Update Driver: v2.00 , Peter Oruba [ 1.530638] PCLMULQDQ-NI instructions are not detected. [ 1.531893] NatSemi SCx200 Driver [ 1.543739] NTFS driver 2.1.30 [Flags: R/O DEBUG]. [ 1.545814] QNX6 filesystem 1.0.0 registered. [ 1.546961] JFS: nTxBlock = 1665, nTxLock = 13321 [ 1.549544] SGI XFS with security attributes, realtime, debug enabled [ 1.552767] NILFS version 2 loaded [ 1.553802] BeFS version: 0.9.3 [ 1.555391] bio: create slab at 1 [ 1.557444] Btrfs loaded, assert=on, integrity-checker=on [ 1.558515] btrfs: selftest: Running btrfs free space cache tests [ 1.559481] btrfs: selftest: Running extent only tests [ 1.560413] btrfs: selftest: Running bitmap only tests [ 1.561286] btrfs: selftest: Running bitmap and extent tests [ 1.562231] btrfs: selftest: Free space cache tests finished [ 1.563131] btrfs: selftest: Running extent buffer operation tests [ 1.563896] btrfs: selftest: Running btrfs_split_item tests [ 1.565167] btrfs: selftest: Running find delalloc tests [ 2.520170] tsc: Refined TSC clocksource calibration: 2892.943 MHz [ 227.860135] rb_consumer: page allocation failure: order:0, mode:0x10d0 [ 227.861160] CPU: 1 PID: 41 Comm: rb_consumer Not tainted 3.12.0-10888-g60d253c #1482 [ 227.862452] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 227.863352] ffffffff caf23e08 c1edfc10 00000001 000010d0 000010d0 caf23e34 c1142093 [ 227.865207] c2455d5c cad1b1fc 00000000 000010d0 c26a9ba0 000010d0 00000001 00000000 [ 227.867028] 00000000 caf23ecc c1147412 000010d0 00000000 00000000 c26a93e0 00000000 [ 227.868890] Call Trace: [ 227.869412] [] dump_stack+0x7a/0xaa [ 227.870164] [] warn_alloc_failed+0x123/0x1a0 [ 227.871000] [] __alloc_pages_nodemask+0xcc2/0x1160 [ 227.871896] [] ring_buffer_alloc_read_page+0x1e/0x50 [ 227.872874] [] ring_buffer_consumer_thread+0x209/0x500 [ 227.873807] [] ? ring_buffer_producer_thread+0x600/0x600 [ 227.874760] [] kthread+0xfe/0x100 [ 227.875484] [] ? ring_buffer_producer_thread+0x600/0x600 [ 227.876481] [] ret_from_kernel_thread+0x1b/0x28 [ 227.877349] [] ? __kthread_parkme+0x70/0x70 [ 227.878171] Mem-Info: [ 227.878671] DMA per-cpu: [ 227.879197] CPU 0: hi: 0, btch: 1 usd: 0 [ 227.879982] CPU 1: hi: 0, btch: 1 usd: 0 [ 227.880818] Normal per-cpu: [ 227.881375] CPU 0: hi: 42, btch: 7 usd: 0 [ 227.882157] CPU 1: hi: 42, btch: 7 usd: 0 [ 227.882956] active_anon:0 inactive_anon:0 isolated_anon:0 [ 227.882956] active_file:525 inactive_file:36114 isolated_file:0 [ 227.882956] unevictable:4127 dirty:0 writeback:0 unstable:0 [ 227.882956] free:7810 slab_reclaimable:909 slab_unreclaimable:2116 [ 227.882956] mapped:0 shmem:0 pagetables:0 bounce:0 [ 227.882956] free_cma:7168 [ 227.887652] DMA free:896kB min:136kB low:168kB high:204kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:14844kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15992kB managed:15916kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:16kB slab_unreclaimable:40kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:24100 all_unreclaimable? yes [ 227.893377] lowmem_reserve[]: 0 192 192 [ 227.894332] Normal free:30344kB min:1704kB low:2128kB high:2556kB active_anon:0kB inactive_anon:0kB active_file:2100kB inactive_file:129592kB unevictable:16508kB isolated(anon):0kB isolated(file):0kB present:245752kB managed:197220kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:3620kB slab_unreclaimable:8424kB kernel_stack:344kB pagetables:0kB unstable:0kB bounce:0kB free_cma:28672kB writeback_tmp:0kB pages_scanned:32 all_unreclaimable? no [ 227.900266] lowmem_reserve[]: 0 0 0 [ 227.901170] DMA: 0*4kB 0*8kB 0*16kB 0*32kB 0*64kB 1*128kB (R) 1*256kB (R) 1*512kB (R) 0*1024kB 0*2048kB 0*4096kB = 896kB [ 227.903836] Normal: 7*4kB (UR) 3*8kB (UR) 1*16kB (R) 0*32kB 0*64kB 1*128kB (R) 0*256kB 1*512kB (R) 1*1024kB (R) 0*2048kB 7*4096kB (C) = 30404kB [ 227.907031] 40772 total pagecache pages [ 227.907705] 65436 pages RAM [ 227.908294] 0 pages HighMem/MovableOnly [ 227.908960] 12133 pages reserved [ 229.172425] rb_consumer: page allocation failure: order:0, mode:0x10d0 [ 229.173483] CPU: 1 PID: 41 Comm: rb_consumer Not tainted 3.12.0-10888-g60d253c #1482 [ 229.174783] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 229.175687] ffffffff caf23e08 c1edfc10 00000001 000010d0 000010d0 caf23e34 c1142093 [ 229.177571] c2455d5c cad1b1fc 00000000 000010d0 c26a9ba0 000010d0 00000002 00000001 [ 229.179411] 00000000 caf23ecc c1147412 000010d0 00000000 00000000 c26a93e0 00000000 [ 229.181285] Call Trace: [ 229.181820] [] dump_stack+0x7a/0xaa [ 229.182592] [] warn_alloc_failed+0x123/0x1a0 [ 229.183424] [] __alloc_pages_nodemask+0xcc2/0x1160 [ 229.184363] [] ring_buffer_alloc_read_page+0x1e/0x50 [ 229.185286] [] ring_buffer_consumer_thread+0x209/0x500 [ 229.186231] [] ? ring_buffer_producer_thread+0x600/0x600 [ 229.187191] [] kthread+0xfe/0x100 [ 229.187929] [] ? ring_buffer_producer_thread+0x600/0x600 [ 229.188939] [] ret_from_kernel_thread+0x1b/0x28 [ 229.189813] [] ? __kthread_parkme+0x70/0x70 [ 229.190644] Mem-Info: [ 229.191137] DMA per-cpu: [ 229.191674] CPU 0: hi: 0, btch: 1 usd: 0 [ 229.192515] CPU 1: hi: 0, btch: 1 usd: 0 [ 229.193301] Normal per-cpu: [ 229.193874] CPU 0: hi: 42, btch: 7 usd: 0 [ 229.194664] CPU 1: hi: 42, btch: 7 usd: 0 [ 229.195449] active_anon:0 inactive_anon:0 isolated_anon:0 [ 229.195449] active_file:525 inactive_file:36109 isolated_file:0 [ 229.195449] unevictable:4127 dirty:0 writeback:0 unstable:0 [ 229.195449] free:7817 slab_reclaimable:909 slab_unreclaimable:2116 [ 229.195449] mapped:0 shmem:0 pagetables:0 bounce:0 [ 229.195449] free_cma:7168 [ 229.200191] DMA free:896kB min:136kB low:168kB high:204kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:14844kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15992kB managed:15916kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:16kB slab_unreclaimable:40kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:24100 all_unreclaimable? yes [ 229.205862] lowmem_reserve[]: 0 192 192 [ 229.206819] Normal free:30372kB min:1704kB low:2128kB high:2556kB active_anon:0kB inactive_anon:0kB active_file:2100kB inactive_file:129592kB unevictable:16508kB isolated(anon):0kB isolated(file):0kB present:245752kB managed:197220kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:3620kB slab_unreclaimable:8424kB kernel_stack:344kB pagetables:0kB unstable:0kB bounce:0kB free_cma:28672kB writeback_tmp:0kB pages_scanned:66095 all_unreclaimable? no [ 229.212796] lowmem_reserve[]: 0 0 0 [ 229.213703] DMA: 0*4kB 0*8kB 0*16kB 0*32kB 0*64kB 1*128kB (R) 1*256kB (R) 1*512kB (R) 0*1024kB 0*2048kB 0*4096kB = 896kB [ 229.216393] Normal: 7*4kB (UR) 3*8kB (UR) 1*16kB (R) 0*32kB 0*64kB 1*128kB (R) 0*256kB 1*512kB (R) 1*1024kB (R) 0*2048kB 7*4096kB (C) = 30404kB [ 229.219540] 40772 total pagecache pages [ 229.220252] 65436 pages RAM [ 229.220816] 0 pages HighMem/MovableOnly [ 229.221484] 12133 pages reserved [ 230.486130] rb_consumer: page allocation failure: order:0, mode:0x10d0 [ 230.487158] CPU: 1 PID: 41 Comm: rb_consumer Not tainted 3.12.0-10888-g60d253c #1482 [ 230.488489] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 230.489373] ffffffff caf23e08 c1edfc10 00000001 000010d0 000010d0 caf23e34 c1142093 [ 230.491196] c2455d5c cad1b1fc 00000000 000010d0 c26a9ba0 000010d0 00000003 00000002 [ 230.493069] 00000000 caf23ecc c1147412 000010d0 00000000 00000000 c26a93e0 00000000 [ 230.494902] Call Trace: [ 230.495417] [] dump_stack+0x7a/0xaa [ 230.496197] [] warn_alloc_failed+0x123/0x1a0 [ 230.497031] [] __alloc_pages_nodemask+0xcc2/0x1160 [ 230.497925] [] ring_buffer_alloc_read_page+0x1e/0x50 [ 230.498840] [] ring_buffer_consumer_thread+0x209/0x500 [ 230.499771] [] ? ring_buffer_producer_thread+0x600/0x600 [ 230.500765] [] kthread+0xfe/0x100 [ 230.501494] [] ? ring_buffer_producer_thread+0x600/0x600 [ 230.502459] [] ret_from_kernel_thread+0x1b/0x28 [ 230.503314] [] ? __kthread_parkme+0x70/0x70 [ 230.504181] Mem-Info: [ 230.504683] DMA per-cpu: [ 230.505207] CPU 0: hi: 0, btch: 1 usd: 0 [ 230.508063] CPU 1: hi: 0, btch: 1 usd: 0 [ 230.508846] Normal per-cpu: [ 230.509397] CPU 0: hi: 42, btch: 7 usd: 0 [ 230.510177] CPU 1: hi: 42, btch: 7 usd: 0 [ 230.510963] active_anon:0 inactive_anon:0 isolated_anon:0 [ 230.510963] active_file:525 inactive_file:36113 isolated_file:0 [ 230.510963] unevictable:4127 dirty:0 writeback:0 unstable:0 [ 230.510963] free:7817 slab_reclaimable:909 slab_unreclaimable:2116 [ 230.510963] mapped:0 shmem:0 pagetables:0 bounce:0 [ 230.510963] free_cma:7168 [ 230.515648] DMA free:896kB min:136kB low:168kB high:204kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:14844kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15992kB managed:15916kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:16kB slab_unreclaimable:40kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:24100 all_unreclaimable? yes [ 230.521322] lowmem_reserve[]: 0 192 192 [ 230.522268] Normal free:30372kB min:1704kB low:2128kB high:2556kB active_anon:0kB inactive_anon:0kB active_file:2100kB inactive_file:129608kB unevictable:16508kB isolated(anon):0kB isolated(file):0kB present:245752kB managed:197220kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:3620kB slab_unreclaimable:8424kB kernel_stack:344kB pagetables:0kB unstable:0kB bounce:0kB free_cma:28672kB writeback_tmp:0kB pages_scanned:132126 all_unreclaimable? no [ 230.528193] lowmem_reserve[]: 0 0 0 [ 230.529090] DMA: 0*4kB 0*8kB 0*16kB 0*32kB 0*64kB 1*128kB (R) 1*256kB (R) 1*512kB (R) 0*1024kB 0*2048kB 0*4096kB = 896kB [ 230.531737] Normal: 7*4kB (UR) 3*8kB (UR) 1*16kB (R) 0*32kB 0*64kB 1*128kB (R) 0*256kB 1*512kB (R) 1*1024kB (R) 0*2048kB 7*4096kB (C) = 30404kB [ 230.534921] 40772 total pagecache pages [ 230.535595] 65436 pages RAM [ 230.536172] 0 pages HighMem/MovableOnly [ 230.536852] 12133 pages reserved [ 262.588304] kthreadd invoked oom-killer: gfp_mask=0x3000d0, order=1, oom_score_adj=0 [ 262.589691] CPU: 0 PID: 2 Comm: kthreadd Not tainted 3.12.0-10888-g60d253c #1482 [ 262.590963] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 262.591873] ffffffff ccc55d78 c1edfc10 ccc48dfc ccc48f00 003000d0 ccc55dd8 c1ece12f [ 262.593859] c2455a5c ccc48dfc 003000d0 00000001 00000000 00000000 00000246 00000000 [ 262.595737] ccc48c00 00000000 ccc55dd8 00000246 00000000 00000000 c11408b0 00000000 [ 262.597641] Call Trace: [ 262.598173] [] dump_stack+0x7a/0xaa [ 262.598945] [] dump_header.isra.15+0x63/0x2fb [ 262.599819] [] ? out_of_memory+0x160/0x390 [ 262.600685] [] ? out_of_memory+0x2c7/0x390 [ 262.601512] [] out_of_memory+0x381/0x390 [ 262.602336] [] ? out_of_memory+0x160/0x390 [ 262.603172] [] ? do_raw_spin_unlock+0xd7/0x130 [ 262.604062] [] __alloc_pages_nodemask+0x1123/0x1160 [ 262.604988] [] copy_process+0x20a/0x1b60 [ 262.605803] [] ? sched_clock_cpu+0x225/0x280 [ 262.606649] [] ? __kthread_parkme+0x70/0x70 [ 262.607491] [] do_fork+0x132/0x480 [ 262.608263] [] ? __kthread_parkme+0x70/0x70 [ 262.609104] [] ? lock_release_holdtime.part.11+0x90/0xf0 [ 262.610074] [] ? __kthread_parkme+0x70/0x70 [ 262.610916] [] kernel_thread+0x28/0x30 [ 262.611715] [] kthreadd+0xce/0x150 [ 262.612495] [] ? schedule_tail+0x1c/0xe0 [ 262.613312] [] ret_from_kernel_thread+0x1b/0x28 [ 262.614195] [] ? kthread_stop+0x160/0x160 [ 262.615014] Mem-Info: [ 262.615516] DMA per-cpu: [ 262.616073] CPU 0: hi: 0, btch: 1 usd: 0 [ 262.616875] CPU 1: hi: 0, btch: 1 usd: 0 [ 262.617677] Normal per-cpu: [ 262.618242] CPU 0: hi: 42, btch: 7 usd: 0 [ 262.619041] CPU 1: hi: 42, btch: 7 usd: 0 [ 262.619843] active_anon:0 inactive_anon:0 isolated_anon:0 [ 262.619843] active_file:525 inactive_file:36110 isolated_file:0 [ 262.619843] unevictable:4127 dirty:0 writeback:0 unstable:0 [ 262.619843] free:7817 slab_reclaimable:909 slab_unreclaimable:2116 [ 262.619843] mapped:0 shmem:0 pagetables:0 bounce:0 [ 262.619843] free_cma:7168 [ 262.624614] DMA free:896kB min:136kB low:168kB high:204kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:14844kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15992kB managed:15916kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:16kB slab_unreclaimable:40kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:24100 all_unreclaimable? yes [ 262.630363] lowmem_reserve[]: 0 192 192 [ 262.631333] Normal free:30372kB min:1704kB low:2128kB high:2556kB active_anon:0kB inactive_anon:0kB active_file:2100kB inactive_file:129596kB unevictable:16508kB isolated(anon):0kB isolated(file):0kB present:245752kB managed:197220kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:3620kB slab_unreclaimable:8424kB kernel_stack:344kB pagetables:0kB unstable:0kB bounce:0kB free_cma:28672kB writeback_tmp:0kB pages_scanned:200879 all_unreclaimable? yes [ 262.637420] lowmem_reserve[]: 0 0 0 [ 262.638346] DMA: 0*4kB 0*8kB 0*16kB 0*32kB 0*64kB 1*128kB (R) 1*256kB (R) 1*512kB (R) 0*1024kB 0*2048kB 0*4096kB = 896kB [ 262.641105] Normal: 7*4kB (UR) 3*8kB (UR) 1*16kB (R) 0*32kB 0*64kB 1*128kB (R) 0*256kB 1*512kB (R) 1*1024kB (R) 0*2048kB 7*4096kB (C) = 30404kB [ 262.644376] 40772 total pagecache pages [ 262.645063] 65436 pages RAM [ 262.645625] 0 pages HighMem/MovableOnly [ 262.646318] 12133 pages reserved [ 262.646936] [ pid ] uid tgid total_vm rss nr_ptes swapents oom_score_adj name [ 262.648286] Kernel panic - not syncing: Out of memory and no killable processes... [ 262.648286] [ 262.649941] CPU: 0 PID: 2 Comm: kthreadd Not tainted 3.12.0-10888-g60d253c #1482 [ 262.651217] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 262.652142] ffffffff ccc55db8 c1edfc10 ca8c3c01 003000d0 00000000 ccc55dd8 c1ecc05a [ 262.652264] c2448078 c2c39ae0 c2595a10 ca8c3c01 003000d0 00000000 ccc55e24 c1140add [ 262.652264] c2455c08 00000001 00000000 c11408b0 c10ca727 003000d0 00000000 00000000 [ 262.652264] Call Trace: [ 262.652264] [] dump_stack+0x7a/0xaa [ 262.652264] [] panic+0xd5/0x245 [ 262.652264] [] out_of_memory+0x38d/0x390 [ 262.652264] [] ? out_of_memory+0x160/0x390 [ 262.652264] [] ? do_raw_spin_unlock+0xd7/0x130 [ 262.652264] [] __alloc_pages_nodemask+0x1123/0x1160 [ 262.652264] [] copy_process+0x20a/0x1b60 [ 262.652264] [] ? sched_clock_cpu+0x225/0x280 [ 262.652264] [] ? __kthread_parkme+0x70/0x70 [ 262.652264] [] do_fork+0x132/0x480 [ 262.652264] [] ? __kthread_parkme+0x70/0x70 [ 262.652264] [] ? lock_release_holdtime.part.11+0x90/0xf0 [ 262.652264] [] ? __kthread_parkme+0x70/0x70 [ 262.652264] [] kernel_thread+0x28/0x30 [ 262.652264] [] kthreadd+0xce/0x150 [ 262.652264] [] ? schedule_tail+0x1c/0xe0 [ 262.652264] [] ret_from_kernel_thread+0x1b/0x28 [ 262.652264] [] ? kthread_stop+0x160/0x160 Elapsed time: 265 qemu-system-x86_64 -cpu kvm64 -enable-kvm -kernel /kernel/i386-randconfig-x1-1121/60d253cd38fac5dca15d6d71e931e840f6c08e6e/vmlinuz-3.12.0-10888-g60d253c -append 'hung_task_panic=1 rcutree.rcu_cpu_stall_timeout=100 log_buf_len=8M ignore_loglevel debug sched_debug apic=debug dynamic_printk sysrq_always_enabled panic=10 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal root=/dev/ram0 rw link=/kernel-tests/run-queue/kvm/i386-randconfig-x1-1121/pm:bleeding-edge/.vmlinuz-60d253cd38fac5dca15d6d71e931e840f6c08e6e-20131121093014-7-athens branch=pm/bleeding-edge BOOT_IMAGE=/kernel/i386-randconfig-x1-1121/60d253cd38fac5dca15d6d71e931e840f6c08e6e/vmlinuz-3.12.0-10888-g60d253c' -initrd /kernel-tests/initrd/yocto-minimal-i386.cgz -m 256M -smp 2 -net nic,vlan=1,model=e1000 -net user,vlan=1 -boot order=nc -no-reboot -watchdog i6300esb -rtc base=localtime -drive file=/fs/LABEL=KVM/disk0-yocto-athens-14,media=disk,if=virtio -drive file=/fs/LABEL=KVM/disk1-yocto-athens-14,media=disk,if=virtio -drive file=/fs/LABEL=KVM/disk2-yocto-athens-14,media=disk,if=virtio -drive file=/fs/LABEL=KVM/disk3-yocto-athens-14,media=disk,if=virtio -drive file=/fs/LABEL=KVM/disk4-yocto-athens-14,media=disk,if=virtio -drive file=/fs/LABEL=KVM/disk5-yocto-athens-14,media=disk,if=virtio -pidfile /dev/shm/kboot/pid-yocto-athens-14 -serial file:/dev/shm/kboot/serial-yocto-athens-14 -daemonize -display none -monitor null