1566277272.524088 usb_event_thread#0@0: sc 0xffff8e7121d7f368 woke up
1566277272.524088 usb_discover#1@0: called!
1566277272.524089 usb_event_thread#0@1: sc 0xffff8e7121d7f7c8 woke up
1566277272.524089 usb_discover#2@1: called!
1566277272.524089 usb_event_thread#0@0: sc 0xffff8e7121d32e68 woke up
1566277272.524090 usb_discover#3@0: called!
1566277272.534097 usb_event_thread#0@1: sc 0xffff8e7121d350a0 woke up
1566277272.534097 usb_discover#4@1: called!
1566277272.534098 usb_event_thread#0@1: sc 0xffff8e7121d353c0 woke up
1566277272.534098 usb_discover#5@1: called!
1566277278.448256 usb_event_thread#0@0: sc 0xffff8e7121d35370 woke up
1566277278.448256 usb_discover#6@0: called!
1566277319.821117 xhci_intr#1@0: called!
1566277319.821117 xhci_intr1#1@0: called!
1566277319.821118 usb_schedsoftintr#1@0: called!
1566277319.821125 usb_schedsoftintr#1@0: polling=0
1566277319.821126 xhci_softintr#1@0: called!
1566277319.821127 xhci_handle_event#1@0: called!
1566277319.821127 xhci_rhpsc#1@0: called!
1566277319.821127 xhci_rhpsc#1@0: xhci3: port 4 status change
1566277319.821127 xhci_rhpsc#1@0: xhci3: bus 1 bp 4 xfer 0xffff8e6a41abf038 status change
1566277319.821128 usb_transfer_complete#1@0: called!
1566277319.821128 usb_transfer_complete#1@0: pipe = 0xffff8e6a4192ddc8 xfer = 0xffff8e6a41abf038 status = 0 actlen = 1
1566277319.821128 usb_transfer_complete#1@0: xfer 0xffff8e6a41abf038: repeat 1 new head = 0xffff8e6a41abf038
1566277319.821128 usb_transfer_complete#1@0: xfer 0xffff8e6a41abf038 doing done 0xffffffff80694941
1566277319.821128 xhci_root_intr_done#1@0: called!
1566277319.821128 usb_transfer_complete#1@0: xfer 0xffff8e6a41abf038 doing callback 0xffffffff8048e8a4 status 0
1566277319.821129 uhub_intr#2@0: called!
1566277319.821129 uhub_intr#2@0: uhub7
1566277319.821129 uhub_intr#2@0: uhub7: explore pending 0
1566277319.821129 uhub_intr#2@0: uhub7: pending/new ports [0] 0x10/0x10
1566277319.821129 uhub_intr#2@0: uhub7: exploring ports [0] 0x10
1566277319.821129 usb_needs_explore#1@0: called!
1566277319.821130 usbd_start_next#1@0: called!
1566277319.821130 usbd_start_next#1@0: pipe = 0xffff8e6a4192ddc8, xfer = 0xffff8e6a41abf038
1566277319.821130 xhci_root_intr_start#1@0: called!
1566277319.821133 usb_event_thread#0@1: sc 0xffff8e7121d350a0 woke up
1566277319.821133 usb_discover#7@1: called!
1566277319.821134 uhub_explore#8@1: called!
1566277319.821134 uhub_explore#8@1: uhub7 dev=0xffff8e6a41ac1828 addr=0 speed=3
1566277319.821134 usbd_get_port_status#1@1: called!
1566277319.821134 usbd_get_port_status#1@1: dev 0xffff8e6a41ac1828 port 4
1566277319.821135 usbd_do_request_flags#1@1: called!
1566277319.821135 usbd_alloc_xfer#1@1: called!
1566277319.821135 xhci_allocx#1@1: called!
1566277319.821136 usbd_alloc_xfer#1@1: returns 0xffff8e6a41abf2a0
1566277319.821136 usb_allocmem_flags#1@1: called!
1566277319.821136 usb_allocmem_flags#1@1: use frag=0xffff9802352e8bc0 size=4
1566277319.821137 usbd_transfer#1@1: called!
1566277319.821137 usbd_transfer#1@1: xfer = 0xffff8e6a41abf2a0, flags = 0x2, pipe = 0xffff8e6a4192dd08, running = 0
1566277319.821137 usbd_dump_queue#1@1: called!
1566277319.821137 usbd_dump_queue#1@1: pipe = 0xffff8e6a4192dd08
1566277319.821137 usb_insert_transfer#1@1: called!
1566277319.821137 usb_insert_transfer#1@1: xfer = 0xffff8e6a41abf2a0 pipe = 0xffff8e6a4192dd08 running = 0 timeout = 5000
1566277319.821137 usb_insert_transfer#1@1: <- done xfer 0xffff8e6a41abf2a0, err 0
1566277319.821138 roothub_ctrl_start#1@1: called!
1566277319.821138 roothub_ctrl_start#1@1: type=0xa3 request= 0
1566277319.821138 xhci_roothub_ctrl#1@1: called!
1566277319.821138 xhci_roothub_ctrl#1@1: get port status bn=1 i=4 cp=4
1566277319.821139 xhci_roothub_ctrl#1@1: getrhportsc 4 000202a1
1566277319.821140 roothub_ctrl_start#1@1: xfer 0xffff8e6a41abf2a0 buflen -1 actlen 4
1566277319.821140 roothub_ctrl_start#1@1: xfer 0xffff8e6a41abf2a0 err 0
1566277319.821140 usb_transfer_complete#2@1: called!
1566277319.821140 usb_transfer_complete#2@1: pipe = 0xffff8e6a4192dd08 xfer = 0xffff8e6a41abf2a0 status = 0 actlen = 4
1566277319.821140 usb_transfer_complete#2@1: xfer 0xffff8e6a41abf2a0: repeat 0 new head = 0
1566277319.821140 usb_transfer_complete#2@1: xfer 0xffff8e6a41abf2a0 doing done 0xffffffff806700c6
1566277319.821140 usb_transfer_complete#2@1: xfer 0xffff8e6a41abf2a0 doing callback 0 status 0
1566277319.821140 usb_transfer_complete#2@1: <- done xfer 0xffff8e6a41abf2a0, wakeup
1566277319.821140 usbd_start_next#2@1: called!
1566277319.821141 usbd_start_next#2@1: pipe = 0xffff8e6a4192dd08, xfer = 0
1566277319.821141 usbd_transfer#1@1: <- done transfer 0xffff8e6a41abf2a0, err = 0
1566277319.821141 usbd_transfer#1@1: <- done xfer 0xffff8e6a41abf2a0, sync (err 0)(complete/error)
1566277319.821141 usbd_free_xfer#1@1: called!
1566277319.821141 usbd_free_xfer#1@1: 0xffff8e6a41abf2a0
1566277319.821141 usb_freemem#1@1: called!
1566277319.821141 usb_freemem#1@1: frag=0xffff9802352e8bc0
1566277319.821142 xhci_freex#1@1: called!
1566277319.821142 uhub_explore#8@1: uhub7 port 4: s/c=101/1
1566277319.821143 uhub_explore#8@1: uhub7 status change port 4
1566277319.821143 usbd_clear_port_feature#1@1: called!
1566277319.821143 usbd_clear_port_feature#1@1: dev 0xffff8e6a41ac1828 port 4 sel 16
1566277319.821143 usbd_do_request_flags#2@1: called!
1566277319.821143 usbd_alloc_xfer#2@1: called!
1566277319.821143 xhci_allocx#2@1: called!
1566277319.821143 usbd_alloc_xfer#2@1: returns 0xffff8e6a41abf2a0
1566277319.821143 usbd_transfer#2@1: called!
1566277319.821143 usbd_transfer#2@1: xfer = 0xffff8e6a41abf2a0, flags = 0x2, pipe = 0xffff8e6a4192dd08, running = 0
1566277319.821144 usbd_dump_queue#2@1: called!
1566277319.821144 usbd_dump_queue#2@1: pipe = 0xffff8e6a4192dd08
1566277319.821144 usb_insert_transfer#2@1: called!
1566277319.821144 usb_insert_transfer#2@1: xfer = 0xffff8e6a41abf2a0 pipe = 0xffff8e6a4192dd08 running = 0 timeout = 5000
1566277319.821144 usb_insert_transfer#2@1: <- done xfer 0xffff8e6a41abf2a0, err 0
1566277319.821144 roothub_ctrl_start#2@1: called!
1566277319.821144 roothub_ctrl_start#2@1: type=0x23 request=0x1
1566277319.821144 xhci_roothub_ctrl#2@1: called!
1566277319.821144 xhci_roothub_ctrl#2@1: UR_CLEAR_PORT_FEAT bp=4 feat=16 bus=1 cp=4
1566277319.821144 xhci_roothub_ctrl#2@1: portsc=0x000206e1
1566277319.821145 roothub_ctrl_start#2@1: xfer 0xffff8e6a41abf2a0 buflen -1 actlen 0
1566277319.821146 roothub_ctrl_start#2@1: xfer 0xffff8e6a41abf2a0 err 0
1566277319.821146 usb_transfer_complete#3@1: called!
1566277319.821146 usb_transfer_complete#3@1: pipe = 0xffff8e6a4192dd08 xfer = 0xffff8e6a41abf2a0 status = 0 actlen = 0
1566277319.821146 usb_transfer_complete#3@1: xfer 0xffff8e6a41abf2a0: repeat 0 new head = 0
1566277319.821146 usb_transfer_complete#3@1: xfer 0xffff8e6a41abf2a0 doing done 0xffffffff806700c6
1566277319.821146 usb_transfer_complete#3@1: xfer 0xffff8e6a41abf2a0 doing callback 0 status 0
1566277319.821146 usb_transfer_complete#3@1: <- done xfer 0xffff8e6a41abf2a0, wakeup
1566277319.821146 usbd_start_next#3@1: called!
1566277319.821146 usbd_start_next#3@1: pipe = 0xffff8e6a4192dd08, xfer = 0
1566277319.821146 usbd_transfer#2@1: <- done transfer 0xffff8e6a41abf2a0, err = 0
1566277319.821146 usbd_transfer#2@1: <- done xfer 0xffff8e6a41abf2a0, sync (err 0)(complete/error)
1566277319.821146 usbd_free_xfer#2@1: called!
1566277319.821146 usbd_free_xfer#2@1: 0xffff8e6a41abf2a0
1566277319.821147 xhci_freex#2@1: called!
1566277319.821147 uhub_explore#8@1: unit 7 dev->speed=3 dev->depth=0
1566277320.128363 usbd_reset_port#1@1: called!
1566277320.128363 usbd_do_request_flags#3@1: called!
1566277320.128363 usbd_alloc_xfer#3@1: called!
1566277320.128363 xhci_allocx#3@1: called!
1566277320.128363 usbd_alloc_xfer#3@1: returns 0xffff8e6a41abf2a0
1566277320.128363 usbd_transfer#3@1: called!
1566277320.128363 usbd_transfer#3@1: xfer = 0xffff8e6a41abf2a0, flags = 0x2, pipe = 0xffff8e6a4192dd08, running = 0
1566277320.128363 usbd_dump_queue#3@1: called!
1566277320.128363 usbd_dump_queue#3@1: pipe = 0xffff8e6a4192dd08
1566277320.128364 usb_insert_transfer#3@1: called!
1566277320.128364 usb_insert_transfer#3@1: xfer = 0xffff8e6a41abf2a0 pipe = 0xffff8e6a4192dd08 running = 0 timeout = 5000
1566277320.128364 usb_insert_transfer#3@1: <- done xfer 0xffff8e6a41abf2a0, err 0
1566277320.128364 roothub_ctrl_start#3@1: called!
1566277320.128364 roothub_ctrl_start#3@1: type=0x23 request=0x3
1566277320.128364 xhci_roothub_ctrl#3@1: called!
1566277320.128364 xhci_roothub_ctrl#3@1: index 4 cp 4 portsc=0x000006e1
1566277320.178600 xhci_intr#2@0: called!
1566277320.178600 xhci_intr1#2@0: called!
1566277320.178602 usb_schedsoftintr#2@0: called!
1566277320.178608 usb_schedsoftintr#2@0: polling=0
1566277320.178609 xhci_softintr#2@0: called!
1566277320.178610 xhci_handle_event#2@0: called!
1566277320.178610 xhci_rhpsc#2@0: called!
1566277320.178610 xhci_rhpsc#2@0: xhci3: port 4 status change
1566277320.178610 xhci_rhpsc#2@0: xhci3: bus 1 bp 4 xfer 0xffff8e6a41abf038 status change
1566277320.178610 usb_transfer_complete#4@0: called!
1566277320.178610 usb_transfer_complete#4@0: pipe = 0xffff8e6a4192ddc8 xfer = 0xffff8e6a41abf038 status = 0 actlen = 1
1566277320.178611 usb_transfer_complete#4@0: xfer 0xffff8e6a41abf038: repeat 1 new head = 0xffff8e6a41abf038
1566277320.178611 usb_transfer_complete#4@0: xfer 0xffff8e6a41abf038 doing done 0xffffffff80694941
1566277320.178611 xhci_root_intr_done#2@0: called!
1566277320.178611 usb_transfer_complete#4@0: xfer 0xffff8e6a41abf038 doing callback 0xffffffff8048e8a4 status 0
1566277320.178611 uhub_intr#3@0: called!
1566277320.178611 uhub_intr#3@0: uhub7
1566277320.178611 uhub_intr#3@0: uhub7: explore pending 1
1566277320.178611 uhub_intr#3@0: uhub7: pending/new ports [0] 0x10/0x10
1566277320.178612 usbd_start_next#4@0: called!
1566277320.178612 usbd_start_next#4@0: pipe = 0xffff8e6a4192ddc8, xfer = 0xffff8e6a41abf038
1566277320.178612 xhci_root_intr_start#2@0: called!
1566277320.388557 roothub_ctrl_start#3@1: xfer 0xffff8e6a41abf2a0 buflen -1 actlen 0
1566277320.388557 roothub_ctrl_start#3@1: xfer 0xffff8e6a41abf2a0 err 0
1566277320.388557 usb_transfer_complete#5@1: called!
1566277320.388557 usb_transfer_complete#5@1: pipe = 0xffff8e6a4192dd08 xfer = 0xffff8e6a41abf2a0 status = 0 actlen = 0
1566277320.388557 usb_transfer_complete#5@1: xfer 0xffff8e6a41abf2a0: repeat 0 new head = 0
1566277320.388557 usb_transfer_complete#5@1: xfer 0xffff8e6a41abf2a0 doing done 0xffffffff806700c6
1566277320.388558 usb_transfer_complete#5@1: xfer 0xffff8e6a41abf2a0 doing callback 0 status 0
1566277320.388558 usb_transfer_complete#5@1: <- done xfer 0xffff8e6a41abf2a0, wakeup
1566277320.388558 usbd_start_next#5@1: called!
1566277320.388558 usbd_start_next#5@1: pipe = 0xffff8e6a4192dd08, xfer = 0
1566277320.388558 usbd_transfer#3@1: <- done transfer 0xffff8e6a41abf2a0, err = 0
1566277320.388558 usbd_transfer#3@1: <- done xfer 0xffff8e6a41abf2a0, sync (err 0)(complete/error)
1566277320.388558 usbd_free_xfer#3@1: called!
1566277320.388558 usbd_free_xfer#3@1: 0xffff8e6a41abf2a0
1566277320.388558 xhci_freex#3@1: called!
1566277320.388559 usbd_reset_port#1@1: port 4 reset done, error=0
1566277320.448598 usbd_get_port_status#2@1: called!
1566277320.448598 usbd_get_port_status#2@1: dev 0xffff8e6a41ac1828 port 4
1566277320.448598 usbd_do_request_flags#4@1: called!
1566277320.448598 usbd_alloc_xfer#4@1: called!
1566277320.448598 xhci_allocx#4@1: called!
1566277320.448598 usbd_alloc_xfer#4@1: returns 0xffff8e6a41abf2a0
1566277320.448598 usb_allocmem_flags#2@1: called!
1566277320.448599 usb_allocmem_flags#2@1: use frag=0xffff9802352e8bc0 size=4
1566277320.448599 usbd_transfer#4@1: called!
1566277320.448599 usbd_transfer#4@1: xfer = 0xffff8e6a41abf2a0, flags = 0x2, pipe = 0xffff8e6a4192dd08, running = 0
1566277320.448599 usbd_dump_queue#4@1: called!
1566277320.448599 usbd_dump_queue#4@1: pipe = 0xffff8e6a4192dd08
1566277320.448599 usb_insert_transfer#4@1: called!
1566277320.448599 usb_insert_transfer#4@1: xfer = 0xffff8e6a41abf2a0 pipe = 0xffff8e6a4192dd08 running = 0 timeout = 5000
1566277320.448599 usb_insert_transfer#4@1: <- done xfer 0xffff8e6a41abf2a0, err 0
1566277320.448599 roothub_ctrl_start#4@1: called!
1566277320.448599 roothub_ctrl_start#4@1: type=0xa3 request= 0
1566277320.448600 xhci_roothub_ctrl#4@1: called!
1566277320.448600 xhci_roothub_ctrl#4@1: get port status bn=1 i=4 cp=4
1566277320.448600 xhci_roothub_ctrl#4@1: getrhportsc 4 002202a0
1566277320.448601 roothub_ctrl_start#4@1: xfer 0xffff8e6a41abf2a0 buflen -1 actlen 4
1566277320.448601 roothub_ctrl_start#4@1: xfer 0xffff8e6a41abf2a0 err 0
1566277320.448601 usb_transfer_complete#6@1: called!
1566277320.448601 usb_transfer_complete#6@1: pipe = 0xffff8e6a4192dd08 xfer = 0xffff8e6a41abf2a0 status = 0 actlen = 4
1566277320.448601 usb_transfer_complete#6@1: xfer 0xffff8e6a41abf2a0: repeat 0 new head = 0
1566277320.448601 usb_transfer_complete#6@1: xfer 0xffff8e6a41abf2a0 doing done 0xffffffff806700c6
1566277320.448601 usb_transfer_complete#6@1: xfer 0xffff8e6a41abf2a0 doing callback 0 status 0
1566277320.448601 usb_transfer_complete#6@1: <- done xfer 0xffff8e6a41abf2a0, wakeup
1566277320.448601 usbd_start_next#6@1: called!
1566277320.448601 usbd_start_next#6@1: pipe = 0xffff8e6a4192dd08, xfer = 0
1566277320.448601 usbd_transfer#4@1: <- done transfer 0xffff8e6a41abf2a0, err = 0
1566277320.448601 usbd_transfer#4@1: <- done xfer 0xffff8e6a41abf2a0, sync (err 0)(complete/error)
1566277320.448602 usbd_free_xfer#4@1: called!
1566277320.448602 usbd_free_xfer#4@1: 0xffff8e6a41abf2a0
1566277320.448602 usb_freemem#2@1: called!
1566277320.448602 usb_freemem#2@1: frag=0xffff9802352e8bc0
1566277320.448602 xhci_freex#4@1: called!
1566277320.448602 uhub_explore#8@1: uhub7 port 4 after reset: s/c=100/11
1566277320.448603 usb_needs_explore#2@1: called!
1566277320.448603 uhub_explore#9@1: called!
1566277320.448604 uhub_explore#9@1: uhub7 dev=0xffff8e6a41ac1828 addr=0 speed=3
1566277320.448604 usbd_get_port_status#3@1: called!
1566277320.448604 usbd_get_port_status#3@1: dev 0xffff8e6a41ac1828 port 4
1566277320.448604 usbd_do_request_flags#5@1: called!
1566277320.448604 usbd_alloc_xfer#5@1: called!
1566277320.448604 xhci_allocx#5@1: called!
1566277320.448604 usbd_alloc_xfer#5@1: returns 0xffff8e6a41abf2a0
1566277320.448604 usb_allocmem_flags#3@1: called!
1566277320.448604 usb_allocmem_flags#3@1: use frag=0xffff9802352e8bc0 size=4
1566277320.448604 usbd_transfer#5@1: called!
1566277320.448604 usbd_transfer#5@1: xfer = 0xffff8e6a41abf2a0, flags = 0x2, pipe = 0xffff8e6a4192dd08, running = 0
1566277320.448604 usbd_dump_queue#5@1: called!
1566277320.448604 usbd_dump_queue#5@1: pipe = 0xffff8e6a4192dd08
1566277320.448605 usb_insert_transfer#5@1: called!
1566277320.448605 usb_insert_transfer#5@1: xfer = 0xffff8e6a41abf2a0 pipe = 0xffff8e6a4192dd08 running = 0 timeout = 5000
1566277320.448605 usb_insert_transfer#5@1: <- done xfer 0xffff8e6a41abf2a0, err 0
1566277320.448605 roothub_ctrl_start#5@1: called!
1566277320.448605 roothub_ctrl_start#5@1: type=0xa3 request= 0
1566277320.448605 xhci_roothub_ctrl#5@1: called!
1566277320.448605 xhci_roothub_ctrl#5@1: get port status bn=1 i=4 cp=4
1566277320.448605 xhci_roothub_ctrl#5@1: getrhportsc 4 002202a0
1566277320.448606 roothub_ctrl_start#5@1: xfer 0xffff8e6a41abf2a0 buflen -1 actlen 4
1566277320.448606 roothub_ctrl_start#5@1: xfer 0xffff8e6a41abf2a0 err 0
1566277320.448606 usb_transfer_complete#7@1: called!
1566277320.448606 usb_transfer_complete#7@1: pipe = 0xffff8e6a4192dd08 xfer = 0xffff8e6a41abf2a0 status = 0 actlen = 4
1566277320.448606 usb_transfer_complete#7@1: xfer 0xffff8e6a41abf2a0: repeat 0 new head = 0
1566277320.448606 usb_transfer_complete#7@1: xfer 0xffff8e6a41abf2a0 doing done 0xffffffff806700c6
1566277320.448606 usb_transfer_complete#7@1: xfer 0xffff8e6a41abf2a0 doing callback 0 status 0
1566277320.448606 usb_transfer_complete#7@1: <- done xfer 0xffff8e6a41abf2a0, wakeup
1566277320.448606 usbd_start_next#7@1: called!
1566277320.448606 usbd_start_next#7@1: pipe = 0xffff8e6a4192dd08, xfer = 0
1566277320.448607 usbd_transfer#5@1: <- done transfer 0xffff8e6a41abf2a0, err = 0
1566277320.448607 usbd_transfer#5@1: <- done xfer 0xffff8e6a41abf2a0, sync (err 0)(complete/error)
1566277320.448607 usbd_free_xfer#5@1: called!
1566277320.448607 usbd_free_xfer#5@1: 0xffff8e6a41abf2a0
1566277320.448607 usb_freemem#3@1: called!
1566277320.448607 usb_freemem#3@1: frag=0xffff9802352e8bc0
1566277320.448607 xhci_freex#5@1: called!
1566277320.448607 uhub_explore#9@1: uhub7 port 4: s/c=100/11
1566277320.448607 usbd_clear_port_feature#2@1: called!
1566277320.448607 usbd_clear_port_feature#2@1: dev 0xffff8e6a41ac1828 port 4 sel 20
1566277320.448607 usbd_do_request_flags#6@1: called!
1566277320.448608 usbd_alloc_xfer#6@1: called!
1566277320.448608 xhci_allocx#6@1: called!
1566277320.448608 usbd_alloc_xfer#6@1: returns 0xffff8e6a41abf2a0
1566277320.448608 usbd_transfer#6@1: called!
1566277320.448608 usbd_transfer#6@1: xfer = 0xffff8e6a41abf2a0, flags = 0x2, pipe = 0xffff8e6a4192dd08, running = 0
1566277320.448608 usbd_dump_queue#6@1: called!
1566277320.448608 usbd_dump_queue#6@1: pipe = 0xffff8e6a4192dd08
1566277320.448608 usb_insert_transfer#6@1: called!
1566277320.448608 usb_insert_transfer#6@1: xfer = 0xffff8e6a41abf2a0 pipe = 0xffff8e6a4192dd08 running = 0 timeout = 5000
1566277320.448608 usb_insert_transfer#6@1: <- done xfer 0xffff8e6a41abf2a0, err 0
1566277320.448608 roothub_ctrl_start#6@1: called!
1566277320.448608 roothub_ctrl_start#6@1: type=0x23 request=0x1
1566277320.448608 xhci_roothub_ctrl#6@1: called!
1566277320.448608 xhci_roothub_ctrl#6@1: UR_CLEAR_PORT_FEAT bp=4 feat=20 bus=1 cp=4
1566277320.448609 xhci_roothub_ctrl#6@1: portsc=0x002202a0
1566277320.448609 roothub_ctrl_start#6@1: xfer 0xffff8e6a41abf2a0 buflen -1 actlen 0
1566277320.448610 roothub_ctrl_start#6@1: xfer 0xffff8e6a41abf2a0 err 0
1566277320.448610 usb_transfer_complete#8@1: called!
1566277320.448610 usb_transfer_complete#8@1: pipe = 0xffff8e6a4192dd08 xfer = 0xffff8e6a41abf2a0 status = 0 actlen = 0
1566277320.448610 usb_transfer_complete#8@1: xfer 0xffff8e6a41abf2a0: repeat 0 new head = 0
1566277320.448610 usb_transfer_complete#8@1: xfer 0xffff8e6a41abf2a0 doing done 0xffffffff806700c6
1566277320.448610 usb_transfer_complete#8@1: xfer 0xffff8e6a41abf2a0 doing callback 0 status 0
1566277320.448610 usb_transfer_complete#8@1: <- done xfer 0xffff8e6a41abf2a0, wakeup
1566277320.448610 usbd_start_next#8@1: called!
1566277320.448610 usbd_start_next#8@1: pipe = 0xffff8e6a4192dd08, xfer = 0
1566277320.448611 usbd_transfer#6@1: <- done transfer 0xffff8e6a41abf2a0, err = 0
1566277320.448611 usbd_transfer#6@1: <- done xfer 0xffff8e6a41abf2a0, sync (err 0)(complete/error)
1566277320.448611 usbd_free_xfer#6@1: called!
1566277320.448611 usbd_free_xfer#6@1: 0xffff8e6a41abf2a0
1566277320.448611 xhci_freex#6@1: called!
1566277320.448611 uhub_explore#9@1: uhub7 status change port 4
1566277320.448611 usbd_clear_port_feature#3@1: called!
1566277320.448611 usbd_clear_port_feature#3@1: dev 0xffff8e6a41ac1828 port 4 sel 16
1566277320.448611 usbd_do_request_flags#7@1: called!
1566277320.448611 usbd_alloc_xfer#7@1: called!
1566277320.448611 xhci_allocx#7@1: called!
1566277320.448611 usbd_alloc_xfer#7@1: returns 0xffff8e6a41abf2a0
1566277320.448611 usbd_transfer#7@1: called!
1566277320.448611 usbd_transfer#7@1: xfer = 0xffff8e6a41abf2a0, flags = 0x2, pipe = 0xffff8e6a4192dd08, running = 0
1566277320.448612 usbd_dump_queue#7@1: called!
1566277320.448612 usbd_dump_queue#7@1: pipe = 0xffff8e6a4192dd08
1566277320.448612 usb_insert_transfer#7@1: called!
1566277320.448612 usb_insert_transfer#7@1: xfer = 0xffff8e6a41abf2a0 pipe = 0xffff8e6a4192dd08 running = 0 timeout = 5000
1566277320.448612 usb_insert_transfer#7@1: <- done xfer 0xffff8e6a41abf2a0, err 0
1566277320.448612 roothub_ctrl_start#7@1: called!
1566277320.448612 roothub_ctrl_start#7@1: type=0x23 request=0x1
1566277320.448612 xhci_roothub_ctrl#7@1: called!
1566277320.448612 xhci_roothub_ctrl#7@1: UR_CLEAR_PORT_FEAT bp=4 feat=16 bus=1 cp=4
1566277320.448612 xhci_roothub_ctrl#7@1: portsc=0x000202a0
1566277320.448613 roothub_ctrl_start#7@1: xfer 0xffff8e6a41abf2a0 buflen -1 actlen 0
1566277320.448614 roothub_ctrl_start#7@1: xfer 0xffff8e6a41abf2a0 err 0
1566277320.448614 usb_transfer_complete#9@1: called!
1566277320.448614 usb_transfer_complete#9@1: pipe = 0xffff8e6a4192dd08 xfer = 0xffff8e6a41abf2a0 status = 0 actlen = 0
1566277320.448614 usb_transfer_complete#9@1: xfer 0xffff8e6a41abf2a0: repeat 0 new head = 0
1566277320.448614 usb_transfer_complete#9@1: xfer 0xffff8e6a41abf2a0 doing done 0xffffffff806700c6
1566277320.448614 usb_transfer_complete#9@1: xfer 0xffff8e6a41abf2a0 doing callback 0 status 0
1566277320.448614 usb_transfer_complete#9@1: <- done xfer 0xffff8e6a41abf2a0, wakeup
1566277320.448614 usbd_start_next#9@1: called!
1566277320.448614 usbd_start_next#9@1: pipe = 0xffff8e6a4192dd08, xfer = 0
1566277320.448614 usbd_transfer#7@1: <- done transfer 0xffff8e6a41abf2a0, err = 0
1566277320.448614 usbd_transfer#7@1: <- done xfer 0xffff8e6a41abf2a0, sync (err 0)(complete/error)
1566277320.448614 usbd_free_xfer#7@1: called!
1566277320.448614 usbd_free_xfer#7@1: 0xffff8e6a41abf2a0
1566277320.448614 xhci_freex#7@1: called!
1566277320.448614 uhub_explore#9@1: uhub7 port 4 !CURRENT_CONNECT_STATUS
1566277320.448615 usb_disconnect_port#1@1: called!
1566277320.448615 usb_disconnect_port#1@1: up=0xffff8e6a41ac19b8 dev=0 port=4
1566277320.448615 usbd_clear_port_feature#4@1: called!
1566277320.448615 usbd_clear_port_feature#4@1: dev 0xffff8e6a41ac1828 port 4 sel 16
1566277320.448615 usbd_do_request_flags#8@1: called!
1566277320.448615 usbd_alloc_xfer#8@1: called!
1566277320.448615 xhci_allocx#8@1: called!
1566277320.448615 usbd_alloc_xfer#8@1: returns 0xffff8e6a41abf2a0
1566277320.448615 usbd_transfer#8@1: called!
1566277320.448615 usbd_transfer#8@1: xfer = 0xffff8e6a41abf2a0, flags = 0x2, pipe = 0xffff8e6a4192dd08, running = 0
1566277320.448615 usbd_dump_queue#8@1: called!
1566277320.448615 usbd_dump_queue#8@1: pipe = 0xffff8e6a4192dd08
1566277320.448615 usb_insert_transfer#8@1: called!
1566277320.448616 usb_insert_transfer#8@1: xfer = 0xffff8e6a41abf2a0 pipe = 0xffff8e6a4192dd08 running = 0 timeout = 5000
1566277320.448616 usb_insert_transfer#8@1: <- done xfer 0xffff8e6a41abf2a0, err 0
1566277320.448616 roothub_ctrl_start#8@1: called!
1566277320.448616 roothub_ctrl_start#8@1: type=0x23 request=0x1
1566277320.448616 xhci_roothub_ctrl#8@1: called!
1566277320.448616 xhci_roothub_ctrl#8@1: UR_CLEAR_PORT_FEAT bp=4 feat=16 bus=1 cp=4
1566277320.448616 xhci_roothub_ctrl#8@1: portsc=0x000002a0
1566277320.448676 roothub_ctrl_start#8@1: xfer 0xffff8e6a41abf2a0 buflen -1 actlen 0
1566277320.448676 roothub_ctrl_start#8@1: xfer 0xffff8e6a41abf2a0 err 0
1566277320.448676 usb_transfer_complete#10@1: called!
1566277320.448676 usb_transfer_complete#10@1: pipe = 0xffff8e6a4192dd08 xfer = 0xffff8e6a41abf2a0 status = 0 actlen = 0
1566277320.448676 usb_transfer_complete#10@1: xfer 0xffff8e6a41abf2a0: repeat 0 new head = 0
1566277320.448676 usb_transfer_complete#10@1: xfer 0xffff8e6a41abf2a0 doing done 0xffffffff806700c6
1566277320.448676 usb_transfer_complete#10@1: xfer 0xffff8e6a41abf2a0 doing callback 0 status 0
1566277320.448677 usb_transfer_complete#10@1: <- done xfer 0xffff8e6a41abf2a0, wakeup
1566277320.448677 usbd_start_next#10@1: called!
1566277320.448677 usbd_start_next#10@1: pipe = 0xffff8e6a4192dd08, xfer = 0
1566277320.448677 usbd_transfer#8@1: <- done transfer 0xffff8e6a41abf2a0, err = 0
1566277320.448677 usbd_transfer#8@1: <- done xfer 0xffff8e6a41abf2a0, sync (err 0)(complete/error)
1566277320.448677 usbd_free_xfer#8@1: called!
1566277320.448677 usbd_free_xfer#8@1: 0xffff8e6a41abf2a0
1566277320.448677 xhci_freex#8@1: called!
1566277332.567228 usb_event_thread#0@0: sc 0xffff8e7121d7f368 woke up
1566277332.567228 usb_discover#8@0: called!
1566277332.567229 usb_event_thread#0@0: sc 0xffff8e7121d32e68 woke up
1566277332.567229 usb_discover#9@0: called!
1