Acer 9410 ATA hangs, system freezes

[timo18146]

Binary package hint: kernel-image-2.6.20-15-generic-di

My system often hangs for about 10-30 seconds and everything concerning disk usage doesnt work. After this time system responds normal. Happens at least every two hours and makes me quite nervous about my valuable data.. ;-)

dmesg:
[ 0.000000] Linux version 2.6.20-15-generic (root@palmer) (gcc version 4.1.2 (Ubuntu 4.1.2-0ubuntu4)) #2 SMP Sun Apr 15 07:36:31 UTC 2007 (Ubuntu 2.6.20-15.27-generic)
[ 0.000000] BIOS-provided physical RAM map:
[ 0.000000] sanitize start
[ 0.000000] sanitize end
[ 0.000000] copy_e820_map() start: 0000000000000000 size: 000000000009f800 end: 000000000009f800 type: 1
[ 0.000000] copy_e820_map() type is E820_RAM
[ 0.000000] copy_e820_map() start: 000000000009f800 size: 0000000000000800 end: 00000000000a0000 type: 2
[ 0.000000] copy_e820_map() start: 00000000000dc000 size: 0000000000024000 end: 0000000000100000 type: 2
[ 0.000000] copy_e820_map() start: 0000000000100000 size: 000000003f590000 end: 000000003f690000 type: 1
[ 0.000000] copy_e820_map() type is E820_RAM
[ 0.000000] copy_e820_map() start: 000000003f690000 size: 000000000000e000 end: 000000003f69e000 type: 3
[ 0.000000] copy_e820_map() start: 000000003f69e000 size: 0000000000062000 end: 000000003f700000 type: 4
[ 0.000000] copy_e820_map() start: 000000003f700000 size: 0000000000900000 end: 0000000040000000 type: 2
[ 0.000000] copy_e820_map() start: 00000000e0000000 size: 0000000010000000 end: 00000000f0000000 type: 2
[ 0.000000] copy_e820_map() start: 00000000fec00000 size: 0000000000010000 end: 00000000fec10000 type: 2
[ 0.000000] copy_e820_map() start: 00000000fed00000 size: 0000000000000400 end: 00000000fed00400 type: 2
[ 0.000000] copy_e820_map() start: 00000000fed14000 size: 0000000000006000 end: 00000000fed1a000 type: 2
[ 0.000000] copy_e820_map() start: 00000000fed1c000 size: 0000000000074000 end: 00000000fed90000 type: 2
[ 0.000000] copy_e820_map() start: 00000000fee00000 size: 0000000000001000 end: 00000000fee01000 type: 2
[ 0.000000] copy_e820_map() start: 00000000ff000000 size: 0000000001000000 end: 0000000100000000 type: 2
[ 0.000000] BIOS-e820: 0000000000000000 - 000000000009f800 (usable)
[ 0.000000] BIOS-e820: 000000000009f800 - 00000000000a0000 (reserved)
[ 0.000000] BIOS-e820: 00000000000dc000 - 0000000000100000 (reserved)
[ 0.000000] BIOS-e820: 0000000000100000 - 000000003f690000 (usable)
[ 0.000000] BIOS-e820: 000000003f690000 - 000000003f69e000 (ACPI data)
[ 0.000000] BIOS-e820: 000000003f69e000 - 000000003f700000 (ACPI NVS)
[ 0.000000] BIOS-e820: 000000003f700000 - 0000000040000000 (reserved)
[ 0.000000] BIOS-e820: 00000000e0000000 - 00000000f0000000 (reserved)
[ 0.000000] BIOS-e820: 00000000fec00000 - 00000000fec10000 (reserved)
[ 0.000000] BIOS-e820: 00000000fed00000 - 00000000fed00400 (reserved)
[ 0.000000] BIOS-e820: 00000000fed14000 - 00000000fed1a000 (reserved)
[ 0.000000] BIOS-e820: 00000000fed1c000 - 00000000fed90000 (reserved)
[ 0.000000] BIOS-e820: 00000000fee00000 - 00000000fee01000 (reserved)
[ 0.000000] BIOS-e820: 00000000ff000000 - 0000000100000000 (reserved)
[ 0.000000] 118MB HIGHMEM available.
[ 0.000000] 896MB LOWMEM available.
[ 0.000000] found SMP MP-table at 000f5c40
[ 0.000000] Entering add_active_range(0, 0, 259728) 0 entries of 256 used
[ 0.000000] Zone PFN ranges:
[ 0.000000] DMA 0 -> 4096
[ 0.000000] Normal 4096 -> 229376
[ 0.000000] HighMem 229376 -> 259728
[ 0.000000] early_node_map[1] active PFN ranges
[ 0.000000] 0: 0 -> 259728
[ 0.000000] On node 0 totalpages: 259728
[ 0.000000] DMA zone: 32 pages used for memmap
[ 0.000000] DMA zone: 0 pages reserved
[ 0.000000] DMA zone: 4064 pages, LIFO batch:0
[ 0.000000] Normal zone: 1760 pages used for memmap
[ 0.000000] Normal zone: 223520 pages, LIFO batch:31
[ 0.000000] HighMem zone: 237 pages used for memmap
[ 0.000000] HighMem zone: 30115 pages, LIFO batch:7
[ 0.000000] DMI present.
[ 0.000000] ACPI: RSDP (v000 PTLTD ) @ 0x000f5aa0
[ 0.000000] ACPI: RSDT (v001 PTLTD RSDT 0x06040000 LTP 0x00000000) @ 0x3f6951f7
[ 0.000000] ACPI: FADT (v001 INTEL CALISTGA 0x06040000 LOHR 0x0000005a) @ 0x3f69ddee
[ 0.000000] ACPI: MADT (v001 INTEL CALISTGA 0x06040000 LOHR 0x0000005a) @ 0x3f69de62
[ 0.000000] ACPI: HPET (v001 INTEL CALISTGA 0x06040000 LOHR 0x0000005a) @ 0x3f69deca
[ 0.000000] ACPI: MCFG (v001 INTEL CALISTGA 0x06040000 LOHR 0x0000005a) @ 0x3f69df02
[ 0.000000] ACPI: TCPA (v001 PTLTD CALISTGA 0x06040000 PTL 0x00000001) @ 0x3f69df3e
[ 0.000000] ACPI: MADT (v001 PTLTD APIC 0x06040000 LTP 0x00000000) @ 0x3f69df70
[ 0.000000] ACPI: BOOT (v001 PTLTD $SBFTBL$ 0x06040000 LTP 0x00000001) @ 0x3f69dfd8
[ 0.000000] ACPI: SSDT (v001 SataRe SataPri 0x00001000 INTL 0x20050624) @ 0x3f696329
[ 0.000000] ACPI: SSDT (v001 SataRe SataSec 0x00001000 INTL 0x20050624) @ 0x3f695c97
[ 0.000000] ACPI: SSDT (v001 PmRef CpuPm 0x00003000 INTL 0x20050624) @ 0x3f695243
[ 0.000000] ACPI: DSDT (v001 INTEL CALISTGA 0x06040000 MSFT 0x0100000e) @ 0x00000000
[ 0.000000] ACPI: PM-Timer IO Port: 0x1008
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] ACPI: 2 duplicate APIC table ignored.
[ 0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
[ 0.000000] Processor #0 6:14 APIC version 20
[ 0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled)
[ 0.000000] Processor #1 6:14 APIC version 20
[ 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: IOAPIC (id[0x02] address[0xfec18000] gsi_base[24])
[ 0.000000] IOAPIC[1]: apic_id 2, version 255, address 0xfec18000, GSI 24-279
[ 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 2 I/O APICs
[ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[ 0.000000] Using ACPI (MADT) for SMP configuration information
[ 0.000000] Allocating PCI resources starting at 50000000 (gap: 40000000:a0000000)
[ 0.000000] Detected 1596.203 MHz processor.
[ 19.278456] Built 1 zonelists. Total pages: 257699
[ 19.278462] Kernel command line: root=UUID=24b670c3-fe6c-4cb0-84b6-53431aceb0e8 ro quiet splash locale=de_DE
[ 19.278805] mapped APIC to ffffd000 (fee00000)
[ 19.278811] mapped IOAPIC to ffffc000 (fec00000)
[ 19.278816] mapped IOAPIC to ffffb000 (fec18000)
[ 19.278821] Enabling fast FPU save and restore... done.
[ 19.278826] Enabling unmasked SIMD FPU exception support... done.
[ 19.278838] Initializing CPU#0
[ 19.278921] PID hash table entries: 4096 (order: 12, 16384 bytes)
[ 19.280567] Console: colour VGA+ 80x25
[ 19.280921] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[ 19.281587] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 19.337001] Memory: 1018740k/1038912k available (1992k kernel code, 19436k reserved, 893k data, 328k init, 121408k highmem)
[ 19.337020] virtual kernel memory layout:
[ 19.337022] fixmap : 0xfff4e000 - 0xfffff000 ( 708 kB)
[ 19.337025] pkmap : 0xff800000 - 0xffc00000 (4096 kB)
[ 19.337028] vmalloc : 0xf8800000 - 0xff7fe000 ( 111 MB)
[ 19.337031] lowmem : 0xc0000000 - 0xf8000000 ( 896 MB)
[ 19.337034] .init : 0xc03d7000 - 0xc0429000 ( 328 kB)
[ 19.337036] .data : 0xc02f2264 - 0xc03d16d4 ( 893 kB)
[ 19.337039] .text : 0xc0100000 - 0xc02f2264 (1992 kB)
[ 19.337047] Checking if this processor honours the WP bit even in supervisor mode... Ok.
[ 19.337286] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
[ 19.337297] hpet0: 3 64-bit timers, 14318180 Hz
[ 19.338305] Using HPET for base-timer
[ 19.417224] Calibrating delay using timer specific routine.. 3196.83 BogoMIPS (lpj=6393668)
[ 19.417294] Security Framework v1.0.0 initialized
[ 19.417306] SELinux: Disabled at boot.
[ 19.417334] Mount-cache hash table entries: 512
[ 19.417552] CPU: After generic identify, caps: bfe9fbff 00100000 00000000 00000000 0000c189 00000000 00000000
[ 19.417568] monitor/mwait feature present.
[ 19.417572] using mwait in idle threads.
[ 19.417579] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 19.417585] CPU: L2 cache: 2048K
[ 19.417590] CPU: Physical Processor ID: 0
[ 19.417594] CPU: Processor Core ID: 0
[ 19.417598] CPU: After all inits, caps: bfe9fbff 00100000 00000000 00002940 0000c189 00000000 00000000
[ 19.417615] Compat vDSO mapped to ffffe000.
[ 19.417622] Remapping vsyscall page to ffffe000
[ 19.417644] Checking 'hlt' instruction... OK.
[ 19.433402] SMP alternatives: switching to UP code
[ 19.434051] Early unpacking initramfs... done
[ 20.124938] ACPI: Core revision 20060707
[ 20.125292] ACPI: Looking for DSDT in initramfs... file /DSDT.aml not found, using machine DSDT.
[ 20.166758] CPU0: Intel Genuine Intel(R) CPU T2050 @ 1.60GHz stepping 08
[ 20.166791] SMP alternatives: switching to SMP code
[ 20.166949] Booting processor 1/1 eip 3000
[ 20.177645] Initializing CPU#1
[ 20.256515] Calibrating delay using timer specific routine.. 3192.51 BogoMIPS (lpj=6385030)
[ 20.256527] CPU: After generic identify, caps: bfe9fbff 00100000 00000000 00000000 0000c189 00000000 00000000
[ 20.256538] monitor/mwait feature present.
[ 20.256544] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 20.256548] CPU: L2 cache: 2048K
[ 20.256553] CPU: Physical Processor ID: 0
[ 20.256556] CPU: Processor Core ID: 1
[ 20.256560] CPU: After all inits, caps: bfe9fbff 00100000 00000000 00002940 0000c189 00000000 00000000
[ 20.257344] CPU1: Intel Genuine Intel(R) CPU T2050 @ 1.60GHz stepping 08
[ 20.257382] Total of 2 processors activated (6389.34 BogoMIPS).
[ 20.258942] ENABLING IO-APIC IRQs
[ 20.259224] ..TIMER: vector=0x31 apic1=0 pin1=2 apic2=-1 pin2=-1
[ 20.432367] checking TSC synchronization across 2 CPUs: passed.
[ 0.004001] Brought up 2 CPUs
[ 0.460277] migration_cost=74
[ 0.460764] Booting paravirtualized kernel on bare hardware
[ 0.460892] Time: 14:38:09 Date: 03/17/107
[ 0.460943] NET: Registered protocol family 16
[ 0.461091] EISA bus registered
[ 0.461100] ACPI: bus type pci registered
[ 0.461271] PCI: PCI BIOS revision 2.10 entry at 0xfd5b3, last bus=10
[ 0.461276] PCI: Using configuration type 1
[ 0.461280] Setting up standard PCI resources
[ 0.471114] ACPI: Interpreter enabled
[ 0.471119] ACPI: Using IOAPIC for interrupt routing
[ 0.472109] ACPI: PCI Root Bridge [PCI0] (0000:00)
[ 0.472117] PCI: Probing PCI hardware (bus 00)
[ 0.473759] Boot video device is 0000:00:02.0
[ 0.474644] PCI quirk: region 1000-107f claimed by ICH6 ACPI/GPIO/TCO
[ 0.474652] PCI quirk: region 1180-11bf claimed by ICH6 GPIO
[ 0.476217] PCI: Transparent bridge - 0000:00:1e.0
[ 0.476337] PCI: Bus #0b (-#0e) is hidden behind transparent bridge #0a (-#0a) (try 'pci=assign-busses')
[ 0.476343] Please report the result to linux-kernel to fix this permanently
[ 0.476453] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
[ 0.485196] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP01._PRT]
[ 0.485766] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP02._PRT]
[ 0.486324] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP03._PRT]
[ 0.486885] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP04._PRT]
[ 0.489764] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PCIB._PRT]
[ 0.491173] ACPI: PCI Interrupt Link [LNKA] (IRQs 10 *11)
[ 0.491722] ACPI: PCI Interrupt Link [LNKB] (IRQs 10 *11)
[ 0.492261] ACPI: PCI Interrupt Link [LNKC] (IRQs *10 11)
[ 0.492803] ACPI: PCI Interrupt Link [LNKD] (IRQs *10 11)
[ 0.493340] ACPI: PCI Interrupt Link [LNKE] (IRQs 10 11) *0, disabled.
[ 0.493887] ACPI: PCI Interrupt Link [LNKF] (IRQs 10 11) *0, disabled.
[ 0.494426] ACPI: PCI Interrupt Link [LNKG] (IRQs *10 11)
[ 0.494965] ACPI: PCI Interrupt Link [LNKH] (IRQs 10 *11)
[ 0.504820] Linux Plug and Play Support v0.97 (c) Adam Belay
[ 0.504837] pnp: PnP ACPI init
[ 0.510648] pnp: PnP ACPI: found 11 devices
[ 0.510656] PnPBIOS: Disabled by ACPI PNP
[ 0.510733] PCI: Using ACPI for IRQ routing
[ 0.510739] PCI: If a device doesn't work, try "pci=routeirq". If it helps, post a report
[ 0.552313] NET: Registered protocol family 8
[ 0.552318] NET: Registered protocol family 20
[ 0.552969] pnp: 00:07: ioport range 0x6a0-0x6af has been reserved
[ 0.552975] pnp: 00:07: ioport range 0x6b0-0x6ff has been reserved
[ 0.553562] PCI: Ignore bogus resource 6 [0:0] of 0000:00:02.0
[ 0.553575] PCI: Bridge: 0000:00:1c.0
[ 0.553581] IO window: 2000-2fff
[ 0.553591] MEM window: c8000000-c9ffffff
[ 0.553599] PREFETCH window: c0000000-c1ffffff
[ 0.553608] PCI: Bridge: 0000:00:1c.1
[ 0.553614] IO window: 3000-3fff
[ 0.553623] MEM window: ca000000-cbffffff
[ 0.553631] PREFETCH window: c2000000-c3ffffff
[ 0.553641] PCI: Bridge: 0000:00:1c.2
[ 0.553646] IO window: 4000-4fff
[ 0.553656] MEM window: cc000000-cdffffff
[ 0.553664] PREFETCH window: c4000000-c5ffffff
[ 0.553673] PCI: Bridge: 0000:00:1c.3
[ 0.553678] IO window: 5000-5fff
[ 0.553688] MEM window: ce000000-cfffffff
[ 0.553696] PREFETCH window: c6000000-c7ffffff
[ 0.553715] PCI: Bus 11, cardbus bridge: 0000:0a:06.0
[ 0.553720] IO window: 00006000-000060ff
[ 0.553728] IO window: 00006400-000064ff
[ 0.553737] PREFETCH window: 50000000-53ffffff
[ 0.553745] MEM window: 54000000-57ffffff
[ 0.553753] PCI: Bridge: 0000:00:1e.0
[ 0.553759] IO window: 6000-6fff
[ 0.553768] MEM window: d0000000-d00fffff
[ 0.553776] PREFETCH window: 50000000-53ffffff
[ 0.553818] ACPI: PCI Interrupt 0000:00:1c.0[A] -> GSI 17 (level, low) -> IRQ 16
[ 0.553830] PCI: Setting latency timer of device 0000:00:1c.0 to 64
[ 0.553864] ACPI: PCI Interrupt 0000:00:1c.1[B] -> GSI 16 (level, low) -> IRQ 17
[ 0.553875] PCI: Setting latency timer of device 0000:00:1c.1 to 64
[ 0.553908] ACPI: PCI Interrupt 0000:00:1c.2[C] -> GSI 18 (level, low) -> IRQ 18
[ 0.553918] PCI: Setting latency timer of device 0000:00:1c.2 to 64
[ 0.553952] ACPI: PCI Interrupt 0000:00:1c.3[D] -> GSI 19 (level, low) -> IRQ 19
[ 0.553962] PCI: Setting latency timer of device 0000:00:1c.3 to 64
[ 0.553983] PCI: Setting latency timer of device 0000:00:1e.0 to 64
[ 0.554008] ACPI: PCI Interrupt 0000:0a:06.0[A] -> GSI 22 (level, low) -> IRQ 20
[ 0.554063] NET: Registered protocol family 2
[ 0.607564] IP route cache hash table entries: 32768 (order: 5, 131072 bytes)
[ 0.607746] TCP established hash table entries: 131072 (order: 8, 1048576 bytes)
[ 0.609276] TCP bind hash table entries: 65536 (order: 7, 524288 bytes)
[ 0.610057] TCP: Hash tables configured (established 131072 bind 65536)
[ 0.610062] TCP reno registered
[ 0.623700] checking if image is initramfs... it is
[ 1.993931] Freeing initrd memory: 6784k freed
[ 1.994203] Simple Boot Flag at 0x36 set to 0x1
[ 1.995099] audit: initializing netlink socket (disabled)
[ 1.995125] audit(1176820691.024:1): initialized
[ 1.995301] highmem bounce pool size: 64 pages
[ 1.995458] VFS: Disk quotas dquot_6.5.1
[ 1.995493] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 1.995573] io scheduler noop registered
[ 1.995578] io scheduler anticipatory registered
[ 1.995583] io scheduler deadline registered
[ 1.995606] io scheduler cfq registered (default)
[ 1.995981] PCI: Setting latency timer of device 0000:00:1c.0 to 64
[ 1.996059] assign_interrupt_mode Found MSI capability
[ 1.996065] Allocate Port Service[0000:00:1c.0:pcie00]
[ 1.996138] Allocate Port Service[0000:00:1c.0:pcie02]
[ 1.996323] PCI: Setting latency timer of device 0000:00:1c.1 to 64
[ 1.996399] assign_interrupt_mode Found MSI capability
[ 1.996405] Allocate Port Service[0000:00:1c.1:pcie00]
[ 1.996468] Allocate Port Service[0000:00:1c.1:pcie02]
[ 1.996653] PCI: Setting latency timer of device 0000:00:1c.2 to 64
[ 1.996729] assign_interrupt_mode Found MSI capability
[ 1.996734] Allocate Port Service[0000:00:1c.2:pcie00]
[ 1.996800] Allocate Port Service[0000:00:1c.2:pcie02]
[ 1.996981] PCI: Setting latency timer of device 0000:00:1c.3 to 64
[ 1.997057] assign_interrupt_mode Found MSI capability
[ 1.997063] Allocate Port Service[0000:00:1c.3:pcie00]
[ 1.997132] Allocate Port Service[0000:00:1c.3:pcie02]
[ 1.997424] isapnp: Scanning for PnP cards...
[ 2.351657] isapnp: No Plug & Play device found
[ 2.398547] Real Time Clock Driver v1.12ac
[ 2.398664] Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing enabled
[ 2.399855] mice: PS/2 mouse device common for all mice
[ 2.400957] RAMDISK driver initialized: 16 RAM disks of 65536K size 1024 blocksize
[ 2.401360] input: Macintosh mouse button emulation as /class/input/input0
[ 2.401427] Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2
[ 2.401434] ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx
[ 2.401780] PNP: PS/2 Controller [PNP0303:KBD0,PNP0f13:PS2M] at 0x60,0x64 irq 1,12
[ 2.402953] i8042.c: Detected active multiplexing controller, rev 1.1.
[ 2.403044] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 2.403052] serio: i8042 AUX0 port at 0x60,0x64 irq 12
[ 2.403058] serio: i8042 AUX1 port at 0x60,0x64 irq 12
[ 2.403063] serio: i8042 AUX2 port at 0x60,0x64 irq 12
[ 2.403068] serio: i8042 AUX3 port at 0x60,0x64 irq 12
[ 2.403280] EISA: Probing bus 0 at eisa.0
[ 2.403294] Cannot allocate resource for EISA slot 1
[ 2.403301] Cannot allocate resource for EISA slot 2
[ 2.403306] Cannot allocate resource for EISA slot 3
[ 2.403311] Cannot allocate resource for EISA slot 4
[ 2.403316] Cannot allocate resource for EISA slot 5
[ 2.403321] Cannot allocate resource for EISA slot 6
[ 2.403338] EISA: Detected 0 cards.
[ 2.429996] input: AT Translated Set 2 keyboard as /class/input/input1
[ 2.433475] TCP cubic registered
[ 2.433491] NET: Registered protocol family 1
[ 2.433532] Starting balanced_irq
[ 2.433546] Using IPI No-Shortcut mode
[ 2.433683] ACPI: (supports S0 S3 S4 S5)
[ 2.433770] Magic number: 3:330:637
[ 2.433952] Time: tsc clocksource has been installed.
[ 2.434147] Freeing unused kernel memory: 328k freed
[ 3.856795] Capability LSM initialized
[ 3.932903] ACPI (exconfig-0455): Dynamic SSDT Load - OemId [ PmRef] OemTableId [ Cpu0Ist] [20060707]
[ 3.933411] ACPI (exconfig-0455): Dynamic SSDT Load - OemId [ PmRef] OemTableId [ Cpu0Cst] [20060707]
[ 3.934034] ACPI: CPU0 (power states: C1[C1] C2[C2] C3[C3])
[ 3.935129] ACPI (exconfig-0455): Dynamic SSDT Load - OemId [ PmRef] OemTableId [ Cpu1Ist] [20060707]
[ 3.935578] ACPI (exconfig-0455): Dynamic SSDT Load - OemId [ PmRef] OemTableId [ Cpu1Cst] [20060707]
[ 3.936300] ACPI: CPU1 (power states: C1[C1] C2[C2] C3[C3])
[ 4.792000] ACPI: Thermal Zone [TZS0] (32 C)
[ 4.796000] Time: hpet clocksource has been installed.
[ 4.796000] ACPI: Thermal Zone [TZS1] (32 C)
[ 5.408000] r8169 Gigabit Ethernet driver 2.2LK loaded
[ 5.408000] ACPI: PCI Interrupt 0000:02:00.0[A] -> GSI 16 (level, low) -> IRQ 17
[ 5.408000] PCI: Setting latency timer of device 0000:02:00.0 to 64
[ 5.408000] eth0: RTL8168b/8111b at 0xf885a000, 00:16:d3:40:fa:55, IRQ 17
[ 5.432000] usbcore: registered new interface driver usbfs
[ 5.432000] usbcore: registered new interface driver hub
[ 5.432000] usbcore: registered new device driver usb
[ 5.432000] USB Universal Host Controller Interface driver v3.0
[ 5.432000] ACPI: PCI Interrupt 0000:00:1d.0[A] -> GSI 23 (level, low) -> IRQ 21
[ 5.432000] PCI: Setting latency timer of device 0000:00:1d.0 to 64
[ 5.432000] uhci_hcd 0000:00:1d.0: UHCI Host Controller
[ 5.432000] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 1
[ 5.432000] uhci_hcd 0000:00:1d.0: irq 21, io base 0x00001820
[ 5.432000] usb usb1: configuration #1 chosen from 1 choice
[ 5.432000] hub 1-0:1.0: USB hub found
[ 5.432000] hub 1-0:1.0: 2 ports detected
[ 5.504000] SCSI subsystem initialized
[ 5.516000] libata version 2.20 loaded.
[ 5.536000] ACPI: PCI Interrupt 0000:00:1d.1[B] -> GSI 19 (level, low) -> IRQ 19
[ 5.536000] PCI: Setting latency timer of device 0000:00:1d.1 to 64
[ 5.536000] uhci_hcd 0000:00:1d.1: UHCI Host Controller
[ 5.536000] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 2
[ 5.536000] uhci_hcd 0000:00:1d.1: irq 19, io base 0x00001840
[ 5.536000] usb usb2: configuration #1 chosen from 1 choice
[ 5.536000] hub 2-0:1.0: USB hub found
[ 5.536000] hub 2-0:1.0: 2 ports detected
[ 5.640000] ACPI: PCI Interrupt 0000:00:1d.2[C] -> GSI 18 (level, low) -> IRQ 18
[ 5.640000] PCI: Setting latency timer of device 0000:00:1d.2 to 64
[ 5.640000] uhci_hcd 0000:00:1d.2: UHCI Host Controller
[ 5.640000] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 3
[ 5.640000] uhci_hcd 0000:00:1d.2: irq 18, io base 0x00001860
[ 5.640000] usb usb3: configuration #1 chosen from 1 choice
[ 5.640000] hub 3-0:1.0: USB hub found
[ 5.640000] hub 3-0:1.0: 2 ports detected
[ 5.744000] ACPI: PCI Interrupt 0000:00:1d.3[D] -> GSI 16 (level, low) -> IRQ 17
[ 5.744000] PCI: Setting latency timer of device 0000:00:1d.3 to 64
[ 5.744000] uhci_hcd 0000:00:1d.3: UHCI Host Controller
[ 5.744000] uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 4
[ 5.744000] uhci_hcd 0000:00:1d.3: irq 17, io base 0x00001880
[ 5.744000] usb usb4: configuration #1 chosen from 1 choice
[ 5.744000] hub 4-0:1.0: USB hub found
[ 5.744000] hub 4-0:1.0: 2 ports detected
[ 5.848000] ACPI: PCI Interrupt 0000:00:1d.7[A] -> GSI 23 (level, low) -> IRQ 21
[ 5.848000] PCI: Setting latency timer of device 0000:00:1d.7 to 64
[ 5.848000] ehci_hcd 0000:00:1d.7: EHCI Host Controller
[ 5.848000] ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 5
[ 5.848000] ehci_hcd 0000:00:1d.7: debug port 1
[ 5.848000] PCI: cache line size of 32 is not supported by device 0000:00:1d.7
[ 5.852000] ehci_hcd 0000:00:1d.7: irq 21, io mem 0xd0444000
[ 5.856000] ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
[ 5.856000] usb usb5: configuration #1 chosen from 1 choice
[ 5.856000] hub 5-0:1.0: USB hub found
[ 5.856000] hub 5-0:1.0: 8 ports detected
[ 5.960000] ata_piix 0000:00:1f.2: version 2.10ac1
[ 5.960000] ata_piix 0000:00:1f.2: MAP [ IDE IDE P1 P3 ]
[ 5.960000] ACPI: PCI Interrupt 0000:00:1f.2[B] -> GSI 19 (level, low) -> IRQ 19
[ 5.960000] PCI: Setting latency timer of device 0000:00:1f.2 to 64
[ 5.960000] ata1: PATA max UDMA/100 cmd 0x000101f0 ctl 0x000103f6 bmdma 0x000118b0 irq 14
[ 5.960000] ata2: SATA max UDMA/133 cmd 0x00010170 ctl 0x00010376 bmdma 0x000118b8 irq 15
[ 5.960000] scsi0 : ata_piix
[ 6.248000] usb 5-7: new high speed USB device using ehci_hcd and address 2
[ 6.304000] ata1.00: ATA-6: WDC WD800UE-22HCT0, 09.07D09, max UDMA/100
[ 6.304000] ata1.00: 156301488 sectors, multi 16: LBA
[ 6.304000] ata1.01: ATAPI, max UDMA/33
[ 6.312000] ata1.00: configured for UDMA/100
[ 6.420000] usb 5-7: configuration #1 chosen from 1 choice
[ 6.500000] ata1.01: configured for UDMA/33
[ 6.500000] scsi1 : ata_piix
[ 6.656000] ATA: abnormal status 0x7F on port 0x00010177
[ 6.660000] scsi 0:0:0:0: Direct-Access ATA WDC WD800UE-22HC 09.0 PQ: 0 ANSI: 5
[ 6.676000] scsi 0:0:1:0: CD-ROM TSSTcorp CD/DVDW TS-L632D ac00 PQ: 0 ANSI: 5
[ 6.696000] SCSI device sda: 156301488 512-byte hdwr sectors (80026 MB)
[ 6.696000] sda: Write Protect is off
[ 6.696000] sda: Mode Sense: 00 3a 00 00
[ 6.696000] SCSI device sda: write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 6.696000] SCSI device sda: 156301488 512-byte hdwr sectors (80026 MB)
[ 6.696000] sda: Write Protect is off
[ 6.696000] sda: Mode Sense: 00 3a 00 00
[ 6.696000] SCSI device sda: write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 6.696000] sda: sda1 sda2 sda3 sda4
[ 6.784000] sd 0:0:0:0: Attached scsi disk sda
[ 6.788000] sd 0:0:0:0: Attached scsi generic sg0 type 0
[ 6.788000] sr 0:0:1:0: Attached scsi generic sg1 type 5
[ 6.888000] sr0: scsi3-mmc drive: 24x/24x writer dvd-ram cd/rw xa/form2 cdda tray
[ 6.888000] Uniform CD-ROM driver Revision: 3.20
[ 6.888000] sr 0:0:1:0: Attached scsi CD-ROM sr0
[ 7.696000] Attempting manual resume
[ 7.696000] swsusp: Resume From Partition 8:4
[ 7.696000] PM: Checking swsusp image.
[ 7.696000] PM: Resume from disk failed.
[ 7.752000] kjournald starting. Commit interval 5 seconds
[ 7.752000] EXT3-fs: mounted filesystem with ordered data mode.
[ 19.528000] r8169: eth0: link up
[ 19.528000] r8169: eth0: link up
[ 20.804000] NET: Registered protocol family 17
[ 21.116000] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[ 21.120000] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[ 21.580000] Linux agpgart interface v0.102 (c) Dave Jones
[ 21.588000] agpgart: Detected an Intel 945GM Chipset.
[ 21.588000] agpgart: Detected 7932K stolen memory.
[ 21.608000] agpgart: AGP aperture is 256M @ 0xb0000000
[ 21.896000] iTCO_vendor_support: vendor-support=0
[ 21.916000] iTCO_wdt: Intel TCO WatchDog Timer Driver v1.01 (11-Nov-2006)
[ 22.008000] Synaptics Touchpad, model: 1, fw: 6.2, id: 0x12a0b1, caps: 0xa04713/0x204000
[ 22.040000] input: SynPS/2 Synaptics TouchPad as /class/input/input2
[ 22.044000] iTCO_wdt: failed to reset NO_REBOOT flag, reboot disabled by hardware
[ 22.044000] iTCO_wdt: No card detected
[ 22.052000] ACPI: PCI Interrupt 0000:0a:06.2[A] -> GSI 22 (level, low) -> IRQ 20
[ 22.172000] Yenta: CardBus bridge found at 0000:0a:06.0 [1025:0107]
[ 22.172000] Yenta: Using CSCINT to route CSC interrupts to PCI
[ 22.172000] Yenta: Routing CardBus interrupts to PCI
[ 22.172000] Yenta TI: socket 0000:0a:06.0, mfunc 0x01aa1b22, devctl 0x64
[ 22.192000] intel_rng: FWH not detected
[ 22.236000] ieee80211_crypt: registered algorithm 'NULL'
[ 22.260000] ieee80211: 802.11 data/management/control stack, git-1.1.13
[ 22.260000] ieee80211: Copyright (C) 2004-2005 Intel Corporation <email address hidden>
[ 22.404000] Yenta: ISA IRQ mask 0x0cf8, PCI irq 20
[ 22.404000] Socket status: 30000006
[ 22.404000] Yenta: Raising subordinate bus# of parent bus (#0a) from #0a to #0e
[ 22.404000] pcmcia: parent PCI bridge I/O window: 0x6000 - 0x6fff
[ 22.404000] cs: IO port probe 0x6000-0x6fff: clean.
[ 22.404000] pcmcia: parent PCI bridge Memory window: 0xd0000000 - 0xd00fffff
[ 22.404000] pcmcia: parent PCI bridge Memory window: 0x50000000 - 0x53ffffff
[ 22.420000] sdhci: Secure Digital Host Controller Interface driver
[ 22.420000] sdhci: Copyright(c) Pierre Ossman
[ 22.420000] sdhci: SDHCI controller found at 0000:0a:06.3 [104c:803c] (rev 0)
[ 22.420000] ACPI: PCI Interrupt 0000:0a:06.3[A] -> GSI 22 (level, low) -> IRQ 20
[ 22.420000] mmc0: SDHCI at 0xd0005800 irq 20 PIO
[ 22.448000] Linux video capture interface: v2.00
[ 22.488000] ipw3945: Intel(R) PRO/Wireless 3945 Network Connection driver for Linux, 1.2.0mp
[ 22.488000] ipw3945: Copyright(c) 2003-2006 Intel Corporation
[ 22.488000] ACPI: PCI Interrupt 0000:05:00.0[A] -> GSI 18 (level, low) -> IRQ 18
[ 22.488000] PCI: Setting latency timer of device 0000:05:00.0 to 64
[ 22.488000] ipw3945: Detected Intel PRO/Wireless 3945ABG Network Connection
[ 22.712000] ubuntu/media/gspcav1/gspca_core.c: USB SPCA5XX camera found.(VC0321)
[ 22.924000] ubuntu/media/gspcav1/gspca_core.c: Failed to configure camera
[ 22.924000] gspca: probe of 5-7:1.0 failed with error -5
[ 22.924000] usbcore: registered new interface driver gspca
[ 22.924000] ubuntu/media/gspcav1/gspca_core.c: gspca driver 01.00.12 registered
[ 22.992000] cs: IO port probe 0x100-0x3af: clean.
[ 22.996000] cs: IO port probe 0x3e0-0x4ff: excluding 0x4d0-0x4d7
[ 22.996000] cs: IO port probe 0x820-0x8ff: clean.
[ 22.996000] cs: IO port probe 0xc00-0xcf7: clean.
[ 22.996000] cs: IO port probe 0xa00-0xaff: clean.
[ 23.104000] ACPI: PCI Interrupt 0000:00:1b.0[A] -> GSI 22 (level, low) -> IRQ 20
[ 23.104000] PCI: Setting latency timer of device 0000:00:1b.0 to 64
[ 23.164000] usb 5-7: USB disconnect, address 2
[ 23.404000] usb 5-7: new high speed USB device using ehci_hcd and address 3
[ 23.576000] usb 5-7: configuration #1 chosen from 1 choice
[ 23.576000] ubuntu/media/gspcav1/gspca_core.c: USB SPCA5XX camera found.(VC0321)
[ 23.988000] fuse init (API version 7.8)
[ 24.072000] lp: driver loaded but no devices found
[ 24.132000] Adding 4072468k swap on /dev/disk/by-uuid/a9f262b0-934e-4ad2-aec5-b9be4cbf9c23. Priority:-1 extents:1 across:4072468k
[ 24.432000] EXT3 FS on sda3, internal journal
[ 24.460000] ipw3945: Detected geography ABG (13 802.11bg channels, 23 802.11a channels)
[ 24.748000] NET: Registered protocol family 10
[ 24.748000] lo: Disabled Privacy Extensions
[ 24.748000] ADDRCONF(NETDEV_UP): eth1: link is not ready
[ 26.300000] NTFS driver 2.1.28 [Flags: R/O MODULE].
[ 26.404000] NTFS volume version 3.1.
[ 31.536000] Using specific hotkey driver
[ 31.600000] input: Power Button (FF) as /class/input/input3
[ 31.600000] ACPI: Power Button (FF) [PWRF]
[ 31.600000] input: Lid Switch as /class/input/input4
[ 31.600000] ACPI: Lid Switch [LID0]
[ 31.600000] input: Sleep Button (CM) as /class/input/input5
[ 31.600000] ACPI: Sleep Button (CM) [SLPB]
[ 31.700000] ACPI: Video Device [VGA] (multi-head: yes rom: no post: no)
[ 31.700000] ACPI: Video Device [GFX0] (multi-head: yes rom: no post: no)
[ 31.740000] ACPI: AC Adapter [ADP1] (on-line)
[ 31.856000] ACPI: Battery Slot [BAT0] (battery present)
[ 31.956000] ibm_acpi: ec object not found
[ 32.044000] No dock devices found.
[ 32.308000] pcc_acpi: loading...
[ 35.704000] eth0: no IPv6 routers present
[ 36.688000] ppdev: user-space parallel port driver
[ 37.464000] apm: BIOS not found.
[ 38.084000] Bluetooth: Core ver 2.11
[ 38.084000] NET: Registered protocol family 31
[ 38.084000] Bluetooth: HCI device and connection manager initialized
[ 38.084000] Bluetooth: HCI socket layer initialized
[ 38.128000] Bluetooth: L2CAP ver 2.8
[ 38.128000] Bluetooth: L2CAP socket layer initialized
[ 38.252000] Bluetooth: RFCOMM socket layer initialized
[ 38.252000] Bluetooth: RFCOMM TTY layer initialized
[ 38.252000] Bluetooth: RFCOMM ver 1.8
[ 40.776000] [drm] Initialized drm 1.1.0 20060810
[ 40.780000] ACPI: PCI Interrupt 0000:00:02.0[A] -> GSI 16 (level, low) -> IRQ 17
[ 40.780000] [drm] Initialized i915 1.6.0 20060119 on minor 0
[ 52.340000] eth0: no IPv6 routers present
[ 5164.800000] atkbd.c: Unknown key pressed (translated set 2, code 0xb3 on isa0060/serio0).
[ 5164.800000] atkbd.c: Use 'setkeycodes e033 <keycode>' to make it known.
[ 5164.916000] atkbd.c: Unknown key released (translated set 2, code 0xb3 on isa0060/serio0).
[ 5164.916000] atkbd.c: Use 'setkeycodes e033 <keycode>' to make it known.
[ 9101.412000] ata1.01: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
[ 9101.412000] ata1.01: cmd a0/01:00:00:00:00/00:00:00:00:00/b0 tag 0 cdb 0x25 data 8 in
[ 9101.412000] res 40/00:03:00:00:00/00:00:00:00:00/b0 Emask 0x4 (timeout)
[ 9108.412000] ata1: port is slow to respond, please be patient (Status 0xd0)
[ 9131.428000] ata1: port failed to respond (30 secs, Status 0xd0)
[ 9131.428000] ata1: soft resetting port
[ 9131.780000] ata1.00: configured for UDMA/100
[ 9131.960000] ata1.01: configured for UDMA/33
[ 9131.960000] ata1: EH complete
[ 9131.976000] SCSI device sda: 156301488 512-byte hdwr sectors (80026 MB)
[ 9131.992000] sda: Write Protect is off
[ 9131.992000] sda: Mode Sense: 00 3a 00 00
[ 9132.016000] SCSI device sda: write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 9132.452000] SCSI device sda: 156301488 512-byte hdwr sectors (80026 MB)
[ 9132.452000] sda: Write Protect is off
[ 9132.452000] sda: Mode Sense: 00 3a 00 00
[ 9132.452000] SCSI device sda: write cache: enabled, read cache: enabled, doesn't support DPO or FUA

ProblemType: Bug
Architecture: i386
Date: Tue Apr 17 17:18:50 2007
DistroRelease: Ubuntu 7.04
Uname: Linux spp-nb-tgo 2.6.20-15-generic #2 SMP Sun Apr 15 07:36:31 UTC 2007 i686 GNU/Linux

[holycow (mik-mars)]

i too have the exact same issue and thats with the feisty final release kernel.

my laptop is an asus z96f with Intel cpu and chipset.

the basic problem seems to surround the following dmesg and syslog messages:

[ 6105.876000] ata2: port is slow to respond, please be patient (Status 0xd0)
[ 6128.892000] ata2: port failed to respond (30 secs, Status 0xd0)
[ 6128.892000] ata2: soft resetting port
[ 6129.236000] ata2.00: ata_hpa_resize 1: sectors = 78140160, hpa_sectors = 78140160
[ 6129.244000] ata2.00: ata_hpa_resize 1: sectors = 78140160, hpa_sectors = 78140160
[ 6129.244000] ata2.00: configured for UDMA/100
[ 6129.424000] ata2.01: configured for UDMA/25
[ 6129.424000] ata2: EH complete
[ 6129.440000] SCSI device sda: 78140160 512-byte hdwr sectors (40008 MB)
[ 6129.456000] sda: Write Protect is off
[ 6129.456000] sda: Mode Sense: 00 3a 00 00
[ 6129.488000] SCSI device sda: write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 6129.496000] SCSI device sda: 78140160 512-byte hdwr sectors (40008 MB)
[ 6129.496000] sda: Write Protect is off
[ 6129.496000] sda: Mode Sense: 00 3a 00 00
[ 6129.496000] SCSI device sda: write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 8876.524000] ata2.01: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
[ 8876.524000] ata2.01: cmd a0/01:00:00:00:00/00:00:00:00:00/b0 tag 0 cdb 0x25 data 8 in
[ 8876.524000] res 40/00:03:00:00:00/00:00:00:00:00/b0 Emask 0x4 (timeout)

i have included dmesg and syslog as attachments for review

[holycow (mik-mars)]

adding syslog now

[holycow (mik-mars)]

please let me know if there are any other tests you would like performed to help track down this issue as it is essentially a show stopper and might require immediate update for feisty.

[Keenan Pepper (keenanpepper)]

Bug 84603 is the same problem and has a workaround. The new ata-piix driver doesn't play nicely with HAL, so use the old piix driver instead.