LKML Archive on lore.kernel.org
help / color / mirror / Atom feed
* sata error on ICH8M
@ 2008-11-04 11:26 Tim Connors
2008-11-04 11:52 ` sata error on ICH8M (Dell Vostro 1710 laptop) Tim Connors
2008-11-11 14:01 ` sata error on ICH8M Tejun Heo
0 siblings, 2 replies; 5+ messages in thread
From: Tim Connors @ 2008-11-04 11:26 UTC (permalink / raw)
To: Linux Kernel Mailing List; +Cc: linux-ide
I'm running a debian 2.6.26-9 kernel (sid) on a new laptop with:
00:1f.2 SATA controller: Intel Corporation 82801HBM/HEM (ICH8M/ICH8M-E) SATA AHCI Controller (rev 03) (prog-if 01 [AHCI 1.0])
Subsystem: Dell Device 0275
Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx+
Status: Cap+ 66MHz+ UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 0
Interrupt: pin B routed to IRQ 378
Region 0: I/O ports at 1c00 [size=8]
Region 1: I/O ports at 18d4 [size=4]
Region 2: I/O ports at 18d8 [size=8]
Region 3: I/O ports at 18d0 [size=4]
Region 4: I/O ports at 18e0 [size=32]
Region 5: Memory at f8504000 (32-bit, non-prefetchable) [size=2K]
Capabilities: [80] Message Signalled Interrupts: Mask- 64bit- Queue=0/2 Enable+
Address: fee0300c Data: 41a1
Capabilities: [70] Power Management version 3
Flags: PMEClk- DSI- D1- D2- AuxCurrent=0mA PME(D0-,D1-,D2-,D3hot+,D3cold-)
Flags: PMEClk- DSI- D1- D2- AuxCurrent=0mA PME(D0-,D1-,D2-,D3hot+,D3cold-)
Status: D0 PME-Enable- DSel=0 DScale=0 PME-
Capabilities: [a8] SATA HBA <?>
Kernel driver in use: ahci
Kernel modules: ahci
Soon after booting, and possibly after the disk had spun down and was
asked to spin back up (which it had done successfully a few times so
far, with a spinddown timeout of 10 minutes, and using laptop_mode), it
had a sata error:
Nov 4 01:49:29 gamow kernel: [ 1865.106289] ata1.00: exception Emask 0x10 SAct 0x3ff SErr 0x50000 action 0xe frozen
Nov 4 01:50:29 gamow kernel: [ 1865.106307] ata1: SError: { PHYRdyChg CommWake }
Nov 4 01:50:29 gamow kernel: [ 1865.106319] ata1.00: cmd 61/08:00:bd:c9:57/00:00:00:00:00/40 tag 0 ncq 4096 out
Nov 4 01:50:29 gamow kernel: [ 1865.106322] res 40/00:00:02:4f:c2/00:00:00:00:00/00 Emask 0x14 (ATA bus error)
Nov 4 01:50:29 gamow kernel: [ 1865.106329] ata1.00: status: { DRDY }
Nov 4 01:50:29 gamow kernel: [ 1865.106339] ata1.00: cmd 61/08:08:35:7a:73/00:00:00:00:00/40 tag 1 ncq 4096 out
Nov 4 01:50:29 gamow kernel: [ 1865.106343] res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x14 (ATA bus error)
Nov 4 01:50:29 gamow kernel: [ 1865.106350] ata1.00: status: { DRDY }
Nov 4 01:50:29 gamow kernel: [ 1865.106361] ata1.00: cmd 61/08:10:35:36:9b/00:00:00:00:00/40 tag 2 ncq 4096 out
Nov 4 01:50:29 gamow kernel: [ 1865.106364] res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x14 (ATA bus error)
Nov 4 01:50:29 gamow kernel: [ 1865.106371] ata1.00: status: { DRDY }
Nov 4 01:50:29 gamow kernel: [ 1865.106382] ata1.00: cmd 61/28:18:55:94:e2/00:00:00:00:00/40 tag 3 ncq 20480 out
And then it fails to reset after some time, remounting the devices
readonly (although what wasn't already in the cache became unreadable with
lots of IO errors rapidly filling up dmesg). None of the logs made it to
disk, naturally enough, and this was what I caught in syslog before syslog
bailed. There were interesting messages that happened after this, but the
dmesg buffer filled up before I thought about saving them.
My /sys/class/scsi_host/host0/link_power_management_policy is:
min_power
. powertop had earlier (in a previous warm-boot) prompted me
to set link_power_management_policy, so I had been tweaking that, but I
didn't look at its default setting - I presume it was already at
min_power, as it is now from a fresh (cold) bootup.
Just in case it is related, in each bootup, I earlier get
Nov 4 01:20:26 gamow kernel: [ 116.217492] CE: hpet increasing min_delta_ns to 15000 nsec
Nov 4 01:20:28 gamow kernel: [ 118.073078] CE: hpet increasing min_delta_ns to 22500 nsec
Nov 4 01:20:30 gamow kernel: [ 120.467250] ACPI: EC: missing confirmations, switch off interrupt mode.
Nov 4 01:20:30 gamow kernel: [ 120.603593] CE: hpet increasing min_delta_ns to 33750 nsec
Nov 4 01:20:31 gamow kernel: [ 121.004372] ACPI Exception (evregion-0420): AE_TIME, Returned by Handler for [EmbeddedControl] [20080321]
Nov 4 01:20:31 gamow kernel: [ 121.004372] ACPI Error (psparse-0530): Method parse/execution failed [\_SB_.PCI0.LPCB.BAT1._BST] (Node ffff81013fa6cb90), AE_TIME
Nov 4 01:20:31 gamow kernel: [ 121.004372] ACPI Exception (battery-0360): AE_TIME, Evaluating _BST [20080321]
and/or
[ 1587.842640] CE: hpet increasing min_delta_ns to 15000 nsec
(successively increasing as time goes on)
The sata link went belly up perhaps a few minutes after I went to bed
lastnight, and the only thing I can think of that I did before then was to
unplug and replug the ethernet and/or the wireless. The ACPI messages
seem to happen around networking events on this laptop, but I haven't had
a chance to investigate further.
--
TimC
You must realize that the computer has it in for you. The irrefutable
proof of this is that the computer always does what you tell it to do.
^ permalink raw reply [flat|nested] 5+ messages in thread
* Re: sata error on ICH8M (Dell Vostro 1710 laptop)
2008-11-04 11:26 sata error on ICH8M Tim Connors
@ 2008-11-04 11:52 ` Tim Connors
2008-11-11 14:01 ` sata error on ICH8M Tejun Heo
1 sibling, 0 replies; 5+ messages in thread
From: Tim Connors @ 2008-11-04 11:52 UTC (permalink / raw)
To: Linux Kernel Mailing List; +Cc: linux-ide
[-- Attachment #1: Type: TEXT/PLAIN, Size: 1733 bytes --]
On Tue, 4 Nov 2008, Tim Connors wrote:
> I'm running a debian 2.6.26-9 kernel (sid) on a new laptop with:
> 00:1f.2 SATA controller: Intel Corporation 82801HBM/HEM (ICH8M/ICH8M-E) SATA AHCI Controller (rev 03) (prog-if 01 [AHCI 1.0])
> Subsystem: Dell Device 0275
> Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx+
> Status: Cap+ 66MHz+ UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
> Latency: 0
> Interrupt: pin B routed to IRQ 378
> Region 0: I/O ports at 1c00 [size=8]
> Region 1: I/O ports at 18d4 [size=4]
> Region 2: I/O ports at 18d8 [size=8]
> Region 3: I/O ports at 18d0 [size=4]
> Region 4: I/O ports at 18e0 [size=32]
> Region 5: Memory at f8504000 (32-bit, non-prefetchable) [size=2K]
> Capabilities: [80] Message Signalled Interrupts: Mask- 64bit- Queue=0/2 Enable+
> Address: fee0300c Data: 41a1
> Capabilities: [70] Power Management version 3
> Flags: PMEClk- DSI- D1- D2- AuxCurrent=0mA PME(D0-,D1-,D2-,D3hot+,D3cold-)
> Flags: PMEClk- DSI- D1- D2- AuxCurrent=0mA PME(D0-,D1-,D2-,D3hot+,D3cold-)
> Status: D0 PME-Enable- DSel=0 DScale=0 PME-
> Capabilities: [a8] SATA HBA <?>
> Kernel driver in use: ahci
> Kernel modules: ahci
hdparm -I and dmesg from a fresh bootup are attached.
I have not set anything using hdparm beyond standard debian install, which
notably does set 'hdparm -B 254'.
--
TimC
There's only one way to better your memory. Everytime you forget
something, poke your brain with a stick. That'll teach it. -- Ash
[-- Attachment #2: Type: TEXT/PLAIN, Size: 3262 bytes --]
/dev/sda:
ATA device, with non-removable media
Model Number: ST9160310AS
Serial Number: 5SV1ELVY
Firmware Revision: DE04
Transport: Serial
Standards:
Used: unknown (minor revision code 0x0029)
Supported: 8 7 6 5
Likely used: 8
Configuration:
Logical max current
cylinders 16383 16383
heads 16 16
sectors/track 63 63
--
CHS current addressable sectors: 16514064
LBA user addressable sectors: 268435455
LBA48 user addressable sectors: 312581808
device size with M = 1024*1024: 152627 MBytes
device size with M = 1000*1000: 160041 MBytes (160 GB)
Capabilities:
LBA, IORDY(can be disabled)
Queue depth: 32
Standby timer values: spec'd by Standard, no device specific minimum
R/W multiple sector transfer: Max = 16 Current = 16
Advanced power management level: 254
Recommended acoustic management value: 208, current value: 208
DMA: mdma0 mdma1 mdma2 udma0 udma1 udma2 udma3 udma4 udma5 *udma6
Cycle time: min=120ns recommended=120ns
PIO: pio0 pio1 pio2 pio3 pio4
Cycle time: no flow control=120ns IORDY flow control=120ns
Commands/features:
Enabled Supported:
* SMART feature set
Security Mode feature set
* Power Management feature set
* Write cache
* Look-ahead
* Host Protected Area feature set
* WRITE_BUFFER command
* READ_BUFFER command
* NOP cmd
* DOWNLOAD_MICROCODE
* Advanced Power Management feature set
SET_MAX security extension
* Automatic Acoustic Management feature set
* 48-bit Address feature set
* Device Configuration Overlay feature set
* Mandatory FLUSH_CACHE
* FLUSH_CACHE_EXT
* SMART error logging
* SMART self-test
* Media Card Pass-Through
* General Purpose Logging feature set
* WRITE_{DMA|MULTIPLE}_FUA_EXT
* WRITE_DMA_QUEUED_FUA_EXT
* 64-bit World wide name
* URG for READ_STREAM[_DMA]_EXT
* URG for WRITE_STREAM[_DMA]_EXT
Time Limited Commands (TLC) feature set
Command Completion Time Limit (CCTL)
* IDLE_IMMEDIATE with UNLOAD
* Write-Read-Verify feature set
* WRITE_UNCORRECTABLE_EXT command
* {READ,WRITE}_DMA_EXT_GPL commands
Segmented DOWNLOAD_MICROCODE
* SATA-I signaling speed (1.5Gb/s)
* SATA-II signaling speed (3.0Gb/s)
* Native Command Queueing (NCQ)
* Host-initiated interface power management
* Phy event counters
DMA Setup Auto-Activate optimization
* Device-initiated interface power management
* Software settings preservation
* SMART Command Transport (SCT) feature set
* SCT Long Sector Access (AC1)
* SCT LBA Segment Access (AC2)
* SCT Error Recovery Control (AC3)
* SCT Features Control (AC4)
* SCT Data Tables (AC5)
unknown 206[12] (vendor specific)
Security:
Master password revision code = 65534
supported
not enabled
not locked
frozen
not expired: security count
supported: enhanced erase
52min for SECURITY ERASE UNIT. 52min for ENHANCED SECURITY ERASE UNIT.
Logical Unit WWN Device Identifier: 5000c500e473341
NAA : 5
IEEE OUI : c50
Unique ID : 0e473341
Checksum: correct
[-- Attachment #3: Type: TEXT/PLAIN, Size: 42683 bytes --]
[ 0.000000] Linux version 2.6.26 (2.6.26) (root@gamow) (gcc version 4.3.2 (Debian 4.3.2-1) ) #4 SMP Mon Nov 3 22:35:21 EST 2008
[ 0.000000] Command line: root=/dev/mapper/gamow-root ro quiet
[ 0.000000] BIOS-provided physical RAM map:
[ 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 - 00000000bf6d0000 (usable)
[ 0.000000] BIOS-e820: 00000000bf6d0000 - 00000000bf6e3000 (ACPI NVS)
[ 0.000000] BIOS-e820: 00000000bf6e3000 - 00000000c0000000 (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] BIOS-e820: 0000000100000000 - 0000000140000000 (usable)
[ 0.000000] Entering add_active_range(0, 0, 159) 0 entries of 3200 used
[ 0.000000] Entering add_active_range(0, 256, 784080) 1 entries of 3200 used
[ 0.000000] Entering add_active_range(0, 1048576, 1310720) 2 entries of 3200 used
[ 0.000000] max_pfn_mapped = 1310720
[ 0.000000] x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106
[ 0.000000] init_memory_mapping
[ 0.000000] DMI present.
[ 0.000000] ACPI: RSDP 000F7660, 0024 (r2 DELL )
[ 0.000000] ACPI: XSDT BF6D66F5, 009C (r1 DELL M08 6040000 LTP 0)
[ 0.000000] ACPI: FACP BF6DEB60, 00F4 (r3 TOSCPL CRESTLNE 6040000 ALAN 1)
[ 0.000000] ACPI: DSDT BF6D7C3B, 6EB1 (r2 TOSCPL CRESTLNE 6040000 INTL 20060608)
[ 0.000000] ACPI: FACS BF6E2FC0, 0040
[ 0.000000] ACPI: APIC BF6DEC54, 0068 (r1 INTEL CRESTLNE 6040000 LOHR 5A)
[ 0.000000] ACPI: HPET BF6DECBC, 0038 (r1 INTEL CRESTLNE 6040000 LOHR 5A)
[ 0.000000] ACPI: MCFG BF6DECF4, 003C (r1 INTEL CRESTLNE 6040000 LOHR 5A)
[ 0.000000] ACPI: TCPA BF6DED30, 0032 (r1 Intel CRESTLNE 6040000 LOHR 5A)
[ 0.000000] ACPI: TMOR BF6DED62, 0026 (r1 PTLTD 6040000 PTL 3)
[ 0.000000] ACPI: OSFR BF6DED88, 0072 (r1 TOSHIB A+2nd ID 6040000 TASM 4010000)
[ 0.000000] ACPI: APIC BF6DEDFA, 0068 (r1 PTLTD APIC 6040000 LTP 0)
[ 0.000000] ACPI: BOOT BF6DEE62, 0028 (r1 PTLTD $SBFTBL$ 6040000 LTP 1)
[ 0.000000] ACPI: SLIC BF6DEE8A, 0176 (r1 DELL M08 6040000 LTP 0)
[ 0.000000] ACPI: SSDT BF6D798E, 02AD (r1 SataRe SataAhci 1000 INTL 20061109)
[ 0.000000] ACPI: SSDT BF6D78EB, 00A3 (r1 BrtRef DD01BRT 1000 INTL 20061109)
[ 0.000000] ACPI: SSDT BF6D6D1D, 025F (r1 PmRef Cpu0Tst 3000 INTL 20061109)
[ 0.000000] ACPI: SSDT BF6D6C77, 00A6 (r1 PmRef Cpu1Tst 3000 INTL 20061109)
[ 0.000000] ACPI: SSDT BF6D6791, 04E6 (r1 PmRef CpuPm 3000 INTL 20061109)
[ 0.000000] ACPI: BIOS bug: multiple APIC/MADT found, using 0
[ 0.000000] ACPI: If "acpi_apic_instance=2" works better, notify linux-acpi@vger.kernel.org
[ 0.000000] No NUMA configuration found
[ 0.000000] Faking a node at 0000000000000000-0000000140000000
[ 0.000000] Entering add_active_range(0, 0, 159) 0 entries of 3200 used
[ 0.000000] Entering add_active_range(0, 256, 784080) 1 entries of 3200 used
[ 0.000000] Entering add_active_range(0, 1048576, 1310720) 2 entries of 3200 used
[ 0.000000] Bootmem setup node 0 0000000000000000-0000000140000000
[ 0.000000] NODE_DATA [0000000000001000 - 0000000000004fff]
[ 0.000000] bootmap [000000000000e000 - 0000000000035fff] pages 28
[ 0.000000] early res: 0 [0-fff] BIOS data page
[ 0.000000] early res: 1 [6000-7fff] TRAMPOLINE
[ 0.000000] early res: 2 [200000-68c487] TEXT DATA BSS
[ 0.000000] early res: 3 [37886000-37fef006] RAMDISK
[ 0.000000] early res: 4 [9f800-fffff] BIOS reserved
[ 0.000000] early res: 5 [8000-dfff] PGTABLE
[ 0.000000] [ffffe20000000000-ffffe20003bfffff] PMD -> [ffff810001200000-ffff810003ffffff] on node 0
[ 0.000000] [ffffe20003c00000-ffffe200045fffff] PMD -> [ffff81000c000000-ffff81000c9fffff] on node 0
[ 0.000000] Zone PFN ranges:
[ 0.000000] DMA 0 -> 4096
[ 0.000000] DMA32 4096 -> 1048576
[ 0.000000] Normal 1048576 -> 1310720
[ 0.000000] Movable zone start PFN for each node
[ 0.000000] early_node_map[3] active PFN ranges
[ 0.000000] 0: 0 -> 159
[ 0.000000] 0: 256 -> 784080
[ 0.000000] 0: 1048576 -> 1310720
[ 0.000000] On node 0 totalpages: 1046127
[ 0.000000] DMA zone: 56 pages used for memmap
[ 0.000000] DMA zone: 1271 pages reserved
[ 0.000000] DMA zone: 2672 pages, LIFO batch:0
[ 0.000000] DMA32 zone: 14280 pages used for memmap
[ 0.000000] DMA32 zone: 765704 pages, LIFO batch:31
[ 0.000000] Normal zone: 3584 pages used for memmap
[ 0.000000] Normal zone: 258560 pages, LIFO batch:31
[ 0.000000] Movable zone: 0 pages used for memmap
[ 0.000000] ACPI: PM-Timer IO Port: 0x1008
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 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[0x00] high edge lint[0x1])
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1])
[ 0.000000] ACPI: IOAPIC (id[0x01] address[0xfec00000] gsi_base[0])
[ 0.000000] IOAPIC[0]: apic_id 1, version 0, 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: IRQ0 used by override.
[ 0.000000] ACPI: IRQ2 used by override.
[ 0.000000] ACPI: IRQ9 used by override.
[ 0.000000] Setting APIC routing to flat
[ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[ 0.000000] Using ACPI (MADT) for SMP configuration information
[ 0.000000] PM: Registered nosave memory: 000000000009f000 - 00000000000a0000
[ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000dc000
[ 0.000000] PM: Registered nosave memory: 00000000000dc000 - 0000000000100000
[ 0.000000] PM: Registered nosave memory: 00000000bf6d0000 - 00000000bf6e3000
[ 0.000000] PM: Registered nosave memory: 00000000bf6e3000 - 00000000c0000000
[ 0.000000] PM: Registered nosave memory: 00000000c0000000 - 00000000e0000000
[ 0.000000] PM: Registered nosave memory: 00000000e0000000 - 00000000f0000000
[ 0.000000] PM: Registered nosave memory: 00000000f0000000 - 00000000fec00000
[ 0.000000] PM: Registered nosave memory: 00000000fec00000 - 00000000fec10000
[ 0.000000] PM: Registered nosave memory: 00000000fec10000 - 00000000fed00000
[ 0.000000] PM: Registered nosave memory: 00000000fed00000 - 00000000fed14000
[ 0.000000] PM: Registered nosave memory: 00000000fed14000 - 00000000fed1a000
[ 0.000000] PM: Registered nosave memory: 00000000fed1a000 - 00000000fed1c000
[ 0.000000] PM: Registered nosave memory: 00000000fed1c000 - 00000000fed90000
[ 0.000000] PM: Registered nosave memory: 00000000fed90000 - 00000000fee00000
[ 0.000000] PM: Registered nosave memory: 00000000fee00000 - 00000000fee01000
[ 0.000000] PM: Registered nosave memory: 00000000fee01000 - 00000000ff000000
[ 0.000000] PM: Registered nosave memory: 00000000ff000000 - 0000000100000000
[ 0.000000] Allocating PCI resources starting at c2000000 (gap: c0000000:20000000)
[ 0.000000] SMP: Allowing 2 CPUs, 0 hotplug CPUs
[ 0.000000] PERCPU: Allocating 32496 bytes of per cpu data
[ 0.000000] NR_CPUS: 4, nr_cpu_ids: 2
[ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 1026936
[ 0.000000] Policy zone: Normal
[ 0.000000] Kernel command line: root=/dev/mapper/gamow-root ro quiet
[ 0.000000] Initializing CPU#0
[ 0.000000] PID hash table entries: 4096 (order: 12, 32768 bytes)
[ 0.000000] Extended CMOS year: 2000
[ 0.000000] TSC calibrated against PM_TIMER
[ 0.000000] time.c: Detected 1795.508 MHz processor.
[ 0.004000] Console: colour VGA+ 80x25
[ 0.004000] console [tty0] enabled
[ 0.004000] Checking aperture...
[ 0.004000] Calgary: detecting Calgary via BIOS EBDA area
[ 0.004000] Calgary: Unable to locate Rio Grande table in EBDA - bailing!
[ 0.004000] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
[ 0.004000] Placing software IO TLB between 0x4000000 - 0x8000000
[ 0.004000] Memory: 4048496k/5242880k available (2281k kernel code, 136012k reserved, 1385k data, 340k init)
[ 0.004000] CPA: page pool initialized 1 of 1 pages preallocated
[ 0.004000] hpet clockevent registered
[ 0.083946] Calibrating delay using timer specific routine.. 3594.81 BogoMIPS (lpj=7189621)
[ 0.083986] Security Framework initialized
[ 0.083992] SELinux: Disabled at boot.
[ 0.083996] Capability LSM initialized
[ 0.084005] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes)
[ 0.084005] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes)
[ 0.085142] Mount-cache hash table entries: 256
[ 0.085328] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 0.085331] CPU: L2 cache: 2048K
[ 0.085333] CPU 0/0 -> Node 0
[ 0.085335] CPU: Physical Processor ID: 0
[ 0.085336] CPU: Processor Core ID: 0
[ 0.085342] CPU0: Thermal monitoring handled by SMI
[ 0.085344] using mwait in idle threads.
[ 0.085364] ACPI: Core revision 20080321
[ 0.140008] CPU0: Intel(R) Core(TM)2 Duo CPU T5670 @ 1.80GHz stepping 0d
[ 0.140008] Using local APIC timer interrupts.
[ 0.144009] APIC timer calibration result 12468793
[ 0.144009] Detected 12.468 MHz APIC timer.
[ 0.144009] Booting processor 1/1 ip 6000
[ 0.152009] Initializing CPU#1
[ 0.152009] Calibrating delay using timer specific routine.. 3591.06 BogoMIPS (lpj=7182132)
[ 0.152009] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 0.152009] CPU: L2 cache: 2048K
[ 0.152009] CPU 1/1 -> Node 0
[ 0.152009] CPU: Physical Processor ID: 0
[ 0.152009] CPU: Processor Core ID: 1
[ 0.152009] CPU1: Thermal monitoring enabled (TM2)
[ 0.152009] x86 PAT enabled: cpu 1, old 0x7040600070406, new 0x7010600070106
[ 0.232014] CPU1: Intel(R) Core(TM)2 Duo CPU T5670 @ 1.80GHz stepping 0d
[ 0.232014] checking TSC synchronization [CPU#0 -> CPU#1]: passed.
[ 0.236014] Brought up 2 CPUs
[ 0.236014] Total of 2 processors activated (7185.87 BogoMIPS).
[ 0.236014] CPU0 attaching sched-domain:
[ 0.236014] domain 0: span 0-1
[ 0.236014] groups: 0 1
[ 0.236014] domain 1: span 0-1
[ 0.236014] groups: 0-1
[ 0.236014] CPU1 attaching sched-domain:
[ 0.236014] domain 0: span 0-1
[ 0.236014] groups: 1 0
[ 0.236014] domain 1: span 0-1
[ 0.236014] groups: 0-1
[ 0.236014] net_namespace: 1192 bytes
[ 0.236014] NET: Registered protocol family 16
[ 0.236014] ACPI: bus type pci registered
[ 0.236014] PCI: MCFG configuration 0: base e0000000 segment 0 buses 0 - 255
[ 0.236014] PCI: MCFG area at e0000000 reserved in E820
[ 0.248015] PCI: Using MMCONFIG at e0000000 - efffffff
[ 0.248015] PCI: Using configuration type 1 for base access
[ 0.248936] ACPI: EC: Look up EC in DSDT
[ 0.256016] ACPI: BIOS _OSI(Linux) query ignored
[ 0.256016] ACPI: DMI System Vendor: Dell Inc.
[ 0.256016] ACPI: DMI Product Name: Vostro1710
[ 0.256016] ACPI: DMI Product Version: Null
[ 0.256016] ACPI: DMI Board Name:
[ 0.256016] ACPI: DMI BIOS Vendor: Dell Inc.
[ 0.256016] ACPI: DMI BIOS Date: 09/09/2008
[ 0.256016] ACPI: Please send DMI info above to linux-acpi@vger.kernel.org
[ 0.256016] ACPI: If "acpi_osi=Linux" works better, please notify linux-acpi@vger.kernel.org
[ 0.256016] ACPI: Interpreter enabled
[ 0.256016] ACPI: (supports S0 S3 S4 S5)
[ 0.256016] ACPI: Using IOAPIC for interrupt routing
[ 0.261219] ACPI: EC: non-query interrupt received, switching to interrupt mode
[ 0.375222] ACPI: EC: GPE = 0x1c, I/O: command/status = 0x66, data = 0x62
[ 0.375222] ACPI: EC: driver started in interrupt mode
[ 0.375222] ACPI: PCI Root Bridge [PCI0] (0000:00)
[ 0.375222] pci 0000:00:1f.0: quirk: region 1000-107f claimed by ICH6 ACPI/GPIO/TCO
[ 0.375222] pci 0000:00:1f.0: quirk: region 1180-11bf claimed by ICH6 GPIO
[ 0.377926] PCI: Transparent bridge - 0000:00:1e.0
[ 0.377979] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
[ 0.379222] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP01._PRT]
[ 0.379403] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP02._PRT]
[ 0.379583] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP04._PRT]
[ 0.379761] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP05._PRT]
[ 0.379902] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PCIB._PRT]
[ 0.395903] ACPI: PCI Interrupt Link [LNKA] (IRQs 1 3 4 *5 6 7 10 12 14 15)
[ 0.395903] ACPI: PCI Interrupt Link [LNKB] (IRQs 1 3 4 5 6 7 *11 12 14 15)
[ 0.395903] ACPI: PCI Interrupt Link [LNKC] (IRQs 1 3 4 5 6 7 *10 12 14 15)
[ 0.395903] ACPI: PCI Interrupt Link [LNKD] (IRQs 1 3 4 5 6 7 *11 12 14 15)
[ 0.395903] ACPI: PCI Interrupt Link [LNKE] (IRQs 1 3 4 5 6 7 10 12 14 15) *0, disabled.
[ 0.395903] ACPI: PCI Interrupt Link [LNKF] (IRQs 1 3 4 5 6 7 *11 12 14 15)
[ 0.395903] ACPI: PCI Interrupt Link [LNKG] (IRQs 1 3 4 5 6 7 *10 12 14 15)
[ 0.395903] ACPI: PCI Interrupt Link [LNKH] (IRQs 1 3 4 5 6 7 11 12 14 15) *10
[ 0.395903] Linux Plug and Play Support v0.97 (c) Adam Belay
[ 0.395903] pnp: PnP ACPI init
[ 0.395903] ACPI: bus type pnp registered
[ 0.395903] pnp 00:00: parse allocated resources
[ 0.395903] pnp 00:00: add io 0xcf8-0xcff flags 0x1
[ 0.395903] pnp 00:00: Plug and Play ACPI device, IDs PNP0a08 PNP0a03 (active)
[ 0.395903] pnp 00:01: parse allocated resources
[ 0.395903] pnp 00:01: add mem 0xfed1c000-0xfed1ffff flags 0x1
[ 0.395903] pnp 00:01: add mem 0xfed14000-0xfed17fff flags 0x1
[ 0.395903] pnp 00:01: add mem 0xfed18000-0xfed18fff flags 0x1
[ 0.395903] pnp 00:01: add mem 0xfed19000-0xfed19fff flags 0x1
[ 0.395903] pnp 00:01: add mem 0xe0000000-0xefffffff flags 0x1
[ 0.395903] pnp 00:01: add mem 0xfed20000-0xfed3ffff flags 0x1
[ 0.395903] pnp 00:01: add mem 0xfed40000-0xfed44fff flags 0x1
[ 0.395903] pnp 00:01: add mem 0xfed45000-0xfed8ffff flags 0x1
[ 0.395903] pnp 00:01: PNP0c02: calling quirk_system_pci_resources+0x0/0x15a
[ 0.395903] pnp 00:01: Plug and Play ACPI device, IDs PNP0c02 (active)
[ 0.396439] pnp 00:02: parse allocated resources
[ 0.396446] pnp 00:02: add io 0x0-0x1f flags 0x1
[ 0.396448] pnp 00:02: add io 0x81-0x91 flags 0x1
[ 0.396450] pnp 00:02: add io 0x93-0x9f flags 0x1
[ 0.396452] pnp 00:02: add io 0xc0-0xdf flags 0x1
[ 0.396455] pnp 00:02: add dma 4 flags 0x1
[ 0.399903] pnp 00:02: Plug and Play ACPI device, IDs PNP0200 (active)
[ 0.399903] pnp 00:03: parse allocated resources
[ 0.399903] pnp 00:03: add mem 0xff000000-0xffffffff flags 0x0
[ 0.399903] pnp 00:03: Plug and Play ACPI device, IDs INT0800 (active)
[ 0.399903] pnp 00:04: parse allocated resources
[ 0.399903] pnp 00:04: add mem 0xfed00000-0xfed003ff flags 0x0
[ 0.399903] pnp 00:04: PNP0c01: calling quirk_system_pci_resources+0x0/0x15a
[ 0.399903] pnp 00:04: Plug and Play ACPI device, IDs PNP0103 PNP0c01 (active)
[ 0.399903] pnp 00:05: parse allocated resources
[ 0.399903] pnp 00:05: add io 0xf0-0xf0 flags 0x1
[ 0.399903] pnp 00:05: add irq 13 flags 0x1
[ 0.399903] pnp 00:05: Plug and Play ACPI device, IDs PNP0c04 (active)
[ 0.399903] pnp 00:06: parse allocated resources
[ 0.399903] pnp 00:06: add io 0x2e-0x2f flags 0x1
[ 0.399903] pnp 00:06: add io 0x61-0x61 flags 0x1
[ 0.399903] pnp 00:06: add io 0x63-0x63 flags 0x1
[ 0.399903] pnp 00:06: add io 0x65-0x65 flags 0x1
[ 0.399903] pnp 00:06: add io 0x67-0x67 flags 0x1
[ 0.399903] pnp 00:06: add io 0x80-0x80 flags 0x1
[ 0.399903] pnp 00:06: add io 0x92-0x92 flags 0x1
[ 0.399903] pnp 00:06: add io 0xb2-0xb3 flags 0x1
[ 0.399903] pnp 00:06: add io 0x680-0x69f flags 0x1
[ 0.399903] pnp 00:06: add io 0x800-0x80f flags 0x1
[ 0.399903] pnp 00:06: add io 0x1000-0x107f flags 0x1
[ 0.399903] pnp 00:06: add io 0x1180-0x11bf flags 0x1
[ 0.399903] pnp 00:06: add io 0xfe00-0xfe00 flags 0x1
[ 0.399903] pnp 00:06: add io 0xff00-0xff7f flags 0x1
[ 0.399903] pnp 00:06: PNP0c02: calling quirk_system_pci_resources+0x0/0x15a
[ 0.399903] pnp 00:06: Plug and Play ACPI device, IDs PNP0c02 (active)
[ 0.399903] pnp 00:07: parse allocated resources
[ 0.399903] pnp 00:07: add io 0x70-0x77 flags 0x1
[ 0.399903] pnp 00:07: add irq 8 flags 0x1
[ 0.399903] pnp 00:07: Plug and Play ACPI device, IDs PNP0b00 (active)
[ 0.428098] pnp 00:08: parse allocated resources
[ 0.428104] pnp 00:08: add io 0x60-0x60 flags 0x1
[ 0.428107] pnp 00:08: add io 0x64-0x64 flags 0x1
[ 0.428112] pnp 00:08: add irq 1 flags 0x1
[ 0.431905] pnp 00:08: Plug and Play ACPI device, IDs PNP0303 (active)
[ 0.431905] pnp 00:09: parse allocated resources
[ 0.431905] pnp 00:09: add irq 12 flags 0x1
[ 0.431905] pnp 00:09: Plug and Play ACPI device, IDs SYN0705 SYN0700 SYN0002 PNP0f13 (active)
[ 0.431905] pnp: PnP ACPI: found 10 devices
[ 0.431905] ACPI: ACPI bus type pnp unregistered
[ 0.431905] usbcore: registered new interface driver usbfs
[ 0.431905] usbcore: registered new interface driver hub
[ 0.431905] usbcore: registered new device driver usb
[ 0.431905] PCI: Using ACPI for IRQ routing
[ 0.442580] NET: Registered protocol family 8
[ 0.442583] NET: Registered protocol family 20
[ 0.443949] PCI-GART: No AMD northbridge found.
[ 0.443949] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
[ 0.443949] hpet0: 3 64-bit timers, 14318180 Hz
[ 0.443949] ACPI: RTC can wake from S4
[ 0.454764] pnp: the driver 'system' has been registered
[ 0.454775] system 00:01: iomem range 0xfed1c000-0xfed1ffff could not be reserved
[ 0.454778] system 00:01: iomem range 0xfed14000-0xfed17fff could not be reserved
[ 0.454782] system 00:01: iomem range 0xfed18000-0xfed18fff could not be reserved
[ 0.454785] system 00:01: iomem range 0xfed19000-0xfed19fff could not be reserved
[ 0.454788] system 00:01: iomem range 0xe0000000-0xefffffff could not be reserved
[ 0.454791] system 00:01: iomem range 0xfed20000-0xfed3ffff could not be reserved
[ 0.454794] system 00:01: iomem range 0xfed40000-0xfed44fff could not be reserved
[ 0.454797] system 00:01: iomem range 0xfed45000-0xfed8ffff could not be reserved
[ 0.454799] system 00:01: driver attached
[ 0.454808] system 00:04: iomem range 0xfed00000-0xfed003ff could not be reserved
[ 0.454810] system 00:04: driver attached
[ 0.454816] system 00:06: ioport range 0x680-0x69f has been reserved
[ 0.454819] system 00:06: ioport range 0x800-0x80f has been reserved
[ 0.454822] system 00:06: ioport range 0x1000-0x107f has been reserved
[ 0.454825] system 00:06: ioport range 0x1180-0x11bf has been reserved
[ 0.454828] system 00:06: ioport range 0xfe00-0xfe00 has been reserved
[ 0.454831] system 00:06: ioport range 0xff00-0xff7f has been reserved
[ 0.454833] system 00:06: driver attached
[ 0.455950] PCI: Bridge: 0000:00:1c.0
[ 0.455950] IO window: 2000-2fff
[ 0.455950] MEM window: 0xc4000000-0xc7ffffff
[ 0.455950] PREFETCH window: 0x00000000cc000000-0x00000000cdffffff
[ 0.455950] PCI: Bridge: 0000:00:1c.1
[ 0.455950] IO window: 3000-3fff
[ 0.455950] MEM window: 0xf0000000-0xf3ffffff
[ 0.455950] PREFETCH window: 0x00000000fa000000-0x00000000fbffffff
[ 0.455950] PCI: Bridge: 0000:00:1c.3
[ 0.455950] IO window: 4000-4fff
[ 0.455950] MEM window: 0xf4000000-0xf7ffffff
[ 0.455950] PREFETCH window: 0x00000000fc000000-0x00000000fdffffff
[ 0.455950] PCI: Bridge: 0000:00:1c.4
[ 0.455950] IO window: 5000-5fff
[ 0.455950] MEM window: 0xc2000000-0xc20fffff
[ 0.455950] PREFETCH window: 0x00000000f8600000-0x00000000f86fffff
[ 0.455950] PCI: Bridge: 0000:00:1e.0
[ 0.455950] IO window: disabled.
[ 0.455950] MEM window: 0xf8200000-0xf82fffff
[ 0.455950] PREFETCH window: disabled.
[ 0.455950] ACPI: PCI Interrupt 0000:00:1c.0[A] -> GSI 17 (level, low) -> IRQ 17
[ 0.455950] PCI: Setting latency timer of device 0000:00:1c.0 to 64
[ 0.455950] ACPI: PCI Interrupt 0000:00:1c.1[B] -> GSI 16 (level, low) -> IRQ 16
[ 0.455950] PCI: Setting latency timer of device 0000:00:1c.1 to 64
[ 0.455950] ACPI: PCI Interrupt 0000:00:1c.3[D] -> GSI 19 (level, low) -> IRQ 19
[ 0.455950] PCI: Setting latency timer of device 0000:00:1c.3 to 64
[ 0.455950] ACPI: PCI Interrupt 0000:00:1c.4[A] -> GSI 17 (level, low) -> IRQ 17
[ 0.455950] PCI: Setting latency timer of device 0000:00:1c.4 to 64
[ 0.455950] PCI: Setting latency timer of device 0000:00:1e.0 to 64
[ 0.455950] NET: Registered protocol family 2
[ 0.491246] IP route cache hash table entries: 131072 (order: 8, 1048576 bytes)
[ 0.493279] TCP established hash table entries: 524288 (order: 11, 8388608 bytes)
[ 0.497290] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
[ 0.497290] TCP: Hash tables configured (established 524288 bind 65536)
[ 0.497290] TCP reno registered
[ 0.506711] NET: Registered protocol family 1
[ 0.506826] checking if image is initramfs...<7>Switched to high resolution mode on CPU 1
[ 0.509283] Switched to high resolution mode on CPU 0
[ 0.833562] it is
[ 1.177563] Freeing initrd memory: 7588k freed
[ 1.181564] Simple Boot Flag at 0x36 set to 0x1
[ 1.184925] audit: initializing netlink socket (disabled)
[ 1.184925] type=2000 audit(1225794110.173:1): initialized
[ 1.184925] VFS: Disk quotas dquot_6.5.1
[ 1.184960] Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[ 1.184995] msgmni has been set to 7922
[ 1.185053] io scheduler noop registered
[ 1.185055] io scheduler anticipatory registered
[ 1.185057] io scheduler deadline registered
[ 1.185070] io scheduler cfq registered (default)
[ 1.185083] pci 0000:00:02.0: Boot video device
[ 1.187347] PCI: Setting latency timer of device 0000:00:1c.0 to 64
[ 1.187397] assign_interrupt_mode Found MSI capability
[ 1.187450] Allocate Port Service[0000:00:1c.0:pcie00]
[ 1.188927] Allocate Port Service[0000:00:1c.0:pcie02]
[ 1.188927] Allocate Port Service[0000:00:1c.0:pcie03]
[ 1.188927] PCI: Setting latency timer of device 0000:00:1c.1 to 64
[ 1.188927] assign_interrupt_mode Found MSI capability
[ 1.188927] Allocate Port Service[0000:00:1c.1:pcie00]
[ 1.188927] Allocate Port Service[0000:00:1c.1:pcie02]
[ 1.188927] Allocate Port Service[0000:00:1c.1:pcie03]
[ 1.188927] PCI: Setting latency timer of device 0000:00:1c.3 to 64
[ 1.188927] assign_interrupt_mode Found MSI capability
[ 1.188927] Allocate Port Service[0000:00:1c.3:pcie00]
[ 1.188927] Allocate Port Service[0000:00:1c.3:pcie02]
[ 1.188927] Allocate Port Service[0000:00:1c.3:pcie03]
[ 1.188927] PCI: Setting latency timer of device 0000:00:1c.4 to 64
[ 1.188927] assign_interrupt_mode Found MSI capability
[ 1.188927] Allocate Port Service[0000:00:1c.4:pcie00]
[ 1.188927] Allocate Port Service[0000:00:1c.4:pcie02]
[ 1.188927] Allocate Port Service[0000:00:1c.4:pcie03]
[ 1.189629] hpet_resources: 0xfed00000 is busy
[ 1.189689] Linux agpgart interface v0.103
[ 1.189692] Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing enabled
[ 1.189992] pnp: the driver 'serial' has been registered
[ 1.191624] brd: module loaded
[ 1.191710] pnp: the driver 'i8042 kbd' has been registered
[ 1.191725] i8042 kbd 00:08: driver attached
[ 1.191760] pnp: the driver 'i8042 aux' has been registered
[ 1.191778] i8042 aux 00:09: driver attached
[ 1.191812] PNP: PS/2 Controller [PNP0303:PS2K,PNP0f13:PS2M] at 0x60,0x64 irq 1,12
[ 1.233364] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 1.233370] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 1.236983] mice: PS/2 mouse device common for all mice
[ 1.236983] cpuidle: using governor ladder
[ 1.236983] cpuidle: using governor menu
[ 1.239129] TCP bic registered
[ 1.239129] NET: Registered protocol family 17
[ 1.239129] registered taskstats version 1
[ 1.239129] Freeing unused kernel memory: 340k freed
[ 1.239129] Write protecting the kernel read-only data: 3376k
[ 1.274139] input: AT Translated Set 2 keyboard as /class/input/input0
[ 1.323134] ACPI: SSDT BF6D75EB, 0238 (r1 PmRef Cpu0Ist 3000 INTL 20061109)
[ 1.323134] ACPI: SSDT BF6D6F7C, 05EA (r1 PmRef Cpu0Cst 3001 INTL 20061109)
[ 1.327133] Monitor-Mwait will be used to enter C-1 state
[ 1.327133] Monitor-Mwait will be used to enter C-2 state
[ 1.327133] Monitor-Mwait will be used to enter C-3 state
[ 1.327133] ACPI: CPU0 (power states: C1[C1] C2[C2] C3[C3])
[ 1.331132] ACPI: ACPI0007:00 is registered as cooling_device0
[ 1.331132] ACPI: Processor [CPU0] (supports 8 throttling states)
[ 1.331132] ACPI: SSDT BF6D7823, 00C8 (r1 PmRef Cpu1Ist 3000 INTL 20061109)
[ 1.331132] ACPI: SSDT BF6D7566, 0085 (r1 PmRef Cpu1Cst 3000 INTL 20061109)
[ 1.334145] ACPI: CPU1 (power states: C1[C1] C2[C2] C3[C3])
[ 1.334145] ACPI: ACPI0007:01 is registered as cooling_device1
[ 1.334145] ACPI: Processor [CPU1] (supports 8 throttling states)
[ 1.334145] Marking TSC unstable due to TSC halts in idle
[ 1.598158] USB Universal Host Controller Interface driver v3.0
[ 1.598201] ACPI: PCI Interrupt 0000:00:1a.0[A] -> GSI 16 (level, low) -> IRQ 16
[ 1.598212] PCI: Setting latency timer of device 0000:00:1a.0 to 64
[ 1.598216] uhci_hcd 0000:00:1a.0: UHCI Host Controller
[ 1.598372] uhci_hcd 0000:00:1a.0: new USB bus registered, assigned bus number 1
[ 1.598412] uhci_hcd 0000:00:1a.0: irq 16, io base 0x00001820
[ 1.598509] usb usb1: configuration #1 chosen from 1 choice
[ 1.598539] hub 1-0:1.0: USB hub found
[ 1.598547] hub 1-0:1.0: 2 ports detected
[ 1.669817] No dock devices found.
[ 1.674481] SCSI subsystem initialized
[ 1.705819] ACPI: PCI Interrupt 0000:00:1a.1[B] -> GSI 21 (level, low) -> IRQ 21
[ 1.705819] PCI: Setting latency timer of device 0000:00:1a.1 to 64
[ 1.705819] uhci_hcd 0000:00:1a.1: UHCI Host Controller
[ 1.705819] uhci_hcd 0000:00:1a.1: new USB bus registered, assigned bus number 2
[ 1.705819] uhci_hcd 0000:00:1a.1: irq 21, io base 0x00001840
[ 1.705819] usb usb2: configuration #1 chosen from 1 choice
[ 1.705819] hub 2-0:1.0: USB hub found
[ 1.705819] hub 2-0:1.0: 2 ports detected
[ 1.761054] libata version 3.00 loaded.
[ 1.761054] sdhci: Secure Digital Host Controller Interface driver
[ 1.761054] sdhci: Copyright(c) Pierre Ossman
[ 1.808072] ACPI: PCI Interrupt 0000:00:1a.7[C] -> GSI 18 (level, low) -> IRQ 18
[ 1.808072] PCI: Setting latency timer of device 0000:00:1a.7 to 64
[ 1.808072] ehci_hcd 0000:00:1a.7: EHCI Host Controller
[ 1.808072] ehci_hcd 0000:00:1a.7: new USB bus registered, assigned bus number 3
[ 1.812219] ehci_hcd 0000:00:1a.7: debug port 1
[ 1.812219] PCI: cache line size of 32 is not supported by device 0000:00:1a.7
[ 1.812219] ehci_hcd 0000:00:1a.7: irq 18, io mem 0xf8504800
[ 1.827827] ehci_hcd 0000:00:1a.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
[ 1.827918] usb usb3: configuration #1 chosen from 1 choice
[ 1.827954] hub 3-0:1.0: USB hub found
[ 1.827962] hub 3-0:1.0: 4 ports detected
[ 1.931807] ACPI: PCI Interrupt 0000:00:1d.0[A] -> GSI 23 (level, low) -> IRQ 23
[ 1.931807] PCI: Setting latency timer of device 0000:00:1d.0 to 64
[ 1.931807] uhci_hcd 0000:00:1d.0: UHCI Host Controller
[ 1.931807] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 4
[ 1.931807] uhci_hcd 0000:00:1d.0: irq 23, io base 0x00001860
[ 1.931807] usb usb4: configuration #1 chosen from 1 choice
[ 1.931807] hub 4-0:1.0: USB hub found
[ 1.931807] hub 4-0:1.0: 2 ports detected
[ 2.026360] Clocksource tsc unstable (delta = -235519534 ns)
[ 2.037372] ACPI: PCI Interrupt 0000:00:1d.1[B] -> GSI 19 (level, low) -> IRQ 19
[ 2.037372] PCI: Setting latency timer of device 0000:00:1d.1 to 64
[ 2.037372] uhci_hcd 0000:00:1d.1: UHCI Host Controller
[ 2.037372] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 5
[ 2.037372] uhci_hcd 0000:00:1d.1: irq 19, io base 0x00001880
[ 2.037372] usb usb5: configuration #1 chosen from 1 choice
[ 2.037372] hub 5-0:1.0: USB hub found
[ 2.037372] hub 5-0:1.0: 2 ports detected
[ 2.141131] ACPI: PCI Interrupt 0000:00:1d.2[C] -> GSI 18 (level, low) -> IRQ 18
[ 2.141131] PCI: Setting latency timer of device 0000:00:1d.2 to 64
[ 2.141131] uhci_hcd 0000:00:1d.2: UHCI Host Controller
[ 2.141131] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 6
[ 2.141131] uhci_hcd 0000:00:1d.2: irq 18, io base 0x000018a0
[ 2.141131] usb usb6: configuration #1 chosen from 1 choice
[ 2.141131] hub 6-0:1.0: USB hub found
[ 2.141131] hub 6-0:1.0: 2 ports detected
[ 2.243959] ACPI: PCI Interrupt 0000:00:1d.7[A] -> GSI 23 (level, low) -> IRQ 23
[ 2.243959] PCI: Setting latency timer of device 0000:00:1d.7 to 64
[ 2.243959] ehci_hcd 0000:00:1d.7: EHCI Host Controller
[ 2.243959] ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 7
[ 2.247781] ehci_hcd 0000:00:1d.7: debug port 1
[ 2.247781] PCI: cache line size of 32 is not supported by device 0000:00:1d.7
[ 2.247781] ehci_hcd 0000:00:1d.7: irq 23, io mem 0xf8504c00
[ 2.263903] ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
[ 2.263985] usb usb7: configuration #1 chosen from 1 choice
[ 2.264024] hub 7-0:1.0: USB hub found
[ 2.264031] hub 7-0:1.0: 6 ports detected
[ 2.370903] r8169 Gigabit Ethernet driver 2.2LK-NAPI loaded
[ 2.370903] ACPI: PCI Interrupt 0000:07:00.0[A] -> GSI 16 (level, low) -> IRQ 16
[ 2.370903] PCI: Setting latency timer of device 0000:07:00.0 to 64
[ 2.370903] eth0: RTL8168c/8111c at 0xffffc2000065c000, 00:21:70:a7:fd:30, XID 3c4000c0 IRQ 379
[ 2.372530] ahci 0000:00:1f.2: version 3.0
[ 2.372557] ACPI: PCI Interrupt 0000:00:1f.2[B] -> GSI 18 (level, low) -> IRQ 18
[ 2.854088] usb 7-6: new high speed USB device using ehci_hcd and address 3
[ 3.027530] usb 7-6: configuration #1 chosen from 1 choice
[ 3.270823] usb 4-2: new full speed USB device using uhci_hcd and address 2
[ 3.378371] ahci 0000:00:1f.2: AHCI 0001.0100 32 slots 3 ports 3 Gbps 0x7 impl SATA mode
[ 3.378377] ahci 0000:00:1f.2: flags: 64bit ncq sntf pm led clo pio slum part
[ 3.378384] PCI: Setting latency timer of device 0000:00:1f.2 to 64
[ 3.380433] scsi0 : ahci
[ 3.380433] scsi1 : ahci
[ 3.380433] scsi2 : ahci
[ 3.380433] ata1: SATA max UDMA/133 abar m2048@0xf8504000 port 0xf8504100 irq 378
[ 3.380433] ata2: SATA max UDMA/133 abar m2048@0xf8504000 port 0xf8504180 irq 378
[ 3.380433] ata3: SATA max UDMA/133 abar m2048@0xf8504000 port 0xf8504200 irq 378
[ 3.453005] usb 4-2: configuration #1 chosen from 1 choice
[ 3.700617] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[ 3.702260] ata1.00: _GTF unexpected object type 0x1
[ 3.731941] ata1.00: ATA-8: ST9160310AS, DE04, max UDMA/133
[ 3.731941] ata1.00: 312581808 sectors, multi 16: LBA48 NCQ (depth 31/32)
[ 3.747312] ata1.00: _GTF unexpected object type 0x1
[ 3.776914] ata1.00: configured for UDMA/133
[ 4.096487] ata2: SATA link down (SStatus 0 SControl 300)
[ 4.418041] ata3: SATA link down (SStatus 0 SControl 300)
[ 4.418013] scsi 0:0:0:0: Direct-Access ATA ST9160310AS DE04 PQ: 0 ANSI: 5
[ 4.418013] sdhci: SDHCI controller found at 0000:08:05.2 [1217:7120] (rev 2)
[ 4.418013] ACPI: PCI Interrupt 0000:08:05.2[A] -> GSI 22 (level, low) -> IRQ 22
[ 4.418013] mmc0: Unknown controller version (2). You may experience problems.
[ 4.418013] mmc0: SDHCI at 0xf8202800 irq 22 DMA
[ 4.428641] Uniform Multi-Platform E-IDE driver
[ 4.428646] ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx
[ 4.428785] ICH8M: IDE controller (0x8086:0x2850 rev 0x03) at PCI slot 0000:00:1f.1
[ 4.428785] ACPI: PCI Interrupt 0000:00:1f.1[A] -> GSI 18 (level, low) -> IRQ 18
[ 4.428785] ICH8M: not 100% native mode: will probe irqs later
[ 4.428785] ide0: BM-DMA at 0x1810-0x1817
[ 4.428785] ide1: BM-DMA at 0x1818-0x181f
[ 4.428785] Probing IDE interface ide0...
[ 4.453097] Driver 'sd' needs updating - please use bus_type methods
[ 4.453097] sd 0:0:0:0: [sda] 312581808 512-byte hardware sectors (160042 MB)
[ 4.453097] sd 0:0:0:0: [sda] Write Protect is off
[ 4.453097] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 4.453097] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 4.453097] sd 0:0:0:0: [sda] 312581808 512-byte hardware sectors (160042 MB)
[ 4.453097] sd 0:0:0:0: [sda] Write Protect is off
[ 4.453097] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 4.453097] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 4.453097] sda: sda1 sda2 sda3
[ 4.463890] sd 0:0:0:0: [sda] Attached SCSI disk
[ 5.164297] hda: Optiarc DVD+/-RW AD-7640A, ATAPI CD/DVD-ROM drive
[ 5.836118] hda: host max PIO4 wanted PIO255(auto-tune) selected PIO4
[ 5.836498] hda: UDMA/33 mode selected
[ 5.840923] Probing IDE interface ide1...
[ 6.405004] ide0 at 0x1f0-0x1f7,0x3f6 on irq 14
[ 6.407726] ide1 at 0x170-0x177,0x376 on irq 15
[ 6.427362] hda: ATAPI 24X DVD-ROM DVD-R-RAM CD-R/RW drive, 2048kB Cache
[ 6.427362] Uniform CD-ROM driver Revision: 3.20
[ 6.514257] device-mapper: ioctl: 4.13.0-ioctl (2007-10-18) initialised: dm-devel@redhat.com
[ 6.597852] PM: Starting manual resume from disk
[ 6.710189] kjournald starting. Commit interval 5 seconds
[ 6.710203] EXT3-fs: mounted filesystem with writeback data mode.
[ 8.559252] udevd version 125 started
[ 8.991246] dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.2)
[ 9.169086] input: Power Button (FF) as /class/input/input1
[ 9.219004] ACPI: Power Button (FF) [PWRF]
[ 9.219076] input: Lid Switch as /class/input/input2
[ 9.252261] ACPI: Lid Switch [LID0]
[ 9.252321] input: Power Button (CM) as /class/input/input3
[ 9.256122] agpgart: Detected an Intel 965GM Chipset.
[ 9.256692] agpgart: Detected 7676K stolen memory.
[ 9.269209] agpgart: AGP aperture is 256M @ 0xd0000000
[ 9.318999] ACPI: Power Button (CM) [PWRB]
[ 9.321075] input: Sleep Button (CM) as /class/input/input4
[ 9.384095] ACPI: Sleep Button (CM) [SLPB]
[ 9.385011] ACPI: WMI: Mapper loaded
[ 9.391603] ACPI: AC Adapter [ACAD] (on-line)
[ 9.531606] ACPI: device:05 is registered as cooling_device2
[ 9.531606] input: Video Bus as /class/input/input5
[ 9.580294] ACPI: Video Device [VGA] (multi-head: yes rom: no post: no)
[ 9.592061] ACPI: device:0a is registered as cooling_device3
[ 9.592419] input: Video Bus as /class/input/input6
[ 9.612220] ieee80211_crypt: registered algorithm 'NULL'
[ 9.649350] ACPI: Video Device [GFX0] (multi-head: yes rom: no post: no)
[ 10.002911] ACPI: Battery Slot [BAT1] (battery present)
[ 10.069690] wl: module license 'unspecified' taints kernel.
[ 10.074913] ACPI: PCI Interrupt 0000:06:00.0[A] -> GSI 19 (level, low) -> IRQ 19
[ 10.074913] PCI: Setting latency timer of device 0000:06:00.0 to 64
[ 10.145119] iTCO_wdt: Intel TCO WatchDog Timer Driver v1.03 (30-Apr-2008)
[ 10.145119] iTCO_wdt: Found a ICH8M TCO device (Version=2, TCOBASE=0x1060)
[ 10.145119] iTCO_wdt: initialized. heartbeat=30 sec (nowayout=0)
[ 10.180255] pnp: the driver 'rtc_cmos' has been registered
[ 10.180317] rtc_cmos 00:07: rtc core: registered rtc_cmos as rtc0
[ 10.180343] rtc0: alarms up to one month, y3k
[ 10.180345] rtc_cmos 00:07: driver attached
[ 10.194514] ieee80211_crypt: registered algorithm 'TKIP'
[ 10.194514] wlan0: Broadcom BCM4315 802.11 Wireless Controller 5.10.27.6
[ 10.266551] Linux video capture interface: v2.00
[ 10.286536] input: PC Speaker as /class/input/input7
[ 10.375098] ACPI: PCI Interrupt 0000:00:1f.3[C] -> GSI 18 (level, low) -> IRQ 18
[ 10.397199] uvcvideo: Found UVC 1.00 device Integrated Webcam (0c45:63e0)
[ 10.415369] input: Integrated Webcam as /class/input/input8
[ 10.448428] usbcore: registered new interface driver uvcvideo
[ 10.448433] USB Video Class driver (v0.1.0)
[ 10.457296] ACPI: PCI Interrupt 0000:00:1b.0[A] -> GSI 22 (level, low) -> IRQ 22
[ 10.457296] PCI: Setting latency timer of device 0000:00:1b.0 to 64
[ 10.487781] hda_codec: Unknown model for ALC268, trying auto-probe from BIOS...
[ 11.063235] input: PS/2 Mouse as /class/input/input9
[ 11.142266] input: AlpsPS/2 ALPS GlidePoint as /class/input/input10
[ 12.778033] EXT3 FS on dm-0, internal journal
[ 13.325076] loop: module loaded
[ 13.680289] Broadcom 43xx driver loaded [ Features: PLR, Firmware-ID: FW13 ]
[ 13.717388] Ethernet Channel Bonding Driver: v3.2.5 (March 21, 2008)
[ 13.717388] bonding: MII link monitoring set to 1500 ms
[ 15.101058] fuse init (API version 7.9)
[ 15.226078] kjournald starting. Commit interval 5 seconds
[ 15.226876] EXT3 FS on dm-1, internal journal
[ 15.226876] EXT3-fs: mounted filesystem with writeback data mode.
[ 15.284065] kjournald starting. Commit interval 5 seconds
[ 15.292828] EXT3 FS on sda2, internal journal
[ 15.292828] EXT3-fs: mounted filesystem with ordered data mode.
[ 15.390085] Adding 6291448k swap on /dev/mapper/gamow-swap. Priority:-1 extents:1 across:6291448k
[ 17.094378] bonding: bond0: Warning: failed to get speed and duplex from wlan0, assumed to be 100Mb/sec and Full.
[ 17.094378] bonding: bond0: enslaving wlan0 as a backup interface with an up link.
[ 17.989324] NET: Registered protocol family 10
[ 17.989685] lo: Disabled Privacy Extensions
[ 17.992056] ADDRCONF(NETDEV_UP): bond0: link is not ready
[ 18.209717] r8169: eth0: link up
[ 18.210290] r8169: eth0: link up
[ 18.268847] r8169: eth0: link up
[ 18.269506] bonding: bond0: enslaving eth0 as a backup interface with an up link.
[ 21.521015] bonding: bond0: link status definitely up for interface wlan0.
[ 21.521021] bonding: bond0: link status definitely up for interface eth0.
[ 21.521033] bonding: bond0: making interface eth0 the new active one.
[ 21.521058] bonding: bond0: first active interface up!
[ 21.521751] ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready
[ 22.040786] RPC: Registered udp transport module.
[ 22.040786] RPC: Registered tcp transport module.
[ 22.282259] Installing knfsd (copyright (C) 1996 okir@monad.swb.de).
[ 24.171512] nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
[ 24.284604] ip_tables: (C) 2000-2006 Netfilter Core Team
[ 27.609165] pnp: the driver 'parport_pc' has been registered
[ 27.614107] lp: driver loaded but no devices found
[ 27.670753] ppdev: user-space parallel port driver
[ 32.189872] bond0: no IPv6 routers present
[ 57.283130] NFSD: Using /var/lib/nfs/v4recovery as the NFSv4 state recovery directory
[ 57.283149] NFSD: unable to find recovery directory /var/lib/nfs/v4recovery
[ 57.283152] NFSD: starting 90-second grace period
[ 62.651315] warning: `ntpd' uses 32-bit capabilities (legacy support in use)
[ 68.040853] CPU0 attaching NULL sched-domain.
[ 68.040853] CPU1 attaching NULL sched-domain.
[ 68.067474] CPU0 attaching sched-domain:
[ 68.067588] domain 0: span 0-1
[ 68.067596] groups: 0 1
[ 68.067605] domain 1: span 0-1
[ 68.067609] groups: 0-1
[ 68.067618] CPU1 attaching sched-domain:
[ 68.067758] domain 0: span 0-1
[ 68.067768] groups: 1 0
[ 68.067775] domain 1: span 0-1
[ 68.067779] groups: 0-1
[ 71.739745] ACPI: EC: missing confirmations, switch off interrupt mode.
[ 72.259596] ACPI Exception (evregion-0420): AE_TIME, Returned by Handler for [EmbeddedControl] [20080321]
[ 72.259612] ACPI Error (psparse-0530): Method parse/execution failed [\_SB_.PCI0.GFX0.DD03._BQC] (Node ffff81013fa6ea90), AE_TIME
[ 74.111540] [drm] Initialized drm 1.1.0 20060810
[ 74.163638] ACPI: PCI Interrupt 0000:00:02.0[A] -> GSI 16 (level, low) -> IRQ 16
[ 74.163649] PCI: Setting latency timer of device 0000:00:02.0 to 64
[ 74.163961] [drm] Initialized i915 1.6.0 20060119 on minor 0
[ 75.189420] mtrr: type mismatch for d0000000,10000000 old: write-back new: write-combining
[ 1054.475893] r8169: eth0: link down
[ 1054.971140] bonding: bond0: link status down for idle interface eth0, disabling it in 1500 ms.
[ 1056.472248] bonding: bond0: link status definitely down for interface eth0, disabling it
[ 1056.472272] bonding: bond0: making interface wlan0 the new active one.
[ 1060.210232] r8169: eth0: link up
[ 1061.696625] bonding: bond0: link status up for interface eth0, enabling it in 3000 ms.
[ 1064.696483] bonding: bond0: link status definitely up for interface eth0.
[ 1064.696507] bonding: bond0: making interface eth0 the new active one.
[ 1067.767643] bond0: no IPv6 routers present
[ 1114.153142] CE: hpet increasing min_delta_ns to 15000 nsec
^ permalink raw reply [flat|nested] 5+ messages in thread
* Re: sata error on ICH8M
2008-11-04 11:26 sata error on ICH8M Tim Connors
2008-11-04 11:52 ` sata error on ICH8M (Dell Vostro 1710 laptop) Tim Connors
@ 2008-11-11 14:01 ` Tejun Heo
2008-11-11 14:32 ` Mark Lord
1 sibling, 1 reply; 5+ messages in thread
From: Tejun Heo @ 2008-11-11 14:01 UTC (permalink / raw)
To: Tim Connors; +Cc: Linux Kernel Mailing List, linux-ide
Hello,
Tim Connors wrote:
> I'm running a debian 2.6.26-9 kernel (sid) on a new laptop with:
Hmmm...
> 00:1f.2 SATA controller: Intel Corporation 82801HBM/HEM (ICH8M/ICH8M-E) SATA AHCI Controller (rev 03) (prog-if 01 [AHCI 1.0])
> Subsystem: Dell Device 0275
> Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx+
> Status: Cap+ 66MHz+ UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
> Latency: 0
> Interrupt: pin B routed to IRQ 378
> Region 0: I/O ports at 1c00 [size=8]
> Region 1: I/O ports at 18d4 [size=4]
> Region 2: I/O ports at 18d8 [size=8]
> Region 3: I/O ports at 18d0 [size=4]
> Region 4: I/O ports at 18e0 [size=32]
> Region 5: Memory at f8504000 (32-bit, non-prefetchable) [size=2K]
> Capabilities: [80] Message Signalled Interrupts: Mask- 64bit- Queue=0/2 Enable+
> Address: fee0300c Data: 41a1
> Capabilities: [70] Power Management version 3
> Flags: PMEClk- DSI- D1- D2- AuxCurrent=0mA PME(D0-,D1-,D2-,D3hot+,D3cold-)
> Flags: PMEClk- DSI- D1- D2- AuxCurrent=0mA PME(D0-,D1-,D2-,D3hot+,D3cold-)
> Status: D0 PME-Enable- DSel=0 DScale=0 PME-
> Capabilities: [a8] SATA HBA <?>
> Kernel driver in use: ahci
> Kernel modules: ahci
>
> Soon after booting, and possibly after the disk had spun down and was
> asked to spin back up (which it had done successfully a few times so
> far, with a spinddown timeout of 10 minutes, and using laptop_mode), it
> had a sata error:
>
> Nov 4 01:49:29 gamow kernel: [ 1865.106289] ata1.00: exception Emask 0x10 SAct 0x3ff SErr 0x50000 action 0xe frozen
> Nov 4 01:50:29 gamow kernel: [ 1865.106307] ata1: SError: { PHYRdyChg CommWake }
> Nov 4 01:50:29 gamow kernel: [ 1865.106319] ata1.00: cmd 61/08:00:bd:c9:57/00:00:00:00:00/40 tag 0 ncq 4096 out
> Nov 4 01:50:29 gamow kernel: [ 1865.106322] res 40/00:00:02:4f:c2/00:00:00:00:00/00 Emask 0x14 (ATA bus error)
> Nov 4 01:50:29 gamow kernel: [ 1865.106329] ata1.00: status: { DRDY }
> Nov 4 01:50:29 gamow kernel: [ 1865.106339] ata1.00: cmd 61/08:08:35:7a:73/00:00:00:00:00/40 tag 1 ncq 4096 out
> Nov 4 01:50:29 gamow kernel: [ 1865.106343] res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x14 (ATA bus error)
> Nov 4 01:50:29 gamow kernel: [ 1865.106350] ata1.00: status: { DRDY }
> Nov 4 01:50:29 gamow kernel: [ 1865.106361] ata1.00: cmd 61/08:10:35:36:9b/00:00:00:00:00/40 tag 2 ncq 4096 out
> Nov 4 01:50:29 gamow kernel: [ 1865.106364] res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x14 (ATA bus error)
> Nov 4 01:50:29 gamow kernel: [ 1865.106371] ata1.00: status: { DRDY }
> Nov 4 01:50:29 gamow kernel: [ 1865.106382] ata1.00: cmd 61/28:18:55:94:e2/00:00:00:00:00/40 tag 3 ncq 20480 out
>
> And then it fails to reset after some time, remounting the devices
> readonly (although what wasn't already in the cache became unreadable with
> lots of IO errors rapidly filling up dmesg). None of the logs made it to
> disk, naturally enough, and this was what I caught in syslog before syslog
> bailed. There were interesting messages that happened after this, but the
> dmesg buffer filled up before I thought about saving them.
Well, the disk is already a goner at that point so you need to either
set up a netconsole or plug in a usb stick, mount it and do "while
true; do dmesg -c >> /mnt/usbstick/dmesg.out; sleep 1; done" to
capture the kernel log.
> My /sys/class/scsi_host/host0/link_power_management_policy is:
> min_power
> . powertop had earlier (in a previous warm-boot) prompted me
> to set link_power_management_policy, so I had been tweaking that, but I
> didn't look at its default setting - I presume it was already at
> min_power, as it is now from a fresh (cold) bootup.
>
> Just in case it is related, in each bootup, I earlier get
> Nov 4 01:20:26 gamow kernel: [ 116.217492] CE: hpet increasing min_delta_ns to 15000 nsec
> Nov 4 01:20:28 gamow kernel: [ 118.073078] CE: hpet increasing min_delta_ns to 22500 nsec
> Nov 4 01:20:30 gamow kernel: [ 120.467250] ACPI: EC: missing confirmations, switch off interrupt mode.
> Nov 4 01:20:30 gamow kernel: [ 120.603593] CE: hpet increasing min_delta_ns to 33750 nsec
> Nov 4 01:20:31 gamow kernel: [ 121.004372] ACPI Exception (evregion-0420): AE_TIME, Returned by Handler for [EmbeddedControl] [20080321]
> Nov 4 01:20:31 gamow kernel: [ 121.004372] ACPI Error (psparse-0530): Method parse/execution failed [\_SB_.PCI0.LPCB.BAT1._BST] (Node ffff81013fa6cb90), AE_TIME
> Nov 4 01:20:31 gamow kernel: [ 121.004372] ACPI Exception (battery-0360): AE_TIME, Evaluating _BST [20080321]
>
> and/or
>
> [ 1587.842640] CE: hpet increasing min_delta_ns to 15000 nsec
> (successively increasing as time goes on)
>
> The sata link went belly up perhaps a few minutes after I went to bed
> lastnight, and the only thing I can think of that I did before then was to
> unplug and replug the ethernet and/or the wireless. The ACPI messages
> seem to happen around networking events on this laptop, but I haven't had
> a chance to investigate further.
I really need to see how the recovery attempt failed. Can you please
reproduce the problem and report the kernel log? Also, please report
how reproducible the problem is.
Thanks.
--
tejun
^ permalink raw reply [flat|nested] 5+ messages in thread
* Re: sata error on ICH8M
2008-11-11 14:01 ` sata error on ICH8M Tejun Heo
@ 2008-11-11 14:32 ` Mark Lord
2008-11-12 1:43 ` Tejun Heo
0 siblings, 1 reply; 5+ messages in thread
From: Mark Lord @ 2008-11-11 14:32 UTC (permalink / raw)
To: Tejun Heo; +Cc: Tim Connors, Linux Kernel Mailing List, linux-ide
Tejun Heo wrote:
> Hello,
>
> Tim Connors wrote:
>> I'm running a debian 2.6.26-9 kernel (sid) on a new laptop with:
>
> Hmmm...
>
>> 00:1f.2 SATA controller: Intel Corporation 82801HBM/HEM (ICH8M/ICH8M-E) SATA AHCI Controller (rev 03) (prog-if 01 [AHCI 1.0])
>> Subsystem: Dell Device 0275
>> Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx+
>> Status: Cap+ 66MHz+ UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
>> Latency: 0
>> Interrupt: pin B routed to IRQ 378
>> Region 0: I/O ports at 1c00 [size=8]
>> Region 1: I/O ports at 18d4 [size=4]
>> Region 2: I/O ports at 18d8 [size=8]
>> Region 3: I/O ports at 18d0 [size=4]
>> Region 4: I/O ports at 18e0 [size=32]
>> Region 5: Memory at f8504000 (32-bit, non-prefetchable) [size=2K]
>> Capabilities: [80] Message Signalled Interrupts: Mask- 64bit- Queue=0/2 Enable+
>> Address: fee0300c Data: 41a1
>> Capabilities: [70] Power Management version 3
>> Flags: PMEClk- DSI- D1- D2- AuxCurrent=0mA PME(D0-,D1-,D2-,D3hot+,D3cold-)
>> Flags: PMEClk- DSI- D1- D2- AuxCurrent=0mA PME(D0-,D1-,D2-,D3hot+,D3cold-)
>> Status: D0 PME-Enable- DSel=0 DScale=0 PME-
>> Capabilities: [a8] SATA HBA <?>
>> Kernel driver in use: ahci
>> Kernel modules: ahci
>>
>> Soon after booting, and possibly after the disk had spun down and was
>> asked to spin back up (which it had done successfully a few times so
>> far, with a spinddown timeout of 10 minutes, and using laptop_mode), it
>> had a sata error:
>>
>> Nov 4 01:49:29 gamow kernel: [ 1865.106289] ata1.00: exception Emask 0x10 SAct 0x3ff SErr 0x50000 action 0xe frozen
>> Nov 4 01:50:29 gamow kernel: [ 1865.106307] ata1: SError: { PHYRdyChg CommWake }
>> Nov 4 01:50:29 gamow kernel: [ 1865.106319] ata1.00: cmd 61/08:00:bd:c9:57/00:00:00:00:00/40 tag 0 ncq 4096 out
>> Nov 4 01:50:29 gamow kernel: [ 1865.106322] res 40/00:00:02:4f:c2/00:00:00:00:00/00 Emask 0x14 (ATA bus error)
>> Nov 4 01:50:29 gamow kernel: [ 1865.106329] ata1.00: status: { DRDY }
>> Nov 4 01:50:29 gamow kernel: [ 1865.106339] ata1.00: cmd 61/08:08:35:7a:73/00:00:00:00:00/40 tag 1 ncq 4096 out
>> Nov 4 01:50:29 gamow kernel: [ 1865.106343] res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x14 (ATA bus error)
>> Nov 4 01:50:29 gamow kernel: [ 1865.106350] ata1.00: status: { DRDY }
>> Nov 4 01:50:29 gamow kernel: [ 1865.106361] ata1.00: cmd 61/08:10:35:36:9b/00:00:00:00:00/40 tag 2 ncq 4096 out
>> Nov 4 01:50:29 gamow kernel: [ 1865.106364] res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x14 (ATA bus error)
>> Nov 4 01:50:29 gamow kernel: [ 1865.106371] ata1.00: status: { DRDY }
>> Nov 4 01:50:29 gamow kernel: [ 1865.106382] ata1.00: cmd 61/28:18:55:94:e2/00:00:00:00:00/40 tag 3 ncq 20480 out
>>
>> And then it fails to reset after some time, remounting the devices
>> readonly (although what wasn't already in the cache became unreadable with
>> lots of IO errors rapidly filling up dmesg). None of the logs made it to
>> disk, naturally enough, and this was what I caught in syslog before syslog
>> bailed. There were interesting messages that happened after this, but the
>> dmesg buffer filled up before I thought about saving them.
>
> Well, the disk is already a goner at that point so you need to either
> set up a netconsole or plug in a usb stick, mount it and do "while
> true; do dmesg -c >> /mnt/usbstick/dmesg.out; sleep 1; done" to
> capture the kernel log.
>
>> My /sys/class/scsi_host/host0/link_power_management_policy is:
>> min_power
>> . powertop had earlier (in a previous warm-boot) prompted me
>> to set link_power_management_policy, so I had been tweaking that, but I
>> didn't look at its default setting - I presume it was already at
>> min_power, as it is now from a fresh (cold) bootup.
>>
>> Just in case it is related, in each bootup, I earlier get
>> Nov 4 01:20:26 gamow kernel: [ 116.217492] CE: hpet increasing min_delta_ns to 15000 nsec
>> Nov 4 01:20:28 gamow kernel: [ 118.073078] CE: hpet increasing min_delta_ns to 22500 nsec
>> Nov 4 01:20:30 gamow kernel: [ 120.467250] ACPI: EC: missing confirmations, switch off interrupt mode.
>> Nov 4 01:20:30 gamow kernel: [ 120.603593] CE: hpet increasing min_delta_ns to 33750 nsec
>> Nov 4 01:20:31 gamow kernel: [ 121.004372] ACPI Exception (evregion-0420): AE_TIME, Returned by Handler for [EmbeddedControl] [20080321]
>> Nov 4 01:20:31 gamow kernel: [ 121.004372] ACPI Error (psparse-0530): Method parse/execution failed [\_SB_.PCI0.LPCB.BAT1._BST] (Node ffff81013fa6cb90), AE_TIME
>> Nov 4 01:20:31 gamow kernel: [ 121.004372] ACPI Exception (battery-0360): AE_TIME, Evaluating _BST [20080321]
>>
>> and/or
>>
>> [ 1587.842640] CE: hpet increasing min_delta_ns to 15000 nsec
>> (successively increasing as time goes on)
>>
>> The sata link went belly up perhaps a few minutes after I went to bed
>> lastnight, and the only thing I can think of that I did before then was to
>> unplug and replug the ethernet and/or the wireless. The ACPI messages
>> seem to happen around networking events on this laptop, but I haven't had
>> a chance to investigate further.
>
> I really need to see how the recovery attempt failed. Can you please
> reproduce the problem and report the kernel log? Also, please report
> how reproducible the problem is.
...
I wonder if this is another scenario, where a full reset of the AHCI host
would recover the system, similar to the one I emailed you about last month.. ?
^ permalink raw reply [flat|nested] 5+ messages in thread
* Re: sata error on ICH8M
2008-11-11 14:32 ` Mark Lord
@ 2008-11-12 1:43 ` Tejun Heo
0 siblings, 0 replies; 5+ messages in thread
From: Tejun Heo @ 2008-11-12 1:43 UTC (permalink / raw)
To: Mark Lord; +Cc: Tim Connors, Linux Kernel Mailing List, linux-ide
Mark Lord wrote:
>> I really need to see how the recovery attempt failed. Can you please
>> reproduce the problem and report the kernel log? Also, please report
>> how reproducible the problem is.
> ...
>
>
> I wonder if this is another scenario, where a full reset of the AHCI host
> would recover the system, similar to the one I emailed you about last
> month.. ?
The one you emailed me last month didn't require host reset after all.
It just needed small adjustment to reset protocol and the upstream
kernel worked fine with it w/o any modification.
Thanks.
--
tejun
^ permalink raw reply [flat|nested] 5+ messages in thread
end of thread, other threads:[~2008-11-12 1:44 UTC | newest]
Thread overview: 5+ messages (download: mbox.gz / follow: Atom feed)
-- links below jump to the message on this page --
2008-11-04 11:26 sata error on ICH8M Tim Connors
2008-11-04 11:52 ` sata error on ICH8M (Dell Vostro 1710 laptop) Tim Connors
2008-11-11 14:01 ` sata error on ICH8M Tejun Heo
2008-11-11 14:32 ` Mark Lord
2008-11-12 1:43 ` Tejun Heo
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox;
as well as URLs for NNTP newsgroup(s).