ripping with cdparanoia option yields "DMA timeout retry" error

William Norfleet <williamnorfleet2000-/[email protected]> Sat, 14 Jul 2007 13:51:04 -0400
Newsgroups gmane.comp.multimedia.grip.user
Message-ID <[email protected]>
I can't seem to get grip to rip from an internal IDE drive using the "grip (cdparanoia)" 
and "cdparanoia" options. At times grip will rip normally, but usually not.  Grip always 
works fine with an external USB dvd drive.  Cdparanoia works fine with this internal drive 
when run from the command line. The drive in question works fine with all other applications.

Some notes on observed behavior with a commercially produced CD in excellent condition:

drive behavior: spins incessantly
grip display behavior: indicates no ripping progress
desktop behavior:  extremely sluggish

grip-3.2.0-16.fc5  Fedora Core 5 up to date as of this date, AMD Duran 1.3 GHz cpu, 1 GB 
memory. SCSI emulation is not implemented, at least by me, and I see no evidence that it 
is set.

dmesg output when grip fails to rip:
hdd: DMA timeout retry
hdd: timeout waiting for DMA
hdd: status timeout: status=0xd0 { Busy }
ide: failed opcode was: unknown
hdd: drive not ready for command
BUG: soft lockup detected on CPU#0!
  [<c0441250>] softlockup_tick+0x90/0xa1
  [<c04245aa>] update_process_times+0x33/0x55
  [<c0406d85>] timer_interrupt+0x62/0x95
  [<c04414bd>] handle_IRQ_event+0x1a/0x3f
  [<c044272b>] handle_level_irq+0x83/0xcc
  [<c04426a8>] handle_level_irq+0x0/0xcc
  [<c0405e54>] do_IRQ+0xae/0xd6
  [<c04caa02>] end_that_request_last+0x7c/0x8d
  [<c0404763>] common_interrupt+0x23/0x28
  [<c05586c7>] ide_inb+0x3/0x7
  [<c05596e0>] ide_wait_stat+0x98/0xf5
  [<c05578c4>] ide_do_request+0x3de/0x8cb
  [<c0441f72>] default_enable+0x12/0x1b
  [<c0441f2a>] check_irq_resend+0x12/0x48
  [<c0441c86>] enable_irq+0x92/0xb0
  [<c055de69>] __ide_dma_test_irq+0x15/0x47
  [<c055df87>] __ide_dma_end+0x50/0x74
  [<c055dd7b>] __ide_dma_host_off+0x3b/0x41
  [<c0558548>] ide_timer_expiry+0x23f/0x254
  [<c0558309>] ide_timer_expiry+0x0/0x254
  [<c0423b68>] run_timer_softirq+0xef/0x14b
  [<c0420a92>] __do_softirq+0x35/0x75
  [<c0405d4e>] do_softirq+0x3e/0x96
  [<c04426a8>] handle_level_irq+0x0/0xcc
  [<c0405e65>] do_IRQ+0xbf/0xd6
  [<c0404763>] common_interrupt+0x23/0x28
  [<c0402c58>] default_idle+0x27/0x39
  [<c041247c>] apm_cpu_idle+0x199/0x1ef
  [<c0402317>] cpu_idle+0x39/0x4e
  [<c06e076f>] start_kernel+0x313/0x317
  [<c06e025a>] unknown_bootoption+0x0/0x202
  =======================
hdd: status timeout: status=0xd0 { Busy }
ide: failed opcode was: unknown
hdd: drive not ready for command
hdd: status timeout: status=0xd0 { Busy }
ide: failed opcode was: unknown
hdd: drive not ready for command
hdd: status timeout: status=0xd0 { Busy }
ide: failed opcode was: unknown
hdd: drive not ready for command

cdparanoia output:
[bill@desk paranoia]$ cdparanoia -d /dev/dvd -B "1-"
cdparanoia III release 9.8 (March 23, 2001)
(C) 2001 Monty <monty-zeIfkxP3e/[email protected]> and Xiphophorus

Report bugs to paranoia-zeIfkxP3e/[email protected]
http://www.xiph.org/paranoia/

Checking /dev/dvd 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: IDE DVD-ROM 16X 2.40

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.     5615 [01:14.65]        0 [00:00.00]    no   no  2
   2.    18617 [04:08.17]     5615 [01:14.65]    no   no  2
   3.    25025 [05:33.50]    24232 [05:23.07]    no   no  2
   4.    13695 [03:02.45]    49257 [10:56.57]    no   no  2
   5.    22870 [05:04.70]    62952 [13:59.27]    no   no  2
   6.    19075 [04:14.25]    85822 [19:04.22]    no   no  2
   7.    19495 [04:19.70]   104897 [23:18.47]    no   no  2
   8.    25795 [05:43.70]   124392 [27:38.42]    no   no  2
   9.    18163 [04:02.13]   150187 [33:22.37]    no   no  2
  10.    18022 [04:00.22]   168350 [37:24.50]    no   no  2
  11.    17953 [03:59.28]   186372 [41:24.72]    no   no  2
  12.    19105 [04:14.55]   204325 [45:24.25]    no   no  2
  13.    18447 [04:05.72]   223430 [49:39.05]    no   no  2
  14.    21785 [04:50.35]   241877 [53:45.02]    no   no  2
  15.    14548 [03:13.73]   263662 [58:35.37]    no   no  2
TOTAL  278210 [61:49.35]    (audio only)

Ripping from sector       0 (track  1 [0:00.00])
           to sector  278209 (track 15 [3:13.72])

outputting to track01.cdda.wav

  (== PROGRESS == [   >                          | 000492 00 ] == :^D o ==)

Any ideas?

-------------------------------------------------------------------------
This SF.net email is sponsored by DB2 Express
Download DB2 Express C - the FREE version of DB2 express and take
control of your XML. No limits. Just data. Click to get it now.
http://sourceforge.net/powerbar/db2/