[Spice-devel] Spice-gtk usbredir
nicolas prochazka
prochazka.nicolas at gmail.com
Fri Sep 30 09:57:41 PDT 2011
Hello,
for spice debug message i send you it, monday.
VM guest is fedora 15 : 2.6.38
HOST VM is gentoo with kernel 3.0.4
SPICE-GTK is on opensuse : 2.6.37
dmesg from guest :
[ 61.718236] usb 1-2: new high speed USB device using ehci_hcd and address 3
[ 62.373585] usb 1-2: New USB device found, idVendor=0529, idProduct=3000
[ 62.373590] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[ 62.373594] usb 1-2: Product: NG-Flash 5.30
[ 62.373597] usb 1-2: Manufacturer: SafeNet
[ 62.373599] usb 1-2: SerialNumber: 000107B30F01647A762C
[ 62.499188] usb 2-1: new full speed USB device using uhci_hcd and address 2
[ 62.996663] usb 2-1: New USB device found, idVendor=0529, idProduct=0620
[ 62.996668] usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[ 62.996672] usb 2-1: Product: Token JC
[ 62.996675] usb 2-1: Manufacturer: Aladdin
[ 63.159697] usbcore: registered new interface driver uas
[ 63.177223] Initializing USB Mass Storage driver...
[ 63.179439] scsi2 : usb-storage 1-2:1.0
[ 63.180264] usbcore: registered new interface driver usb-storage
[ 63.180268] USB Mass Storage support registered.
[ 65.215691] scsi 2:0:0:0: CD-ROM SafeNet NG-Flash 5.30
PMAP PQ: 0 ANSI: 0 CCS
[ 65.222292] scsi 2:0:0:1: Direct-Access SafeNet NG-Flash 5.30
PMAP PQ: 0 ANSI: 0 CCS
[ 65.901851] sr2: scsi3-mmc drive: 0x/0x writer tray
[ 65.903951] sr 2:0:0:0: Attached scsi CD-ROM sr2
[ 65.911580] sr 2:0:0:0: Attached scsi generic sg4 type 5
[ 65.911869] sd 2:0:0:1: Attached scsi generic sg5 type 0
[ 96.838186] usb 1-2: reset high speed USB device using ehci_hcd and address 3
[ 127.814200] usb 1-2: reset high speed USB device using ehci_hcd and address 3
[ 158.918198] usb 1-2: reset high speed USB device using ehci_hcd and address 3
[ 189.895195] usb 1-2: reset high speed USB device using ehci_hcd and address 3
[ 190.654980] sd 2:0:0:1: [sdc] 3903488 512-byte logical blocks:
(1.99 GB/1.86 GiB)
[ 190.668092] sd 2:0:0:1: [sdc] Write Protect is off
[ 190.668097] sd 2:0:0:1: [sdc] Mode Sense: 23 00 00 00
[ 190.699693] sd 2:0:0:1: [sdc] No Caching mode page present
[ 190.699698] sd 2:0:0:1: [sdc] Assuming drive cache: write through
[ 190.823424] sd 2:0:0:1: [sdc] No Caching mode page present
[ 190.823429] sd 2:0:0:1: [sdc] Assuming drive cache: write through
[ 190.858947] sdc: sdc1
[ 207.679249] usb 1-2: USB disconnect, address 3
Regards,
NIcolas
2011/9/30 Hans de Goede <hdegoede at redhat.com>:
> Hi,
>
> On 09/30/2011 04:35 PM, nicolas prochazka wrote:
>>
>> Hello again,
>> With usb mass storage it's working well,
>> now i'm trying with Etoken NG Flash ( mass storage + authentification
>> token )
>>
>> Bus 001 Device 034: ID 0529:3000 Aladdin Knowledge Systems
>> libusb:debug [libusb_get_device_descriptor]
>> Bus 001 Device 035: ID 0529:0620 Aladdin Knowledge Systems
>>
>> on host it's working well,
>> on guest, lsusb show the same thing : Bus 001 Device 034: ID 0529:3000
>> Aladdin Knowledge Systems
>> but i can not mount it :
>
> Hmm, some questions:
>
> 1) What does dmesg on the guest say?
> 2) Are you using the same kernel (version) on the guest and the host?
>
> Also can you please change the debug=3 to debug=5 on the qemu cmdline,
> redirect qemu's output to a log file! and then mail me the log file after
> attempting to use the Etoken NG Flash again ?
>
> Thanks,
>
> Hans
>
>
>
>>
>>
>>
>>
>>
>> colossus:/tmp/TEST/spice-gtk # spicy
>> libusb:debug [libusb_init]
>> libusb:debug [find_usbfs_path] found usbfs at /dev/bus/usb
>> libusb:debug [op_init] bulk continuation flag supported
>> libusb:debug [op_init] found usb devices in sysfs
>> libusb:debug [usbi_add_pollfd] add fd 6 events 1
>> libusb:debug [usbi_io_init] using timerfd for timeouts
>> libusb:debug [usbi_add_pollfd] add fd 8 events 1
>> libusb:debug [libusb_get_device_list]
>> libusb:debug [sysfs_scan_device] scan usb1
>> libusb:debug [sysfs_scan_device] bus=1 dev=1
>> libusb:debug [enumerate_device] busnum 1 devaddr 1 session_id 257
>> libusb:debug [enumerate_device] allocating new device for 1/1 (session
>> 257)
>> libusb:debug [sysfs_scan_device] scan usb2
>> libusb:debug [sysfs_scan_device] bus=2 dev=1
>> libusb:debug [enumerate_device] busnum 2 devaddr 1 session_id 513
>> libusb:debug [enumerate_device] allocating new device for 2/1 (session
>> 513)
>> libusb:debug [sysfs_scan_device] scan usb3
>> libusb:debug [sysfs_scan_device] bus=3 dev=1
>> libusb:debug [enumerate_device] busnum 3 devaddr 1 session_id 769
>> libusb:debug [enumerate_device] allocating new device for 3/1 (session
>> 769)
>> libusb:debug [sysfs_scan_device] scan usb4
>> libusb:debug [sysfs_scan_device] bus=4 dev=1
>> libusb:debug [enumerate_device] busnum 4 devaddr 1 session_id 1025
>> libusb:debug [enumerate_device] allocating new device for 4/1 (session
>> 1025)
>> libusb:debug [sysfs_scan_device] scan usb5
>> libusb:debug [sysfs_scan_device] bus=5 dev=1
>> libusb:debug [enumerate_device] busnum 5 devaddr 1 session_id 1281
>> libusb:debug [enumerate_device] allocating new device for 5/1 (session
>> 1281)
>> libusb:debug [sysfs_scan_device] scan usb6
>> libusb:debug [sysfs_scan_device] bus=6 dev=1
>> libusb:debug [enumerate_device] busnum 6 devaddr 1 session_id 1537
>> libusb:debug [enumerate_device] allocating new device for 6/1 (session
>> 1537)
>> libusb:debug [sysfs_scan_device] scan usb7
>> libusb:debug [sysfs_scan_device] bus=7 dev=1
>> libusb:debug [enumerate_device] busnum 7 devaddr 1 session_id 1793
>> libusb:debug [enumerate_device] allocating new device for 7/1 (session
>> 1793)
>> libusb:debug [sysfs_scan_device] scan usb8
>> libusb:debug [sysfs_scan_device] bus=8 dev=1
>> libusb:debug [enumerate_device] busnum 8 devaddr 1 session_id 2049
>> libusb:debug [enumerate_device] allocating new device for 8/1 (session
>> 2049)
>> libusb:debug [sysfs_scan_device] scan 2-2
>> libusb:debug [sysfs_scan_device] bus=2 dev=3
>> libusb:debug [enumerate_device] busnum 2 devaddr 3 session_id 515
>> libusb:debug [enumerate_device] allocating new device for 2/3 (session
>> 515)
>> libusb:debug [discovered_devs_append] need to increase capacity
>> libusb:debug [sysfs_scan_device] scan 4-2
>> libusb:debug [sysfs_scan_device] bus=4 dev=2
>> libusb:debug [enumerate_device] busnum 4 devaddr 2 session_id 1026
>> libusb:debug [enumerate_device] allocating new device for 4/2 (session
>> 1026)
>> libusb:debug [sysfs_scan_device] scan 6-1
>> libusb:debug [sysfs_scan_device] bus=6 dev=3
>> libusb:debug [enumerate_device] busnum 6 devaddr 3 session_id 1539
>> libusb:debug [enumerate_device] allocating new device for 6/3 (session
>> 1539)
>> libusb:debug [libusb_unref_device] destroy device 1.1
>> libusb:debug [libusb_unref_device] destroy device 2.1
>> libusb:debug [libusb_unref_device] destroy device 3.1
>> libusb:debug [libusb_unref_device] destroy device 4.1
>> libusb:debug [libusb_unref_device] destroy device 5.1
>> libusb:debug [libusb_unref_device] destroy device 6.1
>> libusb:debug [libusb_unref_device] destroy device 7.1
>> libusb:debug [libusb_unref_device] destroy device 8.1
>> GSpice-Message: main channel: failed to connect
>> GSpice-Message: main channel: opened
>>
>> (spicy:12220): GSpice-WARNING **: PulseAudio context failed Connection
>> refused
>> libusb:debug [libusb_get_device_list]
>> libusb:debug [sysfs_scan_device] scan usb1
>> libusb:debug [sysfs_scan_device] bus=1 dev=1
>> libusb:debug [enumerate_device] busnum 1 devaddr 1 session_id 257
>> libusb:debug [enumerate_device] allocating new device for 1/1 (session
>> 257)
>> libusb:debug [sysfs_scan_device] scan usb2
>> libusb:debug [sysfs_scan_device] bus=2 dev=1
>> libusb:debug [enumerate_device] busnum 2 devaddr 1 session_id 513
>> libusb:debug [enumerate_device] allocating new device for 2/1 (session
>> 513)
>> libusb:debug [sysfs_scan_device] scan usb3
>> libusb:debug [sysfs_scan_device] bus=3 dev=1
>> libusb:debug [enumerate_device] busnum 3 devaddr 1 session_id 769
>> libusb:debug [enumerate_device] allocating new device for 3/1 (session
>> 769)
>> libusb:debug [sysfs_scan_device] scan usb4
>> libusb:debug [sysfs_scan_device] bus=4 dev=1
>> libusb:debug [enumerate_device] busnum 4 devaddr 1 session_id 1025
>> libusb:debug [enumerate_device] allocating new device for 4/1 (session
>> 1025)
>> libusb:debug [sysfs_scan_device] scan usb5
>> libusb:debug [sysfs_scan_device] bus=5 dev=1
>> libusb:debug [enumerate_device] busnum 5 devaddr 1 session_id 1281
>> libusb:debug [enumerate_device] allocating new device for 5/1 (session
>> 1281)
>> libusb:debug [sysfs_scan_device] scan usb6
>> libusb:debug [sysfs_scan_device] bus=6 dev=1
>> libusb:debug [enumerate_device] busnum 6 devaddr 1 session_id 1537
>> libusb:debug [enumerate_device] allocating new device for 6/1 (session
>> 1537)
>> libusb:debug [sysfs_scan_device] scan usb7
>> libusb:debug [sysfs_scan_device] bus=7 dev=1
>> libusb:debug [enumerate_device] busnum 7 devaddr 1 session_id 1793
>> libusb:debug [enumerate_device] allocating new device for 7/1 (session
>> 1793)
>> libusb:debug [sysfs_scan_device] scan usb8
>> libusb:debug [sysfs_scan_device] bus=8 dev=1
>> libusb:debug [enumerate_device] busnum 8 devaddr 1 session_id 2049
>> libusb:debug [enumerate_device] allocating new device for 8/1 (session
>> 2049)
>> libusb:debug [sysfs_scan_device] scan 2-2
>> libusb:debug [sysfs_scan_device] bus=2 dev=3
>> libusb:debug [enumerate_device] busnum 2 devaddr 3 session_id 515
>> libusb:debug [enumerate_device] using existing device for 2/3 (session
>> 515)
>> libusb:debug [discovered_devs_append] need to increase capacity
>> libusb:debug [sysfs_scan_device] scan 4-2
>> libusb:debug [sysfs_scan_device] bus=4 dev=2
>> libusb:debug [enumerate_device] busnum 4 devaddr 2 session_id 1026
>> libusb:debug [enumerate_device] using existing device for 4/2 (session
>> 1026)
>> libusb:debug [sysfs_scan_device] scan 6-1
>> libusb:debug [sysfs_scan_device] bus=6 dev=3
>> libusb:debug [enumerate_device] busnum 6 devaddr 3 session_id 1539
>> libusb:debug [enumerate_device] using existing device for 6/3 (session
>> 1539)
>> libusb:debug [sysfs_scan_device] scan 1-3
>> libusb:debug [sysfs_scan_device] bus=1 dev=30
>> libusb:debug [enumerate_device] busnum 1 devaddr 30 session_id 286
>> libusb:debug [enumerate_device] allocating new device for 1/30 (session
>> 286)
>> libusb:debug [sysfs_scan_device] scan 1-3.1
>> libusb:debug [sysfs_scan_device] bus=1 dev=31
>> libusb:debug [enumerate_device] busnum 1 devaddr 31 session_id 287
>> libusb:debug [enumerate_device] allocating new device for 1/31 (session
>> 287)
>> libusb:debug [sysfs_scan_device] scan 1-3.2
>> libusb:debug [sysfs_scan_device] bus=1 dev=32
>> libusb:debug [enumerate_device] busnum 1 devaddr 32 session_id 288
>> libusb:debug [enumerate_device] allocating new device for 1/32 (session
>> 288)
>> libusb:debug [libusb_unref_device] destroy device 1.1
>> libusb:debug [libusb_unref_device] destroy device 2.1
>> libusb:debug [libusb_unref_device] destroy device 3.1
>> libusb:debug [libusb_unref_device] destroy device 4.1
>> libusb:debug [libusb_unref_device] destroy device 5.1
>> libusb:debug [libusb_unref_device] destroy device 6.1
>> libusb:debug [libusb_unref_device] destroy device 7.1
>> libusb:debug [libusb_unref_device] destroy device 8.1
>> libusb:debug [libusb_unref_device] destroy device 1.30
>> libusb:debug [libusb_unref_device] destroy device 1.31
>> libusb:debug [libusb_open] open 1.32
>> libusb:debug [usbi_add_pollfd] add fd 17 events 4
>> libusb:debug [libusb_get_configuration]
>> libusb:debug [libusb_get_configuration] active config 1
>> libusb:debug [libusb_get_device_descriptor]
>> libusb:debug [usbi_get_config_index_by_value] value 1
>> libusb:debug [libusb_get_config_descriptor] index 0
>> libusb:debug [libusb_detach_kernel_driver] interface 0
>> libusb:debug [libusb_claim_interface] interface 0
>> libusb:debug [libusb_get_device_list]
>> libusb:debug [sysfs_scan_device] scan usb1
>> libusb:debug [sysfs_scan_device] bus=1 dev=1
>> libusb:debug [enumerate_device] busnum 1 devaddr 1 session_id 257
>> libusb:debug [enumerate_device] allocating new device for 1/1 (session
>> 257)
>> libusb:debug [sysfs_scan_device] scan usb2
>> libusb:debug [sysfs_scan_device] bus=2 dev=1
>> libusb:debug [enumerate_device] busnum 2 devaddr 1 session_id 513
>> libusb:debug [enumerate_device] allocating new device for 2/1 (session
>> 513)
>> libusb:debug [sysfs_scan_device] scan usb3
>> libusb:debug [sysfs_scan_device] bus=3 dev=1
>> libusb:debug [enumerate_device] busnum 3 devaddr 1 session_id 769
>> libusb:debug [enumerate_device] allocating new device for 3/1 (session
>> 769)
>> libusb:debug [sysfs_scan_device] scan usb4
>> libusb:debug [sysfs_scan_device] bus=4 dev=1
>> libusb:debug [enumerate_device] busnum 4 devaddr 1 session_id 1025
>> libusb:debug [enumerate_device] allocating new device for 4/1 (session
>> 1025)
>> libusb:debug [sysfs_scan_device] scan usb5
>> libusb:debug [sysfs_scan_device] bus=5 dev=1
>> libusb:debug [enumerate_device] busnum 5 devaddr 1 session_id 1281
>> libusb:debug [enumerate_device] allocating new device for 5/1 (session
>> 1281)
>> libusb:debug [sysfs_scan_device] scan usb6
>> libusb:debug [sysfs_scan_device] bus=6 dev=1
>> libusb:debug [enumerate_device] busnum 6 devaddr 1 session_id 1537
>> libusb:debug [enumerate_device] allocating new device for 6/1 (session
>> 1537)
>> libusb:debug [sysfs_scan_device] scan usb7
>> libusb:debug [sysfs_scan_device] bus=7 dev=1
>> libusb:debug [enumerate_device] busnum 7 devaddr 1 session_id 1793
>> libusb:debug [enumerate_device] allocating new device for 7/1 (session
>> 1793)
>> libusb:debug [sysfs_scan_device] scan usb8
>> libusb:debug [sysfs_scan_device] bus=8 dev=1
>> libusb:debug [enumerate_device] busnum 8 devaddr 1 session_id 2049
>> libusb:debug [enumerate_device] allocating new device for 8/1 (session
>> 2049)
>> libusb:debug [sysfs_scan_device] scan 2-2
>> libusb:debug [sysfs_scan_device] bus=2 dev=3
>> libusb:debug [enumerate_device] busnum 2 devaddr 3 session_id 515
>> libusb:debug [enumerate_device] using existing device for 2/3 (session
>> 515)
>> libusb:debug [discovered_devs_append] need to increase capacity
>> libusb:debug [sysfs_scan_device] scan 4-2
>> libusb:debug [sysfs_scan_device] bus=4 dev=2
>> libusb:debug [enumerate_device] busnum 4 devaddr 2 session_id 1026
>> libusb:debug [enumerate_device] using existing device for 4/2 (session
>> 1026)
>> libusb:debug [sysfs_scan_device] scan 6-1
>> libusb:debug [sysfs_scan_device] bus=6 dev=3
>> libusb:debug [enumerate_device] busnum 6 devaddr 3 session_id 1539
>> libusb:debug [enumerate_device] using existing device for 6/3 (session
>> 1539)
>> libusb:debug [sysfs_scan_device] scan 1-3
>> libusb:debug [sysfs_scan_device] bus=1 dev=30
>> libusb:debug [enumerate_device] busnum 1 devaddr 30 session_id 286
>> libusb:debug [enumerate_device] allocating new device for 1/30 (session
>> 286)
>> libusb:debug [sysfs_scan_device] scan 1-3.1
>> libusb:debug [sysfs_scan_device] bus=1 dev=31
>> libusb:debug [enumerate_device] busnum 1 devaddr 31 session_id 287
>> libusb:debug [enumerate_device] allocating new device for 1/31 (session
>> 287)
>> libusb:debug [sysfs_scan_device] scan 1-3.2
>> libusb:debug [sysfs_scan_device] bus=1 dev=32
>> libusb:debug [enumerate_device] busnum 1 devaddr 32 session_id 288
>> libusb:debug [enumerate_device] using existing device for 1/32 (session
>> 288)
>> libusb:debug [libusb_unref_device] destroy device 1.1
>> libusb:debug [libusb_unref_device] destroy device 2.1
>> libusb:debug [libusb_unref_device] destroy device 3.1
>> libusb:debug [libusb_unref_device] destroy device 4.1
>> libusb:debug [libusb_unref_device] destroy device 5.1
>> libusb:debug [libusb_unref_device] destroy device 6.1
>> libusb:debug [libusb_unref_device] destroy device 7.1
>> libusb:debug [libusb_unref_device] destroy device 8.1
>> libusb:debug [libusb_unref_device] destroy device 1.30
>> libusb:debug [libusb_open] open 1.31
>> libusb:debug [usbi_add_pollfd] add fd 18 events 4
>> libusb:debug [libusb_get_configuration]
>> libusb:debug [libusb_get_configuration] active config 1
>> libusb:debug [libusb_get_device_descriptor]
>> libusb:debug [usbi_get_config_index_by_value] value 1
>> libusb:debug [libusb_get_config_descriptor] index 0
>> libusb:debug [libusb_detach_kernel_driver] interface 0
>> libusb:debug [libusb_claim_interface] interface 0
>> libusb:debug [libusb_reset_device]
>> libusb:debug [libusb_reset_device]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=18
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_reset_device]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=18
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=9
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=32
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=4
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=28
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=16
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=42
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_reset_device]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=18
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_reset_device]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=18
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=-32 transferred=0
>> libusb:debug [handle_control_completion] handling completion status -32
>> libusb:debug [handle_control_completion] unsupported control request
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=-32 transferred=0
>> libusb:debug [handle_control_completion] handling completion status -32
>> libusb:debug [handle_control_completion] unsupported control request
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=-32 transferred=0
>> libusb:debug [handle_control_completion] handling completion status -32
>> libusb:debug [handle_control_completion] unsupported control request
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=9
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=93
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=4
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=18
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=16
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=22
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=30
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=4
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=30
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=1
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 36
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=36
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 36
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=36
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 18
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=18
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 18
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=18
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 128
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=-121 transferred=35
>> libusb:debug [handle_bulk_completion] handling completion status -121
>> of bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 8
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=-32 transferred=0
>> libusb:debug [handle_bulk_completion] handling completion status -32
>> of bulk urb 1/1
>> libusb:debug [handle_bulk_completion] detected endpoint stall
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=0
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [handle_events] timerfd triggered
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_cancel_transfer]
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=-2 transferred=0
>> libusb:debug [handle_bulk_completion] handling completion status -2 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] abnormal reap: urb status -2
>> libusb:debug [handle_bulk_completion] abnormal reap: last URB handled,
>> reporting
>> libusb:debug [usbi_handle_transfer_cancellation] detected timeout
>> cancellation
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_reset_device]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=18
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_reset_device]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=18
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=32
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=42
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 8
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=-32 transferred=0
>> libusb:debug [handle_bulk_completion] handling completion status -32
>> of bulk urb 1/1
>> libusb:debug [handle_bulk_completion] detected endpoint stall
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=0
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [handle_events] timerfd triggered
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_cancel_transfer]
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=-2 transferred=0
>> libusb:debug [handle_bulk_completion] handling completion status -2 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] abnormal reap: urb status -2
>> libusb:debug [handle_bulk_completion] abnormal reap: last URB handled,
>> reporting
>> libusb:debug [usbi_handle_transfer_cancellation] detected timeout
>> cancellation
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_reset_device]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=18
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_reset_device]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=18
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=32
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=42
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 8
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=-32 transferred=0
>> libusb:debug [handle_bulk_completion] handling completion status -32
>> of bulk urb 1/1
>> libusb:debug [handle_bulk_completion] detected endpoint stall
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=0
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [handle_events] timerfd triggered
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_cancel_transfer]
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=-2 transferred=0
>> libusb:debug [handle_bulk_completion] handling completion status -2 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] abnormal reap: urb status -2
>> libusb:debug [handle_bulk_completion] abnormal reap: last URB handled,
>> reporting
>> libusb:debug [usbi_handle_transfer_cancellation] detected timeout
>> cancellation
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_reset_device]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=18
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_reset_device]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=18
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=32
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=42
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 8
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=-32 transferred=0
>> libusb:debug [handle_bulk_completion] handling completion status -32
>> of bulk urb 1/1
>> libusb:debug [handle_bulk_completion] detected endpoint stall
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=0
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [handle_events] timerfd triggered
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_cancel_transfer]
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=-2 transferred=0
>> libusb:debug [handle_bulk_completion] handling completion status -2 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] abnormal reap: urb status -2
>> libusb:debug [handle_bulk_completion] abnormal reap: last URB handled,
>> reporting
>> libusb:debug [usbi_handle_transfer_cancellation] detected timeout
>> cancellation
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_reset_device]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=18
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_reset_device]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=18
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=32
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=42
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 18
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=18
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 8
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=-32 transferred=0
>> libusb:debug [handle_bulk_completion] handling completion status -32
>> of bulk urb 1/1
>> libusb:debug [handle_bulk_completion] detected endpoint stall
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=0
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 18
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=18
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 8
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=8
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 192
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=-121 transferred=36
>> libusb:debug [handle_bulk_completion] handling completion status -121
>> of bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 12
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=12
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 4
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=4
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 12
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=12
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 36
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=36
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 12
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=12
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 18
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=18
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 8
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=8
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 2
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=2
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 8
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=8
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 34
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=34
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 192
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=-121 transferred=36
>> libusb:debug [handle_bulk_completion] handling completion status -121
>> of bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 8
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=-32 transferred=0
>> libusb:debug [handle_bulk_completion] handling completion status -32
>> of bulk urb 1/1
>> libusb:debug [handle_bulk_completion] detected endpoint stall
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=0
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 18
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=18
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 4
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=4
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 12
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=12
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 36
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=36
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 4096
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=4096
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 36
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=36
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=13
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 31
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=0 transferred=31
>> libusb:debug [handle_bulk_completion] handling completion status 0 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] last URB in transfer --> complete!
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 8
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=-32 transferred=0
>> libusb:debug [handle_bulk_completion] handling completion status -32
>> of bulk urb 1/1
>> libusb:debug [handle_bulk_completion] detected endpoint stall
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=2 status=0 transferred=0
>> libusb:debug [handle_control_completion] handling completion status 0
>> libusb:debug [disarm_timerfd]
>> libusb:debug [submit_bulk_transfer] need 1 urbs for new transfer with
>> length 13
>> libusb:debug [libusb_submit_transfer] arm timerfd for timeout in
>> 5000ms (first in line)
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [handle_events] timerfd triggered
>> libusb:debug [disarm_timerfd]
>> libusb:debug [libusb_cancel_transfer]
>> libusb:debug [handle_events] poll() 4 fds with timeout in 0ms
>> libusb:debug [handle_events] poll() returned 1
>> libusb:debug [reap_for_handle] urb type=3 status=-2 transferred=0
>> libusb:debug [handle_bulk_completion] handling completion status -2 of
>> bulk urb 1/1
>> libusb:debug [handle_bulk_completion] abnormal reap: urb status -2
>> libusb:debug [handle_bulk_completion] abnormal reap: last URB handled,
>> reporting
>> libusb:debug [usbi_handle_transfer_cancellation] detected timeout
>> cancellation
>> libusb:debug [disarm_timerfd]
>>
>> 2011/9/30 nicolas prochazka<prochazka.nicolas at gmail.com>:
>>>
>>> you're right, it's running now
>>> Regard,
>>> Nicolas
>>>
>>> 2011/9/30 Hans de Goede<hdegoede at redhat.com>
>>>>
>>>> Hi,
>>>>
>>>> On 09/30/2011 03:32 PM, nicolas prochazka wrote:
>>>>>
>>>>> Hello,
>>>>> no change , usb stick not seen, new idea ?
>>>>>
>>>>> 1 )
>>>>>
>>>>> /usr/local/bin/qemu -name M_fedora15 -spice
>>>>> port=11982,disable-ticketing -soundhw hda -vga qxl*-readconfig /tmp/ehci *
>>>>> -device virtio-serial -chardev spicevmc,id=vdagent,name=vdagent -device
>>>>> virtserialport,chardev=vdagent,name=com.redhat.spice.0 -cpu kvm64
>>>>> -localtime -vnc 10.98.98.1:152<http://10.98.98.1:152> -monitor
>>>>> tcp:127.0.0.1:10152<http://127.0.0.1:10152>,server,nowait,nodelay -m 2048
>>>>> -pidfile /var/run/qemu/M_fedora15.pid -net
>>>>> tap,vlan=5,name=externe,script=/etc/qemu-ifEup,downscript=/etc/qemu-ifEdown,ifname=vmEtap52
>>>>> -net nic,vlan=5,macaddr=ac:de:49:29:58:26,model=rtl8139 -drive
>>>>> file=/swapfile-guest/swap1,if=ide,index=1,media=disk,snapshot=on -rtc
>>>>> base=localtime -drive
>>>>> file=/mnt/vdisk/images/MASTER-fedora15.1317382859.042259.MASTER,index=0,media=disk,snapshot=off,cache=writeback
>>>>> -drive
>>>>> file=/swapfile-guest/swap1,if=ide,index=2,media=disk,snapshot=on,boot=off
>>>>> -drive
>>>>> file=/mnt/vdisk/iso/Fedora-15-i686-Live-Desktop.iso,index=3,media=cdrom
>>>>> -boot d -fda fat:floppy:/mnt/vdisk/diskconf/M_fedora15 -chardev
>>>>> spicevmc,name=usbredir,id=usbredirchardev1 -device
>>>>> usb-redir,chardev=usbredirchardev1,id=usbredirdev1,debug=3 -chardev
>>>>> spicevmc,name=usbredir,id=usbredirchardev2 -device
>>>>> usb-redir,chardev=usbredirchardev2,id=usbredirdev2,debug=3 -chardev
>>>>> spicevmc,name=usbredir,id=usbredirchardev3 -device
>>>>> usb-redir,chardev=usbredirchardev3,id=usbredirdev3,debug=3
>>>>>
>>>>> 2 ) automounting is disable , just notifier of new usb plug.
>>>>> Keyboard focus : I write into xterm under the fedora guest. : vm
>>>>> having keyboard focus
>>>>> auto redirect usb devices checkbox checked : yes
>>>>>
>>>>
>>>> Here:
>>>>
>>>>> (spicy:23239): GLib-GObject-WARNING **: g_object_set_valist: object
>>>>> class `SpiceDisplay' has no property named `auto-usbredir'
>>>>
>>>> Is a clue to your problem. Likely you've an older version of spice-gtk
>>>> installed in another libdir then
>>>> where you installed the latest version, run ldd un spicy, ie:
>>>> ldd /usr/local/bin/spicy
>>>>
>>>> And see which libspice-client-* it is using. If the one used is not at
>>>> the location where
>>>> you did the latest make install (I assume you did do a make install,
>>>> right?) you can
>>>> set LD_LIBRARY_PATH to point to point to the latest, ie:
>>>> export LD_LIBRARY_PATH=/usr/local/lib
>>>> ldd /usr/local/bin/spicy
>>>>
>>>> The ldd command is to check the LD_LIBRARY_PATH setting helps, note that
>>>> setting
>>>> LD_LIBRARY_PATH won't work over sudo / su, so first do
>>>> su -
>>>> or:
>>>> sudo su -
>>>> and then set the LD_LIBRARY_PATH and run spicy without sudo.
>>>>
>>>> Regards,
>>>>
>>>> Hans
>>>>
>>>>
>>>>
>>>>> Regards,
>>>>> Nicolas Prochazka.
>>>>>
>>>>>
>>>>> ^Ccolossus:~ # spicy
>>>>> libusb:debug [libusb_init]
>>>>> libusb:debug [find_usbfs_path] found usbfs at /dev/bus/usb
>>>>> libusb:debug [op_init] bulk continuation flag supported
>>>>> libusb:debug [op_init] found usb devices in sysfs
>>>>> libusb:debug [usbi_add_pollfd] add fd 6 events 1
>>>>> libusb:debug [usbi_io_init] using timerfd for timeouts
>>>>> libusb:debug [usbi_add_pollfd] add fd 8 events 1
>>>>> libusb:debug [libusb_get_device_list]
>>>>> libusb:debug [sysfs_scan_device] scan usb1
>>>>> libusb:debug [sysfs_scan_device] bus=1 dev=1
>>>>> libusb:debug [enumerate_device] busnum 1 devaddr 1 session_id 257
>>>>> libusb:debug [enumerate_device] allocating new device for 1/1 (session
>>>>> 257)
>>>>> libusb:debug [sysfs_scan_device] scan usb2
>>>>> libusb:debug [sysfs_scan_device] bus=2 dev=1
>>>>> libusb:debug [enumerate_device] busnum 2 devaddr 1 session_id 513
>>>>> libusb:debug [enumerate_device] allocating new device for 2/1 (session
>>>>> 513)
>>>>> libusb:debug [sysfs_scan_device] scan usb3
>>>>> libusb:debug [sysfs_scan_device] bus=3 dev=1
>>>>> libusb:debug [enumerate_device] busnum 3 devaddr 1 session_id 769
>>>>> libusb:debug [enumerate_device] allocating new device for 3/1 (session
>>>>> 769)
>>>>> libusb:debug [sysfs_scan_device] scan usb4
>>>>> libusb:debug [sysfs_scan_device] bus=4 dev=1
>>>>> libusb:debug [enumerate_device] busnum 4 devaddr 1 session_id 1025
>>>>> libusb:debug [enumerate_device] allocating new device for 4/1 (session
>>>>> 1025)
>>>>> libusb:debug [sysfs_scan_device] scan usb5
>>>>> libusb:debug [sysfs_scan_device] bus=5 dev=1
>>>>> libusb:debug [enumerate_device] busnum 5 devaddr 1 session_id 1281
>>>>> libusb:debug [enumerate_device] allocating new device for 5/1 (session
>>>>> 1281)
>>>>> libusb:debug [sysfs_scan_device] scan usb6
>>>>> libusb:debug [sysfs_scan_device] bus=6 dev=1
>>>>> libusb:debug [enumerate_device] busnum 6 devaddr 1 session_id 1537
>>>>> libusb:debug [enumerate_device] allocating new device for 6/1 (session
>>>>> 1537)
>>>>> libusb:debug [sysfs_scan_device] scan usb7
>>>>> libusb:debug [sysfs_scan_device] bus=7 dev=1
>>>>> libusb:debug [enumerate_device] busnum 7 devaddr 1 session_id 1793
>>>>> libusb:debug [enumerate_device] allocating new device for 7/1 (session
>>>>> 1793)
>>>>> libusb:debug [sysfs_scan_device] scan usb8
>>>>> libusb:debug [sysfs_scan_device] bus=8 dev=1
>>>>> libusb:debug [enumerate_device] busnum 8 devaddr 1 session_id 2049
>>>>> libusb:debug [enumerate_device] allocating new device for 8/1 (session
>>>>> 2049)
>>>>> libusb:debug [sysfs_scan_device] scan 2-2
>>>>> libusb:debug [sysfs_scan_device] bus=2 dev=3
>>>>> libusb:debug [enumerate_device] busnum 2 devaddr 3 session_id 515
>>>>> libusb:debug [enumerate_device] allocating new device for 2/3 (session
>>>>> 515)
>>>>> libusb:debug [discovered_devs_append] need to increase capacity
>>>>> libusb:debug [sysfs_scan_device] scan 4-2
>>>>> libusb:debug [sysfs_scan_device] bus=4 dev=2
>>>>> libusb:debug [enumerate_device] busnum 4 devaddr 2 session_id 1026
>>>>> libusb:debug [enumerate_device] allocating new device for 4/2 (session
>>>>> 1026)
>>>>> libusb:debug [sysfs_scan_device] scan 6-1
>>>>> libusb:debug [sysfs_scan_device] bus=6 dev=3
>>>>> libusb:debug [enumerate_device] busnum 6 devaddr 3 session_id 1539
>>>>> libusb:debug [enumerate_device] allocating new device for 6/3 (session
>>>>> 1539)
>>>>> libusb:debug [sysfs_scan_device] scan 1-3
>>>>> libusb:debug [sysfs_scan_device] bus=1 dev=11
>>>>> libusb:debug [enumerate_device] busnum 1 devaddr 11 session_id 267
>>>>> libusb:debug [enumerate_device] allocating new device for 1/11 (session
>>>>> 267)
>>>>> libusb:debug [libusb_unref_device] destroy device 1.1
>>>>> libusb:debug [libusb_unref_device] destroy device 2.1
>>>>> libusb:debug [libusb_unref_device] destroy device 3.1
>>>>> libusb:debug [libusb_unref_device] destroy device 4.1
>>>>> libusb:debug [libusb_unref_device] destroy device 5.1
>>>>> libusb:debug [libusb_unref_device] destroy device 6.1
>>>>> libusb:debug [libusb_unref_device] destroy device 7.1
>>>>> libusb:debug [libusb_unref_device] destroy device 8.1
>>>>> GSpice-Message: main channel: failed to connect
>>>>> GSpice-Message: main channel: opened
>>>>>
>>>>> (spicy:23239): GLib-GObject-WARNING **: g_object_set_valist: object
>>>>> class `SpiceDisplay' has no property named `auto-usbredir'
>>>>>
>>>>> (spicy:23239): GLib-GObject-WARNING **: g_object_get_valist: object
>>>>> class `SpiceDisplay' has no property named `auto-usbredir'
>>>>>
>>>>> (spicy:23239): GLib-GObject-WARNING **: g_object_set_valist: object
>>>>> class `SpiceDisplay' has no property named `auto-usbredir'
>>>>>
>>>>> (spicy:23239): GSpice-WARNING **: PulseAudio context failed Connection
>>>>> refused
>>>>> libusb:debug [libusb_unref_device] destroy device 1.11
>>>>>
>>>>> (spicy:23239): GLib-GObject-WARNING **: g_object_set_valist: object
>>>>> class `SpiceDisplay' has no property named `auto-usbredir'
>>>>>
>>>>> (spicy:23239): GLib-GObject-WARNING **: g_object_set_valist: object
>>>>> class `SpiceDisplay' has no property named `auto-usbredir'
>>>>> libusb:debug [libusb_get_device_list]
>>>>> libusb:debug [sysfs_scan_device] scan usb1
>>>>> libusb:debug [sysfs_scan_device] bus=1 dev=1
>>>>> libusb:debug [enumerate_device] busnum 1 devaddr 1 session_id 257
>>>>> libusb:debug [enumerate_device] allocating new device for 1/1 (session
>>>>> 257)
>>>>> libusb:debug [sysfs_scan_device] scan usb2
>>>>> libusb:debug [sysfs_scan_device] bus=2 dev=1
>>>>> libusb:debug [enumerate_device] busnum 2 devaddr 1 session_id 513
>>>>> libusb:debug [enumerate_device] allocating new device for 2/1 (session
>>>>> 513)
>>>>> libusb:debug [sysfs_scan_device] scan usb3
>>>>> libusb:debug [sysfs_scan_device] bus=3 dev=1
>>>>> libusb:debug [enumerate_device] busnum 3 devaddr 1 session_id 769
>>>>> libusb:debug [enumerate_device] allocating new device for 3/1 (session
>>>>> 769)
>>>>> libusb:debug [sysfs_scan_device] scan usb4
>>>>> libusb:debug [sysfs_scan_device] bus=4 dev=1
>>>>> libusb:debug [enumerate_device] busnum 4 devaddr 1 session_id 1025
>>>>> libusb:debug [enumerate_device] allocating new device for 4/1 (session
>>>>> 1025)
>>>>> libusb:debug [sysfs_scan_device] scan usb5
>>>>> libusb:debug [sysfs_scan_device] bus=5 dev=1
>>>>> libusb:debug [enumerate_device] busnum 5 devaddr 1 session_id 1281
>>>>> libusb:debug [enumerate_device] allocating new device for 5/1 (session
>>>>> 1281)
>>>>> libusb:debug [sysfs_scan_device] scan usb6
>>>>> libusb:debug [sysfs_scan_device] bus=6 dev=1
>>>>> libusb:debug [enumerate_device] busnum 6 devaddr 1 session_id 1537
>>>>> libusb:debug [enumerate_device] allocating new device for 6/1 (session
>>>>> 1537)
>>>>> libusb:debug [sysfs_scan_device] scan usb7
>>>>> libusb:debug [sysfs_scan_device] bus=7 dev=1
>>>>> libusb:debug [enumerate_device] busnum 7 devaddr 1 session_id 1793
>>>>> libusb:debug [enumerate_device] allocating new device for 7/1 (session
>>>>> 1793)
>>>>> libusb:debug [sysfs_scan_device] scan usb8
>>>>> libusb:debug [sysfs_scan_device] bus=8 dev=1
>>>>> libusb:debug [enumerate_device] busnum 8 devaddr 1 session_id 2049
>>>>> libusb:debug [enumerate_device] allocating new device for 8/1 (session
>>>>> 2049)
>>>>> libusb:debug [sysfs_scan_device] scan 2-2
>>>>> libusb:debug [sysfs_scan_device] bus=2 dev=3
>>>>> libusb:debug [enumerate_device] busnum 2 devaddr 3 session_id 515
>>>>> libusb:debug [enumerate_device] using existing device for 2/3 (session
>>>>> 515)
>>>>> libusb:debug [discovered_devs_append] need to increase capacity
>>>>> libusb:debug [sysfs_scan_device] scan 4-2
>>>>> libusb:debug [sysfs_scan_device] bus=4 dev=2
>>>>> libusb:debug [enumerate_device] busnum 4 devaddr 2 session_id 1026
>>>>> libusb:debug [enumerate_device] using existing device for 4/2 (session
>>>>> 1026)
>>>>> libusb:debug [sysfs_scan_device] scan 6-1
>>>>> libusb:debug [sysfs_scan_device] bus=6 dev=3
>>>>> libusb:debug [enumerate_device] busnum 6 devaddr 3 session_id 1539
>>>>> libusb:debug [enumerate_device] using existing device for 6/3 (session
>>>>> 1539)
>>>>> libusb:debug [sysfs_scan_device] scan 1-3
>>>>> libusb:debug [sysfs_scan_device] bus=1 dev=12
>>>>> libusb:debug [enumerate_device] busnum 1 devaddr 12 session_id 268
>>>>> libusb:debug [enumerate_device] allocating new device for 1/12 (session
>>>>> 268)
>>>>> libusb:debug [libusb_unref_device] destroy device 1.1
>>>>> libusb:debug [libusb_unref_device] destroy device 2.1
>>>>> libusb:debug [libusb_unref_device] destroy device 3.1
>>>>> libusb:debug [libusb_unref_device] destroy device 4.1
>>>>> libusb:debug [libusb_unref_device] destroy device 5.1
>>>>> libusb:debug [libusb_unref_device] destroy device 6.1
>>>>> libusb:debug [libusb_unref_device] destroy device 7.1
>>>>> libusb:debug [libusb_unref_device] destroy device 8.1
>>>>>
>>>>>
>>>>>
>>>>>
>>>>>
>>>>>
>>>>>
>>>>> /usr/local/bin/qemu -name M_fedora15 -spice
>>>>> port=11982,disable-ticketing -soundhw hda -vga qxl -readconfig /tmp/ehci
>>>>> -device virtio-serial -chardev spicevmc,id=vdagent,name=vdagent -device
>>>>> virtserialport,chardev=vdagent,name=com.redhat.spice.0 -cpu kvm64
>>>>> -localtime -vnc 10.98.98.1:152<http://10.98.98.1:152> -monitor
>>>>> tcp:127.0.0.1:10152<http://127.0.0.1:10152>,server,nowait,nodelay -m 2048
>>>>> -pidfile /var/run/qemu/M_fedora15.pid -net
>>>>> tap,vlan=5,name=externe,script=/etc/qemu-ifEup,downscript=/etc/qemu-ifEdown,ifname=vmEtap52
>>>>> -net nic,vlan=5,macaddr=ac:de:49:29:58:26,model=rtl8139 -drive
>>>>> file=/swapfile-guest/swap1,if=ide,index=1,media=disk,snapshot=on -rtc
>>>>> base=localtime -drive
>>>>> file=/mnt/vdisk/images/MASTER-fedora15.1317382859.042259.MASTER,index=0,media=disk,snapshot=off,cache=writeback
>>>>> -drive
>>>>> file=/swapfile-guest/swap1,if=ide,index=2,media=disk,snapshot=on,boot=off
>>>>> -drive
>>>>> file=/mnt/vdisk/iso/Fedora-15-i686-Live-Desktop.iso,index=3,media=cdrom
>>>>> -boot d -fda fat:floppy:/mnt/vdisk/diskconf/M_fedora15 -chardev
>>>>> spicevmc,name=usbredir,id=usbredirchardev1 -device
>>>>> usb-redir,chardev=usbredirchardev1,id=usbredirdev1,debug=3 -chardev
>>>>> spicevmc,name=usbredir,id=usbredirchardev2 -device
>>>>> usb-redir,chardev=usbredirchardev2,id=usbredirdev2,debug=3 -chardev
>>>>> spicevmc,name=usbredir,id=usbredirchardev3 -device
>>>>> usb-redir,chardev=usbredirchardev3,id=usbredirdev3,debug=3
>>>>> do_spice_init: starting 0.9.1
>>>>> spice_server_add_interface: SPICE_INTERFACE_KEYBOARD
>>>>> spice_server_add_interface: SPICE_INTERFACE_MOUSE
>>>>> spice_server_add_interface: SPICE_INTERFACE_QXL
>>>>> red_worker_main: begin
>>>>> ensure_display_channel_created: create display channel
>>>>> ensure_cursor_channel_created: create cursor channel
>>>>> spice_server_add_interface: SPICE_INTERFACE_PLAYBACK
>>>>> spice_server_add_interface: SPICE_INTERFACE_RECORD
>>>>> *** EHCI support is under development ***
>>>>> spice_server_char_device_add_interface: CHAR_DEVICE usbredir
>>>>> spice_server_char_device_add_interface: CHAR_DEVICE usbredir
>>>>> spice_server_char_device_add_interface: CHAR_DEVICE usbredir
>>>>> handle_dev_input: start
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_handle_main_link:
>>>>> reds_disconnect:
>>>>> reds_show_new_channel: channel 1:0, connected successfully, over Non
>>>>> Secure link
>>>>> main_channel_link: add main channel client
>>>>> reds_handle_main_link: NEW Client 0x2dd87f0 mcc 0x2df5440 connect-id
>>>>> 1804289383
>>>>> main_channel_handle_parsed: net test: latency 0.629000 ms, bitrate
>>>>> 856903765 bps (817.207112 Mbps)
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 6:0, connected successfully, over Non
>>>>> Secure link
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 5:0, connected successfully, over Non
>>>>> Secure link
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 2:0, connected successfully, over Non
>>>>> Secure link
>>>>> red_dispatcher_set_display_peer:
>>>>> handle_dev_input: connect
>>>>> handle_new_display_channel: add display channel client
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> handle_new_display_channel: New display (client 0x2dd87f0) dcc
>>>>> 0x2e2d610 stream 0x2de9800
>>>>> handle_new_display_channel: jpeg disabled
>>>>> handle_new_display_channel: zlib-over-glz disabled
>>>>> listen_to_new_client_channel: NEW ID = 0
>>>>> reds_show_new_channel: channel 4:0, connected successfully, over Non
>>>>> Secure link
>>>>> red_dispatcher_set_cursor_peer:
>>>>> display_channel_client_wait_for_init: creating encoder with id == 0
>>>>> handle_dev_input: cursor connect
>>>>> red_connect_cursor: add cursor channel client
>>>>> listen_to_new_client_channel: NEW ID = 0
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 3:0, connected successfully, over Non
>>>>> Secure link
>>>>> inputs_connect: inputs channel client create
>>>>> display_channel_release_item: not pushed (101)
>>>>> handle_dev_input: OOM1 #draw=6, #red_draw=60, #glz_draw=56 current 6
>>>>> pipes 0
>>>>> handle_dev_input: OOM2 #draw=6, #red_draw=60, #glz_draw=56 current 6
>>>>> pipes 0
>>>>> handle_dev_input: OOM1 #draw=7, #red_draw=61, #glz_draw=57 current 7
>>>>> pipes 0
>>>>> red_free_some: #draw=7, #red_draw=61, #glz_draw=57
>>>>> handle_dev_input: OOM2 #draw=0, #red_draw=0, #glz_draw=0 current 0
>>>>> pipes 0
>>>>> spice_server_add_interface: SPICE_INTERFACE_TABLET
>>>>> handle_dev_input: mouse mode 2
>>>>> red_channel_client_disconnect: 0x2e2d610 (channel 0x204fae0 type 2 id
>>>>> 0)
>>>>> snd_channel_put: sound channel freed
>>>>>
>>>>> red_channel_client_disconnect: 0x2df5440 (channel 0x2df6660 type 1 id
>>>>> 0)
>>>>> display_channel_client_on_disconnect:
>>>>> main_channel_client_on_disconnect: rcc=0x2df5440
>>>>> reds_client_disconnect:
>>>>> red_client_destroy: destroy client with #channels 4
>>>>> red_channel_client_disconnect: 0x2e195a0 (channel 0x1fb3fe0 type 3 id
>>>>> 0)
>>>>> red_dispatcher_disconnect_cursor_peer:
>>>>> display_channel_client_on_disconnect: #draw=41, #red_draw=41,
>>>>> #glz_draw=0
>>>>> red_channel_client_disconnect: 0x2e2bb90 (channel 0x2050060 type 4 id
>>>>> 0)
>>>>> handle_dev_input: disconnect cursor client
>>>>> red_channel_client_disconnect: 0x2e2bb90 (channel 0x2050060 type 4 id
>>>>> 0)
>>>>> red_dispatcher_disconnect_display_peer:
>>>>> handle_dev_input: disconnect display client
>>>>> red_channel_client_disconnect: 0x2e2d610 (channel 0x204fae0 type 2 id
>>>>> 0)
>>>>> red_channel_client_disconnect: 0x2df5440 (channel 0x2df6660 type 1 id
>>>>> 0)
>>>>> snd_channel_put: sound channel freed
>>>>>
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_handle_main_link:
>>>>> reds_disconnect:
>>>>> reds_show_new_channel: channel 1:0, connected successfully, over Non
>>>>> Secure link
>>>>> main_channel_link: add main channel client
>>>>> reds_handle_main_link: NEW Client 0x2f9f530 mcc 0x2a2c800 connect-id
>>>>> 846930886
>>>>> main_channel_handle_parsed: net test: latency 0.724000 ms, bitrate
>>>>> 980842911 bps (935.404693 Mbps)
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 6:0, connected successfully, over Non
>>>>> Secure link
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 5:0, connected successfully, over Non
>>>>> Secure link
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 2:0, connected successfully, over Non
>>>>> Secure link
>>>>> red_dispatcher_set_display_peer:
>>>>> handle_dev_input: connect
>>>>> handle_new_display_channel: add display channel client
>>>>> handle_new_display_channel: New display (client 0x2f9f530) dcc
>>>>> 0x7fdfd8e14f40 stream 0x2a19db0
>>>>> handle_new_display_channel: jpeg disabled
>>>>> handle_new_display_channel: zlib-over-glz disabled
>>>>> listen_to_new_client_channel: NEW ID = 0
>>>>> display_channel_client_wait_for_init: creating encoder with id == 0
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 4:0, connected successfully, over Non
>>>>> Secure link
>>>>> red_dispatcher_set_cursor_peer:
>>>>> handle_dev_input: cursor connect
>>>>> red_connect_cursor: add cursor channel client
>>>>> listen_to_new_client_channel: NEW ID = 0
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 3:0, connected successfully, over Non
>>>>> Secure link
>>>>> inputs_connect: inputs channel client create
>>>>>
>>>>>
>>>>>
>>>>>
>>>>>
>>>>>
>>>>> 2011/9/30 Hans de
>>>>> Goede<hdegoede at redhat.com<mailto:hdegoede at redhat.com>>
>>>>>
>>>>> Hi,
>>>>>
>>>>>
>>>>> On 09/30/2011 03:03 PM, nicolas prochazka wrote:
>>>>>
>>>>> Hello,
>>>>> I'm trying to play with usb redirect , I read
>>>>> http://hansdegoede. livejournal.com/<http://hansdegoede.livejournal.com/>
>>>>> howto,
>>>>> but I cannot see usb stick under my guest vm.a
>>>>>
>>>>> I think i do something wrong.
>>>>>
>>>>>
>>>>> So 2 things stand out wrt your qemu cmdline, which explain part of
>>>>> the problem:
>>>>> 1) You've the first -device usb-redir,... on the cmdline before the
>>>>> -readconfig /tmp/ehci
>>>>> 2) You also pass the old -usb, this gives you a usb1 only bus, just
>>>>> drop the -usb please
>>>>>
>>>>>
>>>>> ( I 've keyboard focus in guest vm, but when I plug my usb, my
>>>>> opensuse mount it , is it normal ? )
>>>>>
>>>>>
>>>>> Yes and no, in my testing spice-gtk usually manages to grab the
>>>>> device before it gets
>>>>> mounted. and even if it does get mounted, spice-gtk should "steal"
>>>>> it from the native
>>>>> linux driver, and the mount should go away (unless it is busy).
>>>>>
>>>>> Is the auto redirect usb devices checkbox checked? And when you say
>>>>> has keyboard focus,
>>>>> did you first click and type something inside the vm? If the
>>>>> spice-gtk menu-bar has
>>>>> keyboard focus that does not count as the vm having keyboard focus.
>>>>>
>>>>> Regards,
>>>>>
>>>>> Hans
>>>>>
>>>>>
>>>>>
>>>>>
>>>>>
>>>>>
>>>>>
>>>>> Regards,
>>>>> Nicolas Prochazka
>>>>>
>>>>> Log of qemu /spice , and spicy
>>>>>
>>>>> DEV-10.98.98.1:~# /usr/local/bin/qemu -name M_fedora15 *-spice
>>>>> port=11982,disable-ticketing -soundhw hda -vga qxl -device virtio-serial
>>>>> -chardev spicevmc,id=vdagent,name= vdagent -device virtserialport,chardev=
>>>>> vdagent,name=com.redhat.spice. 0* -cpu kvm64 -localtime -usb -vnc
>>>>> 10.98.98.1:152<http://10.98.98.1:152> <http://10.98.98.1:152> -monitor
>>>>> tcp:127.0.0.1:10152<http://127.0.0.1:10152> <http://127.0.0.1:10152>,
>>>>> server,nowait,nodelay -m 2048 -pidfile /var/run/qemu/M_fedora15.pid -net
>>>>> tap,vlan=5,name=externe, script=/etc/qemu-ifEup,
>>>>> downscript=/etc/qemu-ifEdown, ifname=vmEtap52
>>>>> -net nic,vlan=5,macaddr=ac:de:49: 29:58:26,model=rtl8139 -drive
>>>>> file=/swapfile-guest/swap1,if= ide,index=1,media=disk,
>>>>> snapshot=on -rtc base=localtime -drive file=/mnt/vdisk/images/MASTER-
>>>>> fedora15.1317382859.042259. MASTER,index=0,media=disk,
>>>>> snapshot=off,cache=writeback -drive file=/swapfile-guest/swap1,if=
>>>>> ide,index=2,media=disk, snapshot=on,boot=off -drive
>>>>> file=/mnt/vdisk/iso/Fedora-15- i686-Live-Desktop.iso,index=3, media=cdrom
>>>>> -boot d -fda fat:floppy:/mnt/vdisk/ diskconf/M_fedora15 *-chardev
>>>>> spicevmc,name=usbredir,id= usbredirchardev1 -device usb-redir,chardev=
>>>>> usbredirchardev1,id= usbredirdev1,debug=3 -readconfig /tmp/ehci -chardev
>>>>> spicevmc,name=usbredir,id= usbredirchardev2 -device
>>>>> usb-redir,chardev= usbredirchardev2,id= usbredirdev2,debug=3 -chardev
>>>>> spicevmc,name=usbredir,id= usbredirchardev3 -device usb-redir,chardev=
>>>>> usbredirchardev3,id= usbredirdev3,debug=3*
>>>>>
>>>>>
>>>>> do_spice_init: starting 0.9.1
>>>>> spice_server_add_interface: SPICE_INTERFACE_KEYBOARD
>>>>> spice_server_add_interface: SPICE_INTERFACE_MOUSE
>>>>> spice_server_add_interface: SPICE_INTERFACE_QXL
>>>>> red_worker_main: begin
>>>>> ensure_display_channel_ created: create display channel
>>>>> ensure_cursor_channel_created: create cursor channel
>>>>> spice_server_add_interface: SPICE_INTERFACE_PLAYBACK
>>>>> spice_server_add_interface: SPICE_INTERFACE_RECORD
>>>>> spice_server_char_device_add_ interface: CHAR_DEVICE usbredir
>>>>> *** EHCI support is under development ***
>>>>> spice_server_char_device_add_ interface: CHAR_DEVICE usbredir
>>>>> spice_server_char_device_add_ interface: CHAR_DEVICE usbredir
>>>>> handle_dev_input: start
>>>>> spice_server_add_interface: SPICE_INTERFACE_TABLET
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_handle_main_link:
>>>>> reds_disconnect:
>>>>> reds_show_new_channel: channel 1:0, connected successfully, over
>>>>> Non Secure link
>>>>> main_channel_link: add main channel client
>>>>> reds_handle_main_link: NEW Client 0x2de06a0 mcc 0x2de77f0
>>>>> connect-id 1804289383
>>>>> handle_dev_input: mouse mode 2
>>>>> main_channel_handle_parsed: net test: latency 0.676000 ms,
>>>>> bitrate 840722495 bps (801.775451 Mbps)
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 6:0, connected successfully, over
>>>>> Non Secure link
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 5:0, connected successfully, over
>>>>> Non Secure link
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 2:0, connected successfully, over
>>>>> Non Secure link
>>>>> red_dispatcher_set_display_ peer:
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> handle_dev_input: connect
>>>>> handle_new_display_channel: add display channel client
>>>>> handle_new_display_channel: New display (client 0x2de06a0) dcc
>>>>> 0x2e31640 stream 0x2de7500
>>>>> handle_new_display_channel: jpeg disabled
>>>>> handle_new_display_channel: zlib-over-glz disabled
>>>>> listen_to_new_client_channel: NEW ID = 0
>>>>> reds_show_new_channel: channel 4:0, connected successfully, over
>>>>> Non Secure link
>>>>> red_dispatcher_set_cursor_ peer:
>>>>> display_channel_client_wait_ for_init: creating encoder with id
>>>>> == 0
>>>>> handle_dev_input: cursor connect
>>>>> red_connect_cursor: add cursor channel client
>>>>> listen_to_new_client_channel: NEW ID = 0
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 3:0, connected successfully, over
>>>>> Non Secure link
>>>>> inputs_connect: inputs channel client create
>>>>> display_channel_release_item: not pushed (101)
>>>>> handle_dev_input: OOM1 #draw=7, #red_draw=60, #glz_draw=56
>>>>> current 7 pipes 0
>>>>> handle_dev_input: OOM2 #draw=7, #red_draw=60, #glz_draw=56
>>>>> current 7 pipes 0
>>>>> handle_dev_input: OOM1 #draw=7, #red_draw=60, #glz_draw=56
>>>>> current 7 pipes 0
>>>>> red_free_some: #draw=7, #red_draw=60, #glz_draw=56
>>>>> handle_dev_input: OOM2 #draw=0, #red_draw=0, #glz_draw=0 current
>>>>> 0 pipes 0
>>>>> handle_dev_input: OOM1 #draw=24, #red_draw=3587, #glz_draw=3567
>>>>> current 24 pipes 0
>>>>> handle_dev_input: OOM2 #draw=24, #red_draw=3587, #glz_draw=3567
>>>>> current 24 pipes 0
>>>>> handle_dev_input: OOM1 #draw=24, #red_draw=3587, #glz_draw=3567
>>>>> current 24 pipes 0
>>>>> handle_dev_input: OOM2 #draw=24, #red_draw=3587, #glz_draw=3567
>>>>> current 24 pipes 0
>>>>> handle_dev_input: OOM1 #draw=24, #red_draw=3587, #glz_draw=3567
>>>>> current 24 pipes 0
>>>>> red_free_some: #draw=24, #red_draw=3587, #glz_draw=3567
>>>>> handle_dev_input: OOM2 #draw=24, #red_draw=3523, #glz_draw=3503
>>>>> current 24 pipes 0
>>>>> handle_dev_input: OOM1 #draw=21, #red_draw=3905, #glz_draw=3888
>>>>> current 21 pipes 0
>>>>> handle_dev_input: OOM2 #draw=21, #red_draw=3905, #glz_draw=3888
>>>>> current 21 pipes 0
>>>>> handle_dev_input: OOM1 #draw=21, #red_draw=3905, #glz_draw=3888
>>>>> current 21 pipes 0
>>>>> handle_dev_input: OOM2 #draw=21, #red_draw=3905, #glz_draw=3888
>>>>> current 21 pipes 0
>>>>> handle_dev_input: OOM1 #draw=21, #red_draw=3905, #glz_draw=3888
>>>>> current 21 pipes 0
>>>>> red_free_some: #draw=21, #red_draw=3905, #glz_draw=3888
>>>>> handle_dev_input: OOM2 #draw=21, #red_draw=3841, #glz_draw=3824
>>>>> current 21 pipes 0
>>>>> handle_dev_input: OOM1 #draw=17, #red_draw=3849, #glz_draw=3835
>>>>> current 17 pipes 0
>>>>> handle_dev_input: OOM2 #draw=17, #red_draw=3849, #glz_draw=3835
>>>>> current 17 pipes 0
>>>>> handle_dev_input: OOM1 #draw=17, #red_draw=3849, #glz_draw=3835
>>>>> current 17 pipes 0
>>>>> red_free_some: #draw=17, #red_draw=3849, #glz_draw=3835
>>>>> handle_dev_input: OOM2 #draw=17, #red_draw=3785, #glz_draw=3771
>>>>> current 17 pipes 0
>>>>> handle_dev_input: OOM1 #draw=16, #red_draw=3798, #glz_draw=3784
>>>>> current 16 pipes 0
>>>>> handle_dev_input: OOM2 #draw=16, #red_draw=3798, #glz_draw=3784
>>>>> current 16 pipes 0
>>>>> handle_dev_input: OOM1 #draw=16, #red_draw=3798, #glz_draw=3784
>>>>> current 16 pipes 0
>>>>> handle_dev_input: OOM2 #draw=16, #red_draw=3798, #glz_draw=3784
>>>>> current 16 pipes 0
>>>>> handle_dev_input: OOM1 #draw=16, #red_draw=3798, #glz_draw=3784
>>>>> current 16 pipes 0
>>>>> red_free_some: #draw=16, #red_draw=3798, #glz_draw=3784
>>>>> handle_dev_input: OOM2 #draw=16, #red_draw=3734, #glz_draw=3720
>>>>> current 16 pipes 0
>>>>> handle_dev_input: OOM1 #draw=21, #red_draw=3756, #glz_draw=3740
>>>>> current 21 pipes 0
>>>>> handle_dev_input: OOM2 #draw=21, #red_draw=3756, #glz_draw=3740
>>>>> current 21 pipes 0
>>>>> handle_dev_input: OOM1 #draw=16, #red_draw=3754, #glz_draw=3740
>>>>> current 16 pipes 0
>>>>> handle_dev_input: OOM2 #draw=16, #red_draw=3754, #glz_draw=3740
>>>>> current 16 pipes 0
>>>>> handle_dev_input: OOM1 #draw=16, #red_draw=3754, #glz_draw=3740
>>>>> current 16 pipes 0
>>>>> red_free_some: #draw=16, #red_draw=3754, #glz_draw=3740
>>>>> handle_dev_input: OOM2 #draw=16, #red_draw=3690, #glz_draw=3676
>>>>> current 16 pipes 0
>>>>> handle_dev_input: OOM1 #draw=15, #red_draw=3716, #glz_draw=3702
>>>>> current 15 pipes 0
>>>>> handle_dev_input: OOM2 #draw=15, #red_draw=3716, #glz_draw=3702
>>>>> current 15 pipes 0
>>>>> handle_dev_input: OOM1 #draw=15, #red_draw=3716, #glz_draw=3702
>>>>> current 15 pipes 0
>>>>> handle_dev_input: OOM2 #draw=15, #red_draw=3716, #glz_draw=3702
>>>>> current 15 pipes 0
>>>>> handle_dev_input: OOM1 #draw=15, #red_draw=3716, #glz_draw=3702
>>>>> current 15 pipes 0
>>>>> red_free_some: #draw=15, #red_draw=3716, #glz_draw=3702
>>>>> handle_dev_input: OOM2 #draw=15, #red_draw=3652, #glz_draw=3638
>>>>> current 15 pipes 0
>>>>> handle_dev_input: OOM1 #draw=15, #red_draw=3654, #glz_draw=3640
>>>>> current 15 pipes 0
>>>>> red_free_some: #draw=15, #red_draw=3654, #glz_draw=3640
>>>>> handle_dev_input: OOM2 #draw=15, #red_draw=3590, #glz_draw=3576
>>>>> current 15 pipes 0
>>>>> handle_dev_input: OOM1 #draw=16, #red_draw=3667, #glz_draw=3652
>>>>> current 16 pipes 0
>>>>> handle_dev_input: OOM2 #draw=16, #red_draw=3667, #glz_draw=3652
>>>>> current 16 pipes 0
>>>>> handle_dev_input: OOM1 #draw=16, #red_draw=3667, #glz_draw=3652
>>>>> current 16 pipes 0
>>>>> handle_dev_input: OOM2 #draw=16, #red_draw=3667, #glz_draw=3652
>>>>> current 16 pipes 0
>>>>> handle_dev_input: OOM1 #draw=16, #red_draw=3667, #glz_draw=3652
>>>>> current 16 pipes 0
>>>>> red_free_some: #draw=16, #red_draw=3667, #glz_draw=3652
>>>>> handle_dev_input: OOM2 #draw=16, #red_draw=3603, #glz_draw=3588
>>>>> current 16 pipes 0
>>>>> handle_dev_input: OOM1 #draw=19, #red_draw=3625, #glz_draw=3607
>>>>> current 15 pipes 5
>>>>> handle_dev_input: OOM2 #draw=19, #red_draw=3625, #glz_draw=3607
>>>>> current 15 pipes 5
>>>>> handle_dev_input: OOM1 #draw=19, #red_draw=3625, #glz_draw=3607
>>>>> current 15 pipes 6
>>>>> handle_dev_input: OOM2 #draw=19, #red_draw=3625, #glz_draw=3607
>>>>> current 15 pipes 6
>>>>> handle_dev_input: OOM1 #draw=15, #red_draw=3623, #glz_draw=3609
>>>>> current 15 pipes 0
>>>>> handle_dev_input: OOM2 #draw=15, #red_draw=3623, #glz_draw=3609
>>>>> current 15 pipes 0
>>>>> handle_dev_input: OOM1 #draw=15, #red_draw=3623, #glz_draw=3609
>>>>> current 15 pipes 0
>>>>> red_free_some: #draw=15, #red_draw=3623, #glz_draw=3609
>>>>> handle_dev_input: OOM2 #draw=15, #red_draw=3559, #glz_draw=3545
>>>>> current 15 pipes 0
>>>>> handle_dev_input: OOM1 #draw=19, #red_draw=3625, #glz_draw=3608
>>>>> current 19 pipes 0
>>>>> handle_dev_input: OOM2 #draw=19, #red_draw=3625, #glz_draw=3608
>>>>> current 19 pipes 0
>>>>> handle_dev_input: OOM1 #draw=19, #red_draw=3625, #glz_draw=3608
>>>>> current 19 pipes 0
>>>>> handle_dev_input: OOM2 #draw=19, #red_draw=3625, #glz_draw=3608
>>>>> current 19 pipes 0
>>>>> handle_dev_input: OOM1 #draw=19, #red_draw=3625, #glz_draw=3608
>>>>> current 19 pipes 0
>>>>> red_free_some: #draw=19, #red_draw=3625, #glz_draw=3608
>>>>> handle_dev_input: OOM2 #draw=19, #red_draw=3561, #glz_draw=3544
>>>>> current 19 pipes 0
>>>>> handle_dev_input: OOM1 #draw=17, #red_draw=3561, #glz_draw=3545
>>>>> current 17 pipes 0
>>>>> handle_dev_input: OOM2 #draw=17, #red_draw=3561, #glz_draw=3545
>>>>> current 17 pipes 0
>>>>> handle_dev_input: OOM1 #draw=20, #red_draw=3637, #glz_draw=3618
>>>>> current 20 pipes 0
>>>>> handle_dev_input: OOM2 #draw=20, #red_draw=3637, #glz_draw=3618
>>>>> current 20 pipes 0
>>>>> handle_dev_input: OOM1 #draw=20, #red_draw=3637, #glz_draw=3618
>>>>> current 20 pipes 0
>>>>> handle_dev_input: OOM2 #draw=20, #red_draw=3637, #glz_draw=3618
>>>>> current 20 pipes 0
>>>>> handle_dev_input: OOM1 #draw=20, #red_draw=3637, #glz_draw=3618
>>>>> current 20 pipes 0
>>>>> red_free_some: #draw=20, #red_draw=3637, #glz_draw=3618
>>>>> handle_dev_input: OOM2 #draw=20, #red_draw=3573, #glz_draw=3554
>>>>> current 20 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3654, #glz_draw=3637
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3654, #glz_draw=3637
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3654, #glz_draw=3637
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3654, #glz_draw=3637
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3654, #glz_draw=3637
>>>>> current 25 pipes 0
>>>>> red_free_some: #draw=25, #red_draw=3654, #glz_draw=3637
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3590, #glz_draw=3573
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3617, #glz_draw=3599
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3617, #glz_draw=3599
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3617, #glz_draw=3599
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3617, #glz_draw=3599
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3617, #glz_draw=3599
>>>>> current 25 pipes 0
>>>>> red_free_some: #draw=25, #red_draw=3617, #glz_draw=3599
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3553, #glz_draw=3535
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=22, #red_draw=3612, #glz_draw=3595
>>>>> current 22 pipes 0
>>>>> handle_dev_input: OOM2 #draw=22, #red_draw=3612, #glz_draw=3595
>>>>> current 22 pipes 0
>>>>> handle_dev_input: OOM1 #draw=22, #red_draw=3612, #glz_draw=3595
>>>>> current 22 pipes 0
>>>>> red_free_some: #draw=22, #red_draw=3612, #glz_draw=3595
>>>>> handle_dev_input: OOM2 #draw=22, #red_draw=3548, #glz_draw=3531
>>>>> current 22 pipes 0
>>>>> handle_dev_input: OOM1 #draw=21, #red_draw=3599, #glz_draw=3583
>>>>> current 21 pipes 0
>>>>> handle_dev_input: OOM2 #draw=21, #red_draw=3599, #glz_draw=3583
>>>>> current 21 pipes 0
>>>>> handle_dev_input: OOM1 #draw=21, #red_draw=3599, #glz_draw=3583
>>>>> current 21 pipes 0
>>>>> red_free_some: #draw=21, #red_draw=3599, #glz_draw=3583
>>>>> handle_dev_input: OOM2 #draw=21, #red_draw=3535, #glz_draw=3519
>>>>> current 21 pipes 0
>>>>> handle_dev_input: OOM1 #draw=21, #red_draw=3569, #glz_draw=3553
>>>>> current 21 pipes 0
>>>>> handle_dev_input: OOM2 #draw=21, #red_draw=3569, #glz_draw=3553
>>>>> current 21 pipes 0
>>>>> handle_dev_input: OOM1 #draw=21, #red_draw=3569, #glz_draw=3553
>>>>> current 21 pipes 0
>>>>> red_free_some: #draw=21, #red_draw=3569, #glz_draw=3553
>>>>> handle_dev_input: OOM2 #draw=21, #red_draw=3505, #glz_draw=3489
>>>>> current 21 pipes 0
>>>>> handle_dev_input: OOM1 #draw=21, #red_draw=3540, #glz_draw=3524
>>>>> current 21 pipes 0
>>>>> handle_dev_input: OOM2 #draw=21, #red_draw=3540, #glz_draw=3524
>>>>> current 21 pipes 0
>>>>> handle_dev_input: OOM1 #draw=21, #red_draw=3540, #glz_draw=3524
>>>>> current 21 pipes 0
>>>>> handle_dev_input: OOM2 #draw=21, #red_draw=3540, #glz_draw=3524
>>>>> current 21 pipes 0
>>>>> handle_dev_input: OOM1 #draw=21, #red_draw=3540, #glz_draw=3524
>>>>> current 21 pipes 0
>>>>> red_free_some: #draw=21, #red_draw=3540, #glz_draw=3524
>>>>> handle_dev_input: OOM2 #draw=21, #red_draw=3476, #glz_draw=3460
>>>>> current 21 pipes 0
>>>>> handle_dev_input: OOM1 #draw=24, #red_draw=3503, #glz_draw=3487
>>>>> current 24 pipes 0
>>>>> handle_dev_input: OOM2 #draw=24, #red_draw=3503, #glz_draw=3487
>>>>> current 24 pipes 0
>>>>> handle_dev_input: OOM1 #draw=24, #red_draw=3503, #glz_draw=3487
>>>>> current 24 pipes 0
>>>>> handle_dev_input: OOM2 #draw=24, #red_draw=3503, #glz_draw=3487
>>>>> current 24 pipes 0
>>>>> handle_dev_input: OOM1 #draw=24, #red_draw=3503, #glz_draw=3487
>>>>> current 24 pipes 0
>>>>> red_free_some: #draw=24, #red_draw=3503, #glz_draw=3487
>>>>> handle_dev_input: OOM2 #draw=24, #red_draw=3439, #glz_draw=3423
>>>>> current 24 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3601, #glz_draw=3582
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3601, #glz_draw=3582
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3601, #glz_draw=3582
>>>>> current 25 pipes 0
>>>>> red_free_some: #draw=25, #red_draw=3601, #glz_draw=3582
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3537, #glz_draw=3518
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3551, #glz_draw=3532
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3551, #glz_draw=3532
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3551, #glz_draw=3532
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3551, #glz_draw=3532
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3551, #glz_draw=3532
>>>>> current 25 pipes 0
>>>>> red_free_some: #draw=25, #red_draw=3551, #glz_draw=3532
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3487, #glz_draw=3468
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=26, #red_draw=3518, #glz_draw=3498
>>>>> current 26 pipes 0
>>>>> handle_dev_input: OOM2 #draw=26, #red_draw=3518, #glz_draw=3498
>>>>> current 26 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3517, #glz_draw=3498
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3517, #glz_draw=3498
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3517, #glz_draw=3498
>>>>> current 25 pipes 0
>>>>> red_free_some: #draw=25, #red_draw=3517, #glz_draw=3498
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3453, #glz_draw=3434
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3467, #glz_draw=3448
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3467, #glz_draw=3448
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3467, #glz_draw=3448
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3467, #glz_draw=3448
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3467, #glz_draw=3448
>>>>> current 25 pipes 0
>>>>> red_free_some: #draw=25, #red_draw=3467, #glz_draw=3448
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3403, #glz_draw=3384
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3413, #glz_draw=3394
>>>>> current 25 pipes 0
>>>>> red_free_some: #draw=25, #red_draw=3413, #glz_draw=3394
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3349, #glz_draw=3330
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=26, #red_draw=3408, #glz_draw=3389
>>>>> current 26 pipes 0
>>>>> handle_dev_input: OOM2 #draw=26, #red_draw=3408, #glz_draw=3389
>>>>> current 26 pipes 0
>>>>> handle_dev_input: OOM1 #draw=26, #red_draw=3408, #glz_draw=3389
>>>>> current 26 pipes 0
>>>>> red_free_some: #draw=26, #red_draw=3408, #glz_draw=3389
>>>>> handle_dev_input: OOM2 #draw=26, #red_draw=3344, #glz_draw=3325
>>>>> current 26 pipes 0
>>>>> handle_dev_input: OOM1 #draw=26, #red_draw=3364, #glz_draw=3345
>>>>> current 26 pipes 0
>>>>> handle_dev_input: OOM2 #draw=26, #red_draw=3364, #glz_draw=3345
>>>>> current 26 pipes 0
>>>>> handle_dev_input: OOM1 #draw=26, #red_draw=3364, #glz_draw=3345
>>>>> current 26 pipes 0
>>>>> handle_dev_input: OOM2 #draw=26, #red_draw=3364, #glz_draw=3345
>>>>> current 26 pipes 0
>>>>> handle_dev_input: OOM1 #draw=26, #red_draw=3364, #glz_draw=3345
>>>>> current 26 pipes 0
>>>>> red_free_some: #draw=26, #red_draw=3364, #glz_draw=3345
>>>>> handle_dev_input: OOM2 #draw=26, #red_draw=3300, #glz_draw=3281
>>>>> current 26 pipes 0
>>>>> handle_dev_input: OOM1 #draw=26, #red_draw=3300, #glz_draw=3281
>>>>> current 26 pipes 0
>>>>> red_free_some: #draw=26, #red_draw=3300, #glz_draw=3281
>>>>> handle_dev_input: OOM2 #draw=26, #red_draw=3236, #glz_draw=3217
>>>>> current 26 pipes 0
>>>>> handle_dev_input: OOM1 #draw=26, #red_draw=3258, #glz_draw=3238
>>>>> current 26 pipes 0
>>>>> handle_dev_input: OOM2 #draw=26, #red_draw=3258, #glz_draw=3238
>>>>> current 26 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3257, #glz_draw=3238
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3257, #glz_draw=3238
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3257, #glz_draw=3238
>>>>> current 25 pipes 0
>>>>> red_free_some: #draw=25, #red_draw=3257, #glz_draw=3238
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3193, #glz_draw=3174
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3193, #glz_draw=3174
>>>>> current 25 pipes 0
>>>>> red_free_some: #draw=25, #red_draw=3193, #glz_draw=3174
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3129, #glz_draw=3110
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=26, #red_draw=3131, #glz_draw=3112
>>>>> current 26 pipes 0
>>>>> red_free_some: #draw=26, #red_draw=3131, #glz_draw=3112
>>>>> handle_dev_input: OOM2 #draw=26, #red_draw=3067, #glz_draw=3048
>>>>> current 26 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3073, #glz_draw=3054
>>>>> current 25 pipes 0
>>>>> red_free_some: #draw=25, #red_draw=3073, #glz_draw=3054
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3009, #glz_draw=2990
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=33, #red_draw=3031, #glz_draw=3006
>>>>> current 33 pipes 0
>>>>> handle_dev_input: OOM2 #draw=33, #red_draw=3031, #glz_draw=3006
>>>>> current 33 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3025, #glz_draw=3006
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=3025, #glz_draw=3006
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=3025, #glz_draw=3006
>>>>> current 25 pipes 0
>>>>> red_free_some: #draw=25, #red_draw=3025, #glz_draw=3006
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=2961, #glz_draw=2942
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=2963, #glz_draw=2944
>>>>> current 25 pipes 0
>>>>> red_free_some: #draw=25, #red_draw=2963, #glz_draw=2944
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=2899, #glz_draw=2880
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=26, #red_draw=2904, #glz_draw=2885
>>>>> current 26 pipes 0
>>>>> red_free_some: #draw=26, #red_draw=2904, #glz_draw=2885
>>>>> handle_dev_input: OOM2 #draw=26, #red_draw=2840, #glz_draw=2821
>>>>> current 26 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=2841, #glz_draw=2822
>>>>> current 25 pipes 0
>>>>> red_free_some: #draw=25, #red_draw=2841, #glz_draw=2822
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=2777, #glz_draw=2758
>>>>> current 25 pipes 0
>>>>> handle_dev_input: OOM1 #draw=25, #red_draw=2779, #glz_draw=2760
>>>>> current 25 pipes 0
>>>>> red_free_some: #draw=25, #red_draw=2779, #glz_draw=2760
>>>>> handle_dev_input: OOM2 #draw=25, #red_draw=2715, #glz_draw=2696
>>>>> current 25 pipes 0
>>>>> red_channel_client_disconnect: 0x2e31640 (channel 0x204fae0 type
>>>>> 2 id 0)
>>>>> red_channel_client_disconnect: 0x2e2fe30 (channel 0x1fb3fe0 type
>>>>> 3 id 0)
>>>>> display_channel_client_on_ disconnect:
>>>>> snd_channel_put: sound channel freed
>>>>>
>>>>> snd_channel_put: sound channel freed
>>>>>
>>>>> red_channel_client_disconnect: 0x2de77f0 (channel 0x2de0770 type
>>>>> 1 id 0)
>>>>> main_channel_client_on_ disconnect: rcc=0x2de77f0
>>>>> reds_client_disconnect:
>>>>> red_client_destroy: destroy client with #channels 4
>>>>> red_channel_client_disconnect: 0x2e2fe30 (channel 0x1fb3fe0 type
>>>>> 3 id 0)
>>>>> red_dispatcher_disconnect_ cursor_peer:
>>>>> display_channel_client_on_ disconnect: #draw=37, #red_draw=37,
>>>>> #glz_draw=0
>>>>> red_channel_client_disconnect: 0x2e2e370 (channel 0x2050060 type
>>>>> 4 id 0)
>>>>> handle_dev_input: disconnect cursor client
>>>>> red_channel_client_disconnect: 0x2e2e370 (channel 0x2050060 type
>>>>> 4 id 0)
>>>>> red_dispatcher_disconnect_ display_peer:
>>>>> handle_dev_input: disconnect display client
>>>>> red_channel_client_disconnect: 0x2e31640 (channel 0x204fae0 type
>>>>> 2 id 0)
>>>>> red_channel_client_disconnect: 0x2de77f0 (channel 0x2de0770 type
>>>>> 1 id 0)
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_handle_main_link:
>>>>> reds_disconnect:
>>>>> reds_show_new_channel: channel 1:0, connected successfully, over
>>>>> Non Secure link
>>>>> main_channel_link: add main channel client
>>>>> reds_handle_main_link: NEW Client 0x2de88f0 mcc 0x2e2fdd0
>>>>> connect-id 846930886
>>>>> main_channel_handle_parsed: net test: latency 0.652000 ms,
>>>>> bitrate 864135021 bps (824.103375 Mbps)
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 6:0, connected successfully, over
>>>>> Non Secure link
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 5:0, connected successfully, over
>>>>> Non Secure link
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 2:0, connected successfully, over
>>>>> Non Secure link
>>>>> red_dispatcher_set_display_ peer:
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> handle_dev_input: connect
>>>>> handle_new_display_channel: add display channel client
>>>>> handle_new_display_channel: New display (client 0x2de88f0) dcc
>>>>> 0x7f7328480d50 stream 0x2a2c810
>>>>> handle_new_display_channel: jpeg disabled
>>>>> handle_new_display_channel: zlib-over-glz disabled
>>>>> listen_to_new_client_channel: NEW ID = 0
>>>>> reds_show_new_channel: channel 4:0, connected successfully, over
>>>>> Non Secure link
>>>>> red_dispatcher_set_cursor_ peer:
>>>>> display_channel_client_wait_ for_init: creating encoder with id
>>>>> == 0
>>>>> handle_dev_input: cursor connect
>>>>> red_connect_cursor: add cursor channel client
>>>>> listen_to_new_client_channel: NEW ID = 0
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 3:0, connected successfully, over
>>>>> Non Secure link
>>>>> inputs_connect: inputs channel client create
>>>>> red_channel_client_disconnect: 0x2e2fdd0 (channel 0x2de0770 type
>>>>> 1 id 0)
>>>>> red_channel_client_disconnect: 0x7f7328480d50 (channel 0x204fae0
>>>>> type 2 id 0)
>>>>> main_channel_client_on_ disconnect: rcc=0x2e2fdd0
>>>>> reds_client_disconnect:
>>>>> red_client_destroy: destroy client with #channels 4
>>>>> red_channel_client_disconnect: 0x2e30cd0 (channel 0x1fb3fe0 type
>>>>> 3 id 0)
>>>>> display_channel_client_on_ disconnect:
>>>>> red_dispatcher_disconnect_ cursor_peer:
>>>>> display_channel_client_on_ disconnect: #draw=21, #red_draw=21,
>>>>> #glz_draw=0
>>>>> red_channel_client_disconnect: 0x7f7328c430f0 (channel 0x2050060
>>>>> type 4 id 0)
>>>>> handle_dev_input: disconnect cursor client
>>>>> red_channel_client_disconnect: 0x7f7328c430f0 (channel 0x2050060
>>>>> type 4 id 0)
>>>>> red_dispatcher_disconnect_ display_peer:
>>>>> handle_dev_input: disconnect display client
>>>>> red_channel_client_disconnect: 0x7f7328480d50 (channel 0x204fae0
>>>>> type 2 id 0)
>>>>> red_channel_client_disconnect: 0x2e2fdd0 (channel 0x2de0770 type
>>>>> 1 id 0)
>>>>> snd_channel_put: sound channel freed
>>>>>
>>>>> snd_channel_put: sound channel freed
>>>>>
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_handle_main_link:
>>>>> reds_disconnect:
>>>>> reds_show_new_channel: channel 1:0, connected successfully, over
>>>>> Non Secure link
>>>>> main_channel_link: add main channel client
>>>>> reds_handle_main_link: NEW Client 0x33616b0 mcc 0x34ea040
>>>>> connect-id 1681692777
>>>>> main_channel_handle_parsed: net test: latency 0.627000 ms,
>>>>> bitrate 859060402 bps (819.263842 Mbps)
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 6:0, connected successfully, over
>>>>> Non Secure link
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 5:0, connected successfully, over
>>>>> Non Secure link
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 2:0, connected successfully, over
>>>>> Non Secure link
>>>>> red_dispatcher_set_display_ peer:
>>>>> handle_dev_input: connect
>>>>> handle_new_display_channel: add display channel client
>>>>> handle_new_display_channel: New display (client 0x33616b0) dcc
>>>>> 0x7f7328480d00 stream 0x2dff670
>>>>> handle_new_display_channel: jpeg disabled
>>>>> handle_new_display_channel: zlib-over-glz disabled
>>>>> listen_to_new_client_channel: NEW ID = 0
>>>>> display_channel_client_wait_ for_init: creating encoder with id
>>>>> == 0
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> reds_show_new_channel: channel 4:0, connected successfully, over
>>>>> Non Secure link
>>>>> red_dispatcher_set_cursor_ peer:
>>>>> reds_handle_auth_mechanism: Auth method: 1
>>>>> handle_dev_input: cursor connect
>>>>> red_connect_cursor: add cursor channel client
>>>>> listen_to_new_client_channel: NEW ID = 0
>>>>> reds_show_new_channel: channel 3:0, connected successfully, over
>>>>> Non Secure link
>>>>> inputs_connect: inputs channel client create
>>>>>
>>>>>
>>>>>
>>>>>
>>>>>
>>>>> root account
>>>>>
>>>>> *colossus:~ # spicy*
>>>>>
>>>>> libusb:debug [libusb_init]
>>>>> libusb:debug [find_usbfs_path] found usbfs at /dev/bus/usb
>>>>> libusb:debug [op_init] bulk continuation flag supported
>>>>> libusb:debug [op_init] found usb devices in sysfs
>>>>> libusb:debug [usbi_add_pollfd] add fd 6 events 1
>>>>> libusb:debug [usbi_io_init] using timerfd for timeouts
>>>>> libusb:debug [usbi_add_pollfd] add fd 8 events 1
>>>>> libusb:debug [libusb_get_device_list]
>>>>> libusb:debug [sysfs_scan_device] scan usb1
>>>>> libusb:debug [sysfs_scan_device] bus=1 dev=1
>>>>> libusb:debug [enumerate_device] busnum 1 devaddr 1 session_id
>>>>> 257
>>>>> libusb:debug [enumerate_device] allocating new device for 1/1
>>>>> (session 257)
>>>>> libusb:debug [sysfs_scan_device] scan usb2
>>>>> libusb:debug [sysfs_scan_device] bus=2 dev=1
>>>>> libusb:debug [enumerate_device] busnum 2 devaddr 1 session_id
>>>>> 513
>>>>> libusb:debug [enumerate_device] allocating new device for 2/1
>>>>> (session 513)
>>>>> libusb:debug [sysfs_scan_device] scan usb3
>>>>> libusb:debug [sysfs_scan_device] bus=3 dev=1
>>>>> libusb:debug [enumerate_device] busnum 3 devaddr 1 session_id
>>>>> 769
>>>>> libusb:debug [enumerate_device] allocating new device for 3/1
>>>>> (session 769)
>>>>> libusb:debug [sysfs_scan_device] scan usb4
>>>>> libusb:debug [sysfs_scan_device] bus=4 dev=1
>>>>> libusb:debug [enumerate_device] busnum 4 devaddr 1 session_id
>>>>> 1025
>>>>> libusb:debug [enumerate_device] allocating new device for 4/1
>>>>> (session 1025)
>>>>> libusb:debug [sysfs_scan_device] scan usb5
>>>>> libusb:debug [sysfs_scan_device] bus=5 dev=1
>>>>> libusb:debug [enumerate_device] busnum 5 devaddr 1 session_id
>>>>> 1281
>>>>> libusb:debug [enumerate_device] allocating new device for 5/1
>>>>> (session 1281)
>>>>> libusb:debug [sysfs_scan_device] scan usb6
>>>>> libusb:debug [sysfs_scan_device] bus=6 dev=1
>>>>> libusb:debug [enumerate_device] busnum 6 devaddr 1 session_id
>>>>> 1537
>>>>> libusb:debug [enumerate_device] allocating new device for 6/1
>>>>> (session 1537)
>>>>> libusb:debug [sysfs_scan_device] scan usb7
>>>>> libusb:debug [sysfs_scan_device] bus=7 dev=1
>>>>> libusb:debug [enumerate_device] busnum 7 devaddr 1 session_id
>>>>> 1793
>>>>> libusb:debug [enumerate_device] allocating new device for 7/1
>>>>> (session 1793)
>>>>> libusb:debug [sysfs_scan_device] scan usb8
>>>>> libusb:debug [sysfs_scan_device] bus=8 dev=1
>>>>> libusb:debug [enumerate_device] busnum 8 devaddr 1 session_id
>>>>> 2049
>>>>> libusb:debug [enumerate_device] allocating new device for 8/1
>>>>> (session 2049)
>>>>> libusb:debug [sysfs_scan_device] scan 2-2
>>>>> libusb:debug [sysfs_scan_device] bus=2 dev=3
>>>>> libusb:debug [enumerate_device] busnum 2 devaddr 3 session_id
>>>>> 515
>>>>> libusb:debug [enumerate_device] allocating new device for 2/3
>>>>> (session 515)
>>>>> libusb:debug [discovered_devs_append] need to increase capacity
>>>>> libusb:debug [sysfs_scan_device] scan 4-2
>>>>> libusb:debug [sysfs_scan_device] bus=4 dev=2
>>>>> libusb:debug [enumerate_device] busnum 4 devaddr 2 session_id
>>>>> 1026
>>>>> libusb:debug [enumerate_device] allocating new device for 4/2
>>>>> (session 1026)
>>>>> libusb:debug [sysfs_scan_device] scan 6-1
>>>>> libusb:debug [sysfs_scan_device] bus=6 dev=3
>>>>> libusb:debug [enumerate_device] busnum 6 devaddr 3 session_id
>>>>> 1539
>>>>> libusb:debug [enumerate_device] allocating new device for 6/3
>>>>> (session 1539)
>>>>> libusb:debug [sysfs_scan_device] scan 1-3
>>>>> libusb:debug [sysfs_scan_device] bus=1 dev=8
>>>>> libusb:debug [enumerate_device] busnum 1 devaddr 8 session_id
>>>>> 264
>>>>> libusb:debug [enumerate_device] allocating new device for 1/8
>>>>> (session 264)
>>>>> libusb:debug [libusb_unref_device] destroy device 1.1
>>>>> libusb:debug [libusb_unref_device] destroy device 2.1
>>>>> libusb:debug [libusb_unref_device] destroy device 3.1
>>>>> libusb:debug [libusb_unref_device] destroy device 4.1
>>>>> libusb:debug [libusb_unref_device] destroy device 5.1
>>>>> libusb:debug [libusb_unref_device] destroy device 6.1
>>>>> libusb:debug [libusb_unref_device] destroy device 7.1
>>>>> libusb:debug [libusb_unref_device] destroy device 8.1
>>>>> GSpice-Message: main channel: failed to connect
>>>>>
>>>>> (spicy:18840): Gtk-CRITICAL **: gtk_render_slider: assertion
>>>>> `height> 0' failed
>>>>> GSpice-Message: main channel: opened
>>>>>
>>>>> (spicy:18840): GLib-GObject-WARNING **: g_object_set_valist:
>>>>> object class `SpiceDisplay' has no property named `auto-usbredir'
>>>>>
>>>>> (spicy:18840): GLib-GObject-WARNING **: g_object_get_valist:
>>>>> object class `SpiceDisplay' has no property named `auto-usbredir'
>>>>>
>>>>> (spicy:18840): GLib-GObject-WARNING **: g_object_set_valist:
>>>>> object class `SpiceDisplay' has no property named `auto-usbredir'
>>>>>
>>>>> (spicy:18840): GSpice-WARNING **: PulseAudio context failed
>>>>> Connection refused
>>>>> libusb:debug [libusb_unref_device] destroy device 1.8
>>>>> libusb:debug [libusb_get_device_list]
>>>>> libusb:debug [sysfs_scan_device] scan usb1
>>>>> libusb:debug [sysfs_scan_device] bus=1 dev=1
>>>>> libusb:debug [enumerate_device] busnum 1 devaddr 1 session_id
>>>>> 257
>>>>> libusb:debug [enumerate_device] allocating new device for 1/1
>>>>> (session 257)
>>>>> libusb:debug [sysfs_scan_device] scan usb2
>>>>> libusb:debug [sysfs_scan_device] bus=2 dev=1
>>>>> libusb:debug [enumerate_device] busnum 2 devaddr 1 session_id
>>>>> 513
>>>>> libusb:debug [enumerate_device] allocating new device for 2/1
>>>>> (session 513)
>>>>> libusb:debug [sysfs_scan_device] scan usb3
>>>>> libusb:debug [sysfs_scan_device] bus=3 dev=1
>>>>> libusb:debug [enumerate_device] busnum 3 devaddr 1 session_id
>>>>> 769
>>>>> libusb:debug [enumerate_device] allocating new device for 3/1
>>>>> (session 769)
>>>>> libusb:debug [sysfs_scan_device] scan usb4
>>>>> libusb:debug [sysfs_scan_device] bus=4 dev=1
>>>>> libusb:debug [enumerate_device] busnum 4 devaddr 1 session_id
>>>>> 1025
>>>>> libusb:debug [enumerate_device] allocating new device for 4/1
>>>>> (session 1025)
>>>>> libusb:debug [sysfs_scan_device] scan usb5
>>>>> libusb:debug [sysfs_scan_device] bus=5 dev=1
>>>>> libusb:debug [enumerate_device] busnum 5 devaddr 1 session_id
>>>>> 1281
>>>>> libusb:debug [enumerate_device] allocating new device for 5/1
>>>>> (session 1281)
>>>>> libusb:debug [sysfs_scan_device] scan usb6
>>>>> libusb:debug [sysfs_scan_device] bus=6 dev=1
>>>>> libusb:debug [enumerate_device] busnum 6 devaddr 1 session_id
>>>>> 1537
>>>>> libusb:debug [enumerate_device] allocating new device for 6/1
>>>>> (session 1537)
>>>>> libusb:debug [sysfs_scan_device] scan usb7
>>>>> libusb:debug [sysfs_scan_device] bus=7 dev=1
>>>>> libusb:debug [enumerate_device] busnum 7 devaddr 1 session_id
>>>>> 1793
>>>>> libusb:debug [enumerate_device] allocating new device for 7/1
>>>>> (session 1793)
>>>>> libusb:debug [sysfs_scan_device] scan usb8
>>>>> libusb:debug [sysfs_scan_device] bus=8 dev=1
>>>>> libusb:debug [enumerate_device] busnum 8 devaddr 1 session_id
>>>>> 2049
>>>>> libusb:debug [enumerate_device] allocating new device for 8/1
>>>>> (session 2049)
>>>>> libusb:debug [sysfs_scan_device] scan 2-2
>>>>> libusb:debug [sysfs_scan_device] bus=2 dev=3
>>>>> libusb:debug [enumerate_device] busnum 2 devaddr 3 session_id
>>>>> 515
>>>>> libusb:debug [enumerate_device] using existing device for 2/3
>>>>> (session 515)
>>>>> libusb:debug [discovered_devs_append] need to increase capacity
>>>>> libusb:debug [sysfs_scan_device] scan 4-2
>>>>> libusb:debug [sysfs_scan_device] bus=4 dev=2
>>>>> libusb:debug [enumerate_device] busnum 4 devaddr 2 session_id
>>>>> 1026
>>>>> libusb:debug [enumerate_device] using existing device for 4/2
>>>>> (session 1026)
>>>>> libusb:debug [sysfs_scan_device] scan 6-1
>>>>> libusb:debug [sysfs_scan_device] bus=6 dev=3
>>>>> libusb:debug [enumerate_device] busnum 6 devaddr 3 session_id
>>>>> 1539
>>>>> libusb:debug [enumerate_device] using existing device for 6/3
>>>>> (session 1539)
>>>>> libusb:debug [sysfs_scan_device] scan 1-3
>>>>> libusb:debug [sysfs_scan_device] bus=1 dev=9
>>>>> libusb:debug [enumerate_device] busnum 1 devaddr 9 session_id
>>>>> 265
>>>>> libusb:debug [enumerate_device] allocating new device for 1/9
>>>>> (session 265)
>>>>> libusb:debug [libusb_unref_device] destroy device 1.1
>>>>> libusb:debug [libusb_unref_device] destroy device 2.1
>>>>> libusb:debug [libusb_unref_device] destroy device 3.1
>>>>> libusb:debug [libusb_unref_device] destroy device 4.1
>>>>> libusb:debug [libusb_unref_device] destroy device 5.1
>>>>> libusb:debug [libusb_unref_device] destroy device 6.1
>>>>> libusb:debug [libusb_unref_device] destroy device 7.1
>>>>> libusb:debug [libusb_unref_device] destroy device 8.1
>>>>>
>>>>>
>>>>>
>>>>> ______________________________ _________________
>>>>> Spice-devel mailing list
>>>>> Spice-devel at lists.freedesktop.
>>>>> org<mailto:Spice-devel at lists.freedesktop.org>
>>>>> http://lists.freedesktop.org/
>>>>> mailman/listinfo/spice-devel<http://lists.freedesktop.org/mailman/listinfo/spice-devel>
>>>>>
>>>>>
>>>
>
More information about the Spice-devel
mailing list