Bug 40592
| Summary: | SATA of intel H61 inside Dell optiplex 390 can't work at ATA mode | ||
|---|---|---|---|
| Product: | IO/Storage | Reporter: | Lei Ming (tom.leiming) |
| Component: | Serial ATA | Assignee: | Jeff Garzik (jgarzik) |
| Status: | CLOSED CODE_FIX | ||
| Severity: | high | CC: | alan, florian, luoyanqing, mkblackwell, tj, tom.leiming |
| Priority: | P1 | ||
| Hardware: | All | ||
| OS: | Linux | ||
| Kernel Version: | 3.0-rc7 | Subsystem: | |
| Regression: | No | Bisected commit-id: | |
| Attachments: |
longer-tur-timeout.patch
skip-clear-ua.patch dmesg output on SATA[8086:1c00] IDE mode issue 2port.patch dmesg output on SATA[8086:1c00] IDE mode issue dmesg output on 2.6.32-longterm kernel ata_piix-no-32bit.patch sff_data_xfer-zero-pad.patch sff-lets-see-what-sticks.patch |
||
|
Description
Lei Ming
2011-08-05 09:40:52 UTC
Hello, sorry about the delay. * Can you please attach the output of "lspci -nn"? * Can you try another optical driver or try the drive on another controller? Thanks.
Hi Tejun,
Thanks for your reply.
Attachment is the output of 'lspci -nn -v'.
>Can you try another optical driver or try the drive on another controller?
I have tried windows 7 can support the DVD, so the driver should
be OK.
thanks,
Sorry for the missed output of 'lspci -nn -v'. 00:00.0 Host bridge [0600]: Intel Corporation Sandy Bridge DRAM Controller [8086:0100] (rev 09) Subsystem: Dell Device [1028:04f5] Flags: bus master, fast devsel, latency 0 Capabilities: <access denied> Kernel driver in use: agpgart-intel Kernel modules: intel-agp 00:02.0 VGA compatible controller [0300]: Intel Corporation Sandy Bridge Integrated Graphics Controller [8086:0102] (rev 09) (prog-if 00 [VGA controller]) Subsystem: Dell Device [1028:04f5] Flags: bus master, fast devsel, latency 0, IRQ 44 Memory at 90c00000 (64-bit, non-prefetchable) [size=4M] Memory at 80000000 (64-bit, prefetchable) [size=256M] I/O ports at 4000 [size=64] Expansion ROM at <unassigned> [disabled] Capabilities: <access denied> Kernel driver in use: i915 Kernel modules: i915 00:16.0 Communication controller [0780]: Intel Corporation Cougar Point HECI Controller #1 [8086:1c3a] (rev 04) Subsystem: Dell Device [1028:04f5] Flags: bus master, fast devsel, latency 0, IRQ 11 Memory at 91a60000 (64-bit, non-prefetchable) [size=16] Capabilities: <access denied> 00:1a.0 USB Controller [0c03]: Intel Corporation Cougar Point USB Enhanced Host Controller #2 [8086:1c2d] (rev 04) (prog-if 20 [EHCI]) Subsystem: Dell Device [1028:04f5] Flags: bus master, medium devsel, latency 0, IRQ 16 Memory at 91a40000 (32-bit, non-prefetchable) [size=1K] Capabilities: <access denied> Kernel driver in use: ehci_hcd 00:1b.0 Audio device [0403]: Intel Corporation Cougar Point High Definition Audio Controller [8086:1c20] (rev 04) Subsystem: Dell Device [1028:04f5] Flags: bus master, fast devsel, latency 0, IRQ 45 Memory at 91a30000 (64-bit, non-prefetchable) [size=16K] Capabilities: <access denied> Kernel driver in use: HDA Intel Kernel modules: snd-hda-intel 00:1c.0 PCI bridge [0604]: Intel Corporation Cougar Point PCI Express Root Port 1 [8086:1c10] (rev b4) (prog-if 00 [Normal decode]) Flags: bus master, fast devsel, latency 0 Bus: primary=00, secondary=01, subordinate=01, sec-latency=0 Capabilities: <access denied> Kernel driver in use: pcieport Kernel modules: shpchp 00:1c.2 PCI bridge [0604]: Intel Corporation Cougar Point PCI Express Root Port 3 [8086:1c14] (rev b4) (prog-if 00 [Normal decode]) Flags: bus master, fast devsel, latency 0 Bus: primary=00, secondary=02, subordinate=02, sec-latency=0 I/O behind bridge: 00003000-00003fff Memory behind bridge: 91000000-919fffff Prefetchable memory behind bridge: 0000000090000000-00000000909fffff Capabilities: <access denied> Kernel driver in use: pcieport Kernel modules: shpchp 00:1c.4 PCI bridge [0604]: Intel Corporation Cougar Point PCI Express Root Port 5 [8086:1c18] (rev b4) (prog-if 00 [Normal decode]) Flags: bus master, fast devsel, latency 0 Bus: primary=00, secondary=03, subordinate=03, sec-latency=0 I/O behind bridge: 00002000-00002fff Prefetchable memory behind bridge: 0000000090a00000-0000000090afffff Capabilities: <access denied> Kernel driver in use: pcieport Kernel modules: shpchp 00:1d.0 USB Controller [0c03]: Intel Corporation Cougar Point USB Enhanced Host Controller #1 [8086:1c26] (rev 04) (prog-if 20 [EHCI]) Subsystem: Dell Device [1028:04f5] Flags: bus master, medium devsel, latency 0, IRQ 17 Memory at 91a20000 (32-bit, non-prefetchable) [size=1K] Capabilities: <access denied> Kernel driver in use: ehci_hcd 00:1f.0 ISA bridge [0601]: Intel Corporation Cougar Point LPC Controller [8086:1c5c] (rev 04) Subsystem: Dell Device [1028:04f5] Flags: bus master, medium devsel, latency 0 Capabilities: <access denied> Kernel modules: iTCO_wdt 00:1f.2 IDE interface [0101]: Intel Corporation Cougar Point 4 port SATA IDE Controller [8086:1c00] (rev 04) (prog-if 8f [Master SecP SecO PriP PriO]) Subsystem: Dell Device [1028:04f5] Flags: bus master, 66MHz, medium devsel, latency 0, IRQ 18 I/O ports at 4110 [size=8] I/O ports at 4100 [size=4] I/O ports at 40f0 [size=8] I/O ports at 40e0 [size=4] I/O ports at 40d0 [size=16] I/O ports at 40c0 [size=16] Capabilities: <access denied> Kernel driver in use: ata_piix 00:1f.3 SMBus [0c05]: Intel Corporation Cougar Point SMBus Controller [8086:1c22] (rev 04) Subsystem: Dell Device [1028:04f5] Flags: medium devsel, IRQ 3 Memory at 91a10000 (64-bit, non-prefetchable) [size=256] I/O ports at 4040 [size=32] Kernel modules: i2c-i801 00:1f.5 IDE interface [0101]: Intel Corporation Cougar Point 2 port SATA IDE Controller [8086:1c08] (rev 04) (prog-if 85 [Master SecO PriO]) Subsystem: Dell Device [1028:04f5] Flags: bus master, 66MHz, medium devsel, latency 0, IRQ 18 I/O ports at 40b0 [size=8] I/O ports at 40a0 [size=4] I/O ports at 4090 [size=8] I/O ports at 4080 [size=4] I/O ports at 4070 [size=16] I/O ports at 4060 [size=16] Capabilities: <access denied> Kernel driver in use: ata_piix 03:00.0 Ethernet controller [0200]: Realtek Semiconductor Co., Ltd. RTL8111/8168B PCI Express Gigabit Ethernet controller [10ec:8168] (rev 06) Subsystem: Dell Device [1028:04f5] Flags: bus master, fast devsel, latency 0, IRQ 43 I/O ports at 2000 [size=256] Memory at 90a10000 (64-bit, prefetchable) [size=4K] Memory at 90a00000 (64-bit, prefetchable) [size=16K] Capabilities: <access denied> Kernel driver in use: r8169 Kernel modules: r8169 00:00.0 Host bridge [0600]: Intel Corporation Sandy Bridge DRAM Controller [8086:0100] (rev 09) Subsystem: Dell Device [1028:04f5] Flags: bus master, fast devsel, latency 0 Capabilities: <access denied> Kernel driver in use: agpgart-intel Kernel modules: intel-agp 00:02.0 VGA compatible controller [0300]: Intel Corporation Sandy Bridge Integrated Graphics Controller [8086:0102] (rev 09) (prog-if 00 [VGA controller]) Subsystem: Dell Device [1028:04f5] Flags: bus master, fast devsel, latency 0, IRQ 44 Memory at 90c00000 (64-bit, non-prefetchable) [size=4M] Memory at 80000000 (64-bit, prefetchable) [size=256M] I/O ports at 4000 [size=64] Expansion ROM at <unassigned> [disabled] Capabilities: <access denied> Kernel driver in use: i915 Kernel modules: i915 00:16.0 Communication controller [0780]: Intel Corporation Cougar Point HECI Controller #1 [8086:1c3a] (rev 04) Subsystem: Dell Device [1028:04f5] Flags: bus master, fast devsel, latency 0, IRQ 11 Memory at 91a60000 (64-bit, non-prefetchable) [size=16] Capabilities: <access denied> 00:1a.0 USB Controller [0c03]: Intel Corporation Cougar Point USB Enhanced Host Controller #2 [8086:1c2d] (rev 04) (prog-if 20 [EHCI]) Subsystem: Dell Device [1028:04f5] Flags: bus master, medium devsel, latency 0, IRQ 16 Memory at 91a40000 (32-bit, non-prefetchable) [size=1K] Capabilities: <access denied> Kernel driver in use: ehci_hcd 00:1b.0 Audio device [0403]: Intel Corporation Cougar Point High Definition Audio Controller [8086:1c20] (rev 04) Subsystem: Dell Device [1028:04f5] Flags: bus master, fast devsel, latency 0, IRQ 45 Memory at 91a30000 (64-bit, non-prefetchable) [size=16K] Capabilities: <access denied> Kernel driver in use: HDA Intel Kernel modules: snd-hda-intel 00:1c.0 PCI bridge [0604]: Intel Corporation Cougar Point PCI Express Root Port 1 [8086:1c10] (rev b4) (prog-if 00 [Normal decode]) Flags: bus master, fast devsel, latency 0 Bus: primary=00, secondary=01, subordinate=01, sec-latency=0 Capabilities: <access denied> Kernel driver in use: pcieport Kernel modules: shpchp 00:1c.2 PCI bridge [0604]: Intel Corporation Cougar Point PCI Express Root Port 3 [8086:1c14] (rev b4) (prog-if 00 [Normal decode]) Flags: bus master, fast devsel, latency 0 Bus: primary=00, secondary=02, subordinate=02, sec-latency=0 I/O behind bridge: 00003000-00003fff Memory behind bridge: 91000000-919fffff Prefetchable memory behind bridge: 0000000090000000-00000000909fffff Capabilities: <access denied> Kernel driver in use: pcieport Kernel modules: shpchp 00:1c.4 PCI bridge [0604]: Intel Corporation Cougar Point PCI Express Root Port 5 [8086:1c18] (rev b4) (prog-if 00 [Normal decode]) Flags: bus master, fast devsel, latency 0 Bus: primary=00, secondary=03, subordinate=03, sec-latency=0 I/O behind bridge: 00002000-00002fff Prefetchable memory behind bridge: 0000000090a00000-0000000090afffff Capabilities: <access denied> Kernel driver in use: pcieport Kernel modules: shpchp 00:1d.0 USB Controller [0c03]: Intel Corporation Cougar Point USB Enhanced Host Controller #1 [8086:1c26] (rev 04) (prog-if 20 [EHCI]) Subsystem: Dell Device [1028:04f5] Flags: bus master, medium devsel, latency 0, IRQ 17 Memory at 91a20000 (32-bit, non-prefetchable) [size=1K] Capabilities: <access denied> Kernel driver in use: ehci_hcd 00:1f.0 ISA bridge [0601]: Intel Corporation Cougar Point LPC Controller [8086:1c5c] (rev 04) Subsystem: Dell Device [1028:04f5] Flags: bus master, medium devsel, latency 0 Capabilities: <access denied> Kernel modules: iTCO_wdt 00:1f.2 IDE interface [0101]: Intel Corporation Cougar Point 4 port SATA IDE Controller [8086:1c00] (rev 04) (prog-if 8f [Master SecP SecO PriP PriO]) Subsystem: Dell Device [1028:04f5] Flags: bus master, 66MHz, medium devsel, latency 0, IRQ 18 I/O ports at 4110 [size=8] I/O ports at 4100 [size=4] I/O ports at 40f0 [size=8] I/O ports at 40e0 [size=4] I/O ports at 40d0 [size=16] I/O ports at 40c0 [size=16] Capabilities: <access denied> Kernel driver in use: ata_piix 00:1f.3 SMBus [0c05]: Intel Corporation Cougar Point SMBus Controller [8086:1c22] (rev 04) Subsystem: Dell Device [1028:04f5] Flags: medium devsel, IRQ 3 Memory at 91a10000 (64-bit, non-prefetchable) [size=256] I/O ports at 4040 [size=32] Kernel modules: i2c-i801 00:1f.5 IDE interface [0101]: Intel Corporation Cougar Point 2 port SATA IDE Controller [8086:1c08] (rev 04) (prog-if 85 [Master SecO PriO]) Subsystem: Dell Device [1028:04f5] Flags: bus master, 66MHz, medium devsel, latency 0, IRQ 18 I/O ports at 40b0 [size=8] I/O ports at 40a0 [size=4] I/O ports at 4090 [size=8] I/O ports at 4080 [size=4] I/O ports at 4070 [size=16] I/O ports at 4060 [size=16] Capabilities: <access denied> Kernel driver in use: ata_piix 03:00.0 Ethernet controller [0200]: Realtek Semiconductor Co., Ltd. RTL8111/8168B PCI Express Gigabit Ethernet controller [10ec:8168] (rev 06) Subsystem: Dell Device [1028:04f5] Flags: bus master, fast devsel, latency 0, IRQ 43 I/O ports at 2000 [size=256] Memory at 90a10000 (64-bit, prefetchable) [size=4K] Memory at 90a00000 (64-bit, prefetchable) [size=16K] Capabilities: <access denied> Kernel driver in use: r8169 Kernel modules: r8169 Also have done tests on the below commit, both are same with before: DVD can't be identified. 1),commit 88e8201e67aace3d86de9e75122ea525f0e7248e [1] Author: Seth Heasley <seth.heasley@intel.com> Date: Tue Jan 12 17:01:28 2010 -0800 ata_piix: IDE Mode SATA patch for Intel Cougar Point DeviceIDs 2), v2.6.34 3), v3.1-rc1 [1], this commit is the 1st one to support the ide device[8086:1c00]. The reason why I asked to test another drive/controller combination is not only to determine whether the drive is broken or not. ata_piix is for the most part standard SFF controller and the driver hasn't changed in any significant way for years now. Nothing immediately rings the bell and trying out different combinations is useful in discovering which component is being peculiar how. So, please go on and try different drive and controller and post the logs. I don't really think trying different commits would result in anything different. The code essentially stayed the same for years now.
Hi Tejun,
Sorry for the delay.
Since I am accessing the 390 machine remotely, it is a little difficult
for me to change the drive now, maybe some time is needed to ask other
guys to help do it.
But I also found a interesting things: that the kernel tree in the link
below can recognize both the HDD. and DVD successfully:
http://kernel.ubuntu.com/git?p=ubuntu/ubuntu-lucid.git;a=summary
git://kernel.ubuntu.com/ubuntu/ubuntu-lucid.git
Follows the 'dmesg' info[1] when DVD and HDD. are recognized ok on
the ubuntu-lucid tree(based on 2.6.32):
thanks,
[1], 'dmesg'
[ 0.000000] BIOS-e820: 000000007a7e7000 - 000000007a7ff000 (ACPI data)
[ 0.000000] modified: 000000007a7e7000 - 000000007a7ff000 (ACPI data)
[ 0.000000] #0 [0000000000 - 0000001000] BIOS data page ==> [0000000000 - 0000001000]
[ 0.000000] Memory: 1755324k/4200448k available (5412k kernel code, 2194388k absent, 250736k reserved, 2981k data, 888k init)
[ 0.831728] libata version 3.00 loaded.
[ 0.862714] ata_piix 0000:00:1f.2: version 2.13
[ 0.862726] ata_piix 0000:00:1f.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[ 0.862730] ata_piix 0000:00:1f.2: MAP [ P0 P2 P1 P3 ]
[ 1.018998] ata_piix 0000:00:1f.2: setting latency timer to 64
[ 1.019077] scsi0 : ata_piix
[ 1.019137] scsi1 : ata_piix
[ 1.019159] ata1: SATA max UDMA/133 cmd 0x4110 ctl 0x4100 bmdma 0x40d0 irq 18
[ 1.019164] ata2: SATA max UDMA/133 cmd 0x40f0 ctl 0x40e0 bmdma 0x40d8 irq 18
[ 1.019186] ata_piix 0000:00:1f.5: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[ 1.019189] ata_piix 0000:00:1f.5: MAP [ P0 -- P1 -- ]
[ 1.178972] ata_piix 0000:00:1f.5: SCR access via SIDPR is available but doesn't work
[ 1.178982] ata_piix 0000:00:1f.5: setting latency timer to 64
[ 1.179020] scsi2 : ata_piix
[ 1.179068] scsi3 : ata_piix
[ 1.179085] ata3: SATA max UDMA/133 cmd 0x40b0 ctl 0x40a0 bmdma 0x4070 irq 18
[ 1.179086] ata4: SATA max UDMA/133 cmd 0x4090 ctl 0x4080 bmdma 0x4078 irq 18
[ 2.434160] ata1.01: failed to resume link (SControl 0)
[ 2.434164] ata2.01: failed to resume link (SControl 0)
[ 2.594242] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[ 2.594262] ata1.00: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[ 2.594264] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 2.594278] ata2.01: link offline, clearing class 3 to NONE
[ 2.594280] ata1.01: SATA link down (SStatus 0 SControl 0)
[ 2.614517] ata2.00: ATAPI: Optiarc DVD+/-RW AD-7717H, 101A, max UDMA/100
[ 2.614700] ata1.00: ATA-8: WDC WD3200AAKX-753CA0, 15.01H15, max UDMA/133
[ 2.614702] ata1.00: 625142448 sectors, multi 16: LBA48 NCQ (depth 0/32)
[ 2.634778] ata1.00: configured for UDMA/133
[ 2.814363] ata2.00: configured for UDMA/100
[ 3.283594] Write protecting the kernel read-only data: 7688k
[ 3.543189] EXT4-fs (sda1): mounted filesystem with ordered data mode
Also both HDD. and DVD. can be recognized by 2.6.32-longterm kernel tree: http://git.kernel.org/?p=linux/kernel/git/longterm/linux-2.6.32.y.git;a=summary thanks, Created attachment 68492 [details]
longer-tur-timeout.patch
Hmmm... so, that means it works fine with atapi_eh_clear_ua(). Does this fix the issue? Can you please post the kernel log with the patch applied?
Thanks.
Hi Tejun, Seems your patch doesn't fix the issue, see the kernel log below[1]: thanks, [1], dmesg u@u:~$ dmesg | grep ata [ 0.000000] BIOS-e820: 000000007a7e7000 - 000000007a7ff000 (ACPI data) [ 0.000000] Memory: 1749960k/4200448k available (5806k kernel code, 2194432k absent, 256056k reserved, 5114k data, 948k init) [ 0.961092] _OSC request data:1 8 1f [ 0.963272] _OSC request data:1 1f 1f [ 0.963295] _OSC request data:1 0 1d [ 0.965208] libata version 3.00 loaded. [ 1.470138] ata_piix 0000:00:1f.2: version 2.13 [ 1.470148] ata_piix 0000:00:1f.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [ 1.470152] ata_piix 0000:00:1f.2: MAP [ P0 P2 P1 P3 ] [ 1.628899] ata_piix 0000:00:1f.2: setting latency timer to 64 [ 1.629052] scsi0 : ata_piix [ 1.629099] scsi1 : ata_piix [ 1.629121] ata1: SATA max UDMA/133 cmd 0x4110 ctl 0x4100 bmdma 0x40d0 irq 18 [ 1.629126] ata2: SATA max UDMA/133 cmd 0x40f0 ctl 0x40e0 bmdma 0x40d8 irq 18 [ 1.629138] ata_piix 0000:00:1f.5: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [ 1.629143] ata_piix 0000:00:1f.5: MAP [ P0 -- P1 -- ] [ 1.788881] ata_piix 0000:00:1f.5: SCR access via SIDPR is available but doesn't work [ 1.788892] ata_piix 0000:00:1f.5: setting latency timer to 64 [ 1.789010] scsi2 : ata_piix [ 1.789043] scsi3 : ata_piix [ 1.789063] ata3: SATA max UDMA/133 cmd 0x40b0 ctl 0x40a0 bmdma 0x4070 irq 18 [ 1.789064] ata4: SATA max UDMA/133 cmd 0x4090 ctl 0x4080 bmdma 0x4078 irq 18 [ 3.048876] ata2.01: failed to resume link (SControl 0) [ 3.048952] ata1.01: failed to resume link (SControl 0) [ 3.208925] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 3.208940] ata2.01: SATA link down (SStatus 0 SControl 0) [ 3.208950] ata2.01: link offline, clearing class 3 to NONE [ 3.209067] ata1.00: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 3.209078] ata1.01: SATA link down (SStatus 0 SControl 0) [ 3.229069] ata2.00: ATAPI: Optiarc DVD+/-RW AD-7717H, 101A, max UDMA/100 [ 3.229565] ata1.00: ATA-8: WDC WD3200AAKX-753CA0, 15.01H15, max UDMA/133 [ 3.229570] ata1.00: 625142448 sectors, multi 16: LBA48 NCQ (depth 0/32) [ 3.269609] ata1.00: configured for UDMA/133 [ 3.428983] ata2.00: configured for UDMA/100 [ 33.428166] ata2.00: qc timeout (cmd 0xa0) [ 33.428170] ata2.00: TEST_UNIT_READY failed (err_mask=0x4) [ 34.848076] ata2.01: failed to resume link (SControl 0) [ 35.008121] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 35.008136] ata2.01: SATA link down (SStatus 0 SControl 0) [ 35.008147] ata2.01: link offline, clearing class 3 to NONE [ 35.068208] ata2.00: configured for UDMA/100 [ 65.067319] ata2.00: qc timeout (cmd 0xa0) [ 65.067323] ata2.00: TEST_UNIT_READY failed (err_mask=0x4) [ 65.067329] ata2.00: limiting SATA link speed to 1.5 Gbps [ 65.067339] ata2.00: limiting speed to UDMA/100:PIO3 [ 66.482657] ata2.01: failed to resume link (SControl 0) [ 66.643002] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310) [ 66.643017] ata2.01: SATA link down (SStatus 0 SControl 0) [ 66.643028] ata2.01: link offline, clearing class 3 to NONE [ 66.703182] ata2.00: configured for UDMA/100 [ 96.723657] ata2.00: qc timeout (cmd 0xa0) [ 96.723661] ata2.00: TEST_UNIT_READY failed (err_mask=0x4) [ 96.723664] ata2.00: disabled [ 96.723686] ata2.00: hard resetting link [ 97.069956] ata2.01: hard resetting link [ 98.135868] ata2.01: failed to resume link (SControl 0) [ 98.295155] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310) [ 98.295169] ata2.01: SATA link down (SStatus 0 SControl 0) [ 98.295181] ata2.01: link offline, clearing class 3 to NONE [ 98.295184] ata2: EH complete [ 98.296220] Write protecting the kernel read-only data: 10240k [ 98.634906] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null) Created attachment 68502 [details]
skip-clear-ua.patch
Let's see whether it works if we skip ua clearing altogether. Can you please test this one?
Thanks.
Ooh, if possible, please also verify you can actually use the device to read media after booting. Thanks.
Hi Tejun,
Even after applying both your two patches(), /dev/sr0 still doesn't
come, follows the kernel log[1]:
thanks,
[1], dmesg
Last login: Thu Aug 11 03:28:44 2011 from 10.193.37.1
u@u:~$ dmesg | grep ata
[ 0.000000] BIOS-e820: 000000007a7e7000 - 000000007a7ff000 (ACPI data)
[ 0.000000] Memory: 1749960k/4200448k available (5805k kernel code, 2194432k absent, 256056k reserved, 5115k data, 948k init)
[ 0.960900] _OSC request data:1 8 1f
[ 0.963078] _OSC request data:1 1f 1f
[ 0.963100] _OSC request data:1 0 1d
[ 0.965017] libata version 3.00 loaded.
[ 1.469941] ata_piix 0000:00:1f.2: version 2.13
[ 1.469950] ata_piix 0000:00:1f.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[ 1.469954] ata_piix 0000:00:1f.2: MAP [ P0 P2 P1 P3 ]
[ 1.628704] ata_piix 0000:00:1f.2: setting latency timer to 64
[ 1.628857] scsi0 : ata_piix
[ 1.628904] scsi1 : ata_piix
[ 1.628927] ata1: SATA max UDMA/133 cmd 0x4110 ctl 0x4100 bmdma 0x40d0 irq 18
[ 1.628932] ata2: SATA max UDMA/133 cmd 0x40f0 ctl 0x40e0 bmdma 0x40d8 irq 18
[ 1.628944] ata_piix 0000:00:1f.5: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[ 1.628948] ata_piix 0000:00:1f.5: MAP [ P0 -- P1 -- ]
[ 1.788687] ata_piix 0000:00:1f.5: SCR access via SIDPR is available but doesn't work
[ 1.788698] ata_piix 0000:00:1f.5: setting latency timer to 64
[ 1.788815] scsi2 : ata_piix
[ 1.788848] scsi3 : ata_piix
[ 1.788867] ata3: SATA max UDMA/133 cmd 0x40b0 ctl 0x40a0 bmdma 0x4070 irq 18
[ 1.788869] ata4: SATA max UDMA/133 cmd 0x4090 ctl 0x4080 bmdma 0x4078 irq 18
[ 3.048681] ata2.01: failed to resume link (SControl 0)
[ 3.048756] ata1.01: failed to resume link (SControl 0)
[ 3.208730] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[ 3.208744] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 3.208755] ata2.01: link offline, clearing class 3 to NONE
[ 3.208870] ata1.00: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[ 3.208882] ata1.01: SATA link down (SStatus 0 SControl 0)
[ 3.228877] ata2.00: ATAPI: Optiarc DVD+/-RW AD-7717H, 101A, max UDMA/100
[ 3.229176] ata1.00: ATA-8: WDC WD3200AAKX-753CA0, 15.01H15, max UDMA/133
[ 3.229181] ata1.00: 625142448 sectors, multi 16: LBA48 NCQ (depth 0/32)
[ 3.269180] ata1.00: configured for UDMA/133
[ 3.428791] ata2.00: configured for UDMA/100
[ 24.108220] ata2: lost interrupt (Status 0x58)
[ 24.150289] ata2: drained 65536 bytes to clear DRQ
[ 24.150299] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 24.150332] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 24.150383] ata2.00: status: { DRDY }
[ 24.150408] ata2.00: hard resetting link
[ 24.498144] ata2.01: hard resetting link
[ 25.568123] ata2.01: failed to resume link (SControl 0)
[ 25.728156] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[ 25.728170] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 25.728181] ata2.01: link offline, clearing class 3 to NONE
[ 25.788243] ata2.00: configured for UDMA/100
[ 25.788250] ata2: EH complete
[ 47.147535] ata2: lost interrupt (Status 0x58)
[ 47.189605] ata2: drained 65536 bytes to clear DRQ
[ 47.189616] ata2.00: limiting SATA link speed to 1.5 Gbps
[ 47.189619] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 47.189651] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 47.189702] ata2.00: status: { DRDY }
[ 47.189727] ata2.00: hard resetting link
[ 47.537562] ata2.01: hard resetting link
[ 48.607521] ata2.01: failed to resume link (SControl 0)
[ 48.767581] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 48.767596] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 48.767607] ata2.01: link offline, clearing class 3 to NONE
[ 48.827664] ata2.00: configured for UDMA/100
[ 48.827671] ata2: EH complete
[ 70.187040] ata2: lost interrupt (Status 0x58)
[ 70.229110] ata2: drained 65536 bytes to clear DRQ
[ 70.229120] ata2.00: limiting speed to UDMA/66:PIO4
[ 70.229124] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 70.229156] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 70.229207] ata2.00: status: { DRDY }
[ 70.229232] ata2.00: hard resetting link
[ 70.576969] ata2.01: hard resetting link
[ 71.646952] ata2.01: failed to resume link (SControl 0)
[ 71.807008] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 71.807022] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 71.807034] ata2.01: link offline, clearing class 3 to NONE
[ 71.867072] ata2.00: configured for UDMA/66
[ 71.867079] ata2: EH complete
[ 93.146372] ata2: lost interrupt (Status 0x58)
[ 93.188434] ata2: drained 65536 bytes to clear DRQ
[ 93.188446] ata2.00: limiting speed to UDMA/33:PIO4
[ 93.188450] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 93.188482] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 93.188533] ata2.00: status: { DRDY }
[ 93.188558] ata2.00: hard resetting link
[ 93.536404] ata2.01: hard resetting link
[ 94.606357] ata2.01: failed to resume link (SControl 0)
[ 94.766417] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 94.766432] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 94.766443] ata2.01: link offline, clearing class 3 to NONE
[ 94.826498] ata2.00: configured for UDMA/33
[ 94.826505] ata2: EH complete
[ 116.185867] ata2: lost interrupt (Status 0x58)
[ 116.227937] ata2: drained 65536 bytes to clear DRQ
[ 116.227947] ata2.00: limiting speed to PIO4
[ 116.227951] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 116.227983] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 116.228054] ata2.00: status: { DRDY }
[ 116.228089] ata2.00: hard resetting link
[ 116.575808] ata2.01: hard resetting link
[ 117.645788] ata2.01: failed to resume link (SControl 0)
[ 117.805844] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 117.805858] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 117.805870] ata2.01: link offline, clearing class 3 to NONE
[ 117.865907] ata2.00: configured for PIO4
[ 117.865913] ata2: EH complete
[ 139.145273] ata2: lost interrupt (Status 0x58)
[ 139.187342] ata2: drained 65536 bytes to clear DRQ
[ 139.187354] ata2.00: limiting speed to PIO3
[ 139.187358] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 139.187400] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 139.187481] ata2.00: status: { DRDY }
[ 139.187516] ata2.00: hard resetting link
[ 139.535225] ata2.01: hard resetting link
[ 140.605191] ata2.01: failed to resume link (SControl 0)
[ 140.765252] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 140.765266] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 140.765277] ata2.01: link offline, clearing class 3 to NONE
[ 140.825335] ata2.00: configured for PIO3
[ 140.825342] ata2: EH complete
[ 140.825356] ata2: WARNING: synchronous SCSI scan failed without making any progress, switching to async
[ 140.826424] Write protecting the kernel read-only data: 10240k
[ 141.123521] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null)
[ 142.287627] ata2: drained 65536 bytes to clear DRQ
[ 142.287713] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 142.287751] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 142.287792] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 142.287874] ata2.00: status: { DRDY DRQ }
[ 142.287910] ata2.00: hard resetting link
[ 142.635124] ata2.01: hard resetting link
[ 143.705097] ata2.01: failed to resume link (SControl 0)
[ 143.865185] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 143.865200] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 143.865211] ata2.01: link offline, clearing class 3 to NONE
[ 143.925221] ata2.00: configured for PIO3
[ 143.925230] ata2: EH complete
[ 145.287519] ata2: drained 65536 bytes to clear DRQ
[ 145.287537] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 145.287587] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 145.287628] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 145.287710] ata2.00: status: { DRDY DRQ }
[ 145.287746] ata2.00: hard resetting link
[ 145.635042] ata2.01: hard resetting link
[ 146.705046] ata2.01: failed to resume link (SControl 0)
[ 146.865080] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 146.865095] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 146.865106] ata2.01: link offline, clearing class 3 to NONE
[ 146.925149] ata2.00: configured for PIO3
[ 146.925157] ata2: EH complete
[ 148.287460] ata2: drained 65536 bytes to clear DRQ
[ 148.287475] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 148.287524] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 148.287567] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 148.287650] ata2.00: status: { DRDY DRQ }
[ 148.287685] ata2.00: hard resetting link
[ 148.635002] ata2.01: hard resetting link
[ 149.704970] ata2.01: failed to resume link (SControl 0)
[ 149.865033] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 149.865047] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 149.865059] ata2.01: link offline, clearing class 3 to NONE
[ 149.925072] ata2.00: configured for PIO3
[ 149.925083] ata2: EH complete
[ 151.287392] ata2: drained 65536 bytes to clear DRQ
[ 151.287409] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 151.287460] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 151.287507] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 151.287611] ata2.00: status: { DRDY DRQ }
[ 151.287649] ata2.00: hard resetting link
[ 151.634938] ata2.01: hard resetting link
[ 152.704873] ata2.01: failed to resume link (SControl 0)
[ 152.864958] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 152.864973] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 152.864984] ata2.01: link offline, clearing class 3 to NONE
[ 152.925005] ata2.00: configured for PIO3
[ 152.925021] ata2: EH complete
[ 156.780831] ata2: drained 65536 bytes to clear DRQ
[ 156.780882] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 156.780931] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 156.780971] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 156.781068] ata2.00: status: { DRDY DRQ }
[ 156.781104] ata2.00: hard resetting link
[ 157.124788] ata2.01: hard resetting link
[ 158.194755] ata2.01: failed to resume link (SControl 0)
[ 158.354815] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 158.354830] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 158.354841] ata2.01: link offline, clearing class 3 to NONE
[ 158.414848] ata2.00: configured for PIO3
[ 158.415308] ata2: EH complete
[ 164.104401] ata2: drained 65536 bytes to clear DRQ
[ 164.104416] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 164.104458] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 164.104502] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 164.104584] ata2.00: status: { DRDY DRQ }
[ 164.104620] ata2.00: hard resetting link
[ 164.451513] ata2.01: hard resetting link
[ 165.520991] ata2.01: failed to resume link (SControl 0)
[ 165.680994] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 165.681008] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 165.681019] ata2.01: link offline, clearing class 3 to NONE
[ 165.740968] ata2.00: configured for PIO3
[ 165.741416] ata2: EH complete
[ 170.101206] ata2: drained 65536 bytes to clear DRQ
[ 170.101236] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 170.101280] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 170.101321] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 170.101463] ata2.00: status: { DRDY DRQ }
[ 170.101498] ata2.00: hard resetting link
[ 170.448361] ata2.01: hard resetting link
[ 171.517878] ata2.01: failed to resume link (SControl 0)
[ 171.677848] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 171.677863] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 171.677874] ata2.01: link offline, clearing class 3 to NONE
[ 171.737817] ata2.00: configured for PIO3
[ 171.738269] ata2: EH complete
[ 176.138116] ata2: drained 65536 bytes to clear DRQ
[ 176.138148] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 176.138191] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 176.138232] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 176.138374] ata2.00: status: { DRDY DRQ }
[ 176.138409] ata2.00: hard resetting link
[ 176.485189] ata2.01: hard resetting link
[ 177.554725] ata2.01: failed to resume link (SControl 0)
[ 177.714670] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 177.714684] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 177.714695] ata2.01: link offline, clearing class 3 to NONE
[ 177.774646] ata2.00: configured for PIO3
[ 177.775098] ata2: EH complete
[ 182.134881] ata2: drained 65536 bytes to clear DRQ
[ 182.134913] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 182.134956] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 182.134997] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 182.135139] ata2.00: status: { DRDY DRQ }
[ 182.135174] ata2.00: hard resetting link
[ 182.482040] ata2.01: hard resetting link
[ 183.551571] ata2.01: failed to resume link (SControl 0)
[ 183.711520] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 183.711534] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 183.711546] ata2.01: link offline, clearing class 3 to NONE
[ 183.771498] ata2.00: configured for PIO3
[ 183.771947] ata2: EH complete
[ 186.374397] ata2: drained 65536 bytes to clear DRQ
[ 186.374448] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 186.374486] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 186.374527] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 186.374608] ata2.00: status: { DRDY DRQ }
[ 186.374644] ata2.00: hard resetting link
[ 186.719816] ata2.01: hard resetting link
[ 187.789345] ata2.01: failed to resume link (SControl 0)
[ 187.949250] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 187.949265] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 187.949276] ata2.01: link offline, clearing class 3 to NONE
[ 188.009272] ata2.00: configured for PIO3
[ 188.009737] ata2: EH complete
[ 189.282061] ata2: drained 65536 bytes to clear DRQ
[ 189.282076] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 189.282114] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 189.282155] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 189.282236] ata2.00: status: { DRDY DRQ }
[ 189.282271] ata2.00: hard resetting link
[ 189.628287] ata2.01: hard resetting link
[ 190.697771] ata2.01: failed to resume link (SControl 0)
[ 190.857766] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 190.857781] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 190.857792] ata2.01: link offline, clearing class 3 to NONE
[ 190.917742] ata2.00: configured for PIO3
[ 190.918187] ata2: EH complete
[ 193.128986] ata2: drained 65536 bytes to clear DRQ
[ 193.129068] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 193.129104] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 193.129144] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 193.129223] ata2.00: status: { DRDY DRQ }
[ 193.129255] ata2.00: hard resetting link
[ 193.476266] ata2.01: hard resetting link
[ 194.545752] ata2.01: failed to resume link (SControl 0)
[ 194.705735] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 194.705749] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 194.705760] ata2.01: link offline, clearing class 3 to NONE
[ 194.765721] ata2.00: configured for PIO3
[ 194.766143] ata2: EH complete
[ 196.742230] ata2: drained 65536 bytes to clear DRQ
[ 196.742251] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 196.742290] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 196.742331] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 196.742412] ata2.00: status: { DRDY DRQ }
[ 196.742449] ata2.00: hard resetting link
[ 197.084373] ata2.01: hard resetting link
[ 198.153808] ata2.01: failed to resume link (SControl 0)
[ 198.313743] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 198.313760] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 198.313772] ata2.01: link offline, clearing class 3 to NONE
[ 198.373791] ata2.00: configured for PIO3
[ 198.374190] ata2: EH complete
[ 204.183136] ata2: drained 65536 bytes to clear DRQ
[ 204.183169] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 204.183213] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 204.183256] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 204.183398] ata2.00: status: { DRDY DRQ }
[ 204.183434] ata2.00: hard resetting link
[ 204.530459] ata2.01: hard resetting link
Does it work if you specify 'irqpoll' kernel param?
Hi Tejun,
No, it still doesn't work, follows the kernel log[1]:
thanks,
[1],
u@u:~$ cat /proc/cmdline
BOOT_IMAGE=/boot/vmlinuz-3.1.0-rc1-custom+ root=UUID=f3d95a23-0520-4d1e-8b27-d7fb1361657d ro crashkernel=384M-2G:64M,2G-:128M quiet splash irqpoll
u@u:~$ dmesg | grep ata
[ 0.000000] BIOS-e820: 000000007a7e7000 - 000000007a7ff000 (ACPI data)
[ 0.000000] Memory: 1749960k/4200448k available (5805k kernel code, 2194432k absent, 256056k reserved, 5115k data, 948k init)
[ 0.961220] _OSC request data:1 8 1f
[ 0.963395] _OSC request data:1 1f 1f
[ 0.963418] _OSC request data:1 0 1d
[ 0.965333] libata version 3.00 loaded.
[ 1.460261] ata_piix 0000:00:1f.2: version 2.13
[ 1.460270] ata_piix 0000:00:1f.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[ 1.460274] ata_piix 0000:00:1f.2: MAP [ P0 P2 P1 P3 ]
[ 1.619020] ata_piix 0000:00:1f.2: setting latency timer to 64
[ 1.619172] scsi0 : ata_piix
[ 1.619220] scsi1 : ata_piix
[ 1.619242] ata1: SATA max UDMA/133 cmd 0x4110 ctl 0x4100 bmdma 0x40d0 irq 18
[ 1.619247] ata2: SATA max UDMA/133 cmd 0x40f0 ctl 0x40e0 bmdma 0x40d8 irq 18
[ 1.619259] ata_piix 0000:00:1f.5: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[ 1.619264] ata_piix 0000:00:1f.5: MAP [ P0 -- P1 -- ]
[ 1.779003] ata_piix 0000:00:1f.5: SCR access via SIDPR is available but doesn't work
[ 1.779014] ata_piix 0000:00:1f.5: setting latency timer to 64
[ 1.779131] scsi2 : ata_piix
[ 1.779165] scsi3 : ata_piix
[ 1.779184] ata3: SATA max UDMA/133 cmd 0x40b0 ctl 0x40a0 bmdma 0x4070 irq 18
[ 1.779185] ata4: SATA max UDMA/133 cmd 0x4090 ctl 0x4080 bmdma 0x4078 irq 18
[ 3.038999] ata2.01: failed to resume link (SControl 0)
[ 3.039075] ata1.01: failed to resume link (SControl 0)
[ 3.199047] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[ 3.199061] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 3.199072] ata2.01: link offline, clearing class 3 to NONE
[ 3.199188] ata1.00: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[ 3.199200] ata1.01: SATA link down (SStatus 0 SControl 0)
[ 3.219193] ata2.00: ATAPI: Optiarc DVD+/-RW AD-7717H, 101A, max UDMA/100
[ 3.220309] ata1.00: ATA-8: WDC WD3200AAKX-753CA0, 15.01H15, max UDMA/133
[ 3.220314] ata1.00: 625142448 sectors, multi 16: LBA48 NCQ (depth 0/32)
[ 3.259315] ata1.00: configured for UDMA/133
[ 3.419106] ata2.00: configured for UDMA/100
[ 24.108451] ata2: lost interrupt (Status 0x58)
[ 24.150511] ata2: drained 65536 bytes to clear DRQ
[ 24.150521] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 24.150553] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 24.150604] ata2.00: status: { DRDY }
[ 24.150629] ata2.00: hard resetting link
[ 24.498467] ata2.01: hard resetting link
[ 25.568421] ata2.01: failed to resume link (SControl 0)
[ 25.728498] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[ 25.728513] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 25.728524] ata2.01: link offline, clearing class 3 to NONE
[ 25.788556] ata2.00: configured for UDMA/100
[ 25.788563] ata2: EH complete
[ 47.147777] ata2: lost interrupt (Status 0x58)
[ 47.189840] ata2: drained 65536 bytes to clear DRQ
[ 47.189850] ata2.00: limiting SATA link speed to 1.5 Gbps
[ 47.189854] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 47.189886] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 47.189937] ata2.00: status: { DRDY }
[ 47.189962] ata2.00: hard resetting link
[ 47.537867] ata2.01: hard resetting link
[ 48.607838] ata2.01: failed to resume link (SControl 0)
[ 48.767899] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 48.767913] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 48.767924] ata2.01: link offline, clearing class 3 to NONE
[ 48.827980] ata2.00: configured for UDMA/100
[ 48.827987] ata2: EH complete
[ 70.187334] ata2: lost interrupt (Status 0x58)
[ 70.229396] ata2: drained 65536 bytes to clear DRQ
[ 70.229407] ata2.00: limiting speed to UDMA/66:PIO4
[ 70.229411] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 70.229443] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 70.229494] ata2.00: status: { DRDY }
[ 70.229519] ata2.00: hard resetting link
[ 70.577290] ata2.01: hard resetting link
[ 71.647272] ata2.01: failed to resume link (SControl 0)
[ 71.807326] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 71.807340] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 71.807351] ata2.01: link offline, clearing class 3 to NONE
[ 71.867386] ata2.00: configured for UDMA/66
[ 71.867393] ata2: EH complete
[ 93.146648] ata2: lost interrupt (Status 0x58)
[ 93.188711] ata2: drained 65536 bytes to clear DRQ
[ 93.188722] ata2.00: limiting speed to UDMA/33:PIO4
[ 93.188726] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 93.188759] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 93.188809] ata2.00: status: { DRDY }
[ 93.188833] ata2.00: hard resetting link
[ 93.536718] ata2.01: hard resetting link
[ 94.606679] ata2.01: failed to resume link (SControl 0)
[ 94.766739] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 94.766754] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 94.766765] ata2.01: link offline, clearing class 3 to NONE
[ 94.826816] ata2.00: configured for UDMA/33
[ 94.826823] ata2: EH complete
[ 116.186017] ata2: lost interrupt (Status 0x58)
[ 116.228080] ata2: drained 65536 bytes to clear DRQ
[ 116.228090] ata2.00: limiting speed to PIO4
[ 116.228094] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 116.228126] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 116.228198] ata2.00: status: { DRDY }
[ 116.228232] ata2.00: hard resetting link
[ 116.576120] ata2.01: hard resetting link
[ 117.646102] ata2.01: failed to resume link (SControl 0)
[ 117.806163] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 117.806178] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 117.806189] ata2.01: link offline, clearing class 3 to NONE
[ 117.866222] ata2.00: configured for PIO4
[ 117.866229] ata2: EH complete
[ 139.145464] ata2: lost interrupt (Status 0x58)
[ 139.187526] ata2: drained 65536 bytes to clear DRQ
[ 139.187537] ata2.00: limiting speed to PIO3
[ 139.187541] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 139.187583] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 139.187663] ata2.00: status: { DRDY }
[ 139.187698] ata2.00: hard resetting link
[ 139.535541] ata2.01: hard resetting link
[ 140.605503] ata2.01: failed to resume link (SControl 0)
[ 140.765566] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 140.765581] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 140.765592] ata2.01: link offline, clearing class 3 to NONE
[ 140.825654] ata2.00: configured for PIO3
[ 140.825660] ata2: EH complete
[ 140.825675] ata2: WARNING: synchronous SCSI scan failed without making any progress, switching to async
[ 140.826740] Write protecting the kernel read-only data: 10240k
[ 141.123612] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null)
[ 142.287896] ata2: drained 65536 bytes to clear DRQ
[ 142.287948] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 142.287988] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 142.288030] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 142.288113] ata2.00: status: { DRDY DRQ }
[ 142.288148] ata2.00: hard resetting link
[ 142.635441] ata2.01: hard resetting link
[ 143.705408] ata2.01: failed to resume link (SControl 0)
[ 143.865534] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 143.865548] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 143.865560] ata2.01: link offline, clearing class 3 to NONE
[ 143.925533] ata2.00: configured for PIO3
[ 143.925542] ata2: EH complete
[ 145.287845] ata2: drained 65536 bytes to clear DRQ
[ 145.287863] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 145.287913] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 145.287955] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 145.288037] ata2.00: status: { DRDY DRQ }
[ 145.288106] ata2.00: hard resetting link
[ 145.635359] ata2.01: hard resetting link
[ 146.705361] ata2.01: failed to resume link (SControl 0)
[ 146.865417] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 146.865431] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 146.865442] ata2.01: link offline, clearing class 3 to NONE
[ 146.925497] ata2.00: configured for PIO3
[ 146.925506] ata2: EH complete
[ 148.287802] ata2: drained 65536 bytes to clear DRQ
[ 148.287817] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 148.287868] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 148.287909] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 148.287991] ata2.00: status: { DRDY DRQ }
[ 148.288026] ata2.00: hard resetting link
[ 148.635298] ata2.01: hard resetting link
[ 149.705288] ata2.01: failed to resume link (SControl 0)
[ 149.865323] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 149.865337] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 149.865349] ata2.01: link offline, clearing class 3 to NONE
[ 149.925393] ata2.00: configured for PIO3
[ 149.925402] ata2: EH complete
[ 151.287704] ata2: drained 65536 bytes to clear DRQ
[ 151.287717] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 151.287765] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 151.287813] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 151.287907] ata2.00: status: { DRDY DRQ }
[ 151.287952] ata2.00: hard resetting link
[ 151.635220] ata2.01: hard resetting link
[ 152.705219] ata2.01: failed to resume link (SControl 0)
[ 152.865231] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 152.865248] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 152.865260] ata2.01: link offline, clearing class 3 to NONE
[ 152.925351] ata2.00: configured for PIO3
[ 152.925368] ata2: EH complete
[ 155.991728] ata2: drained 65536 bytes to clear DRQ
[ 155.991747] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 155.991797] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 155.991840] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 155.991922] ata2.00: status: { DRDY DRQ }
[ 155.991957] ata2.00: hard resetting link
[ 156.335126] ata2.01: hard resetting link
[ 157.405093] ata2.01: failed to resume link (SControl 0)
[ 157.565156] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 157.565170] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 157.565181] ata2.01: link offline, clearing class 3 to NONE
[ 157.625218] ata2.00: configured for PIO3
[ 157.625639] ata2: EH complete
[ 164.110168] ata2: drained 65536 bytes to clear DRQ
[ 164.110211] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 164.110250] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 164.110291] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 164.110388] ata2.00: status: { DRDY DRQ }
[ 164.110428] ata2.00: hard resetting link
[ 164.457990] ata2.01: hard resetting link
[ 165.528473] ata2.01: failed to resume link (SControl 0)
[ 165.688618] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 165.688633] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 165.688644] ata2.01: link offline, clearing class 3 to NONE
[ 165.748733] ata2.00: configured for PIO3
[ 165.749186] ata2: EH complete
[ 169.172594] ata2: drained 65536 bytes to clear DRQ
[ 169.172669] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 169.172706] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 169.172746] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 169.172825] ata2.00: status: { DRDY DRQ }
[ 169.172874] ata2.00: hard resetting link
[ 169.520392] ata2.01: hard resetting link
[ 170.590881] ata2.01: failed to resume link (SControl 0)
[ 170.751012] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 170.751027] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 170.751038] ata2.01: link offline, clearing class 3 to NONE
[ 170.811135] ata2.00: configured for PIO3
[ 170.811581] ata2: EH complete
[ 175.155426] ata2: drained 65536 bytes to clear DRQ
[ 175.155502] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 175.155539] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 175.155579] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 175.155658] ata2.00: status: { DRDY DRQ }
[ 175.155709] ata2.00: hard resetting link
[ 175.503232] ata2.01: hard resetting link
[ 176.573721] ata2.01: failed to resume link (SControl 0)
[ 176.733849] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 176.733863] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 176.733875] ata2.01: link offline, clearing class 3 to NONE
[ 176.793973] ata2.00: configured for PIO3
[ 176.794387] ata2: EH complete
[ 181.158277] ata2: drained 65536 bytes to clear DRQ
[ 181.158306] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 181.158348] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 181.158388] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 181.158530] ata2.00: status: { DRDY DRQ }
[ 181.158565] ata2.00: hard resetting link
[ 181.506081] ata2.01: hard resetting link
[ 182.576556] ata2.01: failed to resume link (SControl 0)
[ 182.736710] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 182.736725] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 182.736736] ata2.01: link offline, clearing class 3 to NONE
[ 182.796826] ata2.00: configured for PIO3
[ 182.797279] ata2: EH complete
[ 187.161501] ata2: drained 65536 bytes to clear DRQ
[ 187.161576] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 187.161612] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 187.161651] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 187.161784] ata2.00: status: { DRDY DRQ }
[ 187.161819] ata2.00: hard resetting link
[ 187.508932] ata2.01: hard resetting link
[ 188.579421] ata2.01: failed to resume link (SControl 0)
[ 188.739548] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 188.739562] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 188.739573] ata2.01: link offline, clearing class 3 to NONE
[ 188.799671] ata2.00: configured for PIO3
[ 188.800098] ata2: EH complete
[ 193.164019] ata2: drained 65536 bytes to clear DRQ
[ 193.164094] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 193.164130] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 193.164170] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 193.164310] ata2.00: status: { DRDY DRQ }
[ 193.164345] ata2.00: hard resetting link
[ 193.511780] ata2.01: hard resetting link
[ 194.582271] ata2.01: failed to resume link (SControl 0)
[ 194.742401] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 194.742415] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 194.742426] ata2.01: link offline, clearing class 3 to NONE
[ 194.802525] ata2.00: configured for PIO3
[ 194.803022] ata2: EH complete
[ 199.166823] ata2: drained 65536 bytes to clear DRQ
[ 199.166854] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 199.166898] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 199.166938] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 199.167080] ata2.00: status: { DRDY DRQ }
[ 199.167116] ata2.00: hard resetting link
[ 199.514630] ata2.01: hard resetting link
[ 200.585112] ata2.01: failed to resume link (SControl 0)
[ 200.745254] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 200.745268] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 200.745280] ata2.01: link offline, clearing class 3 to NONE
[ 200.805375] ata2.00: configured for PIO3
[ 200.805821] ata2: EH complete
[ 205.169676] ata2: drained 65536 bytes to clear DRQ
[ 205.169707] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 205.169752] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 205.169792] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 205.169935] ata2.00: status: { DRDY DRQ }
[ 205.169970] ata2.00: hard resetting link
[ 205.517481] ata2.01: hard resetting link
[ 206.587948] ata2.01: failed to resume link (SControl 0)
[ 206.748106] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 206.748120] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 206.748132] ata2.01: link offline, clearing class 3 to NONE
[ 206.808224] ata2.00: configured for PIO3
[ 206.808662] ata2: EH complete
[ 209.673795] ata2: drained 65536 bytes to clear DRQ
[ 209.673812] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 209.673852] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 209.673893] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 209.673974] ata2.00: status: { DRDY DRQ }
[ 209.674009] ata2.00: hard resetting link
[ 210.019616] ata2.01: hard resetting link
[ 211.090100] ata2.01: failed to resume link (SControl 0)
[ 211.250247] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 211.250262] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 211.250273] ata2.01: link offline, clearing class 3 to NONE
[ 211.310360] ata2.00: configured for PIO3
[ 211.310789] ata2: EH complete
[ 214.684679] ata2: drained 65536 bytes to clear DRQ
[ 214.684741] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 214.684791] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 214.684848] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 214.684956] ata2.00: status: { DRDY DRQ }
[ 214.685002] ata2.00: hard resetting link
[ 215.042008] ata2.01: hard resetting link
[ 216.112493] ata2.01: failed to resume link (SControl 0)
[ 216.272630] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 216.272648] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 216.272662] ata2.01: link offline, clearing class 3 to NONE
[ 216.332747] ata2.00: configured for PIO3
[ 216.333211] ata2: EH complete
[ 218.041027] ata2: drained 65536 bytes to clear DRQ
[ 218.041137] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 218.041189] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 218.041245] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 218.041423] ata2.00: status: { DRDY DRQ }
[ 218.041469] ata2.00: hard resetting link
[ 218.383594] ata2.01: hard resetting link
[ 219.454076] ata2.01: failed to resume link (SControl 0)
[ 219.614212] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 219.614230] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 219.614244] ata2.01: link offline, clearing class 3 to NONE
[ 219.674344] ata2.00: configured for PIO3
[ 219.674772] ata2: EH complete
[ 222.203020] ata2: drained 65536 bytes to clear DRQ
[ 222.203124] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 222.203173] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 222.203229] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 222.203334] ata2.00: status: { DRDY DRQ }
[ 222.203450] ata2.00: hard resetting link
[ 222.545572] ata2.01: hard resetting link
[ 223.616053] ata2.01: failed to resume link (SControl 0)
[ 223.776187] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 223.776205] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 223.776219] ata2.01: link offline, clearing class 3 to NONE
[ 223.836319] ata2.00: configured for PIO3
[ 223.836753] ata2: EH complete
[ 225.344317] ata2: drained 65536 bytes to clear DRQ
[ 225.344374] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 225.344436] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 225.344519] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 225.344623] ata2.00: status: { DRDY DRQ }
[ 225.344659] ata2.00: hard resetting link
[ 225.687064] ata2.01: hard resetting link
[ 226.757539] ata2.01: failed to resume link (SControl 0)
[ 226.917685] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 226.917703] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 226.917717] ata2.01: link offline, clearing class 3 to NONE
[ 226.977811] ata2.00: configured for PIO3
[ 226.978257] ata2: EH complete
[ 248.105315] ata2: drained 65536 bytes to clear DRQ
[ 248.105421] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 248.105477] ata2.00: ATAPI check failed (ireason=0x1 bytes=36)
[ 248.105558] ata2.00: cmd a0/00:00:00:24:00/00:00:00:00:00/a0 tag 0 pio 36 in
[ 248.105665] ata2.00: status: { DRDY DRQ }
[ 248.105712] ata2.00: hard resetting link
[ 248.447866] ata2.01: hard resetting link
[ 249.518347] ata2.01: failed to resume link (SControl 0)
[ 249.678484] ata2.00: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 249.678502] ata2.01: SATA link down (SStatus 0 SControl 0)
[ 249.678516] ata2.01: link offline, clearing class 3 to NONE
[ 249.738614] ata2.00: configured for PIO3
[ 249.739048] ata2: EH complete
u@u:~$ ls -l /dev/cdrom
ls: cannot access /dev/cdrom: No such file or directory
u@u:~$ ls -l /dev/sr*
ls: cannot access /dev/sr*: No such file or directory
Can you please attach full dmesg (which is generally a good idea whenever you're reporting kernel bug)? Created attachment 68512 [details]
dmesg output on SATA[8086:1c00] IDE mode issue
The output of 'dmesg' is obtained from the two patches
(longer-tur-timeout.patch, skip-clear-ua.patch) which are
applied on 3.0-rc1.
Created attachment 68522 [details]
2port.patch
Hmmm.... can you please try this one? Thanks.
Hi Tejun,
Will do it.
Will these previous two below needed for the test?
longer-tur-timeout.patch
skip-clear-ua.patch
thanks,
They don't really interact with each other, so just doing whatever is convenient should be fine. Thanks. Created attachment 68532 [details]
dmesg output on SATA[8086:1c00] IDE mode issue
The output of 'dmesg' is obtained from the three patches
(2port.patch, longer-tur-timeout.patch, skip-clear-ua.patch) which are
applied on 3.0-rc1.
Hi Tejun, Looks like the 2port.patch still doesn't solve the issue. thanks, Can you please attach full boot log from 2.6.32-longterm kernel? Thanks. Created attachment 68682 [details]
dmesg output on 2.6.32-longterm kernel
This is a wild hunch but can you disable usb from the kernel and see whether that makes any difference? Thanks. Hi Tejun, After passing 'nousb' to kernel, the dvd is still not recognized as before. thanks, Thanks for testing. I'm running out of ideas and afraid that the only thing left to try is bisection. I could be completely wrong but I don't think this is caused by isolated driver behavior change on libata side. Bisection is painful but thankfully is a logarithmic process meaning the huge gap between 2.6.32 and 3.0 would be bisected away fairly quickly. Can you please give a shot at bisection? Thank you. Hi Tejun, I have tried 'git bisect' already, but seems not sure if v2.6.32 is ok because I can't boot at all from v2.6.32 plus the patch of adding [8086:1c00] device id to ata_piix.c. thanks, I'm fairly sure something between 3.0 and 2.6.32 is culprit and it's unlikely that the problem was in .32 fixed by -stable and then reappeared afterwards, so I think the best way to start would be trying out each major version since .32 and start from the first one which boots successfully w/ the PCI ID patch. Thanks. Tejun, The machine can't boot with v2.6.33 plus the patch of adding [8086:1c00] device id to ata_piix.c. Also I have verified the 390 can boot with v2.6.34 and the commit[1] (in v2.6.34-rc1), but still can't recognize the dvd driver. So looks like the issue can't be bisectable. Is there any debug or test patch I can apply for you to generate some debug info, so that help you to troubleshoot? thanks, [1], commit 88e8201e67aace3d86de9e75122ea525f0e7248e Author: Seth Heasley <seth.heasley@intel.com> Date: Tue Jan 12 17:01:28 2010 -0800 ata_piix: IDE Mode SATA patch for Intel Cougar Point DeviceIDs Hmm... so 2.6.34 still has the issue, 2.6.32-stable can boot and works okay. So, most likely the change has been introduced between 2.6.32 and 34. I guess we need to find out what in the -stable makes it boot. Can you please attach dmesg of failed boot from 2.6.32 + PCI ID patch? Let's see why the boot is failing. Thank you. I can verify that 2.6.32.45 works fine on this box (Dell Optiplex 390 SFF), and 2.6.34 does not work - can't access the DVD. This has become a big issue for us - Dell discontinued the old box we were shipping and offered the 390 as a replacement. We are temporarily downgrading to 2.6.32 in order to ship a product, but this is not an ideal solution... If necessary I can lend a box to someone for further debugging. US location would be best to keep shipping costs reasonable. Created attachment 69612 [details]
ata_piix-no-32bit.patch
Scanned through changelog between 32 and 34. The two things which stood out are enabling of 32bit PIO and spurious IRQ handling changes. Can you please try the attached patch?
Unfortunately, I'm in the process of moving across the pond and won't be able to receive anything throughout September. I'll be in CA from October tho, so if it doesn't get fixed by then, we can try shipping stuff.
Thanks.
(In reply to comment #32) > Created an attachment (id=69612) [details] > ata_piix-no-32bit.patch > > Scanned through changelog between 32 and 34. The two things which stood out > are > enabling of 32bit PIO and spurious IRQ handling changes. Can you please try > the > attached patch? > > Unfortunately, I'm in the process of moving across the pond and won't be able > to receive anything throughout September. I'll be in CA from October tho, so > if it doesn't get fixed by then, we can try shipping stuff. > > Thanks. Yes, this patch fixes the problem (applied to 2.6.34-gentoo-r1). I don't know what other implications this patch might have, but it lets us move forward on our new hardware platform. Thanks so much! Hi Tejun, The patch does fix the problem, and I have tested it ok against 3.1-rc3. great thanks. Hmm... that's interesting. I wonder where the problem is tho. It's not like 32bit PIO helps all that much w/ SATA devices so we might as well just drop it but I'd like to at least find out where the fault is. Is it possible for you guys to put a different optical drive and see whether that works? Also, can you please connect the drive which doesn't work to a sil3112/4 or sil3512 controller and see how it behaves? I *suspect* the problem is with the drive rather than the controller and wanna be sure before making decisions. Thank you. Created attachment 70402 [details]
sff_data_xfer-zero-pad.patch
I went through the code path again and found out that the 32bit PIO function wasn't zeroing the pad area, which can explain the behavior. Can you please apply the attached patch and see whether the problem goes away?
Thanks.
Unfortunately, this one(sff_data_xfer-zero-pad.patch) can't solve the problem. thanks, Created attachment 70412 [details]
sff-lets-see-what-sticks.patch
This one should work but I'm not sure whether this is the right way to go. Would you be able to verify whether the problem is w/ the controller or the drive as described a couple of comments above?
Thank you.
Yeah, sff-lets-see-what-sticks.patch can fix the problem. Sorry, I have no way to switch dvd drive or controller as you commented before because I just have to access the machine remotely via ssh. I don't have the machine at my hand. BTW: I have found more and more guys start to report this kind of problem on Apple, Asus and dell machines, so looks like it is not a hardware problem. thanks, Tejun, Could you prepare a fix patch and submit to upstream? You know the issue has affected many people for long time, so hope that it can be fixed soon. thanks, Sorry about the delay. I've been and still am traveling. The problem is that I'm still not sure where the problem is and thus how to properly fix this. Given how long the 32bit io enable has been there and how few reports we've had till now, I think it's more likely the problem is confined to few devices. Maybe they don't like how the payload is divided across multiple FISes when 32bit PIO is used. It would be great if we can hook up the troubled configuration to SATA analyzer and see what exactly is going on the wire. That said, I don't think there's much to be gained by using 32bit PIO for ATAPI cdb transfers, so maybe we should just apply the last patch. Eh... Maybe I'll do that. Thanks. I tried swapping in a different optical drive (Toshiba TS-L633) into an Optiplex 390 SFF, and still observe the broken behavior with an unpatched kernel. That drive works fine on other boxes (Dell Optiplex 960 SFF) with unpatched kernels, so I assume the issue is with the SATA chip and not the particular drive. Tejun, Fedora15/Fedora 14 can not find the the DVD-ROM when install using Sata DVD-ROM drive and my BIOS was configured in IDE mode for Intel Cougar Point Sata controller on Sata 6GB/S port. But when I changed the sata 6Gb/s port from IDE mode to AHCI mode on my BIOS, the Fedora15/Fedora 14 can be installed successly. And I alse do a test on changing the DVD-ROM to the sata 3GB/s port and keep the sata controller on IDE mode, the Fedora15/14 can also be installed successly. I also have done an other test, I try to install RHEL 6.0 on the sata 6GB/s port and keep the sata controller on IDE mode , and I also have the right result. So, it is my BIOS have a bug? or Fedora15/14 can not be installed on sata 6GB/s port when the sata controller is configured in IDE mode? or there is a bug on linux kernel(RHEL6.0 kernel:2.6.32, FC15 kernel:2.6.40)? thanks. My computer: cpu: intel sandy brige(i5 2500), pch: intel cougar point(QM67) Focus.luo, Looks like your machine is based on H67 or P67 chipsets, so you can switch to AHCI mode or switch sata port to support DVD. Maybe you can try tejun's patch to see if it may fix your issue too. I have verified the patch can make DVD workable on H61 chipsets. thanks A patch referencing this bug report has been merged in Linux v3.2-rc1: commit 5e5a4f5d5a08c9c504fe956391ac3dae2c66556d Author: Ming Lei <ming.lei@canonical.com> Date: Fri Oct 7 11:50:22 2011 +0800 ata_piix: make DVD Drive recognisable on systems with Intel Sandybridge chipsets(v2) |