Skip to content

Instantly share code, notes, and snippets.

@hramrach
Last active August 20, 2017 08:41
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save hramrach/a621d79ee34d1b5ff2eb6a1ae7885fc7 to your computer and use it in GitHub Desktop.
Save hramrach/a621d79ee34d1b5ff2eb6a1ae7885fc7 to your computer and use it in GitHub Desktop.
heimdall log j510F
Heimdall v1.4.1
Copyright (c) 2010-2014 Benjamin Dobell, Glass Echidna
http://www.glassechidna.com.au/
This software is provided free of charge. Copying and redistribution is
encouraged.
If you appreciate this software and you would like to support future
development please consider donating:
http://www.glassechidna.com.au/donate/
Initialising connection...
Detecting device...
[timestamp] [threadID] facility level [function call] <message>
--------------------------------------------------------------------------------
[ 0.008568] [00007f62] libusb: debug [libusb_get_device_list]
[ 0.008588] [00007f62] libusb: debug [discovered_devs_append] need to increase capacity
[ 0.008594] [00007f62] libusb: debug [discovered_devs_append] need to increase capacity
[ 0.008601] [00007f62] libusb: debug [libusb_get_device_descriptor]
[ 0.008604] [00007f62] libusb: debug [libusb_get_device_descriptor]
[ 0.008607] [00007f62] libusb: debug [libusb_get_device_descriptor]
[ 0.008610] [00007f62] libusb: debug [libusb_get_device_descriptor]
[ 0.008612] [00007f62] libusb: debug [libusb_get_device_descriptor]
[ 0.008615] [00007f62] libusb: debug [libusb_get_device_descriptor]
[ 0.008617] [00007f62] libusb: debug [libusb_get_device_descriptor]
[ 0.008620] [00007f62] libusb: debug [libusb_get_device_descriptor]
[ 0.008623] [00007f62] libusb: debug [libusb_get_device_descriptor]
[ 0.008625] [00007f62] libusb: debug [libusb_get_device_descriptor]
[ 0.008630] [00007f62] libusb: debug [libusb_open] open 1.21
[ 0.008660] [00007f62] libusb: debug [usbi_add_pollfd] add fd 10 events 4
[ 0.008666] [00007f62] libusb: debug [libusb_get_device_descriptor]
[ 0.008673] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea031bc0
[ 0.008676] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea031bc0
[ 0.008681] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 1000ms (first in line)
[ 0.008705] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.008711] [00007f62] libusb: debug [handle_events] poll fds modified, reallocating
[ 0.008716] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 0.009005] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 0.009014] [00007f62] libusb: debug [reap_for_handle] urb type=2 status=0 transferred=4
[ 0.009018] [00007f62] libusb: debug [handle_control_completion] handling completion status 0
[ 0.009022] [00007f62] libusb: debug [disarm_timerfd]
[ 0.009026] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea031bc0 has callback 0x7fe45f814ff0
[ 0.009030] [00007f62] libusb: debug [sync_transfer_cb] actual_length=4
[ 0.009039] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea031bc0
[ 0.009046] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea031bc0
[ 0.009050] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea031bc0
[ 0.009054] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 1000ms (first in line)
[ 0.009063] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.009069] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 0.009377] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 0.009384] [00007f62] libusb: debug [reap_for_handle] urb type=2 status=0 transferred=18
[ 0.009387] [00007f62] libusb: debug [handle_control_completion] handling completion status 0
[ 0.009391] [00007f62] libusb: debug [disarm_timerfd]
[ 0.009395] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea031bc0 has callback 0x7fe45f814ff0
[ 0.009398] [00007f62] libusb: debug [sync_transfer_cb] actual_length=18
[ 0.009402] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea031bc0
Manufacturer: "Sasmsung"
[ 0.009408] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea031bc0
[ 0.009411] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea031bc0
[ 0.009415] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 1000ms (first in line)
[ 0.009423] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.009427] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 0.009750] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 0.009757] [00007f62] libusb: debug [reap_for_handle] urb type=2 status=0 transferred=4
[ 0.009760] [00007f62] libusb: debug [handle_control_completion] handling completion status 0
[ 0.009763] [00007f62] libusb: debug [disarm_timerfd]
[ 0.009767] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea031bc0 has callback 0x7fe45f814ff0
[ 0.009770] [00007f62] libusb: debug [sync_transfer_cb] actual_length=4
[ 0.009774] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea031bc0
[ 0.009778] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea031bc0
[ 0.009781] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea031bc0
[ 0.009785] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 1000ms (first in line)
[ 0.009793] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.009798] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 0.010125] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 0.010132] [00007f62] libusb: debug [reap_for_handle] urb type=2 status=0 transferred=16
[ 0.010135] [00007f62] libusb: debug [handle_control_completion] handling completion status 0
[ 0.010139] [00007f62] libusb: debug [disarm_timerfd]
[ 0.010143] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea031bc0 has callback 0x7fe45f814ff0
[ 0.010146] [00007f62] libusb: debug [sync_transfer_cb] actual_length=16
[ 0.010149] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea031bc0
Product: "MSM8960"
length: 18
device class: 2
S/N: 0
VID:PID: 04E8:685D
bcdDevice: 0100
iMan:iProd:iSer: 1:2:0
nb confs: 1
[ 0.010162] [00007f62] libusb: debug [libusb_get_config_descriptor] index 0
interface[0].altsetting[0]: num endpoints = 1
Class.SubClass.Protocol: 02.02.01
endpoint[0].address: 82
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: 01
max packet size: 0200
polling interval: 00
Claiming interface...
[ 0.010187] [00007f62] libusb: debug [libusb_claim_interface] interface 1
Setting up interface...
[ 0.010210] [00007f62] libusb: debug [libusb_set_interface_alt_setting] interface 1 altsetting 0
Initialising protocol...
[ 0.011757] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea031bc0
[ 0.011762] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea031bc0
[ 0.011771] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 1000ms (first in line)
[ 0.011780] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 4
[ 0.011797] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.011803] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 0.011810] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 0.011814] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=4
[ 0.011817] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 0.011827] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 0.011833] [00007f62] libusb: debug [disarm_timerfd]
[ 0.011841] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea031bc0 has callback 0x7fe45f814ff0
[ 0.011847] [00007f62] libusb: debug [sync_transfer_cb] actual_length=4
[ 0.011854] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea031bc0
[ 0.011859] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea031bc0
[ 0.011862] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea031bc0
[ 0.011865] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 1000ms (first in line)
[ 0.011870] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 7
[ 0.011877] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.011881] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 0.011895] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 0.011900] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=4
[ 0.011903] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 0.011906] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 0.011909] [00007f62] libusb: debug [disarm_timerfd]
[ 0.011913] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea031bc0 has callback 0x7fe45f814ff0
[ 0.011916] [00007f62] libusb: debug [sync_transfer_cb] actual_length=4
[ 0.011920] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea031bc0
Protocol initialisation successful.
Beginning session...
[ 0.011934] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 0.011959] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 0.011976] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 0.011993] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 0.012013] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.012028] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 0.015098] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 0.015119] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 0.015135] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 0.015147] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 0.015160] [00007f62] libusb: debug [disarm_timerfd]
[ 0.015173] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 0.015185] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 0.015198] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 0.015211] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 0.015223] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 0.015236] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 0.015249] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 0.015266] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.015270] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 0.115257] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 0.115272] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 0.115284] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 0.115887] [00007f62] libusb: debug [disarm_timerfd]
[ 0.115897] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 0.115902] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 0.115908] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 0.115911] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 0.115915] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 0.115918] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 0.115922] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 0.115925] [00007f62] libusb: debug [disarm_timerfd]
[ 0.115929] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 0.115932] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 0.115938] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 0.115963] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 0.115966] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 0.115970] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 0.115976] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 8
[ 0.115991] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 0.115995] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 0.116027] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 0.116035] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=8
[ 0.116038] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 0.116041] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 0.116044] [00007f62] libusb: debug [disarm_timerfd]
[ 0.116048] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 0.116051] [00007f62] libusb: debug [sync_transfer_cb] actual_length=8
[ 0.116055] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
Some devices may take up to 2 minutes to respond.
Please be patient!
[ 3.116142] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.116158] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.116165] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 3.116174] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 3.116201] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.116206] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.116314] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.116324] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 3.116327] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 3.116331] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 3.116334] [00007f62] libusb: debug [disarm_timerfd]
[ 3.116339] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.116342] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 3.116347] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 3.116351] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.116354] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.116357] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 3.116362] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 3.116369] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.116373] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.216376] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.216391] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 3.216397] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 3.216903] [00007f62] libusb: debug [disarm_timerfd]
[ 3.216914] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 3.216919] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.216925] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 3.216929] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 3.216932] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 3.216935] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 3.216939] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 3.216942] [00007f62] libusb: debug [disarm_timerfd]
[ 3.216946] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.216950] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 3.216955] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 3.216966] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.216969] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.216974] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 3.216980] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 8
[ 3.216995] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.216999] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.217055] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.217064] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=8
[ 3.217067] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 3.217071] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 3.217074] [00007f62] libusb: debug [disarm_timerfd]
[ 3.217079] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.217082] [00007f62] libusb: debug [sync_transfer_cb] actual_length=8
[ 3.217086] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
Session begun.
Downloading device's PIT file...
[ 3.217106] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.217110] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.217114] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 3.217119] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 3.217127] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.217132] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.217320] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.217330] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 3.217334] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 3.217338] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 3.217341] [00007f62] libusb: debug [disarm_timerfd]
[ 3.217346] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.217349] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 3.217354] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 3.217358] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.217361] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.217364] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 3.217369] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 3.217377] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.217381] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.317386] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.317406] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 3.317412] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 3.317991] [00007f62] libusb: debug [disarm_timerfd]
[ 3.318002] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 3.318007] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.318013] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 3.318017] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 3.318020] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 3.318024] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 3.318027] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 3.318030] [00007f62] libusb: debug [disarm_timerfd]
[ 3.318034] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.318038] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 3.318042] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 3.318057] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.318061] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.318065] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 3.318072] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 8
[ 3.318089] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.318093] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.318108] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.318113] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=8
[ 3.318117] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 3.318120] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 3.318123] [00007f62] libusb: debug [disarm_timerfd]
[ 3.318127] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.318130] [00007f62] libusb: debug [sync_transfer_cb] actual_length=8
[ 3.318134] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 3.318141] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.318144] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.318437] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 3.318444] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 3.318454] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.318458] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.318513] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.318521] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 3.318535] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 3.318539] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 3.318542] [00007f62] libusb: debug [disarm_timerfd]
[ 3.318546] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.318550] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 3.318554] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 3.318558] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.318561] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.318565] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 3.318569] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 3.318759] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.318766] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.418593] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.418611] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 3.418617] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 3.419243] [00007f62] libusb: debug [disarm_timerfd]
[ 3.419254] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 3.419260] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.419266] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 3.419270] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 3.419273] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 3.419276] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 3.419280] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 3.419284] [00007f62] libusb: debug [disarm_timerfd]
[ 3.419287] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.419291] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 3.419296] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 3.419359] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.419363] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.419367] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 3.419374] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 500
[ 3.419389] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.419396] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.419420] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.419436] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=500
[ 3.419440] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 3.419444] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 3.419446] [00007f62] libusb: debug [disarm_timerfd]
[ 3.419451] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.419454] [00007f62] libusb: debug [sync_transfer_cb] actual_length=500
[ 3.419458] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 3.419465] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.419468] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.419472] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 3.419477] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 3.419485] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.419489] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.419721] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.419731] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 3.419735] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 3.419738] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 3.419742] [00007f62] libusb: debug [disarm_timerfd]
[ 3.419746] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.419749] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 3.419780] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 3.419785] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.419788] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.419793] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 3.419798] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 3.419806] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.419810] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.519816] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.519833] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 3.519839] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 3.520564] [00007f62] libusb: debug [disarm_timerfd]
[ 3.520575] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 3.520580] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.520586] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 3.520590] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 3.520593] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 3.520597] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 3.520601] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 3.520604] [00007f62] libusb: debug [disarm_timerfd]
[ 3.520608] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.520611] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 3.520617] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 3.520631] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.520635] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.520639] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 3.520646] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 500
[ 3.520662] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.520667] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.520718] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.520726] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=500
[ 3.520730] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 3.520733] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 3.520736] [00007f62] libusb: debug [disarm_timerfd]
[ 3.520741] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.520744] [00007f62] libusb: debug [sync_transfer_cb] actual_length=500
[ 3.520748] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 3.520755] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.520758] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.520762] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 3.520767] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 3.520775] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.520779] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.520977] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.520985] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 3.520989] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 3.520992] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 3.520995] [00007f62] libusb: debug [disarm_timerfd]
[ 3.521000] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.521003] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 3.521006] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 3.521010] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.521013] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.521016] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 3.521022] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 3.521029] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.521033] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.621038] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.621056] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 3.621062] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 3.621639] [00007f62] libusb: debug [disarm_timerfd]
[ 3.621649] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 3.621655] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.621661] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 3.621664] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 3.621668] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 3.621671] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 3.621675] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 3.621677] [00007f62] libusb: debug [disarm_timerfd]
[ 3.621682] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.621686] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 3.621691] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 3.621706] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.621709] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.621714] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 3.621721] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 500
[ 3.621737] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.621741] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.621797] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.621806] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=500
[ 3.621809] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 3.621812] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 3.621815] [00007f62] libusb: debug [disarm_timerfd]
[ 3.621820] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.621823] [00007f62] libusb: debug [sync_transfer_cb] actual_length=500
[ 3.621827] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 3.621834] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.621837] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.621841] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 3.621846] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 3.621855] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.621859] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.621994] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.622001] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 3.622005] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 3.622008] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 3.622012] [00007f62] libusb: debug [disarm_timerfd]
[ 3.622016] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.622019] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 3.622023] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 3.622027] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.622030] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.622034] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 3.622039] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 3.622046] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.622050] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.722054] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.722070] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 3.722077] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 3.722595] [00007f62] libusb: debug [disarm_timerfd]
[ 3.722604] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 3.722609] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.722615] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 3.722618] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 3.722622] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 3.722625] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 3.722629] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 3.722632] [00007f62] libusb: debug [disarm_timerfd]
[ 3.722636] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.722639] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 3.722645] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 3.722658] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.722664] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.722668] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 3.722674] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 500
[ 3.722689] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.722693] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.722722] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.722731] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=500
[ 3.722735] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 3.722739] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 3.722742] [00007f62] libusb: debug [disarm_timerfd]
[ 3.722747] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.722750] [00007f62] libusb: debug [sync_transfer_cb] actual_length=500
[ 3.722755] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 3.722762] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.722766] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.722769] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 3.722775] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 3.722784] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.722788] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.722958] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.722966] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 3.722970] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 3.722973] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 3.722976] [00007f62] libusb: debug [disarm_timerfd]
[ 3.722981] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.722984] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 3.722988] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 3.722992] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.722995] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.722999] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 3.723004] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 3.723011] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.723017] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.823019] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.823037] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 3.823043] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 3.823562] [00007f62] libusb: debug [disarm_timerfd]
[ 3.823569] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 3.823573] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.823578] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 3.823580] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 3.823583] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 3.823586] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 3.823588] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 3.823591] [00007f62] libusb: debug [disarm_timerfd]
[ 3.823594] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.823596] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 3.823600] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 3.823612] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.823616] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.823620] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 3.823625] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 500
[ 3.823638] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.823642] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.823668] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.823674] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=500
[ 3.823676] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 3.823679] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 3.823682] [00007f62] libusb: debug [disarm_timerfd]
[ 3.823685] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.823687] [00007f62] libusb: debug [sync_transfer_cb] actual_length=500
[ 3.823690] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 3.823695] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.823698] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.823701] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 3.823704] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 3.823710] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.823714] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.823926] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.823932] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 3.823936] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 3.823940] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 3.823943] [00007f62] libusb: debug [disarm_timerfd]
[ 3.823948] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.823951] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 3.823955] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 3.823959] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.823962] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.823966] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 3.823972] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 3.823978] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.823982] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.923990] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.924005] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 3.924011] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 3.924522] [00007f62] libusb: debug [disarm_timerfd]
[ 3.924530] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 3.924535] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.924541] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 3.924544] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 3.924548] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 3.924551] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 3.924555] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 3.924558] [00007f62] libusb: debug [disarm_timerfd]
[ 3.924562] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.924565] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 3.924570] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 3.924584] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.924590] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.924595] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 3.924601] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 500
[ 3.924616] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.924620] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.924648] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.924658] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=500
[ 3.924662] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 3.924666] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 3.924669] [00007f62] libusb: debug [disarm_timerfd]
[ 3.924674] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.924677] [00007f62] libusb: debug [sync_transfer_cb] actual_length=500
[ 3.924681] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 3.924689] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.924692] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.924696] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 3.924702] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 3.924711] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.924715] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 3.924890] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 3.924898] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 3.924902] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 3.924906] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 3.924909] [00007f62] libusb: debug [disarm_timerfd]
[ 3.924914] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 3.924917] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 3.924921] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 3.924925] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 3.924928] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 3.924932] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 3.924937] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 3.924944] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 3.924950] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.024953] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.024969] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 4.024975] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 4.025486] [00007f62] libusb: debug [disarm_timerfd]
[ 4.025495] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 4.025501] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.025506] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 4.025510] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 4.025514] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 4.025517] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 4.025520] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 4.025523] [00007f62] libusb: debug [disarm_timerfd]
[ 4.025527] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.025531] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 4.025536] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 4.025550] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.025554] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.025558] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.025565] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 500
[ 4.025612] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.025617] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.025639] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.025646] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=500
[ 4.025655] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.025658] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.025661] [00007f62] libusb: debug [disarm_timerfd]
[ 4.025666] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.025669] [00007f62] libusb: debug [sync_transfer_cb] actual_length=500
[ 4.025674] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.025681] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.025684] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.025688] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.025693] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 4.025702] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.025706] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.025854] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.025861] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 4.025864] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.025868] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.025871] [00007f62] libusb: debug [disarm_timerfd]
[ 4.025876] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.025879] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 4.025883] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.025887] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.025890] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.025894] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 4.025899] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 4.025906] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.025910] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.125913] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.125931] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 4.125938] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 4.126451] [00007f62] libusb: debug [disarm_timerfd]
[ 4.126460] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 4.126465] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.126471] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 4.126475] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 4.126479] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 4.126482] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 4.126485] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 4.126488] [00007f62] libusb: debug [disarm_timerfd]
[ 4.126492] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.126496] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 4.126502] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 4.126528] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.126533] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.126538] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.126544] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 500
[ 4.126562] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.126566] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.126593] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.126599] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=500
[ 4.126602] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.126605] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.126608] [00007f62] libusb: debug [disarm_timerfd]
[ 4.126612] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.126616] [00007f62] libusb: debug [sync_transfer_cb] actual_length=500
[ 4.126620] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.126626] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.126630] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.126634] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.126638] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 4.126646] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.126650] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.126815] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.126824] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 4.126828] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.126831] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.126834] [00007f62] libusb: debug [disarm_timerfd]
[ 4.126839] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.126842] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 4.126846] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.126851] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.126854] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.126858] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 4.126863] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 4.126870] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.126874] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.226879] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.226896] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 4.226902] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 4.227416] [00007f62] libusb: debug [disarm_timerfd]
[ 4.227424] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 4.227430] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.227435] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 4.227439] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 4.227442] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 4.227446] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 4.227450] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 4.227453] [00007f62] libusb: debug [disarm_timerfd]
[ 4.227457] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.227460] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 4.227465] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 4.227486] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.227492] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.227496] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.227501] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 500
[ 4.227516] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.227519] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.227545] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.227551] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=500
[ 4.227555] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.227558] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.227561] [00007f62] libusb: debug [disarm_timerfd]
[ 4.227565] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.227568] [00007f62] libusb: debug [sync_transfer_cb] actual_length=500
[ 4.227573] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.227579] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.227583] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.227592] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.227598] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 4.227606] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.227612] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.227782] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.227789] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 4.227793] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.227796] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.227799] [00007f62] libusb: debug [disarm_timerfd]
[ 4.227804] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.227807] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 4.227811] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.227815] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.227818] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.227822] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 4.227827] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 4.227834] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.227840] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.327839] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.327855] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 4.327861] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 4.328377] [00007f62] libusb: debug [disarm_timerfd]
[ 4.328386] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 4.328391] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.328397] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 4.328401] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 4.328404] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 4.328407] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 4.328411] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 4.328414] [00007f62] libusb: debug [disarm_timerfd]
[ 4.328418] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.328421] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 4.328426] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 4.328440] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.328445] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.328450] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.328456] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 500
[ 4.328469] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.328473] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.328500] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.328506] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=500
[ 4.328509] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.328512] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.328515] [00007f62] libusb: debug [disarm_timerfd]
[ 4.328519] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.328523] [00007f62] libusb: debug [sync_transfer_cb] actual_length=500
[ 4.328526] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.328533] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.328536] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.328540] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.328545] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 4.328553] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.328557] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.328743] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.328750] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 4.328754] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.328758] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.328761] [00007f62] libusb: debug [disarm_timerfd]
[ 4.328765] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.328769] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 4.328773] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.328777] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.328780] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.328784] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 4.328789] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 4.328796] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.328800] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.428804] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.428821] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 4.428827] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 4.429344] [00007f62] libusb: debug [disarm_timerfd]
[ 4.429352] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 4.429357] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.429362] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 4.429366] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 4.429370] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 4.429373] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 4.429377] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 4.429380] [00007f62] libusb: debug [disarm_timerfd]
[ 4.429384] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.429387] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 4.429392] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 4.429406] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.429413] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.429417] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.429423] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 500
[ 4.429438] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.429444] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.429475] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.429483] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=500
[ 4.429487] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.429489] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.429492] [00007f62] libusb: debug [disarm_timerfd]
[ 4.429497] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.429500] [00007f62] libusb: debug [sync_transfer_cb] actual_length=500
[ 4.429504] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.429511] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.429514] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.429518] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.429523] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 4.429531] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.429535] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.429711] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.429720] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 4.429723] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.429727] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.429730] [00007f62] libusb: debug [disarm_timerfd]
[ 4.429734] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.429737] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 4.429741] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.429745] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.429748] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.429752] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 4.429757] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 4.429764] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.429768] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.529772] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.529789] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 4.529795] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 4.530309] [00007f62] libusb: debug [disarm_timerfd]
[ 4.530317] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 4.530322] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.530328] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 4.530332] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 4.530335] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 4.530338] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 4.530342] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 4.530345] [00007f62] libusb: debug [disarm_timerfd]
[ 4.530350] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.530353] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 4.530358] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 4.530372] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.530378] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.530383] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.530389] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 500
[ 4.530403] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.530409] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.530441] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.530450] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=500
[ 4.530454] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.530458] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.530461] [00007f62] libusb: debug [disarm_timerfd]
[ 4.530466] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.530470] [00007f62] libusb: debug [sync_transfer_cb] actual_length=500
[ 4.530474] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.530481] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.530485] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.530489] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.530495] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 4.530504] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.530508] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.530674] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.530683] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 4.530687] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.530690] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.530693] [00007f62] libusb: debug [disarm_timerfd]
[ 4.530698] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.530701] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 4.530705] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.530710] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.530713] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.530716] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 4.530721] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 4.530729] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.530733] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.630736] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.630753] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 4.630759] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 4.631269] [00007f62] libusb: debug [disarm_timerfd]
[ 4.631277] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 4.631283] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.631289] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 4.631292] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 4.631296] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 4.631299] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 4.631303] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 4.631306] [00007f62] libusb: debug [disarm_timerfd]
[ 4.631310] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.631313] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 4.631319] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 4.631333] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.631339] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.631343] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.631349] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 500
[ 4.631366] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.631371] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.631401] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.631407] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=500
[ 4.631410] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.631413] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.631416] [00007f62] libusb: debug [disarm_timerfd]
[ 4.631421] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.631424] [00007f62] libusb: debug [sync_transfer_cb] actual_length=500
[ 4.631428] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.631435] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.631438] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.631441] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.631446] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 4.631460] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.631465] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.631636] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.631646] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 4.631650] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.631653] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.631657] [00007f62] libusb: debug [disarm_timerfd]
[ 4.631661] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.631665] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 4.631788] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.631792] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.631795] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.631799] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 4.631803] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 4.631811] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.631815] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.731819] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.731837] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 4.731843] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 4.732363] [00007f62] libusb: debug [disarm_timerfd]
[ 4.732372] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 4.732377] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.732382] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 4.732386] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 4.732389] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 4.732392] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 4.732396] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 4.732399] [00007f62] libusb: debug [disarm_timerfd]
[ 4.732402] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.732405] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 4.732410] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 4.732424] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.732428] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.732432] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.732439] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 500
[ 4.732453] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.732457] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.732502] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.732510] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=500
[ 4.732514] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.732517] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.732520] [00007f62] libusb: debug [disarm_timerfd]
[ 4.732524] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.732527] [00007f62] libusb: debug [sync_transfer_cb] actual_length=500
[ 4.732531] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.732538] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.732541] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.732545] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.732549] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 4.732558] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.732562] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.732718] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.732726] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 4.732729] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.732733] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.732736] [00007f62] libusb: debug [disarm_timerfd]
[ 4.732740] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.732743] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 4.732747] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.732751] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.732754] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.732758] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 4.732762] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 4.732769] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.732772] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.832781] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.832799] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 4.832805] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 4.833322] [00007f62] libusb: debug [disarm_timerfd]
[ 4.833332] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 4.833337] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.833343] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 4.833346] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 4.833350] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 4.833353] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 4.833357] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 4.833360] [00007f62] libusb: debug [disarm_timerfd]
[ 4.833364] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.833367] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 4.833373] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 4.833387] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.833393] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.833398] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.833404] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 500
[ 4.833419] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.833426] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.833467] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.833476] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=500
[ 4.833479] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.833483] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.833486] [00007f62] libusb: debug [disarm_timerfd]
[ 4.833491] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.833494] [00007f62] libusb: debug [sync_transfer_cb] actual_length=500
[ 4.833498] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.833504] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.833508] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.833512] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.833516] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 4.833525] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.833529] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.833692] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.833700] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 4.833703] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.833707] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.833710] [00007f62] libusb: debug [disarm_timerfd]
[ 4.833714] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.833718] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 4.833722] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.833726] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.833729] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.833733] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 4.833738] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 4.833745] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.833750] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.933755] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.933772] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 4.933779] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 4.934299] [00007f62] libusb: debug [disarm_timerfd]
[ 4.934309] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 4.934314] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.934320] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 4.934323] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 4.934327] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 4.934330] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 4.934335] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 4.934338] [00007f62] libusb: debug [disarm_timerfd]
[ 4.934342] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.934345] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 4.934350] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 4.934364] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.934370] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.934375] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.934381] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 500
[ 4.934396] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.934400] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.934545] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.934555] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=500
[ 4.934558] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.934562] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.934565] [00007f62] libusb: debug [disarm_timerfd]
[ 4.934570] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.934573] [00007f62] libusb: debug [sync_transfer_cb] actual_length=500
[ 4.934577] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.934584] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.934588] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.934592] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 4.934597] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 4.934605] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.934611] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 4.934884] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 4.934891] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=1024
[ 4.934896] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 4.934899] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 4.934902] [00007f62] libusb: debug [disarm_timerfd]
[ 4.934907] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 4.934910] [00007f62] libusb: debug [sync_transfer_cb] actual_length=1024
[ 4.934915] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 4.934919] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 4.934922] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 4.934926] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 100ms (first in line)
[ 4.934930] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 0
[ 4.934937] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 4.934943] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 5.034950] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 5.034968] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 5.034975] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 5.035502] [00007f62] libusb: debug [disarm_timerfd]
[ 5.035511] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 5.035516] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 5.035522] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 5.035525] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 5.035529] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 5.035532] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 5.035536] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 5.035539] [00007f62] libusb: debug [disarm_timerfd]
[ 5.035543] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 5.035547] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 5.035552] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
WARNING: Empty bulk transfer after sending packet failed. Continuing anyway...
[ 5.035568] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 5.035572] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 5.035576] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 5.035582] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 500
[ 5.035597] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 5.035603] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 5.035621] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 5.035627] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=0 transferred=192
[ 5.035631] [00007f62] libusb: debug [handle_bulk_completion] handling completion status 0 of bulk urb 1/1
[ 5.035634] [00007f62] libusb: debug [handle_bulk_completion] last URB in transfer --> complete!
[ 5.035637] [00007f62] libusb: debug [disarm_timerfd]
[ 5.035641] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 5.035645] [00007f62] libusb: debug [sync_transfer_cb] actual_length=192
[ 5.035648] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
[ 5.035655] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 5.035662] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 5.035666] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 5.035670] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 5.035679] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 5.035684] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[ 8.035685] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 8.035700] [00007f62] libusb: debug [handle_events] timerfd triggered
[ 8.035706] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[ 8.036304] [00007f62] libusb: debug [disarm_timerfd]
[ 8.036313] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[ 8.036318] [00007f62] libusb: debug [handle_events] poll() returned 1
[ 8.036324] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[ 8.036328] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[ 8.036332] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[ 8.036335] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[ 8.036338] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[ 8.036342] [00007f62] libusb: debug [disarm_timerfd]
[ 8.036346] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[ 8.036349] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[ 8.036354] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
ERROR: libusb error -7 whilst sending bulk transfer. Retrying...
[ 8.286439] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[ 8.286458] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[ 8.286464] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[ 8.286472] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[ 8.286496] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[ 8.286501] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[11.286486] [00007f62] libusb: debug [handle_events] poll() returned 1
[11.286499] [00007f62] libusb: debug [handle_events] timerfd triggered
[11.286504] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[11.287012] [00007f62] libusb: debug [disarm_timerfd]
[11.287021] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[11.287025] [00007f62] libusb: debug [handle_events] poll() returned 1
[11.287029] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[11.287032] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[11.287035] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[11.287038] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[11.287040] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[11.287043] [00007f62] libusb: debug [disarm_timerfd]
[11.287046] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[11.287049] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[11.287053] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
ERROR: libusb error -7 whilst sending bulk transfer. Retrying...
[11.787131] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[11.787149] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[11.787155] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[11.787165] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[11.787191] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[11.787196] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[14.787177] [00007f62] libusb: debug [handle_events] poll() returned 1
[14.787195] [00007f62] libusb: debug [handle_events] timerfd triggered
[14.787201] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[14.787765] [00007f62] libusb: debug [disarm_timerfd]
[14.787774] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[14.787779] [00007f62] libusb: debug [handle_events] poll() returned 1
[14.787785] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[14.787788] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[14.787792] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[14.787795] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[14.787799] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[14.787802] [00007f62] libusb: debug [disarm_timerfd]
[14.787806] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[14.787810] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[14.787815] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
ERROR: libusb error -7 whilst sending bulk transfer. Retrying...
[15.537902] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[15.537921] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[15.537927] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[15.537937] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[15.537967] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[15.537972] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[18.537946] [00007f62] libusb: debug [handle_events] poll() returned 1
[18.537961] [00007f62] libusb: debug [handle_events] timerfd triggered
[18.537968] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[18.538546] [00007f62] libusb: debug [disarm_timerfd]
[18.538555] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[18.538560] [00007f62] libusb: debug [handle_events] poll() returned 1
[18.538566] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[18.538570] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[18.538573] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[18.538576] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[18.538580] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[18.538583] [00007f62] libusb: debug [disarm_timerfd]
[18.538587] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[18.538591] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[18.538596] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
ERROR: libusb error -7 whilst sending bulk transfer. Retrying...
[19.538681] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[19.538696] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[19.538703] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[19.538712] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[19.538737] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[19.538742] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[22.538720] [00007f62] libusb: debug [handle_events] poll() returned 1
[22.538733] [00007f62] libusb: debug [handle_events] timerfd triggered
[22.538738] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[22.539239] [00007f62] libusb: debug [disarm_timerfd]
[22.539245] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[22.539248] [00007f62] libusb: debug [handle_events] poll() returned 1
[22.539253] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[22.539255] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[22.539258] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[22.539260] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[22.539263] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[22.539266] [00007f62] libusb: debug [disarm_timerfd]
[22.539269] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[22.539271] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[22.539275] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
ERROR: libusb error -7 whilst sending bulk transfer. Retrying...
[23.789359] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[23.789377] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[23.789383] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[23.789391] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[23.789416] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[23.789420] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[26.789402] [00007f62] libusb: debug [handle_events] poll() returned 1
[26.789418] [00007f62] libusb: debug [handle_events] timerfd triggered
[26.789425] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[26.790046] [00007f62] libusb: debug [disarm_timerfd]
[26.790055] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[26.790059] [00007f62] libusb: debug [handle_events] poll() returned 1
[26.790065] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[26.790068] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[26.790072] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[26.790075] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[26.790079] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[26.790082] [00007f62] libusb: debug [disarm_timerfd]
[26.790086] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[26.790090] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[26.790095] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
ERROR: libusb error -7 whilst sending bulk transfer.
ERROR: Failed to send request to end PIT file transfer!
ERROR: Failed to download PIT file!
Ending session...
[26.790117] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[26.790123] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[26.790127] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[26.790133] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[26.790148] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[26.790152] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[29.790147] [00007f62] libusb: debug [handle_events] poll() returned 1
[29.790164] [00007f62] libusb: debug [handle_events] timerfd triggered
[29.790170] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[29.790898] [00007f62] libusb: debug [disarm_timerfd]
[29.790909] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[29.790915] [00007f62] libusb: debug [handle_events] poll() returned 1
[29.790920] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[29.790924] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[29.790928] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[29.790931] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[29.790935] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[29.790937] [00007f62] libusb: debug [disarm_timerfd]
[29.790942] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[29.790945] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[29.790951] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
ERROR: libusb error -7 whilst sending bulk transfer. Retrying...
[30.041033] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[30.041050] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[30.041056] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[30.041066] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[30.041092] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[30.041097] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[33.041081] [00007f62] libusb: debug [handle_events] poll() returned 1
[33.041100] [00007f62] libusb: debug [handle_events] timerfd triggered
[33.041106] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[33.041644] [00007f62] libusb: debug [disarm_timerfd]
[33.041652] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[33.041657] [00007f62] libusb: debug [handle_events] poll() returned 1
[33.041663] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[33.041667] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[33.041670] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[33.041673] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[33.041677] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[33.041680] [00007f62] libusb: debug [disarm_timerfd]
[33.041684] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[33.041688] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[33.041693] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
ERROR: libusb error -7 whilst sending bulk transfer. Retrying...
[33.541782] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[33.541798] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[33.541803] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[33.541811] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[33.541837] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[33.541841] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[36.541822] [00007f62] libusb: debug [handle_events] poll() returned 1
[36.541838] [00007f62] libusb: debug [handle_events] timerfd triggered
[36.541845] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[36.542392] [00007f62] libusb: debug [disarm_timerfd]
[36.542400] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[36.542405] [00007f62] libusb: debug [handle_events] poll() returned 1
[36.542411] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[36.542415] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[36.542418] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[36.542421] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[36.542425] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[36.542428] [00007f62] libusb: debug [disarm_timerfd]
[36.542432] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[36.542436] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[36.542441] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
ERROR: libusb error -7 whilst sending bulk transfer. Retrying...
[37.292526] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[37.292542] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[37.292548] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[37.292556] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[37.292580] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[37.292585] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[40.292568] [00007f62] libusb: debug [handle_events] poll() returned 1
[40.292583] [00007f62] libusb: debug [handle_events] timerfd triggered
[40.292590] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[40.293213] [00007f62] libusb: debug [disarm_timerfd]
[40.293223] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[40.293229] [00007f62] libusb: debug [handle_events] poll() returned 1
[40.293234] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[40.293238] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[40.293242] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[40.293244] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[40.293248] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[40.293251] [00007f62] libusb: debug [disarm_timerfd]
[40.293255] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[40.293259] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[40.293264] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
ERROR: libusb error -7 whilst sending bulk transfer. Retrying...
[41.293345] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[41.293361] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[41.293367] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[41.293375] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[41.293400] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[41.293405] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[44.293383] [00007f62] libusb: debug [handle_events] poll() returned 1
[44.293400] [00007f62] libusb: debug [handle_events] timerfd triggered
[44.293405] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[44.293954] [00007f62] libusb: debug [disarm_timerfd]
[44.293962] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[44.293975] [00007f62] libusb: debug [handle_events] poll() returned 1
[44.293981] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[44.293983] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[44.293986] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[44.293988] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[44.293992] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[44.293994] [00007f62] libusb: debug [disarm_timerfd]
[44.293997] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[44.294000] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[44.294004] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
ERROR: libusb error -7 whilst sending bulk transfer. Retrying...
[45.544082] [00007f62] libusb: debug [libusb_alloc_transfer] transfer 0x562aea00ac00
[45.544099] [00007f62] libusb: debug [libusb_submit_transfer] transfer 0x562aea00ac00
[45.544105] [00007f62] libusb: debug [add_to_flying_list] arm timerfd for timeout in 3000ms (first in line)
[45.544113] [00007f62] libusb: debug [submit_bulk_transfer] need 1 urbs for new transfer with length 1024
[45.544138] [00007f62] libusb: debug [libusb_handle_events_timeout_completed] doing our own event handling
[45.544144] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 60000ms
[48.544123] [00007f62] libusb: debug [handle_events] poll() returned 1
[48.544141] [00007f62] libusb: debug [handle_events] timerfd triggered
[48.544147] [00007f62] libusb: debug [libusb_cancel_transfer] transfer 0x562aea00ac00
[48.544690] [00007f62] libusb: debug [disarm_timerfd]
[48.544698] [00007f62] libusb: debug [handle_events] poll() 3 fds with timeout in 0ms
[48.544703] [00007f62] libusb: debug [handle_events] poll() returned 1
[48.544709] [00007f62] libusb: debug [reap_for_handle] urb type=3 status=-2 transferred=0
[48.544713] [00007f62] libusb: debug [handle_bulk_completion] handling completion status -2 of bulk urb 1/1
[48.544716] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: urb status -2
[48.544719] [00007f62] libusb: debug [handle_bulk_completion] abnormal reap: last URB handled, reporting
[48.544723] [00007f62] libusb: debug [usbi_handle_transfer_cancellation] detected timeout cancellation
[48.544726] [00007f62] libusb: debug [disarm_timerfd]
[48.544731] [00007f62] libusb: debug [usbi_handle_transfer_completion] transfer 0x562aea00ac00 has callback 0x7fe45f814ff0
[48.544734] [00007f62] libusb: debug [sync_transfer_cb] actual_length=0
[48.544739] [00007f62] libusb: debug [libusb_free_transfer] transfer 0x562aea00ac00
ERROR: libusb error -7 whilst sending bulk transfer.
ERROR: Failed to send end session packet!
Releasing device interface...
[48.544760] [00007f62] libusb: debug [libusb_release_interface] interface 1
[48.544786] [00007f62] libusb: debug [libusb_close]
[48.544793] [00007f62] libusb: debug [usbi_remove_pollfd] remove fd 10
[48.544803] [00007f62] libusb: debug [libusb_exit]
[48.544806] [00007f62] libusb: debug [libusb_exit] destroying default context
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment