Hi
I tried use my toshiba usb cdrom in linux, but no sucess. There is a
strange long delay after device insertion and before it initializes. lsmod
shows, that usb-storage is in state "initializing". here are some logs
too...
Sorry for long mail, usb debug logs are somewhat long, i hope, taht they
are useful for debugging. If some more information is needed, please ask.
Thanks :)
Taavi Tuisk
Toshiba Mobile CD-ROM PCMCIA Premium 2793020
USB Cable REV.HW035/FW930
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.00 Cls=09(hub ) Sub=00 Prot=00 MxPS= 8 #Cfgs= 1
P: Vendor=0000 ProdID=0000 Rev= 0.00
S: Product=USB UHCI Root Hub
S: SerialNumber=ff80
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= 8 Ivl=255ms
T: Bus=01 Lev=01 Prnt=01 Port=00 Cnt=01 Dev#= 2 Spd=12 MxCh= 0
D: Ver= 1.10 Cls=ff(vend.) Sub=00 Prot=00 MxPS=64 #Cfgs= 1
P: Vendor=07ab ProdID=fc01 Rev= 9.30
S: Manufacturer=Freecom
S: Product=US�-IDE Rev 930
C:* #Ifs= 1 Cfg#= 1 Atr=00 MxPwr=400mA
I: If#= 0 Alt= 0 #EPs= 2 Cls=00(>ifc ) Sub=00 Prot=00 Driver=usb-storage
E: Ad=81(I) Atr=02(Bulk) MxPS= 64 Ivl= 0ms
E: Ad=02(O) Atr=02(Bulk) MxPS= 64 Ivl= 0ms
Linux version 2.4.12 ([EMAIL PROTECTED]) (gcc version 2.96 20000731 (Red Hat Linux 7.1
2.96-85)) #5 Tue Oct 16 14:53:18 EET 2001
BIOS-provided physical RAM map:
BIOS-e820: 0000000000000000 - 000000000009fc00 (usable)
BIOS-e820: 000000000009fc00 - 00000000000a0000 (reserved)
BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved)
BIOS-e820: 0000000000100000 - 0000000007fe0000 (usable)
BIOS-e820: 0000000007fe0000 - 0000000007ff0000 (ACPI data)
BIOS-e820: 0000000007ff0000 - 0000000008000000 (reserved)
BIOS-e820: 00000000100a0000 - 00000000100b6e00 (reserved)
BIOS-e820: 00000000100b6e00 - 00000000100b7000 (ACPI NVS)
BIOS-e820: 00000000100b7000 - 0000000010100000 (reserved)
BIOS-e820: 00000000fff80000 - 0000000100000000 (reserved)
On node 0 totalpages: 32736
zone(0): 4096 pages.
zone(1): 28640 pages.
zone(2): 0 pages.
Kernel command line: BOOT_IMAGE=linux ro root=302 BOOT_FILE=/boot/vmlinuz-2.4.12
Initializing CPU#0
Detected 497.561 MHz processor.
Console: colour VGA+ 80x25
Calibrating delay loop... 992.87 BogoMIPS
Memory: 127132k/130944k available (778k kernel code, 3424k reserved, 206k data, 180k
init, 0k highmem)
Dentry-cache hash table entries: 16384 (order: 5, 131072 bytes)
Inode-cache hash table entries: 8192 (order: 4, 65536 bytes)
Mount-cache hash table entries: 2048 (order: 2, 16384 bytes)
Buffer-cache hash table entries: 4096 (order: 2, 16384 bytes)
Page-cache hash table entries: 32768 (order: 5, 131072 bytes)
CPU: Before vendor init, caps: 0383f9ff 00000000 00000000, vendor = 0
CPU: L1 I cache: 16K, L1 D cache: 16K
CPU: L2 cache: 256K
Intel machine check architecture supported.
Intel machine check reporting enabled on CPU#0.
CPU: After vendor init, caps: 0383f9ff 00000000 00000000 00000000
CPU: After generic, caps: 0383f9ff 00000000 00000000 00000000
CPU: Common caps: 0383f9ff 00000000 00000000 00000000
CPU: Intel Pentium III (Coppermine) stepping 01
Enabling fast FPU save and restore... done.
Enabling unmasked SIMD FPU exception support... done.
Checking 'hlt' instruction... OK.
POSIX conformance testing by UNIFIX
mtrr: v1.40 (20010327) Richard Gooch ([EMAIL PROTECTED])
mtrr: detected mtrr type: Intel
PCI: PCI BIOS revision 2.10 entry at 0xfed9b, last bus=21
PCI: Using configuration type 1
PCI: Probing PCI hardware
Unknown bridge resource 0: assuming transparent
Unknown bridge resource 2: assuming transparent
PCI: Using IRQ router PIIX [8086/7110] at 00:05.0
PCI: Found IRQ 11 for device 00:0b.0
PCI: Found IRQ 11 for device 00:0b.1
Limiting direct PCI/PCI transfers.
Linux NET4.0 for Linux 2.4
Based upon Swansea University Computer Society NET3.039
apm: BIOS version 1.2 Flags 0x02 (Driver version 1.14)
Starting kswapd
pty: 256 Unix98 ptys configured
Toshiba System Managment Mode driver v1.9 22/3/2001
Serial driver version 5.05c (2001-07-08) with MANY_PORTS SHARE_IRQ SERIAL_PCI enabled
ttyS00 at 0x03f8 (irq = 4) is a 16550A
Real Time Clock Driver v1.10e
block: 128 slots per queue, batch=16
Uniform Multi-Platform E-IDE driver Revision: 6.31
ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx
PIIX4: IDE controller on PCI bus 00 dev 29
PIIX4: chipset revision 1
PIIX4: not 100% native mode: will probe irqs later
ide0: BM-DMA at 0xfff0-0xfff7, BIOS settings: hda:DMA, hdb:pio
ide1: BM-DMA at 0xfff8-0xffff, BIOS settings: hdc:pio, hdd:pio
hda: IBM-DARA-206000, ATA DISK drive
ide0 at 0x1f0-0x1f7,0x3f6 on irq 14
hda: 11733120 sectors (6007 MB) w/418KiB Cache, CHS=730/255/63, UDMA(33)
Partition check:
hda: hda1 hda2 hda3 < hda5 >
Linux Kernel Card Services 3.1.22
options: [pci] [cardbus] [pm]
PCI: Found IRQ 11 for device 00:0b.0
PCI: Found IRQ 11 for device 00:0b.1
NET4: Linux TCP/IP 1.0 for NET4.0
IP Protocols: ICMP, UDP, TCP
IP: routing cache hash table of 512 buckets, 4Kbytes
TCP: Hash tables configured (established 8192 bind 8192)
NET4: Unix domain sockets 1.0/SMP for Linux NET4.0.
Yenta IRQ list 06b0, PCI irq11
Socket status: 30000007
Yenta IRQ list 06b0, PCI irq11
Socket status: 30000007
VFS: Mounted root (ext2 filesystem) readonly.
Freeing unused kernel memory: 180k freed
Adding Swap: 136512k swap-space (priority -1)
usb.c: registered new driver usbdevfs
usb.c: registered new driver hub
usb-uhci.c: $Revision: 1.268 $ time 15:02:19 Oct 16 2001
usb-uhci.c: High bandwidth mode enabled
PCI: Found IRQ 11 for device 00:05.2
PCI: Sharing IRQ 11 with 00:0c.0
usb-uhci.c: USB UHCI at I/O 0xff80, IRQ 11
usb-uhci.c: Detected 2 ports
usb.c: new USB bus registered, assigned bus number 1
usb.c: kmalloc IF c7bb42c0, numif 1
usb.c: new device strings: Mfr=0, Product=2, SerialNumber=1
usb.c: USB device number 1 default language ID 0x0
Product: USB UHCI Root Hub
SerialNumber: ff80
hub.c: USB hub found
hub.c: 2 ports detected
hub.c: standalone hub
hub.c: ganged power switching
hub.c: global over-current protection
hub.c: Port indicators are not supported
hub.c: power on to power good time: 2ms
hub.c: hub controller current requirement: 0mA
hub.c: port removable status: RR
hub.c: local power source is good
hub.c: no over-current condition exists
hub.c: enabling power on all ports
usb.c: hub driver claimed interface c7bb42c0
usb.c: kusbd: /sbin/hotplug add 1
usb-uhci.c: v1.268:USB Universal Host Controller Interface driver
cs: IO port probe 0x0c00-0x0cff: clean.
cs: IO port probe 0x0100-0x04ff: excluding 0x170-0x177 0x370-0x37f 0x4d0-0x4d7
cs: IO port probe 0x0a00-0x0aff: clean.
hub.c: port 1 connection change
hub.c: port 1, portstatus 101, change 1, 12 Mb/s
hub.c: port 1, portstatus 103, change 0, 12 Mb/s
hub.c: USB new device connect on bus1/1, assigned device number 2
usb.c: kmalloc IF c1353540, numif 1
usb.c: new device strings: Mfr=1, Product=2, SerialNumber=0
usb.c: USB device number 2 default language ID 0x409
Manufacturer: Freecom
Product: US�-IDE Rev 930
usb.c: unhandled interfaces on device
usb.c: USB device 2 (vend/prod 0x7ab/0xfc01) is not claimed by any active driver.
Length = 18
DescriptorType = 01
USB version = 1.10
Vendor:Product = 07ab:fc01
MaxPacketSize0 = 64
NumConfigurations = 1
Device version = 9.30
Device Class:SubClass:Protocol = ff:00:00
Vendor class
Configuration:
bLength = 9
bDescriptorType = 02
wTotalLength = 0020
bNumInterfaces = 01
bConfigurationValue = 01
iConfiguration = 02
bmAttributes = 00
MaxPower = 400mA
Interface: 0
Alternate Setting: 0
bLength = 9
bDescriptorType = 04
bInterfaceNumber = 00
bAlternateSetting = 00
bNumEndpoints = 02
bInterface Class:SubClass:Protocol = 00:00:00
iInterface = 02
Endpoint:
bLength = 7
bDescriptorType = 05
bEndpointAddress = 81 (in)
bmAttributes = 02 (Bulk)
wMaxPacketSize = 0040
bInterval = 00
Endpoint:
bLength = 7
bDescriptorType = 05
bEndpointAddress = 02 (out)
bmAttributes = 02 (Bulk)
wMaxPacketSize = 0040
bInterval = 00
usb.c: kusbd: /sbin/hotplug add 2
SCSI subsystem driver Revision: 1.00
Initializing USB Mass Storage driver...
usb.c: registered new driver usb-storage
usb-storage: act_altsettting is 0
usb-storage: id_index calculated to be: 31
usb-storage: Array length appears to be: 55
usb-storage: Vendor: Freecom
usb-storage: Product: USB-IDE
usb-storage: USB Mass Storage device detected
usb-storage: Endpoints: In: 0xc74c1320 Out: 0xc74c1334 Int: 0x00000000 (Period 0)
usb-storage: New GUID 07abfc010000000000000000
usb-storage: Transport: Freecom
usb-storage: Protocol: QIC-157
usb-storage: String returned from FC init is: Freecom USB Device I001X048R930
usb-storage: IDE out 0x06 <- 0xa0
usb-storage: IDE out 0x01 <- 0x00
usb-storage: IDE in 0x17 -> 0x51
usb-storage: IDE out 0x07 <- 0x08
usb-storage: IDE in 0x17 -> 0x51
usb-storage: IDE out 0x08 <- 0x08
usb-storage: *** thread sleeping.
scsi0 : SCSI emulation for USB Mass Storage devices
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Command INQUIRY (6 bytes)
usb-storage: 12 00 00 00 ff 00 00 00 00 86 32 c7
usb-storage: Freecom TRANSPORT STARTED
usb-storage: 00000000: 12 00 00 00 ff 00 00 00 - 00 00 00 00 -
............
usb-storage: foo Status result 0 4
usb-storage: 00000000: 4a 02 24 00 - J.$.
usb-storage: Device indicates that it has 36 bytes available
usb-storage: SCSI requested 255
usb-storage: Read data Freecom! (c=36)
usb-storage: Done issuing read request: 0 64
usb-storage: Start of read
usb-storage: usb_stor_transfer_partial(): xfer 36 bytes
usb-storage: usb_stor_bulk_msg() returned 0 xferred 36/36
usb-storage: usb_stor_transfer_partial(): transfer complete
usb-storage: freecom_readdata done!
usb-storage: FCM: Waiting for status
usb-storage: 00000000: 52 03 24 00 - R.$.
usb-storage: Transfer happy
usb-storage: Fixing INQUIRY data to show SCSI rev 2
usb-storage: scsi cmd done, result=0x0
usb-storage: *** thread sleeping.
Vendor: TEAC Model: CD-224E Rev: 1.6A
Type: CD-ROM ANSI SCSI revision: 02
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Bad target number (1/0)
usb-storage: *** thread sleeping.
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Bad target number (2/0)
usb-storage: *** thread sleeping.
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Bad target number (3/0)
usb-storage: *** thread sleeping.
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Bad target number (4/0)
usb-storage: *** thread sleeping.
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Bad target number (5/0)
usb-storage: *** thread sleeping.
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Bad target number (6/0)
usb-storage: *** thread sleeping.
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Bad target number (7/0)
usb-storage: *** thread sleeping.
WARNING: USB Mass Storage data integrity not assured
USB Mass Storage device found at 2
usb.c: usb-storage driver claimed interface c1353540
USB Mass Storage support registered.
Attached scsi CD-ROM sr0 at scsi0, channel 0, id 0, lun 0
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Command MODE_SENSE (6 bytes)
usb-storage: 1a 00 2a 00 80 00 00 00 3a 00 00 00
usb-storage: Freecom TRANSPORT STARTED
usb-storage: 00000000: 1a 00 2a 00 80 00 00 00 - 00 00 00 00 -
..*.........
usb-storage: foo Status result 0 4
usb-storage: 00000000: 53 03 ff ff - S...
usb-storage: operation failed
usb-storage: -- transport indicates command failure
usb-storage: Issuing auto-REQUEST_SENSE
usb-storage: Freecom TRANSPORT STARTED
usb-storage: 00000000: 03 00 00 00 12 00 00 00 - 00 00 00 00 -
............
usb-storage: foo Status result 0 4
usb-storage: 00000000: 4a 02 12 00 - J...
usb-storage: Device indicates that it has 18 bytes available
usb-storage: SCSI requested 18
usb-storage: Read data Freecom! (c=18)
usb-storage: Done issuing read request: 0 64
usb-storage: Start of read
usb-storage: usb_stor_transfer_partial(): xfer 18 bytes
usb-storage: usb_stor_bulk_msg() returned 0 xferred 18/18
usb-storage: usb_stor_transfer_partial(): transfer complete
usb-storage: freecom_readdata done!
usb-storage: FCM: Waiting for status
usb-storage: 00000000: 52 03 12 00 - R...
usb-storage: Transfer happy
usb-storage: -- Result from auto-sense is 0
usb-storage: -- code: 0x70, key: 0x5, ASC: 0x20, ASCQ: 0x0
usb-storage: Illegal Request: (unknown ASC/ASCQ)
usb-storage: scsi cmd done, result=0x2
usb-storage: *** thread sleeping.
sr0: scsi-1 drive
Uniform CD-ROM driver Revision: 3.12
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Command TEST_UNIT_READY (6 bytes)
usb-storage: 00 00 00 00 00 00 00 00 46 02 00 00
usb-storage: Freecom TRANSPORT STARTED
usb-storage: 00000000: 00 00 00 00 00 00 00 00 - 00 00 00 00 -
............
usb-storage: foo Status result 0 4
usb-storage: 00000000: 53 03 ff ff - S...
usb-storage: operation failed
usb-storage: -- transport indicates command failure
usb-storage: Issuing auto-REQUEST_SENSE
usb-storage: Freecom TRANSPORT STARTED
usb-storage: 00000000: 03 00 00 00 12 00 00 00 - 00 00 00 00 -
............
usb-storage: foo Status result 0 4
usb-storage: 00000000: 4a 02 12 00 - J...
usb-storage: Device indicates that it has 18 bytes available
usb-storage: SCSI requested 18
usb-storage: Read data Freecom! (c=18)
usb-storage: Done issuing read request: 0 64
usb-storage: Start of read
usb-storage: usb_stor_transfer_partial(): xfer 18 bytes
usb-storage: usb_stor_bulk_msg() returned 0 xferred 18/18
usb-storage: usb_stor_transfer_partial(): transfer complete
usb-storage: freecom_readdata done!
usb-storage: FCM: Waiting for status
usb-storage: 00000000: 52 03 12 00 - R...
usb-storage: Transfer happy
usb-storage: -- Result from auto-sense is 0
usb-storage: -- code: 0x70, key: 0x6, ASC: 0x28, ASCQ: 0x0
usb-storage: Unit Attention: not ready to ready transition
usb-storage: scsi cmd done, result=0x2
usb-storage: *** thread sleeping.
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Command TEST_UNIT_READY (6 bytes)
usb-storage: 00 00 00 00 00 00 00 00 46 02 00 00
usb-storage: Freecom TRANSPORT STARTED
usb-storage: 00000000: 00 00 00 00 00 00 00 00 - 00 00 00 00 -
............
usb-storage: foo Status result 0 4
usb-storage: 00000000: 52 03 ff ff - R...
usb-storage: Device indicates that it has 65535 bytes available
usb-storage: SCSI requested 0
usb-storage: scsi cmd done, result=0x0
usb-storage: *** thread sleeping.
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Command READ_TOC (10 bytes)
usb-storage: 43 00 00 00 00 00 00 00 0c 00 ad c7
usb-storage: Freecom TRANSPORT STARTED
usb-storage: 00000000: 43 00 00 00 00 00 00 00 - 0c 00 00 00 -
C...........
usb-storage: foo Status result 0 4
usb-storage: 00000000: 4a 02 0c 00 - J...
usb-storage: Device indicates that it has 12 bytes available
usb-storage: SCSI requested 12
usb-storage: Read data Freecom! (c=12)
usb-storage: Done issuing read request: 0 64
usb-storage: Start of read
usb-storage: usb_stor_transfer_partial(): xfer 12 bytes
usb-storage: usb_stor_bulk_msg() returned 0 xferred 12/12
usb-storage: usb_stor_transfer_partial(): transfer complete
usb-storage: freecom_readdata done!
usb-storage: FCM: Waiting for status
usb-storage: 00000000: 52 03 0c 00 - R...
usb-storage: Transfer happy
usb-storage: scsi cmd done, result=0x0
usb-storage: *** thread sleeping.
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Command READ_TOC (10 bytes)
usb-storage: 43 02 00 00 00 00 01 00 0c 00 ad c7
usb-storage: Freecom TRANSPORT STARTED
usb-storage: 00000000: 43 02 00 00 00 00 01 00 - 0c 00 00 00 -
C...........
usb-storage: foo Status result 0 4
usb-storage: 00000000: 4a 02 0c 00 - J...
usb-storage: Device indicates that it has 12 bytes available
usb-storage: SCSI requested 12
usb-storage: Read data Freecom! (c=12)
usb-storage: Done issuing read request: 0 64
usb-storage: Start of read
usb-storage: usb_stor_transfer_partial(): xfer 12 bytes
usb-storage: usb_stor_bulk_msg() returned 0 xferred 12/12
usb-storage: usb_stor_transfer_partial(): transfer complete
usb-storage: freecom_readdata done!
usb-storage: FCM: Waiting for status
usb-storage: 00000000: 52 03 0c 00 - R...
usb-storage: Transfer happy
usb-storage: scsi cmd done, result=0x0
usb-storage: *** thread sleeping.
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Command TEST_UNIT_READY (6 bytes)
usb-storage: 00 00 00 00 00 00 01 00 00 00 02 00
usb-storage: Freecom TRANSPORT STARTED
usb-storage: 00000000: 00 00 00 00 00 00 00 00 - 00 00 00 00 -
............
usb-storage: foo Status result 0 4
usb-storage: 00000000: 52 03 ff ff - R...
usb-storage: Device indicates that it has 65535 bytes available
usb-storage: SCSI requested 0
usb-storage: scsi cmd done, result=0x0
usb-storage: *** thread sleeping.
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Command READ_TOC (10 bytes)
usb-storage: 43 00 00 00 00 00 00 00 0c 40 00 00
usb-storage: Freecom TRANSPORT STARTED
usb-storage: 00000000: 43 00 00 00 00 00 00 00 - 0c 40 00 00 -
C........@..
usb-storage: foo Status result 0 4
usb-storage: 00000000: 4a 02 0c 00 - J...
usb-storage: Device indicates that it has 12 bytes available
usb-storage: SCSI requested 12
usb-storage: Read data Freecom! (c=12)
usb-storage: Done issuing read request: 0 64
usb-storage: Start of read
usb-storage: usb_stor_transfer_partial(): xfer 12 bytes
usb-storage: usb_stor_bulk_msg() returned 0 xferred 12/12
usb-storage: usb_stor_transfer_partial(): transfer complete
usb-storage: freecom_readdata done!
usb-storage: FCM: Waiting for status
usb-storage: 00000000: 52 03 0c 00 - R...
usb-storage: Transfer happy
usb-storage: scsi cmd done, result=0x0
usb-storage: *** thread sleeping.
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Command READ_TOC (10 bytes)
usb-storage: 43 00 00 00 00 00 00 00 0c 00 ba c7
usb-storage: Freecom TRANSPORT STARTED
usb-storage: 00000000: 43 00 00 00 00 00 00 00 - 0c 00 00 00 -
C...........
usb-storage: foo Status result 0 4
usb-storage: 00000000: 4a 02 0c 00 - J...
usb-storage: Device indicates that it has 12 bytes available
usb-storage: SCSI requested 12
usb-storage: Read data Freecom! (c=12)
usb-storage: Done issuing read request: 0 64
usb-storage: Start of read
usb-storage: usb_stor_transfer_partial(): xfer 12 bytes
usb-storage: usb_stor_bulk_msg() returned 0 xferred 12/12
usb-storage: usb_stor_transfer_partial(): transfer complete
usb-storage: freecom_readdata done!
usb-storage: FCM: Waiting for status
usb-storage: 00000000: 52 03 0c 00 - R...
usb-storage: Transfer happy
usb-storage: scsi cmd done, result=0x0
usb-storage: *** thread sleeping.
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Command READ_TOC (10 bytes)
usb-storage: 43 00 00 00 00 00 01 00 0c 00 ba c7
usb-storage: Freecom TRANSPORT STARTED
usb-storage: 00000000: 43 00 00 00 00 00 01 00 - 0c 00 00 00 -
C...........
usb-storage: foo Status result 0 4
usb-storage: 00000000: 4a 02 0c 00 - J...
usb-storage: Device indicates that it has 12 bytes available
usb-storage: SCSI requested 12
usb-storage: Read data Freecom! (c=12)
usb-storage: Done issuing read request: 0 64
usb-storage: Start of read
usb-storage: usb_stor_transfer_partial(): xfer 12 bytes
usb-storage: usb_stor_bulk_msg() returned 0 xferred 12/12
usb-storage: usb_stor_transfer_partial(): transfer complete
usb-storage: freecom_readdata done!
usb-storage: FCM: Waiting for status
usb-storage: 00000000: 52 03 0c 00 - R...
usb-storage: Transfer happy
usb-storage: scsi cmd done, result=0x0
usb-storage: *** thread sleeping.
VFS: Disk change detected on device sr(11,0)
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Command READ_CAPACITY (10 bytes)
usb-storage: 25 00 00 00 00 00 00 00 00 00 00 00
usb-storage: Freecom TRANSPORT STARTED
usb-storage: 00000000: 25 00 00 00 00 00 00 00 - 00 00 00 00 -
%...........
usb-storage: foo Status result 0 4
usb-storage: 00000000: 4a 02 08 00 - J...
usb-storage: Device indicates that it has 8 bytes available
usb-storage: SCSI requested 8
usb-storage: Read data Freecom! (c=8)
usb-storage: Done issuing read request: 0 64
usb-storage: Start of read
usb-storage: usb_stor_transfer_partial(): xfer 8 bytes
usb-storage: usb_stor_bulk_msg() returned 0 xferred 8/8
usb-storage: usb_stor_transfer_partial(): transfer complete
usb-storage: freecom_readdata done!
usb-storage: FCM: Waiting for status
usb-storage: 00000000: 52 03 08 00 - R...
usb-storage: Transfer happy
usb-storage: scsi cmd done, result=0x0
usb-storage: *** thread sleeping.
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Command ALLOW_MEDIUM_REMOVAL (6 bytes)
usb-storage: 1e 00 00 00 01 00 00 00 00 00 00 00
usb-storage: Freecom TRANSPORT STARTED
usb-storage: 00000000: 1e 00 00 00 01 00 00 00 - 00 00 00 00 -
............
usb-storage: foo Status result 0 4
usb-storage: 00000000: 52 03 ff ff - R...
usb-storage: Device indicates that it has 65535 bytes available
usb-storage: SCSI requested 0
usb-storage: scsi cmd done, result=0x0
usb-storage: *** thread sleeping.
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Command TEST_UNIT_READY (6 bytes)
usb-storage: 00 00 00 00 00 00 00 00 01 00 00 00
usb-storage: Freecom TRANSPORT STARTED
usb-storage: 00000000: 00 00 00 00 00 00 00 00 - 00 00 00 00 -
............
usb-storage: foo Status result 0 4
usb-storage: 00000000: 52 03 ff ff - R...
usb-storage: Device indicates that it has 65535 bytes available
usb-storage: SCSI requested 0
usb-storage: scsi cmd done, result=0x0
usb-storage: *** thread sleeping.
usb-storage: queuecommand() called
usb-storage: *** thread awakened.
usb-storage: Command READ_10 (10 bytes)
usb-storage: 28 00 00 00 00 00 00 00 02 00 00 00
usb-storage: Freecom TRANSPORT STARTED
usb-storage: 00000000: 28 00 00 00 00 00 00 00 - 02 00 00 00 -
(...........
usb-storage: foo Status result 0 4
usb-storage: 00000000: 4a 02 00 08 - J...
usb-storage: Device indicates that it has 2048 bytes available
usb-storage: SCSI requested 4096
usb-storage: Read data Freecom! (c=2048)
usb-storage: Done issuing read request: 0 64
usb-storage: Start of read
usb-storage: usb_stor_transfer_partial(): xfer 2048 bytes
usb-storage: usb_stor_bulk_msg() returned 0 xferred 2048/2048
usb-storage: usb_stor_transfer_partial(): transfer complete
usb-storage: freecom_readdata done!
usb-storage: FCM: Waiting for status
usb-storage: 00000000: 4a 02 00 08 - J...
usb-storage: Drive seems still hungry
usb-storage: -- transport indicates command failure
usb-storage: Issuing auto-REQUEST_SENSE
usb-storage: Freecom TRANSPORT STARTED
usb-storage: 00000000: 03 00 00 00 12 00 00 00 - 02 00 00 00 -
............
usb-storage: foo Status result 0 4
usb-storage: 00000000: 4a 02 00 08 - J...
usb-storage: Device indicates that it has 2048 bytes available
usb-storage: SCSI requested 4096
usb-storage: Read data Freecom! (c=2048)
usb-storage: Done issuing read request: 0 64
usb-storage: Start of read
usb-storage: usb_stor_transfer_partial(): xfer 2048 bytes
usb-storage: usb_stor_bulk_msg() returned 0 xferred 2048/2048
usb-storage: usb_stor_transfer_partial(): transfer complete
usb-storage: freecom_readdata done!
usb-storage: FCM: Waiting for status
usb-storage: 00000000: 4a 02 00 08 - J...
usb-storage: Drive seems still hungry
usb-storage: -- transport indicates command failure
usb-storage: Issuing auto-REQUEST_SENSE
usb-storage: Freecom TRANSPORT STARTED
usb-storage: 00000000: 03 00 00 00 12 00 00 00 - 02 00 00 00 -
............
usb-storage: command_abort() called
usb-storage: foo Status result -2 0
usb-storage: freecom_transport(): transfer aborted
usb-storage: -- auto-sense failure
freecom reset called
usb-storage: scsi cmd done, result=0x70000
usb-storage: *** thread sleeping.
