Re: s2disk hang update
From: Alan Jenkins
Date: Tue Feb 16 2010 - 10:13:21 EST
On 2/16/10, Alan Jenkins <sourcejedi.lkml@xxxxxxxxxxxxxx> wrote:
> On 2/15/10, Rafael J. Wysocki <rjw@xxxxxxx> wrote:
>> On Tuesday 09 February 2010, Alan Jenkins wrote:
>>> Perhaps I spoke too soon. I see the same hang if I run too many
>>> applications. The first hibernation fails with "not enough swap" as
>>> expected, but the second or third attempt hangs (with the same backtrace
>>> as before).
>>>
>>> The patch definitely helps though. Without the patch, I see a hang the
>>> first time I try to hibernate with too many applications running.
>>
>> Well, I have an idea.
>>
>> Can you try to apply the appended patch in addition and see if that
>> helps?
>>
>> Rafael
>
> It doesn't seem to help.
To be clear: It doesn't stop the hang when I hibernate with too many
applications.
It does stop the same hang in a different case though.
1. boot with init=/bin/bash
2. run s2disk
3. cancel the s2disk
4. repeat steps 2&3
With the patch, I can run 10s of iterations, with no hang.
Without the patch, it soon hangs, (in disable_nonboot_cpus(), as always).
That's what happens on 2.6.33-rc7. On 2.6.30, there is no problem.
On 2.6.31 and 2.6.32 I don't get a hang, but dmesg shows an allocation
failure after a couple of iterations ("kthreadd: page allocation
failure. order:1, mode:0xd0"). It looks like it might be the same
stop_machine thread allocation failure that causes the hang.
Regards
Alan
[ 0.000000] Initializing cgroup subsys cpuset
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Linux version 2.6.31eeepc (alan@alan-desktop-karmic) (gcc version 4.4.1 (Ubuntu 4.4.1-4ubuntu8) ) #48 SMP Tue Dec 1 14:37:15 GMT 2009
[ 0.000000] KERNEL supported cpus:
[ 0.000000] Intel GenuineIntel
[ 0.000000] AMD AuthenticAMD
[ 0.000000] NSC Geode by NSC
[ 0.000000] Cyrix CyrixInstead
[ 0.000000] Centaur CentaurHauls
[ 0.000000] Transmeta GenuineTMx86
[ 0.000000] Transmeta TransmetaCPU
[ 0.000000] UMC UMC UMC UMC
[ 0.000000] BIOS-provided physical RAM map:
[ 0.000000] BIOS-e820: 0000000000000000 - 000000000009fc00 (usable)
[ 0.000000] BIOS-e820: 000000000009fc00 - 00000000000a0000 (reserved)
[ 0.000000] BIOS-e820: 00000000000e4000 - 0000000000100000 (reserved)
[ 0.000000] BIOS-e820: 0000000000100000 - 000000001f780000 (usable)
[ 0.000000] BIOS-e820: 000000001f780000 - 000000001f790000 (ACPI data)
[ 0.000000] BIOS-e820: 000000001f790000 - 000000001f7d0000 (ACPI NVS)
[ 0.000000] BIOS-e820: 000000001f7d0000 - 000000001f7de000 (reserved)
[ 0.000000] BIOS-e820: 000000001f7e0000 - 000000001f800000 (reserved)
[ 0.000000] BIOS-e820: 00000000fee00000 - 00000000fee01000 (reserved)
[ 0.000000] BIOS-e820: 00000000fff80000 - 0000000100000000 (reserved)
[ 0.000000] DMI present.
[ 0.000000] AMI BIOS detected: BIOS may corrupt low RAM, working around it.
[ 0.000000] e820 update range: 0000000000000000 - 0000000000010000 (usable) ==> (reserved)
[ 0.000000] last_pfn = 0x1f780 max_arch_pfn = 0x100000
[ 0.000000] MTRR default type: uncachable
[ 0.000000] MTRR fixed ranges enabled:
[ 0.000000] 00000-9FFFF write-back
[ 0.000000] A0000-DFFFF uncachable
[ 0.000000] E0000-EFFFF write-through
[ 0.000000] F0000-FFFFF write-protect
[ 0.000000] MTRR variable ranges enabled:
[ 0.000000] 0 base 000000000 mask FE0000000 write-back
[ 0.000000] 1 base 01F800000 mask FFF800000 uncachable
[ 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] PAT not supported by CPU.
[ 0.000000] initial memory mapped : 0 - 01800000
[ 0.000000] init_memory_mapping: 0000000000000000-000000001f780000
[ 0.000000] 0000000000 - 0000400000 page 4k
[ 0.000000] 0000400000 - 001f400000 page 2M
[ 0.000000] 001f400000 - 001f780000 page 4k
[ 0.000000] kernel direct mapping tables up to 1f780000 @ 10000-16000
[ 0.000000] RAMDISK: 176f6000 - 179df1f6
[ 0.000000] ACPI: RSDP 000fbe50 00014 (v00 ACPIAM)
[ 0.000000] ACPI: RSDT 1f780000 00034 (v01 A M I OEMRSDT 03000911 MSFT 00000097)
[ 0.000000] ACPI: FACP 1f780200 00081 (v01 A M I OEMFACP 03000911 MSFT 00000097)
[ 0.000000] ACPI: DSDT 1f780400 06069 (v01 A0797 A0797000 00000000 INTL 20060113)
[ 0.000000] ACPI: FACS 1f790000 00040
[ 0.000000] ACPI: APIC 1f780390 00068 (v01 A M I OEMAPIC 03000911 MSFT 00000097)
[ 0.000000] ACPI: OEMB 1f790040 00046 (v01 A M I AMI_OEM 03000911 MSFT 00000097)
[ 0.000000] ACPI: MCFG 1f786470 0003C (v01 A M I OEMMCFG 03000911 MSFT 00000097)
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] 0MB HIGHMEM available.
[ 0.000000] 503MB LOWMEM available.
[ 0.000000] mapped low ram: 0 - 1f780000
[ 0.000000] low ram: 0 - 1f780000
[ 0.000000] node 0 low ram: 00000000 - 1f780000
[ 0.000000] node 0 bootmap 00012000 - 00015ef0
[ 0.000000] (9 early reservations) ==> bootmem [0000000000 - 001f780000]
[ 0.000000] #0 [0000000000 - 0000001000] BIOS data page ==> [0000000000 - 0000001000]
[ 0.000000] #1 [0000001000 - 0000002000] EX TRAMPOLINE ==> [0000001000 - 0000002000]
[ 0.000000] #2 [0000006000 - 0000007000] TRAMPOLINE ==> [0000006000 - 0000007000]
[ 0.000000] #3 [0001000000 - 00014a5f90] TEXT DATA BSS ==> [0001000000 - 00014a5f90]
[ 0.000000] #4 [00176f6000 - 00179df1f6] RAMDISK ==> [00176f6000 - 00179df1f6]
[ 0.000000] #5 [000009fc00 - 0000100000] BIOS reserved ==> [000009fc00 - 0000100000]
[ 0.000000] #6 [00014a6000 - 00014ac1f4] BRK ==> [00014a6000 - 00014ac1f4]
[ 0.000000] #7 [0000010000 - 0000012000] PGTABLE ==> [0000010000 - 0000012000]
[ 0.000000] #8 [0000012000 - 0000016000] BOOTMAP ==> [0000012000 - 0000016000]
[ 0.000000] found SMP MP-table at [c00ff780] ff780
[ 0.000000] Zone PFN ranges:
[ 0.000000] DMA 0x00000010 -> 0x00001000
[ 0.000000] Normal 0x00001000 -> 0x0001f780
[ 0.000000] HighMem 0x0001f780 -> 0x0001f780
[ 0.000000] Movable zone start PFN for each node
[ 0.000000] early_node_map[2] active PFN ranges
[ 0.000000] 0: 0x00000010 -> 0x0000009f
[ 0.000000] 0: 0x00000100 -> 0x0001f780
[ 0.000000] On node 0 totalpages: 128783
[ 0.000000] free_area_init_node: node 0, pgdat c1396960, node_mem_map c14ae200
[ 0.000000] DMA zone: 32 pages used for memmap
[ 0.000000] DMA zone: 0 pages reserved
[ 0.000000] DMA zone: 3951 pages, LIFO batch:0
[ 0.000000] Normal zone: 975 pages used for memmap
[ 0.000000] Normal zone: 123825 pages, LIFO batch:31
[ 0.000000] Using APIC driver default
[ 0.000000] ACPI: PM-Timer IO Port: 0x808
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x00] enabled)
[ 0.000000] ACPI: IOAPIC (id[0x01] address[0xfec00000] gsi_base[0])
[ 0.000000] IOAPIC[0]: apic_id 1, version 32, address 0xfec00000, GSI 0-23
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[ 0.000000] ACPI: IRQ0 used by override.
[ 0.000000] ACPI: IRQ2 used by override.
[ 0.000000] ACPI: IRQ9 used by override.
[ 0.000000] Enabling APIC mode: Flat. Using 1 I/O APICs
[ 0.000000] Using ACPI (MADT) for SMP configuration information
[ 0.000000] SMP: Allowing 1 CPUs, 0 hotplug CPUs
[ 0.000000] nr_irqs_gsi: 24
[ 0.000000] PM: Registered nosave memory: 000000000009f000 - 00000000000a0000
[ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000e4000
[ 0.000000] PM: Registered nosave memory: 00000000000e4000 - 0000000000100000
[ 0.000000] Allocating PCI resources starting at 1f800000 (gap: 1f800000:df600000)
[ 0.000000] Booting paravirtualized kernel on bare hardware
[ 0.000000] NR_CPUS:32 nr_cpumask_bits:32 nr_cpu_ids:1 nr_node_ids:1
[ 0.000000] PERCPU: Embedded 13 pages/cpu @c1c00000 s32088 r0 d21160 u4194304
[ 0.000000] pcpu-alloc: s32088 r0 d21160 u4194304 alloc=1*4194304
[ 0.000000] pcpu-alloc: [0] 0
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 127776
[ 0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-2.6.31eeepc root=/dev/sda2 ro rootfstype=ext4 no_console_suspend i915.modeset=1 resume=/dev/sda2 resume_offset=188416 init=/bin/bash
[ 0.000000] Unknown boot option `i915.modeset=1': ignoring
[ 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] Enabling fast FPU save and restore... done.
[ 0.000000] Enabling unmasked SIMD FPU exception support... done.
[ 0.000000] Initializing CPU#0
[ 0.000000] Initializing HighMem for node 0 (00000000:00000000)
[ 0.000000] Memory: 502436k/515584k available (2390k kernel code, 12296k reserved, 1319k data, 356k init, 0k highmem)
[ 0.000000] virtual kernel memory layout:
[ 0.000000] fixmap : 0xffd56000 - 0xfffff000 (2724 kB)
[ 0.000000] pkmap : 0xff400000 - 0xff800000 (4096 kB)
[ 0.000000] vmalloc : 0xdff80000 - 0xff3fe000 ( 500 MB)
[ 0.000000] lowmem : 0xc0000000 - 0xdf780000 ( 503 MB)
[ 0.000000] .init : 0xc13a0000 - 0xc13f9000 ( 356 kB)
[ 0.000000] .data : 0xc1255afe - 0xc139fa68 (1319 kB)
[ 0.000000] .text : 0xc1000000 - 0xc1255afe (2390 kB)
[ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[ 0.000000] Hierarchical RCU implementation.
[ 0.000000] NR_IRQS:1280
[ 0.000000] Console: colour VGA+ 80x25
[ 0.000000] console [tty0] enabled
[ 0.000000] Fast TSC calibration using PIT
[ 0.000000] Detected 630.015 MHz processor.
[ 0.004010] Calibrating delay loop (skipped), value calculated using timer frequency.. 1260.03 BogoMIPS (lpj=2520060)
[ 0.008114] Security Framework initialized
[ 0.008220] SELinux: Disabled at boot.
[ 0.008348] Mount-cache hash table entries: 512
[ 0.008760] Initializing cgroup subsys ns
[ 0.008860] Initializing cgroup subsys cpuacct
[ 0.008961] Initializing cgroup subsys devices
[ 0.009058] Initializing cgroup subsys freezer
[ 0.009153] Initializing cgroup subsys net_cls
[ 0.009303] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 0.009446] CPU: L2 cache: 512K
[ 0.009542] mce: CPU supports 5 MCE banks
[ 0.009651] CPU0: Thermal monitoring enabled (TM1)
[ 0.009764] Performance Events: p6 PMU driver.
[ 0.009931] ... version: 0
[ 0.010024] ... bit width: 32
[ 0.010118] ... generic registers: 2
[ 0.010211] ... value mask: 00000000ffffffff
[ 0.010310] ... max period: 000000007fffffff
[ 0.010408] ... fixed-purpose events: 0
[ 0.010502] ... event mask: 0000000000000003
[ 0.010608] Checking 'hlt' instruction... OK.
[ 0.024948] SMP alternatives: switching to UP code
[ 0.035538] Freeing SMP alternatives: 12k freed
[ 0.035655] ACPI: Core revision 20090521
[ 0.060707] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[ 0.102319] CPU0: Intel(R) Celeron(R) M processor 900MHz stepping 08
[ 0.104001] APIC calibration not consistent with PM-Timer: 136ms instead of 100ms
[ 0.104001] APIC delta adjusted to PM-Timer: 437545 (595095)
[ 0.104001] Brought up 1 CPUs
[ 0.104001] Total of 1 processors activated (1260.03 BogoMIPS).
[ 0.104001] CPU0 attaching NULL sched-domain.
[ 0.104001] regulator: core version 0.5
[ 0.104001] NET: Registered protocol family 16
[ 0.104001] ACPI: bus type pci registered
[ 0.104001] PCI: MCFG configuration 0: base e0000000 segment 0 buses 0 - 255
[ 0.104001] PCI: Not using MMCONFIG.
[ 0.104001] PCI: PCI BIOS revision 3.00 entry at 0xf0031, last bus=5
[ 0.104001] PCI: Using configuration type 1 for base access
[ 0.105290] bio: create slab <bio-0> at 0
[ 0.107289] ACPI: EC: Look up EC in DSDT
[ 0.128761] ACPI: Interpreter enabled
[ 0.128881] ACPI: (supports S0 S1 S3 S4 S5)
[ 0.129262] ACPI: Using IOAPIC for interrupt routing
[ 0.129500] PCI: MCFG configuration 0: base e0000000 segment 0 buses 0 - 255
[ 0.135742] PCI: MCFG area at e0000000 reserved in ACPI motherboard resources
[ 0.135852] PCI: Using MMCONFIG for extended config space
[ 0.149580] ACPI: EC: GPE = 0x18, I/O: command/status = 0x66, data = 0x62
[ 0.149689] ACPI: EC: driver started in poll mode
[ 0.150277] ACPI: No dock devices found.
[ 0.150782] ACPI: PCI Root Bridge [PCI0] (0000:00)
[ 0.151088] pci 0000:00:02.0: reg 10 32bit mmio: [0xf7f00000-0xf7f7ffff]
[ 0.151103] pci 0000:00:02.0: reg 14 io port: [0xec00-0xec07]
[ 0.151117] pci 0000:00:02.0: reg 18 32bit mmio pref: [0xd0000000-0xdfffffff]
[ 0.151131] pci 0000:00:02.0: reg 1c 32bit mmio: [0xf7ec0000-0xf7efffff]
[ 0.151206] pci 0000:00:02.1: reg 10 32bit mmio: [0xf7f80000-0xf7ffffff]
[ 0.151357] pci 0000:00:1b.0: reg 10 64bit mmio: [0xf7eb8000-0xf7ebbfff]
[ 0.151428] pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold
[ 0.151536] pci 0000:00:1b.0: PME# disabled
[ 0.151732] pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold
[ 0.151837] pci 0000:00:1c.0: PME# disabled
[ 0.152049] pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold
[ 0.152156] pci 0000:00:1c.1: PME# disabled
[ 0.152355] pci 0000:00:1c.2: PME# supported from D0 D3hot D3cold
[ 0.152460] pci 0000:00:1c.2: PME# disabled
[ 0.152630] pci 0000:00:1d.0: reg 20 io port: [0xe400-0xe41f]
[ 0.152714] pci 0000:00:1d.1: reg 20 io port: [0xe480-0xe49f]
[ 0.152797] pci 0000:00:1d.2: reg 20 io port: [0xe800-0xe81f]
[ 0.152880] pci 0000:00:1d.3: reg 20 io port: [0xe880-0xe89f]
[ 0.152968] pci 0000:00:1d.7: reg 10 32bit mmio: [0xf7eb7c00-0xf7eb7fff]
[ 0.153048] pci 0000:00:1d.7: PME# supported from D0 D3hot D3cold
[ 0.153154] pci 0000:00:1d.7: PME# disabled
[ 0.153427] pci 0000:00:1f.0: Force enabled HPET at 0xfed00000
[ 0.153448] pci 0000:00:1f.0: quirk: region 0800-087f claimed by ICH6 ACPI/GPIO/TCO
[ 0.153589] pci 0000:00:1f.0: quirk: region 0480-04bf claimed by ICH6 GPIO
[ 0.153698] pci 0000:00:1f.0: LPC Generic IO decode 1 PIO at 0380-03ff
[ 0.153856] pci 0000:00:1f.2: reg 10 io port: [0x00-0x07]
[ 0.153870] pci 0000:00:1f.2: reg 14 io port: [0x00-0x03]
[ 0.153884] pci 0000:00:1f.2: reg 18 io port: [0x00-0x07]
[ 0.153898] pci 0000:00:1f.2: reg 1c io port: [0x00-0x03]
[ 0.153913] pci 0000:00:1f.2: reg 20 io port: [0xffa0-0xffaf]
[ 0.153955] pci 0000:00:1f.2: PME# supported from D3hot
[ 0.154057] pci 0000:00:1f.2: PME# disabled
[ 0.154217] pci 0000:00:1f.3: reg 20 io port: [0x400-0x41f]
[ 0.154409] pci 0000:03:00.0: reg 10 64bit mmio: [0xfbfc0000-0xfbffffff]
[ 0.154459] pci 0000:03:00.0: reg 30 32bit mmio pref: [0xfbfa0000-0xfbfbffff]
[ 0.154516] pci 0000:03:00.0: PME# supported from D3hot D3cold
[ 0.156011] pci 0000:03:00.0: PME# disabled
[ 0.156180] pci 0000:00:1c.1: bridge 32bit mmio: [0xfbf00000-0xfbffffff]
[ 0.156271] pci 0000:01:00.0: reg 10 64bit mmio: [0xfbef0000-0xfbefffff]
[ 0.156446] pci 0000:00:1c.2: bridge 32bit mmio: [0xf8000000-0xfbefffff]
[ 0.156461] pci 0000:00:1c.2: bridge 64bit mmio pref: [0xf0000000-0xf6ffffff]
[ 0.156536] pci 0000:00:1e.0: transparent bridge
[ 0.156670] pci_bus 0000:00: on NUMA node 0
[ 0.156692] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
[ 0.157130] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P3._PRT]
[ 0.157287] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P5._PRT]
[ 0.157427] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P6._PRT]
[ 0.169807] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 *5 6 7 10 11 12 14 15)
[ 0.170792] ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 7 10 *11 12 14 15)
[ 0.171762] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 6 7 *10 11 12 14 15)
[ 0.172727] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 *7 10 11 12 14 15)
[ 0.173695] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled.
[ 0.174791] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled.
[ 0.175889] ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled.
[ 0.176994] ACPI: PCI Interrupt Link [LNKH] (IRQs *3 4 5 6 7 10 11 12 14 15)
[ 0.177907] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
[ 0.178069] vgaarb: loaded
[ 0.178497] SCSI subsystem initialized
[ 0.178735] libata version 3.00 loaded.
[ 0.178908] PCI: Using ACPI for IRQ routing
[ 0.179757] hpet clockevent registered
[ 0.179767] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
[ 0.179882] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
[ 0.180181] hpet0: 3 comparators, 64-bit 14.318180 MHz counter
[ 0.184027] Switching to clocksource tsc
[ 0.187552] pnp: PnP ACPI init
[ 0.187701] ACPI: bus type pnp registered
[ 0.192924] pnp: PnP ACPI: found 13 devices
[ 0.193021] ACPI: ACPI bus type pnp unregistered
[ 0.193123] PnPBIOS: Disabled by ACPI PNP
[ 0.193278] system 00:01: iomem range 0xfed13000-0xfed19fff has been reserved
[ 0.193407] system 00:08: ioport range 0x380-0x383 has been reserved
[ 0.193514] system 00:08: ioport range 0x4d0-0x4d1 has been reserved
[ 0.193620] system 00:08: ioport range 0x800-0x87f has been reserved
[ 0.193727] system 00:08: ioport range 0x480-0x4bf has been reserved
[ 0.193835] system 00:08: iomem range 0xfed1c000-0xfed1ffff has been reserved
[ 0.193945] system 00:08: iomem range 0xfed20000-0xfed8ffff has been reserved
[ 0.194056] system 00:08: iomem range 0xfff00000-0xffffffff could not be reserved
[ 0.194203] system 00:09: iomem range 0xfec00000-0xfec00fff could not be reserved
[ 0.194343] system 00:09: iomem range 0xfee00000-0xfee00fff has been reserved
[ 0.194462] system 00:0a: iomem range 0xe0000000-0xefffffff has been reserved
[ 0.194579] system 00:0b: iomem range 0xe0000000-0xefffffff has been reserved
[ 0.194695] system 00:0c: iomem range 0x0-0x9ffff could not be reserved
[ 0.194803] system 00:0c: iomem range 0xc0000-0xcffff could not be reserved
[ 0.194914] system 00:0c: iomem range 0xe0000-0xfffff could not be reserved
[ 0.195024] system 00:0c: iomem range 0x100000-0x1f7fffff could not be reserved
[ 0.231261] pci 0000:00:1c.0: PCI bridge, secondary bus 0000:04
[ 0.231369] pci 0000:00:1c.0: IO window: 0x1000-0x1fff
[ 0.231474] pci 0000:00:1c.0: MEM window: 0x20000000-0x201fffff
[ 0.231581] pci 0000:00:1c.0: PREFETCH window: 0x00000020200000-0x000000203fffff
[ 0.231726] pci 0000:00:1c.1: PCI bridge, secondary bus 0000:03
[ 0.231842] pci 0000:00:1c.1: IO window: 0x2000-0x2fff
[ 0.231947] pci 0000:00:1c.1: MEM window: 0xfbf00000-0xfbffffff
[ 0.232054] pci 0000:00:1c.1: PREFETCH window: 0x00000020400000-0x000000205fffff
[ 0.232198] pci 0000:00:1c.2: PCI bridge, secondary bus 0000:01
[ 0.232303] pci 0000:00:1c.2: IO window: 0x3000-0x3fff
[ 0.232408] pci 0000:00:1c.2: MEM window: 0xf8000000-0xfbefffff
[ 0.232515] pci 0000:00:1c.2: PREFETCH window: 0x000000f0000000-0x000000f6ffffff
[ 0.232659] pci 0000:00:1e.0: PCI bridge, secondary bus 0000:05
[ 0.232761] pci 0000:00:1e.0: IO window: disabled
[ 0.232864] pci 0000:00:1e.0: MEM window: disabled
[ 0.232964] pci 0000:00:1e.0: PREFETCH window: disabled
[ 0.233082] pci 0000:00:1c.0: enabling device (0104 -> 0107)
[ 0.233201] pci 0000:00:1c.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 0.233311] pci 0000:00:1c.0: setting latency timer to 64
[ 0.233327] pci 0000:00:1c.1: enabling device (0106 -> 0107)
[ 0.233434] pci 0000:00:1c.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17
[ 0.233542] pci 0000:00:1c.1: setting latency timer to 64
[ 0.233557] pci 0000:00:1c.2: enabling device (0106 -> 0107)
[ 0.233665] pci 0000:00:1c.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[ 0.233774] pci 0000:00:1c.2: setting latency timer to 64
[ 0.233788] pci 0000:00:1e.0: setting latency timer to 64
[ 0.233801] pci_bus 0000:00: resource 0 io: [0x00-0xffff]
[ 0.233810] pci_bus 0000:00: resource 1 mem: [0x000000-0xffffffff]
[ 0.233820] pci_bus 0000:04: resource 0 io: [0x1000-0x1fff]
[ 0.233829] pci_bus 0000:04: resource 1 mem: [0x20000000-0x201fffff]
[ 0.233838] pci_bus 0000:04: resource 2 pref mem [0x20200000-0x203fffff]
[ 0.233848] pci_bus 0000:03: resource 0 io: [0x2000-0x2fff]
[ 0.233857] pci_bus 0000:03: resource 1 mem: [0xfbf00000-0xfbffffff]
[ 0.233866] pci_bus 0000:03: resource 2 pref mem [0x20400000-0x205fffff]
[ 0.233876] pci_bus 0000:01: resource 0 io: [0x3000-0x3fff]
[ 0.233885] pci_bus 0000:01: resource 1 mem: [0xf8000000-0xfbefffff]
[ 0.233894] pci_bus 0000:01: resource 2 pref mem [0xf0000000-0xf6ffffff]
[ 0.233904] pci_bus 0000:05: resource 3 io: [0x00-0xffff]
[ 0.233913] pci_bus 0000:05: resource 4 mem: [0x000000-0xffffffff]
[ 0.234068] NET: Registered protocol family 2
[ 0.234411] IP route cache hash table entries: 4096 (order: 2, 16384 bytes)
[ 0.235326] TCP established hash table entries: 16384 (order: 5, 131072 bytes)
[ 0.235726] TCP bind hash table entries: 16384 (order: 5, 131072 bytes)
[ 0.236111] TCP: Hash tables configured (established 16384 bind 16384)
[ 0.236217] TCP reno registered
[ 0.236581] NET: Registered protocol family 1
[ 0.236831] Unpacking initramfs...
[ 0.487945] Freeing initrd memory: 2980k freed
[ 0.493850] audit: initializing netlink socket (disabled)
[ 0.494001] type=2000 audit(1266331887.491:1): initialized
[ 0.494513] HugeTLB registered 4 MB page size, pre-allocated 0 pages
[ 0.494853] VFS: Disk quotas dquot_6.5.2
[ 0.495040] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 0.495352] msgmni has been set to 987
[ 0.495949] alg: No test for stdrng (krng)
[ 0.496140] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
[ 0.496280] io scheduler noop registered
[ 0.496374] io scheduler anticipatory registered
[ 0.496470] io scheduler deadline registered
[ 0.496601] io scheduler cfq registered (default)
[ 0.496733] pci 0000:00:02.0: Boot video device
[ 0.497135] pcieport-driver 0000:00:1c.0: irq 24 for MSI/MSI-X
[ 0.497155] pcieport-driver 0000:00:1c.0: setting latency timer to 64
[ 0.497400] pcieport-driver 0000:00:1c.1: irq 25 for MSI/MSI-X
[ 0.497417] pcieport-driver 0000:00:1c.1: setting latency timer to 64
[ 0.497651] pcieport-driver 0000:00:1c.2: irq 26 for MSI/MSI-X
[ 0.497667] pcieport-driver 0000:00:1c.2: setting latency timer to 64
[ 0.498101] isapnp: Scanning for PnP cards...
[ 0.851963] isapnp: No Plug & Play device found
[ 0.855293] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[ 0.856555] PNP: PS/2 Controller [PNP0303:PS2K,PNP0f13:PS2M] at 0x60,0x64 irq 1,12
[ 0.877617] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 0.877727] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 0.878071] mice: PS/2 mouse device common for all mice
[ 0.878930] rtc_cmos 00:03: RTC can wake from S4
[ 0.879121] rtc_cmos 00:03: rtc core: registered rtc_cmos as rtc0
[ 0.879260] rtc0: alarms up to one month, 114 bytes nvram, hpet irqs
[ 0.879396] cpuidle: using governor ladder
[ 0.879490] cpuidle: using governor menu
[ 0.879589] No iBFT detected.
[ 0.880694] TCP cubic registered
[ 0.880872] NET: Registered protocol family 10
[ 0.882240] lo: Disabled Privacy Extensions
[ 0.883269] Mobile IPv6
[ 0.883360] NET: Registered protocol family 17
[ 0.883500] Using IPI No-Shortcut mode
[ 0.898223] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
[ 0.917824] registered taskstats version 1
[ 0.918510] rtc_cmos 00:03: setting system clock to 2010-02-16 14:51:28 UTC (1266331888)
[ 0.918806] Freeing unused kernel memory: 356k freed
[ 0.919389] Write protecting the kernel text: 2392k
[ 0.919536] Write protecting the kernel read-only data: 928k
[ 1.003758] ata_piix 0000:00:1f.2: version 2.13
[ 1.003815] ata_piix 0000:00:1f.2: PCI INT B -> GSI 19 (level, low) -> IRQ 19
[ 1.003986] ata_piix 0000:00:1f.2: MAP [ P0 P2 IDE IDE ]
[ 1.004358] ata_piix 0000:00:1f.2: setting latency timer to 64
[ 1.004540] scsi0 : ata_piix
[ 1.004886] scsi1 : ata_piix
[ 1.009412] ata1: SATA max UDMA/133 cmd 0x1f0 ctl 0x3f6 bmdma 0xffa0 irq 14
[ 1.009523] ata2: PATA max UDMA/100 cmd 0x170 ctl 0x376 bmdma 0xffa8 irq 15
[ 1.103840] Switched to high resolution mode on CPU 0
[ 1.180377] ata2.00: CFA: SILICONMOTION SM223AC, , max UDMA/66
[ 1.180483] ata2.00: 7815024 sectors, multi 0: LBA
[ 1.196318] ata2.00: configured for UDMA/66
[ 1.196698] scsi 1:0:0:0: Direct-Access ATA SILICONMOTION SM n/a PQ: 0 ANSI: 5
[ 1.249334] ACPI: EC: non-query interrupt received, switching to interrupt mode
[ 1.269516] thermal LNXTHERM:01: registered as thermal_zone0
[ 1.269638] ACPI: Thermal Zone [TZ00] (52 C)
[ 1.624225] sd 1:0:0:0: [sda] 7815024 512-byte logical blocks: (4.00 GB/3.72 GiB)
[ 1.624505] sd 1:0:0:0: [sda] Write Protect is off
[ 1.624606] sd 1:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 1.624682] sd 1:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
[ 1.625201] sda: sda1 sda2
[ 1.627406] sd 1:0:0:0: [sda] Attached SCSI disk
[ 1.726773] PM: Starting manual resume from disk
[ 1.830772] EXT4-fs (sda2): delayed allocation enabled
[ 1.830974] EXT4-fs: file extents enabled
[ 1.831247] EXT4-fs: mballoc enabled
[ 1.831377] EXT4-fs (sda2): mounted filesystem without journal
[ 33.244766] EXT4-fs (sda2): warning: mounting unchecked fs, running e2fsck is recommended
[ 33.246093] EXT4-fs (sda2): no journal
[ 66.496623] Adding 358392k swap on /swapfile. Priority:-1 extents:48 across:1567744k
[ 68.432097] Syncing filesystems ... done.
[ 68.436096] Freezing user space processes ... (elapsed 0.00 seconds) done.
[ 68.436299] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done.
[ 68.436696] PM: Preallocating image memory... done (allocated 122032 pages)
[ 68.693244] PM: Allocated 488128 kbytes in 0.25 seconds (1952.51 MB/s)
[ 68.693835] ata_piix 0000:00:1f.2: PCI INT B disabled
[ 68.695106] Disabling non-boot CPUs ...
[ 68.695379] PM: Creating hibernation image:
[ 68.696008] PM: Need to copy 5137 pages
[ 68.696008] PM: Hibernation image created (5137 pages copied)
[ 68.696008] CPU0: Thermal LVT vector (0xfa) already installed
[ 68.696008] Force enabled HPET at resume
[ 68.703403] pci 0000:00:1e.0: setting latency timer to 64
[ 68.703526] ata_piix 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00001, writing 0x2b00005)
[ 68.703638] ata_piix 0000:00:1f.2: PCI INT B -> GSI 19 (level, low) -> IRQ 19
[ 68.703721] ata_piix 0000:00:1f.2: setting latency timer to 64
[ 68.710309] sd 1:0:0:0: [sda] Starting disk
[ 68.876379] ata2.00: ACPI cmd ef/03:44:00:00:00:a0 (SET FEATURES) filtered out
[ 68.876465] ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
[ 68.892319] ata2.00: configured for UDMA/66
[ 68.978249] Restarting tasks ... done.
[ 70.404093] Syncing filesystems ... done.
[ 70.408090] Freezing user space processes ... (elapsed 0.00 seconds) done.
[ 70.408300] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done.
[ 70.408689] PM: Preallocating image memory... done (allocated 123273 pages)
[ 71.325465] PM: Allocated 493092 kbytes in 0.91 seconds (541.85 MB/s)
[ 71.326053] ata_piix 0000:00:1f.2: PCI INT B disabled
[ 71.327436] kthreadd: page allocation failure. order:1, mode:0xd0
[ 71.327519] Pid: 2, comm: kthreadd Not tainted 2.6.31eeepc #48
[ 71.327592] Call Trace:
[ 71.327671] [<c10848f4>] ? __alloc_pages_nodemask+0x423/0x490
[ 71.327755] [<c103fb65>] ? kthread+0x0/0x64
[ 71.327826] [<c108496d>] ? __get_free_pages+0xc/0x17
[ 71.327904] [<c102d74f>] ? copy_process+0x99/0xf35
[ 71.327978] [<c103fb65>] ? kthread+0x0/0x64
[ 71.328084] [<c102e71f>] ? do_fork+0x134/0x297
[ 71.328158] [<c1001e00>] ? __switch_to+0x6f/0xe2
[ 71.328231] [<c103fb65>] ? kthread+0x0/0x64
[ 71.328301] [<c1001d89>] ? kernel_thread+0x7a/0x82
[ 71.328374] [<c103fb65>] ? kthread+0x0/0x64
[ 71.328447] [<c1003be0>] ? kernel_thread_helper+0x0/0x10
[ 71.328523] [<c103fb36>] ? kthreadd+0x8a/0xb9
[ 71.328593] [<c103faac>] ? kthreadd+0x0/0xb9
[ 71.328665] [<c1003be7>] ? kernel_thread_helper+0x7/0x10
[ 71.328765] Mem-Info:
[ 71.328851] DMA per-cpu:
[ 71.328939] CPU 0: hi: 0, btch: 1 usd: 0
[ 71.329036] Normal per-cpu:
[ 71.329127] CPU 0: hi: 186, btch: 31 usd: 0
[ 71.329236] active_anon:0 inactive_anon:0 isolated_anon:0
[ 71.329240] active_file:0 inactive_file:10 isolated_file:0
[ 71.329244] unevictable:1058 dirty:0 writeback:0 unstable:0 buffer:10
[ 71.329249] free:1267 slab_reclaimable:189 slab_unreclaimable:430
[ 71.329253] mapped:931 shmem:0 pagetables:9 bounce:0
[ 71.329745] DMA free:2012kB min:88kB low:108kB high:132kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15804kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:0kB slab_unreclaimable:0kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no
[ 71.330118] lowmem_reserve[]: 0 483 483 483
[ 71.330454] Normal free:3056kB min:2764kB low:3452kB high:4144kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:40kB unevictable:4232kB isolated(anon):0kB isolated(file):0kB present:495300kB mlocked:4232kB dirty:0kB writeback:0kB mapped:3724kB shmem:0kB slab_reclaimable:756kB slab_unreclaimable:1720kB kernel_stack:232kB pagetables:36kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no
[ 71.330835] lowmem_reserve[]: 0 0 0 0
[ 71.331154] DMA: 1*4kB 1*8kB 1*16kB 0*32kB 1*64kB 1*128kB 1*256kB 1*512kB 1*1024kB 0*2048kB 0*4096kB = 2012kB
[ 71.331854] Normal: 26*4kB 9*8kB 4*16kB 0*32kB 0*64kB 0*128kB 1*256kB 1*512kB 0*1024kB 1*2048kB 0*4096kB = 3056kB
[ 71.332569] 940 total pagecache pages
[ 71.332661] 0 pages in swap cache
[ 71.332752] Swap cache stats: add 91, delete 91, find 0/0
[ 71.332851] Free swap = 358028kB
[ 71.332941] Total swap = 358392kB
[ 71.338499] 128880 pages RAM
[ 71.338591] 0 pages HighMem
[ 71.338679] 2332 pages reserved
[ 71.338767] 1079 pages shared
[ 71.338855] 124261 pages non-shared
[ 71.433571] pci 0000:00:1e.0: setting latency timer to 64
[ 71.433731] ata_piix 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00001, writing 0x2b00005)
[ 71.433903] ata_piix 0000:00:1f.2: PCI INT B -> GSI 19 (level, low) -> IRQ 19
[ 71.434013] ata_piix 0000:00:1f.2: setting latency timer to 64
[ 71.440327] sd 1:0:0:0: [sda] Starting disk
[ 71.612382] ata2.00: ACPI cmd ef/03:44:00:00:00:a0 (SET FEATURES) filtered out
[ 71.612526] ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
[ 71.628319] ata2.00: configured for UDMA/66
[ 71.629042] Restarting tasks ... done.