Can't init usb device with "virtual CD-Rom" #365

thebino · 2023-01-26T15:31:34Z

Problem

When initializing a device with multiple endpoints where the first behaves like a CD-Rom drive, the initialisation fails.

See attached files for more details on the device.
device_dump.txt
device_info.txt

Expected behavior

Initialise at least the non virtual CD-Rom drive

Actual behavior

Crash due initialisation

Stacktrace of Excpetion

I  USB Device detached
I  ⏹️ stop communication
I  USB Device attached '������������' on port '/dev/bus/usb/001/002'
V  request USB permission for device '������������' on port '/dev/bus/usb/001/002'
W  USB Permission denied!
W  USB Permission denied!
V  Has permission for attached device /dev/bus/usb/001/002
I  ▶️️ start communication
I  found usb device: /dev/bus/usb/001/002=UsbDevice[mName=/dev/bus/usb/001/002,mVendorId=3141,mProductId=12801,mClass=0,mSubclass=0,mProtocol=0,mManufacturerName=null,mProductName=������������,mVersion=1.00,mSerialNumberReader=android.hardware.usb.IUsbSerialReader$Stub$Proxy@ac570ec, mHasAudioPlayback=false, mHasAudioCapture=false, mHasMidi=false, mHasVideoCapture=false, mHasVideoPlayback=false, mConfigurations=[
    UsbConfiguration[mId=1,mName=null,mAttributes=192,mMaxPower=250,mInterfaces=[
    UsbInterface[mId=0,mAlternateSetting=0,mName=null,mClass=8,mSubclass=6,mProtocol=80,mEndpoints=[
    UsbEndpoint[mAddress=129,mAttributes=2,mMaxPacketSize=512,mInterval=0]
    UsbEndpoint[mAddress=2,mAttributes=2,mMaxPacketSize=512,mInterval=0]]]]
I  Found usb interface: UsbInterface[mId=0,mAlternateSetting=0,mName=null,mClass=8,mSubclass=6,mProtocol=80,mEndpoints=[
    UsbEndpoint[mAddress=129,mAttributes=2,mMaxPacketSize=512,mInterval=0]
    UsbEndpoint[mAddress=2,mAttributes=2,mMaxPacketSize=512,mInterval=0]]
I  Found usb endpoint: UsbEndpoint[mAddress=129,mAttributes=2,mMaxPacketSize=512,mInterval=0]
I  Found usb endpoint: UsbEndpoint[mAddress=2,mAttributes=2,mMaxPacketSize=512,mInterval=0]
I  Found 1 usb mass storage devices.
I  Initialize device[0]
D  setup device
I  MAX LUN 1
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
W  Could not read from device, result == -1 errno 0 null, retrying...
E  Could not init devise!
    java.io.IOException: MAX_RECOVERY_ATTEMPTS Exceeded while trying to transfer command to device, please reattach device and try again
    	at me.jahnen.libaums.core.driver.scsi.ScsiBlockDevice.transferCommand(ScsiBlockDevice.kt:181)
    	at me.jahnen.libaums.core.driver.scsi.ScsiBlockDevice.initAttempt(ScsiBlockDevice.kt:100)
    	at me.jahnen.libaums.core.driver.scsi.ScsiBlockDevice.init(ScsiBlockDevice.kt:83)
    	at me.jahnen.libaums.core.UsbMassStorageDevice.setupDevice(UsbMassStorageDevice.kt:138)
    	at me.jahnen.libaums.core.UsbMassStorageDevice.init(UsbMassStorageDevice.kt:100)
    	at pro.stuermer.bookii.usb.ConnectionService.connect(ConnectionService.kt:56)
    	at pro.stuermer.bookii.usb.repository.ConnectionRepositoryImpl.initConnection(ConnectionRepositoryImpl.kt:37)
    	at pro.stuermer.bookii.devices.domain.InitConnectionUseCase.invoke(InitConnectionUseCase.kt:10)
    	at pro.stuermer.bookii.MainViewModel.startCommunication(MainViewModel.kt:16)
    	at pro.stuermer.bookii.MainActivity.scanForAlreadyAttachedDevices(MainActivity.kt:133)
    	at pro.stuermer.bookii.MainActivity.onResume(MainActivity.kt:63)
    	at android.app.Instrumentation.callActivityOnResume(Instrumentation.java:1569)
    	at android.app.Activity.performResume(Activity.java:8484)
    	at android.app.ActivityThread.performResumeActivity(ActivityThread.java:4769)
    	at android.app.ActivityThread.handleResumeActivity(ActivityThread.java:4812)
    	at android.app.servertransaction.ResumeActivityItem.execute(ResumeActivityItem.java:54)
    	at android.app.servertransaction.ActivityTransactionItem.execute(ActivityTransactionItem.java:45)
    	at android.app.servertransaction.TransactionExecutor.executeLifecycleState(TransactionExecutor.java:176)
    	at android.app.servertransaction.TransactionExecutor.execute(TransactionExecutor.java:97)
    	at android.app.ActivityThread$H.handleMessage(ActivityThread.java:2308)
    	at android.os.Handler.dispatchMessage(Handler.java:106)
    	at android.os.Looper.loopOnce(Looper.java:201)
    	at android.os.Looper.loop(Looper.java:288)
    	at android.app.ActivityThread.main(ActivityThread.java:7878)
    	at java.lang.reflect.Method.invoke(Native Method)
    	at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:548)
    	at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:952)
I  USB Device detached
I  ⏹️ stop communication

Code where problem occurs

val massStorageDevice = device.getMassStorageDevices(context = context.applicationContext)
massStorageDevice.init()

The text was updated successfully, but these errors were encountered:

magnusja · 2023-03-10T11:15:21Z

Puh I never tested CD roms tbh

I dont think it is compatible. They probably use a different protocol.

thebino · 2023-03-12T14:57:14Z

@magnusja It is not a real CD-drive. The USB device contains two interfaces, see attached device_dump.txt and device_info.txt for more details.

magnusja · 2023-03-13T22:34:35Z

So it seems that the interface does not respond properly to a scsi inquiry. I guess one option would to not throw an exception in that case.

magnusja · 2023-03-13T22:35:09Z

Not sure if there is way to recognize before if the device responds to the scisi command protocol

magnusja · 2023-03-14T13:05:44Z

Does the device really have two interfaces? I can only see one.

thebino · 2023-03-14T13:09:58Z

The device_dump.txt lists two interfaces when using dumping the USB Device from android itself.

The device_info.txt has it listed as two different disks (disk5 the MTP storage I'm interested in, and disk6 which is just the fake CD-Rom with the application/driver for windows)

magnusja · 2023-03-14T13:12:52Z

I would suggest that you change the initialization of the device so that you catch the exception, ignore it and then continue to initialize the second LUN.

magnusja · 2023-03-14T13:16:35Z

The device_dump.txt lists two interfaces when using dumping the USB Device from android itself.

This is what I see.

ConnectionService  I  ▶️️ start communication
ConnectionService  V  ├── manufacturerName = null
ConnectionService  V  ├── productId = 12801
ConnectionService  V  ├── productName = ������������
ConnectionService  V  ├── serialNumber = ������������
ConnectionService  V  ├── vendorId = 3141
ConnectionService  V  ├── version = 1.00
ConnectionService  V  ├── deviceClass = 0
ConnectionService  V  ├── deviceId = 1006
ConnectionService  V  ├── deviceName = /dev/bus/usb/001/006
ConnectionService  V  ├── deviceProtocol = 0
ConnectionService  V  ├── deviceSubclass = 0
ConnectionService  V  └─ interface
ConnectionService  V      ├─ name = null
ConnectionService  V      ├─ interfaceProtocol = 80
ConnectionService  V      ├─ interfaceClass = 8
ConnectionService  V      ├─ interfaceSubclass = 6
ConnectionService  V      ├─ endpoint
ConnectionService  V      │   ├─ address = 129
ConnectionService  V      │   ├─ attributes = 2
ConnectionService  V      │   ├─ direction = 128
ConnectionService  V      │   ├─ endpointNumber = 1
ConnectionService  V      │   ├─ interval = 0
ConnectionService  V      │   ├─ maxPacketSize = 512
ConnectionService  V      │   └─ type = 2
ConnectionService  V      └─ endpoint
ConnectionService  V          ├─ address = 2
ConnectionService  V          ├─ attributes = 2
ConnectionService  V          ├─ direction = 0
ConnectionService  V          ├─ endpointNumber = 2
ConnectionService  V          ├─ interval = 0
ConnectionService  V          ├─ maxPacketSize = 512
ConnectionService  V          └─ type = 2
MainAct...eceiver  I  USB Device detached
ConnectionService  I  ⏹️ stop communication

One interface, two endpoints. What am I missing?

The device_info.txt has it listed as two different disks (disk5 the MTP storage I'm interested in, and disk6 which is just the fake CD-Rom with the application/driver for windows)

MTP is not supported! That is a whole nother protocol. This lib only supports the SCSI block command set. I am happy to take contributions though.

magnusja · 2023-03-14T13:25:07Z

Are you sure it is an MTP device?

I would have hoped that an MTP device would not advertise itself as a device which supports scsi.

libaums/libaums/src/main/java/me/jahnen/libaums/core/UsbMassStorageDevice.kt

Lines 181 to 190 in e5a31e9

    
                   /** 
        
                    * subclass 6 means that the usb mass storage device implements the SCSI 
        
                    * transparent command set 
        
                    */ 
        
                   private const val INTERFACE_SUBCLASS = 6 
        
                   /** 
        
                    * protocol 80 means the communication happens only via bulk transfers 
        
                    */ 
        
                   private const val INTERFACE_PROTOCOL = 80

thebino · 2023-03-14T13:28:08Z

I meant "Mass Storage Device" not MTP.

And yes, 1 interface, 2 endpoints

magnusja · 2023-03-14T13:31:42Z

I see. Then try what I suggested. Ignore the exception on first LUN and try the second. Maybe we are in luck. But the device not responding to the SCSI inquiry is odd. Maybe the CDRom thingy only supports an older version of that inquiry, I am unsure.

thebino · 2023-03-14T15:58:16Z

Hasn't changed anything. See attached logcat
logcat.txt

magnusja · 2023-03-20T14:55:47Z

This doesnt look like you did what I suggested. Did you catch the exception in you application code? That wont work. Please fork and catch the exception in libaums to ignore and continue initialization of second LUN.

thebino · 2023-03-20T15:26:26Z

It's catching the exception for the init() which doesn't help since it is only a single device.

I can try to fork it and debug libaums directly

for (device in devices) {
    Timber.d("try to init device ${device.usbDevice.deviceName}")
    Timber.v("\t${device.usbDevice}")
    try {
        Timber.d("\twith ${device.partitions.size} partitions")
    } catch (u: UninitializedPropertyAccessException) {
        // no-op: partitions aren't initialized yet
    }

    try {
        // before interacting with a device you need to call init()!
        device.init()
    } catch (io: IOException) {
        Timber.e(io, "catch IOException while initializing device!")
    }
}

Provide feedback

Saved searches

Use saved searches to filter your results more quickly

Can't init usb device with "virtual CD-Rom" #365

Can't init usb device with "virtual CD-Rom" #365

thebino commented Jan 26, 2023 •

edited

Loading

magnusja commented Mar 10, 2023

thebino commented Mar 12, 2023

magnusja commented Mar 13, 2023

magnusja commented Mar 13, 2023

magnusja commented Mar 14, 2023

thebino commented Mar 14, 2023

magnusja commented Mar 14, 2023

magnusja commented Mar 14, 2023

magnusja commented Mar 14, 2023

thebino commented Mar 14, 2023

magnusja commented Mar 14, 2023

thebino commented Mar 14, 2023

magnusja commented Mar 20, 2023

thebino commented Mar 20, 2023

Can't init usb device with "virtual CD-Rom" #365

Can't init usb device with "virtual CD-Rom" #365

Comments

thebino commented Jan 26, 2023 • edited Loading

Problem

Expected behavior

Actual behavior

Stacktrace of Excpetion

Code where problem occurs

magnusja commented Mar 10, 2023

thebino commented Mar 12, 2023

magnusja commented Mar 13, 2023

magnusja commented Mar 13, 2023

magnusja commented Mar 14, 2023

thebino commented Mar 14, 2023

magnusja commented Mar 14, 2023

magnusja commented Mar 14, 2023

magnusja commented Mar 14, 2023

thebino commented Mar 14, 2023

magnusja commented Mar 14, 2023

thebino commented Mar 14, 2023

magnusja commented Mar 20, 2023

thebino commented Mar 20, 2023

thebino commented Jan 26, 2023 •

edited

Loading