Comment 30 for bug 379831

Revision history for this message
Tom Pringle (thomas-b-pringle) wrote :

Is this the right place to file this problem?

Extracting part of the dmesg log file... You can see that the ATA logic appears to report lost interrupts during DMA operation which causes it to sequentially try slower DMA modes until it finally arrives at a PIO mode that works. This process appears to take approximately 40 seconds (boot time feels much longer).

After looking at this further, it is not clear to me that this is the same cause as the one which created this bug but merely the similar log dump text (exception Emask) and certainly the same symptom (delayed booting)

Perhaps forcing the device connected to ata7 to PIO from the start would work around this problem? Perhaps this can be configured in the bios. I will experiment this weekend.

[ 22.780016] ata7: lost interrupt (Status 0x7f)
[ 22.784002] ata7: drained 32768 bytes to clear DRQ.
[ 22.862739] ata7.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 22.862786] ata7.00: cmd a0/01:00:00:60:00/00:00:00:00:00/a0 tag 0 dma 96 in
[ 22.862787] cdb 12 00 00 00 60 00 00 00 00 00 00 00 00 00 00 00
[ 22.862788] res 40/00:02:00:24:00/00:00:00:00:00/a0 Emask 0x4 (timeout)
[ 22.862900] ata7.00: status: { DRDY }
[ 22.862956] ata7: soft resetting link
[ 23.096414] ata7.00: configured for UDMA/33
[ 23.096941] ata7: EH complete
[ 43.780021] ata7: lost interrupt (Status 0x7f)
[ 43.784002] ata7: drained 32768 bytes to clear DRQ.
[ 43.862744] ata7.00: limiting speed to UDMA/25:PIO4
[ 43.862746] ata7.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 43.862791] ata7.00: cmd a0/01:00:00:60:00/00:00:00:00:00/a0 tag 0 dma 96 in
[ 43.862792] cdb 12 00 00 00 60 00 00 00 00 00 00 00 00 00 00 00
[ 43.862793] res 40/00:02:00:24:00/00:00:00:00:00/a0 Emask 0x4 (timeout)
[ 43.862905] ata7.00: status: { DRDY }
[ 43.862961] ata7: soft resetting link
[ 44.096414] ata7.00: configured for UDMA/25
[ 44.096940] ata7: EH complete
[ 64.780019] ata7: lost interrupt (Status 0x7f)
[ 64.784002] ata7: drained 32768 bytes to clear DRQ.
[ 64.862741] ata7.00: limiting speed to PIO4
[ 64.862743] ata7.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[ 64.862788] ata7.00: cmd a0/01:00:00:60:00/00:00:00:00:00/a0 tag 0 dma 96 in
[ 64.862789] cdb 12 00 00 00 60 00 00 00 00 00 00 00 00 00 00 00
[ 64.862790] res 40/00:02:00:24:00/00:00:00:00:00/a0 Emask 0x4 (timeout)
[ 64.862902] ata7.00: status: { DRDY }
[ 64.862957] ata7: soft resetting link
[ 65.096414] ata7.00: configured for PIO4
[ 65.096942] ata7: EH complete