Problem with libata-pata, ATAPI DVD reader and a "copy-protected"audio cd

From: GhePeU
Date: Sat Mar 03 2007 - 06:00:52 EST

Next message: Evgeniy Polyakov: "Re: [patch 00/13] Syslets, "Threadlets", generic AIO support, v3"
Previous message: Ihar `Philips` Filipau: "Re: [patch 00/13] Syslets, "Threadlets", generic AIO support, v3"
Next in thread: GhePeU: "Re: Problem with libata-pata, ATAPI DVD reader and a"copy-protected" audio cd"
Messages sorted by: [ date ] [ thread ] [ subject ] [ author ]

Hello,

when kernel 2.6.20 was released I switched to the new libata-pata
infrastructure for my EIDE hard disk and ATAPI dvd-reader.

Until yesterday I didn't have any problem, then I tried to play an audio
CD and my media player hanged. Looking to the logs, I found that the DVD
reader (a Toshiba SD-M1612) was having problems reading the disk and
that the kernel dropped its speed from UDMA/33 to PIO3 before I could
eject the CD. Attached to this mail are the relevant lines of the system
log.

After a careful scrutiny of the box, I noticed that the disk was one of
those "Copy protected" non-standard CD. With the old ide driver I could
play and rip the CD without problems, so from a user point of view this
is a regression.

Besides, with the reduced speed the DVD reader was almost unusable, and
since the new libata layer doesn't support forcing the driver speed with
hdparm, I had to reboot the machine.

So my questions are:

1) it is possible to implement a command to force re-detection of the
better transfer mode available? I suppose that by unloading and
reloading the module, the transfer mode should become again the better
available, but when the driver is compiled in-kernel, this is not
possible.

2) is there a way to access copy protected audio CD again? the only
change here was ide -> libata, so there has to be some difference in the
error handling of the two layer that caused this pseudo-regression.

Thank you in advance

Giacomo

PS. I'm not subscribed to the list. I'm going to regularly check the
archives in the next days to see if there are responses, CC me if you
can. Thank you.

SCSI subsystem initialized
libata version 2.00 loaded.
sata_nv 0000:00:07.0: version 3.2
sata_nv 0000:00:07.0: Using ADMA mode
ata1: SATA max UDMA/133 cmd 0xF0804480 ctl 0xF08044A0 bmdma 0xD400 irq 16
ata2: SATA max UDMA/133 cmd 0xF0804580 ctl 0xF08045A0 bmdma 0xD408 irq 16
scsi0 : sata_nv
ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
ata1.00: ATA-7, max UDMA/133, 312581808 sectors: LBA48 NCQ (depth 31/32)
ata1.00: ata1: dev 0 multi count 16
ata1.00: configured for UDMA/133
scsi 0:0:0:0: Direct-Access ATA WDC WD1600JS-22N 10.0 PQ: 0 ANSI: 5
ata1: bounce limit 0xFFFFFFFFFFFFFFFF, segment boundary 0xFFFFFFFF, hw segs 61
SCSI device sda: 312581808 512-byte hdwr sectors (160042 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: write cache: enabled, read cache: enabled, doesn't support DPO or FUA
SCSI device sda: 312581808 512-byte hdwr sectors (160042 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: write cache: enabled, read cache: enabled, doesn't support DPO or FUA
sda: sda1 sda2 < sda5 sda6 sda7 sda8 sda9 >
sd 0:0:0:0: Attached scsi disk sda
sd 0:0:0:0: Attached scsi generic sg0 type 0
sata_nv 0000:00:08.0: Using ADMA mode
ata3: SATA max UDMA/133 cmd 0xF0806480 ctl 0xF08064A0 bmdma 0xC000 irq 17
ata4: SATA max UDMA/133 cmd 0xF0806580 ctl 0xF08065A0 bmdma 0xC008 irq 17
scsi2 : sata_nv
ata3: SATA link down (SStatus 0 SControl 300)
scsi3 : sata_nv
ata4: SATA link down (SStatus 0 SControl 300)
pata_amd 0000:00:06.0: version 0.2.7
ata5: PATA max UDMA/133 cmd 0x1F0 ctl 0x3F6 bmdma 0xE800 irq 14
ata6: PATA max UDMA/133 cmd 0x170 ctl 0x376 bmdma 0xE808 irq 15
scsi4 : pata_amd
ata5.00: ATA-6, max UDMA/100, 156301488 sectors: LBA
ata5.00: ata5: dev 0 multi count 16
ata5.01: ATA-5, max UDMA/133, 78177792 sectors: LBA
ata5.01: ata5: dev 1 multi count 16
ata5.00: configured for UDMA/100
ata5.01: configured for UDMA/133
scsi5 : pata_amd
ata6.00: ATAPI, max UDMA/66
ata6.01: ATAPI, max UDMA/33
ata6.00: configured for UDMA/66
ata6.01: configured for UDMA/33
scsi 4:0:0:0: Direct-Access ATA WDC WD800JB-00FM 13.0 PQ: 0 ANSI: 5
SCSI device sdb: 156301488 512-byte hdwr sectors (80026 MB)
sdb: Write Protect is off
sdb: Mode Sense: 00 3a 00 00
SCSI device sdb: write cache: enabled, read cache: enabled, doesn't support DPO or FUA
SCSI device sdb: 156301488 512-byte hdwr sectors (80026 MB)
sdb: Write Protect is off
sdb: Mode Sense: 00 3a 00 00
SCSI device sdb: write cache: enabled, read cache: enabled, doesn't support DPO or FUA
sdb: sdb1 sdb2 < sdb5 sdb6 sdb7 sdb8 >
sd 4:0:0:0: Attached scsi disk sdb
sd 4:0:0:0: Attached scsi generic sg1 type 0
scsi 4:0:1:0: Direct-Access ATA MAXTOR 6L040J2 A93. PQ: 0 ANSI: 5
SCSI device sdc: 78177792 512-byte hdwr sectors (40027 MB)
sdc: Write Protect is off
sdc: Mode Sense: 00 3a 00 00
SCSI device sdc: write cache: enabled, read cache: enabled, doesn't support DPO or FUA
SCSI device sdc: 78177792 512-byte hdwr sectors (40027 MB)
sdc: Write Protect is off
sdc: Mode Sense: 00 3a 00 00
SCSI device sdc: write cache: enabled, read cache: enabled, doesn't support DPO or FUA
sdc: sdc1
sd 4:0:1:0: Attached scsi disk sdc
sd 4:0:1:0: Attached scsi generic sg2 type 0
scsi 5:0:0:0: CD-ROM PIONEER DVD-RW DVR-111D 1.23 PQ: 0 ANSI: 5
sr0: scsi3-mmc drive: 40x/40x writer cd/rw xa/form2 cdda tray
Uniform CD-ROM driver Revision: 3.20
sr 5:0:0:0: Attached scsi CD-ROM sr0
sr 5:0:0:0: Attached scsi generic sg3 type 5
scsi 5:0:1:0: CD-ROM TOSHIBA DVD-ROM SD-M1612 1806 PQ: 0 ANSI: 5
sr1: scsi3-mmc drive: 40x/48x cd/rw xa/form2 cdda tray
sr 5:0:1:0: Attached scsi CD-ROM sr1
sr 5:0:1:0: Attached scsi generic sg4 type 5

...

ata6.01: qc timeout (cmd 0xa0)
ata6.01: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata6.01: (BMDMA stat 0x65)
ata6.01: cmd a0/01:00:00:00:00/00:00:00:00:00/b0 tag 0 cdb 0x28 data 16384 in
res 51/51:03:00:00:00/00:00:00:00:00/b0 Emask 0x5 (timeout)
ata6: soft resetting port
ata6.00: configured for UDMA/66
ata6.01: configured for UDMA/33
ata6: EH complete
ata6.01: 8096 bytes trailing data
ata6.01: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata6.01: (BMDMA stat 0x65)
ata6.01: cmd a0/01:00:00:00:00/00:00:00:00:00/b0 tag 0 cdb 0x28 data 16384 in
res 51/51:03:00:00:00/00:00:00:00:00/b0 Emask 0x3 (HSM violation)
ata6: soft resetting port
ata6.00: configured for UDMA/66
ata6.01: configured for UDMA/33
ata6: EH complete
ata6.01: qc timeout (cmd 0xa0)
ata6.01: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata6.01: (BMDMA stat 0x65)
ata6.01: cmd a0/01:00:00:00:00/00:00:00:00:00/b0 tag 0 cdb 0x28 data 16384 in
res 51/51:03:00:00:00/00:00:00:00:00/b0 Emask 0x5 (timeout)
ata6: soft resetting port
ata6.00: configured for UDMA/66
ata6.01: configured for UDMA/33
ata6: EH complete
ata6.01: qc timeout (cmd 0xa0)
ata6.01: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata6.01: (BMDMA stat 0x65)
ata6.01: cmd a0/01:00:00:00:00/00:00:00:00:00/b0 tag 0 cdb 0x28 data 16384 in
res 51/51:03:00:00:00/00:00:00:00:00/b0 Emask 0x5 (timeout)
ata6: soft resetting port
ata6.00: configured for UDMA/66
ata6.01: configured for UDMA/33
sr 5:0:1:0: SCSI error: return code = 0x08000002
sr1: Current [descriptor]: sense key=0x3
ASC=0x13 ASCQ=0x0
Descriptor sense data with sense descriptors (in hex):
72 03 13 00 00 00 00 0e 09 0c 00 51 00 03 00 00
00 00 00 00 b0 51
end_request: I/O error, dev sr1, sector 0
Buffer I/O error on device sr1, logical block 0
Buffer I/O error on device sr1, logical block 1
Buffer I/O error on device sr1, logical block 2
Buffer I/O error on device sr1, logical block 3
ata6: EH complete
ata6.01: 8096 bytes trailing data
ata6.01: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata6.01: (BMDMA stat 0x65)
ata6.01: cmd a0/01:00:00:00:00/00:00:00:00:00/b0 tag 0 cdb 0x28 data 4096 in
res 51/51:03:00:00:00/00:00:00:00:00/b0 Emask 0x3 (HSM violation)
ata6: soft resetting port
ata6.00: configured for UDMA/66
ata6.01: configured for UDMA/33
ata6: EH complete
ata6.01: qc timeout (cmd 0xa0)
ata6.01: limiting speed to UDMA/25
ata6.01: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata6.01: (BMDMA stat 0x65)
ata6.01: cmd a0/01:00:00:00:00/00:00:00:00:00/b0 tag 0 cdb 0x28 data 4096 in
res 51/51:03:00:00:00/00:00:00:00:00/b0 Emask 0x5 (timeout)
ata6: soft resetting port
ata6.00: configured for UDMA/66
ata6.01: configured for UDMA/25
ata6: EH complete
ata6.01: qc timeout (cmd 0xa0)
ata6.01: limiting speed to UDMA/16
ata6.01: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata6.01: (BMDMA stat 0x65)
ata6.01: cmd a0/01:00:00:00:00/00:00:00:00:00/b0 tag 0 cdb 0x28 data 4096 in
res 51/51:03:00:00:00/00:00:00:00:00/b0 Emask 0x5 (timeout)
ata6: soft resetting port
ata6.00: configured for UDMA/66
ata6.01: configured for UDMA/16
ata6: EH complete
ata6.01: 8096 bytes trailing data
ata6.01: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata6.01: (BMDMA stat 0x65)
ata6.01: cmd a0/01:00:00:00:00/00:00:00:00:00/b0 tag 0 cdb 0x28 data 4096 in
res 51/51:03:00:00:00/00:00:00:00:00/b0 Emask 0x3 (HSM violation)
ata6: soft resetting port
ata6.00: configured for UDMA/66
ata6.01: configured for UDMA/16
sr 5:0:1:0: SCSI error: return code = 0x08000002
sr1: Current [descriptor]: sense key=0x3
ASC=0x13 ASCQ=0x0
Descriptor sense data with sense descriptors (in hex):
72 03 13 00 00 00 00 0e 09 0c 00 51 00 03 00 00
00 00 00 00 b0 51
end_request: I/O error, dev sr1, sector 0
Buffer I/O error on device sr1, logical block 0
ata6: EH complete
ata6.01: limiting speed to PIO4
ata6.01: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata6.01: cmd a0/00:00:00:00:20/00:00:00:00:00/b0 tag 0 cdb 0x1b data 0
res 40/00:03:00:00:20/00:00:00:00:00/b0 Emask 0x4 (timeout)
ata6: soft resetting port
ata6.00: configured for UDMA/66
ata6.01: configured for PIO4
ata6: EH complete
ata6.01: limiting speed to PIO3
ata6.01: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
ata6.01: cmd a0/00:00:00:00:20/00:00:00:00:00/b0 tag 0 cdb 0x1b data 0
res 40/00:03:00:00:20/00:00:00:00:00/b0 Emask 0x4 (timeout)
ata6: soft resetting port
ata6.00: configured for UDMA/66
ata6.01: configured for PIO3
ata6: EH complete

Next message: Evgeniy Polyakov: "Re: [patch 00/13] Syslets, "Threadlets", generic AIO support, v3"
Previous message: Ihar `Philips` Filipau: "Re: [patch 00/13] Syslets, "Threadlets", generic AIO support, v3"
Next in thread: GhePeU: "Re: Problem with libata-pata, ATAPI DVD reader and a"copy-protected" audio cd"
Messages sorted by: [ date ] [ thread ] [ subject ] [ author ]