2008-03-08 21:47:57

by Rafael J. Wysocki

[permalink] [raw]
Subject: [Regression] 2.6.25-rc4-git3: Handling of audio CDs broken on pata_ali

Hi,

On one of my test boxes I'm unable to do just about anything with audio CDs
using the current -git (2.6.24 is fine in that respect on the same box).

When an audio CD is inserted into the drive, I get the following errors in
dmesg and nothing more happens (quite obviously):

ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata1.00: cmd a0/01:00:00:10:00/00:00:00:00:00/a0 tag 0 dma 16400 in
cdb 42 02 40 01 00 00 00 00 10 00 00 00 00 00 00 00
res 40/00:00:00:18:00/00:00:00:00:00/a0 Emask 0x4 (timeout)
ata1.00: status: { DRDY }
ata1: soft resetting link
ata1.00: configured for UDMA/33
ata1: EH complete
ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata1.00: cmd a0/01:00:00:10:00/00:00:00:00:00/a0 tag 0 dma 16400 in
cdb 42 02 40 01 00 00 00 00 10 00 00 00 00 00 00 00
res 40/00:00:00:18:00/00:00:00:00:00/a0 Emask 0x4 (timeout)
ata1.00: status: { DRDY }
ata1: port is slow to respond, please be patient (Status 0x80)
ata1: device not ready (errno=-16), forcing hardreset
ata1: soft resetting link
ata1.00: qc timeout (cmd 0xa1)
ata1.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata1.00: revalidation failed (errno=-5)
ata1: failed to recover some devices, retrying in 5 secs
ata1: port is slow to respond, please be patient (Status 0x80)
ata1: device not ready (errno=-16), forcing hardreset
ata1: soft resetting link
ata1.00: qc timeout (cmd 0xa1)
ata1.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata1.00: revalidation failed (errno=-5)
ata1: failed to recover some devices, retrying in 5 secs
ata1: port is slow to respond, please be patient (Status 0x80)
ata1: device not ready (errno=-16), forcing hardreset
ata1: soft resetting link
ata1.00: qc timeout (cmd 0xa1)
ata1.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata1.00: revalidation failed (errno=-5)
ata1.00: disabled

where ata1 is:

scsi0 : pata_ali
scsi1 : pata_ali
ata1: PATA max UDMA/133 cmd 0x1f0 ctl 0x3f6 bmdma 0xff00 irq 14
ata2: PATA max UDMA/133 cmd 0x170 ctl 0x376 bmdma 0xff08 irq 15
ata1.00: ATAPI: TSSTcorpCD/DVDW SH-S182M, SB03, max UDMA/33
ata1.00: configured for UDMA/33
scsi 0:0:0:0: CD-ROM TSSTcorp CD/DVDW SH-S182M SB03 PQ: 0 ANSI: 5

(full dmesg attached).

I can't reproduce this problem on my other test boxes, so I think it's related
to pata_ali rather than anything else.

In principle I can try to find the commit that caused this problem to occur,
but that would be rather tedious, so if anyone has any ideas of what's up,
please let me know.

Thanks,
Rafael


Attachments:
(No filename) (2.49 kB)
dmesg.log (24.46 kB)
Download all attachments

2008-03-09 07:38:38

by Andrey Borzenkov

[permalink] [raw]
Subject: Re: [Regression] 2.6.25-rc4-git3: Handling of audio CDs broken on pata_ali

Rafael J. Wysocki wrote:

> Hi,
>
> On one of my test boxes I'm unable to do just about anything with audio
> CDs using the current -git (2.6.24 is fine in that respect on the same
> box).
>
> When an audio CD is inserted into the drive, I get the following errors in
> dmesg and nothing more happens (quite obviously):
>
> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> ata1.00: cmd a0/01:00:00:10:00/00:00:00:00:00/a0 tag 0 dma 16400 in
> cdb 42 02 40 01 00 00 00 00 10 00 00 00 00 00 00 00
> res 40/00:00:00:18:00/00:00:00:00:00/a0 Emask 0x4 (timeout)
> ata1.00: status: { DRDY }
> ata1: soft resetting link
> ata1.00: configured for UDMA/33
> ata1: EH complete
> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> ata1.00: cmd a0/01:00:00:10:00/00:00:00:00:00/a0 tag 0 dma 16400 in
> cdb 42 02 40 01 00 00 00 00 10 00 00 00 00 00 00 00
> res 40/00:00:00:18:00/00:00:00:00:00/a0 Emask 0x4 (timeout)
> ata1.00: status: { DRDY }
> ata1: port is slow to respond, please be patient (Status 0x80)
> ata1: device not ready (errno=-16), forcing hardreset
> ata1: soft resetting link
> ata1.00: qc timeout (cmd 0xa1)
> ata1.00: failed to IDENTIFY (I/O error, err_mask=0x4)
> ata1.00: revalidation failed (errno=-5)
> ata1: failed to recover some devices, retrying in 5 secs
> ata1: port is slow to respond, please be patient (Status 0x80)
> ata1: device not ready (errno=-16), forcing hardreset
> ata1: soft resetting link
> ata1.00: qc timeout (cmd 0xa1)
> ata1.00: failed to IDENTIFY (I/O error, err_mask=0x4)
> ata1.00: revalidation failed (errno=-5)
> ata1: failed to recover some devices, retrying in 5 secs
> ata1: port is slow to respond, please be patient (Status 0x80)
> ata1: device not ready (errno=-16), forcing hardreset
> ata1: soft resetting link
> ata1.00: qc timeout (cmd 0xa1)
> ata1.00: failed to IDENTIFY (I/O error, err_mask=0x4)
> ata1.00: revalidation failed (errno=-5)
> ata1.00: disabled
>
> where ata1 is:
>
> scsi0 : pata_ali
> scsi1 : pata_ali

Oh, is it only with audio CDs? I am unable to use DVD on pata_ali in DMA at
all. Have you tried to disable ATAPI DMA (libata.dma=1)?


> ata1: PATA max UDMA/133 cmd 0x1f0 ctl 0x3f6 bmdma 0xff00 irq 14
> ata2: PATA max UDMA/133 cmd 0x170 ctl 0x376 bmdma 0xff08 irq 15
> ata1.00: ATAPI: TSSTcorpCD/DVDW SH-S182M, SB03, max UDMA/33
> ata1.00: configured for UDMA/33
> scsi 0:0:0:0: CD-ROM TSSTcorp CD/DVDW SH-S182M SB03 PQ: 0 ANSI:
> 5
>
> (full dmesg attached).
>
> I can't reproduce this problem on my other test boxes, so I think it's
> related to pata_ali rather than anything else.
>
> In principle I can try to find the commit that caused this problem to
> occur, but that would be rather tedious, so if anyone has any ideas of
> what's up, please let me know.
>
> Thanks,
> Rafael

2008-03-09 23:13:43

by Rafael J. Wysocki

[permalink] [raw]
Subject: Re: [Regression] 2.6.25-rc4-git3: Handling of audio CDs broken on pata_ali

On Sunday, 9 of March 2008, Andrey Borzenkov wrote:
> Rafael J. Wysocki wrote:
>
> > Hi,
> >
> > On one of my test boxes I'm unable to do just about anything with audio
> > CDs using the current -git (2.6.24 is fine in that respect on the same
> > box).
> >
> > When an audio CD is inserted into the drive, I get the following errors in
> > dmesg and nothing more happens (quite obviously):
> >
> > ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> > ata1.00: cmd a0/01:00:00:10:00/00:00:00:00:00/a0 tag 0 dma 16400 in
> > cdb 42 02 40 01 00 00 00 00 10 00 00 00 00 00 00 00
> > res 40/00:00:00:18:00/00:00:00:00:00/a0 Emask 0x4 (timeout)
> > ata1.00: status: { DRDY }
> > ata1: soft resetting link
> > ata1.00: configured for UDMA/33
> > ata1: EH complete
> > ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> > ata1.00: cmd a0/01:00:00:10:00/00:00:00:00:00/a0 tag 0 dma 16400 in
> > cdb 42 02 40 01 00 00 00 00 10 00 00 00 00 00 00 00
> > res 40/00:00:00:18:00/00:00:00:00:00/a0 Emask 0x4 (timeout)
> > ata1.00: status: { DRDY }
> > ata1: port is slow to respond, please be patient (Status 0x80)
> > ata1: device not ready (errno=-16), forcing hardreset
> > ata1: soft resetting link
> > ata1.00: qc timeout (cmd 0xa1)
> > ata1.00: failed to IDENTIFY (I/O error, err_mask=0x4)
> > ata1.00: revalidation failed (errno=-5)
> > ata1: failed to recover some devices, retrying in 5 secs
> > ata1: port is slow to respond, please be patient (Status 0x80)
> > ata1: device not ready (errno=-16), forcing hardreset
> > ata1: soft resetting link
> > ata1.00: qc timeout (cmd 0xa1)
> > ata1.00: failed to IDENTIFY (I/O error, err_mask=0x4)
> > ata1.00: revalidation failed (errno=-5)
> > ata1: failed to recover some devices, retrying in 5 secs
> > ata1: port is slow to respond, please be patient (Status 0x80)
> > ata1: device not ready (errno=-16), forcing hardreset
> > ata1: soft resetting link
> > ata1.00: qc timeout (cmd 0xa1)
> > ata1.00: failed to IDENTIFY (I/O error, err_mask=0x4)
> > ata1.00: revalidation failed (errno=-5)
> > ata1.00: disabled
> >
> > where ata1 is:
> >
> > scsi0 : pata_ali
> > scsi1 : pata_ali
>
> Oh, is it only with audio CDs? I am unable to use DVD on pata_ali in DMA at
> all. Have you tried to disable ATAPI DMA (libata.dma=1)?

Data CDs seem to work fine here.

Thanks,
Rafael

2008-03-10 07:42:23

by Tejun Heo

[permalink] [raw]
Subject: Re: [Regression] 2.6.25-rc4-git3: Handling of audio CDs broken on pata_ali

Rafael J. Wysocki wrote:
>>> where ata1 is:
>>>
>>> scsi0 : pata_ali
>>> scsi1 : pata_ali
>> Oh, is it only with audio CDs? I am unable to use DVD on pata_ali in DMA at
>> all. Have you tried to disable ATAPI DMA (libata.dma=1)?
>
> Data CDs seem to work fine here.

* Does booting into runlevel 1, putting in an audio cd and running
cdparanoia give the same result?

* Does setting module parameter libata.force to "1.00:pio4" make any
difference?

Thanks.

--
tejun

2008-03-10 07:47:38

by Tejun Heo

[permalink] [raw]
Subject: Re: [Regression] 2.6.25-rc4-git3: Handling of audio CDs broken on pata_ali

Tejun Heo wrote:
> Rafael J. Wysocki wrote:
>>>> where ata1 is:
>>>>
>>>> scsi0 : pata_ali
>>>> scsi1 : pata_ali
>>> Oh, is it only with audio CDs? I am unable to use DVD on pata_ali in DMA at
>>> all. Have you tried to disable ATAPI DMA (libata.dma=1)?
>> Data CDs seem to work fine here.
>
> * Does booting into runlevel 1, putting in an audio cd and running
> cdparanoia give the same result?
>
> * Does setting module parameter libata.force to "1.00:pio4" make any
> difference?

Oh, never mind. I have a hunch. I'll report back in a while.

--
tejun

2008-03-10 12:04:07

by Tejun Heo

[permalink] [raw]
Subject: Re: [Regression] 2.6.25-rc4-git3: Handling of audio CDs broken on pata_ali

Tejun Heo wrote:
> Tejun Heo wrote:
>> Rafael J. Wysocki wrote:
>>>>> where ata1 is:
>>>>>
>>>>> scsi0 : pata_ali
>>>>> scsi1 : pata_ali
>>>> Oh, is it only with audio CDs? I am unable to use DVD on pata_ali in DMA at
>>>> all. Have you tried to disable ATAPI DMA (libata.dma=1)?
>>> Data CDs seem to work fine here.
>> * Does booting into runlevel 1, putting in an audio cd and running
>> cdparanoia give the same result?
>>
>> * Does setting module parameter libata.force to "1.00:pio4" make any
>> difference?
>
> Oh, never mind. I have a hunch. I'll report back in a while.
>

Does the attached patch fix the problem?

--
tejun


Attachments:
use-cmd_type-in-atapi-dma-check.patch (1.03 kB)

2008-03-10 16:32:44

by Chuck Ebbert

[permalink] [raw]
Subject: Re: [Regression] 2.6.25-rc4-git3: Handling of audio CDs broken on pata_ali

On 03/08/2008 04:46 PM, Rafael J. Wysocki wrote:
> Hi,
>
> On one of my test boxes I'm unable to do just about anything with audio CDs
> using the current -git (2.6.24 is fine in that respect on the same box).
>
> When an audio CD is inserted into the drive, I get the following errors in
> dmesg and nothing more happens (quite obviously):
>
> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> ata1.00: cmd a0/01:00:00:10:00/00:00:00:00:00/a0 tag 0 dma 16400 in
> cdb 42 02 40 01 00 00 00 00 10 00 00 00 00 00 00 00
> res 40/00:00:00:18:00/00:00:00:00:00/a0 Emask 0x4 (timeout)
> ata1.00: status: { DRDY }
> ata1: soft resetting link
> ata1.00: configured for UDMA/33
> ata1: EH complete
> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> ata1.00: cmd a0/01:00:00:10:00/00:00:00:00:00/a0 tag 0 dma 16400 in
> cdb 42 02 40 01 00 00 00 00 10 00 00 00 00 00 00 00
> res 40/00:00:00:18:00/00:00:00:00:00/a0 Emask 0x4 (timeout)
> ata1.00: status: { DRDY }
> ata1: port is slow to respond, please be patient (Status 0x80)
> ata1: device not ready (errno=-16), forcing hardreset
> ata1: soft resetting link
> ata1.00: qc timeout (cmd 0xa1)
> ata1.00: failed to IDENTIFY (I/O error, err_mask=0x4)
> ata1.00: revalidation failed (errno=-5)
> ata1: failed to recover some devices, retrying in 5 secs
> ata1: port is slow to respond, please be patient (Status 0x80)
> ata1: device not ready (errno=-16), forcing hardreset
> ata1: soft resetting link
> ata1.00: qc timeout (cmd 0xa1)
> ata1.00: failed to IDENTIFY (I/O error, err_mask=0x4)
> ata1.00: revalidation failed (errno=-5)
> ata1: failed to recover some devices, retrying in 5 secs
> ata1: port is slow to respond, please be patient (Status 0x80)
> ata1: device not ready (errno=-16), forcing hardreset
> ata1: soft resetting link
> ata1.00: qc timeout (cmd 0xa1)
> ata1.00: failed to IDENTIFY (I/O error, err_mask=0x4)
> ata1.00: revalidation failed (errno=-5)
> ata1.00: disabled
>

We still have DMA totally disabled on pata_ali in Fedora.

2008-03-10 21:38:00

by Rafael J. Wysocki

[permalink] [raw]
Subject: Re: [Regression] 2.6.25-rc4-git3: Handling of audio CDs broken on pata_ali

On Monday, 10 of March 2008, Tejun Heo wrote:
> Tejun Heo wrote:
> > Tejun Heo wrote:
> >> Rafael J. Wysocki wrote:
> >>>>> where ata1 is:
> >>>>>
> >>>>> scsi0 : pata_ali
> >>>>> scsi1 : pata_ali
> >>>> Oh, is it only with audio CDs? I am unable to use DVD on pata_ali in DMA at
> >>>> all. Have you tried to disable ATAPI DMA (libata.dma=1)?
> >>> Data CDs seem to work fine here.
> >> * Does booting into runlevel 1, putting in an audio cd and running
> >> cdparanoia give the same result?
> >>
> >> * Does setting module parameter libata.force to "1.00:pio4" make any
> >> difference?
> >
> > Oh, never mind. I have a hunch. I'll report back in a while.
> >
>
> Does the attached patch fix the problem?

Yes, it does. Please push upstream.

Thanks,
Rafael

2008-03-11 02:32:18

by Tejun Heo

[permalink] [raw]
Subject: Re: [Regression] 2.6.25-rc4-git3: Handling of audio CDs broken on pata_ali

Rafael J. Wysocki wrote:
> On Monday, 10 of March 2008, Tejun Heo wrote:
>> Tejun Heo wrote:
>>> Tejun Heo wrote:
>>>> Rafael J. Wysocki wrote:
>>>>>>> where ata1 is:
>>>>>>>
>>>>>>> scsi0 : pata_ali
>>>>>>> scsi1 : pata_ali
>>>>>> Oh, is it only with audio CDs? I am unable to use DVD on pata_ali in DMA at
>>>>>> all. Have you tried to disable ATAPI DMA (libata.dma=1)?
>>>>> Data CDs seem to work fine here.
>>>> * Does booting into runlevel 1, putting in an audio cd and running
>>>> cdparanoia give the same result?
>>>>
>>>> * Does setting module parameter libata.force to "1.00:pio4" make any
>>>> difference?
>>> Oh, never mind. I have a hunch. I'll report back in a while.
>>>
>> Does the attached patch fix the problem?
>
> Yes, it does. Please push upstream.

Thanks for testing. Will do.


--
tejun