Hi

I have Diva mp3 player. It works flawlessly with my Acer TravelMate 201T
under linux, both with build in memory and with 32MB Jenoptik CF card
from my digital camera. Lately I bought a Viking 256MB CF card and
during transfer of files to the card cp, usb-storage-0, scsi-eh-0 fall
into uninterruptible sleep. This problem is hardly reproducible:
sometimes it happens after few kB, sometimes after dozens of MB and once
I managed to fill whole 256 MB without problems. As it was right after I
had recompiled the kernel with increased timeout option, I thought that
was a solution. Unfortunately, next transfer was unsuccesful again.

Any ideas or should I simply wait for 2.4.21 to see if it will get
resolved in general usb mass storage improvement?

Cheers

Raf

I run Debian sarge. Here is output from ver_linux script:

Linux harpi 2.4.20 #1 thu feb 13 17:57:32 GMT 2003 i686 Celeron
(Coppermine) GenuineIntel GNU/Linux
 
Gnu C                  2.95.4
Gnu make               3.79.1
util-linux             2.11n
mount                  2.11n
modutils               2.4.19
e2fsprogs              1.30-WIP
pcmcia-cs              3.1.33
PPP                    2.4.1
Linux C Library        2.3.1
Dynamic linker (ldd)   2.3.1
Procps                 2.0.7
Net-tools              1.60
Console-tools          0.2.3
Sh-utils               4.5.2
Modules Loaded         usb-storage ppp_deflate zlib_inflate zlib_deflate
bsd_comp ppp_async ppp_generic slhc mach64 serial_cs ds i82365
pcmcia_core snd-seq-oss snd-seq-midi-event snd-seq snd-seq-device
snd-pcm-oss snd-mixer-oss snd-ali5451 snd-pcm snd-timer snd-ac97-codec
snd nls_cp437 sd_mod scsi_mod vfat fat nls_iso8859-1 nls_iso8859-2 rtc

Here is relevant part of /proc/iomem:

82400000-82400fff : Acer Laboratories Inc. [ALi] USB 1.1 Controller
  82400000-82400fff : usb-ohci

And here output from lspci -vvv:

00:14.0 USB Controller: Acer Laboratories Inc. [ALi] USB 1.1 Controller
(rev 03) (prog-if 10 [OHCI])
        Subsystem: Acer Incorporated [ALI]: Unknown device 1010
        Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop-
ParErr- Stepping- SERR- FastB2B-
        Status: Cap+ 66Mhz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort-
<TAbort- <MAbort- >SERR- <PERR-
        Latency: 32 (20000ns max), cache line size 08
        Interrupt: pin A routed to IRQ 11
        Region 0: Memory at 82400000 (32-bit, non-prefetchable)
[size=4K]
        Capabilities: [60] Power Management version 2
                Flags: PMEClk- DSI- D1- D2- AuxCurrent=0mA
PME(D0-,D1-,D2-,D3hot-,D3cold-)
                Status: D0 PME-Enable- DSel=0 DScale=0 PME-

/proc/scsi/scsi:

Attached devices: 
Host: scsi0 Channel: 00 Id: 00 Lun: 00
  Vendor: DIVA USB Model: Media Reader     Rev: 2.21
  Type:   Direct-Access                    ANSI SCSI revision: 02

/proc/scsi/usb-storage-0/0:

   Host scsi0: usb-storage
       Vendor: Unknown
      Product: Unknown
Serial Number: None
     Protocol: Transparent SCSI
    Transport: Bulk
         GUID: 357969010000000000000000
     Attached: Yes

/proc/bus/usb/devices:

T:  Bus=01 Lev=00 Prnt=00 Port=00 Cnt=00 Dev#=  1 Spd=12  MxCh= 2
B:  Alloc=  0/900 us ( 0%), #Int=  0, #Iso=  0
D:  Ver= 1.10 Cls=09(hub  ) Sub=00 Prot=00 MxPS= 8 #Cfgs=  1
P:  Vendor=0000 ProdID=0000 Rev= 0.00
S:  Product=USB OHCI Root Hub
S:  SerialNumber=c881a000
C:* #Ifs= 1 Cfg#= 1 Atr=40 MxPwr=  0mA
I:  If#= 0 Alt= 0 #EPs= 1 Cls=09(hub  ) Sub=00 Prot=00 Driver=hub
E:  Ad=81(I) Atr=03(Int.) MxPS=   2 Ivl=255ms
T:  Bus=01 Lev=01 Prnt=01 Port=00 Cnt=01 Dev#=  3 Spd=12  MxCh= 0
D:  Ver= 1.00 Cls=00(>ifc ) Sub=00 Prot=00 MxPS=16 #Cfgs=  1
P:  Vendor=3579 ProdID=6901 Rev= 1.00
C:* #Ifs= 1 Cfg#= 1 Atr=e0 MxPwr=100mA
I:  If#= 0 Alt= 0 #EPs= 2 Cls=08(stor.) Sub=06 Prot=50
Driver=usb-storage
E:  Ad=82(I) Atr=02(Bulk) MxPS=  64 Ivl=0ms
E:  Ad=02(O) Atr=02(Bulk) MxPS=  64 Ivl=0ms

And here is the relevant part of syslog:

Connecting device:

Feb 21 18:11:29 harpi kernel: hub.c: port 1, portstatus 300, change 1,
1.5 Mb/s
Feb 21 18:11:29 harpi kernel: hub.c: port 1 connection change
Feb 21 18:11:29 harpi kernel: hub.c: port 1, portstatus 300, change 1,
1.5 Mb/s
Feb 21 18:11:29 harpi kernel: hub.c: port 2, portstatus 100, change 0,
12 Mb/s
Feb 21 18:11:32 harpi kernel: hub.c: port 1, portstatus 101, change 1,
12 Mb/s
Feb 21 18:11:32 harpi kernel: hub.c: port 1 connection change
Feb 21 18:11:32 harpi kernel: hub.c: port 1, portstatus 101, change 1,
12 Mb/s
Feb 21 18:11:32 harpi kernel: hub.c: port 1, portstatus 101, change 0,
12 Mb/s
Feb 21 18:11:32 harpi last message repeated 3 times
Feb 21 18:11:32 harpi kernel: hub.c: port 1, portstatus 103, change 10,
12 Mb/s
Feb 21 18:11:32 harpi kernel: hub.c: new USB device 00:14.0-1, assigned
address 2
Feb 21 18:11:33 harpi kernel: usb.c: kmalloc IF c7b0ec20, numif 1
Feb 21 18:11:33 harpi kernel: usb.c: new device strings: Mfr=0,
Product=0, SerialNumber=0
Feb 21 18:11:33 harpi kernel: usb.c: unhandled interfaces on device
Feb 21 18:11:33 harpi kernel: usb.c: USB device 2 (vend/prod
0x3579/0x6901) is not claimed by any active driver.
Feb 21 18:11:33 harpi kernel:   Length              = 18
Feb 21 18:11:33 harpi kernel:   DescriptorType      = 01
Feb 21 18:11:33 harpi kernel:   USB version         = 1.00
Feb 21 18:11:33 harpi kernel:   Vendor:Product      = 3579:6901
Feb 21 18:11:33 harpi kernel:   MaxPacketSize0      = 16
Feb 21 18:11:33 harpi kernel:   NumConfigurations   = 1
Feb 21 18:11:33 harpi kernel:   Device version      = 1.00
Feb 21 18:11:33 harpi kernel:   Device Class:SubClass:Protocol =
00:00:00
Feb 21 18:11:33 harpi kernel:     Per-interface classes
Feb 21 18:11:33 harpi kernel: Configuration:
Feb 21 18:11:33 harpi kernel:   bLength             =    9
Feb 21 18:11:33 harpi kernel:   bDescriptorType     =   02
Feb 21 18:11:33 harpi kernel:   wTotalLength        = 0020
Feb 21 18:11:33 harpi kernel:   bNumInterfaces      =   01
Feb 21 18:11:33 harpi kernel:   bConfigurationValue =   01
Feb 21 18:11:33 harpi kernel:   iConfiguration      =   00
Feb 21 18:11:33 harpi kernel:   bmAttributes        =   e0
Feb 21 18:11:33 harpi kernel:   MaxPower            =  100mA
Feb 21 18:11:33 harpi kernel: 
Feb 21 18:11:33 harpi kernel:   Interface: 0
Feb 21 18:11:33 harpi kernel:   Alternate Setting:  0
Feb 21 18:11:33 harpi kernel:     bLength             =    9
Feb 21 18:11:33 harpi kernel:     bDescriptorType     =   04
Feb 21 18:11:33 harpi kernel:     bInterfaceNumber    =   00
Feb 21 18:11:33 harpi kernel:     bAlternateSetting   =   00
Feb 21 18:11:33 harpi kernel:     bNumEndpoints       =   02
Feb 21 18:11:33 harpi kernel:     bInterface Class:SubClass:Protocol =  
08:06:5
0
Feb 21 18:11:33 harpi kernel:     iInterface          =   00
Feb 21 18:11:33 harpi kernel:     Endpoint:
Feb 21 18:11:33 harpi kernel:       bLength             =    7
Feb 21 18:11:33 harpi kernel:       bDescriptorType     =   05
Feb 21 18:11:33 harpi kernel:       bEndpointAddress    =   82 (in)
Feb 21 18:11:33 harpi kernel:       bmAttributes        =   02 (Bulk)
Feb 21 18:11:33 harpi kernel:       wMaxPacketSize      = 0040
Feb 21 18:11:33 harpi kernel:       bInterval           =   00
Feb 21 18:11:33 harpi kernel:     Endpoint:
Feb 21 18:11:33 harpi kernel:       bLength             =    7
Feb 21 18:11:33 harpi kernel:       bDescriptorType     =   05
Feb 21 18:11:33 harpi kernel:       bEndpointAddress    =   02 (out)
Feb 21 18:11:33 harpi kernel:       bmAttributes        =   02 (Bulk)
Feb 21 18:11:33 harpi kernel:       wMaxPacketSize      = 0040
Feb 21 18:11:33 harpi kernel:       bInterval           =   00
Feb 21 18:11:33 harpi kernel: usb.c: kusbd: /sbin/hotplug add 2
Feb 21 18:11:33 harpi kernel: hub.c: port 2, portstatus 100, change 0,
12 Mb/s
Feb 21 18:11:33 harpi /sbin/hotplug: arguments (usb) env
(DEVFS=/proc/bus/usb OLDPWD=/ PATH=/bin:/sbin:/usr/sbin:/usr/bin
ACTION=add PWD=/etc/hotplug SHLVL=1 HOME=/ DEVICE=/proc/bus/usb/001/002
INTERFACE=8/6/80 PRODUCT=3579/6901/100 TYPE=0/0/0 DEBUG=kernel
_=/usr/bin/env)
Feb 21 18:11:33 harpi /sbin/hotplug: invoke /etc/hotplug/usb.agent ()
Feb 21 18:11:36 harpi /etc/hotplug/usb.agent: Setup usb-storage for USB
product 3579/6901/100
Feb 21 18:11:37 harpi kernel: Initializing USB Mass Storage driver...
Feb 21 18:11:37 harpi kernel: usb.c: registered new driver usb-storage
Feb 21 18:11:37 harpi kernel: usb-storage: act_altsettting is 0
Feb 21 18:11:37 harpi kernel: usb-storage: id_index calculated to be: 66
Feb 21 18:11:37 harpi kernel: usb-storage: Array length appears to be:
68
Feb 21 18:11:37 harpi kernel: usb-storage: USB Mass Storage device
detected
Feb 21 18:11:37 harpi kernel: usb-storage: Endpoints: In: 0xc074a720
Out: 0xc074a734 Int: 0x00000000 (Period 0)
Feb 21 18:11:37 harpi kernel: usb-storage: New GUID
357969010000000000000000
Feb 21 18:11:37 harpi kernel: usb-storage: GetMaxLUN command result is
-32, data
 is 128
Feb 21 18:11:37 harpi kernel: usb-storage: clearing endpoint halt for
pipe 0x800
00280
Feb 21 18:11:40 harpi kernel: usb_control/bulk_msg: timeout
Feb 21 18:11:40 harpi kernel: usb-storage: Transport: Bulk
Feb 21 18:11:40 harpi kernel: usb-storage: Protocol: Transparent SCSI
Feb 21 18:11:40 harpi kernel: usb-storage: *** thread sleeping.
Feb 21 18:11:40 harpi kernel: scsi0 : SCSI emulation for USB Mass
Storage devices



Then copying goes happily for some time until:


Feb 21 18:15:16 harpi kernel: usb-storage: Bulk data transfer result 0x0
Feb 21 18:15:16 harpi kernel: usb-storage: Attempting to get CSW...
Feb 21 18:15:16 harpi kernel: usb-storage: Bulk status result = 0
Feb 21 18:15:16 harpi kernel: usb-storage: Bulk status Sig 0x53425355 T
0x359 R 0 Stat 0x0
Feb 21 18:15:16 harpi kernel: usb-storage: scsi cmd done, result=0x0
Feb 21 18:15:16 harpi kernel: usb-storage: *** thread sleeping.
Feb 21 18:15:16 harpi kernel: usb-storage: queuecommand() called
Feb 21 18:15:16 harpi kernel: usb-storage: *** thread awakened.
Feb 21 18:15:16 harpi kernel: usb-storage: Command WRITE_10 (10 bytes)
Feb 21 18:15:16 harpi kernel: usb-storage: 2a 00 00 00 20 1e 00 00 10 00
00 00
Feb 21 18:15:16 harpi kernel: usb-storage: Bulk command S 0x43425355 T
0x35a Trg 0 LUN 0 L 8192 F 0 CL 10
Feb 21 18:15:16 harpi kernel: usb-storage: Bulk command transfer
result=0
Feb 21 18:15:16 harpi kernel: usb-storage: usb_stor_transfer_partial():
xfer 4096 bytes
Feb 21 18:15:16 harpi kernel: usb-storage: usb_stor_bulk_msg() returned
0 xferred 4096/4096
Feb 21 18:15:16 harpi kernel: usb-storage: usb_stor_transfer_partial():
transfer complete
Feb 21 18:15:16 harpi kernel: usb-storage: usb_stor_transfer_partial():
xfer 4096 bytes
Feb 21 18:15:45 harpi pppd[1416]: sent [LCP EchoReq id=0xb
magic=0x2f1a7334]
Feb 21 18:15:45 harpi pppd[1416]: rcvd [LCP EchoRep id=0xb
magic=0x79df168b]
Feb 21 18:15:46 harpi kernel: usb-storage: command_abort() called
Feb 21 18:15:46 harpi kernel: usb-storage: usb_stor_bulk_msg() returned
-104 xferred 256/4096
Feb 21 18:15:46 harpi kernel: usb-storage: usb_stor_transfer_partial():
unknown error
Feb 21 18:15:46 harpi kernel: usb-storage: Bulk data transfer result 0x2
Feb 21 18:15:46 harpi kernel: usb-storage: Attempting to get CSW...


and here it hangs, no more messages appear until I unplug the player.

Disconnecting of course doesn't help and fails:


Feb 21 18:52:25 harpi kernel: usb-storage: Bulk status result = -110
Feb 21 18:52:25 harpi kernel: usb-storage: -- transport indicates error,
resetti
ng
Feb 21 18:52:25 harpi kernel: usb-storage: Bulk reset requested
Feb 21 18:52:25 harpi kernel: usb-storage: Bulk soft reset failed -110
Feb 21 18:52:25 harpi kernel: usb-storage: scsi cmd done, result=0x70000
Feb 21 18:52:25 harpi kernel: usb-storage: *** thread sleeping.
Feb 21 18:52:25 harpi kernel: hub.c: port 1, portstatus 100, change 3,
12 Mb/s
Feb 21 18:52:25 harpi kernel: hub.c: port 1 connection change
Feb 21 18:52:25 harpi kernel: hub.c: port 1, portstatus 100, change 3,
12 Mb/s
Feb 21 18:52:25 harpi kernel: usb.c: USB disconnect on device 00:14.0-1
address 
2
Feb 21 18:52:25 harpi kernel: usb-storage: storage_disconnect() called
Feb 21 18:52:25 harpi kernel: usb-storage: -- releasing main URB
Feb 21 18:52:25 harpi kernel: usb-storage: -- usb_unlink_urb() returned
-19
Feb 21 18:52:25 harpi kernel: usb.c: kusbd: /sbin/hotplug remove 2
Feb 21 18:52:25 harpi kernel: hub.c: port 2, portstatus 100, change 0,
12 Mb/s
Feb 21 18:52:25 harpi /sbin/hotplug: arguments (usb) env
(DEVFS=/proc/bus/usb OLDPWD=/ PATH=/bin:/sbin:/usr/sbin:/usr/bin
ACTION=remove PWD=/etc/hotplug SHLVL=1 HOME=/
DEVICE=/proc/bus/usb/001/002 INTERFACE=8/6/80 PRODUCT=3579/6901/100
TYPE=0/0/0 DEBUG=kernel _=/usr/bin/env)
Feb 21 18:52:25 harpi /sbin/hotplug: invoke /etc/hotplug/usb.agent ()
Feb 21 18:52:25 harpi kernel: hub.c: port 1, portstatus 100, change 2,
12 Mb/s
Feb 21 18:52:25 harpi kernel: hub.c: port 1 enable change, status 100
Feb 21 18:52:25 harpi kernel: hub.c: port 2, portstatus 100, change 0,
12 Mb/s




-- 

Rafal Czarnocki

[EMAIL PROTECTED]

"I look from the window at the plane you are staging
 And I'm sitting here doing nothing but ageing
 While my guitar gently weeps"


-------------------------------------------------------
This SF.net email is sponsored by: SlickEdit Inc. Develop an edge.
The most comprehensive and flexible code editor you can use.
Code faster. C/C++, C#, Java, HTML, XML, many more. FREE 30-Day Trial.
www.slickedit.com/sourceforge
_______________________________________________
[EMAIL PROTECTED]
To unsubscribe, use the last form field at:
https://lists.sourceforge.net/lists/listinfo/linux-usb-users

Reply via email to