Re: [Qemu-devel] usb3 - xhci - Assertion `intr->er_full' failed

[Martin Cerveny]

Hello.

On Thu, 2 Feb 2017, Gerd Hoffmann wrote:
 Hi,
- usb with usbredir 0.7.1

What kind of device do you assign to the guest?

Keyboard.

Where is the verfied windows driver that is compatible/tested with xhci code ?

Usually I test with the drivers shipped by the operating system, i.e.
linux kernel or windows 8 (or newer).

Windows 7 :-(

---------------------------------- USB keyboard + qemu-xen-4.8.0 + 2.1.39 
driver + DEBUG_XHCI + DEBUG_DATA ---------------------------

Is the usb keyboard enough to trigger this?

Yes. Boots normaly, host+root hub drivers starts ok (verified over RDP), 
after keyboard attach over qemu/usbredir - it few moments works
(detected "compound" device) and than assert().

The keyboard description from remote linux (lsusb -vvv):

Bus 001 Device 007: ID 0e6a:6001 Megawin Technology Co., Ltd GEMBIRD 
Flexible keyboard KB-109F-B-DE
Device Descriptor:
  bLength                18
  bDescriptorType         1
  bcdUSB               1.10
  bDeviceClass            0 (Defined at Interface level)
  bDeviceSubClass         0
  bDeviceProtocol         0
  bMaxPacketSize0         8
  idVendor           0x0e6a Megawin Technology Co., Ltd
  idProduct          0x6001 GEMBIRD Flexible keyboard KB-109F-B-DE
  bcdDevice            0.07
  iManufacturer           0
  iProduct                1 HID Keyboard Device
  iSerial                 0
  bNumConfigurations      1
  Configuration Descriptor:
    bLength                 9
    bDescriptorType         2
    wTotalLength           59
    bNumInterfaces          2
    bConfigurationValue     1
    iConfiguration          1 HID Keyboard Device
    bmAttributes         0xa0
      (Bus Powered)
      Remote Wakeup
    MaxPower              100mA
    Interface Descriptor:
      bLength                 9
      bDescriptorType         4
      bInterfaceNumber        0
      bAlternateSetting       0
      bNumEndpoints           1
      bInterfaceClass         3 Human Interface Device
      bInterfaceSubClass      1 Boot Interface Subclass
      bInterfaceProtocol      1 Keyboard
      iInterface              1 HID Keyboard Device
        HID Device Descriptor:
          bLength                 9
          bDescriptorType        33
          bcdHID               1.10
          bCountryCode            0 Not supported
          bNumDescriptors         1
          bDescriptorType        34 Report
          wDescriptorLength      54
         Report Descriptors:
           ** UNAVAILABLE **
      Endpoint Descriptor:
        bLength                 7
        bDescriptorType         5
        bEndpointAddress     0x81  EP 1 IN
        bmAttributes            3
          Transfer Type            Interrupt
          Synch Type               None
          Usage Type               Data
        wMaxPacketSize     0x0008  1x 8 bytes
        bInterval              10
    Interface Descriptor:
      bLength                 9
      bDescriptorType         4
      bInterfaceNumber        1
      bAlternateSetting       0
      bNumEndpoints           1
      bInterfaceClass         3 Human Interface Device
      bInterfaceSubClass      0 No Subclass
      bInterfaceProtocol      0 None
      iInterface              2 HID Keyboard Hot Keys
        HID Device Descriptor:
          bLength                 9
          bDescriptorType        33
          bcdHID               1.10
          bCountryCode            0 Not supported
          bNumDescriptors         1
          bDescriptorType        34 Report
          wDescriptorLength      50
         Report Descriptors:
           ** UNAVAILABLE **
      Endpoint Descriptor:
        bLength                 7
        bDescriptorType         5
        bEndpointAddress     0x82  EP 2 IN
        bmAttributes            3
          Transfer Type            Interrupt
          Synch Type               None
          Usage Type               Data
        wMaxPacketSize     0x0003  1x 3 bytes
        bInterval              10
Device Status:     0x0000
  (Bus Powered)

enabling usb_xhci_* trace events would be more helpful than DEBUG_XHCI
(see qemu.git/docs/tracing.txt).

Ok, attached all output (remote usb attached from line 'usb-redir').

Thanks, Martin===== VGPU ===== --domain 3 --vcpus 4 --gpu 0000:08:00.0 --config 
/usr/share/nvidia/vgx/grid_k160q.conf,frl_config=0x1d,intervaltime=33000,sw_vsync_enabled=0,max_resolution=1920x1080
 --net 10.199.100.1:20007 --encoder nvenc
===== QEMU ===== -xen-domid 3 -chardev 
socket,id=libxl-cmd,path=/var/run/xen/qmp-libxl-3,server,nowait -no-shutdown 
-mon chardev=libxl-cmd,mode=control -chardev 
socket,id=libxenstat-cmd,path=/var/run/xen/qmp-libxenstat-3,server,nowait -mon 
chardev=libxenstat-cmd,mode=control -nodefaults -no-user-config -name test -vnc 
127.0.0.1:0,to=99 -display none -boot order=cda -device nec-usb-xhci,id=usb 
-soundhw hda -smp 4,maxcpus=4 -device 
rtl8139,id=nic0,netdev=net0,mac=02:00:01:00:01:05 -netdev 
type=tap,id=net0,ifname=vif3.0-emu,script=no,downscript=no -monitor 
telnet:127.0.0.1:20005,server,nowait -qmp tcp:10.199.100.1:20006,server,nowait 
-machine xenfv,max-ram-below-4g=3758096384 -m 6128 -drive 
if=ide,index=1,readonly=on,media=cdrom,id=ide-832 -drive 
file=/dev/mapper/3600144f07a0542580000568063220001,if=ide,index=0,media=disk,format=raw,cache=writeback
ERROR: ld.so: object 'libkeepalive.so' from LD_PRELOAD cannot be preloaded 
(cannot open shared object file): ignored.
==== CHILD 5020 5032
udp: DATA: ch:2 freq:44100 shift:2
udp: PORT: 20008
udp: AUDIO NET thread start
audio: Failed to create voice `adc'
VNC server running on 127.0.0.1:5901
5032@1486038164.077162:usb_xhci_reset === RESET ===
5032@1486038164.077177:usb_xhci_slot_disable slotid 1
5032@1486038164.077181:usb_xhci_slot_disable slotid 2
5032@1486038164.077185:usb_xhci_slot_disable slotid 3
5032@1486038164.077188:usb_xhci_slot_disable slotid 4
5032@1486038164.077191:usb_xhci_slot_disable slotid 5
5032@1486038164.077195:usb_xhci_slot_disable slotid 6
5032@1486038164.077198:usb_xhci_slot_disable slotid 7
5032@1486038164.077201:usb_xhci_slot_disable slotid 8
5032@1486038164.077204:usb_xhci_slot_disable slotid 9
5032@1486038164.077208:usb_xhci_slot_disable slotid 10
5032@1486038164.077211:usb_xhci_slot_disable slotid 11
5032@1486038164.077214:usb_xhci_slot_disable slotid 12
5032@1486038164.077217:usb_xhci_slot_disable slotid 13
5032@1486038164.077221:usb_xhci_slot_disable slotid 14
5032@1486038164.077224:usb_xhci_slot_disable slotid 15
5032@1486038164.077227:usb_xhci_slot_disable slotid 16
5032@1486038164.077230:usb_xhci_slot_disable slotid 17
5032@1486038164.077233:usb_xhci_slot_disable slotid 18
5032@1486038164.077236:usb_xhci_slot_disable slotid 19
5032@1486038164.077240:usb_xhci_slot_disable slotid 20
5032@1486038164.077243:usb_xhci_slot_disable slotid 21
5032@1486038164.077246:usb_xhci_slot_disable slotid 22
5032@1486038164.077250:usb_xhci_slot_disable slotid 23
5032@1486038164.077253:usb_xhci_slot_disable slotid 24
5032@1486038164.077256:usb_xhci_slot_disable slotid 25
5032@1486038164.077259:usb_xhci_slot_disable slotid 26
5032@1486038164.077263:usb_xhci_slot_disable slotid 27
5032@1486038164.077266:usb_xhci_slot_disable slotid 28
5032@1486038164.077269:usb_xhci_slot_disable slotid 29
5032@1486038164.077272:usb_xhci_slot_disable slotid 30
5032@1486038164.077275:usb_xhci_slot_disable slotid 31
5032@1486038164.077278:usb_xhci_slot_disable slotid 32
5032@1486038164.077282:usb_xhci_slot_disable slotid 33
5032@1486038164.077285:usb_xhci_slot_disable slotid 34
5032@1486038164.077288:usb_xhci_slot_disable slotid 35
5032@1486038164.077291:usb_xhci_slot_disable slotid 36
5032@1486038164.077294:usb_xhci_slot_disable slotid 37
5032@1486038164.077297:usb_xhci_slot_disable slotid 38
5032@1486038164.077301:usb_xhci_slot_disable slotid 39
5032@1486038164.077304:usb_xhci_slot_disable slotid 40
5032@1486038164.077307:usb_xhci_slot_disable slotid 41
5032@1486038164.077310:usb_xhci_slot_disable slotid 42
5032@1486038164.077313:usb_xhci_slot_disable slotid 43
5032@1486038164.077317:usb_xhci_slot_disable slotid 44
5032@1486038164.077320:usb_xhci_slot_disable slotid 45
5032@1486038164.077323:usb_xhci_slot_disable slotid 46
5032@1486038164.077326:usb_xhci_slot_disable slotid 47
5032@1486038164.077329:usb_xhci_slot_disable slotid 48
5032@1486038164.077332:usb_xhci_slot_disable slotid 49
5032@1486038164.077355:usb_xhci_slot_disable slotid 50
5032@1486038164.077359:usb_xhci_slot_disable slotid 51
5032@1486038164.077362:usb_xhci_slot_disable slotid 52
5032@1486038164.077365:usb_xhci_slot_disable slotid 53
5032@1486038164.077368:usb_xhci_slot_disable slotid 54
5032@1486038164.077372:usb_xhci_slot_disable slotid 55
5032@1486038164.077375:usb_xhci_slot_disable slotid 56
5032@1486038164.077378:usb_xhci_slot_disable slotid 57
5032@1486038164.077381:usb_xhci_slot_disable slotid 58
5032@1486038164.077384:usb_xhci_slot_disable slotid 59
5032@1486038164.077388:usb_xhci_slot_disable slotid 60
5032@1486038164.077391:usb_xhci_slot_disable slotid 61
5032@1486038164.077394:usb_xhci_slot_disable slotid 62
5032@1486038164.077397:usb_xhci_slot_disable slotid 63
5032@1486038164.077400:usb_xhci_slot_disable slotid 64
5032@1486038164.077405:usb_xhci_port_link port 1, pls 5
5032@1486038164.077408:usb_xhci_port_notify port 1, bits 20000
5032@1486038164.077412:usb_xhci_port_link port 2, pls 5
5032@1486038164.077415:usb_xhci_port_notify port 2, bits 20000
5032@1486038164.077418:usb_xhci_port_link port 3, pls 5
5032@1486038164.077422:usb_xhci_port_notify port 3, bits 20000
5032@1486038164.077425:usb_xhci_port_link port 4, pls 5
5032@1486038164.077428:usb_xhci_port_notify port 4, bits 20000
5032@1486038164.077431:usb_xhci_port_link port 5, pls 5
5032@1486038164.077434:usb_xhci_port_notify port 5, bits 20000
5032@1486038164.077438:usb_xhci_port_link port 6, pls 5
5032@1486038164.077441:usb_xhci_port_notify port 6, bits 20000
5032@1486038164.077444:usb_xhci_port_link port 7, pls 5
5032@1486038164.077447:usb_xhci_port_notify port 7, bits 20000
5032@1486038164.077451:usb_xhci_port_link port 8, pls 5
5032@1486038164.077454:usb_xhci_port_notify port 8, bits 20000
5032@1486038164.840662:usb_xhci_cap_read off 0x0000, ret 0x01000040
5032@1486038164.840732:usb_xhci_cap_read off 0x0000, ret 0x01000040
5032@1486038164.840782:usb_xhci_cap_read off 0x0014, ret 0x00002000
5032@1486038164.840849:usb_xhci_cap_read off 0x0018, ret 0x00001000
5032@1486038164.840897:usb_xhci_cap_read off 0x0004, ret 0x08001040
5032@1486038164.840946:usb_xhci_cap_read off 0x0010, ret 0x00087001
5032@1486038164.841136:usb_xhci_cap_read off 0x0020, ret 0x02000402
5032@1486038164.841186:usb_xhci_cap_read off 0x0024, ret 0x20425355
5032@1486038164.841233:usb_xhci_cap_read off 0x0028, ret 0x00000405
5032@1486038164.841378:usb_xhci_cap_read off 0x0030, ret 0x03000002
5032@1486038164.841422:usb_xhci_cap_read off 0x0034, ret 0x20425355
5032@1486038164.841469:usb_xhci_cap_read off 0x0038, ret 0x00000401
5032@1486038164.841614:usb_xhci_oper_read off 0x0008, ret 0x00000001
5032@1486038164.841790:usb_xhci_oper_read off 0x0000, ret 0x00000000
5032@1486038164.841840:usb_xhci_oper_write off 0x0000, val 0x00000002
5032@1486038164.841849:usb_xhci_reset === RESET ===
5032@1486038164.841854:usb_xhci_slot_disable slotid 1
5032@1486038164.841859:usb_xhci_slot_disable slotid 2
5032@1486038164.841863:usb_xhci_slot_disable slotid 3
5032@1486038164.841867:usb_xhci_slot_disable slotid 4
5032@1486038164.841871:usb_xhci_slot_disable slotid 5
5032@1486038164.841894:usb_xhci_slot_disable slotid 6
5032@1486038164.841904:usb_xhci_slot_disable slotid 7
5032@1486038164.841909:usb_xhci_slot_disable slotid 8
5032@1486038164.841913:usb_xhci_slot_disable slotid 9
5032@1486038164.841917:usb_xhci_slot_disable slotid 10
5032@1486038164.841921:usb_xhci_slot_disable slotid 11
5032@1486038164.841925:usb_xhci_slot_disable slotid 12
5032@1486038164.841929:usb_xhci_slot_disable slotid 13
5032@1486038164.841933:usb_xhci_slot_disable slotid 14
5032@1486038164.841937:usb_xhci_slot_disable slotid 15
5032@1486038164.841941:usb_xhci_slot_disable slotid 16
5032@1486038164.841945:usb_xhci_slot_disable slotid 17
5032@1486038164.841949:usb_xhci_slot_disable slotid 18
5032@1486038164.841953:usb_xhci_slot_disable slotid 19
5032@1486038164.841957:usb_xhci_slot_disable slotid 20
5032@1486038164.841961:usb_xhci_slot_disable slotid 21
5032@1486038164.841965:usb_xhci_slot_disable slotid 22
5032@1486038164.841969:usb_xhci_slot_disable slotid 23
5032@1486038164.841988:usb_xhci_slot_disable slotid 24
5032@1486038164.841993:usb_xhci_slot_disable slotid 25
5032@1486038164.841997:usb_xhci_slot_disable slotid 26
5032@1486038164.842001:usb_xhci_slot_disable slotid 27
5032@1486038164.842005:usb_xhci_slot_disable slotid 28
5032@1486038164.842008:usb_xhci_slot_disable slotid 29
5032@1486038164.842012:usb_xhci_slot_disable slotid 30
5032@1486038164.842016:usb_xhci_slot_disable slotid 31
5032@1486038164.842020:usb_xhci_slot_disable slotid 32
5032@1486038164.842024:usb_xhci_slot_disable slotid 33
5032@1486038164.842028:usb_xhci_slot_disable slotid 34
5032@1486038164.842032:usb_xhci_slot_disable slotid 35
5032@1486038164.842036:usb_xhci_slot_disable slotid 36
5032@1486038164.842039:usb_xhci_slot_disable slotid 37
5032@1486038164.842043:usb_xhci_slot_disable slotid 38
5032@1486038164.842047:usb_xhci_slot_disable slotid 39
5032@1486038164.842051:usb_xhci_slot_disable slotid 40
5032@1486038164.842055:usb_xhci_slot_disable slotid 41
5032@1486038164.842059:usb_xhci_slot_disable slotid 42
5032@1486038164.842063:usb_xhci_slot_disable slotid 43
5032@1486038164.842067:usb_xhci_slot_disable slotid 44
5032@1486038164.842071:usb_xhci_slot_disable slotid 45
5032@1486038164.842075:usb_xhci_slot_disable slotid 46
5032@1486038164.842079:usb_xhci_slot_disable slotid 47
5032@1486038164.842082:usb_xhci_slot_disable slotid 48
5032@1486038164.842086:usb_xhci_slot_disable slotid 49
5032@1486038164.842090:usb_xhci_slot_disable slotid 50
5032@1486038164.842094:usb_xhci_slot_disable slotid 51
5032@1486038164.842098:usb_xhci_slot_disable slotid 52
5032@1486038164.842102:usb_xhci_slot_disable slotid 53
5032@1486038164.842106:usb_xhci_slot_disable slotid 54
5032@1486038164.842110:usb_xhci_slot_disable slotid 55
5032@1486038164.842113:usb_xhci_slot_disable slotid 56
5032@1486038164.842117:usb_xhci_slot_disable slotid 57
5032@1486038164.842121:usb_xhci_slot_disable slotid 58
5032@1486038164.842125:usb_xhci_slot_disable slotid 59
5032@1486038164.842129:usb_xhci_slot_disable slotid 60
5032@1486038164.842133:usb_xhci_slot_disable slotid 61
5032@1486038164.842137:usb_xhci_slot_disable slotid 62
5032@1486038164.842141:usb_xhci_slot_disable slotid 63
5032@1486038164.842145:usb_xhci_slot_disable slotid 64
5032@1486038164.842149:usb_xhci_port_link port 1, pls 5
5032@1486038164.842154:usb_xhci_port_notify port 1, bits 20000
5032@1486038164.842159:usb_xhci_port_link port 2, pls 5
5032@1486038164.842163:usb_xhci_port_notify port 2, bits 20000
5032@1486038164.842167:usb_xhci_port_link port 3, pls 5
5032@1486038164.842171:usb_xhci_port_notify port 3, bits 20000
5032@1486038164.842175:usb_xhci_port_link port 4, pls 5
5032@1486038164.842178:usb_xhci_port_notify port 4, bits 20000
5032@1486038164.842182:usb_xhci_port_link port 5, pls 5
5032@1486038164.842186:usb_xhci_port_notify port 5, bits 20000
5032@1486038164.842190:usb_xhci_port_link port 6, pls 5
5032@1486038164.842194:usb_xhci_port_notify port 6, bits 20000
5032@1486038164.842198:usb_xhci_port_link port 7, pls 5
5032@1486038164.842202:usb_xhci_port_notify port 7, bits 20000
5032@1486038164.842206:usb_xhci_port_link port 8, pls 5
5032@1486038164.842209:usb_xhci_port_notify port 8, bits 20000
5032@1486038164.842221:usb_xhci_irq_intx level 0
5032@1486038164.842278:usb_xhci_oper_read off 0x0000, ret 0x00000000
5032@1486038164.842330:usb_xhci_oper_read off 0x0004, ret 0x00000001
5032@1486038164.842378:usb_xhci_oper_write off 0x0038, val 0x00000040
5032@1486038164.842427:usb_xhci_oper_write off 0x0030, val 0xdfffedc0
5032@1486038164.842475:usb_xhci_oper_write off 0x0034, val 0x00000000
5032@1486038164.842522:usb_xhci_oper_write off 0x0018, val 0xdfffec01
5032@1486038164.842569:usb_xhci_oper_write off 0x001c, val 0x00000000
5032@1486038164.842617:usb_xhci_runtime_write off 0x0028, val 0x00000001
5032@1486038164.842665:usb_xhci_runtime_write off 0x0038, val 0x000ef600
5032@1486038164.842711:usb_xhci_runtime_write off 0x003c, val 0x00000000
5032@1486038164.842757:usb_xhci_runtime_write off 0x0030, val 0xdfffed80
5032@1486038164.842803:usb_xhci_runtime_write off 0x0034, val 0x00000000
xhci: event ring[0]:ef600 [16]
5032@1486038164.843188:usb_xhci_cap_read off 0x0008, ret 0x0000000f
5032@1486038164.843240:usb_xhci_oper_read off 0x0000, ret 0x00000000
5032@1486038164.843292:usb_xhci_oper_write off 0x0000, val 0x00000001
5032@1486038164.843299:usb_xhci_run 
5032@1486038164.843305:usb_xhci_irq_intx level 0
5032@1486038164.943482:usb_xhci_port_read port 1, off 0x0000, ret 0x000202a0
5032@1486038164.943687:usb_xhci_port_read port 2, off 0x0000, ret 0x000202a0
5032@1486038164.943892:usb_xhci_port_read port 3, off 0x0000, ret 0x000202a0
5032@1486038164.944097:usb_xhci_port_read port 4, off 0x0000, ret 0x000202a0
5032@1486038164.944287:usb_xhci_port_read port 5, off 0x0000, ret 0x000202a0
5032@1486038164.944481:usb_xhci_port_read port 6, off 0x0000, ret 0x000202a0
5032@1486038164.944674:usb_xhci_port_read port 7, off 0x0000, ret 0x000202a0
5032@1486038164.945106:usb_xhci_port_read port 8, off 0x0000, ret 0x000202a0
5032@1486038164.945769:usb_xhci_oper_read off 0x0000, ret 0x00000001
5032@1486038164.945817:usb_xhci_oper_write off 0x0000, val 0x00000000
5032@1486038164.945823:usb_xhci_stop 
5032@1486038164.945827:usb_xhci_irq_intx level 0
5032@1486038164.945877:usb_xhci_oper_read off 0x0004, ret 0x00000001
5032@1486038208.367314:usb_xhci_cap_read off 0x0000, ret 0x01000040
5032@1486038208.367417:usb_xhci_unimplemented cap read (0x2)
5032@1486038208.367428:usb_xhci_cap_read off 0x0002, ret 0x00000000
5032@1486038208.367489:usb_xhci_cap_read off 0x0004, ret 0x08001040
5032@1486038208.367546:usb_xhci_cap_read off 0x0008, ret 0x0000000f
5032@1486038208.367617:usb_xhci_cap_read off 0x000c, ret 0x00000000
5032@1486038208.367675:usb_xhci_cap_read off 0x0010, ret 0x00087001
5032@1486038208.367731:usb_xhci_cap_read off 0x0014, ret 0x00002000
5032@1486038208.367795:usb_xhci_cap_read off 0x0018, ret 0x00001000
5032@1486038208.368316:usb_xhci_oper_read off 0x0004, ret 0x00000001
5032@1486038208.368408:usb_xhci_cap_read off 0x0020, ret 0x02000402
5032@1486038208.368466:usb_xhci_cap_read off 0x0020, ret 0x02000402
5032@1486038208.368524:usb_xhci_cap_read off 0x0024, ret 0x20425355
5032@1486038208.368592:usb_xhci_cap_read off 0x0028, ret 0x00000405
5032@1486038208.368647:usb_xhci_cap_read off 0x0030, ret 0x03000002
5032@1486038208.368702:usb_xhci_cap_read off 0x0030, ret 0x03000002
5032@1486038208.368758:usb_xhci_cap_read off 0x0034, ret 0x20425355
5032@1486038208.368850:usb_xhci_cap_read off 0x0038, ret 0x00000401
5032@1486038208.368922:usb_xhci_oper_read off 0x0004, ret 0x00000001
5032@1486038208.368981:usb_xhci_oper_read off 0x0000, ret 0x00000000
5032@1486038208.369040:usb_xhci_oper_write off 0x0000, val 0x00000002
5032@1486038208.369053:usb_xhci_reset === RESET ===
5032@1486038208.369060:usb_xhci_slot_disable slotid 1
5032@1486038208.369067:usb_xhci_slot_disable slotid 2
5032@1486038208.369073:usb_xhci_slot_disable slotid 3
5032@1486038208.369079:usb_xhci_slot_disable slotid 4
5032@1486038208.369085:usb_xhci_slot_disable slotid 5
5032@1486038208.369091:usb_xhci_slot_disable slotid 6
5032@1486038208.369096:usb_xhci_slot_disable slotid 7
5032@1486038208.369102:usb_xhci_slot_disable slotid 8
5032@1486038208.369108:usb_xhci_slot_disable slotid 9
5032@1486038208.369114:usb_xhci_slot_disable slotid 10
5032@1486038208.369120:usb_xhci_slot_disable slotid 11
5032@1486038208.369126:usb_xhci_slot_disable slotid 12
5032@1486038208.369132:usb_xhci_slot_disable slotid 13
5032@1486038208.369137:usb_xhci_slot_disable slotid 14
5032@1486038208.369143:usb_xhci_slot_disable slotid 15
5032@1486038208.369149:usb_xhci_slot_disable slotid 16
5032@1486038208.369154:usb_xhci_slot_disable slotid 17
5032@1486038208.369160:usb_xhci_slot_disable slotid 18
5032@1486038208.369166:usb_xhci_slot_disable slotid 19
5032@1486038208.369171:usb_xhci_slot_disable slotid 20
5032@1486038208.369177:usb_xhci_slot_disable slotid 21
5032@1486038208.369183:usb_xhci_slot_disable slotid 22
5032@1486038208.369188:usb_xhci_slot_disable slotid 23
5032@1486038208.369194:usb_xhci_slot_disable slotid 24
5032@1486038208.369200:usb_xhci_slot_disable slotid 25
5032@1486038208.369228:usb_xhci_slot_disable slotid 26
5032@1486038208.369235:usb_xhci_slot_disable slotid 27
5032@1486038208.369241:usb_xhci_slot_disable slotid 28
5032@1486038208.369247:usb_xhci_slot_disable slotid 29
5032@1486038208.369252:usb_xhci_slot_disable slotid 30
5032@1486038208.369258:usb_xhci_slot_disable slotid 31
5032@1486038208.369264:usb_xhci_slot_disable slotid 32
5032@1486038208.369269:usb_xhci_slot_disable slotid 33
5032@1486038208.369275:usb_xhci_slot_disable slotid 34
5032@1486038208.369280:usb_xhci_slot_disable slotid 35
5032@1486038208.369286:usb_xhci_slot_disable slotid 36
5032@1486038208.369291:usb_xhci_slot_disable slotid 37
5032@1486038208.369297:usb_xhci_slot_disable slotid 38
5032@1486038208.369303:usb_xhci_slot_disable slotid 39
5032@1486038208.369308:usb_xhci_slot_disable slotid 40
5032@1486038208.369314:usb_xhci_slot_disable slotid 41
5032@1486038208.369320:usb_xhci_slot_disable slotid 42
5032@1486038208.369325:usb_xhci_slot_disable slotid 43
5032@1486038208.369331:usb_xhci_slot_disable slotid 44
5032@1486038208.369336:usb_xhci_slot_disable slotid 45
5032@1486038208.369342:usb_xhci_slot_disable slotid 46
5032@1486038208.369347:usb_xhci_slot_disable slotid 47
5032@1486038208.369353:usb_xhci_slot_disable slotid 48
5032@1486038208.369359:usb_xhci_slot_disable slotid 49
5032@1486038208.369364:usb_xhci_slot_disable slotid 50
5032@1486038208.369370:usb_xhci_slot_disable slotid 51
5032@1486038208.369375:usb_xhci_slot_disable slotid 52
5032@1486038208.369381:usb_xhci_slot_disable slotid 53
5032@1486038208.369386:usb_xhci_slot_disable slotid 54
5032@1486038208.369392:usb_xhci_slot_disable slotid 55
5032@1486038208.369398:usb_xhci_slot_disable slotid 56
5032@1486038208.369403:usb_xhci_slot_disable slotid 57
5032@1486038208.369409:usb_xhci_slot_disable slotid 58
5032@1486038208.369414:usb_xhci_slot_disable slotid 59
5032@1486038208.369420:usb_xhci_slot_disable slotid 60
5032@1486038208.369425:usb_xhci_slot_disable slotid 61
5032@1486038208.369431:usb_xhci_slot_disable slotid 62
5032@1486038208.369437:usb_xhci_slot_disable slotid 63
5032@1486038208.369442:usb_xhci_slot_disable slotid 64
5032@1486038208.369449:usb_xhci_port_link port 1, pls 5
5032@1486038208.369455:usb_xhci_port_notify port 1, bits 20000
5032@1486038208.369462:usb_xhci_port_link port 2, pls 5
5032@1486038208.369467:usb_xhci_port_notify port 2, bits 20000
5032@1486038208.369473:usb_xhci_port_link port 3, pls 5
5032@1486038208.369479:usb_xhci_port_notify port 3, bits 20000
5032@1486038208.369485:usb_xhci_port_link port 4, pls 5
5032@1486038208.369490:usb_xhci_port_notify port 4, bits 20000
5032@1486038208.369496:usb_xhci_port_link port 5, pls 5
5032@1486038208.369501:usb_xhci_port_notify port 5, bits 20000
5032@1486038208.369507:usb_xhci_port_link port 6, pls 5
5032@1486038208.369512:usb_xhci_port_notify port 6, bits 20000
5032@1486038208.369518:usb_xhci_port_link port 7, pls 5
5032@1486038208.369524:usb_xhci_port_notify port 7, bits 20000
5032@1486038208.369529:usb_xhci_port_link port 8, pls 5
5032@1486038208.369535:usb_xhci_port_notify port 8, bits 20000
5032@1486038208.369596:usb_xhci_oper_read off 0x0000, ret 0x00000000
5032@1486038208.369679:usb_xhci_oper_read off 0x0038, ret 0x00000000
5032@1486038208.369739:usb_xhci_oper_write off 0x0038, val 0x00000040
5032@1486038208.369805:usb_xhci_oper_write off 0x0030, val 0x9c9d9000
5032@1486038208.369816:usb_xhci_oper_write off 0x0034, val 0x00000001
5032@1486038208.369918:usb_xhci_cap_read off 0x0030, ret 0x03000002
5032@1486038208.369976:usb_xhci_cap_read off 0x0034, ret 0x20425355
5032@1486038208.370033:usb_xhci_cap_read off 0x0038, ret 0x00000401
5032@1486038208.370098:usb_xhci_cap_read off 0x0020, ret 0x02000402
5032@1486038208.370155:usb_xhci_cap_read off 0x0024, ret 0x20425355
5032@1486038208.370211:usb_xhci_cap_read off 0x0028, ret 0x00000405
5032@1486038208.370267:usb_xhci_cap_read off 0x0030, ret 0x03000002
5032@1486038208.370330:usb_xhci_port_read port 1, off 0x0000, ret 0x000202a0
5032@1486038208.370385:usb_xhci_port_read port 1, off 0x0004, ret 0x00000000
5032@1486038208.370453:usb_xhci_port_read port 1, off 0x0008, ret 0x00000000
5032@1486038208.370510:usb_xhci_port_read port 2, off 0x0000, ret 0x000202a0
5032@1486038208.370563:usb_xhci_port_read port 2, off 0x0004, ret 0x00000000
5032@1486038208.370617:usb_xhci_port_read port 2, off 0x0008, ret 0x00000000
5032@1486038208.370672:usb_xhci_port_read port 3, off 0x0000, ret 0x000202a0
5032@1486038208.370737:usb_xhci_port_read port 3, off 0x0004, ret 0x00000000
5032@1486038208.370794:usb_xhci_port_read port 3, off 0x0008, ret 0x00000000
5032@1486038208.370869:usb_xhci_port_read port 4, off 0x0000, ret 0x000202a0
5032@1486038208.370934:usb_xhci_port_read port 4, off 0x0004, ret 0x00000000
5032@1486038208.370991:usb_xhci_port_read port 4, off 0x0008, ret 0x00000000
5032@1486038208.371047:usb_xhci_port_read port 5, off 0x0000, ret 0x000202a0
5032@1486038208.371103:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486038208.371157:usb_xhci_port_read port 5, off 0x0008, ret 0x00000000
5032@1486038208.371212:usb_xhci_port_read port 6, off 0x0000, ret 0x000202a0
5032@1486038208.371267:usb_xhci_port_read port 6, off 0x0004, ret 0x00000000
5032@1486038208.371321:usb_xhci_port_read port 6, off 0x0008, ret 0x00000000
5032@1486038208.371377:usb_xhci_port_read port 7, off 0x0000, ret 0x000202a0
5032@1486038208.371443:usb_xhci_port_read port 7, off 0x0004, ret 0x00000000
5032@1486038208.371502:usb_xhci_port_read port 7, off 0x0008, ret 0x00000000
5032@1486038208.371557:usb_xhci_port_read port 8, off 0x0000, ret 0x000202a0
5032@1486038208.371613:usb_xhci_port_read port 8, off 0x0004, ret 0x00000000
5032@1486038208.371667:usb_xhci_port_read port 8, off 0x0008, ret 0x00000000
5032@1486038208.371746:usb_xhci_oper_write off 0x0018, val 0x9c612001
5032@1486038208.371757:usb_xhci_oper_write off 0x001c, val 0x00000001
5032@1486038208.371848:usb_xhci_cap_read off 0x0008, ret 0x0000000f
5032@1486038208.371934:usb_xhci_runtime_write off 0x0028, val 0x00000001
5032@1486038208.371991:usb_xhci_runtime_write off 0x0038, val 0x9c657008
5032@1486038208.372001:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486038208.372065:usb_xhci_runtime_write off 0x0030, val 0x9c61e000
5032@1486038208.372075:usb_xhci_runtime_write off 0x0034, val 0x00000001
xhci: event ring[0]:19c657000 [256]
5032@1486038208.372506:usb_xhci_runtime_write off 0x0024, val 0x00000fa0
5032@1486038208.372566:usb_xhci_runtime_write off 0x0020, val 0x00000002
5032@1486038208.372576:usb_xhci_irq_msix_use nr 0
5032@1486038208.372643:usb_xhci_oper_write off 0x0014, val 0x00000002
5032@1486038208.372874:usb_xhci_oper_read off 0x0000, ret 0x00000000
5032@1486038208.372944:usb_xhci_oper_write off 0x0000, val 0x0000000d
5032@1486038208.372953:usb_xhci_run 
5032@1486038208.373031:usb_xhci_oper_read off 0x0004, ret 0x00000000
5032@1486038208.373100:usb_xhci_oper_read off 0x0004, ret 0x00000000
5032@1486038208.373168:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486038208.373187:usb_xhci_fetch_trb addr 000000019c612000, 
CR_VENDOR_NEC_FIRMWARE_REVISION, p 0000000000000000, s 00000000, c 0x0000c401
5032@1486038208.373199:usb_xhci_queue_event v 0, idx 0, 
CR_VENDOR_VIA_CHALLENGE_RESPONSE, CC_SUCCESS, p 000000019c612000, s 01003025, c 
0x0000c001
5032@1486038208.373211:usb_xhci_irq_msix nr 0
5032@1486038208.373238:usb_xhci_fetch_trb addr 000000019c612010, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486038208.373312:usb_xhci_oper_read off 0x0004, ret 0x00000008
5032@1486038208.373364:usb_xhci_runtime_write off 0x0038, val 0x9c657018
5032@1486038208.373374:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486038208.373414:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486038208.373430:usb_xhci_fetch_trb addr 000000019c612010, 
CR_VENDOR_NEC_CHALLENGE_RESPONSE, p 7edb0561ae7b2abf, s 00000000, c 0x0000c801
5032@1486038208.373439:usb_xhci_queue_event v 0, idx 1, 
CR_VENDOR_VIA_CHALLENGE_RESPONSE, CC_SUCCESS, p 000000019c612010, s 01001ce6, c 
0x9f16c001
5032@1486038208.373450:usb_xhci_irq_msix nr 0
5032@1486038208.373471:usb_xhci_fetch_trb addr 000000019c612020, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486038208.373559:usb_xhci_oper_read off 0x0004, ret 0x00000008
5032@1486038208.373612:usb_xhci_runtime_write off 0x0038, val 0x9c657028
5032@1486038208.373621:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486038208.373661:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486038208.373677:usb_xhci_fetch_trb addr 000000019c612020, ???, p 
0000000003ff6a00, s 00000000, c 0x0007d001
5032@1486038208.373686:usb_xhci_unimplemented command (0x34)
5032@1486038208.373693:usb_xhci_queue_event v 0, idx 2, ER_COMMAND_COMPLETE, 
CC_TRB_ERROR, p 000000019c612020, s 05000000, c 0x00008401
5032@1486038208.373703:usb_xhci_irq_msix nr 0
5032@1486038208.373721:usb_xhci_fetch_trb addr 000000019c612030, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486038208.373804:usb_xhci_runtime_write off 0x0038, val 0x9c657038
5032@1486038208.373816:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486038208.374217:usb_xhci_oper_read off 0x0004, ret 0x00000008
5032@1486038208.374287:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486038208.374304:usb_xhci_fetch_trb addr 000000019c612030, 
CR_GET_PORT_BANDWIDTH, p 000000019c602000, s 00000000, c 0x00015401
xhci_get_port_bandwidth()
xhci: bandwidth context at 19c602000
5032@1486038208.374327:usb_xhci_queue_event v 0, idx 3, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c612030, s 01000000, c 0x00008401
5032@1486038208.374337:usb_xhci_irq_msix nr 0
5032@1486038208.374359:usb_xhci_fetch_trb addr 000000019c612040, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486038208.374431:usb_xhci_oper_read off 0x0004, ret 0x00000008
5032@1486038208.374484:usb_xhci_runtime_write off 0x0038, val 0x9c657048
5032@1486038208.374494:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486038208.374533:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486038208.374548:usb_xhci_fetch_trb addr 000000019c612040, 
CR_GET_PORT_BANDWIDTH, p 000000019c602000, s 00000000, c 0x00025401
xhci_get_port_bandwidth()
xhci: bandwidth context at 19c602000
5032@1486038208.374568:usb_xhci_queue_event v 0, idx 4, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c612040, s 01000000, c 0x00008401
5032@1486038208.374578:usb_xhci_irq_msix nr 0
5032@1486038208.374595:usb_xhci_fetch_trb addr 000000019c612050, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486038208.374668:usb_xhci_runtime_write off 0x0038, val 0x9c657058
5032@1486038208.374679:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486038208.374747:usb_xhci_oper_read off 0x0004, ret 0x00000008
5032@1486038208.374807:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486038208.374852:usb_xhci_fetch_trb addr 000000019c612050, 
CR_GET_PORT_BANDWIDTH, p 000000019c602000, s 00000000, c 0x00035401
xhci_get_port_bandwidth()
xhci: bandwidth context at 19c602000
5032@1486038208.374882:usb_xhci_queue_event v 0, idx 5, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c612050, s 01000000, c 0x00008401
5032@1486038208.374892:usb_xhci_irq_msix nr 0
5032@1486038208.374912:usb_xhci_fetch_trb addr 000000019c612060, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486038208.374982:usb_xhci_runtime_write off 0x0038, val 0x9c657068
5032@1486038208.374993:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486038208.375071:usb_xhci_oper_read off 0x0004, ret 0x00000008
5032@1486038208.375128:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486038208.375144:usb_xhci_fetch_trb addr 000000019c612060, 
CR_GET_PORT_BANDWIDTH, p 000000019c602000, s 00000000, c 0x00045401
xhci_get_port_bandwidth()
xhci: bandwidth context at 19c602000
5032@1486038208.375165:usb_xhci_queue_event v 0, idx 6, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c612060, s 01000000, c 0x00008401
5032@1486038208.375174:usb_xhci_irq_msix nr 0
5032@1486038208.375194:usb_xhci_fetch_trb addr 000000019c612070, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486038208.375293:usb_xhci_runtime_write off 0x0038, val 0x9c657078
5032@1486038208.375304:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486038208.688987:usb_xhci_port_read port 1, off 0x0000, ret 0x000202a0
5032@1486038208.689077:usb_xhci_port_read port 2, off 0x0000, ret 0x000202a0
5032@1486038208.689133:usb_xhci_port_read port 3, off 0x0000, ret 0x000202a0
5032@1486038208.689204:usb_xhci_port_read port 4, off 0x0000, ret 0x000202a0
5032@1486038208.689256:usb_xhci_port_read port 5, off 0x0000, ret 0x000202a0
5032@1486038208.689315:usb_xhci_port_read port 6, off 0x0000, ret 0x000202a0
5032@1486038208.689431:usb_xhci_port_read port 7, off 0x0000, ret 0x000202a0
5032@1486038208.689983:usb_xhci_port_read port 8, off 0x0000, ret 0x000202a0
5032@1486038208.691270:usb_xhci_port_read port 1, off 0x0000, ret 0x000202a0
5032@1486038208.691899:usb_xhci_port_read port 2, off 0x0000, ret 0x000202a0
5032@1486038208.692650:usb_xhci_port_read port 3, off 0x0000, ret 0x000202a0
5032@1486038208.692906:usb_xhci_port_read port 4, off 0x0000, ret 0x000202a0
5032@1486038208.693076:usb_xhci_port_read port 5, off 0x0000, ret 0x000202a0
5032@1486038208.693160:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486038208.693288:usb_xhci_port_read port 6, off 0x0000, ret 0x000202a0
5032@1486038208.693387:usb_xhci_port_read port 6, off 0x0004, ret 0x00000000
5032@1486038208.693937:usb_xhci_port_read port 7, off 0x0000, ret 0x000202a0
5032@1486038208.694060:usb_xhci_port_read port 7, off 0x0004, ret 0x00000000
5032@1486038208.694600:usb_xhci_port_read port 8, off 0x0000, ret 0x000202a0
5032@1486038208.694712:usb_xhci_port_read port 8, off 0x0004, ret 0x00000000
5032@1486038208.739230:usb_xhci_port_read port 1, off 0x0000, ret 0x000202a0
5032@1486038208.739399:usb_xhci_port_read port 1, off 0x0000, ret 0x000202a0
5032@1486038208.739471:usb_xhci_port_read port 1, off 0x0000, ret 0x000202a0
5032@1486038208.739538:usb_xhci_port_read port 1, off 0x0004, ret 0x00000000
5032@1486038208.739628:usb_xhci_port_write port 1, off 0x0000, val 0x000202a0
5032@1486038208.739717:usb_xhci_port_read port 1, off 0x0000, ret 0x000002a0
5032@1486038208.739787:usb_xhci_port_read port 1, off 0x0000, ret 0x000002a0
5032@1486038208.739935:usb_xhci_port_read port 1, off 0x0000, ret 0x000002a0
5032@1486038208.740034:usb_xhci_port_read port 1, off 0x0000, ret 0x000002a0
5032@1486038208.740124:usb_xhci_port_read port 1, off 0x0004, ret 0x00000000
5032@1486038208.740194:usb_xhci_port_write port 1, off 0x0000, val 0x000002a0
5032@1486038208.740261:usb_xhci_port_read port 1, off 0x0000, ret 0x000002a0
5032@1486038208.740345:usb_xhci_port_read port 1, off 0x0000, ret 0x000002a0
5032@1486038208.740490:usb_xhci_port_read port 2, off 0x0000, ret 0x000202a0
5032@1486038208.741171:usb_xhci_port_read port 2, off 0x0000, ret 0x000202a0
5032@1486038208.741254:usb_xhci_port_read port 2, off 0x0000, ret 0x000202a0
5032@1486038208.741320:usb_xhci_port_read port 2, off 0x0004, ret 0x00000000
5032@1486038208.741429:usb_xhci_port_write port 2, off 0x0000, val 0x000202a0
5032@1486038208.741539:usb_xhci_port_read port 2, off 0x0000, ret 0x000002a0
5032@1486038208.741647:usb_xhci_port_read port 2, off 0x0000, ret 0x000002a0
5032@1486038208.742140:usb_xhci_port_read port 2, off 0x0000, ret 0x000002a0
5032@1486038208.742223:usb_xhci_port_read port 2, off 0x0000, ret 0x000002a0
5032@1486038208.742323:usb_xhci_port_read port 2, off 0x0004, ret 0x00000000
5032@1486038208.742426:usb_xhci_port_write port 2, off 0x0000, val 0x000002a0
5032@1486038208.742528:usb_xhci_port_read port 2, off 0x0000, ret 0x000002a0
5032@1486038208.742627:usb_xhci_port_read port 2, off 0x0000, ret 0x000002a0
5032@1486038208.742766:usb_xhci_port_read port 3, off 0x0000, ret 0x000202a0
5032@1486038208.742900:usb_xhci_port_read port 3, off 0x0000, ret 0x000202a0
5032@1486038208.742982:usb_xhci_port_read port 3, off 0x0000, ret 0x000202a0
5032@1486038208.743077:usb_xhci_port_read port 3, off 0x0004, ret 0x00000000
5032@1486038208.743147:usb_xhci_port_write port 3, off 0x0000, val 0x000202a0
5032@1486038208.743280:usb_xhci_port_read port 3, off 0x0000, ret 0x000002a0
5032@1486038208.743392:usb_xhci_port_read port 3, off 0x0000, ret 0x000002a0
5032@1486038208.743979:usb_xhci_port_read port 3, off 0x0000, ret 0x000002a0
5032@1486038208.744047:usb_xhci_port_read port 3, off 0x0000, ret 0x000002a0
5032@1486038208.744104:usb_xhci_port_read port 3, off 0x0004, ret 0x00000000
5032@1486038208.744162:usb_xhci_port_write port 3, off 0x0000, val 0x000002a0
5032@1486038208.744228:usb_xhci_port_read port 3, off 0x0000, ret 0x000002a0
5032@1486038208.744282:usb_xhci_port_read port 3, off 0x0000, ret 0x000002a0
5032@1486038208.744432:usb_xhci_port_read port 4, off 0x0000, ret 0x000202a0
5032@1486038208.744575:usb_xhci_port_read port 4, off 0x0000, ret 0x000202a0
5032@1486038208.744633:usb_xhci_port_read port 4, off 0x0000, ret 0x000202a0
5032@1486038208.744689:usb_xhci_port_read port 4, off 0x0004, ret 0x00000000
5032@1486038208.744747:usb_xhci_port_write port 4, off 0x0000, val 0x000202a0
5032@1486038208.744802:usb_xhci_port_read port 4, off 0x0000, ret 0x000002a0
5032@1486038208.744881:usb_xhci_port_read port 4, off 0x0000, ret 0x000002a0
5032@1486038208.745031:usb_xhci_port_read port 4, off 0x0000, ret 0x000002a0
5032@1486038208.745090:usb_xhci_port_read port 4, off 0x0000, ret 0x000002a0
5032@1486038208.745146:usb_xhci_port_read port 4, off 0x0004, ret 0x00000000
5032@1486038208.745203:usb_xhci_port_write port 4, off 0x0000, val 0x000002a0
5032@1486038208.745259:usb_xhci_port_read port 4, off 0x0000, ret 0x000002a0
5032@1486038208.745325:usb_xhci_port_read port 4, off 0x0000, ret 0x000002a0
5032@1486038208.745463:usb_xhci_port_read port 5, off 0x0000, ret 0x000202a0
5032@1486038208.745521:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486038208.745658:usb_xhci_port_read port 5, off 0x0000, ret 0x000202a0
5032@1486038208.745716:usb_xhci_port_read port 5, off 0x0000, ret 0x000202a0
5032@1486038208.745785:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486038208.745865:usb_xhci_port_write port 5, off 0x0000, val 0x000202a0
5032@1486038208.745932:usb_xhci_port_read port 5, off 0x0000, ret 0x000002a0
5032@1486038208.745989:usb_xhci_port_read port 5, off 0x0000, ret 0x000002a0
5032@1486038208.746046:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486038208.746184:usb_xhci_port_read port 5, off 0x0000, ret 0x000002a0
5032@1486038208.746242:usb_xhci_port_read port 5, off 0x0000, ret 0x000002a0
5032@1486038208.746298:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486038208.746355:usb_xhci_port_write port 5, off 0x0000, val 0x000002a0
5032@1486038208.746408:usb_xhci_port_read port 5, off 0x0000, ret 0x000002a0
5032@1486038208.746463:usb_xhci_port_read port 5, off 0x0000, ret 0x000002a0
5032@1486038208.746518:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486038208.746655:usb_xhci_port_read port 6, off 0x0000, ret 0x000202a0
5032@1486038208.746713:usb_xhci_port_read port 6, off 0x0004, ret 0x00000000
5032@1486038208.746851:usb_xhci_port_read port 6, off 0x0000, ret 0x000202a0
5032@1486038208.746915:usb_xhci_port_read port 6, off 0x0000, ret 0x000202a0
5032@1486038208.746972:usb_xhci_port_read port 6, off 0x0004, ret 0x00000000
5032@1486038208.747029:usb_xhci_port_write port 6, off 0x0000, val 0x000202a0
5032@1486038208.747082:usb_xhci_port_read port 6, off 0x0000, ret 0x000002a0
5032@1486038208.747137:usb_xhci_port_read port 6, off 0x0000, ret 0x000002a0
5032@1486038208.747193:usb_xhci_port_read port 6, off 0x0004, ret 0x00000000
5032@1486038208.747334:usb_xhci_port_read port 6, off 0x0000, ret 0x000002a0
5032@1486038208.747389:usb_xhci_port_read port 6, off 0x0000, ret 0x000002a0
5032@1486038208.747446:usb_xhci_port_read port 6, off 0x0004, ret 0x00000000
5032@1486038208.747503:usb_xhci_port_write port 6, off 0x0000, val 0x000002a0
5032@1486038208.747555:usb_xhci_port_read port 6, off 0x0000, ret 0x000002a0
5032@1486038208.747619:usb_xhci_port_read port 6, off 0x0000, ret 0x000002a0
5032@1486038208.747674:usb_xhci_port_read port 6, off 0x0004, ret 0x00000000
5032@1486038208.747827:usb_xhci_port_read port 7, off 0x0000, ret 0x000202a0
5032@1486038208.747883:usb_xhci_port_read port 7, off 0x0004, ret 0x00000000
5032@1486038208.748021:usb_xhci_port_read port 7, off 0x0000, ret 0x000202a0
5032@1486038208.748086:usb_xhci_port_read port 7, off 0x0000, ret 0x000202a0
5032@1486038208.748138:usb_xhci_port_read port 7, off 0x0004, ret 0x00000000
5032@1486038208.748196:usb_xhci_port_write port 7, off 0x0000, val 0x000202a0
5032@1486038208.748252:usb_xhci_port_read port 7, off 0x0000, ret 0x000002a0
5032@1486038208.748308:usb_xhci_port_read port 7, off 0x0000, ret 0x000002a0
5032@1486038208.748362:usb_xhci_port_read port 7, off 0x0004, ret 0x00000000
5032@1486038208.748499:usb_xhci_port_read port 7, off 0x0000, ret 0x000002a0
5032@1486038208.748554:usb_xhci_port_read port 7, off 0x0000, ret 0x000002a0
5032@1486038208.748610:usb_xhci_port_read port 7, off 0x0004, ret 0x00000000
5032@1486038208.748668:usb_xhci_port_write port 7, off 0x0000, val 0x000002a0
5032@1486038208.748724:usb_xhci_port_read port 7, off 0x0000, ret 0x000002a0
5032@1486038208.748779:usb_xhci_port_read port 7, off 0x0000, ret 0x000002a0
5032@1486038208.748860:usb_xhci_port_read port 7, off 0x0004, ret 0x00000000
5032@1486038208.749008:usb_xhci_port_read port 8, off 0x0000, ret 0x000202a0
5032@1486038208.749063:usb_xhci_port_read port 8, off 0x0004, ret 0x00000000
5032@1486038208.749200:usb_xhci_port_read port 8, off 0x0000, ret 0x000202a0
5032@1486038208.749258:usb_xhci_port_read port 8, off 0x0000, ret 0x000202a0
5032@1486038208.749314:usb_xhci_port_read port 8, off 0x0004, ret 0x00000000
5032@1486038208.749371:usb_xhci_port_write port 8, off 0x0000, val 0x000202a0
5032@1486038208.749427:usb_xhci_port_read port 8, off 0x0000, ret 0x000002a0
5032@1486038208.749483:usb_xhci_port_read port 8, off 0x0000, ret 0x000002a0
5032@1486038208.749538:usb_xhci_port_read port 8, off 0x0004, ret 0x00000000
5032@1486038208.749689:usb_xhci_port_read port 8, off 0x0000, ret 0x000002a0
5032@1486038208.750000:usb_xhci_port_read port 8, off 0x0000, ret 0x000002a0
5032@1486038208.750094:usb_xhci_port_read port 8, off 0x0004, ret 0x00000000
5032@1486038208.750172:usb_xhci_port_write port 8, off 0x0000, val 0x000002a0
5032@1486038208.750245:usb_xhci_port_read port 8, off 0x0000, ret 0x000002a0
5032@1486038208.750319:usb_xhci_port_read port 8, off 0x0000, ret 0x000002a0
5032@1486038208.750394:usb_xhci_port_read port 8, off 0x0004, ret 0x00000000
5032@1486038208.750574:usb_xhci_port_read port 1, off 0x0000, ret 0x000002a0
5032@1486038208.750754:usb_xhci_port_read port 2, off 0x0000, ret 0x000002a0
5032@1486038208.750920:usb_xhci_port_read port 3, off 0x0000, ret 0x000002a0
5032@1486038208.751097:usb_xhci_port_read port 4, off 0x0000, ret 0x000002a0
udp: AUDIO add
qemu-system-x86_64: usbredirparser: Peer version: USBMR 1.0, using 64-bits ids
qemu-system-x86_64: usb-redir: attaching low speed device 0e6a:6001 version 0.7 
class 00

5032@1486039054.054270:usb_xhci_port_link port 5, pls 7
5032@1486039054.054279:usb_xhci_port_notify port 5, bits 20000
5032@1486039054.054289:usb_xhci_queue_event v 0, idx 7, ER_PORT_STATUS_CHANGE, 
CC_SUCCESS, p 0000000005000000, s 01000000, c 0x00008801
5032@1486039054.054310:usb_xhci_irq_msix nr 0
5032@1486039054.054600:usb_xhci_runtime_write off 0x0038, val 0x9c657088
5032@1486039054.054624:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039054.054921:usb_xhci_port_read port 5, off 0x0000, ret 0x00020ae1
5032@1486039054.055074:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.055285:usb_xhci_port_read port 5, off 0x0000, ret 0x00020ae1
5032@1486039054.055357:usb_xhci_port_read port 5, off 0x0000, ret 0x00020ae1
5032@1486039054.055417:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.055477:usb_xhci_port_write port 5, off 0x0000, val 0x00020ae1
5032@1486039054.055531:usb_xhci_port_read port 5, off 0x0000, ret 0x00000ae1
5032@1486039054.055587:usb_xhci_port_read port 5, off 0x0000, ret 0x00000ae1
5032@1486039054.055640:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.165715:usb_xhci_port_read port 5, off 0x0000, ret 0x00000ae1
5032@1486039054.165872:usb_xhci_port_read port 5, off 0x0000, ret 0x00000ae1
5032@1486039054.166016:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.166081:usb_xhci_port_write port 5, off 0x0000, val 0x00000af1
5032@1486039054.166091:usb_xhci_port_reset port 5, warm 0
5032@1486039054.166141:usb_xhci_port_link port 5, pls 0
5032@1486039054.166150:usb_xhci_port_notify port 5, bits 200000
5032@1486039054.166159:usb_xhci_queue_event v 0, idx 8, ER_PORT_STATUS_CHANGE, 
CC_SUCCESS, p 0000000005000000, s 01000000, c 0x00008801
5032@1486039054.166177:usb_xhci_irq_msix nr 0
5032@1486039054.166257:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039054.166314:usb_xhci_runtime_write off 0x0038, val 0x9c657098
5032@1486039054.166325:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039054.166366:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039054.166426:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.166514:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039054.166573:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.166707:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039054.166766:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039054.166846:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.166915:usb_xhci_port_write port 5, off 0x0000, val 0x00200a01
5032@1486039054.166970:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039054.167028:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039054.167081:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.212473:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039054.212567:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.212963:usb_xhci_oper_read off 0x0004, ret 0x00000008
5032@1486039054.213044:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039054.213066:usb_xhci_fetch_trb addr 000000019c612070, 
CR_ENABLE_SLOT, p 0000000000000000, s 00000000, c 0x00002401
5032@1486039054.213077:usb_xhci_slot_enable slotid 1
5032@1486039054.213086:usb_xhci_queue_event v 0, idx 9, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c612070, s 01000000, c 0x01008401
5032@1486039054.213098:usb_xhci_irq_msix nr 0
5032@1486039054.213124:usb_xhci_fetch_trb addr 000000019c612080, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039054.213337:usb_xhci_runtime_write off 0x0038, val 0x9c6570a8
5032@1486039054.213361:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039054.213422:usb_xhci_runtime_write off 0x0108, val 0x00000001
5032@1486039054.213509:usb_xhci_runtime_write off 0x0118, val 0x9ea54008
5032@1486039054.213524:usb_xhci_runtime_write off 0x011c, val 0x00000001
xhci: ERDP out of bounds: 19ea54000
xhci: ER[7] at 0 len 0
xhci: asserted controller error
5032@1486039054.213596:usb_xhci_runtime_write off 0x0110, val 0x9c61e070
5032@1486039054.213606:usb_xhci_runtime_write off 0x0114, val 0x00000001
xhci: event ring[7]:19ea54000 [256]
5032@1486039054.213675:usb_xhci_runtime_write off 0x0104, val 0x00000fa0
5032@1486039054.213753:usb_xhci_runtime_write off 0x0100, val 0x00000002
5032@1486039054.213765:usb_xhci_irq_msix_use nr 7
5032@1486039054.213854:usb_xhci_runtime_read off 0x0104, ret 0x00000fa0
5032@1486039054.213961:usb_xhci_oper_read off 0x0004, ret 0x00001008
5032@1486039054.214022:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039054.214040:usb_xhci_fetch_trb addr 000000019c612080, 
CR_ADDRESS_DEVICE, p 000000019ea4d000, s 00000000, c 0x01002e01
xhci: input context at 19ea4d000
xhci: output context at 19ea1d000
xhci: input slot context: 08200000 00050000 00000000 00000000
xhci: input ep0 context: 00000000 00080026 9e85b001 00000001 00001000
5032@1486039054.214480:usb_xhci_slot_address slotid 1, port 1
5032@1486039054.214530:usb_xhci_ep_enable slotid 1, epid 1
xhci: endpoint 0.1 type is 4, max transaction (burst) size is 8
xhci: output slot context: 08200000 00050000 00000000 08000000
xhci: output ep0 context: 00000001 00080026 9e85b001 00000001 00001000
5032@1486039054.214599:usb_xhci_queue_event v 0, idx 10, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c612080, s 01000000, c 0x01008401
5032@1486039054.214610:usb_xhci_irq_msix nr 0
5032@1486039054.214636:usb_xhci_fetch_trb addr 000000019c612090, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039054.214819:usb_xhci_runtime_write off 0x0038, val 0x9c6570b8
5032@1486039054.214843:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039054.214944:usb_xhci_doorbell_write off 0x0004, val 0x00000001
5032@1486039054.214967:usb_xhci_ep_kick slotid 1, epid 1, streamid 0
xhci: set epctx: 19ea1d020 state=1 dequeue=000000019e85b001
5032@1486039054.215312:usb_xhci_fetch_trb addr 000000019e85b000, TR_SETUP, p 
0040000001000680, s 01c00008, c 0x00000841
5032@1486039054.215327:usb_xhci_fetch_trb addr 000000019e85b010, TR_DATA, p 
000000019eb38000, s 01c00040, c 0x00010c25
5032@1486039054.215336:usb_xhci_fetch_trb addr 000000019e85b020, TR_STATUS, p 
0000000000000000, s 01c00000, c 0x00001021
5032@1486039054.215344:usb_xhci_xfer_start 0x56429708c7a8: slotid 1, epid 1, 
streamid 0
xhci: setup packet pid 0x69 addr 0 ep 0
5032@1486039054.215718:usb_xhci_xfer_async 0x56429708c7a8
5032@1486039054.219744:usb_xhci_xfer_success 0x56429708c7a8: len 18
5032@1486039054.219775:usb_xhci_queue_event v 7, idx 0, ER_TRANSFER, 
CC_SHORT_PACKET, p 000000019e85b010, s 0d00002e, c 0x01018001
5032@1486039054.219791:usb_xhci_irq_msix nr 7
5032@1486039054.219818:usb_xhci_queue_event v 7, idx 1, ER_TRANSFER, 
CC_SUCCESS, p 000000019e85b020, s 01000000, c 0x01018001
5032@1486039054.219866:usb_xhci_irq_msix nr 7
5032@1486039054.219885:usb_xhci_ep_kick slotid 1, epid 1, streamid 0
xhci: set epctx: 19ea1d020 state=1 dequeue=000000019e85b031
5032@1486039054.219962:usb_xhci_runtime_write off 0x0118, val 0x9ea54018
5032@1486039054.219973:usb_xhci_runtime_write off 0x011c, val 0x00000001
5032@1486039054.220039:usb_xhci_runtime_write off 0x0118, val 0x9ea54028
5032@1486039054.220048:usb_xhci_runtime_write off 0x011c, val 0x00000001
5032@1486039054.220263:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039054.220361:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039054.220421:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.220477:usb_xhci_port_write port 5, off 0x0000, val 0x00000a11
5032@1486039054.220487:usb_xhci_port_reset port 5, warm 0
5032@1486039054.220534:usb_xhci_port_link port 5, pls 0
5032@1486039054.220543:usb_xhci_port_notify port 5, bits 200000
5032@1486039054.220552:usb_xhci_queue_event v 0, idx 11, ER_PORT_STATUS_CHANGE, 
CC_SUCCESS, p 0000000005000000, s 01000000, c 0x00008801
5032@1486039054.220567:usb_xhci_irq_msix nr 0
5032@1486039054.220645:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039054.220722:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039054.220778:usb_xhci_runtime_write off 0x0038, val 0x9c6570c8
5032@1486039054.220788:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039054.220866:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.220968:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039054.221028:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.221273:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039054.221334:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039054.221387:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.221440:usb_xhci_port_write port 5, off 0x0000, val 0x00200a01
5032@1486039054.221493:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039054.221552:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039054.221604:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.259305:usb_xhci_oper_read off 0x0004, ret 0x00001008
5032@1486039054.259471:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039054.259516:usb_xhci_fetch_trb addr 000000019c612090, 
CR_ADDRESS_DEVICE, p 000000019ea4d000, s 00000000, c 0x01002c01
xhci: input context at 19ea4d000
xhci: output context at 19ea1d000
xhci: input slot context: 08200000 00050000 00000000 00000000
xhci: input ep0 context: 00000000 00080026 9e85b031 00000001 00001000
5032@1486039054.259557:usb_xhci_slot_address slotid 1, port 1
5032@1486039054.259609:usb_xhci_ep_enable slotid 1, epid 1
5032@1486039054.259619:usb_xhci_ep_disable slotid 1, epid 1
xhci_ep_nuke_xfers(1, 1)
xhci: set epctx: 19ea1d020 state=0 dequeue=000000019e85b031
5032@1486039054.259651:usb_xhci_ep_state slotid 1, epid 1, running -> disabled
xhci: endpoint 0.1 type is 4, max transaction (burst) size is 8
xhci: output slot context: 08200000 00050000 00000000 10000001
xhci: output ep0 context: 00000001 00080026 9e85b031 00000001 00001000
5032@1486039054.259692:usb_xhci_queue_event v 0, idx 12, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c612090, s 01000000, c 0x01008401
5032@1486039054.259703:usb_xhci_irq_msix nr 0
5032@1486039054.259730:usb_xhci_fetch_trb addr 000000019c6120a0, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039054.259925:usb_xhci_runtime_write off 0x0038, val 0x9c6570d8
5032@1486039054.259946:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039054.290401:usb_xhci_doorbell_write off 0x0004, val 0x00000001
5032@1486039054.290433:usb_xhci_ep_kick slotid 1, epid 1, streamid 0
xhci: set epctx: 19ea1d020 state=1 dequeue=000000019e85b031
5032@1486039054.290463:usb_xhci_fetch_trb addr 000000019e85b030, TR_SETUP, p 
0012000001000680, s 01c00008, c 0x00000841
5032@1486039054.290473:usb_xhci_fetch_trb addr 000000019e85b040, TR_DATA, p 
000000019eb38000, s 01c00012, c 0x00010c25
5032@1486039054.290482:usb_xhci_fetch_trb addr 000000019e85b050, TR_STATUS, p 
0000000000000000, s 01c00000, c 0x00001021
5032@1486039054.290490:usb_xhci_xfer_start 0x56429708c7a8: slotid 1, epid 1, 
streamid 0
xhci: setup packet pid 0x69 addr 1 ep 0
5032@1486039054.290553:usb_xhci_xfer_async 0x56429708c7a8
5032@1486039054.797633:usb_xhci_xfer_success 0x56429708c7a8: len 18
5032@1486039054.797675:usb_xhci_queue_event v 7, idx 2, ER_TRANSFER, 
CC_SUCCESS, p 000000019e85b040, s 01000000, c 0x01018001
5032@1486039054.797695:usb_xhci_irq_msix nr 7
5032@1486039054.797733:usb_xhci_queue_event v 7, idx 3, ER_TRANSFER, 
CC_SUCCESS, p 000000019e85b050, s 01000000, c 0x01018001
5032@1486039054.797748:usb_xhci_irq_msix nr 7
5032@1486039054.797768:usb_xhci_ep_kick slotid 1, epid 1, streamid 0
xhci: set epctx: 19ea1d020 state=1 dequeue=000000019e85b061
5032@1486039054.797919:usb_xhci_runtime_write off 0x0118, val 0x9ea54058
5032@1486039054.797935:usb_xhci_runtime_write off 0x011c, val 0x00000001
5032@1486039054.797996:usb_xhci_runtime_write off 0x0118, val 0x9ea54048
5032@1486039054.798008:usb_xhci_runtime_write off 0x011c, val 0x00000001
5032@1486039054.798161:usb_xhci_doorbell_write off 0x0004, val 0x00000001
5032@1486039054.798184:usb_xhci_ep_kick slotid 1, epid 1, streamid 0
xhci: set epctx: 19ea1d020 state=1 dequeue=000000019e85b061
5032@1486039054.798214:usb_xhci_fetch_trb addr 000000019e85b060, TR_SETUP, p 
00ff000002000680, s 01c00008, c 0x00000841
5032@1486039054.798225:usb_xhci_fetch_trb addr 000000019e85b070, TR_DATA, p 
000000019eb38000, s 01c000ff, c 0x00010c25
5032@1486039054.798234:usb_xhci_fetch_trb addr 000000019e85b080, TR_STATUS, p 
0000000000000000, s 01c00000, c 0x00001021
5032@1486039054.798241:usb_xhci_xfer_start 0x56429708c890: slotid 1, epid 1, 
streamid 0
xhci: setup packet pid 0x69 addr 1 ep 0
5032@1486039054.798310:usb_xhci_xfer_async 0x56429708c890
5032@1486039054.810638:usb_xhci_xfer_success 0x56429708c890: len 59
5032@1486039054.810673:usb_xhci_queue_event v 7, idx 4, ER_TRANSFER, 
CC_SHORT_PACKET, p 000000019e85b070, s 0d0000c4, c 0x01018001
5032@1486039054.810690:usb_xhci_irq_msix nr 7
5032@1486039054.810719:usb_xhci_queue_event v 7, idx 5, ER_TRANSFER, 
CC_SUCCESS, p 000000019e85b080, s 01000000, c 0x01018001
5032@1486039054.810731:usb_xhci_irq_msix nr 7
5032@1486039054.810772:usb_xhci_ep_kick slotid 1, epid 1, streamid 0
xhci: set epctx: 19ea1d020 state=1 dequeue=000000019e85b091
5032@1486039054.810921:usb_xhci_runtime_write off 0x0118, val 0x9ea54068
5032@1486039054.810934:usb_xhci_runtime_write off 0x011c, val 0x00000001
5032@1486039054.930072:usb_xhci_runtime_write off 0x0100, val 0x00000000
5032@1486039054.930110:usb_xhci_irq_msix_unuse nr 7
5032@1486039054.930246:usb_xhci_runtime_write off 0x0108, val 0x00000000
5032@1486039054.930308:usb_xhci_runtime_write off 0x0110, val 0x00000000
5032@1486039054.930318:usb_xhci_runtime_write off 0x0114, val 0x00000000
5032@1486039054.930371:usb_xhci_runtime_write off 0x0118, val 0x00000000
5032@1486039054.930380:usb_xhci_runtime_write off 0x011c, val 0x00000000
xhci: ERDP out of bounds: 0
xhci: ER[7] at 0 len 0
xhci: asserted controller error
5032@1486039054.930500:usb_xhci_oper_read off 0x0004, ret 0x00001008
5032@1486039054.930563:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039054.930584:usb_xhci_fetch_trb addr 000000019c6120a0, 
CR_DISABLE_SLOT, p 0000000000000000, s 00000000, c 0x01002801
5032@1486039054.930594:usb_xhci_slot_disable slotid 1
5032@1486039054.930600:usb_xhci_ep_disable slotid 1, epid 1
xhci_ep_nuke_xfers(1, 1)
xhci: set epctx: 19ea1d020 state=0 dequeue=000000019e85b091
5032@1486039054.930635:usb_xhci_ep_state slotid 1, epid 1, running -> disabled
5032@1486039054.930645:usb_xhci_queue_event v 0, idx 13, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c6120a0, s 01000000, c 0x01008401
5032@1486039054.930656:usb_xhci_irq_msix nr 0
5032@1486039054.930681:usb_xhci_fetch_trb addr 000000019c6120b0, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039054.930776:usb_xhci_runtime_write off 0x0038, val 0x9c6570e8
5032@1486039054.930789:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039054.930883:usb_xhci_oper_read off 0x0004, ret 0x00001008
5032@1486039054.930955:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039054.930973:usb_xhci_fetch_trb addr 000000019c6120b0, 
CR_GET_PORT_BANDWIDTH, p 000000019c602000, s 00000000, c 0x00015401
xhci_get_port_bandwidth()
xhci: bandwidth context at 19c602000
5032@1486039054.930995:usb_xhci_queue_event v 0, idx 14, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c6120b0, s 01000000, c 0x00008401
5032@1486039054.931005:usb_xhci_irq_msix nr 0
5032@1486039054.931027:usb_xhci_fetch_trb addr 000000019c6120c0, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039054.931171:usb_xhci_runtime_write off 0x0038, val 0x9c6570f8
5032@1486039054.931183:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039054.931229:usb_xhci_oper_read off 0x0004, ret 0x00001008
5032@1486039054.931289:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039054.931306:usb_xhci_fetch_trb addr 000000019c6120c0, 
CR_GET_PORT_BANDWIDTH, p 000000019c602000, s 00000000, c 0x00025401
xhci_get_port_bandwidth()
xhci: bandwidth context at 19c602000
5032@1486039054.931327:usb_xhci_queue_event v 0, idx 15, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c6120c0, s 01000000, c 0x00008401
5032@1486039054.931337:usb_xhci_irq_msix nr 0
5032@1486039054.931359:usb_xhci_fetch_trb addr 000000019c6120d0, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039054.931509:usb_xhci_oper_read off 0x0004, ret 0x00001008
5032@1486039054.931565:usb_xhci_runtime_write off 0x0038, val 0x9c657108
5032@1486039054.931575:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039054.931616:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039054.931632:usb_xhci_fetch_trb addr 000000019c6120d0, 
CR_GET_PORT_BANDWIDTH, p 000000019c602000, s 00000000, c 0x00035401
xhci_get_port_bandwidth()
xhci: bandwidth context at 19c602000
5032@1486039054.931653:usb_xhci_queue_event v 0, idx 16, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c6120d0, s 01000000, c 0x00008401
5032@1486039054.931662:usb_xhci_irq_msix nr 0
5032@1486039054.931683:usb_xhci_fetch_trb addr 000000019c6120e0, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039054.931872:usb_xhci_runtime_write off 0x0038, val 0x9c657118
5032@1486039054.931942:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039054.932018:usb_xhci_oper_read off 0x0004, ret 0x00001008
5032@1486039054.932102:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039054.932126:usb_xhci_fetch_trb addr 000000019c6120e0, 
CR_GET_PORT_BANDWIDTH, p 000000019c602000, s 00000000, c 0x00045401
xhci_get_port_bandwidth()
xhci: bandwidth context at 19c602000
5032@1486039054.932153:usb_xhci_queue_event v 0, idx 17, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c6120e0, s 01000000, c 0x00008401
5032@1486039054.932167:usb_xhci_irq_msix nr 0
5032@1486039054.932193:usb_xhci_fetch_trb addr 000000019c6120f0, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039054.932277:usb_xhci_runtime_write off 0x0038, val 0x9c657128
5032@1486039054.932291:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039054.932649:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039054.932746:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039054.932808:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.932900:usb_xhci_port_write port 5, off 0x0000, val 0x00000a11
5032@1486039054.932921:usb_xhci_port_reset port 5, warm 0
5032@1486039054.932974:usb_xhci_port_link port 5, pls 0
5032@1486039054.932983:usb_xhci_port_notify port 5, bits 200000
5032@1486039054.932991:usb_xhci_queue_event v 0, idx 18, ER_PORT_STATUS_CHANGE, 
CC_SUCCESS, p 0000000005000000, s 01000000, c 0x00008801
5032@1486039054.933006:usb_xhci_irq_msix nr 0
5032@1486039054.933083:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039054.933160:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039054.933216:usb_xhci_runtime_write off 0x0038, val 0x9c657138
5032@1486039054.933226:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039054.933267:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.933353:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039054.933411:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.933542:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039054.933601:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039054.933654:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.933714:usb_xhci_port_write port 5, off 0x0000, val 0x00200a01
5032@1486039054.933769:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039054.933847:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039054.933915:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.976824:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039054.976977:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039054.977337:usb_xhci_oper_read off 0x0004, ret 0x00001008
5032@1486039054.977417:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039054.977439:usb_xhci_fetch_trb addr 000000019c6120f0, 
CR_ENABLE_SLOT, p 0000000000000000, s 00000000, c 0x00002401
5032@1486039054.977449:usb_xhci_slot_enable slotid 1
5032@1486039054.977458:usb_xhci_queue_event v 0, idx 19, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c6120f0, s 01000000, c 0x01008401
5032@1486039054.977469:usb_xhci_irq_msix nr 0
5032@1486039054.977496:usb_xhci_fetch_trb addr 000000019c612100, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039054.977667:usb_xhci_runtime_write off 0x0038, val 0x9c657148
5032@1486039054.977688:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039054.977747:usb_xhci_runtime_write off 0x0108, val 0x00000001
5032@1486039054.977833:usb_xhci_runtime_write off 0x0118, val 0x9e864008
5032@1486039054.977847:usb_xhci_runtime_write off 0x011c, val 0x00000001
xhci: ERDP out of bounds: 19e864000
xhci: ER[7] at 0 len 0
xhci: asserted controller error
5032@1486039054.977954:usb_xhci_runtime_write off 0x0110, val 0x9c61e070
5032@1486039054.977994:usb_xhci_runtime_write off 0x0114, val 0x00000001
xhci: event ring[7]:19e864000 [256]
5032@1486039054.978064:usb_xhci_runtime_write off 0x0104, val 0x00000fa0
5032@1486039054.978125:usb_xhci_runtime_write off 0x0100, val 0x00000002
5032@1486039054.978135:usb_xhci_irq_msix_use nr 7
5032@1486039054.978192:usb_xhci_runtime_read off 0x0104, ret 0x00000fa0
5032@1486039054.978280:usb_xhci_oper_read off 0x0004, ret 0x00001008
5032@1486039054.978341:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039054.978358:usb_xhci_fetch_trb addr 000000019c612100, 
CR_ADDRESS_DEVICE, p 000000019e863000, s 00000000, c 0x01002e01
xhci: input context at 19e863000
xhci: output context at 19e862000
xhci: input slot context: 08200000 00050000 00000000 00000000
xhci: input ep0 context: 00000000 00080026 9e867001 00000001 00001000
5032@1486039054.978398:usb_xhci_slot_address slotid 1, port 1
5032@1486039054.978447:usb_xhci_ep_enable slotid 1, epid 1
xhci: endpoint 0.1 type is 4, max transaction (burst) size is 8
xhci: output slot context: 08200000 00050000 00000000 08000000
xhci: output ep0 context: 00000001 00080026 9e867001 00000001 00001000
5032@1486039054.978495:usb_xhci_queue_event v 0, idx 20, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c612100, s 01000000, c 0x01008401
5032@1486039054.978506:usb_xhci_irq_msix nr 0
5032@1486039054.978530:usb_xhci_fetch_trb addr 000000019c612110, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039054.978695:usb_xhci_runtime_write off 0x0038, val 0x9c657158
5032@1486039054.978708:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039054.978753:usb_xhci_doorbell_write off 0x0004, val 0x00000001
5032@1486039054.978762:usb_xhci_ep_kick slotid 1, epid 1, streamid 0
xhci: set epctx: 19e862020 state=1 dequeue=000000019e867001
5032@1486039054.978786:usb_xhci_fetch_trb addr 000000019e867000, TR_SETUP, p 
0040000001000680, s 01c00008, c 0x00000841
5032@1486039054.978795:usb_xhci_fetch_trb addr 000000019e867010, TR_DATA, p 
000000019e865000, s 01c00040, c 0x00010c25
5032@1486039054.978803:usb_xhci_fetch_trb addr 000000019e867020, TR_STATUS, p 
0000000000000000, s 01c00000, c 0x00001021
5032@1486039054.978811:usb_xhci_xfer_start 0x56429708c7a8: slotid 1, epid 1, 
streamid 0
xhci: setup packet pid 0x69 addr 0 ep 0
5032@1486039054.978906:usb_xhci_xfer_async 0x56429708c7a8
5032@1486039055.507938:usb_xhci_xfer_success 0x56429708c7a8: len 18
5032@1486039055.507977:usb_xhci_queue_event v 7, idx 0, ER_TRANSFER, 
CC_SHORT_PACKET, p 000000019e867010, s 0d00002e, c 0x01018001
5032@1486039055.507995:usb_xhci_irq_msix nr 7
5032@1486039055.508025:usb_xhci_queue_event v 7, idx 1, ER_TRANSFER, 
CC_SUCCESS, p 000000019e867020, s 01000000, c 0x01018001
5032@1486039055.508037:usb_xhci_irq_msix nr 7
5032@1486039055.508054:usb_xhci_ep_kick slotid 1, epid 1, streamid 0
xhci: set epctx: 19e862020 state=1 dequeue=000000019e867031
5032@1486039055.508214:usb_xhci_runtime_write off 0x0118, val 0x9e864028
5032@1486039055.508227:usb_xhci_runtime_write off 0x011c, val 0x00000001
5032@1486039055.508504:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039055.508658:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039055.508764:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039055.508885:usb_xhci_port_write port 5, off 0x0000, val 0x00000a11
5032@1486039055.508909:usb_xhci_port_reset port 5, warm 0
5032@1486039055.508960:usb_xhci_port_link port 5, pls 0
5032@1486039055.508969:usb_xhci_port_notify port 5, bits 200000
5032@1486039055.508977:usb_xhci_queue_event v 0, idx 21, ER_PORT_STATUS_CHANGE, 
CC_SUCCESS, p 0000000005000000, s 01000000, c 0x00008801
5032@1486039055.508993:usb_xhci_irq_msix nr 0
5032@1486039055.509147:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039055.509201:usb_xhci_runtime_write off 0x0038, val 0x9c657168
5032@1486039055.509211:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039055.509260:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039055.509420:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039055.509524:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039055.509596:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039055.509804:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039055.509863:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039055.509934:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039055.510002:usb_xhci_port_write port 5, off 0x0000, val 0x00200a01
5032@1486039055.510055:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039055.510114:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039055.510168:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039055.554045:usb_xhci_oper_read off 0x0004, ret 0x00001008
5032@1486039055.554139:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039055.554164:usb_xhci_fetch_trb addr 000000019c612110, 
CR_ADDRESS_DEVICE, p 000000019e863000, s 00000000, c 0x01002c01
xhci: input context at 19e863000
xhci: output context at 19e862000
xhci: input slot context: 08200000 00050000 00000000 00000000
xhci: input ep0 context: 00000000 00080026 9e867031 00000001 00001000
5032@1486039055.554206:usb_xhci_slot_address slotid 1, port 1
5032@1486039055.554259:usb_xhci_ep_enable slotid 1, epid 1
5032@1486039055.554269:usb_xhci_ep_disable slotid 1, epid 1
xhci_ep_nuke_xfers(1, 1)
xhci: set epctx: 19e862020 state=0 dequeue=000000019e867031
5032@1486039055.554302:usb_xhci_ep_state slotid 1, epid 1, running -> disabled
xhci: endpoint 0.1 type is 4, max transaction (burst) size is 8
xhci: output slot context: 08200000 00050000 00000000 10000001
xhci: output ep0 context: 00000001 00080026 9e867031 00000001 00001000
5032@1486039055.554344:usb_xhci_queue_event v 0, idx 22, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c612110, s 01000000, c 0x01008401
5032@1486039055.554355:usb_xhci_irq_msix nr 0
5032@1486039055.554382:usb_xhci_fetch_trb addr 000000019c612120, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039055.554625:usb_xhci_runtime_write off 0x0038, val 0x9c657178
5032@1486039055.554649:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039055.585298:usb_xhci_doorbell_write off 0x0004, val 0x00000001
5032@1486039055.585330:usb_xhci_ep_kick slotid 1, epid 1, streamid 0
xhci: set epctx: 19e862020 state=1 dequeue=000000019e867031
5032@1486039055.585359:usb_xhci_fetch_trb addr 000000019e867030, TR_SETUP, p 
0012000001000680, s 01c00008, c 0x00000841
5032@1486039055.585370:usb_xhci_fetch_trb addr 000000019e867040, TR_DATA, p 
000000019e865000, s 01c00012, c 0x00010c25
5032@1486039055.585378:usb_xhci_fetch_trb addr 000000019e867050, TR_STATUS, p 
0000000000000000, s 01c00000, c 0x00001021
5032@1486039055.585386:usb_xhci_xfer_start 0x56429708c7a8: slotid 1, epid 1, 
streamid 0
xhci: setup packet pid 0x69 addr 1 ep 0
5032@1486039055.585449:usb_xhci_xfer_async 0x56429708c7a8
5032@1486039056.087928:usb_xhci_xfer_success 0x56429708c7a8: len 18
5032@1486039056.087972:usb_xhci_queue_event v 7, idx 2, ER_TRANSFER, 
CC_SUCCESS, p 000000019e867040, s 01000000, c 0x01018001
5032@1486039056.087988:usb_xhci_irq_msix nr 7
5032@1486039056.088019:usb_xhci_queue_event v 7, idx 3, ER_TRANSFER, 
CC_SUCCESS, p 000000019e867050, s 01000000, c 0x01018001
5032@1486039056.088030:usb_xhci_irq_msix nr 7
5032@1486039056.088047:usb_xhci_ep_kick slotid 1, epid 1, streamid 0
xhci: set epctx: 19e862020 state=1 dequeue=000000019e867061
5032@1486039056.088181:usb_xhci_runtime_write off 0x0118, val 0x9e864048
5032@1486039056.088194:usb_xhci_runtime_write off 0x011c, val 0x00000001
5032@1486039056.088242:usb_xhci_runtime_write off 0x0118, val 0x9e864058
5032@1486039056.088251:usb_xhci_runtime_write off 0x011c, val 0x00000001
5032@1486039056.088489:usb_xhci_doorbell_write off 0x0004, val 0x00000001
5032@1486039056.088510:usb_xhci_ep_kick slotid 1, epid 1, streamid 0
xhci: set epctx: 19e862020 state=1 dequeue=000000019e867061
5032@1486039056.088538:usb_xhci_fetch_trb addr 000000019e867060, TR_SETUP, p 
00ff000002000680, s 01c00008, c 0x00000841
5032@1486039056.088573:usb_xhci_fetch_trb addr 000000019e867070, TR_DATA, p 
000000019e865000, s 01c000ff, c 0x00010c25
5032@1486039056.088582:usb_xhci_fetch_trb addr 000000019e867080, TR_STATUS, p 
0000000000000000, s 01c00000, c 0x00001021
5032@1486039056.088590:usb_xhci_xfer_start 0x56429708c890: slotid 1, epid 1, 
streamid 0
xhci: setup packet pid 0x69 addr 1 ep 0
5032@1486039056.088662:usb_xhci_xfer_async 0x56429708c890
5032@1486039056.100776:usb_xhci_xfer_success 0x56429708c890: len 59
xhci_event(): ER full, queueing
5032@1486039056.100815:usb_xhci_irq_msix nr 7
xhci_event(): ER full, queueing
5032@1486039056.100884:usb_xhci_ep_kick slotid 1, epid 1, streamid 0
xhci: set epctx: 19e862020 state=1 dequeue=000000019e867091
5032@1486039056.101108:usb_xhci_runtime_write off 0x0118, val 0x9e864058
5032@1486039056.101129:usb_xhci_runtime_write off 0x011c, val 0x00000001
xhci_events_update(): event ring still more than half full (hack)
5032@1486039061.092104:usb_xhci_oper_read off 0x0004, ret 0x00001008
5032@1486039061.092205:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039061.092230:usb_xhci_fetch_trb addr 000000019c612120, 
CR_STOP_ENDPOINT, p 0000000000000000, s 00000000, c 0x01013c01
5032@1486039061.092242:usb_xhci_ep_stop slotid 1, epid 1
xhci_ep_nuke_xfers(1, 1)
xhci: set epctx: 19e862020 state=3 dequeue=000000019e867091
5032@1486039061.092275:usb_xhci_ep_state slotid 1, epid 1, running -> stopped
5032@1486039061.092285:usb_xhci_queue_event v 0, idx 23, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c612120, s 01000000, c 0x01008401
5032@1486039061.092296:usb_xhci_irq_msix nr 0
5032@1486039061.092326:usb_xhci_fetch_trb addr 000000019c612130, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039061.092549:usb_xhci_runtime_write off 0x0038, val 0x9c657188
5032@1486039061.092570:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039061.092629:usb_xhci_oper_read off 0x0004, ret 0x00001008
5032@1486039061.092706:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039061.092727:usb_xhci_fetch_trb addr 000000019c612130, 
CR_SET_TR_DEQUEUE, p 000000019e867091, s 00000000, c 0x01014001
5032@1486039061.092738:usb_xhci_ep_set_dequeue slotid 1, epid 1, streamid 0, 
ptr 000000019e867091
xhci: set epctx: 19e862020 state=3 dequeue=000000019e867091
5032@1486039061.092758:usb_xhci_queue_event v 0, idx 24, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c612130, s 01000000, c 0x01008401
5032@1486039061.092769:usb_xhci_irq_msix nr 0
5032@1486039061.092792:usb_xhci_fetch_trb addr 000000019c612140, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039061.092882:usb_xhci_runtime_write off 0x0038, val 0x9c657198
5032@1486039061.092894:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039061.216885:usb_xhci_runtime_write off 0x0100, val 0x00000000
5032@1486039061.216959:usb_xhci_irq_msix_unuse nr 7
5032@1486039061.217103:usb_xhci_runtime_write off 0x0108, val 0x00000000
5032@1486039061.217211:usb_xhci_runtime_write off 0x0110, val 0x00000000
5032@1486039061.217222:usb_xhci_runtime_write off 0x0114, val 0x00000000
5032@1486039061.217319:usb_xhci_runtime_write off 0x0118, val 0x00000000
5032@1486039061.217331:usb_xhci_runtime_write off 0x011c, val 0x00000000
xhci: ERDP out of bounds: 0
xhci: ER[7] at 0 len 0
xhci: asserted controller error
5032@1486039061.217510:usb_xhci_oper_read off 0x0004, ret 0x00001008
5032@1486039061.217594:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039061.217615:usb_xhci_fetch_trb addr 000000019c612140, 
CR_DISABLE_SLOT, p 0000000000000000, s 00000000, c 0x01002801
5032@1486039061.217625:usb_xhci_slot_disable slotid 1
5032@1486039061.217632:usb_xhci_ep_disable slotid 1, epid 1
xhci_ep_nuke_xfers(1, 1)
xhci: set epctx: 19e862020 state=0 dequeue=000000019e867091
5032@1486039061.217668:usb_xhci_ep_state slotid 1, epid 1, stopped -> disabled
5032@1486039061.217680:usb_xhci_queue_event v 0, idx 25, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c612140, s 01000000, c 0x01008401
5032@1486039061.217716:usb_xhci_irq_msix nr 0
5032@1486039061.217745:usb_xhci_fetch_trb addr 000000019c612150, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039061.217919:usb_xhci_oper_read off 0x0004, ret 0x00001008
5032@1486039061.217989:usb_xhci_runtime_write off 0x0038, val 0x9c6571a8
5032@1486039061.218000:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039061.218042:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039061.218059:usb_xhci_fetch_trb addr 000000019c612150, 
CR_GET_PORT_BANDWIDTH, p 000000019c602000, s 00000000, c 0x00015401
xhci_get_port_bandwidth()
xhci: bandwidth context at 19c602000
5032@1486039061.218081:usb_xhci_queue_event v 0, idx 26, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c612150, s 01000000, c 0x00008401
5032@1486039061.218091:usb_xhci_irq_msix nr 0
5032@1486039061.218112:usb_xhci_fetch_trb addr 000000019c612160, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039061.218264:usb_xhci_oper_read off 0x0004, ret 0x00001008
5032@1486039061.218323:usb_xhci_runtime_write off 0x0038, val 0x9c6571b8
5032@1486039061.218332:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039061.218373:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039061.218389:usb_xhci_fetch_trb addr 000000019c612160, 
CR_GET_PORT_BANDWIDTH, p 000000019c602000, s 00000000, c 0x00025401
xhci_get_port_bandwidth()
xhci: bandwidth context at 19c602000
5032@1486039061.218410:usb_xhci_queue_event v 0, idx 27, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c612160, s 01000000, c 0x00008401
5032@1486039061.218419:usb_xhci_irq_msix nr 0
5032@1486039061.218437:usb_xhci_fetch_trb addr 000000019c612170, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039061.218521:usb_xhci_runtime_write off 0x0038, val 0x9c6571c8
5032@1486039061.218533:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039061.218601:usb_xhci_oper_read off 0x0004, ret 0x00001008
5032@1486039061.218658:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039061.218675:usb_xhci_fetch_trb addr 000000019c612170, 
CR_GET_PORT_BANDWIDTH, p 000000019c602000, s 00000000, c 0x00035401
xhci_get_port_bandwidth()
xhci: bandwidth context at 19c602000
5032@1486039061.218695:usb_xhci_queue_event v 0, idx 28, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c612170, s 01000000, c 0x00008401
5032@1486039061.218704:usb_xhci_irq_msix nr 0
5032@1486039061.218725:usb_xhci_fetch_trb addr 000000019c612180, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039061.218869:usb_xhci_runtime_write off 0x0038, val 0x9c6571d8
5032@1486039061.218970:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039061.219026:usb_xhci_oper_read off 0x0004, ret 0x00001008
5032@1486039061.219089:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039061.219106:usb_xhci_fetch_trb addr 000000019c612180, 
CR_GET_PORT_BANDWIDTH, p 000000019c602000, s 00000000, c 0x00045401
xhci_get_port_bandwidth()
xhci: bandwidth context at 19c602000
5032@1486039061.219127:usb_xhci_queue_event v 0, idx 29, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c612180, s 01000000, c 0x00008401
5032@1486039061.219136:usb_xhci_irq_msix nr 0
5032@1486039061.219158:usb_xhci_fetch_trb addr 000000019c612190, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039061.219369:usb_xhci_runtime_write off 0x0038, val 0x9c6571e8
5032@1486039061.219392:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039061.219463:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039061.219522:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039061.219575:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039061.219636:usb_xhci_port_write port 5, off 0x0000, val 0x00000a11
5032@1486039061.219645:usb_xhci_port_reset port 5, warm 0
5032@1486039061.219704:usb_xhci_port_link port 5, pls 0
5032@1486039061.219713:usb_xhci_port_notify port 5, bits 200000
5032@1486039061.219739:usb_xhci_queue_event v 0, idx 30, ER_PORT_STATUS_CHANGE, 
CC_SUCCESS, p 0000000005000000, s 01000000, c 0x00008801
5032@1486039061.219756:usb_xhci_irq_msix nr 0
5032@1486039061.219873:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039061.219946:usb_xhci_runtime_write off 0x0038, val 0x9c6571f8
5032@1486039061.219957:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039061.219998:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039061.220056:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039061.220145:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039061.220204:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039061.220336:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039061.220392:usb_xhci_port_read port 5, off 0x0000, ret 0x00200a03
5032@1486039061.220445:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039061.220499:usb_xhci_port_write port 5, off 0x0000, val 0x00200a01
5032@1486039061.220551:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039061.220603:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039061.220654:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039061.220889:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039061.220955:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039061.263731:usb_xhci_port_read port 5, off 0x0000, ret 0x00000a03
5032@1486039061.263889:usb_xhci_port_read port 5, off 0x0004, ret 0x00000000
5032@1486039061.264239:usb_xhci_oper_read off 0x0004, ret 0x00001008
5032@1486039061.264319:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039061.264341:usb_xhci_fetch_trb addr 000000019c612190, 
CR_ENABLE_SLOT, p 0000000000000000, s 00000000, c 0x00002401
5032@1486039061.264351:usb_xhci_slot_enable slotid 1
5032@1486039061.264358:usb_xhci_queue_event v 0, idx 31, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c612190, s 01000000, c 0x01008401
5032@1486039061.264370:usb_xhci_irq_msix nr 0
5032@1486039061.264393:usb_xhci_fetch_trb addr 000000019c6121a0, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039061.264478:usb_xhci_runtime_write off 0x0038, val 0x9c657208
5032@1486039061.264490:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039061.264597:usb_xhci_runtime_write off 0x0108, val 0x00000001
5032@1486039061.264659:usb_xhci_runtime_write off 0x0118, val 0x9e86a008
5032@1486039061.264668:usb_xhci_runtime_write off 0x011c, val 0x00000001
xhci: ERDP out of bounds: 19e86a000
xhci: ER[7] at 0 len 0
xhci: asserted controller error
5032@1486039061.264742:usb_xhci_runtime_write off 0x0110, val 0x9c61e070
5032@1486039061.264751:usb_xhci_runtime_write off 0x0114, val 0x00000001
xhci: event ring[7]:19e86a000 [256]
5032@1486039061.264815:usb_xhci_runtime_write off 0x0104, val 0x00000fa0
5032@1486039061.264916:usb_xhci_runtime_write off 0x0100, val 0x00000002
5032@1486039061.264927:usb_xhci_irq_msix_use nr 7
5032@1486039061.264995:usb_xhci_runtime_read off 0x0104, ret 0x00000fa0
5032@1486039061.265089:usb_xhci_oper_read off 0x0004, ret 0x00001008
5032@1486039061.265151:usb_xhci_doorbell_write off 0x0000, val 0x00000000
xhci_process_commands()
5032@1486039061.265168:usb_xhci_fetch_trb addr 000000019c6121a0, 
CR_ADDRESS_DEVICE, p 000000019e869000, s 00000000, c 0x01002e01
xhci: input context at 19e869000
xhci: output context at 19e868000
xhci: input slot context: 08200000 00050000 00000000 00000000
xhci: input ep0 context: 00000000 00080026 9e86d001 00000001 00001000
5032@1486039061.265208:usb_xhci_slot_address slotid 1, port 1
5032@1486039061.265258:usb_xhci_ep_enable slotid 1, epid 1
xhci: endpoint 0.1 type is 4, max transaction (burst) size is 8
xhci: output slot context: 08200000 00050000 00000000 08000000
xhci: output ep0 context: 00000001 00080026 9e86d001 00000001 00001000
5032@1486039061.265306:usb_xhci_queue_event v 0, idx 32, ER_COMMAND_COMPLETE, 
CC_SUCCESS, p 000000019c6121a0, s 01000000, c 0x01008401
5032@1486039061.265336:usb_xhci_irq_msix nr 0
5032@1486039061.265361:usb_xhci_fetch_trb addr 000000019c6121b0, TRB_RESERVED, 
p 0000000000000000, s 00000000, c 0x00000000
5032@1486039061.265511:usb_xhci_runtime_write off 0x0038, val 0x9c657218
5032@1486039061.265524:usb_xhci_runtime_write off 0x003c, val 0x00000001
5032@1486039061.265570:usb_xhci_doorbell_write off 0x0004, val 0x00000001
5032@1486039061.265579:usb_xhci_ep_kick slotid 1, epid 1, streamid 0
xhci: set epctx: 19e868020 state=1 dequeue=000000019e86d001
5032@1486039061.265604:usb_xhci_fetch_trb addr 000000019e86d000, TR_SETUP, p 
0040000001000680, s 01c00008, c 0x00000841
5032@1486039061.265613:usb_xhci_fetch_trb addr 000000019e86d010, TR_DATA, p 
000000019e86c000, s 01c00040, c 0x00010c25
5032@1486039061.265621:usb_xhci_fetch_trb addr 000000019e86d020, TR_STATUS, p 
0000000000000000, s 01c00000, c 0x00001021
5032@1486039061.265629:usb_xhci_xfer_start 0x56429708c7a8: slotid 1, epid 1, 
streamid 0
xhci: setup packet pid 0x69 addr 0 ep 0
5032@1486039061.265686:usb_xhci_xfer_async 0x56429708c7a8
5032@1486039061.796605:usb_xhci_xfer_success 0x56429708c7a8: len 18
5032@1486039061.796629:usb_xhci_queue_event v 7, idx 0, ER_TRANSFER, 
CC_SHORT_PACKET, p 000000019e86d010, s 0d00002e, c 0x01018001
5032@1486039061.796640:usb_xhci_irq_msix nr 7
5032@1486039061.796661:usb_xhci_queue_event v 7, idx 1, ER_TRANSFER, 
CC_SUCCESS, p 000000019e86d020, s 01000000, c 0x01018001
5032@1486039061.796668:usb_xhci_irq_msix nr 7
5032@1486039061.796678:usb_xhci_ep_kick slotid 1, epid 1, streamid 0
xhci: set epctx: 19e868020 state=1 dequeue=000000019e86d031
5032@1486039061.796865:usb_xhci_runtime_write off 0x0118, val 0x9e86a028
5032@1486039061.796877:usb_xhci_runtime_write off 0x011c, val 0x00000001
qemu-system-x86_64: hw/usb/hcd-xhci.c:903: xhci_events_update: Assertion 
`intr->er_full' failed.
/root/qemu.sh: line 70:  5032 Aborted                 (core dumped) 
LD_PRELOAD=libkeepalive.so KEEPIDLE=20 KEEPINTVL=5 KEEPCNT=3 
/root/src/qemu-xen/x86_64-softmmu/qemu-system-x86_64 -trace events=/tmp/events 
"${options[@]}"
/root/qemu.sh: line 71: wait: %2: no such job
==== QEMU EXITED
==== HUP
==== VGPU EXITED
==== CHILD 5020