What happens if you use the usb-storage driver rather than the ub driver?
Ah, I didn't notice this was happening. I had to recompile my kernel and remove the ub module to get the usb-storage driver to work again. So now without the ehci driver loaded, the iPod does get detected and is mountable. I took this opportunity to throw some new music on the iPod, however, things went south after loading a few songs. Here is some stuff from the debug log:
Everything started out fine:
Oct 9 11:02:11 doolittle kernel: usb-storage: *** thread awakened.
Oct 9 11:02:11 doolittle kernel: usb-storage: Command WRITE_10 (10 bytes)
Oct 9 11:02:11 doolittle kernel: usb-storage: 2a 00 00 3f 91 73 00 00 10 00
Oct 9 11:02:11 doolittle kernel: usb-storage: Bulk Command S 0x43425355 T 0x195c L 8192 F 0 Trg 0 LUN 0 CL 10
Oct 9 11:02:11 doolittle kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
Oct 9 11:02:11 doolittle kernel: usb-storage: Status code 0; transferred 31/31
Oct 9 11:02:11 doolittle kernel: usb-storage: -- transfer complete
Oct 9 11:02:11 doolittle kernel: usb-storage: Bulk command transfer result=0
Oct 9 11:02:11 doolittle kernel: usb-storage: usb_stor_bulk_transfer_sglist: xfer 8192 bytes, 1 entries
Oct 9 11:02:11 doolittle kernel: usb-storage: Status code 0; transferred 8192/8192
Oct 9 11:02:11 doolittle kernel: usb-storage: -- transfer complete
Oct 9 11:02:11 doolittle kernel: usb-storage: Bulk data transfer result 0x0
Oct 9 11:02:11 doolittle kernel: usb-storage: Attempting to get CSW...
Oct 9 11:02:11 doolittle kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
Oct 9 11:02:11 doolittle kernel: usb-storage: Status code 0; transferred 13/13
Oct 9 11:02:11 doolittle kernel: usb-storage: -- transfer complete
Oct 9 11:02:11 doolittle kernel: usb-storage: Bulk status result = 0
Oct 9 11:02:11 doolittle kernel: usb-storage: Bulk Status S 0x53425355 T 0x195c R 0 Stat 0x0
Oct 9 11:02:11 doolittle kernel: usb-storage: scsi cmd done, result=0x0
Oct 9 11:02:11 doolittle kernel: usb-storage: *** thread sleeping.
Oct 9 11:02:11 doolittle kernel: usb-storage: queuecommand called
Oct 9 11:02:11 doolittle kernel: usb-storage: *** thread awakened.
Oct 9 11:02:11 doolittle kernel: usb-storage: Command WRITE_10 (10 bytes)
Oct 9 11:02:11 doolittle kernel: usb-storage: 2a 00 00 3f 91 83 00 00 70 00
Oct 9 11:02:11 doolittle kernel: usb-storage: Bulk Command S 0x43425355 T 0x195d L 57344 F 0 Trg 0 LUN 0 CL 10
Oct 9 11:02:11 doolittle kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
Oct 9 11:02:11 doolittle kernel: usb-storage: Status code 0; transferred 31/31
Oct 9 11:02:11 doolittle kernel: usb-storage: -- transfer complete
But then things went sour:
Oct 9 11:02:11 doolittle kernel: usb-storage: Bulk command transfer result=0
Oct 9 11:02:11 doolittle kernel: usb-storage: usb_stor_bulk_transfer_sglist: xfer 57344 bytes, 2 entries
Oct 9 11:02:11 doolittle kernel: usb-storage: Status code -75; transferred 19968/57344
Oct 9 11:02:11 doolittle kernel: usb-storage: -- babble
Oct 9 11:02:11 doolittle kernel: usb-storage: Bulk data transfer result 0x3
Oct 9 11:02:11 doolittle kernel: usb-storage: Attempting to get CSW...
Oct 9 11:02:11 doolittle kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
Oct 9 11:02:11 doolittle kernel: usb-storage: Status code -84; transferred 0/13
Oct 9 11:02:11 doolittle kernel: usb-storage: -- unknown error
Oct 9 11:02:11 doolittle kernel: usb-storage: Bulk status result = 4
Oct 9 11:02:11 doolittle kernel: usb-storage: -- transport indicates error, resetting
Oct 9 11:02:11 doolittle kernel: usb-storage: usb_stor_Bulk_reset called
Oct 9 11:02:11 doolittle kernel: usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
Oct 9 11:02:11 doolittle kernel: uhci_hcd 0000:00:1d.1: uhci_result_control: failed with status 440000
Oct 9 11:02:11 doolittle kernel: [f6869270] link (368691e2) element (330a6040)
Oct 9 11:02:11 doolittle kernel: 0: [f30a6040] link (330a6080) e0 Stalled CRC/Timeo Length=7 MaxLen=7 DT0 EndPt=0 Dev=6, PID=2d(SETUP) (buf=36e47020)
Oct 9 11:02:11 doolittle kernel: 1: [f30a6080] link (00000001) e3 IOC Active Length=0 MaxLen=7ff DT1 EndPt=0 Dev=6, PID=69(IN) (buf=00000000)
Oct 9 11:02:11 doolittle kernel:
Oct 9 11:02:11 doolittle kernel: usb-storage: Soft reset failed: -71
Oct 9 11:02:11 doolittle kernel: usb-storage: scsi cmd done, result=0x70000
Oct 9 11:02:11 doolittle kernel: usb-storage: *** thread sleeping.
Oct 9 11:02:11 doolittle kernel: usb-storage: queuecommand called
Oct 9 11:02:11 doolittle kernel: usb-storage: *** thread awakened.
Oct 9 11:02:11 doolittle kernel: usb-storage: Command WRITE_10 (10 bytes)
Oct 9 11:02:11 doolittle kernel: usb-storage: 2a 00 00 3f 91 83 00 00 70 00
Oct 9 11:02:11 doolittle kernel: usb-storage: Bulk Command S 0x43425355 T 0x195e L 57344 F 0 Trg 0 LUN 0 CL 10
Oct 9 11:02:11 doolittle kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
Oct 9 11:02:11 doolittle kernel: usb-storage: Status code -71; transferred 31/31
Oct 9 11:02:11 doolittle kernel: usb-storage: -- unknown error
Oct 9 11:02:11 doolittle kernel: usb-storage: Bulk command transfer result=4
Oct 9 11:02:11 doolittle kernel: usb-storage: -- transport indicates error, resetting
Oct 9 11:02:11 doolittle kernel: usb-storage: usb_stor_Bulk_reset called
Oct 9 11:02:11 doolittle kernel: usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
Oct 9 11:02:11 doolittle kernel: uhci_hcd 0000:00:1d.1: uhci_result_control: failed with status 440000
Oct 9 11:02:11 doolittle kernel: [f6869270] link (368691e2) element (330a6040)
Oct 9 11:02:11 doolittle kernel: 0: [f30a6040] link (330a6080) e0 Stalled CRC/Timeo Length=7 MaxLen=7 DT0 EndPt=0 Dev=6, PID=2d(SETUP) (buf=36e47020)
Oct 9 11:02:11 doolittle kernel: 1: [f30a6080] link (00000001) e3 IOC Active Length=0 MaxLen=7ff DT1 EndPt=0 Dev=6, PID=69(IN) (buf=00000000)
Oct 9 11:02:11 doolittle kernel:
Oct 9 11:02:11 doolittle kernel: usb-storage: Soft reset failed: -71
Oct 9 11:02:11 doolittle kernel: usb-storage: scsi cmd done, result=0x70000
Oct 9 11:02:11 doolittle kernel: usb-storage: *** thread sleeping.
Oct 9 11:02:11 doolittle kernel: usb-storage: queuecommand called
Oct 9 11:02:11 doolittle kernel: usb-storage: *** thread awakened.
Oct 9 11:02:11 doolittle kernel: usb-storage: Command WRITE_10 (10 bytes)
Oct 9 11:02:11 doolittle kernel: usb-storage: 2a 00 00 3f 91 83 00 00 70 00
Oct 9 11:02:11 doolittle kernel: usb-storage: Bulk Command S 0x43425355 T 0x195f L 57344 F 0 Trg 0 LUN 0 CL 10
Oct 9 11:02:11 doolittle kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
Oct 9 11:02:11 doolittle kernel: usb-storage: Status code -71; transferred 31/31
Oct 9 11:02:11 doolittle kernel: usb-storage: -- unknown error
Oct 9 11:02:11 doolittle kernel: usb-storage: Bulk command transfer result=4
Oct 9 11:02:11 doolittle kernel: usb-storage: -- transport indicates error, resetting
Oct 9 11:02:11 doolittle kernel: usb-storage: usb_stor_Bulk_reset called
Oct 9 11:02:11 doolittle kernel: usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
Oct 9 11:02:11 doolittle kernel: uhci_hcd 0000:00:1d.1: uhci_result_control: failed with status 440000
Oct 9 11:02:11 doolittle kernel: [f6869270] link (368691e2) element (330a6040)
Oct 9 11:02:11 doolittle kernel: 0: [f30a6040] link (330a6080) e0 Stalled CRC/Timeo Length=7 MaxLen=7 DT0 EndPt=0 Dev=6, PID=2d(SETUP) (buf=36e47020)
Oct 9 11:02:11 doolittle kernel: 1: [f30a6080] link (00000001) e3 IOC Active Length=0 MaxLen=7ff DT1 EndPt=0 Dev=6, PID=69(IN) (buf=00000000)
Oct 9 11:02:11 doolittle kernel:
And messages like this releated for a while. I also got this in my dmesg:
usb-storage: Command WRITE_10 (10 bytes)
usb-storage: 2a 00 00 3f 91 e4 00 00 0f 00
usb-storage: Bulk Command S 0x43425355 T 0x19c2 L 7680 F 0 Trg 0 LUN 0 CL 10
usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
usb-storage: Status code -71; transferred 31/31
usb-storage: -- unknown error
usb-storage: Bulk command transfer result=4
usb-storage: -- transport indicates error, resetting
usb-storage: usb_stor_Bulk_reset called
usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
uhci_hcd 0000:00:1d.1: port 2 portsc 008a
hub 2-0:1.0: port 2, status 0100, change 0003, 12 Mb/s
usb 2-2: USB disconnect, address 6
usb 2-2: usb_disable_device nuking all URBs
uhci_hcd 0000:00:1d.1: shutdown urb f4417f00 pipe 80000600 ep0out
usb-storage: Soft reset failed: -108
usb-storage: scsi cmd done, result=0x70000
usb-storage: *** thread sleeping.
usb 2-2: unregistering interface 2-2:1.0
usb-storage: storage_disconnect() called
usb-storage: usb_stor_stop_transport called
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 4166116
usb-storage: queuecommand called
scsi0 (0:0): rejecting I/O to device being removed
scsi0 (0:0): rejecting I/O to device being removed
scsi0 (0:0): rejecting I/O to device being removed
scsi0 (0:0): rejecting I/O to device being removed
scsi0 (0:0): rejecting I/O to device being removed
scsi0 (0:0): rejecting I/O to device being removed
scsi0 (0:0): rejecting I/O to device being removed
scsi0 (0:0): rejecting I/O to device being removed
scsi0 (0:0): rejecting I/O to device being removed
scsi0 (0:0): rejecting I/O to device being removed
usb-storage: *** thread awakened.
usb-storage: No command during disconnect
usb-storage: *** thread sleeping.
uhci_hcd 0000:00:1d.1: suspend_hc
uhci_hcd 0000:00:1d.1: wakeup_hc
usb-storage: command_abort called
usb-storage: -- nothing to abort
usb-storage: device_reset called
usb-storage: No reset during disconnect
usb-storage: bus_reset called
usb-storage: No reset during disconnect
scsi: Device offlined - not ready after error recovery: host 0 channel 0 id 0 lun 0
sd 0:0:0:0: Illegal state transition cancel->offline
Badness in scsi_device_set_state at drivers/scsi/scsi_lib.c:1688
[<f903fd99>] scsi_device_set_state+0xc9/0x120 [scsi_mod]
[<f903da3e>] scsi_eh_offline_sdevs+0x6e/0x90 [scsi_mod]
[<f903df13>] scsi_unjam_host+0xc3/0xd0 [scsi_mod]
[<f903dfc8>] scsi_error_handler+0xa8/0xd0 [scsi_mod]
[<f903df20>] scsi_error_handler+0x0/0xd0 [scsi_mod]
[<c010403d>] kernel_thread_helper+0x5/0x18
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 4166117
printk: 100 messages suppressed.
Buffer I/O error on device sda2, logical block 4085792
lost page write due to I/O error on sda2
usb-storage: queuecommand called
usb-storage: *** thread awakened.
usb-storage: No command during disconnect
usb-storage: *** thread sleeping.
usb-storage: command_abort called
usb-storage: -- nothing to abort
usb-storage: bus_reset called
usb-storage: No reset during disconnect
scsi: Device offlined - not ready after error recovery: host 0 channel 0 id 0 lun 0
sd 0:0:0:0: Illegal state transition cancel->offline
Badness in scsi_device_set_state at drivers/scsi/scsi_lib.c:1688
[<f903fd99>] scsi_device_set_state+0xc9/0x120 [scsi_mod]
[<f903da3e>] scsi_eh_offline_sdevs+0x6e/0x90 [scsi_mod]
[<f903df13>] scsi_unjam_host+0xc3/0xd0 [scsi_mod]
[<f903dfc8>] scsi_error_handler+0xa8/0xd0 [scsi_mod]
[<f903df20>] scsi_error_handler+0x0/0xd0 [scsi_mod]
[<c010403d>] kernel_thread_helper+0x5/0x18
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 4166118
Buffer I/O error on device sda2, logical block 4085793
lost page write due to I/O error on sda2
Badness in kref_get at lib/kref.c:32
[<c0201607>] kref_get+0x47/0x50
[<c02011ca>] kobject_get+0x1a/0x30
[<c0247bf8>] get_device+0x18/0x20
[<f903f455>] scsi_request_fn+0x25/0x3c0 [scsi_mod]
[<c024eb7c>] blk_insert_request+0xbc/0xe0
[<c024fea9>] __end_that_request_first+0xf9/0x240
[<f903e8e4>] scsi_requeue_command+0x44/0x60 [scsi_mod]
[<f903e9f6>] scsi_end_request+0x76/0xf0 [scsi_mod]
[<f903ee54>] scsi_io_completion+0x224/0x460 [scsi_mod]
[<f8fbe9da>] sd_rw_intr+0x5a/0x1e0 [sd_mod]
[<f903aa26>] scsi_finish_command+0x76/0xc0 [scsi_mod]
[<f903da4a>] scsi_eh_offline_sdevs+0x7a/0x90 [scsi_mod]
[<f903de1d>] scsi_eh_flush_done_q+0x7d/0xb0 [scsi_mod]
[<f903dedf>] scsi_unjam_host+0x8f/0xd0 [scsi_mod]
[<f903dfc8>] scsi_error_handler+0xa8/0xd0 [scsi_mod]
[<f903df20>] scsi_error_handler+0x0/0xd0 [scsi_mod]
[<c010403d>] kernel_thread_helper+0x5/0x18
Unable to handle kernel paging request at virtual address 00200200
printing eip:
f9041a30
*pde = 00000000
Oops: 0002 [#1]
PREEMPT
Modules linked in: sd_mod usb_storage scsi_mod radeon wlan_wep ath_pci wlan ath_hal ds irtty_sir sir_dev irda crc_ccitt ohci1394 ieee1394 yenta_socket pcmcia_core snd_intel8x0 snd_ac97_codec snd_pcm_oss snd_mixer_oss snd_pcm snd_timer snd_page_alloc snd_mpu401_uart snd_rawmidi snd_seq_device snd uhci_hcd evdev ntfs nvram intel_agp cpufreq_userspace speedstep_centrino freq_table e1000 rtc
CPU: 0
EIP: 0060:[<f9041a30>] Tainted: P VLI
EFLAGS: 00010002 (2.6.8.1.20041009)
EIP is at scsi_device_dev_release+0x30/0x120 [scsi_mod]
eax: 00100100 ebx: f6803c08 ecx: 00200200 edx: f6803d84
esi: f6803c00 edi: 00000296 ebp: c1fbd4b4 esp: f3059e0c
ds: 007b es: 007b ss: 0068
Process scsi_eh_0 (pid: 5496, threadinfo=f3058000 task=f461c560)
Stack: 00000000 f6803da8 c038bee8 c038bf00 c1fbd4d8 c02478db f6803d84 f6803da8
c038bee8 c038bf00 c0201278 f6803da8 f6803dc0 c0201280 f3058000 f3058000
c0201649 f6803da8 f3058000 f3058000 c024e016 f3058000 f6803c00 c02012af
Call Trace:
[<c02478db>] device_release+0x5b/0x60
[<c0201278>] kobject_cleanup+0x98/0xa0
[<c0201280>] kobject_release+0x0/0x10
[<c0201649>] kref_put+0x39/0xa0
[<c024e016>] blk_plug_device+0x56/0x90
[<c02012af>] kobject_put+0x1f/0x30
[<c0201280>] kobject_release+0x0/0x10
[<f903f645>] scsi_request_fn+0x215/0x3c0 [scsi_mod]
[<c024eb7c>] blk_insert_request+0xbc/0xe0
[<c024fea9>] __end_that_request_first+0xf9/0x240
[<f903e8e4>] scsi_requeue_command+0x44/0x60 [scsi_mod]
[<f903e9f6>] scsi_end_request+0x76/0xf0 [scsi_mod]
[<f903ee54>] scsi_io_completion+0x224/0x460 [scsi_mod]
[<f8fbe9da>] sd_rw_intr+0x5a/0x1e0 [sd_mod]
[<f903aa26>] scsi_finish_command+0x76/0xc0 [scsi_mod]
[<f903da4a>] scsi_eh_offline_sdevs+0x7a/0x90 [scsi_mod]
[<f903de1d>] scsi_eh_flush_done_q+0x7d/0xb0 [scsi_mod]
[<f903dedf>] scsi_unjam_host+0x8f/0xd0 [scsi_mod]
[<f903dfc8>] scsi_error_handler+0xa8/0xd0 [scsi_mod]
[<f903df20>] scsi_error_handler+0x0/0xd0 [scsi_mod]
[<c010403d>] kernel_thread_helper+0x5/0x18
Code: ec 04 8b 54 24 18 8b 6a 20 8d b2 7c fe ff ff 9c 5f fa b8 00 e0 ff ff 21 e0 ff 40 14 8d 9a 84 fe ff ff 8b 82 84 fe ff ff 8b 4b 04 <89> 01 89 48 04 b8 00 01 10 00 c7 43 04 00 02 20 00 8d 9a 8c fe
<6>note: scsi_eh_0[5496] exited with preempt_count 1
Badness in kref_get at lib/kref.c:32
[<c0201607>] kref_get+0x47/0x50
[<c02011ca>] kobject_get+0x1a/0x30
[<c0247bf8>] get_device+0x18/0x20
[<f903f455>] scsi_request_fn+0x25/0x3c0 [scsi_mod]
[<c024c396>] elv_next_request+0x16/0x110
[<c024e111>] __generic_unplug_device+0x41/0x50
[<c024e13e>] generic_unplug_device+0x1e/0x40
[<c024e1a0>] blk_unplug_work+0x10/0x20
[<c01287f9>] worker_thread+0x1d9/0x2a0
[<c024e190>] blk_unplug_work+0x0/0x20
[<c0115930>] default_wake_function+0x0/0x20
[<c0115930>] default_wake_function+0x0/0x20
[<c0128620>] worker_thread+0x0/0x2a0
[<c012c97a>] kthread+0xaa/0xb0
[<c012c8d0>] kthread+0x0/0xb0
[<c010403d>] kernel_thread_helper+0x5/0x18
Unable to handle kernel paging request at virtual address 00200200
printing eip:
f9041a30
*pde = 00000000
Oops: 0002 [#2]
PREEMPT
Modules linked in: sd_mod usb_storage scsi_mod radeon wlan_wep ath_pci wlan ath_hal ds irtty_sir sir_dev irda crc_ccitt ohci1394 ieee1394 yenta_socket pcmcia_core snd_intel8x0 snd_ac97_codec snd_pcm_oss snd_mixer_oss snd_pcm snd_timer snd_page_alloc snd_mpu401_uart snd_rawmidi snd_seq_device snd uhci_hcd evdev ntfs nvram intel_agp cpufreq_userspace speedstep_centrino freq_table e1000 rtc
CPU: 0
EIP: 0060:[<f9041a30>] Tainted: P VLI
EFLAGS: 00010002 (2.6.8.1.20041009)
EIP is at scsi_device_dev_release+0x30/0x120 [scsi_mod]
eax: 00100100 ebx: f6803c08 ecx: 00200200 edx: f6803d84
esi: f6803c00 edi: 00000282 ebp: c1fbd4b4 esp: c1f3fe98
ds: 007b es: 007b ss: 0068
Process kblockd/0 (pid: 27, threadinfo=c1f3e000 task=c1d37020)
Stack: 00000000 f6803da8 c038bee8 c038bf00 c1fbd4d8 c02478db f6803d84 f6803da8
c038bee8 c038bf00 c0201278 f6803da8 f6803dc0 c0201280 c1f3e000 c1f3e000
c0201649 f6803da8 c1f3e000 c1f3e000 c024e016 c1f3e000 f6803c00 c02012af
Call Trace:
[<c02478db>] device_release+0x5b/0x60
[<c0201278>] kobject_cleanup+0x98/0xa0
[<c0201280>] kobject_release+0x0/0x10
[<c0201649>] kref_put+0x39/0xa0
[<c024e016>] blk_plug_device+0x56/0x90
[<c02012af>] kobject_put+0x1f/0x30
[<c0201280>] kobject_release+0x0/0x10
[<f903f645>] scsi_request_fn+0x215/0x3c0 [scsi_mod]
[<c024c396>] elv_next_request+0x16/0x110
[<c024e111>] __generic_unplug_device+0x41/0x50
[<c024e13e>] generic_unplug_device+0x1e/0x40
[<c024e1a0>] blk_unplug_work+0x10/0x20
[<c01287f9>] worker_thread+0x1d9/0x2a0
[<c024e190>] blk_unplug_work+0x0/0x20
[<c0115930>] default_wake_function+0x0/0x20
[<c0115930>] default_wake_function+0x0/0x20
[<c0128620>] worker_thread+0x0/0x2a0
[<c012c97a>] kthread+0xaa/0xb0
[<c012c8d0>] kthread+0x0/0xb0
[<c010403d>] kernel_thread_helper+0x5/0x18
Code: ec 04 8b 54 24 18 8b 6a 20 8d b2 7c fe ff ff 9c 5f fa b8 00 e0 ff ff 21 e0 ff 40 14 8d 9a 84 fe ff ff 8b 82 84 fe ff ff 8b 4b 04 <89> 01 89 48 04 b8 00 01 10 00 c7 43 04 00 02 20 00 8d 9a 8c fe
<6>note: kblockd/0[27] exited with preempt_count 1
thanks again for your continued help, -steve
------------------------------------------------------- This SF.net email is sponsored by: IT Product Guide on ITManagersJournal Use IT products in your business? Tell us what you think of them. Give us Your Opinions, Get Free ThinkGeek Gift Certificates! Click to find out more http://productguide.itmanagersjournal.com/guidepromo.tmpl _______________________________________________ [EMAIL PROTECTED] To unsubscribe, use the last form field at: https://lists.sourceforge.net/lists/listinfo/linux-usb-devel
