using MSImport on Clie NX70 with mixed results (2.4.22-ac4 versus 2.6.0-test10)

re, all.  I have a Clie NX70 and when I was running kernel 2.4.22-ac4, I
was able to mount the MSImport-exported SCSI device and use it perfectly
(well, maybe not perfectly--it got errors and such, but for the most
part, I was able to copy to and from it).  I was assuming that when I
went to 2.6.0-test10, whatever fixes were present in 2.4.22-ac4 would
also be in 2.6.0-t10.  This is not the case.

I just wanted to see if anyone else:

1) has had success using MSImport in combination with kernel 2.4.22 

2) has had success with MSImport and kernel 2.6.0-t10.

3) knows what has changed between kernel versions that would break this

4) knows where to start looking for clues.

I've contacted Matt Dharm about this and he's not able to help.  The
problem is that when this doesn't work, the kernel's logs show that the
Clie doesn't look like it has any media in it.  Brief portions of syslog
below...

Nov 26 10:46:41 localhost kernel: scsi0 : SCSI emulation for USB Mass Storage devices
Nov 26 10:46:41 localhost kernel:   Vendor: Sony      Model: CLIE MGMS         Rev: 1.00
Nov 26 10:46:41 localhost kernel:   Type:   Direct-Access                      ANSI SCSI revision: 02
Nov 26 10:46:41 localhost kernel: Attached scsi removable disk sda at scsi0, channel 0, id 0, lun 0
Nov 26 10:46:41 localhost /sbin/hotplug: no runnable /etc/hotplug/scsi_device.agent is installedNov 26 10:46:41 localhost kernel: Attached scsi generic sg0 at scsi0, channel 0, id 0, lun 0,  type 0
...
Nov 26 10:46:41 localhost kernel: drivers/usb/host/uhci-hcd.c: 1820: wakeup_hc
Nov 26 10:46:41 localhost kernel: hub 2-0:1.0: port 2, status 101, change 1, 12 Mb/s
Nov 26 10:46:41 localhost kernel: hub 2-0:1.0: debounce: port 2: delay 100ms stable 4 status 0x101
Nov 26 10:46:41 localhost kernel: hub 2-0:1.0: new USB device on port 2, assigned address 4
Nov 26 10:46:41 localhost kernel: usb 2-2: new device strings: Mfr=1, Product=2, SerialNumber=0
Nov 26 10:46:41 localhost kernel: drivers/usb/core/message.c: USB device number 4 default language ID 0x409
Nov 26 10:46:41 localhost kernel: usb 2-2: Product: Sony PEG Mass Storage
Nov 26 10:46:41 localhost /etc/hotplug/usb.agent: Bad USB agent invocation
Nov 26 10:46:41 localhost kernel: usb 2-2: Manufacturer: Sony
Nov 26 10:46:41 localhost kernel: drivers/usb/core/usb.c: usb_hotplug
Nov 26 10:46:41 localhost kernel: usb 2-2: registering 2-2:1.0 (config #1, interface 0)
Nov 26 10:46:41 localhost kernel: drivers/usb/core/usb.c: usb_hotplug
Nov 26 10:46:41 localhost kernel: usb-storage 2-2:1.0: usb_probe_interface
Nov 26 10:46:41 localhost kernel: usb-storage 2-2:1.0: usb_probe_interface - got id
Nov 26 10:46:41 localhost kernel: usb-storage: USB Mass Storage device detected
Nov 26 10:46:41 localhost kernel: usb-storage: act_altsetting is 0, id_index is 96
Nov 26 10:46:41 localhost kernel: usb-storage: -- associate_dev
Nov 26 10:46:41 localhost /sbin/hotplug: no runnable /etc/hotplug/scsi_host.agent is installed
Nov 26 10:46:41 localhost kernel: usb-storage: Transport: Control/Bulk/Interrupt
Nov 26 10:46:41 localhost kernel: usb-storage: Protocol: 8070i
Nov 26 10:46:41 localhost kernel: usb-storage: Endpoints: In: 0xe01655c0 Out: 0xe01655d4 Int: 0xe01655e8 (Period 1)
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread sleeping.
Nov 26 10:46:41 localhost kernel: scsi0 : SCSI emulation for USB Mass Storage devices
Nov 26 10:46:41 localhost kernel: usb-storage: queuecommand called
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread awakened.
Nov 26 10:46:41 localhost kernel: usb-storage: Command INQUIRY (6 bytes)
Nov 26 10:46:41 localhost kernel: usb-storage:  12 00 00 00 24 00
Nov 26 10:46:41 localhost kernel: usb-storage: usb_stor_ctrl_transfer: rq=00 rqtype=21 value=0000 index=00 len=12
Nov 26 10:46:41 localhost kernel: usb-storage: Status code 0; transferred 12/12
Nov 26 10:46:41 localhost kernel: usb-storage: -- transfer complete
Nov 26 10:46:41 localhost kernel: usb-storage: Call to usb_stor_ctrl_transfer() returned 0
Nov 26 10:46:41 localhost kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 36 bytes
Nov 26 10:46:41 localhost kernel: usb-storage: Status code 0; transferred 36/36
Nov 26 10:46:41 localhost kernel: usb-storage: -- transfer complete
Nov 26 10:46:41 localhost kernel: usb-storage: CBI data stage result is 0x0
Nov 26 10:46:41 localhost kernel: usb-storage: usb_stor_intr_transfer: xfer 2 bytes
Nov 26 10:46:41 localhost kernel: usb-storage: Status code 0; transferred 2/2
Nov 26 10:46:41 localhost kernel: usb-storage: -- transfer complete
Nov 26 10:46:41 localhost kernel: usb-storage: Got interrupt data (0x0, 0x0)
Nov 26 10:46:41 localhost kernel: usb-storage: Fixing INQUIRY data to show SCSI rev 2 - was 0
Nov 26 10:46:41 localhost kernel: usb-storage: scsi cmd done, result=0x0
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread sleeping.
Nov 26 10:46:41 localhost kernel: usb-storage: queuecommand called
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread awakened.
Nov 26 10:46:41 localhost kernel: usb-storage: Command INQUIRY (6 bytes)
Nov 26 10:46:41 localhost kernel: usb-storage:  12 00 00 00 38 00
Nov 26 10:46:41 localhost kernel: usb-storage: usb_stor_ctrl_transfer: rq=00 rqtype=21 value=0000 index=00 len=12
Nov 26 10:46:41 localhost kernel: usb-storage: Status code 0; transferred 12/12
Nov 26 10:46:41 localhost kernel: usb-storage: -- transfer complete
Nov 26 10:46:41 localhost kernel: usb-storage: Call to usb_stor_ctrl_transfer() returned 0
Nov 26 10:46:41 localhost kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 56 bytes
Nov 26 10:46:41 localhost kernel: usb-storage: Status code 0; transferred 56/56
Nov 26 10:46:41 localhost kernel: usb-storage: -- transfer complete
Nov 26 10:46:41 localhost kernel: usb-storage: CBI data stage result is 0x0
Nov 26 10:46:41 localhost kernel: usb-storage: usb_stor_intr_transfer: xfer 2 bytes
Nov 26 10:46:41 localhost kernel: usb-storage: Status code 0; transferred 2/2
Nov 26 10:46:41 localhost kernel: usb-storage: -- transfer complete
Nov 26 10:46:41 localhost kernel: usb-storage: Got interrupt data (0x0, 0x0)
Nov 26 10:46:41 localhost kernel: usb-storage: Fixing INQUIRY data to show SCSI rev 2 - was 0
Nov 26 10:46:41 localhost kernel: usb-storage: scsi cmd done, result=0x0
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread sleeping.
Nov 26 10:46:41 localhost kernel:   Vendor: Sony      Model: CLIE MGMS         Rev: 1.00
Nov 26 10:46:41 localhost kernel:   Type:   Direct-Access                      ANSI SCSI revision: 02
Nov 26 10:46:41 localhost kernel: usb-storage: queuecommand called
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread awakened.
Nov 26 10:46:41 localhost kernel: usb-storage: Command TEST_UNIT_READY (6 bytes)
Nov 26 10:46:41 localhost kernel: usb-storage:  00 00 00 00 00 00
Nov 26 10:46:41 localhost kernel: usb-storage: usb_stor_ctrl_transfer: rq=00 rqtype=21 value=0000 index=00 len=12
Nov 26 10:46:41 localhost kernel: usb-storage: Status code -32; transferred 12/12
Nov 26 10:46:41 localhost kernel: usb-storage: -- stall on control pipe
Nov 26 10:46:41 localhost kernel: usb-storage: Call to usb_stor_ctrl_transfer() returned 2
Nov 26 10:46:41 localhost kernel: usb-storage: -- transport indicates command failure
Nov 26 10:46:41 localhost kernel: usb-storage: Issuing auto-REQUEST_SENSE
Nov 26 10:46:41 localhost kernel: usb-storage: usb_stor_ctrl_transfer: rq=00 rqtype=21 value=0000 index=00 len=12
Nov 26 10:46:41 localhost kernel: usb-storage: Status code 0; transferred 12/12
Nov 26 10:46:41 localhost kernel: usb-storage: -- transfer complete
Nov 26 10:46:41 localhost kernel: usb-storage: Call to usb_stor_ctrl_transfer() returned 0
Nov 26 10:46:41 localhost kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 18 bytes
Nov 26 10:46:41 localhost kernel: usb-storage: Status code 0; transferred 18/18
Nov 26 10:46:41 localhost kernel: usb-storage: -- transfer complete
Nov 26 10:46:41 localhost kernel: usb-storage: CBI data stage result is 0x0
Nov 26 10:46:41 localhost kernel: usb-storage: usb_stor_intr_transfer: xfer 2 bytes
Nov 26 10:46:41 localhost kernel: usb-storage: Status code 0; transferred 2/2
Nov 26 10:46:41 localhost kernel: usb-storage: -- transfer complete
Nov 26 10:46:41 localhost kernel: usb-storage: Got interrupt data (0x0, 0x0)
Nov 26 10:46:41 localhost kernel: usb-storage: -- Result from auto-sense is 0
Nov 26 10:46:41 localhost kernel: usb-storage: -- code: 0x70, key: 0x2, ASC: 0x3a, ASCQ: 0x0
Nov 26 10:46:41 localhost kernel: usb-storage: Not Ready: Medium not present
Nov 26 10:46:41 localhost kernel: usb-storage: scsi cmd done, result=0x2
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread sleeping.
Nov 26 10:46:41 localhost kernel: usb-storage: queuecommand called
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread awakened.
Nov 26 10:46:41 localhost kernel: usb-storage: Command TEST_UNIT_READY (6 bytes)
Nov 26 10:46:41 localhost kernel: usb-storage:  00 00 00 00 00 00
Nov 26 10:46:41 localhost kernel: usb-storage: usb_stor_ctrl_transfer: rq=00 rqtype=21 value=0000 index=00 len=12
Nov 26 10:46:41 localhost kernel: usb-storage: Status code -32; transferred 12/12
Nov 26 10:46:41 localhost kernel: usb-storage: -- stall on control pipe
Nov 26 10:46:41 localhost kernel: usb-storage: Call to usb_stor_ctrl_transfer() returned 2
Nov 26 10:46:41 localhost kernel: usb-storage: -- transport indicates command failure
Nov 26 10:46:41 localhost kernel: usb-storage: Issuing auto-REQUEST_SENSE
Nov 26 10:46:41 localhost kernel: usb-storage: usb_stor_ctrl_transfer: rq=00 rqtype=21 value=0000 index=00 len=12
Nov 26 10:46:41 localhost kernel: usb-storage: Status code 0; transferred 12/12
Nov 26 10:46:41 localhost kernel: usb-storage: -- transfer complete
Nov 26 10:46:41 localhost kernel: usb-storage: Call to usb_stor_ctrl_transfer() returned 0
Nov 26 10:46:41 localhost kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 18 bytes
Nov 26 10:46:41 localhost kernel: usb-storage: Status code 0; transferred 18/18
Nov 26 10:46:41 localhost kernel: usb-storage: -- transfer complete
Nov 26 10:46:41 localhost kernel: usb-storage: CBI data stage result is 0x0
Nov 26 10:46:41 localhost kernel: usb-storage: usb_stor_intr_transfer: xfer 2 bytes
Nov 26 10:46:41 localhost kernel: usb-storage: Status code 0; transferred 2/2
Nov 26 10:46:41 localhost kernel: usb-storage: -- transfer complete
Nov 26 10:46:41 localhost kernel: usb-storage: Got interrupt data (0x0, 0x0)
Nov 26 10:46:41 localhost kernel: usb-storage: -- Result from auto-sense is 0
Nov 26 10:46:41 localhost kernel: usb-storage: -- code: 0x70, key: 0x2, ASC: 0x3a, ASCQ: 0x0
Nov 26 10:46:41 localhost kernel: usb-storage: Not Ready: Medium not present
Nov 26 10:46:41 localhost kernel: usb-storage: scsi cmd done, result=0x2
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread sleeping.
Nov 26 10:46:41 localhost kernel: usb-storage: queuecommand called
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread awakened.
Nov 26 10:46:41 localhost kernel: usb-storage: Command TEST_UNIT_READY (6 bytes)
Nov 26 10:46:41 localhost kernel: usb-storage:  00 00 00 00 00 00
Nov 26 10:46:41 localhost kernel: usb-storage: usb_stor_ctrl_transfer: rq=00 rqtype=21 value=0000 index=00 len=12
Nov 26 10:46:41 localhost kernel: usb-storage: Status code -32; transferred 12/12
Nov 26 10:46:41 localhost kernel: usb-storage: -- stall on control pipe
Nov 26 10:46:41 localhost kernel: usb-storage: Call to usb_stor_ctrl_transfer() returned 2
Nov 26 10:46:41 localhost kernel: usb-storage: -- transport indicates command failure
Nov 26 10:46:41 localhost kernel: usb-storage: Issuing auto-REQUEST_SENSE
Nov 26 10:46:41 localhost kernel: usb-storage: usb_stor_ctrl_transfer: rq=00 rqtype=21 value=0000 index=00 len=12
Nov 26 10:46:41 localhost kernel: usb-storage: Status code 0; transferred 12/12
Nov 26 10:46:41 localhost kernel: usb-storage: -- transfer complete
Nov 26 10:46:41 localhost kernel: usb-storage: Call to usb_stor_ctrl_transfer() returned 0
Nov 26 10:46:41 localhost kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 18 bytes
Nov 26 10:46:41 localhost kernel: usb-storage: Status code 0; transferred 18/18
Nov 26 10:46:41 localhost kernel: usb-storage: -- transfer complete
Nov 26 10:46:41 localhost kernel: usb-storage: CBI data stage result is 0x0
Nov 26 10:46:41 localhost kernel: usb-storage: usb_stor_intr_transfer: xfer 2 bytes
Nov 26 10:46:41 localhost kernel: usb-storage: Status code 0; transferred 2/2
Nov 26 10:46:41 localhost kernel: usb-storage: -- transfer complete
Nov 26 10:46:41 localhost kernel: usb-storage: Got interrupt data (0x0, 0x0)
Nov 26 10:46:41 localhost kernel: usb-storage: -- Result from auto-sense is 0
Nov 26 10:46:41 localhost kernel: usb-storage: -- code: 0x70, key: 0x2, ASC: 0x3a, ASCQ: 0x0
Nov 26 10:46:41 localhost kernel: usb-storage: Not Ready: Medium not present
Nov 26 10:46:41 localhost kernel: usb-storage: scsi cmd done, result=0x2
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread sleeping.
Nov 26 10:46:41 localhost kernel: Attached scsi removable disk sda at scsi0, channel 0, id 0, lun 0
Nov 26 10:46:41 localhost /sbin/hotplug: no runnable /etc/hotplug/scsi_device.agent is installedNov 26 10:46:41 localhost kernel: Attached scsi generic sg0 at scsi0, channel 0, id 0, lun 0,  type 0
Nov 26 10:46:41 localhost kernel: usb-storage: queuecommand called
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread awakened.
Nov 26 10:46:41 localhost kernel: usb-storage: Bad LUN (0:1)
Nov 26 10:46:41 localhost kernel: usb-storage: scsi cmd done, result=0x40000
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread sleeping.
Nov 26 10:46:41 localhost kernel: usb-storage: queuecommand called
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread awakened.
Nov 26 10:46:41 localhost kernel: usb-storage: Bad target number (1:0)
Nov 26 10:46:41 localhost kernel: usb-storage: scsi cmd done, result=0x40000
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread sleeping.
Nov 26 10:46:41 localhost kernel: usb-storage: queuecommand called
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread awakened.
Nov 26 10:46:41 localhost kernel: usb-storage: Bad target number (2:0)
Nov 26 10:46:41 localhost kernel: usb-storage: scsi cmd done, result=0x40000
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread sleeping.
Nov 26 10:46:41 localhost kernel: usb-storage: queuecommand called
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread awakened.
Nov 26 10:46:41 localhost kernel: usb-storage: Bad target number (3:0)
Nov 26 10:46:41 localhost kernel: usb-storage: scsi cmd done, result=0x40000
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread sleeping.
Nov 26 10:46:41 localhost kernel: usb-storage: queuecommand called
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread awakened.
Nov 26 10:46:41 localhost kernel: usb-storage: Bad target number (4:0)
Nov 26 10:46:41 localhost kernel: usb-storage: scsi cmd done, result=0x40000
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread sleeping.
Nov 26 10:46:41 localhost kernel: usb-storage: queuecommand called
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread awakened.
Nov 26 10:46:41 localhost kernel: usb-storage: Bad target number (5:0)
Nov 26 10:46:41 localhost kernel: usb-storage: scsi cmd done, result=0x40000
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread sleeping.
Nov 26 10:46:41 localhost kernel: usb-storage: queuecommand called
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread awakened.
Nov 26 10:46:41 localhost kernel: usb-storage: Bad target number (6:0)
Nov 26 10:46:41 localhost kernel: usb-storage: scsi cmd done, result=0x40000
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread sleeping.
Nov 26 10:46:41 localhost kernel: usb-storage: queuecommand called
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread awakened.
Nov 26 10:46:41 localhost kernel: usb-storage: Bad target number (7:0)
Nov 26 10:46:41 localhost kernel: usb-storage: scsi cmd done, result=0x40000
Nov 26 10:46:41 localhost kernel: usb-storage: *** thread sleeping.
Nov 26 10:46:41 localhost kernel: WARNING: USB Mass Storage data integrity not assured
Nov 26 10:46:41 localhost kernel: USB Mass Storage device found at 4
Nov 26 10:46:41 localhost /sbin/hotplug: no runnable /etc/hotplug/block.agent is installed
Nov 26 10:46:41 localhost /etc/hotplug/scsi.agent: Unknown type:
Nov 26 10:46:44 localhost /etc/hotplug/usb.agent: Setup usb-storage for USB product 54c/d9/1
Nov 26 10:46:44 localhost modprobe: FATAL: Module usb_storage already in kernel.
Nov 26 10:46:44 localhost /etc/hotplug/usb.agent: Module setup usb-storage for USB product 54c/d9/1
Nov 26 10:46:44 localhost /etc/hotplug/usb/usb-storage: Load scsimon
Nov 26 10:46:44 localhost /etc/hotplug/usb/usb-storage: loading ... scsimon
Nov 26 10:46:44 localhost modprobe: FATAL: Module scsimon not found.
Nov 26 10:46:57 localhost modprobe: FATAL: Module /dev/scsi/host0/bus0/target0/lun0/part1 not found.
Nov 26 10:46:57 localhost modprobe: FATAL: Module /dev/scsi/host0/bus0/target0/lun0/part1 not found.


Does anyone have any ideas??  Even where to start looking to debug this
personally??

HELP!!!  Thanks!!!

-- 

,-----------------------------------------------------------------//
| Jason 'vanRijn' Kasper ::  Numbers 6:22-26 
 `
 | All brontosauruses are thin at one end, much MUCH thicker 
 | in the middle, and then thin again at the far end.  That is 
 | the theory that I have and which is mine, and what it is too.  
 ,
| bash$ :(){ :|:&};:
`----------------------//


_______________________________________________
clie-linux mailing list
[email protected]
http://kreucher.net/mailman/listinfo/clie-linux

Sony Clié and Linux Homepage:
http://kreucher.net/clie/