Re: Problems burning CDs with ASUS P5B-E/atapi race condition?

From: Christian Gusenbauer <c47g_at_gmx.at>
Date: Mon, 2 Apr 2007 19:48:14 +0200
Hi!

Playing a bit with the ATA debug options, I get the following traces:

acd0: WARNING - TEST_UNIT_READY freeing taskqueue zombie requesacd0: 
req=0xc54590c0 PREVENT_ALLOW interrupt

this looks like a race condition, because printing one text is interrupted by 
another one, coming out of the ata driver. Or did I miss something?

I attach part of the log. Complete log's available on request.

Many thanks,
Christian.

(probe0:ata4:0:0:0): INQUIRY. CDB: 12 1 80 0 ff 0 
atapi_action: hcb_at_0xc5468280: 12 1 80 0 ff 0 
acd0: WARNING - TEST_UNIT_READY taskqueue timeout - completing request 
directly
acd0: req=0xc54590c0 PREVENT_ALLOW queued
acd0: req=0xc54590c0 PREVENT_ALLOW wait for completion
acd0: req=0xc5459000 SETFEATURES SET TRANSFER MODE begin transaction
acd0: req=0xc5459000 SETFEATURES SET TRANSFER MODE wait for completion
acd0: req=0xc5459000 SETFEATURES SET TRANSFER MODE interrupt
acd0: req=0xc5459000 SETFEATURES SET TRANSFER MODE end transaction
acd0: req=0xc5459000 SETFEATURES SET TRANSFER MODE finish directly
acd0: req=0xc5459000 SETFEATURES SET TRANSFER MODE completed entered
acd0: req=0xc5459000 SETFEATURES SET TRANSFER MODE completed callback/wakeup
acd0: req=0xc5459000 SETFEATURES SET TRANSFER MODE begin transaction
acd0: req=0xc5459000 SETFEATURES SET TRANSFER MODE wait for completion
acd0: req=0xc5459000 SETFEATURES SET TRANSFER MODE interrupt
acd0: req=0xc5459000 SETFEATURES SET TRANSFER MODE end transaction
acd0: req=0xc5459000 SETFEATURES SET TRANSFER MODE finish directly
acd0: req=0xc5459000 SETFEATURES SET TRANSFER MODE completed entered
acd0: req=0xc5459000 SETFEATURES SET TRANSFER MODE completed callback/wakeup
(noperiph:ata4:0:-1:-1): xpt_async
(noperiph:ata4:0:0:0): xpt_compile_path
(noperiph:ata4:0:0:0): xpt_release_path
acd0: FAILURE - INQUIRY timed out
atapi_cb: hcb_at_0xc5468280 sense = 00: sk = 0
acd0: cmd INQUIRY status 00 result 05 error 00
(probe0:ata4:0:0:0): xpt_done
(probe0:ata4:0:0:0): camisr
(probe0:ata4:0:0:0): probedone
(probe0:ata4:0:0:0): xpt_action
(probe0:ata4:0:0:0): INQUIRY. CDB: 12 1 80 0 ff 0 
atapi_action: hcb_at_0xc5468100: 12 1 80 0 ff 0 
acd0: req=0xc54590c0 PREVENT_ALLOW starting
acd0: req=0xc54590c0 PREVENT_ALLOW begin transaction
acd0: WARNING - TEST_UNIT_READY freeing taskqueue zombie requesacd0: 
req=0xc54590c0 PREVENT_ALLOW interrupt
acd0: req=0xc54590c0 PREVENT_ALLOW end transaction
acd0: req=0xc54590c0 PREVENT_ALLOW finish taskqueue_swi
t
acd0: req=0xc54590c0 PREVENT_ALLOW completed entered
acd0: req=0xc54590c0 REQUEST_SENSE autoissue request sense
acd0: req=0xc54590c0 REQUEST_SENSE queued
acd0: req=0xc54590c0 REQUEST_SENSE starting
acd0: req=0xc54590c0 REQUEST_SENSE begin transaction
acd0: req=0xc54590c0 REQUEST_SENSE interrupt
acd0: req=0xc54590c0 REQUEST_SENSE end transaction
acd0: req=0xc54590c0 PREVENT_ALLOW interrupt
acd0: req=0xc54590c0 PREVENT_ALLOW end transaction
acd0: req=0xc54590c0 PREVENT_ALLOW finish taskqueue_swi
acd0: req=0xc54590c0 PREVENT_ALLOW completed entered
acd0: req=0xc54590c0 PREVENT_ALLOW completed callback/wakeup
acd0: req=0xc54593c0 TEST_UNIT_READY queued
acd0: req=0xc54593c0 TEST_UNIT_READY wait for completion
acd0: req=0xc5459480 SETFEATURES SET TRANSFER MODE begin transaction
acd0: req=0xc5459480 SETFEATURES SET TRANSFER MODE wait for completion
acd0: req=0xc5459480 SETFEATURES SET TRANSFER MODE interrupt
acd0: req=0xc5459480 SETFEATURES SET TRANSFER MODE end transaction
acd0: req=0xc5459480 SETFEATURES SET TRANSFER MODE finish directly
acd0: req=0xc5459480 SETFEATURES SET TRANSFER MODE completed entered
acd0: req=0xc5459480 SETFEATURES SET TRANSFER MODE completed callback/wakeup
acd0: req=0xc5459540 SETFEATURES SET TRANSFER MODE begin transaction
acd0: req=0xc5459540 SETFEATURES SET TRANSFER MODE wait for completion
acd0: req=0xc5459540 SETFEATURES SET TRANSFER MODE interrupt
acd0: req=0xc5459540 SETFEATURES SET TRANSFER MODE end transaction
acd0: req=0xc5459540 SETFEATURES SET TRANSFER MODE finish directly
acd0: req=0xc5459540 SETFEATURES SET TRANSFER MODE completed entered
acd0: req=0xc5459540 SETFEATURES SET TRANSFER MODE completed callback/wakeup
(noperiph:ata4:0:-1:-1): xpt_async
(noperiph:ata4:0:0:0): xpt_compile_path
(noperiph:ata4:0:0:0): xpt_release_path
acd0: req=0xc54593c0 TEST_UNIT_READY starting
acd0: req=0xc54593c0 TEST_UNIT_READY begin transaction
acd0: FAILURE - INQUIRY timed outacd0: req=0xc54593c0 TEST_UNIT_READY 
interrupt
acd0: req=0xc54593c0 TEST_UNIT_READY end transaction
acd0: req=0xc54593c0 TEST_UNIT_READY finish taskqueue_swi

atapi_cb: hcb_at_0xc5468100 sense = 00: sk = 0
acd0: cmd INQUIRY status 00 result 05 error 00
(probe0:ata4:0:0:0): xpt_done
(probe0:ata4:0:0:0): camisr
(probe0:ata4:0:0:0): probedone
(probe0:ata4:0:0:0): xpt_action
(probe0:ata4:0:0:0): INQUIRY. CDB: 12 1 80 0 ff 0 
atapi_action: hcb_at_0xc54680c0: 12 1 80 0 ff 0 
acd0: req=0xc54593c0 TEST_UNIT_READY completed entered
acd0: req=0xc54593c0 REQUEST_SENSE autoissue request sense
acd0: req=0xc54593c0 REQUEST_SENSE queued


On Friday, 30. March 2007, Christian Gusenbauer wrote:
> Hi!
>
> I'm having some problems burning CDs and DVDs with -current on a
> new ASUS P5B-E board with an Intel Core 2 Duo. The IDE DVD drive, a Plextor
> PX708A is connected to the JMicron JMB363 controller.
>
> First of all, there's a problem detecting the atapicam based cd0 device. As
> long as hw.ata.atapi_dma is set to 1, the boot hangs while the kernel
> searches for the device. Many commands time out like:
>
> (probe0:ata4:0:0:0): xpt_schedule
> (probe0:ata4:0:0:0): xpt_setup_ccb
> (probe0:ata4:0:0:0): probestart
> (probe0:ata4:0:0:0): xpt_action
> (probe0:ata4:0:0:0): INQUIRY. CDB: 12 1 80 0 ff 0
> atapi_action: hcb_at_0xc4a47c80: 12 1 80 0 ff 0
> (noperiph:ata4:0:-1:-1): xpt_async
> (noperiph:ata4:0:0:0): xpt_compile_path
> (noperiph:ata4:0:0:0): xpt_release_path
> acd0: FAILURE - INQUIRY timed out
> atapi_cb: hcb_at_0xc4a47c80 sense = 00: sk = 0
> acd0: cmd INQUIRY status 00 result 05 error 00
> (probe0:ata4:0:0:0): xpt_done
> (probe0:ata4:0:0:0): camisr
> (probe0:ata4:0:0:0): probedone
> (probe0:ata4:0:0:0): xpt_action
> (probe0:ata4:0:0:0): INQUIRY. CDB: 12 1 80 0 ff 0
> atapi_action: hcb_at_0xc4a47c40: 12 1 80 0 ff 0
> acd0: WARNING - TEST_UNIT_READY taskqueue timeout - completing request
> directly
> (noperiph:ata4:0:-1:-1): xpt_async
> (noperiph:ata4:0:0:0): xpt_compile_path
> (noperiph:ata4:0:0:0): xpt_release_path
> acd0: FAILURE - INQUIRY timed out
> atapi_cb: hcb_at_0xc4a47c40 sense = 00: sk = 0
> acd0: cmd INQUIRY status 00 result 05 error 00
> (probe0:ata4:0:0:0): xpt_done
>
> Nevertheless, after about 20 minutes both devices, an acd0 and a cd0 are
> recognized. I can mount a CD using both acd0 and cd0 and reading from the
> CD is no problem. But when I try to burn a CD or DVD with burncd or
> cdrecord, after a while the drive's LED stops blinking and the process then
> hangs indefinitly.
>
> If I turn dma off (hw.ata.atapi_dma="0" setting in loader.conf), the drives
> are correctly detected and there are no hangs (no timeouts) during boot.
> Mounting and reading from the CD is no problem, but burning doesn't work
> either :-(.
>
> Any ideas?
>
> Thanks in advance,
> Christian.



Received on Mon Apr 02 2007 - 15:47:50 UTC

This archive was generated by hypermail 2.4.0 : Wed May 19 2021 - 11:39:07 UTC