[Paranoia] Cdparanoia stuck in blk_execute_rq

David Wake dwake at stanfordalumni.org
Tue Jan 18 00:53:55 PST 2005


I'm running Fedora Core 3 with kernel 2.6.9-1.667smp.  Whenever I'm
running cdparanoia to rip a CD track, and there's a problem, the
cdparanoia process goes into an uninterruptible sleep.  "ps" shows
that it's stuck in blk_execute_rq.  So far I have
only managed to kill the process by restarting my machine.


Output from "cdparanoia -Q":

--BEGIN OUPUT--
cdparanoia III release 9.8 (March 23, 2001)
(C) 2001 Monty <monty at xiph.org> and Xiphophorus

Report bugs to paranoia at xiph.org
http://www.xiph.org/paranoia/

Checking /dev/cdrom for cdrom...
	DMA scatter/gather table entries: 1
	table entry size: 131072 bytes
	maximum theoretical transfer: 55 sectors
	Setting default read size to 24 sectors (56448 bytes).


CDROM model sensed sensed: PIONEER DVD-ROM DVD-120S 1.01 


Checking for SCSI emulation...
	Drive is ATAPI (using SCSI host adaptor emulation)

Checking for MMC style command set...
	Drive is MMC style
Verifying CDDA command set...
	Expected command set reads OK.

Table of contents (audio tracks only):
track        length               begin        copy pre ch
===========================================================
  1.     5633 [01:15.08]        0 [00:00.00]    no   no  2
  2.     6917 [01:32.17]     5633 [01:15.08]    no   no  2
  3.    17970 [03:59.45]    12550 [02:47.25]    no   no  2
  4.     8160 [01:48.60]    30520 [06:46.70]    no   no  2
  5.    16740 [03:43.15]    38680 [08:35.55]    no   no  2
  6.     3893 [00:51.68]    55420 [12:18.70]    no   no  2
  7.    12065 [02:40.65]    59313 [13:10.63]    no   no  2
  8.    14175 [03:09.00]    71378 [15:51.53]    no   no  2
  9.     8232 [01:49.57]    85553 [19:00.53]    no   no  2
 10.     8960 [01:59.35]    93785 [20:50.35]    no   no  2
 11.     6913 [01:32.13]   102745 [22:49.70]    no   no  2
 12.    25897 [05:45.22]   109658 [24:22.08]    no   no  2
 13.     7333 [01:37.58]   135555 [30:07.30]    no   no  2
 14.    16487 [03:39.62]   142888 [31:45.13]    no   no  2
 15.    38140 [08:28.40]   159375 [35:25.00]    no   no  2
 16.    27760 [06:10.10]   197515 [43:53.40]    no   no  2
 17.    25518 [05:40.18]   225275 [50:03.50]    no   no  2
 18.    13370 [02:58.20]   250793 [55:43.68]    no   no  2
 19.    30430 [06:45.55]   264163 [58:42.13]    no   no  2
 20.     7550 [01:40.50]   294593 [65:27.68]    no   no  2
 21.    11155 [02:28.55]   302143 [67:08.43]    no   no  2
 22.    17500 [03:53.25]   313298 [69:37.23]    no   no  2
TOTAL  330798 [73:30.48]    (audio only)
--END OUPUT--

Output from "cdparanoia 21-21 /tmp/tmp_wavfile"

--BEGIN OUTPUT--
Ripping from sector  302143 (track 21 [0:00.00])
	  to sector  313297 (track 21 [2:28.54])

outputting to /tmp/tmp_wavfile

 (== PROGRESS == [   ++!!>                      O| 304894 00 ] == :-P O ==)   
Error reading command:  
	be 00 00 04 a7 8f 00 00  18 f8 00 00 
scsi_read error: sector=305039 length=24 retry=0
                 Sense key: 3 ASC: 11 ASCQ: 0
                 Transport error: Medium reading data from medium
                 System error: Input/output error
scsi_read error: sector=305039 length=24 retry=0
                 Sense key: 3 ASC: 11 ASCQ: 0
                 Transport error: Medium reading data from medium
                 System error: Input/output error
sending SG SCSI reset... FAILED: EBUSY
 (== PROGRESS == [   ++!!>                      0| 304894 00 ] == :-P 0 ==)   
Error reading command:  
	be 00 00 04 a7 49 00 00  18 f8 00 00 
scsi_read error: sector=304969 length=24 retry=0
                 Sense key: 3 ASC: 11 ASCQ: 0
                 Transport error: Medium reading data from medium
                 System error: Input/output error
scsi_read error: sector=304969 length=24 retry=0
                 Sense key: 3 ASC: 11 ASCQ: 0
                 Transport error: Medium reading data from medium
                 System error: Input/output error
sending SG SCSI reset... FAILED: EBUSY
[the above repeated countless times]
--END OUTPUT--

Output from /var/log/messages:

Jan 15 18:11:07 andromeda kernel: hda: DMA timeout retry
Jan 15 18:11:07 andromeda kernel: hda: timeout waiting for DMA
Jan 15 18:11:07 andromeda kernel: hda: status error: status=0x58 { DriveReady SeekComplete DataRequest }
Jan 15 18:11:07 andromeda kernel: hda: status error: error=0x00
Jan 15 18:11:07 andromeda kernel: hda: drive not ready for command
Jan 15 18:11:34 andromeda ntpd[2661]: synchronized to 192.5.41.41, stratum 1
Jan 15 18:14:29 andromeda kernel: hda: DMA timeout retry
Jan 15 18:14:29 andromeda kernel: hda: timeout waiting for DMA
Jan 15 18:14:29 andromeda kernel: hda: status error: status=0x58 { DriveReady SeekComplete DataRequest }
Jan 15 18:14:29 andromeda kernel: hda: status error: error=0x00
Jan 15 18:14:29 andromeda kernel: hda: drive not ready for command
Jan 15 18:14:46 andromeda kernel: hda: DMA timeout retry
Jan 15 18:14:46 andromeda kernel: hda: timeout waiting for DMA
Jan 15 18:14:46 andromeda kernel: hda: status error: status=0x58 { DriveReady SeekComplete DataRequest }
Jan 15 18:14:46 andromeda kernel: hda: status error: error=0x00
Jan 15 18:14:46 andromeda kernel: hda: drive not ready for command
[etcetera...]

Many thanks for any suggestions.

David



More information about the Paranoia mailing list