Benjamin-Dobell / Heimdall

Heimdall is a cross-platform open-source tool suite used to flash firmware (aka ROMs) onto Samsung Galaxy devices.
MIT License
2.58k stars 585 forks source link

Unable to communicate with Samsung Galaxy Camera 2 in download mode #302

Open realchrisolin opened 8 years ago

realchrisolin commented 8 years ago

Previously, I've been able to flash images on this device using Hemidall, but now I encounter constant errors when Heimdall tries to intialise a connection protocol:

libusb0:

[ 0.319032] [00002a14] libusb: debug [libusb_unref_device] destroy device 3.0
[ 0.319032] [00002a14] libusb: debug [libusb_open] open 1.5
[ 0.319032] [00002a14] libusb: debug [libusb_get_device_descriptor]
[ 0.319032] [00002a14] libusb: debug [libusb_alloc_transfer] transfer 0000000000378790
[ 0.319032] [00002a14] libusb: debug [libusb_submit_transfer] transfer 0000000000378790
[ 0.319032] [00002a14] libusb: debug [libusb_claim_interface] interface 0
[ 0.319032] [00002a14] libusb: debug [winusbx_claim_interface] claimed interface 0
[ 0.319032] [00002a14] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.319032] [00002a14] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 83 to interface 0
[ 0.319032] [00002a14] libusb: debug [auto_claim] auto-claimed interface 0 for control request
[ 0.319032] [00002a14] libusb: debug [winusbx_submit_control_transfer] will use interface 0
[ 0.319032] [00002a14] libusb: debug [usbi_add_pollfd] add fd 1 events 1
[ 0.319032] [00002a14] libusb: debug [libusb_get_next_timeout] next timeout in 0.999620s
[ 0.319032] [00002a14] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.320032] [00002a14] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.320032] [00002a14] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.320032] [00002a14] libusb: debug [handle_events] poll() returned 1
[ 0.320032] [00002a14] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 0.320032] [00002a14] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.320032] [00002a14] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 255
[ 0.320032] [00002a14] libusb: debug [libusb_release_interface] interface 0
[ 0.320032] [00002a14] libusb: debug [auto_release] auto-released interface 0
[ 0.320032] [00002a14] libusb: debug [usbi_handle_transfer_completion] transfer 0000000000378790 has callback 0000000000415da0
[ 0.320032] [00002a14] libusb: debug [sync_transfer_cb] actual_length=255
[ 0.320032] [00002a14] libusb: debug [libusb_free_transfer] transfer 0000000000378790
[ 0.320032] [00002a14] libusb: debug [libusb_alloc_transfer] transfer 0000000000378790
[ 0.320032] [00002a14] libusb: debug [libusb_submit_transfer] transfer 0000000000378790
[ 0.320032] [00002a14] libusb: debug [libusb_claim_interface] interface 0
[ 0.320032] [00002a14] libusb: debug [winusbx_claim_interface] claimed interface 0
[ 0.320032] [00002a14] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.320032] [00002a14] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 83 to interface 0
[ 0.320032] [00002a14] libusb: debug [auto_claim] auto-claimed interface 0 for control request
[ 0.320032] [00002a14] libusb: debug [winusbx_submit_control_transfer] will use interface 0
[ 0.320032] [00002a14] libusb: debug [usbi_add_pollfd] add fd 1 events 1
[ 0.320032] [00002a14] libusb: debug [libusb_get_next_timeout] next timeout in 0.999619s
[ 0.320032] [00002a14] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.320032] [00002a14] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.320032] [00002a14] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.320032] [00002a14] libusb: debug [handle_events] poll() returned 1
[ 0.320032] [00002a14] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 0.320032] [00002a14] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.320032] [00002a14] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 255
[ 0.320032] [00002a14] libusb: debug [libusb_release_interface] interface 0
[ 0.320032] [00002a14] libusb: debug [auto_release] auto-released interface 0
[ 0.320032] [00002a14] libusb: debug [usbi_handle_transfer_completion] transfer 0000000000378790 has callback 0000000000415da0
[ 0.320032] [00002a14] libusb: debug [sync_transfer_cb] actual_length=255
[ 0.320032] [00002a14] libusb: debug [libusb_free_transfer] transfer 0000000000378790
[ 0.320032] [00002a14] libusb: debug [libusb_alloc_transfer] transfer 0000000000378790
[ 0.320032] [00002a14] libusb: debug [libusb_submit_transfer] transfer 0000000000378790
[ 0.320032] [00002a14] libusb: debug [libusb_claim_interface] interface 0
[ 0.320032] [00002a14] libusb: debug [winusbx_claim_interface] claimed interface 0
[ 0.320032] [00002a14] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.320032] [00002a14] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 83 to interface 0
[ 0.320032] [00002a14] libusb: debug [auto_claim] auto-claimed interface 0 for control request

Product: "Gadget Serial"
            length: 18
      device class: 2
               S/N: 0
           VID:PID: 04E8:685D
         bcdDevice: 021B
   iMan:iProd:iSer: 1:2:0
          nb confs: 1

interface[0].altsetting[0]: num endpoints = 1
   Class.SubClass.Protocol: 02.02.01
       endpoint[0].address: 83
           max packet size: 0010
          polling interval: 09

interface[1].altsetting[0]: num endpoints = 2
   Class.SubClass.Protocol: 0A.00.00
       endpoint[0].address: 81
           max packet size: 0200
          polling interval: 00
       endpoint[1].address: 02
           max packet size: 0200
          polling interval: 00
Claiming interface...
Setting up interface...
0002a14] libusb: debug [winusbx_submit_control_transfer] will use interface 0
[ 0.320032] [00002a14] libusb: debug [usbi_add_pollfd] add fd 1 events 1
[ 0.320032] [00002a14] libusb: debug [libusb_get_next_timeout] next timeout in 0.999620s
[ 0.320032] [00002a14] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.320032] [00002a14] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.320032] [00002a14] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.320032] [00002a14] libusb: debug [handle_events] poll() returned 1
[ 0.320032] [00002a14] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 0.320032] [00002a14] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.320032] [00002a14] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 255
[ 0.320032] [00002a14] libusb: debug [libusb_release_interface] interface 0
[ 0.320032] [00002a14] libusb: debug [auto_release] auto-released interface 0
[ 0.320032] [00002a14] libusb: debug [usbi_handle_transfer_completion] transfer 0000000000378790 has callback 0000000000415da0
[ 0.320032] [00002a14] libusb: debug [sync_transfer_cb] actual_length=255
[ 0.320032] [00002a14] libusb: debug [libusb_free_transfer] transfer 0000000000378790
[ 0.320032] [00002a14] libusb: debug [libusb_alloc_transfer] transfer 0000000000378790
[ 0.320032] [00002a14] libusb: debug [libusb_submit_transfer] transfer 0000000000378790
[ 0.320032] [00002a14] libusb: debug [libusb_claim_interface] interface 0
[ 0.320032] [00002a14] libusb: debug [winusbx_claim_interface] claimed interface 0
[ 0.320032] [00002a14] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.320032] [00002a14] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 83 to interface 0
[ 0.320032] [00002a14] libusb: debug [auto_claim] auto-claimed interface 0 for control request
[ 0.321032] [00002a14] libusb: debug [winusbx_submit_control_transfer] will use interface 0
[ 0.321032] [00002a14] libusb: debug [usbi_add_pollfd] add fd 1 events 1
[ 0.321032] [00002a14] libusb: debug [libusb_get_next_timeout] next timeout in 0.999619s
[ 0.321032] [00002a14] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.321032] [00002a14] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.321032] [00002a14] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.321032] [00002a14] libusb: debug [handle_events] poll() returned 1
[ 0.321032] [00002a14] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 0.321032] [00002a14] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.321032] [00002a14] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 255
[ 0.321032] [00002a14] libusb: debug [libusb_release_interface] interface 0
[ 0.321032] [00002a14] libusb: debug [auto_release] auto-released interface 0
[ 0.321032] [00002a14] libusb: debug [usbi_handle_transfer_completion] transfer 0000000000378790 has callback 0000000000415da0
[ 0.321032] [00002a14] libusb: debug [sync_transfer_cb] actual_length=255
[ 0.321032] [00002a14] libusb: debug [libusb_free_transfer] transfer 0000000000378790
[ 0.321032] [00002a14] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.321032] [00002a14] libusb: debug [libusb_claim_interface] interface 1
[ 0.321032] [00002a14] libusb: warning [winusbx_claim_interface] auto-claimed interface 0 (required to claim 1 with WinUSB)
[ 0.321032] [00002a14] libusb: debug [winusbx_claim_interface] claimed interface 1
[ 0.321032] [00002a14] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.321032] [00002a14] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 81 to interface 1
[ 0.321032] [00002a14] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 02 to interface 1
[ 0.321032] [00002a14] libusb: debug [libusb_set_interface_alt_setting] interface 1 altsetting 0
[ 0.389039] [00002a14] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.389039] [00002a14] libusb: debug
Initialising protocol...
[windows_assign_endpoints] (re)assigned endpoint 81 to interface 1
[ 0.389039] [00002a14] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 02 to interface 1
[ 0.389039] [00002a14] libusb: debug [libusb_alloc_transfer] transfer 0000000000378790
[ 0.389039] [00002a14] libusb: debug [libusb_submit_transfer] transfer 0000000000378790
[ 0.389039] [00002a14] libusb: debug [winusbx_submit_bulk_transfer] matched endpoint 02 with interface 1
[ 0.389039] [00002a14] libusb: debug [winusbx_submit_bulk_transfer] writing 4 bytes
[ 0.389039] [00002a14] libusb: debug [usbi_add_pollfd] add fd 1 events 4
[ 0.389039] [00002a14] libusb: debug [libusb_get_next_timeout] next timeout in 1.000000s
[ 0.389039] [00002a14] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.389039] [00002a14] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.389039] [00002a14] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.389039] [00002a14] libusb: debug [handle_events] poll() returned 1
[ 0.389039] [00002a14] libusb: debug [windows_handle_events] checking fd 1 with revents = 0004
[ 0.389039] [00002a14] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.389039] [00002a14] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 4
[ 0.389039] [00002a14] libusb: debug [usbi_handle_transfer_completion] transfer 0000000000378790 has callback 0000000000415da0
[ 0.389039] [00002a14] libusb: debug [sync_transfer_cb] actual_length=4
[ 0.389039] [00002a14] libusb: debug [libusb_free_transfer] transfer 0000000000378790
[ 0.389039] [00002a14] libusb: debug [libusb_alloc_transfer] transfer 0000000000378790
[ 0.389039] [00002a14] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 1.389139] [00002a14] libusb: debug [handle_events] poll() returned 0
[ 1.389139] [00002a14] libusb: debug [libusb_get_next_timeout] next timeout in 0.000381s
[ 1.389139] [00002a14] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 1.389139] [00002a14] libusb: debug [handle_events] poll() 2 fds with timeout in 1ms
[ 1.390139] [00002a14] libusb: debug [handle_events] poll() returned 0
[ 1.390139] [00002a14] libusb: debug [libusb_cancel_transfer] transfer 0000000000378790
[ 1.390139] [00002a14] libusb: debug [winusbx_abort_transfers] will use interface 1
[ 1.390139] [00002a14] libusb: debug [libusb_get_next_timeout] no URB with timeout or all handled by OS; no timeout!
[ 1.390139] [00002a14] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 1.390139] [00002a14] libusb: debug [handle_events] poll() 2 fds with timeout in 60000ms
[ 1.390139] [00002a14] libusb: debug [handle_events] poll() returned 1
[ 1.390139] [00002a14] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 1.390139] [00002a14] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 1.390139] [00002a14] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 995, size 0
[ 1.390139] [00002a14] libusb: debug [windows_transfer_callback] detected timeout
[ 1.390139] [00002a14] libusb: debug [usbi_handle_transfer_completion] transfer 0000000000378790 has callback 0000000000415da0
[ 1.390139] [00002a14] libusb: debug [sync_transfer_cb] actual_length=0
[ 1.390139] [00002a14] libusb: debug [libusb_free_transfer] transfer 0000000000378790
ERROR: Failed to receive handshake response. Result: -7
ERROR: Protocol initialisation failed!

Releasing device interface...

WinUSB:

[ 0.330000] [00000a20] libusb: debug [get_api_type] driver(s): WinUSB
[ 0.331000] [00000a20] libusb: debug [get_api_type] matched driver name against WinUSB
[ 0.331000] [00000a20] libusb: debug [libusb_unref_device] destroy device 4.0
[ 0.331000] [00000a20] libusb: debug [libusb_get_device_descriptor]
[ 0.331000] [00000a20] libusb: debug [libusb_get_device_descriptor]
[ 0.331000] [00000a20] libusb: debug [libusb_get_device_descriptor]
[ 0.331000] [00000a20] libusb: debug [libusb_get_device_descriptor]
[ 0.331000] [00000a20] libusb: debug [libusb_unref_device] destroy device 1.4
[ 0.331000] [00000a20] libusb: debug [libusb_unref_device] destroy device 3.4
[ 0.331000] [00000a20] libusb: debug [libusb_unref_device] destroy device 2.4
[ 0.331000] [00000a20] libusb: debug [libusb_unref_device] destroy device 3.3
[ 0.331000] [00000a20] libusb: debug [libusb_unref_device] destroy device 1.7
[ 0.331000] [00000a20] libusb: debug [libusb_unref_device] destroy device 1.6
[ 0.331000] [00000a20] libusb: debug [libusb_unref_device] destroy device 3.2
[ 0.331000] [00000a20] libusb: debug [libusb_unref_device] destroy device 2.3
[ 0.331000] [00000a20] libusb: debug [libusb_unref_device] destroy device 2.2
[ 0.331000] [00000a20] libusb: debug [libusb_unref_device] destroy device 2.1
[ 0.331000] [00000a20] libusb: debug [libusb_unref_device] destroy device 2.0
[ 0.331000] [00000a20] libusb: debug [libusb_unref_device] destroy device 3.1
[ 0.331000] [00000a20] libusb: debug [libusb_unref_device] destroy device 3.0
[ 0.331000] [00000a20] libusb: debug [libusb_open] open 1.8
[ 0.331000] [00000a20] libusb: debug [libusb_get_device_descriptor]
[ 0.331000] [00000a20] libusb: debug [libusb_alloc_transfer] transfer 0000000000378790
[ 0.331000] [00000a20] libusb: debu      Manufacturer: "SAMSUNG"
g [libusb_submit_transfer] transfer 0000000000378790
[ 0.331000] [00000a20] libusb: debug [libusb_claim_interface] interface 0
[ 0.332000] [00000a20] libusb: debug [winusbx_claim_interface] claimed interface 0
[ 0.332000] [00000a20] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.332000] [00000a20] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 83 to interface 0
[ 0.362000] [00000a20] libusb: debug [auto_claim] auto-claimed interface 0 for control request
[ 0.362000] [00000a20] libusb: debug [winusbx_submit_control_transfer] will use interface 0
[ 0.362000] [00000a20] libusb: debug [usbi_add_pollfd] add fd 1 events 1
[ 0.362000] [00000a20] libusb: debug [libusb_get_next_timeout] next timeout in 0.969181s
[ 0.362000] [00000a20] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.362000] [00000a20] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.362000] [00000a20] libusb: debug [handle_events] poll() 2 fds with timeout in 970ms
[ 0.362000] [00000a20] libusb: debug [handle_events] poll() returned 1
[ 0.362000] [00000a20] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 0.362000] [00000a20] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.362000] [00000a20] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 4
[ 0.362000] [00000a20] libusb: debug [libusb_release_interface] interface 0
[ 0.362000] [00000a20] libusb: debug [auto_release] auto-released interface 0
[ 0.362000] [00000a20] libusb: debug [usbi_handle_transfer_completion] transfer 0000000000378790 has callback 0000000000415da0
[ 0.362000] [00000a20] libusb: debug [sync_transfer_cb] actual_length=4
[ 0.363000] [00000a20] libusb: debug [libusb_free_transfer] transfer 0000000000378790
[ 0.363000] [00000a20] libusb: debug [libusb_alloc_transfer] transfer 0000000000378790
[ 0.363000] [00000a20] libusb: debug [libusb_submit_transfer] transfer 0000000000378790
[ 0.363000] [00000a20] libusb: debug [libusb_claim_interface] interface 0
[ 0.363000] [00000a20] libusb: debug [winusbx_claim_interface] claimed interface 0
[ 0.363000] [00000a20] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.363000] [00000a20] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 83 to interface 0
[ 0.363000] [00000a20] libusb: debug [auto_claim] auto-claimed interface 0 for control request
[ 0.363000] [00000a20] libusb: debug [winusbx_submit_control_transfer] will use interface 0
[ 0.363000] [00000a20] libusb: debug [usbi_add_pollfd] add fd 1 events 1
[ 0.363000] [00000a20] libusb: debug [libusb_get_next_timeout] next timeout in 0.999619s
[ 0.363000] [00000a20] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.363000] [00000a20] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.363000] [00000a20] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.363000] [00000a20] libusb: debug [handle_events] poll() returned 1
[ 0.363000] [00000a20] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 0.363000] [00000a20] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.363000] [00000a20] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 16
[ 0.363000] [00000a20] libusb: debug [libusb_release_interface] interface 0
[ 0.363000] [00000a20] libusb: debug [auto_release] auto-released interface 0
[ 0.363000] [00000a20] libusb: debug [usbi_handle_transfer_completion] transfer 0000000000378790 has callback 0000000000415da0
[ 0.363000] [00000a20] libusb: debug [sync_transfer_cb] actual_length=16
[ 0.363000] [00000a20] libusb: debug [libusb_free_transfer] transfer 0000000000378790
[ 0.363000] [00000a20] libusb: debug [libusb_alloc_transfer] transfer 0000000000378790
[ 0.363000] [00000a20] libusb: debug [libusb_submit_transfer] transfer 0000000000378790
[ 0.363000] [00000a20] libusb: debug [libusb_claim_interface] interface 0
[ 0.363000] [00000a20] libusb: debug [winusbx_claim_interface] claimed interface 0

Product: "Gadget Serial"
            length: 18
      device class: 2
               S/N: 0
           VID:PID: 04E8:685D
         bcdDevice: 021B
   iMan:iProd:iSer: 1:2:0
          nb confs: 1

interface[0].altsetting[0]: num endpoints = 1
   Class.SubClass.Protocol: 02.02.01
       endpoint[0].address: 83
           max packet size: 0010
          polling interval: 09

interface[1].altsetting[0]: num endpoints = 2
   Class.SubClass.Protocol: 0A.00.00
       endpoint[0].address: 81
           max packet size: 0200
          polling interval: 00
       endpoint[1].address: 02
           max packet size: 0200
          polling interval: 00
Claiming interface...
sb: debug [libusb_get_config_descriptor] index 0
[ 0.364000] [00000a20] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 83 to interface 0
[ 0.364000] [00000a20] libusb: debug [auto_claim] auto-claimed interface 0 for control request
[ 0.364000] [00000a20] libusb: debug [winusbx_submit_control_transfer] will use interface 0
[ 0.364000] [00000a20] libusb: debug [usbi_add_pollfd] add fd 1 events 1
[ 0.364000] [00000a20] libusb: debug [libusb_get_next_timeout] next timeout in 0.999619s
[ 0.364000] [00000a20] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.364000] [00000a20] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.364000] [00000a20] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.364000] [00000a20] libusb: debug [handle_events] poll() returned 1
[ 0.364000] [00000a20] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 0.364000] [00000a20] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.364000] [00000a20] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 4
[ 0.364000] [00000a20] libusb: debug [libusb_release_interface] interface 0
[ 0.364000] [00000a20] libusb: debug [auto_release] auto-released interface 0
[ 0.364000] [00000a20] libusb: debug [usbi_handle_transfer_completion] transfer 0000000000378790 has callback 0000000000415da0
[ 0.364000] [00000a20] libusb: debug [sync_transfer_cb] actual_length=4
[ 0.364000] [00000a20] libusb: debug [libusb_free_transfer] transfer 0000000000378790
[ 0.364000] [00000a20] libusb: debug [libusb_alloc_transfer] transfer 0000000000378790
[ 0.364000] [00000a20] libusb: debug [libusb_submit_transfer] transfer 0000000000378790
[ 0.364000] [00000a20] libusb: debug [libusb_claim_interface] interface 0
[ 0.364000] [00000a20] libusb: debug [winusbx_claim_interface] claimed interface 0
[ 0.364000] [00000a20] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.364000] [00000a20] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 83 to interface 0
[ 0.364000] [00000a20] libusb: debug [auto_claim] auto-claimed interface 0 for control request
[ 0.364000] [00000a20] libusb: debug [winusbx_submit_control_transfer] will use interface 0
[ 0.364000] [00000a20] libusb: debug [usbi_add_pollfd] add fd 1 events 1
[ 0.364000] [00000a20] libusb: debug [libusb_get_next_timeout] next timeout in 1.000000s
[ 0.364000] [00000a20] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.364000] [00000a20] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.364000] [00000a20] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.364000] [00000a20] libusb: debug [handle_events] poll() returned 1
[ 0.364000] [00000a20] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 0.364000] [00000a20] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.364000] [00000a20] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 28
[ 0.364000] [00000a20] libusb: debug [libusb_release_interface] interface 0
[ 0.364000] [00000a20] libusb: debug [auto_release] auto-released interface 0
[ 0.364000] [00000a20] libusb: debug [usbi_handle_transfer_completion] transfer 0000000000378790 has callback 0000000000415da0
[ 0.364000] [00000a20] libusb: debug [sync_transfer_cb] actual_length=28
[ 0.364000] [00000a20] libusb: debug [libusb_free_transfer] transfer 0000000000378790
[ 0.364000] [00000a20] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.365000] [00000a20] libusb: debug [libusb_claim_interface] interface 1
[ 0.365000] [00000a20] libusb: warning [winusbx_claim_interface] auto-claimed interface 0 (required to claim 1 with WinUSB)
[ 0.365000] [00000a20] libusb: debug [winusbx_claim_interface] claimed interface 1
[ 0.365000] [00000a20] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.365000] [00000a20] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 81 to interface 1
[ 0.365000] [00000a20] libusb: debug [windows_assign_endpoSetting up interface...

Initialising protocol...
ints] (re)assigned endpoint 02 to interface 1
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to set PIPE_TRANSFER_TIMEOUT for control endpoint 81
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to disable SHORT_PACKET_TERMINATE for endpoint 81
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to disable IGNORE_SHORT_PACKETS for endpoint 81
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to enable ALLOW_PARTIAL_READS for endpoint 81
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to enable AUTO_CLEAR_STALL for endpoint 81
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to set PIPE_TRANSFER_TIMEOUT for control endpoint 02
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to disable SHORT_PACKET_TERMINATE for endpoint 02
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to disable IGNORE_SHORT_PACKETS for endpoint 02
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to enable ALLOW_PARTIAL_READS for endpoint 02
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to enable AUTO_CLEAR_STALL for endpoint 02
[ 0.365000] [00000a20] libusb: debug [libusb_set_interface_alt_setting] interface 1 altsetting 0
[ 0.365000] [00000a20] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.365000] [00000a20] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 81 to interface 1
[ 0.365000] [00000a20] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 02 to interface 1
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to set PIPE_TRANSFER_TIMEOUT for control endpoint 81
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to disable SHORT_PACKET_TERMINATE for endpoint 81
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to disable IGNORE_SHORT_PACKETS for endpoint 81
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to enable ALLOW_PARTIAL_READS for endpoint 81
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to enable AUTO_CLEAR_STALL for endpoint 81
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to set PIPE_TRANSFER_TIMEOUT for control endpoint 02
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to disable SHORT_PACKET_TERMINATE for endpoint 02
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to disable IGNORE_SHORT_PACKETS for endpoint 02
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to enable ALLOW_PARTIAL_READS for endpoint 02
[ 0.365000] [00000a20] libusb: debug [winusbx_configure_endpoints] failed to enable AUTO_CLEAR_STALL for endpoint 02
[ 0.365000] [00000a20] libusb: debug [libusb_alloc_transfer] transfer 0000000000378790
[ 0.365000] [00000a20] libusb: debug [libusb_submit_transfer] transfer 0000000000378790
[ 0.365000] [00000a20] libusb: debug [winusbx_submit_bulk_transfer] matched endpoint 02 with interface 1
[ 0.365000] [00000a20] libusb: debug [winusbx_submit_bulk_transfer] writing 4 bytes
[ 0.365000] [00000a20] libusb: debug [usbi_add_pollfd] add fd 1 events 4
[ 0.365000] [00000a20] libusb: debug [libusb_get_next_timeout] next timeout in 1.000000s
[ 0.365000] [00000a20] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.365000] [00000a20] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.365000] [00000a20] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.365000] [00000a20] libusb: debug [handle_events] poll() returned 1
[ 0.365000] [00000a20] libusb: debug [windows_handle_events] checking fd 1 with revents = 0004
[ 0.365000] [00000a20] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.365000] [00000a20] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 87, size 0
[ 0.365000] [00000a20] libusb: error [windows_transfer_callback] detected I/O error 87: [87] The parameter is incorrect.
[ 0.365000] [00000a20] libusb: debug [usbi_handle_transfer_completion] transfer 0000000000378790 has callback 0000000000415da0
[ 0.365000] [00000a20] libusb: debug [sync_transfer_cb] actual_length=0
[ 0.365000] [00000a20] libusb: debug [libusb_free_transfer] transfer 0000000000378790
ERROR: libusb error -1 whilst sending bulk transfer. Retrying...
[ 0.615000] [00000a20] libusb: debug [libusb_alloc_transfer] transfer 0000000000378790
[ 0.615000] [00000a20] libusb: debug [libusb_submit_transfer] transfer 0000000000378790
[ 0.615000] [00000a20] libusb: debug [winusbx_submit_bulk_transfer] matched endpoint 02 with interface 1
[ 0.615000] [00000a20] libusb: debug [winusbx_submit_bulk_transfer] writing 4 bytes
[ 0.615000] [00000a20] libusb: debug [usbi_add_pollfd] add fd 1 events 4
[ 0.615000] [00000a20] libusb: debug [libusb_get_next_timeout] next timeout in 1.000000s
[ 0.615000] [00000a20] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.615000] [00000a20] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.615000] [00000a20] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.615000] [00000a20] libusb: debug [handle_events] poll() returned 1
[ 0.615000] [00000a20] libusb: debug [windows_handle_events] checking fd 1 with revents = 0004
[ 0.615000] [00000a20] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.615000] [00000a20] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 87, size 0
[ 0.615000] [00000a20] libusb: error [windows_transfer_callback] detected I/O error 87: [87] The parameter is incorrect.
[ 0.615000] [00000a20] libusb: debug [usbi_handle_transfer_completion] transfer 0000000000378790 has callback 0000000000415da0
[ 0.615000] [00000a20] libusb: debug [sync_transfer_cb] actual_length=0
[ 0.615000] [00000a20] libusb: debug [libusb_free_transfer] transfer 0000000000378790
ERROR: libusb error -1 whilst sending bulk transfer. Retrying...
[ 1.115000] [00000a20] libusb: debug [libusb_alloc_transfer] transfer 0000000000378790
[ 1.115000] [00000a20] libusb: debug [libusb_submit_transfer] transfer 0000000000378790
[ 1.115000] [00000a20] libusb: debug [winusbx_submit_bulk_transfer] matched endpoint 02 with interface 1
[ 1.115000] [00000a20] libusb: debug [winusbx_submit_bulk_transfer] writing 4 bytes
[ 1.115000] [00000a20] libusb: debug [usbi_add_pollfd] add fd 1 events 4
[ 1.115000] [00000a20] libusb: debug [libusb_get_next_timeout] next timeout in 1.000000s
[ 1.115000] [00000a20] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 1.115000] [00000a20] libusb: debug [handle_events] poll fds modified, reallocating
[ 1.115000] [00000a20] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 1.115000] [00000a20] libusb: debug [handle_events] poll() returned 1
[ 1.115000] [00000a20] libusb: debug [windows_handle_events] checking fd 1 with revents = 0004
[ 1.115000] [00000a20] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 1.115000] [00000a20] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 87, size 0
[ 1.115000] [00000a20] libusb: error [windows_transfer_callback] detected I/O error 87: [87] The parameter is incorrect.
[ 1.115000] [00000a20] libusb: debug [usbi_handle_transfer_completion] transfer 0000000000378790 has callback 0000000000415da0
[ 1.115000] [00000a20] libusb: debug [sync_transfer_cb] actual_length=0
[ 1.115000] [00000a20] libusb: debug [libusb_free_transfer] transfer 0000000000378790
ERROR: libusb error -1 whilst sending bulk transfer. Retrying...
[ 1.865000] [00000a20] libusb: debug [libusb_alloc_transfer] transfer 0000000000378790
[ 1.865000] [00000a20] libusb: debug [libusb_submit_transfer] transfer 0000000000378790
[ 1.866000] [00000a20] libusb: debug [winusbx_submit_bulk_transfer] matched endpoint 02 with interface 1
[ 1.866000] [00000a20] libusb: debug [winusbx_submit_bulk_transfer] writing 4 bytes
[ 1.867000] [00000a20] libusb: debug [usbi_add_pollfd] add fd 1 events 4
[ 1.867000] [00000a20] libusb: debug [libusb_get_next_timeout] next timeout in 0.999619s
[ 1.867000] [00000a20] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 1.867000] [00000a20] libusb: debug [handle_events] poll fds modified, reallocating
[ 1.867000] [00000a20] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 1.867000] [00000a20] libusb: debug [handle_events] poll() returned 1
[ 1.867000] [00000a20] libusb: debug [windows_handle_events] checking fd 1 with revents = 0004
[ 1.867000] [00000a20] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 1.867000] [00000a20] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 87, size 0
[ 1.867000] [00000a20] libusb: error [windows_transfer_callback] detected I/O error 87: [87] The parameter is incorrect.
[ 1.867000] [00000a20] libusb: debug [usbi_handle_transfer_completion] transfer 0000000000378790 has callback 0000000000415da0
[ 1.867000] [00000a20] libusb: debug [sync_transfer_cb] actual_length=0
[ 1.867000] [00000a20] libusb: debug [libusb_free_transfer] transfer 0000000000378790
ERROR: libusb error -1 whilst sending bulk transfer. Retrying...
[ 1.867000] [00000a20] libusb: debug [libusb_alloc_transfer] transfer 0000000000378790
[ 1.867000] [00000a20] libusb: debug [libusb_submit_transfer] transfer 0000000000378790
[ 1.867000] [00000a20] libusb: debug [winusbx_submit_bulk_transfer] matched endpoint 02 with interface 1
[ 1.867000] [00000a20] libusb: debug [winusbx_submit_bulk_transfer] writing 4 bytes
[ 1.867000] [00000a20] libusb: debug [usbi_add_pollfd] add fd 1 events 4
[ 1.867000] [00000a20] libusb: debug [libusb_get_next_timeout] next timeout in 1.000000s
[ 1.867000] [00000a20] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 1.867000] [00000a20] libusb: debug [handle_events] poll fds modified, reallocating
[ 1.867000] [00000a20] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 1.867000] [00000a20] libusb: debug [handle_events] poll() returned 1
[ 1.867000] [00000a20] libusb: debug [windows_handle_events] checking fd 1 with revents = 0004
[ 1.867000] [00000a20] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 1.867000] [00000a20] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 87, size 0
[ 1.867000] [00000a20] libusb: error [windows_transfer_callback] detected I/O error 87: [87] The parameter is incorrect.
[ 1.867000] [00000a20] libusb: debug [usbi_handle_transfer_completion] transfer 0000000000378790 has callback 0000000000415da0
[ 1.867000] [00000a20] libusb: debug [sync_transfer_cb] actual_length=0
[ 1.867000] [00000a20] libusb: debug [libusb_free_transfer] transfer 0000000000378790
ERROR: libusb error -1 whilst sending bulk transfer. Retrying...
[ 1.867000] [00000a20] libusb: debug [libusb_alloc_transfer] transfer 0000000000378790
[ 1.867000] [00000a20] libusb: debug [libusb_submit_transfer] transfer 0000000000378790
[ 1.867000] [00000a20] libusb: debug [winusbx_submit_bulk_transfer] matched endpoint 02 with interface 1
[ 1.867000] [00000a20] libusb: debug [winusbx_submit_bulk_transfer] writing 4 bytes
[ 1.867000] [00000a20] libusb: debug [usbi_add_pollfd] add fd 1 events 4
[ 1.867000] [00000a20] libusb: debug [libusb_get_next_timeout] next timeout in 1.000000s
[ 1.867000] [00000a20] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 1.867000] [00000a20] libusb: debug [handle_events] poll fds modified, reallocating
[ 1.867000] [00000a20] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 1.867000] [00000a20] libusb: debug [handle_events] poll() returned 1
[ 1.867000] [00000a20] libusb: debug [windows_handle_events] checking fd 1 with revents = 0004
[ 1.867000] [00000a20] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 1.867000] [00000a20] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 87, size 0
[ 1.867000] [00000a20] libusb: error [windows_transfer_callback] detected I/O error 87: [87] The parameter is incorrect.
[ 1.867000] [00000a20] libusb: debug [usbi_handle_transfer_completion] transfer 0000000000378790 has callback 0000000000415da0
[ 1.867000] [00000a20] libusb: debug [sync_transfer_cb] actual_length=0
[ 1.867000] [00000a20] libusb: debug [libusb_free_transfer] transfer 0000000000378790
ERROR: libusb error -1 whilst sending bulk transfer.
ERROR: Failed to send handshake![ 1.867000] [00000a20] libusb: debug [libusb_alloc_transfer] transfer 0000000000378790
[ 1.867000] [00000a20] libusb: debug [libusb_submit_transfer] transfer 0000000000378790
[ 1.867000] [00000a20] libusb: debug [winusbx_submit_bulk_transfer] matched endpoint 81 with interface 1
[ 1.867000] [00000a20] libusb: debug [winusbx_submit_bulk_transfer] reading 7 bytes
[ 1.867000] [00000a20] libusb: debug [usbi_add_pollfd] add fd 1 events 1
[ 1.868000] [00000a20] libusb: debug [libusb_get_next_timeout] next timeout in 0.999619s
[ 1.868000] [00000a20] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 1.868000] [00000a20] libusb: debug [handle_events] poll fds modified, reallocating
[ 1.868000] [00000a20] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 1.868000] [00000a20] libusb: debug [handle_events] poll() returned 1
[ 1.868000] [00000a20] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 1.868000] [00000a20] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 1.868000] [00000a20] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 87, size 0
[ 1.868000] [00000a20] libusb: error [windows_transfer_callback] detected I/O error 87: [87] The parameter is incorrect.
[ 1.868000] [00000a20] libusb: debug [usbi_handle_transfer_completion] transfer 0000000000378790 has callback 0000000000415da0
[ 1.868000] [00000a20] libusb: debug [sync_transfer_cb] actual_length=0
[ 1.868000] [00000a20] libusb: debug [libusb_free_transfer] transfer 0000000000378790
ERROR: Failed to receive handshake response. Result: -1
ERROR: Protocol initialisation failed!

Releasing device interface...

libusbK:

[ 0.317000] [00002a50] libusb: debug [get_api_type] driver(s): libusbK
[ 0.317000] [00002a50] libusb: debug [get_api_type] matched driver name against libusbK
[ 0.317000] [00002a50] libusb: debug [libusb_unref_device] destroy device 4.0
[ 0.317000] [00002a50] libusb: debug [libusb_get_device_descriptor]
[ 0.317000] [00002a50] libusb: debug [libusb_get_device_descriptor]
[ 0.317000] [00002a50] libusb: debug [libusb_get_device_descriptor]
[ 0.317000] [00002a50] libusb: debug [libusb_get_device_descriptor]
[ 0.317000] [00002a50] libusb: debug [libusb_unref_device] destroy device 1.4
[ 0.317000] [00002a50] libusb: debug [libusb_unref_device] destroy device 3.4
[ 0.317000] [00002a50] libusb: debug [libusb_unref_device] destroy device 2.4
[ 0.317000] [00002a50] libusb: debug [libusb_unref_device] destroy device 3.3
[ 0.317000] [00002a50] libusb: debug [libusb_unref_device] destroy device 1.7
[ 0.317000] [00002a50] libusb: debug [libusb_unref_device] destroy device 1.6
[ 0.317000] [00002a50] libusb: debug [libusb_unref_device] destroy device 3.2
[ 0.317000] [00002a50] libusb: debug [libusb_unref_device] destroy device 2.3
[ 0.317000] [00002a50] libusb: debug [libusb_unref_device] destroy device 2.2
[ 0.317000] [00002a50] libusb: debug [libusb_unref_device] destroy device 2.1
[ 0.317000] [00002a50] libusb: debug [libusb_unref_device] destroy device 2.0
[ 0.317000] [00002a50] libusb: debug [libusb_unref_device] destroy device 3.1
[ 0.317000] [00002a50] libusb: debug [libusb_unref_device] destroy device 3.0
[ 0.317000] [00002a50] libusb: debug [libusb_open] open 1.5
[ 0.317000] [00002a50] libusb: debug [libusb_get_device_descriptor]
[ 0.317000] [00002a50] libusb: debug [libusb_alloc_transfer] transfer 00000000006d8790
[ 0.317000] [00002a50] libusb:       Manufacturer: "SAMSUNG"
debug [libusb_submit_transfer] transfer 00000000006d8790
[ 0.317000] [00002a50] libusb: debug [libusb_claim_interface] interface 0
[ 0.317000] [00002a50] libusb: debug [winusbx_claim_interface] claimed interface 0
[ 0.317000] [00002a50] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.318000] [00002a50] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 83 to interface 0
[ 0.318000] [00002a50] libusb: debug [auto_claim] auto-claimed interface 0 for control request
[ 0.318000] [00002a50] libusb: debug [winusbx_submit_control_transfer] will use interface 0
[ 0.318000] [00002a50] libusb: debug [usbi_add_pollfd] add fd 1 events 1
[ 0.318000] [00002a50] libusb: debug [libusb_get_next_timeout] next timeout in 0.999619s
[ 0.318000] [00002a50] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.318000] [00002a50] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.318000] [00002a50] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.318000] [00002a50] libusb: debug [handle_events] poll() returned 1
[ 0.318000] [00002a50] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 0.318000] [00002a50] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.318000] [00002a50] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 4
[ 0.318000] [00002a50] libusb: debug [libusb_release_interface] interface 0
[ 0.318000] [00002a50] libusb: debug [auto_release] auto-released interface 0
[ 0.318000] [00002a50] libusb: debug [usbi_handle_transfer_completion] transfer 00000000006d8790 has callback 0000000000415da0
[ 0.318000] [00002a50] libusb: debug [sync_transfer_cb] actual_length=4
[ 0.318000] [00002a50] libusb: debug [libusb_free_transfer] transfer 00000000006d8790
[ 0.318000] [00002a50] libusb: debug [libusb_alloc_transfer] transfer 00000000006d8790
[ 0.318000] [00002a50] libusb: debug [libusb_submit_transfer] transfer 00000000006d8790
[ 0.318000] [00002a50] libusb: debug [libusb_claim_interface] interface 0
[ 0.318000] [00002a50] libusb: debug [winusbx_claim_interface] claimed interface 0
[ 0.318000] [00002a50] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.318000] [00002a50] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 83 to interface 0
[ 0.318000] [00002a50] libusb: debug [auto_claim] auto-claimed interface 0 for control request
[ 0.318000] [00002a50] libusb: debug [winusbx_submit_control_transfer] will use interface 0
[ 0.318000] [00002a50] libusb: debug [usbi_add_pollfd] add fd 1 events 1
[ 0.318000] [00002a50] libusb: debug [libusb_get_next_timeout] next timeout in 1.000000s
[ 0.318000] [00002a50] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.318000] [00002a50] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.318000] [00002a50] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.318000] [00002a50] libusb: debug [handle_events] poll() returned 1
[ 0.318000] [00002a50] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 0.318000] [00002a50] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.318000] [00002a50] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 16
[ 0.318000] [00002a50] libusb: debug [libusb_release_interface] interface 0
[ 0.318000] [00002a50] libusb: debug [auto_release] auto-released interface 0
[ 0.318000] [00002a50] libusb: debug [usbi_handle_transfer_completion] transfer 00000000006d8790 has callback 0000000000415da0
[ 0.318000] [00002a50] libusb: debug [sync_transfer_cb] actual_length=16
[ 0.318000] [00002a50] libusb: debug [libusb_free_transfer] transfer 00000000006d8790
[ 0.318000] [00002a50] libusb: debug [libusb_alloc_transfer] transfer 00000000006d8790
[ 0.318000] [00002a50] libusb: debug [libusb_submit_transfer] transfer 00000000006d8790
[ 0.318000] [00002a50] libusb: debug [libusb_claim_interface] interface 0
[ 0.318000] [00002a50] libusb: debug [winusbx_claim_interface] claimed interface 0
[ 0.318000] [00002a50]           Product: "Gadget Serial"

            length: 18
      device class: 2
               S/N: 0
           VID:PID: 04E8:685D
         bcdDevice: 021B
   iMan:iProd:iSer: 1:2:0
          nb confs: 1

interface[0].altsetting[0]: num endpoints = 1
   Class.SubClass.Protocol: 02.02.01
       endpoint[0].address: 83
           max packet size: 0010
          polling interval: 09

interface[1].altsetting[0]: num endpoints = 2
   Class.SubClass.Protocol: 0A.00.00
       endpoint[0].address: 81
           max packet size: 0200
          polling interval: 00
       endpoint[1].address: 02
           max packet size: 0200
          polling interval: 00
Claiming interface...
 libusb: debug [libusb_get_config_descriptor] index 0
[ 0.318000] [00002a50] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 83 to interface 0
[ 0.318000] [00002a50] libusb: debug [auto_claim] auto-claimed interface 0 for control request
[ 0.318000] [00002a50] libusb: debug [winusbx_submit_control_transfer] will use interface 0
[ 0.319000] [00002a50] libusb: debug [usbi_add_pollfd] add fd 1 events 1
[ 0.319000] [00002a50] libusb: debug [libusb_get_next_timeout] next timeout in 1.000000s
[ 0.319000] [00002a50] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.319000] [00002a50] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.319000] [00002a50] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.319000] [00002a50] libusb: debug [handle_events] poll() returned 1
[ 0.319000] [00002a50] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 0.319000] [00002a50] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.319000] [00002a50] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 4
[ 0.319000] [00002a50] libusb: debug [libusb_release_interface] interface 0
[ 0.319000] [00002a50] libusb: debug [auto_release] auto-released interface 0
[ 0.319000] [00002a50] libusb: debug [usbi_handle_transfer_completion] transfer 00000000006d8790 has callback 0000000000415da0
[ 0.319000] [00002a50] libusb: debug [sync_transfer_cb] actual_length=4
[ 0.319000] [00002a50] libusb: debug [libusb_free_transfer] transfer 00000000006d8790
[ 0.319000] [00002a50] libusb: debug [libusb_alloc_transfer] transfer 00000000006d8790
[ 0.319000] [00002a50] libusb: debug [libusb_submit_transfer] transfer 00000000006d8790
[ 0.319000] [00002a50] libusb: debug [libusb_claim_interface] interface 0
[ 0.319000] [00002a50] libusb: debug [winusbx_claim_interface] claimed interface 0
[ 0.319000] [00002a50] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.319000] [00002a50] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 83 to interface 0
[ 0.319000] [00002a50] libusb: debug [auto_claim] auto-claimed interface 0 for control request
[ 0.319000] [00002a50] libusb: debug [winusbx_submit_control_transfer] will use interface 0
[ 0.319000] [00002a50] libusb: debug [usbi_add_pollfd] add fd 1 events 1
[ 0.319000] [00002a50] libusb: debug [libusb_get_next_timeout] next timeout in 1.000000s
[ 0.319000] [00002a50] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.319000] [00002a50] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.319000] [00002a50] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.319000] [00002a50] libusb: debug [handle_events] poll() returned 1
[ 0.319000] [00002a50] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 0.319000] [00002a50] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.319000] [00002a50] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 28
[ 0.319000] [00002a50] libusb: debug [libusb_release_interface] interface 0
[ 0.319000] [00002a50] libusb: debug [auto_release] auto-released interface 0
[ 0.319000] [00002a50] libusb: debug [usbi_handle_transfer_completion] transfer 00000000006d8790 has callback 0000000000415da0
[ 0.319000] [00002a50] libusb: debug [sync_transfer_cb] actual_length=28
[ 0.319000] [00002a50] libusb: debug [libusb_free_transfer] transfer 00000000006d8790
[ 0.319000] [00002a50] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.319000] [00002a50] libusb: debug [libusb_claim_interface] interface 1
[ 0.319000] [00002a50] libusb: warning [winusbx_claim_interface] auto-claimed interface 0 (required to claim 1 with WinUSB)
[ 0.319000] [00002a50] libusb: debug [winusbx_claim_interface] claimed interface 1
[ 0.319000] [00002a50] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.319000] [00002a50] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 81 to interface 1
[ 0.319000] [00002a50] libusb: debug [windows_assign_Setting up interface...

Initialising protocol...
endpoints] (re)assigned endpoint 02 to interface 1
[ 0.319000] [00002a50] libusb: debug [libusb_set_interface_alt_setting] interface 1 altsetting 0
[ 0.319000] [00002a50] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.319000] [00002a50] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 81 to interface 1
[ 0.319000] [00002a50] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 02 to interface 1
[ 0.320000] [00002a50] libusb: debug [libusb_alloc_transfer] transfer 00000000006d8790
[ 0.320000] [00002a50] libusb: debug [libusb_submit_transfer] transfer 00000000006d8790
[ 0.320000] [00002a50] libusb: debug [winusbx_submit_bulk_transfer] matched endpoint 02 with interface 1
[ 0.320000] [00002a50] libusb: debug [winusbx_submit_bulk_transfer] writing 4 bytes
[ 0.320000] [00002a50] libusb: debug [usbi_add_pollfd] add fd 1 events 4
[ 0.320000] [00002a50] libusb: debug [libusb_get_next_timeout] next timeout in 1.000000s
[ 0.320000] [00002a50] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.320000] [00002a50] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.320000] [00002a50] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.320000] [00002a50] libusb: debug [handle_events] poll() returned 1
[ 0.320000] [00002a50] libusb: debug [windows_handle_events] checking fd 1 with revents = 0004
[ 0.320000] [00002a50] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.320000] [00002a50] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 4
[ 0.320000] [00002a50] libusb: debug [usbi_handle_transfer_completion] transfer 00000000006d8790 has callback 0000000000415da0
[ 0.320000] [00002a50] libusb: debug [sync_transfer_cb] actual_length=4
[ 0.320000] [00002a50] libusb: debug [libusb_free_transfer] transfer 00000000006d8790
[ 0.320000] [00002a50] libusb: debug [libusb_alloc_transfer] transfer 00000000006d8790
[ 0.320000] [00002a50] libusb: debug [libusb_submit_transfer] transfer 00000000006d8790
[ 0.320000] [00002a50] libusb: debug [winusbx_submit_bulk_transfer] matched endpoint 81 with interface 1
[ 0.320000] [00002a50] libusb: debug [winusbx_submit_bulk_transfer] reading 7 bytes
[ 0.320000] [00002a50] libusb: debug [usbi_add_pollfd] add fd 1 events 1
[ 0.320000] [00002a50] libusb: debug [libusb_get_next_timeout] next timeout in 1.000000s
[ 0.320000] [00002a50] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.320000] [00002a50] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.320000] [00002a50] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 1.320000] [00002a50] libusb: debug [handle_events] poll() returned 0
[ 1.320000] [00002a50] libusb: debug [libusb_get_next_timeout] next timeout in 0.000381s
[ 1.320000] [00002a50] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 1.320000] [00002a50] libusb: debug [handle_events] poll() 2 fds with timeout in 1ms
[ 1.321000] [00002a50] libusb: debug [handle_events] poll() returned 0
[ 1.321000] [00002a50] libusb: debug [libusb_cancel_transfer] transfer 00000000006d8790
[ 1.321000] [00002a50] libusb: debug [winusbx_abort_transfers] will use interface 1
[ 1.321000] [00002a50] libusb: debug [libusb_get_next_timeout] no URB with timeout or all handled by OS; no timeout!
[ 1.321000] [00002a50] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 1.321000] [00002a50] libusb: debug [handle_events] poll() 2 fds with timeout in 60000ms
[ 1.321000] [00002a50] libusb: debug [handle_events] poll() returned 1
[ 1.321000] [00002a50] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 1.321000] [00002a50] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 1.321000] [00002a50] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 995, size 0
[ 1.321000] [00002a50] libusb: debug [windows_transfer_callback] detected timeout
[ 1.321000] [00002a50] libusb: debug [usbi_handle_transfer_completion] transfer 00000000006d8790 has callback 0000000000415da0
[ 1.321000] [00002a50] libusb: debug [sync_transfer_cb] actual_length=0
[ 1.321000] [00002a50] libusb: debug [libusb_free_transfer] transfer 00000000006d8790
ERROR: Failed to receive handshake response. Result: -7
ERROR: Protocol initialisation failed!

Releasing device interface...

I can't tell if this is a driver issue or a Heimdall issue, but since I'm encountering an issue with all three drivers, I thought I'd open an issue here first.

realchrisolin commented 8 years ago

Received a different error with libusbK:

[ 0.337034] [00000eb4] libusb: debug [get_api_type] driver(s): libusbK
[ 0.337034] [00000eb4] libusb: debug [get_api_type] matched driver name against libusbK
[ 0.337034] [00000eb4] libusb: debug [libusb_unref_device] destroy device 4.0
[ 0.337034] [00000eb4] libusb: debug [libusb_get_device_descriptor]
[ 0.337034] [00000eb4] libusb: debug [libusb_get_device_descriptor]
[ 0.337034] [00000eb4] libusb: debug [libusb_get_device_descriptor]
[ 0.337034] [00000eb4] libusb: debug [libusb_get_device_descriptor]
[ 0.337034] [00000eb4] libusb: debug [libusb_unref_device] destroy device 1.4
[ 0.337034] [00000eb4] libusb: debug [libusb_unref_device] destroy device 3.4
[ 0.337034] [00000eb4] libusb: debug [libusb_unref_device] destroy device 2.4
[ 0.337034] [00000eb4] libusb: debug [libusb_unref_device] destroy device 3.3
[ 0.337034] [00000eb4] libusb: debug [libusb_unref_device] destroy device 1.7
[ 0.337034] [00000eb4] libusb: debug [libusb_unref_device] destroy device 1.6
[ 0.337034] [00000eb4] libusb: debug [libusb_unref_device] destroy device 3.2
[ 0.337034] [00000eb4] libusb: debug [libusb_unref_device] destroy device 2.3
[ 0.337034] [00000eb4] libusb: debug [libusb_unref_device] destroy device 2.2
[ 0.337034] [00000eb4] libusb: debug [libusb_unref_device] destroy device 2.1
[ 0.337034] [00000eb4] libusb: debug [libusb_unref_device] destroy device 2.0
[ 0.337034] [00000eb4] libusb: debug [libusb_unref_device] destroy device 3.1
[ 0.337034] [00000eb4] libusb: debug [libusb_unref_device] destroy device 3.0
[ 0.337034] [00000eb4] libusb: debug [libusb_open] open 1.5
[ 0.337034] [00000eb4] libusb: debug [libusb_get_device_descriptor]
[ 0.337034] [00000eb4] libusb: debug [libusb_alloc_transfer] transfer 00000000005b9590
[ 0.337034] [00000eb4] libusb:       Manufacturer: "SAMSUNG"
debug [libusb_submit_transfer] transfer 00000000005b9590
[ 0.337034] [00000eb4] libusb: debug [libusb_claim_interface] interface 0
[ 0.337034] [00000eb4] libusb: debug [winusbx_claim_interface] claimed interface 0
[ 0.337034] [00000eb4] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.337034] [00000eb4] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 83 to interface 0
[ 0.337034] [00000eb4] libusb: debug [auto_claim] auto-claimed interface 0 for control request
[ 0.337034] [00000eb4] libusb: debug [winusbx_submit_control_transfer] will use interface 0
[ 0.338034] [00000eb4] libusb: debug [usbi_add_pollfd] add fd 1 events 1
[ 0.338034] [00000eb4] libusb: debug [libusb_get_next_timeout] next timeout in 0.999619s
[ 0.338034] [00000eb4] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.338034] [00000eb4] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.338034] [00000eb4] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.338034] [00000eb4] libusb: debug [handle_events] poll() returned 1
[ 0.338034] [00000eb4] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 0.338034] [00000eb4] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.338034] [00000eb4] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 4
[ 0.338034] [00000eb4] libusb: debug [libusb_release_interface] interface 0
[ 0.338034] [00000eb4] libusb: debug [auto_release] auto-released interface 0
[ 0.338034] [00000eb4] libusb: debug [usbi_handle_transfer_completion] transfer 00000000005b9590 has callback 0000000000415da0
[ 0.338034] [00000eb4] libusb: debug [sync_transfer_cb] actual_length=4
[ 0.338034] [00000eb4] libusb: debug [libusb_free_transfer] transfer 00000000005b9590
[ 0.338034] [00000eb4] libusb: debug [libusb_alloc_transfer] transfer 00000000005b9590
[ 0.338034] [00000eb4] libusb: debug [libusb_submit_transfer] transfer 00000000005b9590
[ 0.338034] [00000eb4] libusb: debug [libusb_claim_interface] interface 0
[ 0.338034] [00000eb4] libusb: debug [winusbx_claim_interface] claimed interface 0
[ 0.338034] [00000eb4] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.338034] [00000eb4] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 83 to interface 0
[ 0.338034] [00000eb4] libusb: debug [auto_claim] auto-claimed interface 0 for control request
[ 0.338034] [00000eb4] libusb: debug [winusbx_submit_control_transfer] will use interface 0
[ 0.338034] [00000eb4] libusb: debug [usbi_add_pollfd] add fd 1 events 1
[ 0.338034] [00000eb4] libusb: debug [libusb_get_next_timeout] next timeout in 1.000000s
[ 0.338034] [00000eb4] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.338034] [00000eb4] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.338034] [00000eb4] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.338034] [00000eb4] libusb: debug [handle_events] poll() returned 1
[ 0.338034] [00000eb4] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 0.338034] [00000eb4] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.338034] [00000eb4] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 16
[ 0.338034] [00000eb4] libusb: debug [libusb_release_interface] interface 0
[ 0.338034] [00000eb4] libusb: debug [auto_release] auto-released interface 0
[ 0.338034] [00000eb4] libusb: debug [usbi_handle_transfer_completion] transfer 00000000005b9590 has callback 0000000000415da0
[ 0.338034] [00000eb4] libusb: debug [sync_transfer_cb] actual_length=16
[ 0.338034] [00000eb4] libusb: debug [libusb_free_transfer] transfer 00000000005b9590
[ 0.338034] [00000eb4] libusb: debug [libusb_alloc_transfer] transfer 00000000005b9590
[ 0.338034] [00000eb4] libusb: debug [libusb_submit_transfer] transfer 00000000005b9590
[ 0.338034] [00000eb4] libusb: debug [libusb_claim_interface] interface 0
[ 0.338034] [00000eb4] libusb: debug [winusbx_claim_interface] claimed interface 0
[ 0.338034] [00000eb4]           Product: "Gadget Serial"

            length: 18
      device class: 2
               S/N: 0
           VID:PID: 04E8:685D
         bcdDevice: 021B
   iMan:iProd:iSer: 1:2:0
          nb confs: 1

interface[0].altsetting[0]: num endpoints = 1
   Class.SubClass.Protocol: 02.02.01
       endpoint[0].address: 83
           max packet size: 0010
          polling interval: 09

interface[1].altsetting[0]: num endpoints = 2
   Class.SubClass.Protocol: 0A.00.00
       endpoint[0].address: 81
           max packet size: 0200
          polling interval: 00
       endpoint[1].address: 02
           max packet size: 0200
          polling interval: 00
Claiming interface...
 libusb: debug [libusb_get_config_descriptor] index 0
[ 0.338034] [00000eb4] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 83 to interface 0
[ 0.338034] [00000eb4] libusb: debug [auto_claim] auto-claimed interface 0 for control request
[ 0.338034] [00000eb4] libusb: debug [winusbx_submit_control_transfer] will use interface 0
[ 0.338034] [00000eb4] libusb: debug [usbi_add_pollfd] add fd 1 events 1
[ 0.338034] [00000eb4] libusb: debug [libusb_get_next_timeout] next timeout in 0.999620s
[ 0.338034] [00000eb4] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.338034] [00000eb4] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.338034] [00000eb4] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.338034] [00000eb4] libusb: debug [handle_events] poll() returned 1
[ 0.338034] [00000eb4] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 0.338034] [00000eb4] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.338034] [00000eb4] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 4
[ 0.338034] [00000eb4] libusb: debug [libusb_release_interface] interface 0
[ 0.338034] [00000eb4] libusb: debug [auto_release] auto-released interface 0
[ 0.338034] [00000eb4] libusb: debug [usbi_handle_transfer_completion] transfer 00000000005b9590 has callback 0000000000415da0
[ 0.338034] [00000eb4] libusb: debug [sync_transfer_cb] actual_length=4
[ 0.338034] [00000eb4] libusb: debug [libusb_free_transfer] transfer 00000000005b9590
[ 0.338034] [00000eb4] libusb: debug [libusb_alloc_transfer] transfer 00000000005b9590
[ 0.338034] [00000eb4] libusb: debug [libusb_submit_transfer] transfer 00000000005b9590
[ 0.338034] [00000eb4] libusb: debug [libusb_claim_interface] interface 0
[ 0.338034] [00000eb4] libusb: debug [winusbx_claim_interface] claimed interface 0
[ 0.338034] [00000eb4] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.338034] [00000eb4] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 83 to interface 0
[ 0.338034] [00000eb4] libusb: debug [auto_claim] auto-claimed interface 0 for control request
[ 0.338034] [00000eb4] libusb: debug [winusbx_submit_control_transfer] will use interface 0
[ 0.338034] [00000eb4] libusb: debug [usbi_add_pollfd] add fd 1 events 1
[ 0.338034] [00000eb4] libusb: debug [libusb_get_next_timeout] next timeout in 1.000000s
[ 0.338034] [00000eb4] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.338034] [00000eb4] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.338034] [00000eb4] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.338034] [00000eb4] libusb: debug [handle_events] poll() returned 1
[ 0.338034] [00000eb4] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 0.338034] [00000eb4] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.338034] [00000eb4] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 28
[ 0.338034] [00000eb4] libusb: debug [libusb_release_interface] interface 0
[ 0.338034] [00000eb4] libusb: debug [auto_release] auto-released interface 0
[ 0.338034] [00000eb4] libusb: debug [usbi_handle_transfer_completion] transfer 00000000005b9590 has callback 0000000000415da0
[ 0.338034] [00000eb4] libusb: debug [sync_transfer_cb] actual_length=28
[ 0.338034] [00000eb4] libusb: debug [libusb_free_transfer] transfer 00000000005b9590
[ 0.338034] [00000eb4] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.339034] [00000eb4] libusb: debug [libusb_claim_interface] interface 1
[ 0.339034] [00000eb4] libusb: warning [winusbx_claim_interface] auto-claimed interface 0 (required to claim 1 with WinUSB)
[ 0.339034] [00000eb4] libusb: debug [winusbx_claim_interface] claimed interface 1
[ 0.339034] [00000eb4] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.339034] [00000eb4] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 81 to interface 1
[ 0.339034] [00000eb4] libusb: debug [windows_assign_Setting up interface...

Initialising protocol...
endpoints] (re)assigned endpoint 02 to interface 1
[ 0.339034] [00000eb4] libusb: debug [libusb_set_interface_alt_setting] interface 1 altsetting 0
[ 0.339034] [00000eb4] libusb: debug [libusb_get_config_descriptor] index 0
[ 0.339034] [00000eb4] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 81 to interface 1
[ 0.339034] [00000eb4] libusb: debug [windows_assign_endpoints] (re)assigned endpoint 02 to interface 1
[ 0.339034] [00000eb4] libusb: debug [libusb_alloc_transfer] transfer 00000000005b9590
[ 0.339034] [00000eb4] libusb: debug [libusb_submit_transfer] transfer 00000000005b9590
[ 0.339034] [00000eb4] libusb: debug [winusbx_submit_bulk_transfer] matched endpoint 02 with interface 1
[ 0.339034] [00000eb4] libusb: debug [winusbx_submit_bulk_transfer] writing 4 bytes
[ 0.339034] [00000eb4] libusb: debug [usbi_add_pollfd] add fd 1 events 4
[ 0.339034] [00000eb4] libusb: debug [libusb_get_next_timeout] next timeout in 1.000000s
[ 0.339034] [00000eb4] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.339034] [00000eb4] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.339034] [00000eb4] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.339034] [00000eb4] libusb: debug [handle_events] poll() returned 1
[ 0.339034] [00000eb4] libusb: debug [windows_handle_events] checking fd 1 with revents = 0004
[ 0.339034] [00000eb4] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.339034] [00000eb4] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 4
[ 0.339034] [00000eb4] libusb: debug [usbi_handle_transfer_completion] transfer 00000000005b9590 has callback 0000000000415da0
[ 0.339034] [00000eb4] libusb: debug [sync_transfer_cb] actual_length=4
[ 0.339034] [00000eb4] libusb: debug [libusb_free_transfer] transfer 00000000005b9590
[ 0.339034] [00000eb4] libusb: debug [libusb_alloc_transfer] transfer 00000000005b9590
[ 0.339034] [00000eb4] libusb: debug [libusb_submit_transfer] transfer 00000000005b9590
[ 0.339034] [00000eb4] libusb: debug [winusbx_submit_bulk_transfer] matched endpoint 81 with interface 1
[ 0.339034] [00000eb4] libusb: debug [winusbx_submit_bulk_transfer] reading 7 bytes
[ 0.339034] [00000eb4] libusb: debug [usbi_add_pollfd] add fd 1 events 1
[ 0.339034] [00000eb4] libusb: debug [libusb_get_next_timeout] next timeout in 1.000000s
[ 0.339034] [00000eb4] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.339034] [00000eb4] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.339034] [00000eb4] libusb: debug [handle_events] poll() 2 fds with timeout in 1000ms
[ 0.339034] [00000eb4] libusb: debug [handle_events] poll() returned 1
[ 0.339034] [00000eb4] libusb: debug [windows_handle_events] checking fd 1 with revents = 0001
[ 0.339034] [00000eb4] libusb: debug [usbi_remove_pollfd] remove fd 1
[ 0.339034] [00000eb4] libusb: debug [windows_transfer_callback] handling I/O completion with errcode 0, size 7
[ 0.339034] [00000eb4] libusb: debug [usbi_handle_transfer_completion] transfer 00000000005b9590 has callback 0000000000415da0
[ 0.339034] [00000eb4] libusb: debug [sync_transfer_cb] actual_length=7
[ 0.339034] [00000eb4] libusb: debug [libusb_free_transfer] transfer 00000000005b9590
ERROR: Expected: "LOKE"
Received: "     "
ERROR: Unexpected handshake response!
ERROR: Protocol initialisation failed!