1464911348.122519 ehci_intr#1@2: called! 1464911348.122520 ehci_intr1#1@2: called! 1464911348.122521 ehci_intr1#1@2: sc=0x919d7008 intrs=0xc(0xc08c) eintrs=0x4 1464911348.122524 ehci_pcd#1@2: called! 1464911348.122526 usb_transfer_complete#1@2: called! 1464911348.122526 usb_transfer_complete#1@2: pipe = 0x9156d2e0 xfer = 0x919edea0 status = 0 actlen = 1 1464911348.122527 usb_transfer_complete#1@2: xfer 0x919edea0: repeat 1 new head = 0x919edea0 1464911348.122527 usb_transfer_complete#1@2: xfer 0x919edea0 doing done 0x810fa5e8 1464911348.122528 usb_transfer_complete#1@2: xfer 0x919edea0 doing callback 0x81066ed0 status 0 1464911348.122530 usb_needs_explore#1@2: called! 1464911348.122533 usbd_start_next#1@2: called! 1464911348.122533 usbd_start_next#1@2: pipe = 0x9156d2e0, xfer = 0x919edea0 1464911348.122536 usb_event_thread#0@3: sc 0x915ac938 woke up 1464911348.122536 usb_discover#1@3: called! 1464911348.122538 usbd_get_port_status#1@3: called! 1464911348.122539 usbd_get_port_status#1@3: dev 0x919d95f8 port 1 1464911348.122539 usbd_do_request_flags#1@3: called! 1464911348.122540 usbd_alloc_xfer#1@3: called! 1464911348.122541 usbd_alloc_xfer#1@3: returns 0x919edce0 1464911348.122542 usb_allocmem_flags#1@3: called! 1464911348.122544 usb_allocmem_flags#1@3: use frag=0x9bbecf40 size=4 1464911348.122545 usbd_transfer#1@3: called! 1464911348.122545 usbd_transfer#1@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911348.122546 usb_insert_transfer#1@3: called! 1464911348.122546 usb_insert_transfer#1@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911348.122546 usb_insert_transfer#1@3: <- done xfer 0x919edce0, err 0 1464911348.122547 roothub_ctrl_start#1@3: called! 1464911348.122548 roothub_ctrl_start#1@3: type=0xa3 request= 0 1464911348.122549 ehci_roothub_ctrl#1@3: called! 1464911348.122549 ehci_roothub_ctrl#1@3: type=0xa3 request=00 1464911348.122549 ehci_roothub_ctrl#1@3: get port status i=1 1464911348.122550 ehci_roothub_ctrl#1@3: port status=0x1803 1464911348.122552 ehci_roothub_ctrl#1@3: returning 4 1464911348.122552 roothub_ctrl_start#1@3: xfer 0x919edce0 buflen -1 actlen 4 1464911348.122552 roothub_ctrl_start#1@3: xfer 0x919edce0 err 0 1464911348.122553 usb_transfer_complete#2@3: called! 1464911348.122553 usb_transfer_complete#2@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911348.122553 usb_transfer_complete#2@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911348.122553 usb_transfer_complete#2@3: xfer 0x919edce0 doing done 0x810f9b24 1464911348.122554 usb_transfer_complete#2@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911348.122554 usb_transfer_complete#2@3: <- done xfer 0x919edce0, wakeup 1464911348.122554 usbd_start_next#2@3: called! 1464911348.122554 usbd_start_next#2@3: pipe = 0x9156d3c0, xfer = 0x0 1464911348.122555 usbd_transfer#1@3: <- done transfer 0x919edce0, err = 0 1464911348.122555 usbd_transfer#1@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911348.122556 usbd_free_xfer#1@3: called! 1464911348.122556 usbd_free_xfer#1@3: 0x919edce0 1464911348.122557 usb_freemem#1@3: called! 1464911348.122558 usb_freemem#1@3: frag=0x9bbecf40 1464911348.122559 usbd_clear_port_feature#1@3: called! 1464911348.122560 usbd_clear_port_feature#1@3: dev 0x919d95f8 port 1 sel 16 1464911348.122560 usbd_do_request_flags#2@3: called! 1464911348.122560 usbd_alloc_xfer#2@3: called! 1464911348.122561 usbd_alloc_xfer#2@3: returns 0x919edce0 1464911348.122561 usbd_transfer#2@3: called! 1464911348.122561 usbd_transfer#2@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911348.122561 usb_insert_transfer#2@3: called! 1464911348.122562 usb_insert_transfer#2@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911348.122562 usb_insert_transfer#2@3: <- done xfer 0x919edce0, err 0 1464911348.122562 roothub_ctrl_start#2@3: called! 1464911348.122563 roothub_ctrl_start#2@3: type=0x23 request=0x1 1464911348.122563 ehci_roothub_ctrl#2@3: called! 1464911348.122563 ehci_roothub_ctrl#2@3: type=0x23 request=01 1464911348.122563 ehci_roothub_ctrl#2@3: UR_CLEAR_PORT_FEATURE port=1 feature=16 1464911348.122564 ehci_roothub_ctrl#2@3: portsc=0x00001803 1464911348.122565 ehci_roothub_ctrl#2@3: returning 0 1464911348.122565 roothub_ctrl_start#2@3: xfer 0x919edce0 buflen -1 actlen 0 1464911348.122565 roothub_ctrl_start#2@3: xfer 0x919edce0 err 0 1464911348.122566 usb_transfer_complete#3@3: called! 1464911348.122566 usb_transfer_complete#3@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 0 1464911348.122566 usb_transfer_complete#3@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911348.122566 usb_transfer_complete#3@3: xfer 0x919edce0 doing done 0x810f9b24 1464911348.122566 usb_transfer_complete#3@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911348.122567 usb_transfer_complete#3@3: <- done xfer 0x919edce0, wakeup 1464911348.122567 usbd_start_next#3@3: called! 1464911348.122567 usbd_start_next#3@3: pipe = 0x9156d3c0, xfer = 0x0 1464911348.122568 usbd_transfer#2@3: <- done transfer 0x919edce0, err = 0 1464911348.122568 usbd_transfer#2@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911348.122568 usbd_free_xfer#2@3: called! 1464911348.122568 usbd_free_xfer#2@3: 0x919edce0 1464911348.428130 usbd_reset_port#1@3: called! 1464911348.428131 usbd_do_request_flags#3@3: called! 1464911348.428131 usbd_alloc_xfer#3@3: called! 1464911348.428132 usbd_alloc_xfer#3@3: returns 0x919edce0 1464911348.428132 usbd_transfer#3@3: called! 1464911348.428132 usbd_transfer#3@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911348.428133 usb_insert_transfer#3@3: called! 1464911348.428133 usb_insert_transfer#3@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911348.428133 usb_insert_transfer#3@3: <- done xfer 0x919edce0, err 0 1464911348.428133 roothub_ctrl_start#3@3: called! 1464911348.428134 roothub_ctrl_start#3@3: type=0x23 request=0x3 1464911348.428134 ehci_roothub_ctrl#3@3: called! 1464911348.428134 ehci_roothub_ctrl#3@3: type=0x23 request=03 1464911348.428135 ehci_roothub_ctrl#3@3: portsc=0x00001801 1464911348.428135 ehci_roothub_ctrl#3@3: reset port 1 1464911348.478180 ehci_intr#2@1: called! 1464911348.478181 ehci_intr1#2@1: called! 1464911348.478182 ehci_intr1#2@1: sc=0x919d7008 intrs=0x4(0xc084) eintrs=0x4 1464911348.478185 ehci_pcd#2@1: called! 1464911348.478186 usb_transfer_complete#4@1: called! 1464911348.478186 usb_transfer_complete#4@1: pipe = 0x9156d2e0 xfer = 0x919edea0 status = 0 actlen = 1 1464911348.478186 usb_transfer_complete#4@1: xfer 0x919edea0: repeat 1 new head = 0x919edea0 1464911348.478186 usb_transfer_complete#4@1: xfer 0x919edea0 doing done 0x810fa5e8 1464911348.478187 usb_transfer_complete#4@1: xfer 0x919edea0 doing callback 0x81066ed0 status 0 1464911348.478188 usbd_start_next#4@1: called! 1464911348.478189 usbd_start_next#4@1: pipe = 0x9156d2e0, xfer = 0x919edea0 1464911348.478196 ehci_intr#3@3: called! 1464911348.478197 ehci_intr1#3@3: called! 1464911348.478198 ehci_intr1#3@3: sc=0x919d7008 intrs=0x4(0xc084) eintrs=0x4 1464911348.478201 ehci_pcd#3@3: called! 1464911348.478202 usb_transfer_complete#5@3: called! 1464911348.478202 usb_transfer_complete#5@3: pipe = 0x9156d2e0 xfer = 0x919edea0 status = 0 actlen = 1 1464911348.478202 usb_transfer_complete#5@3: xfer 0x919edea0: repeat 1 new head = 0x919edea0 1464911348.478203 usb_transfer_complete#5@3: xfer 0x919edea0 doing done 0x810fa5e8 1464911348.478203 usb_transfer_complete#5@3: xfer 0x919edea0 doing callback 0x81066ed0 status 0 1464911348.478204 usbd_start_next#5@3: called! 1464911348.478205 usbd_start_next#5@3: pipe = 0x9156d2e0, xfer = 0x919edea0 1464911348.481268 ehci_intr#4@2: called! 1464911348.481269 ehci_intr1#4@2: called! 1464911348.481270 ehci_intr1#4@2: sc=0x919d7008 intrs=0x4(0xc084) eintrs=0x4 1464911348.481272 ehci_pcd#4@2: called! 1464911348.481273 usb_transfer_complete#6@2: called! 1464911348.481273 usb_transfer_complete#6@2: pipe = 0x9156d2e0 xfer = 0x919edea0 status = 0 actlen = 1 1464911348.481274 usb_transfer_complete#6@2: xfer 0x919edea0: repeat 1 new head = 0x919edea0 1464911348.481274 usb_transfer_complete#6@2: xfer 0x919edea0 doing done 0x810fa5e8 1464911348.481274 usb_transfer_complete#6@2: xfer 0x919edea0 doing callback 0x81066ed0 status 0 1464911348.481275 usbd_start_next#6@2: called! 1464911348.481276 usbd_start_next#6@2: pipe = 0x9156d2e0, xfer = 0x919edea0 1464911348.688132 ehci_roothub_ctrl#3@3: ehci after reset, status=0x0000180b 1464911348.688133 ehci_disown#1@3: called! 1464911348.688133 ehci_disown#1@3: index=1 lowspeed=0 1464911348.688169 ehci_roothub_ctrl#3@3: returning 0 1464911348.688169 roothub_ctrl_start#3@3: xfer 0x919edce0 buflen -1 actlen 0 1464911348.688169 roothub_ctrl_start#3@3: xfer 0x919edce0 err 0 1464911348.688170 usb_transfer_complete#7@3: called! 1464911348.688170 usb_transfer_complete#7@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 0 1464911348.688170 usb_transfer_complete#7@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911348.688171 usb_transfer_complete#7@3: xfer 0x919edce0 doing done 0x810f9b24 1464911348.688171 usb_transfer_complete#7@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911348.688171 usb_transfer_complete#7@3: <- done xfer 0x919edce0, wakeup 1464911348.688171 usbd_start_next#7@3: called! 1464911348.688172 usbd_start_next#7@3: pipe = 0x9156d3c0, xfer = 0x0 1464911348.688172 usbd_transfer#3@3: <- done transfer 0x919edce0, err = 0 1464911348.688173 usbd_transfer#3@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911348.688173 usbd_free_xfer#3@3: called! 1464911348.688173 usbd_free_xfer#3@3: 0x919edce0 1464911348.688174 usbd_reset_port#1@3: port 1 reset done, error=0 1464911348.748132 usbd_get_port_status#2@3: called! 1464911348.748132 usbd_get_port_status#2@3: dev 0x919d95f8 port 1 1464911348.748132 usbd_do_request_flags#4@3: called! 1464911348.748133 usbd_alloc_xfer#4@3: called! 1464911348.748133 usbd_alloc_xfer#4@3: returns 0x919edce0 1464911348.748134 usb_allocmem_flags#2@3: called! 1464911348.748135 usb_allocmem_flags#2@3: use frag=0x9bbecf40 size=4 1464911348.748135 usbd_transfer#4@3: called! 1464911348.748136 usbd_transfer#4@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911348.748136 usb_insert_transfer#4@3: called! 1464911348.748136 usb_insert_transfer#4@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911348.748137 usb_insert_transfer#4@3: <- done xfer 0x919edce0, err 0 1464911348.748137 roothub_ctrl_start#4@3: called! 1464911348.748137 roothub_ctrl_start#4@3: type=0xa3 request= 0 1464911348.748138 ehci_roothub_ctrl#4@3: called! 1464911348.748138 ehci_roothub_ctrl#4@3: type=0xa3 request=00 1464911348.748138 ehci_roothub_ctrl#4@3: get port status i=1 1464911348.748139 ehci_roothub_ctrl#4@3: port status=0x180b 1464911348.748140 ehci_roothub_ctrl#4@3: returning 4 1464911348.748140 roothub_ctrl_start#4@3: xfer 0x919edce0 buflen -1 actlen 4 1464911348.748140 roothub_ctrl_start#4@3: xfer 0x919edce0 err 0 1464911348.748141 usb_transfer_complete#8@3: called! 1464911348.748141 usb_transfer_complete#8@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911348.748141 usb_transfer_complete#8@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911348.748141 usb_transfer_complete#8@3: xfer 0x919edce0 doing done 0x810f9b24 1464911348.748142 usb_transfer_complete#8@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911348.748142 usb_transfer_complete#8@3: <- done xfer 0x919edce0, wakeup 1464911348.748142 usbd_start_next#8@3: called! 1464911348.748142 usbd_start_next#8@3: pipe = 0x9156d3c0, xfer = 0x0 1464911348.748143 usbd_transfer#4@3: <- done transfer 0x919edce0, err = 0 1464911348.748143 usbd_transfer#4@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911348.748143 usbd_free_xfer#4@3: called! 1464911348.748144 usbd_free_xfer#4@3: 0x919edce0 1464911348.748144 usb_freemem#2@3: called! 1464911348.748145 usb_freemem#2@3: frag=0x9bbecf40 1464911348.808132 usbd_get_port_status#3@3: called! 1464911348.808132 usbd_get_port_status#3@3: dev 0x919d95f8 port 1 1464911348.808132 usbd_do_request_flags#5@3: called! 1464911348.808132 usbd_alloc_xfer#5@3: called! 1464911348.808133 usbd_alloc_xfer#5@3: returns 0x919edce0 1464911348.808133 usb_allocmem_flags#3@3: called! 1464911348.808135 usb_allocmem_flags#3@3: use frag=0x9bbecf40 size=4 1464911348.808135 usbd_transfer#5@3: called! 1464911348.808135 usbd_transfer#5@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911348.808136 usb_insert_transfer#5@3: called! 1464911348.808136 usb_insert_transfer#5@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911348.808136 usb_insert_transfer#5@3: <- done xfer 0x919edce0, err 0 1464911348.808136 roothub_ctrl_start#5@3: called! 1464911348.808137 roothub_ctrl_start#5@3: type=0xa3 request= 0 1464911348.808137 ehci_roothub_ctrl#5@3: called! 1464911348.808137 ehci_roothub_ctrl#5@3: type=0xa3 request=00 1464911348.808137 ehci_roothub_ctrl#5@3: get port status i=1 1464911348.808138 ehci_roothub_ctrl#5@3: port status=0x180b 1464911348.808139 ehci_roothub_ctrl#5@3: returning 4 1464911348.808139 roothub_ctrl_start#5@3: xfer 0x919edce0 buflen -1 actlen 4 1464911348.808139 roothub_ctrl_start#5@3: xfer 0x919edce0 err 0 1464911348.808140 usb_transfer_complete#9@3: called! 1464911348.808140 usb_transfer_complete#9@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911348.808140 usb_transfer_complete#9@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911348.808140 usb_transfer_complete#9@3: xfer 0x919edce0 doing done 0x810f9b24 1464911348.808141 usb_transfer_complete#9@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911348.808141 usb_transfer_complete#9@3: <- done xfer 0x919edce0, wakeup 1464911348.808141 usbd_start_next#9@3: called! 1464911348.808141 usbd_start_next#9@3: pipe = 0x9156d3c0, xfer = 0x0 1464911348.808142 usbd_transfer#5@3: <- done transfer 0x919edce0, err = 0 1464911348.808142 usbd_transfer#5@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911348.808142 usbd_free_xfer#5@3: called! 1464911348.808142 usbd_free_xfer#5@3: 0x919edce0 1464911348.808143 usb_freemem#3@3: called! 1464911348.808143 usb_freemem#3@3: frag=0x9bbecf40 1464911348.868132 usbd_get_port_status#4@3: called! 1464911348.868132 usbd_get_port_status#4@3: dev 0x919d95f8 port 1 1464911348.868133 usbd_do_request_flags#6@3: called! 1464911348.868133 usbd_alloc_xfer#6@3: called! 1464911348.868134 usbd_alloc_xfer#6@3: returns 0x919edce0 1464911348.868134 usb_allocmem_flags#4@3: called! 1464911348.868135 usb_allocmem_flags#4@3: use frag=0x9bbecf40 size=4 1464911348.868135 usbd_transfer#6@3: called! 1464911348.868135 usbd_transfer#6@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911348.868136 usb_insert_transfer#6@3: called! 1464911348.868136 usb_insert_transfer#6@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911348.868136 usb_insert_transfer#6@3: <- done xfer 0x919edce0, err 0 1464911348.868137 roothub_ctrl_start#6@3: called! 1464911348.868137 roothub_ctrl_start#6@3: type=0xa3 request= 0 1464911348.868137 ehci_roothub_ctrl#6@3: called! 1464911348.868138 ehci_roothub_ctrl#6@3: type=0xa3 request=00 1464911348.868138 ehci_roothub_ctrl#6@3: get port status i=1 1464911348.868139 ehci_roothub_ctrl#6@3: port status=0x180b 1464911348.868139 ehci_roothub_ctrl#6@3: returning 4 1464911348.868140 roothub_ctrl_start#6@3: xfer 0x919edce0 buflen -1 actlen 4 1464911348.868140 roothub_ctrl_start#6@3: xfer 0x919edce0 err 0 1464911348.868140 usb_transfer_complete#10@3: called! 1464911348.868140 usb_transfer_complete#10@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911348.868141 usb_transfer_complete#10@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911348.868141 usb_transfer_complete#10@3: xfer 0x919edce0 doing done 0x810f9b24 1464911348.868141 usb_transfer_complete#10@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911348.868141 usb_transfer_complete#10@3: <- done xfer 0x919edce0, wakeup 1464911348.868141 usbd_start_next#10@3: called! 1464911348.868142 usbd_start_next#10@3: pipe = 0x9156d3c0, xfer = 0x0 1464911348.868142 usbd_transfer#6@3: <- done transfer 0x919edce0, err = 0 1464911348.868142 usbd_transfer#6@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911348.868143 usbd_free_xfer#6@3: called! 1464911348.868143 usbd_free_xfer#6@3: 0x919edce0 1464911348.868143 usb_freemem#4@3: called! 1464911348.868144 usb_freemem#4@3: frag=0x9bbecf40 1464911348.928134 usbd_get_port_status#5@3: called! 1464911348.928134 usbd_get_port_status#5@3: dev 0x919d95f8 port 1 1464911348.928135 usbd_do_request_flags#7@3: called! 1464911348.928135 usbd_alloc_xfer#7@3: called! 1464911348.928135 usbd_alloc_xfer#7@3: returns 0x919edce0 1464911348.928136 usb_allocmem_flags#5@3: called! 1464911348.928137 usb_allocmem_flags#5@3: use frag=0x9bbecf40 size=4 1464911348.928137 usbd_transfer#7@3: called! 1464911348.928138 usbd_transfer#7@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911348.928138 usb_insert_transfer#7@3: called! 1464911348.928138 usb_insert_transfer#7@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911348.928138 usb_insert_transfer#7@3: <- done xfer 0x919edce0, err 0 1464911348.928139 roothub_ctrl_start#7@3: called! 1464911348.928139 roothub_ctrl_start#7@3: type=0xa3 request= 0 1464911348.928139 ehci_roothub_ctrl#7@3: called! 1464911348.928140 ehci_roothub_ctrl#7@3: type=0xa3 request=00 1464911348.928140 ehci_roothub_ctrl#7@3: get port status i=1 1464911348.928141 ehci_roothub_ctrl#7@3: port status=0x180b 1464911348.928142 ehci_roothub_ctrl#7@3: returning 4 1464911348.928142 roothub_ctrl_start#7@3: xfer 0x919edce0 buflen -1 actlen 4 1464911348.928142 roothub_ctrl_start#7@3: xfer 0x919edce0 err 0 1464911348.928142 usb_transfer_complete#11@3: called! 1464911348.928142 usb_transfer_complete#11@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911348.928143 usb_transfer_complete#11@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911348.928143 usb_transfer_complete#11@3: xfer 0x919edce0 doing done 0x810f9b24 1464911348.928143 usb_transfer_complete#11@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911348.928143 usb_transfer_complete#11@3: <- done xfer 0x919edce0, wakeup 1464911348.928143 usbd_start_next#11@3: called! 1464911348.928144 usbd_start_next#11@3: pipe = 0x9156d3c0, xfer = 0x0 1464911348.928144 usbd_transfer#7@3: <- done transfer 0x919edce0, err = 0 1464911348.928144 usbd_transfer#7@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911348.928145 usbd_free_xfer#7@3: called! 1464911348.928145 usbd_free_xfer#7@3: 0x919edce0 1464911348.928145 usb_freemem#5@3: called! 1464911348.928146 usb_freemem#5@3: frag=0x9bbecf40 1464911348.988134 usbd_get_port_status#6@3: called! 1464911348.988134 usbd_get_port_status#6@3: dev 0x919d95f8 port 1 1464911348.988134 usbd_do_request_flags#8@3: called! 1464911348.988134 usbd_alloc_xfer#8@3: called! 1464911348.988135 usbd_alloc_xfer#8@3: returns 0x919edce0 1464911348.988135 usb_allocmem_flags#6@3: called! 1464911348.988136 usb_allocmem_flags#6@3: use frag=0x9bbecf40 size=4 1464911348.988137 usbd_transfer#8@3: called! 1464911348.988137 usbd_transfer#8@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911348.988137 usb_insert_transfer#8@3: called! 1464911348.988137 usb_insert_transfer#8@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911348.988138 usb_insert_transfer#8@3: <- done xfer 0x919edce0, err 0 1464911348.988138 roothub_ctrl_start#8@3: called! 1464911348.988138 roothub_ctrl_start#8@3: type=0xa3 request= 0 1464911348.988139 ehci_roothub_ctrl#8@3: called! 1464911348.988139 ehci_roothub_ctrl#8@3: type=0xa3 request=00 1464911348.988139 ehci_roothub_ctrl#8@3: get port status i=1 1464911348.988140 ehci_roothub_ctrl#8@3: port status=0x180b 1464911348.988141 ehci_roothub_ctrl#8@3: returning 4 1464911348.988141 roothub_ctrl_start#8@3: xfer 0x919edce0 buflen -1 actlen 4 1464911348.988141 roothub_ctrl_start#8@3: xfer 0x919edce0 err 0 1464911348.988141 usb_transfer_complete#12@3: called! 1464911348.988141 usb_transfer_complete#12@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911348.988142 usb_transfer_complete#12@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911348.988142 usb_transfer_complete#12@3: xfer 0x919edce0 doing done 0x810f9b24 1464911348.988142 usb_transfer_complete#12@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911348.988142 usb_transfer_complete#12@3: <- done xfer 0x919edce0, wakeup 1464911348.988143 usbd_start_next#12@3: called! 1464911348.988143 usbd_start_next#12@3: pipe = 0x9156d3c0, xfer = 0x0 1464911348.988143 usbd_transfer#8@3: <- done transfer 0x919edce0, err = 0 1464911348.988144 usbd_transfer#8@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911348.988144 usbd_free_xfer#8@3: called! 1464911348.988144 usbd_free_xfer#8@3: 0x919edce0 1464911348.988144 usb_freemem#6@3: called! 1464911348.988145 usb_freemem#6@3: frag=0x9bbecf40 1464911349.048134 usbd_get_port_status#7@3: called! 1464911349.048134 usbd_get_port_status#7@3: dev 0x919d95f8 port 1 1464911349.048134 usbd_do_request_flags#9@3: called! 1464911349.048135 usbd_alloc_xfer#9@3: called! 1464911349.048135 usbd_alloc_xfer#9@3: returns 0x919edce0 1464911349.048136 usb_allocmem_flags#7@3: called! 1464911349.048137 usb_allocmem_flags#7@3: use frag=0x9bbecf40 size=4 1464911349.048137 usbd_transfer#9@3: called! 1464911349.048137 usbd_transfer#9@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911349.048138 usb_insert_transfer#9@3: called! 1464911349.048138 usb_insert_transfer#9@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911349.048138 usb_insert_transfer#9@3: <- done xfer 0x919edce0, err 0 1464911349.048139 roothub_ctrl_start#9@3: called! 1464911349.048139 roothub_ctrl_start#9@3: type=0xa3 request= 0 1464911349.048139 ehci_roothub_ctrl#9@3: called! 1464911349.048139 ehci_roothub_ctrl#9@3: type=0xa3 request=00 1464911349.048139 ehci_roothub_ctrl#9@3: get port status i=1 1464911349.048140 ehci_roothub_ctrl#9@3: port status=0x180b 1464911349.048141 ehci_roothub_ctrl#9@3: returning 4 1464911349.048141 roothub_ctrl_start#9@3: xfer 0x919edce0 buflen -1 actlen 4 1464911349.048142 roothub_ctrl_start#9@3: xfer 0x919edce0 err 0 1464911349.048142 usb_transfer_complete#13@3: called! 1464911349.048142 usb_transfer_complete#13@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911349.048142 usb_transfer_complete#13@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911349.048142 usb_transfer_complete#13@3: xfer 0x919edce0 doing done 0x810f9b24 1464911349.048143 usb_transfer_complete#13@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911349.048143 usb_transfer_complete#13@3: <- done xfer 0x919edce0, wakeup 1464911349.048143 usbd_start_next#13@3: called! 1464911349.048143 usbd_start_next#13@3: pipe = 0x9156d3c0, xfer = 0x0 1464911349.048144 usbd_transfer#9@3: <- done transfer 0x919edce0, err = 0 1464911349.048144 usbd_transfer#9@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911349.048144 usbd_free_xfer#9@3: called! 1464911349.048145 usbd_free_xfer#9@3: 0x919edce0 1464911349.048145 usb_freemem#7@3: called! 1464911349.048146 usb_freemem#7@3: frag=0x9bbecf40 1464911349.108134 usbd_get_port_status#8@3: called! 1464911349.108135 usbd_get_port_status#8@3: dev 0x919d95f8 port 1 1464911349.108135 usbd_do_request_flags#10@3: called! 1464911349.108135 usbd_alloc_xfer#10@3: called! 1464911349.108136 usbd_alloc_xfer#10@3: returns 0x919edce0 1464911349.108136 usb_allocmem_flags#8@3: called! 1464911349.108137 usb_allocmem_flags#8@3: use frag=0x9bbecf40 size=4 1464911349.108138 usbd_transfer#10@3: called! 1464911349.108138 usbd_transfer#10@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911349.108138 usb_insert_transfer#10@3: called! 1464911349.108138 usb_insert_transfer#10@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911349.108138 usb_insert_transfer#10@3: <- done xfer 0x919edce0, err 0 1464911349.108139 roothub_ctrl_start#10@3: called! 1464911349.108139 roothub_ctrl_start#10@3: type=0xa3 request= 0 1464911349.108139 ehci_roothub_ctrl#10@3: called! 1464911349.108140 ehci_roothub_ctrl#10@3: type=0xa3 request=00 1464911349.108140 ehci_roothub_ctrl#10@3: get port status i=1 1464911349.108141 ehci_roothub_ctrl#10@3: port status=0x180b 1464911349.108142 ehci_roothub_ctrl#10@3: returning 4 1464911349.108142 roothub_ctrl_start#10@3: xfer 0x919edce0 buflen -1 actlen 4 1464911349.108142 roothub_ctrl_start#10@3: xfer 0x919edce0 err 0 1464911349.108142 usb_transfer_complete#14@3: called! 1464911349.108142 usb_transfer_complete#14@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911349.108143 usb_transfer_complete#14@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911349.108143 usb_transfer_complete#14@3: xfer 0x919edce0 doing done 0x810f9b24 1464911349.108143 usb_transfer_complete#14@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911349.108143 usb_transfer_complete#14@3: <- done xfer 0x919edce0, wakeup 1464911349.108143 usbd_start_next#14@3: called! 1464911349.108144 usbd_start_next#14@3: pipe = 0x9156d3c0, xfer = 0x0 1464911349.108144 usbd_transfer#10@3: <- done transfer 0x919edce0, err = 0 1464911349.108144 usbd_transfer#10@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911349.108145 usbd_free_xfer#10@3: called! 1464911349.108145 usbd_free_xfer#10@3: 0x919edce0 1464911349.108145 usb_freemem#8@3: called! 1464911349.108146 usb_freemem#8@3: frag=0x9bbecf40 1464911349.168135 usbd_get_port_status#9@3: called! 1464911349.168135 usbd_get_port_status#9@3: dev 0x919d95f8 port 1 1464911349.168135 usbd_do_request_flags#11@3: called! 1464911349.168135 usbd_alloc_xfer#11@3: called! 1464911349.168136 usbd_alloc_xfer#11@3: returns 0x919edce0 1464911349.168136 usb_allocmem_flags#9@3: called! 1464911349.168138 usb_allocmem_flags#9@3: use frag=0x9bbecf40 size=4 1464911349.168138 usbd_transfer#11@3: called! 1464911349.168138 usbd_transfer#11@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911349.168138 usb_insert_transfer#11@3: called! 1464911349.168138 usb_insert_transfer#11@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911349.168139 usb_insert_transfer#11@3: <- done xfer 0x919edce0, err 0 1464911349.168139 roothub_ctrl_start#11@3: called! 1464911349.168140 roothub_ctrl_start#11@3: type=0xa3 request= 0 1464911349.168140 ehci_roothub_ctrl#11@3: called! 1464911349.168140 ehci_roothub_ctrl#11@3: type=0xa3 request=00 1464911349.168140 ehci_roothub_ctrl#11@3: get port status i=1 1464911349.168141 ehci_roothub_ctrl#11@3: port status=0x180b 1464911349.168142 ehci_roothub_ctrl#11@3: returning 4 1464911349.168142 roothub_ctrl_start#11@3: xfer 0x919edce0 buflen -1 actlen 4 1464911349.168142 roothub_ctrl_start#11@3: xfer 0x919edce0 err 0 1464911349.168143 usb_transfer_complete#15@3: called! 1464911349.168143 usb_transfer_complete#15@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911349.168143 usb_transfer_complete#15@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911349.168143 usb_transfer_complete#15@3: xfer 0x919edce0 doing done 0x810f9b24 1464911349.168144 usb_transfer_complete#15@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911349.168144 usb_transfer_complete#15@3: <- done xfer 0x919edce0, wakeup 1464911349.168144 usbd_start_next#15@3: called! 1464911349.168144 usbd_start_next#15@3: pipe = 0x9156d3c0, xfer = 0x0 1464911349.168145 usbd_transfer#11@3: <- done transfer 0x919edce0, err = 0 1464911349.168145 usbd_transfer#11@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911349.168145 usbd_free_xfer#11@3: called! 1464911349.168146 usbd_free_xfer#11@3: 0x919edce0 1464911349.168146 usb_freemem#9@3: called! 1464911349.168146 usb_freemem#9@3: frag=0x9bbecf40 1464911349.228135 usbd_get_port_status#10@3: called! 1464911349.228136 usbd_get_port_status#10@3: dev 0x919d95f8 port 1 1464911349.228136 usbd_do_request_flags#12@3: called! 1464911349.228136 usbd_alloc_xfer#12@3: called! 1464911349.228137 usbd_alloc_xfer#12@3: returns 0x919edce0 1464911349.228137 usb_allocmem_flags#10@3: called! 1464911349.228138 usb_allocmem_flags#10@3: use frag=0x9bbecf40 size=4 1464911349.228138 usbd_transfer#12@3: called! 1464911349.228138 usbd_transfer#12@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911349.228139 usb_insert_transfer#12@3: called! 1464911349.228139 usb_insert_transfer#12@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911349.228139 usb_insert_transfer#12@3: <- done xfer 0x919edce0, err 0 1464911349.228140 roothub_ctrl_start#12@3: called! 1464911349.228140 roothub_ctrl_start#12@3: type=0xa3 request= 0 1464911349.228140 ehci_roothub_ctrl#12@3: called! 1464911349.228140 ehci_roothub_ctrl#12@3: type=0xa3 request=00 1464911349.228141 ehci_roothub_ctrl#12@3: get port status i=1 1464911349.228141 ehci_roothub_ctrl#12@3: port status=0x180b 1464911349.228142 ehci_roothub_ctrl#12@3: returning 4 1464911349.228142 roothub_ctrl_start#12@3: xfer 0x919edce0 buflen -1 actlen 4 1464911349.228143 roothub_ctrl_start#12@3: xfer 0x919edce0 err 0 1464911349.228143 usb_transfer_complete#16@3: called! 1464911349.228143 usb_transfer_complete#16@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911349.228143 usb_transfer_complete#16@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911349.228144 usb_transfer_complete#16@3: xfer 0x919edce0 doing done 0x810f9b24 1464911349.228144 usb_transfer_complete#16@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911349.228144 usb_transfer_complete#16@3: <- done xfer 0x919edce0, wakeup 1464911349.228145 usbd_start_next#16@3: called! 1464911349.228145 usbd_start_next#16@3: pipe = 0x9156d3c0, xfer = 0x0 1464911349.228145 usbd_transfer#12@3: <- done transfer 0x919edce0, err = 0 1464911349.228146 usbd_transfer#12@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911349.228146 usbd_free_xfer#12@3: called! 1464911349.228146 usbd_free_xfer#12@3: 0x919edce0 1464911349.228146 usb_freemem#10@3: called! 1464911349.228147 usb_freemem#10@3: frag=0x9bbecf40 1464911349.288136 usbd_get_port_status#11@3: called! 1464911349.288136 usbd_get_port_status#11@3: dev 0x919d95f8 port 1 1464911349.288136 usbd_do_request_flags#13@3: called! 1464911349.288137 usbd_alloc_xfer#13@3: called! 1464911349.288137 usbd_alloc_xfer#13@3: returns 0x919edce0 1464911349.288138 usb_allocmem_flags#11@3: called! 1464911349.288139 usb_allocmem_flags#11@3: use frag=0x9bbecf40 size=4 1464911349.288139 usbd_transfer#13@3: called! 1464911349.288139 usbd_transfer#13@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911349.288140 usb_insert_transfer#13@3: called! 1464911349.288140 usb_insert_transfer#13@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911349.288140 usb_insert_transfer#13@3: <- done xfer 0x919edce0, err 0 1464911349.288141 roothub_ctrl_start#13@3: called! 1464911349.288141 roothub_ctrl_start#13@3: type=0xa3 request= 0 1464911349.288141 ehci_roothub_ctrl#13@3: called! 1464911349.288141 ehci_roothub_ctrl#13@3: type=0xa3 request=00 1464911349.288141 ehci_roothub_ctrl#13@3: get port status i=1 1464911349.288142 ehci_roothub_ctrl#13@3: port status=0x180b 1464911349.288143 ehci_roothub_ctrl#13@3: returning 4 1464911349.288143 roothub_ctrl_start#13@3: xfer 0x919edce0 buflen -1 actlen 4 1464911349.288144 roothub_ctrl_start#13@3: xfer 0x919edce0 err 0 1464911349.288144 usb_transfer_complete#17@3: called! 1464911349.288144 usb_transfer_complete#17@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911349.288145 usb_transfer_complete#17@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911349.288145 usb_transfer_complete#17@3: xfer 0x919edce0 doing done 0x810f9b24 1464911349.288145 usb_transfer_complete#17@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911349.288145 usb_transfer_complete#17@3: <- done xfer 0x919edce0, wakeup 1464911349.288146 usbd_start_next#17@3: called! 1464911349.288146 usbd_start_next#17@3: pipe = 0x9156d3c0, xfer = 0x0 1464911349.288146 usbd_transfer#13@3: <- done transfer 0x919edce0, err = 0 1464911349.288146 usbd_transfer#13@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911349.288147 usbd_free_xfer#13@3: called! 1464911349.288147 usbd_free_xfer#13@3: 0x919edce0 1464911349.288147 usb_freemem#11@3: called! 1464911349.288148 usb_freemem#11@3: frag=0x9bbecf40 1464911349.288594 usb_needs_explore#2@3: called! 1464911349.288596 usbd_get_port_status#12@3: called! 1464911349.288597 usbd_get_port_status#12@3: dev 0x919d95f8 port 1 1464911349.288597 usbd_do_request_flags#14@3: called! 1464911349.288597 usbd_alloc_xfer#14@3: called! 1464911349.288598 usbd_alloc_xfer#14@3: returns 0x919edce0 1464911349.288598 usb_allocmem_flags#12@3: called! 1464911349.288599 usb_allocmem_flags#12@3: use frag=0x9bbecf40 size=4 1464911349.288600 usbd_transfer#14@3: called! 1464911349.288600 usbd_transfer#14@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911349.288600 usb_insert_transfer#14@3: called! 1464911349.288601 usb_insert_transfer#14@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911349.288601 usb_insert_transfer#14@3: <- done xfer 0x919edce0, err 0 1464911349.288601 roothub_ctrl_start#14@3: called! 1464911349.288602 roothub_ctrl_start#14@3: type=0xa3 request= 0 1464911349.288602 ehci_roothub_ctrl#14@3: called! 1464911349.288602 ehci_roothub_ctrl#14@3: type=0xa3 request=00 1464911349.288602 ehci_roothub_ctrl#14@3: get port status i=1 1464911349.288603 ehci_roothub_ctrl#14@3: port status=0x180b 1464911349.288604 ehci_roothub_ctrl#14@3: returning 4 1464911349.288604 roothub_ctrl_start#14@3: xfer 0x919edce0 buflen -1 actlen 4 1464911349.288605 roothub_ctrl_start#14@3: xfer 0x919edce0 err 0 1464911349.288605 usb_transfer_complete#18@3: called! 1464911349.288605 usb_transfer_complete#18@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911349.288605 usb_transfer_complete#18@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911349.288605 usb_transfer_complete#18@3: xfer 0x919edce0 doing done 0x810f9b24 1464911349.288606 usb_transfer_complete#18@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911349.288606 usb_transfer_complete#18@3: <- done xfer 0x919edce0, wakeup 1464911349.288606 usbd_start_next#18@3: called! 1464911349.288606 usbd_start_next#18@3: pipe = 0x9156d3c0, xfer = 0x0 1464911349.288607 usbd_transfer#14@3: <- done transfer 0x919edce0, err = 0 1464911349.288607 usbd_transfer#14@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911349.288607 usbd_free_xfer#14@3: called! 1464911349.288608 usbd_free_xfer#14@3: 0x919edce0 1464911349.288608 usb_freemem#12@3: called! 1464911349.288609 usb_freemem#12@3: frag=0x9bbecf40 1464911349.288610 usbd_clear_port_feature#2@3: called! 1464911349.288610 usbd_clear_port_feature#2@3: dev 0x919d95f8 port 1 sel 17 1464911349.288610 usbd_do_request_flags#15@3: called! 1464911349.288611 usbd_alloc_xfer#15@3: called! 1464911349.288611 usbd_alloc_xfer#15@3: returns 0x919edce0 1464911349.288611 usbd_transfer#15@3: called! 1464911349.288612 usbd_transfer#15@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911349.288612 usb_insert_transfer#15@3: called! 1464911349.288612 usb_insert_transfer#15@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911349.288612 usb_insert_transfer#15@3: <- done xfer 0x919edce0, err 0 1464911349.288613 roothub_ctrl_start#15@3: called! 1464911349.288613 roothub_ctrl_start#15@3: type=0x23 request=0x1 1464911349.288613 ehci_roothub_ctrl#15@3: called! 1464911349.288614 ehci_roothub_ctrl#15@3: type=0x23 request=01 1464911349.288614 ehci_roothub_ctrl#15@3: UR_CLEAR_PORT_FEATURE port=1 feature=17 1464911349.288615 ehci_roothub_ctrl#15@3: portsc=0x0000180b 1464911349.288615 ehci_roothub_ctrl#15@3: returning 0 1464911349.288616 roothub_ctrl_start#15@3: xfer 0x919edce0 buflen -1 actlen 0 1464911349.288616 roothub_ctrl_start#15@3: xfer 0x919edce0 err 0 1464911349.288616 usb_transfer_complete#19@3: called! 1464911349.288616 usb_transfer_complete#19@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 0 1464911349.288617 usb_transfer_complete#19@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911349.288617 usb_transfer_complete#19@3: xfer 0x919edce0 doing done 0x810f9b24 1464911349.288617 usb_transfer_complete#19@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911349.288617 usb_transfer_complete#19@3: <- done xfer 0x919edce0, wakeup 1464911349.288618 usbd_start_next#19@3: called! 1464911349.288618 usbd_start_next#19@3: pipe = 0x9156d3c0, xfer = 0x0 1464911349.288618 usbd_transfer#15@3: <- done transfer 0x919edce0, err = 0 1464911349.288618 usbd_transfer#15@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911349.288619 usbd_free_xfer#15@3: called! 1464911349.288619 usbd_free_xfer#15@3: 0x919edce0 1464911349.288620 usbd_clear_port_feature#3@3: called! 1464911349.288620 usbd_clear_port_feature#3@3: dev 0x919d95f8 port 1 sel 16 1464911349.288621 usbd_do_request_flags#16@3: called! 1464911349.288621 usbd_alloc_xfer#16@3: called! 1464911349.288621 usbd_alloc_xfer#16@3: returns 0x919edce0 1464911349.288622 usbd_transfer#16@3: called! 1464911349.288622 usbd_transfer#16@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911349.288622 usb_insert_transfer#16@3: called! 1464911349.288622 usb_insert_transfer#16@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911349.288623 usb_insert_transfer#16@3: <- done xfer 0x919edce0, err 0 1464911349.288623 roothub_ctrl_start#16@3: called! 1464911349.288623 roothub_ctrl_start#16@3: type=0x23 request=0x1 1464911349.288624 ehci_roothub_ctrl#16@3: called! 1464911349.288624 ehci_roothub_ctrl#16@3: type=0x23 request=01 1464911349.288624 ehci_roothub_ctrl#16@3: UR_CLEAR_PORT_FEATURE port=1 feature=16 1464911349.288625 ehci_roothub_ctrl#16@3: portsc=0x00001803 1464911349.288626 ehci_roothub_ctrl#16@3: returning 0 1464911349.288626 roothub_ctrl_start#16@3: xfer 0x919edce0 buflen -1 actlen 0 1464911349.288626 roothub_ctrl_start#16@3: xfer 0x919edce0 err 0 1464911349.288626 usb_transfer_complete#20@3: called! 1464911349.288626 usb_transfer_complete#20@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 0 1464911349.288627 usb_transfer_complete#20@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911349.288627 usb_transfer_complete#20@3: xfer 0x919edce0 doing done 0x810f9b24 1464911349.288627 usb_transfer_complete#20@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911349.288627 usb_transfer_complete#20@3: <- done xfer 0x919edce0, wakeup 1464911349.288627 usbd_start_next#20@3: called! 1464911349.288628 usbd_start_next#20@3: pipe = 0x9156d3c0, xfer = 0x0 1464911349.288628 usbd_transfer#16@3: <- done transfer 0x919edce0, err = 0 1464911349.288628 usbd_transfer#16@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911349.288628 usbd_free_xfer#16@3: called! 1464911349.288629 usbd_free_xfer#16@3: 0x919edce0 1464911349.598139 usbd_reset_port#2@3: called! 1464911349.598139 usbd_do_request_flags#17@3: called! 1464911349.598139 usbd_alloc_xfer#17@3: called! 1464911349.598140 usbd_alloc_xfer#17@3: returns 0x919edce0 1464911349.598140 usbd_transfer#17@3: called! 1464911349.598140 usbd_transfer#17@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911349.598141 usb_insert_transfer#17@3: called! 1464911349.598141 usb_insert_transfer#17@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911349.598141 usb_insert_transfer#17@3: <- done xfer 0x919edce0, err 0 1464911349.598142 roothub_ctrl_start#17@3: called! 1464911349.598142 roothub_ctrl_start#17@3: type=0x23 request=0x3 1464911349.598142 ehci_roothub_ctrl#17@3: called! 1464911349.598142 ehci_roothub_ctrl#17@3: type=0x23 request=03 1464911349.598143 ehci_roothub_ctrl#17@3: portsc=0x00001801 1464911349.598143 ehci_roothub_ctrl#17@3: reset port 1 1464911349.648146 ehci_intr#5@0: called! 1464911349.648146 ehci_intr1#5@0: called! 1464911349.648147 ehci_intr1#5@0: sc=0x919d7008 intrs=0xc(0xc08c) eintrs=0x4 1464911349.648150 ehci_pcd#5@0: called! 1464911349.648152 usb_transfer_complete#21@0: called! 1464911349.648152 usb_transfer_complete#21@0: pipe = 0x9156d2e0 xfer = 0x919edea0 status = 0 actlen = 1 1464911349.648152 usb_transfer_complete#21@0: xfer 0x919edea0: repeat 1 new head = 0x919edea0 1464911349.648152 usb_transfer_complete#21@0: xfer 0x919edea0 doing done 0x810fa5e8 1464911349.648153 usb_transfer_complete#21@0: xfer 0x919edea0 doing callback 0x81066ed0 status 0 1464911349.648154 usb_needs_explore#3@0: called! 1464911349.648155 usbd_start_next#21@0: called! 1464911349.648155 usbd_start_next#21@0: pipe = 0x9156d2e0, xfer = 0x919edea0 1464911349.648196 ehci_intr#6@1: called! 1464911349.648197 ehci_intr1#6@1: called! 1464911349.648198 ehci_intr1#6@1: sc=0x919d7008 intrs=0x4(0xc084) eintrs=0x4 1464911349.648200 ehci_pcd#6@1: called! 1464911349.648201 usb_transfer_complete#22@1: called! 1464911349.648201 usb_transfer_complete#22@1: pipe = 0x9156d2e0 xfer = 0x919edea0 status = 0 actlen = 1 1464911349.648202 usb_transfer_complete#22@1: xfer 0x919edea0: repeat 1 new head = 0x919edea0 1464911349.648202 usb_transfer_complete#22@1: xfer 0x919edea0 doing done 0x810fa5e8 1464911349.648202 usb_transfer_complete#22@1: xfer 0x919edea0 doing callback 0x81066ed0 status 0 1464911349.648204 usbd_start_next#22@1: called! 1464911349.648204 usbd_start_next#22@1: pipe = 0x9156d2e0, xfer = 0x919edea0 1464911349.651268 ehci_intr#7@2: called! 1464911349.651269 ehci_intr1#7@2: called! 1464911349.651270 ehci_intr1#7@2: sc=0x919d7008 intrs=0x4(0xc084) eintrs=0x4 1464911349.651272 ehci_pcd#7@2: called! 1464911349.651273 usb_transfer_complete#23@2: called! 1464911349.651273 usb_transfer_complete#23@2: pipe = 0x9156d2e0 xfer = 0x919edea0 status = 0 actlen = 1 1464911349.651274 usb_transfer_complete#23@2: xfer 0x919edea0: repeat 1 new head = 0x919edea0 1464911349.651274 usb_transfer_complete#23@2: xfer 0x919edea0 doing done 0x810fa5e8 1464911349.651274 usb_transfer_complete#23@2: xfer 0x919edea0 doing callback 0x81066ed0 status 0 1464911349.651275 usbd_start_next#23@2: called! 1464911349.651276 usbd_start_next#23@2: pipe = 0x9156d2e0, xfer = 0x919edea0 1464911349.858142 ehci_roothub_ctrl#17@3: ehci after reset, status=0x0000180b 1464911349.858142 ehci_disown#2@3: called! 1464911349.858142 ehci_disown#2@3: index=1 lowspeed=0 1464911349.858174 ehci_roothub_ctrl#17@3: returning 0 1464911349.858174 roothub_ctrl_start#17@3: xfer 0x919edce0 buflen -1 actlen 0 1464911349.858174 roothub_ctrl_start#17@3: xfer 0x919edce0 err 0 1464911349.858174 usb_transfer_complete#24@3: called! 1464911349.858174 usb_transfer_complete#24@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 0 1464911349.858175 usb_transfer_complete#24@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911349.858175 usb_transfer_complete#24@3: xfer 0x919edce0 doing done 0x810f9b24 1464911349.858175 usb_transfer_complete#24@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911349.858175 usb_transfer_complete#24@3: <- done xfer 0x919edce0, wakeup 1464911349.858176 usbd_start_next#24@3: called! 1464911349.858176 usbd_start_next#24@3: pipe = 0x9156d3c0, xfer = 0x0 1464911349.858176 usbd_transfer#17@3: <- done transfer 0x919edce0, err = 0 1464911349.858177 usbd_transfer#17@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911349.858177 usbd_free_xfer#17@3: called! 1464911349.858177 usbd_free_xfer#17@3: 0x919edce0 1464911349.858178 usbd_reset_port#2@3: port 1 reset done, error=0 1464911349.918141 usbd_get_port_status#13@3: called! 1464911349.918141 usbd_get_port_status#13@3: dev 0x919d95f8 port 1 1464911349.918141 usbd_do_request_flags#18@3: called! 1464911349.918142 usbd_alloc_xfer#18@3: called! 1464911349.918142 usbd_alloc_xfer#18@3: returns 0x919edce0 1464911349.918143 usb_allocmem_flags#13@3: called! 1464911349.918144 usb_allocmem_flags#13@3: use frag=0x9bbecf40 size=4 1464911349.918144 usbd_transfer#18@3: called! 1464911349.918144 usbd_transfer#18@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911349.918145 usb_insert_transfer#18@3: called! 1464911349.918145 usb_insert_transfer#18@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911349.918145 usb_insert_transfer#18@3: <- done xfer 0x919edce0, err 0 1464911349.918145 roothub_ctrl_start#18@3: called! 1464911349.918146 roothub_ctrl_start#18@3: type=0xa3 request= 0 1464911349.918146 ehci_roothub_ctrl#18@3: called! 1464911349.918146 ehci_roothub_ctrl#18@3: type=0xa3 request=00 1464911349.918146 ehci_roothub_ctrl#18@3: get port status i=1 1464911349.918147 ehci_roothub_ctrl#18@3: port status=0x180b 1464911349.918148 ehci_roothub_ctrl#18@3: returning 4 1464911349.918148 roothub_ctrl_start#18@3: xfer 0x919edce0 buflen -1 actlen 4 1464911349.918148 roothub_ctrl_start#18@3: xfer 0x919edce0 err 0 1464911349.918149 usb_transfer_complete#25@3: called! 1464911349.918149 usb_transfer_complete#25@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911349.918149 usb_transfer_complete#25@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911349.918149 usb_transfer_complete#25@3: xfer 0x919edce0 doing done 0x810f9b24 1464911349.918150 usb_transfer_complete#25@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911349.918150 usb_transfer_complete#25@3: <- done xfer 0x919edce0, wakeup 1464911349.918150 usbd_start_next#25@3: called! 1464911349.918150 usbd_start_next#25@3: pipe = 0x9156d3c0, xfer = 0x0 1464911349.918151 usbd_transfer#18@3: <- done transfer 0x919edce0, err = 0 1464911349.918151 usbd_transfer#18@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911349.918151 usbd_free_xfer#18@3: called! 1464911349.918151 usbd_free_xfer#18@3: 0x919edce0 1464911349.918152 usb_freemem#13@3: called! 1464911349.918152 usb_freemem#13@3: frag=0x9bbecf40 1464911349.978142 usbd_get_port_status#14@3: called! 1464911349.978142 usbd_get_port_status#14@3: dev 0x919d95f8 port 1 1464911349.978142 usbd_do_request_flags#19@3: called! 1464911349.978142 usbd_alloc_xfer#19@3: called! 1464911349.978143 usbd_alloc_xfer#19@3: returns 0x919edce0 1464911349.978143 usb_allocmem_flags#14@3: called! 1464911349.978144 usb_allocmem_flags#14@3: use frag=0x9bbecf40 size=4 1464911349.978145 usbd_transfer#19@3: called! 1464911349.978145 usbd_transfer#19@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911349.978145 usb_insert_transfer#19@3: called! 1464911349.978145 usb_insert_transfer#19@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911349.978146 usb_insert_transfer#19@3: <- done xfer 0x919edce0, err 0 1464911349.978146 roothub_ctrl_start#19@3: called! 1464911349.978146 roothub_ctrl_start#19@3: type=0xa3 request= 0 1464911349.978147 ehci_roothub_ctrl#19@3: called! 1464911349.978147 ehci_roothub_ctrl#19@3: type=0xa3 request=00 1464911349.978147 ehci_roothub_ctrl#19@3: get port status i=1 1464911349.978148 ehci_roothub_ctrl#19@3: port status=0x180b 1464911349.978149 ehci_roothub_ctrl#19@3: returning 4 1464911349.978149 roothub_ctrl_start#19@3: xfer 0x919edce0 buflen -1 actlen 4 1464911349.978149 roothub_ctrl_start#19@3: xfer 0x919edce0 err 0 1464911349.978149 usb_transfer_complete#26@3: called! 1464911349.978150 usb_transfer_complete#26@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911349.978150 usb_transfer_complete#26@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911349.978150 usb_transfer_complete#26@3: xfer 0x919edce0 doing done 0x810f9b24 1464911349.978150 usb_transfer_complete#26@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911349.978150 usb_transfer_complete#26@3: <- done xfer 0x919edce0, wakeup 1464911349.978151 usbd_start_next#26@3: called! 1464911349.978151 usbd_start_next#26@3: pipe = 0x9156d3c0, xfer = 0x0 1464911349.978151 usbd_transfer#19@3: <- done transfer 0x919edce0, err = 0 1464911349.978152 usbd_transfer#19@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911349.978152 usbd_free_xfer#19@3: called! 1464911349.978152 usbd_free_xfer#19@3: 0x919edce0 1464911349.978152 usb_freemem#14@3: called! 1464911349.978153 usb_freemem#14@3: frag=0x9bbecf40 1464911350.038144 usbd_get_port_status#15@3: called! 1464911350.038144 usbd_get_port_status#15@3: dev 0x919d95f8 port 1 1464911350.038145 usbd_do_request_flags#20@3: called! 1464911350.038145 usbd_alloc_xfer#20@3: called! 1464911350.038145 usbd_alloc_xfer#20@3: returns 0x919edce0 1464911350.038146 usb_allocmem_flags#15@3: called! 1464911350.038147 usb_allocmem_flags#15@3: use frag=0x9bbecf40 size=4 1464911350.038147 usbd_transfer#20@3: called! 1464911350.038147 usbd_transfer#20@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911350.038148 usb_insert_transfer#20@3: called! 1464911350.038148 usb_insert_transfer#20@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911350.038148 usb_insert_transfer#20@3: <- done xfer 0x919edce0, err 0 1464911350.038149 roothub_ctrl_start#20@3: called! 1464911350.038149 roothub_ctrl_start#20@3: type=0xa3 request= 0 1464911350.038149 ehci_roothub_ctrl#20@3: called! 1464911350.038149 ehci_roothub_ctrl#20@3: type=0xa3 request=00 1464911350.038149 ehci_roothub_ctrl#20@3: get port status i=1 1464911350.038150 ehci_roothub_ctrl#20@3: port status=0x180b 1464911350.038151 ehci_roothub_ctrl#20@3: returning 4 1464911350.038151 roothub_ctrl_start#20@3: xfer 0x919edce0 buflen -1 actlen 4 1464911350.038151 roothub_ctrl_start#20@3: xfer 0x919edce0 err 0 1464911350.038152 usb_transfer_complete#27@3: called! 1464911350.038152 usb_transfer_complete#27@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911350.038152 usb_transfer_complete#27@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911350.038152 usb_transfer_complete#27@3: xfer 0x919edce0 doing done 0x810f9b24 1464911350.038153 usb_transfer_complete#27@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911350.038153 usb_transfer_complete#27@3: <- done xfer 0x919edce0, wakeup 1464911350.038153 usbd_start_next#27@3: called! 1464911350.038153 usbd_start_next#27@3: pipe = 0x9156d3c0, xfer = 0x0 1464911350.038154 usbd_transfer#20@3: <- done transfer 0x919edce0, err = 0 1464911350.038154 usbd_transfer#20@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911350.038154 usbd_free_xfer#20@3: called! 1464911350.038155 usbd_free_xfer#20@3: 0x919edce0 1464911350.038155 usb_freemem#15@3: called! 1464911350.038156 usb_freemem#15@3: frag=0x9bbecf40 1464911350.098142 usbd_get_port_status#16@3: called! 1464911350.098143 usbd_get_port_status#16@3: dev 0x919d95f8 port 1 1464911350.098143 usbd_do_request_flags#21@3: called! 1464911350.098143 usbd_alloc_xfer#21@3: called! 1464911350.098144 usbd_alloc_xfer#21@3: returns 0x919edce0 1464911350.098144 usb_allocmem_flags#16@3: called! 1464911350.098145 usb_allocmem_flags#16@3: use frag=0x9bbecf40 size=4 1464911350.098145 usbd_transfer#21@3: called! 1464911350.098145 usbd_transfer#21@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911350.098146 usb_insert_transfer#21@3: called! 1464911350.098146 usb_insert_transfer#21@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911350.098146 usb_insert_transfer#21@3: <- done xfer 0x919edce0, err 0 1464911350.098147 roothub_ctrl_start#21@3: called! 1464911350.098147 roothub_ctrl_start#21@3: type=0xa3 request= 0 1464911350.098147 ehci_roothub_ctrl#21@3: called! 1464911350.098148 ehci_roothub_ctrl#21@3: type=0xa3 request=00 1464911350.098148 ehci_roothub_ctrl#21@3: get port status i=1 1464911350.098148 ehci_roothub_ctrl#21@3: port status=0x180b 1464911350.098149 ehci_roothub_ctrl#21@3: returning 4 1464911350.098150 roothub_ctrl_start#21@3: xfer 0x919edce0 buflen -1 actlen 4 1464911350.098150 roothub_ctrl_start#21@3: xfer 0x919edce0 err 0 1464911350.098150 usb_transfer_complete#28@3: called! 1464911350.098150 usb_transfer_complete#28@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911350.098151 usb_transfer_complete#28@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911350.098151 usb_transfer_complete#28@3: xfer 0x919edce0 doing done 0x810f9b24 1464911350.098151 usb_transfer_complete#28@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911350.098151 usb_transfer_complete#28@3: <- done xfer 0x919edce0, wakeup 1464911350.098151 usbd_start_next#28@3: called! 1464911350.098152 usbd_start_next#28@3: pipe = 0x9156d3c0, xfer = 0x0 1464911350.098152 usbd_transfer#21@3: <- done transfer 0x919edce0, err = 0 1464911350.098152 usbd_transfer#21@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911350.098153 usbd_free_xfer#21@3: called! 1464911350.098153 usbd_free_xfer#21@3: 0x919edce0 1464911350.098153 usb_freemem#16@3: called! 1464911350.098154 usb_freemem#16@3: frag=0x9bbecf40 1464911350.158143 usbd_get_port_status#17@3: called! 1464911350.158143 usbd_get_port_status#17@3: dev 0x919d95f8 port 1 1464911350.158143 usbd_do_request_flags#22@3: called! 1464911350.158144 usbd_alloc_xfer#22@3: called! 1464911350.158144 usbd_alloc_xfer#22@3: returns 0x919edce0 1464911350.158144 usb_allocmem_flags#17@3: called! 1464911350.158146 usb_allocmem_flags#17@3: use frag=0x9bbecf40 size=4 1464911350.158146 usbd_transfer#22@3: called! 1464911350.158146 usbd_transfer#22@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911350.158146 usb_insert_transfer#22@3: called! 1464911350.158147 usb_insert_transfer#22@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911350.158147 usb_insert_transfer#22@3: <- done xfer 0x919edce0, err 0 1464911350.158147 roothub_ctrl_start#22@3: called! 1464911350.158148 roothub_ctrl_start#22@3: type=0xa3 request= 0 1464911350.158148 ehci_roothub_ctrl#22@3: called! 1464911350.158148 ehci_roothub_ctrl#22@3: type=0xa3 request=00 1464911350.158148 ehci_roothub_ctrl#22@3: get port status i=1 1464911350.158149 ehci_roothub_ctrl#22@3: port status=0x180b 1464911350.158150 ehci_roothub_ctrl#22@3: returning 4 1464911350.158150 roothub_ctrl_start#22@3: xfer 0x919edce0 buflen -1 actlen 4 1464911350.158151 roothub_ctrl_start#22@3: xfer 0x919edce0 err 0 1464911350.158151 usb_transfer_complete#29@3: called! 1464911350.158151 usb_transfer_complete#29@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911350.158151 usb_transfer_complete#29@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911350.158152 usb_transfer_complete#29@3: xfer 0x919edce0 doing done 0x810f9b24 1464911350.158152 usb_transfer_complete#29@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911350.158152 usb_transfer_complete#29@3: <- done xfer 0x919edce0, wakeup 1464911350.158152 usbd_start_next#29@3: called! 1464911350.158153 usbd_start_next#29@3: pipe = 0x9156d3c0, xfer = 0x0 1464911350.158153 usbd_transfer#22@3: <- done transfer 0x919edce0, err = 0 1464911350.158153 usbd_transfer#22@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911350.158153 usbd_free_xfer#22@3: called! 1464911350.158154 usbd_free_xfer#22@3: 0x919edce0 1464911350.158154 usb_freemem#17@3: called! 1464911350.158155 usb_freemem#17@3: frag=0x9bbecf40 1464911350.218143 usbd_get_port_status#18@3: called! 1464911350.218144 usbd_get_port_status#18@3: dev 0x919d95f8 port 1 1464911350.218144 usbd_do_request_flags#23@3: called! 1464911350.218144 usbd_alloc_xfer#23@3: called! 1464911350.218145 usbd_alloc_xfer#23@3: returns 0x919edce0 1464911350.218145 usb_allocmem_flags#18@3: called! 1464911350.218146 usb_allocmem_flags#18@3: use frag=0x9bbecf40 size=4 1464911350.218146 usbd_transfer#23@3: called! 1464911350.218147 usbd_transfer#23@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911350.218147 usb_insert_transfer#23@3: called! 1464911350.218147 usb_insert_transfer#23@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911350.218147 usb_insert_transfer#23@3: <- done xfer 0x919edce0, err 0 1464911350.218148 roothub_ctrl_start#23@3: called! 1464911350.218148 roothub_ctrl_start#23@3: type=0xa3 request= 0 1464911350.218148 ehci_roothub_ctrl#23@3: called! 1464911350.218149 ehci_roothub_ctrl#23@3: type=0xa3 request=00 1464911350.218149 ehci_roothub_ctrl#23@3: get port status i=1 1464911350.218150 ehci_roothub_ctrl#23@3: port status=0x180b 1464911350.218151 ehci_roothub_ctrl#23@3: returning 4 1464911350.218151 roothub_ctrl_start#23@3: xfer 0x919edce0 buflen -1 actlen 4 1464911350.218151 roothub_ctrl_start#23@3: xfer 0x919edce0 err 0 1464911350.218151 usb_transfer_complete#30@3: called! 1464911350.218151 usb_transfer_complete#30@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911350.218152 usb_transfer_complete#30@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911350.218152 usb_transfer_complete#30@3: xfer 0x919edce0 doing done 0x810f9b24 1464911350.218152 usb_transfer_complete#30@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911350.218152 usb_transfer_complete#30@3: <- done xfer 0x919edce0, wakeup 1464911350.218152 usbd_start_next#30@3: called! 1464911350.218153 usbd_start_next#30@3: pipe = 0x9156d3c0, xfer = 0x0 1464911350.218153 usbd_transfer#23@3: <- done transfer 0x919edce0, err = 0 1464911350.218153 usbd_transfer#23@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911350.218154 usbd_free_xfer#23@3: called! 1464911350.218154 usbd_free_xfer#23@3: 0x919edce0 1464911350.218154 usb_freemem#18@3: called! 1464911350.218155 usb_freemem#18@3: frag=0x9bbecf40 1464911350.278144 usbd_get_port_status#19@3: called! 1464911350.278144 usbd_get_port_status#19@3: dev 0x919d95f8 port 1 1464911350.278144 usbd_do_request_flags#24@3: called! 1464911350.278144 usbd_alloc_xfer#24@3: called! 1464911350.278145 usbd_alloc_xfer#24@3: returns 0x919edce0 1464911350.278145 usb_allocmem_flags#19@3: called! 1464911350.278147 usb_allocmem_flags#19@3: use frag=0x9bbecf40 size=4 1464911350.278147 usbd_transfer#24@3: called! 1464911350.278147 usbd_transfer#24@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911350.278147 usb_insert_transfer#24@3: called! 1464911350.278147 usb_insert_transfer#24@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911350.278148 usb_insert_transfer#24@3: <- done xfer 0x919edce0, err 0 1464911350.278148 roothub_ctrl_start#24@3: called! 1464911350.278149 roothub_ctrl_start#24@3: type=0xa3 request= 0 1464911350.278149 ehci_roothub_ctrl#24@3: called! 1464911350.278149 ehci_roothub_ctrl#24@3: type=0xa3 request=00 1464911350.278149 ehci_roothub_ctrl#24@3: get port status i=1 1464911350.278150 ehci_roothub_ctrl#24@3: port status=0x180b 1464911350.278151 ehci_roothub_ctrl#24@3: returning 4 1464911350.278151 roothub_ctrl_start#24@3: xfer 0x919edce0 buflen -1 actlen 4 1464911350.278151 roothub_ctrl_start#24@3: xfer 0x919edce0 err 0 1464911350.278152 usb_transfer_complete#31@3: called! 1464911350.278152 usb_transfer_complete#31@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911350.278152 usb_transfer_complete#31@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911350.278152 usb_transfer_complete#31@3: xfer 0x919edce0 doing done 0x810f9b24 1464911350.278152 usb_transfer_complete#31@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911350.278153 usb_transfer_complete#31@3: <- done xfer 0x919edce0, wakeup 1464911350.278153 usbd_start_next#31@3: called! 1464911350.278153 usbd_start_next#31@3: pipe = 0x9156d3c0, xfer = 0x0 1464911350.278154 usbd_transfer#24@3: <- done transfer 0x919edce0, err = 0 1464911350.278154 usbd_transfer#24@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911350.278154 usbd_free_xfer#24@3: called! 1464911350.278154 usbd_free_xfer#24@3: 0x919edce0 1464911350.278155 usb_freemem#19@3: called! 1464911350.278155 usb_freemem#19@3: frag=0x9bbecf40 1464911350.338144 usbd_get_port_status#20@3: called! 1464911350.338145 usbd_get_port_status#20@3: dev 0x919d95f8 port 1 1464911350.338145 usbd_do_request_flags#25@3: called! 1464911350.338145 usbd_alloc_xfer#25@3: called! 1464911350.338146 usbd_alloc_xfer#25@3: returns 0x919edce0 1464911350.338146 usb_allocmem_flags#20@3: called! 1464911350.338147 usb_allocmem_flags#20@3: use frag=0x9bbecf40 size=4 1464911350.338147 usbd_transfer#25@3: called! 1464911350.338148 usbd_transfer#25@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911350.338148 usb_insert_transfer#25@3: called! 1464911350.338148 usb_insert_transfer#25@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911350.338148 usb_insert_transfer#25@3: <- done xfer 0x919edce0, err 0 1464911350.338149 roothub_ctrl_start#25@3: called! 1464911350.338149 roothub_ctrl_start#25@3: type=0xa3 request= 0 1464911350.338149 ehci_roothub_ctrl#25@3: called! 1464911350.338150 ehci_roothub_ctrl#25@3: type=0xa3 request=00 1464911350.338150 ehci_roothub_ctrl#25@3: get port status i=1 1464911350.338151 ehci_roothub_ctrl#25@3: port status=0x180b 1464911350.338152 ehci_roothub_ctrl#25@3: returning 4 1464911350.338152 roothub_ctrl_start#25@3: xfer 0x919edce0 buflen -1 actlen 4 1464911350.338152 roothub_ctrl_start#25@3: xfer 0x919edce0 err 0 1464911350.338152 usb_transfer_complete#32@3: called! 1464911350.338152 usb_transfer_complete#32@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911350.338153 usb_transfer_complete#32@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911350.338153 usb_transfer_complete#32@3: xfer 0x919edce0 doing done 0x810f9b24 1464911350.338153 usb_transfer_complete#32@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911350.338153 usb_transfer_complete#32@3: <- done xfer 0x919edce0, wakeup 1464911350.338154 usbd_start_next#32@3: called! 1464911350.338154 usbd_start_next#32@3: pipe = 0x9156d3c0, xfer = 0x0 1464911350.338154 usbd_transfer#25@3: <- done transfer 0x919edce0, err = 0 1464911350.338154 usbd_transfer#25@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911350.338155 usbd_free_xfer#25@3: called! 1464911350.338155 usbd_free_xfer#25@3: 0x919edce0 1464911350.338155 usb_freemem#20@3: called! 1464911350.338156 usb_freemem#20@3: frag=0x9bbecf40 1464911350.398145 usbd_get_port_status#21@3: called! 1464911350.398145 usbd_get_port_status#21@3: dev 0x919d95f8 port 1 1464911350.398145 usbd_do_request_flags#26@3: called! 1464911350.398145 usbd_alloc_xfer#26@3: called! 1464911350.398146 usbd_alloc_xfer#26@3: returns 0x919edce0 1464911350.398146 usb_allocmem_flags#21@3: called! 1464911350.398147 usb_allocmem_flags#21@3: use frag=0x9bbecf40 size=4 1464911350.398148 usbd_transfer#26@3: called! 1464911350.398148 usbd_transfer#26@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911350.398148 usb_insert_transfer#26@3: called! 1464911350.398148 usb_insert_transfer#26@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911350.398149 usb_insert_transfer#26@3: <- done xfer 0x919edce0, err 0 1464911350.398149 roothub_ctrl_start#26@3: called! 1464911350.398149 roothub_ctrl_start#26@3: type=0xa3 request= 0 1464911350.398150 ehci_roothub_ctrl#26@3: called! 1464911350.398150 ehci_roothub_ctrl#26@3: type=0xa3 request=00 1464911350.398150 ehci_roothub_ctrl#26@3: get port status i=1 1464911350.398151 ehci_roothub_ctrl#26@3: port status=0x180b 1464911350.398152 ehci_roothub_ctrl#26@3: returning 4 1464911350.398152 roothub_ctrl_start#26@3: xfer 0x919edce0 buflen -1 actlen 4 1464911350.398152 roothub_ctrl_start#26@3: xfer 0x919edce0 err 0 1464911350.398152 usb_transfer_complete#33@3: called! 1464911350.398153 usb_transfer_complete#33@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911350.398153 usb_transfer_complete#33@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911350.398153 usb_transfer_complete#33@3: xfer 0x919edce0 doing done 0x810f9b24 1464911350.398153 usb_transfer_complete#33@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911350.398154 usb_transfer_complete#33@3: <- done xfer 0x919edce0, wakeup 1464911350.398154 usbd_start_next#33@3: called! 1464911350.398154 usbd_start_next#33@3: pipe = 0x9156d3c0, xfer = 0x0 1464911350.398155 usbd_transfer#26@3: <- done transfer 0x919edce0, err = 0 1464911350.398155 usbd_transfer#26@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911350.398155 usbd_free_xfer#26@3: called! 1464911350.398155 usbd_free_xfer#26@3: 0x919edce0 1464911350.398155 usb_freemem#21@3: called! 1464911350.398156 usb_freemem#21@3: frag=0x9bbecf40 1464911350.458145 usbd_get_port_status#22@3: called! 1464911350.458145 usbd_get_port_status#22@3: dev 0x919d95f8 port 1 1464911350.458146 usbd_do_request_flags#27@3: called! 1464911350.458146 usbd_alloc_xfer#27@3: called! 1464911350.458146 usbd_alloc_xfer#27@3: returns 0x919edce0 1464911350.458147 usb_allocmem_flags#22@3: called! 1464911350.458148 usb_allocmem_flags#22@3: use frag=0x9bbecf40 size=4 1464911350.458148 usbd_transfer#27@3: called! 1464911350.458148 usbd_transfer#27@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911350.458149 usb_insert_transfer#27@3: called! 1464911350.458149 usb_insert_transfer#27@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911350.458149 usb_insert_transfer#27@3: <- done xfer 0x919edce0, err 0 1464911350.458150 roothub_ctrl_start#27@3: called! 1464911350.458150 roothub_ctrl_start#27@3: type=0xa3 request= 0 1464911350.458150 ehci_roothub_ctrl#27@3: called! 1464911350.458150 ehci_roothub_ctrl#27@3: type=0xa3 request=00 1464911350.458151 ehci_roothub_ctrl#27@3: get port status i=1 1464911350.458151 ehci_roothub_ctrl#27@3: port status=0x180b 1464911350.458152 ehci_roothub_ctrl#27@3: returning 4 1464911350.458152 roothub_ctrl_start#27@3: xfer 0x919edce0 buflen -1 actlen 4 1464911350.458153 roothub_ctrl_start#27@3: xfer 0x919edce0 err 0 1464911350.458153 usb_transfer_complete#34@3: called! 1464911350.458153 usb_transfer_complete#34@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911350.458153 usb_transfer_complete#34@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911350.458154 usb_transfer_complete#34@3: xfer 0x919edce0 doing done 0x810f9b24 1464911350.458154 usb_transfer_complete#34@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911350.458154 usb_transfer_complete#34@3: <- done xfer 0x919edce0, wakeup 1464911350.458154 usbd_start_next#34@3: called! 1464911350.458154 usbd_start_next#34@3: pipe = 0x9156d3c0, xfer = 0x0 1464911350.458155 usbd_transfer#27@3: <- done transfer 0x919edce0, err = 0 1464911350.458155 usbd_transfer#27@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911350.458155 usbd_free_xfer#27@3: called! 1464911350.458155 usbd_free_xfer#27@3: 0x919edce0 1464911350.458156 usb_freemem#22@3: called! 1464911350.458157 usb_freemem#22@3: frag=0x9bbecf40 1464911350.458601 usb_needs_explore#4@3: called! 1464911350.458603 usbd_get_port_status#23@3: called! 1464911350.458603 usbd_get_port_status#23@3: dev 0x919d95f8 port 1 1464911350.458603 usbd_do_request_flags#28@3: called! 1464911350.458604 usbd_alloc_xfer#28@3: called! 1464911350.458604 usbd_alloc_xfer#28@3: returns 0x919edce0 1464911350.458604 usb_allocmem_flags#23@3: called! 1464911350.458606 usb_allocmem_flags#23@3: use frag=0x9bbecf40 size=4 1464911350.458606 usbd_transfer#28@3: called! 1464911350.458606 usbd_transfer#28@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911350.458606 usb_insert_transfer#28@3: called! 1464911350.458607 usb_insert_transfer#28@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911350.458607 usb_insert_transfer#28@3: <- done xfer 0x919edce0, err 0 1464911350.458607 roothub_ctrl_start#28@3: called! 1464911350.458608 roothub_ctrl_start#28@3: type=0xa3 request= 0 1464911350.458608 ehci_roothub_ctrl#28@3: called! 1464911350.458608 ehci_roothub_ctrl#28@3: type=0xa3 request=00 1464911350.458608 ehci_roothub_ctrl#28@3: get port status i=1 1464911350.458609 ehci_roothub_ctrl#28@3: port status=0x180b 1464911350.458610 ehci_roothub_ctrl#28@3: returning 4 1464911350.458610 roothub_ctrl_start#28@3: xfer 0x919edce0 buflen -1 actlen 4 1464911350.458610 roothub_ctrl_start#28@3: xfer 0x919edce0 err 0 1464911350.458611 usb_transfer_complete#35@3: called! 1464911350.458611 usb_transfer_complete#35@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911350.458611 usb_transfer_complete#35@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911350.458611 usb_transfer_complete#35@3: xfer 0x919edce0 doing done 0x810f9b24 1464911350.458612 usb_transfer_complete#35@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911350.458612 usb_transfer_complete#35@3: <- done xfer 0x919edce0, wakeup 1464911350.458612 usbd_start_next#35@3: called! 1464911350.458612 usbd_start_next#35@3: pipe = 0x9156d3c0, xfer = 0x0 1464911350.458613 usbd_transfer#28@3: <- done transfer 0x919edce0, err = 0 1464911350.458613 usbd_transfer#28@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911350.458613 usbd_free_xfer#28@3: called! 1464911350.458614 usbd_free_xfer#28@3: 0x919edce0 1464911350.458614 usb_freemem#23@3: called! 1464911350.458614 usb_freemem#23@3: frag=0x9bbecf40 1464911350.458616 usbd_clear_port_feature#4@3: called! 1464911350.458616 usbd_clear_port_feature#4@3: dev 0x919d95f8 port 1 sel 17 1464911350.458616 usbd_do_request_flags#29@3: called! 1464911350.458616 usbd_alloc_xfer#29@3: called! 1464911350.458617 usbd_alloc_xfer#29@3: returns 0x919edce0 1464911350.458617 usbd_transfer#29@3: called! 1464911350.458617 usbd_transfer#29@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911350.458618 usb_insert_transfer#29@3: called! 1464911350.458618 usb_insert_transfer#29@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911350.458618 usb_insert_transfer#29@3: <- done xfer 0x919edce0, err 0 1464911350.458619 roothub_ctrl_start#29@3: called! 1464911350.458619 roothub_ctrl_start#29@3: type=0x23 request=0x1 1464911350.458619 ehci_roothub_ctrl#29@3: called! 1464911350.458619 ehci_roothub_ctrl#29@3: type=0x23 request=01 1464911350.458620 ehci_roothub_ctrl#29@3: UR_CLEAR_PORT_FEATURE port=1 feature=17 1464911350.458620 ehci_roothub_ctrl#29@3: portsc=0x0000180b 1464911350.458621 ehci_roothub_ctrl#29@3: returning 0 1464911350.458621 roothub_ctrl_start#29@3: xfer 0x919edce0 buflen -1 actlen 0 1464911350.458621 roothub_ctrl_start#29@3: xfer 0x919edce0 err 0 1464911350.458621 usb_transfer_complete#36@3: called! 1464911350.458622 usb_transfer_complete#36@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 0 1464911350.458622 usb_transfer_complete#36@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911350.458622 usb_transfer_complete#36@3: xfer 0x919edce0 doing done 0x810f9b24 1464911350.458622 usb_transfer_complete#36@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911350.458622 usb_transfer_complete#36@3: <- done xfer 0x919edce0, wakeup 1464911350.458623 usbd_start_next#36@3: called! 1464911350.458623 usbd_start_next#36@3: pipe = 0x9156d3c0, xfer = 0x0 1464911350.458623 usbd_transfer#29@3: <- done transfer 0x919edce0, err = 0 1464911350.458624 usbd_transfer#29@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911350.458624 usbd_free_xfer#29@3: called! 1464911350.458624 usbd_free_xfer#29@3: 0x919edce0 1464911350.458625 usbd_clear_port_feature#5@3: called! 1464911350.458625 usbd_clear_port_feature#5@3: dev 0x919d95f8 port 1 sel 16 1464911350.458625 usbd_do_request_flags#30@3: called! 1464911350.458626 usbd_alloc_xfer#30@3: called! 1464911350.458626 usbd_alloc_xfer#30@3: returns 0x919edce0 1464911350.458626 usbd_transfer#30@3: called! 1464911350.458627 usbd_transfer#30@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911350.458627 usb_insert_transfer#30@3: called! 1464911350.458627 usb_insert_transfer#30@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911350.458627 usb_insert_transfer#30@3: <- done xfer 0x919edce0, err 0 1464911350.458628 roothub_ctrl_start#30@3: called! 1464911350.458628 roothub_ctrl_start#30@3: type=0x23 request=0x1 1464911350.458628 ehci_roothub_ctrl#30@3: called! 1464911350.458628 ehci_roothub_ctrl#30@3: type=0x23 request=01 1464911350.458629 ehci_roothub_ctrl#30@3: UR_CLEAR_PORT_FEATURE port=1 feature=16 1464911350.458630 ehci_roothub_ctrl#30@3: portsc=0x00001803 1464911350.458630 ehci_roothub_ctrl#30@3: returning 0 1464911350.458630 roothub_ctrl_start#30@3: xfer 0x919edce0 buflen -1 actlen 0 1464911350.458630 roothub_ctrl_start#30@3: xfer 0x919edce0 err 0 1464911350.458631 usb_transfer_complete#37@3: called! 1464911350.458631 usb_transfer_complete#37@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 0 1464911350.458631 usb_transfer_complete#37@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911350.458632 usb_transfer_complete#37@3: xfer 0x919edce0 doing done 0x810f9b24 1464911350.458632 usb_transfer_complete#37@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911350.458632 usb_transfer_complete#37@3: <- done xfer 0x919edce0, wakeup 1464911350.458632 usbd_start_next#37@3: called! 1464911350.458632 usbd_start_next#37@3: pipe = 0x9156d3c0, xfer = 0x0 1464911350.458633 usbd_transfer#30@3: <- done transfer 0x919edce0, err = 0 1464911350.458633 usbd_transfer#30@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911350.458633 usbd_free_xfer#30@3: called! 1464911350.458633 usbd_free_xfer#30@3: 0x919edce0 1464911350.768148 usbd_reset_port#3@3: called! 1464911350.768148 usbd_do_request_flags#31@3: called! 1464911350.768148 usbd_alloc_xfer#31@3: called! 1464911350.768149 usbd_alloc_xfer#31@3: returns 0x919edce0 1464911350.768149 usbd_transfer#31@3: called! 1464911350.768149 usbd_transfer#31@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911350.768150 usb_insert_transfer#31@3: called! 1464911350.768150 usb_insert_transfer#31@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911350.768150 usb_insert_transfer#31@3: <- done xfer 0x919edce0, err 0 1464911350.768151 roothub_ctrl_start#31@3: called! 1464911350.768151 roothub_ctrl_start#31@3: type=0x23 request=0x3 1464911350.768151 ehci_roothub_ctrl#31@3: called! 1464911350.768151 ehci_roothub_ctrl#31@3: type=0x23 request=03 1464911350.768152 ehci_roothub_ctrl#31@3: portsc=0x00001801 1464911350.768152 ehci_roothub_ctrl#31@3: reset port 1 1464911350.818155 ehci_intr#8@2: called! 1464911350.818155 ehci_intr1#8@2: called! 1464911350.818156 ehci_intr1#8@2: sc=0x919d7008 intrs=0xc(0xc08c) eintrs=0x4 1464911350.818158 ehci_pcd#8@2: called! 1464911350.818159 usb_transfer_complete#38@2: called! 1464911350.818159 usb_transfer_complete#38@2: pipe = 0x9156d2e0 xfer = 0x919edea0 status = 0 actlen = 1 1464911350.818159 usb_transfer_complete#38@2: xfer 0x919edea0: repeat 1 new head = 0x919edea0 1464911350.818160 usb_transfer_complete#38@2: xfer 0x919edea0 doing done 0x810fa5e8 1464911350.818160 usb_transfer_complete#38@2: xfer 0x919edea0 doing callback 0x81066ed0 status 0 1464911350.818161 usb_needs_explore#5@2: called! 1464911350.818162 usbd_start_next#38@2: called! 1464911350.818162 usbd_start_next#38@2: pipe = 0x9156d2e0, xfer = 0x919edea0 1464911350.818196 ehci_intr#9@3: called! 1464911350.818197 ehci_intr1#9@3: called! 1464911350.818198 ehci_intr1#9@3: sc=0x919d7008 intrs=0x4(0xc084) eintrs=0x4 1464911350.818200 ehci_pcd#9@3: called! 1464911350.818202 usb_transfer_complete#39@3: called! 1464911350.818202 usb_transfer_complete#39@3: pipe = 0x9156d2e0 xfer = 0x919edea0 status = 0 actlen = 1 1464911350.818202 usb_transfer_complete#39@3: xfer 0x919edea0: repeat 1 new head = 0x919edea0 1464911350.818202 usb_transfer_complete#39@3: xfer 0x919edea0 doing done 0x810fa5e8 1464911350.818202 usb_transfer_complete#39@3: xfer 0x919edea0 doing callback 0x81066ed0 status 0 1464911350.818204 usbd_start_next#39@3: called! 1464911350.818204 usbd_start_next#39@3: pipe = 0x9156d2e0, xfer = 0x919edea0 1464911350.821268 ehci_intr#10@1: called! 1464911350.821269 ehci_intr1#10@1: called! 1464911350.821270 ehci_intr1#10@1: sc=0x919d7008 intrs=0x4(0xc084) eintrs=0x4 1464911350.821272 ehci_pcd#10@1: called! 1464911350.821274 usb_transfer_complete#40@1: called! 1464911350.821274 usb_transfer_complete#40@1: pipe = 0x9156d2e0 xfer = 0x919edea0 status = 0 actlen = 1 1464911350.821274 usb_transfer_complete#40@1: xfer 0x919edea0: repeat 1 new head = 0x919edea0 1464911350.821274 usb_transfer_complete#40@1: xfer 0x919edea0 doing done 0x810fa5e8 1464911350.821274 usb_transfer_complete#40@1: xfer 0x919edea0 doing callback 0x81066ed0 status 0 1464911350.821276 usbd_start_next#40@1: called! 1464911350.821276 usbd_start_next#40@1: pipe = 0x9156d2e0, xfer = 0x919edea0 1464911351.028151 ehci_roothub_ctrl#31@3: ehci after reset, status=0x0000180b 1464911351.028151 ehci_disown#3@3: called! 1464911351.028152 ehci_disown#3@3: index=1 lowspeed=0 1464911351.028183 ehci_roothub_ctrl#31@3: returning 0 1464911351.028183 roothub_ctrl_start#31@3: xfer 0x919edce0 buflen -1 actlen 0 1464911351.028183 roothub_ctrl_start#31@3: xfer 0x919edce0 err 0 1464911351.028184 usb_transfer_complete#41@3: called! 1464911351.028184 usb_transfer_complete#41@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 0 1464911351.028184 usb_transfer_complete#41@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911351.028184 usb_transfer_complete#41@3: xfer 0x919edce0 doing done 0x810f9b24 1464911351.028184 usb_transfer_complete#41@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911351.028185 usb_transfer_complete#41@3: <- done xfer 0x919edce0, wakeup 1464911351.028185 usbd_start_next#41@3: called! 1464911351.028185 usbd_start_next#41@3: pipe = 0x9156d3c0, xfer = 0x0 1464911351.028186 usbd_transfer#31@3: <- done transfer 0x919edce0, err = 0 1464911351.028186 usbd_transfer#31@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911351.028186 usbd_free_xfer#31@3: called! 1464911351.028186 usbd_free_xfer#31@3: 0x919edce0 1464911351.028187 usbd_reset_port#3@3: port 1 reset done, error=0 1464911351.088150 usbd_get_port_status#24@3: called! 1464911351.088150 usbd_get_port_status#24@3: dev 0x919d95f8 port 1 1464911351.088151 usbd_do_request_flags#32@3: called! 1464911351.088151 usbd_alloc_xfer#32@3: called! 1464911351.088152 usbd_alloc_xfer#32@3: returns 0x919edce0 1464911351.088152 usb_allocmem_flags#24@3: called! 1464911351.088153 usb_allocmem_flags#24@3: use frag=0x9bbecf40 size=4 1464911351.088153 usbd_transfer#32@3: called! 1464911351.088154 usbd_transfer#32@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911351.088154 usb_insert_transfer#32@3: called! 1464911351.088154 usb_insert_transfer#32@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911351.088154 usb_insert_transfer#32@3: <- done xfer 0x919edce0, err 0 1464911351.088155 roothub_ctrl_start#32@3: called! 1464911351.088155 roothub_ctrl_start#32@3: type=0xa3 request= 0 1464911351.088155 ehci_roothub_ctrl#32@3: called! 1464911351.088155 ehci_roothub_ctrl#32@3: type=0xa3 request=00 1464911351.088156 ehci_roothub_ctrl#32@3: get port status i=1 1464911351.088157 ehci_roothub_ctrl#32@3: port status=0x180b 1464911351.088157 ehci_roothub_ctrl#32@3: returning 4 1464911351.088158 roothub_ctrl_start#32@3: xfer 0x919edce0 buflen -1 actlen 4 1464911351.088158 roothub_ctrl_start#32@3: xfer 0x919edce0 err 0 1464911351.088158 usb_transfer_complete#42@3: called! 1464911351.088158 usb_transfer_complete#42@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911351.088158 usb_transfer_complete#42@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911351.088159 usb_transfer_complete#42@3: xfer 0x919edce0 doing done 0x810f9b24 1464911351.088159 usb_transfer_complete#42@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911351.088159 usb_transfer_complete#42@3: <- done xfer 0x919edce0, wakeup 1464911351.088159 usbd_start_next#42@3: called! 1464911351.088160 usbd_start_next#42@3: pipe = 0x9156d3c0, xfer = 0x0 1464911351.088160 usbd_transfer#32@3: <- done transfer 0x919edce0, err = 0 1464911351.088160 usbd_transfer#32@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911351.088161 usbd_free_xfer#32@3: called! 1464911351.088161 usbd_free_xfer#32@3: 0x919edce0 1464911351.088161 usb_freemem#24@3: called! 1464911351.088162 usb_freemem#24@3: frag=0x9bbecf40 1464911351.148151 usbd_get_port_status#25@3: called! 1464911351.148151 usbd_get_port_status#25@3: dev 0x919d95f8 port 1 1464911351.148151 usbd_do_request_flags#33@3: called! 1464911351.148152 usbd_alloc_xfer#33@3: called! 1464911351.148152 usbd_alloc_xfer#33@3: returns 0x919edce0 1464911351.148152 usb_allocmem_flags#25@3: called! 1464911351.148154 usb_allocmem_flags#25@3: use frag=0x9bbecf40 size=4 1464911351.148154 usbd_transfer#33@3: called! 1464911351.148154 usbd_transfer#33@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911351.148154 usb_insert_transfer#33@3: called! 1464911351.148154 usb_insert_transfer#33@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911351.148155 usb_insert_transfer#33@3: <- done xfer 0x919edce0, err 0 1464911351.148155 roothub_ctrl_start#33@3: called! 1464911351.148155 roothub_ctrl_start#33@3: type=0xa3 request= 0 1464911351.148156 ehci_roothub_ctrl#33@3: called! 1464911351.148156 ehci_roothub_ctrl#33@3: type=0xa3 request=00 1464911351.148156 ehci_roothub_ctrl#33@3: get port status i=1 1464911351.148157 ehci_roothub_ctrl#33@3: port status=0x180b 1464911351.148158 ehci_roothub_ctrl#33@3: returning 4 1464911351.148158 roothub_ctrl_start#33@3: xfer 0x919edce0 buflen -1 actlen 4 1464911351.148159 roothub_ctrl_start#33@3: xfer 0x919edce0 err 0 1464911351.148159 usb_transfer_complete#43@3: called! 1464911351.148159 usb_transfer_complete#43@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911351.148159 usb_transfer_complete#43@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911351.148160 usb_transfer_complete#43@3: xfer 0x919edce0 doing done 0x810f9b24 1464911351.148160 usb_transfer_complete#43@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911351.148160 usb_transfer_complete#43@3: <- done xfer 0x919edce0, wakeup 1464911351.148160 usbd_start_next#43@3: called! 1464911351.148161 usbd_start_next#43@3: pipe = 0x9156d3c0, xfer = 0x0 1464911351.148161 usbd_transfer#33@3: <- done transfer 0x919edce0, err = 0 1464911351.148161 usbd_transfer#33@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911351.148161 usbd_free_xfer#33@3: called! 1464911351.148162 usbd_free_xfer#33@3: 0x919edce0 1464911351.148162 usb_freemem#25@3: called! 1464911351.148162 usb_freemem#25@3: frag=0x9bbecf40 1464911351.208151 usbd_get_port_status#26@3: called! 1464911351.208152 usbd_get_port_status#26@3: dev 0x919d95f8 port 1 1464911351.208152 usbd_do_request_flags#34@3: called! 1464911351.208152 usbd_alloc_xfer#34@3: called! 1464911351.208153 usbd_alloc_xfer#34@3: returns 0x919edce0 1464911351.208153 usb_allocmem_flags#26@3: called! 1464911351.208154 usb_allocmem_flags#26@3: use frag=0x9bbecf40 size=4 1464911351.208154 usbd_transfer#34@3: called! 1464911351.208155 usbd_transfer#34@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911351.208155 usb_insert_transfer#34@3: called! 1464911351.208155 usb_insert_transfer#34@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911351.208155 usb_insert_transfer#34@3: <- done xfer 0x919edce0, err 0 1464911351.208156 roothub_ctrl_start#34@3: called! 1464911351.208156 roothub_ctrl_start#34@3: type=0xa3 request= 0 1464911351.208156 ehci_roothub_ctrl#34@3: called! 1464911351.208157 ehci_roothub_ctrl#34@3: type=0xa3 request=00 1464911351.208157 ehci_roothub_ctrl#34@3: get port status i=1 1464911351.208158 ehci_roothub_ctrl#34@3: port status=0x180b 1464911351.208158 ehci_roothub_ctrl#34@3: returning 4 1464911351.208159 roothub_ctrl_start#34@3: xfer 0x919edce0 buflen -1 actlen 4 1464911351.208159 roothub_ctrl_start#34@3: xfer 0x919edce0 err 0 1464911351.208159 usb_transfer_complete#44@3: called! 1464911351.208159 usb_transfer_complete#44@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911351.208160 usb_transfer_complete#44@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911351.208160 usb_transfer_complete#44@3: xfer 0x919edce0 doing done 0x810f9b24 1464911351.208160 usb_transfer_complete#44@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911351.208160 usb_transfer_complete#44@3: <- done xfer 0x919edce0, wakeup 1464911351.208160 usbd_start_next#44@3: called! 1464911351.208161 usbd_start_next#44@3: pipe = 0x9156d3c0, xfer = 0x0 1464911351.208161 usbd_transfer#34@3: <- done transfer 0x919edce0, err = 0 1464911351.208161 usbd_transfer#34@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911351.208162 usbd_free_xfer#34@3: called! 1464911351.208162 usbd_free_xfer#34@3: 0x919edce0 1464911351.208162 usb_freemem#26@3: called! 1464911351.208163 usb_freemem#26@3: frag=0x9bbecf40 1464911351.268152 usbd_get_port_status#27@3: called! 1464911351.268152 usbd_get_port_status#27@3: dev 0x919d95f8 port 1 1464911351.268152 usbd_do_request_flags#35@3: called! 1464911351.268152 usbd_alloc_xfer#35@3: called! 1464911351.268153 usbd_alloc_xfer#35@3: returns 0x919edce0 1464911351.268153 usb_allocmem_flags#27@3: called! 1464911351.268154 usb_allocmem_flags#27@3: use frag=0x9bbecf40 size=4 1464911351.268155 usbd_transfer#35@3: called! 1464911351.268155 usbd_transfer#35@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911351.268155 usb_insert_transfer#35@3: called! 1464911351.268156 usb_insert_transfer#35@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911351.268156 usb_insert_transfer#35@3: <- done xfer 0x919edce0, err 0 1464911351.268156 roothub_ctrl_start#35@3: called! 1464911351.268156 roothub_ctrl_start#35@3: type=0xa3 request= 0 1464911351.268157 ehci_roothub_ctrl#35@3: called! 1464911351.268157 ehci_roothub_ctrl#35@3: type=0xa3 request=00 1464911351.268157 ehci_roothub_ctrl#35@3: get port status i=1 1464911351.268158 ehci_roothub_ctrl#35@3: port status=0x180b 1464911351.268159 ehci_roothub_ctrl#35@3: returning 4 1464911351.268159 roothub_ctrl_start#35@3: xfer 0x919edce0 buflen -1 actlen 4 1464911351.268159 roothub_ctrl_start#35@3: xfer 0x919edce0 err 0 1464911351.268160 usb_transfer_complete#45@3: called! 1464911351.268160 usb_transfer_complete#45@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911351.268160 usb_transfer_complete#45@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911351.268160 usb_transfer_complete#45@3: xfer 0x919edce0 doing done 0x810f9b24 1464911351.268160 usb_transfer_complete#45@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911351.268161 usb_transfer_complete#45@3: <- done xfer 0x919edce0, wakeup 1464911351.268161 usbd_start_next#45@3: called! 1464911351.268161 usbd_start_next#45@3: pipe = 0x9156d3c0, xfer = 0x0 1464911351.268162 usbd_transfer#35@3: <- done transfer 0x919edce0, err = 0 1464911351.268162 usbd_transfer#35@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911351.268162 usbd_free_xfer#35@3: called! 1464911351.268162 usbd_free_xfer#35@3: 0x919edce0 1464911351.268163 usb_freemem#27@3: called! 1464911351.268163 usb_freemem#27@3: frag=0x9bbecf40 1464911351.328152 usbd_get_port_status#28@3: called! 1464911351.328152 usbd_get_port_status#28@3: dev 0x919d95f8 port 1 1464911351.328153 usbd_do_request_flags#36@3: called! 1464911351.328153 usbd_alloc_xfer#36@3: called! 1464911351.328154 usbd_alloc_xfer#36@3: returns 0x919edce0 1464911351.328154 usb_allocmem_flags#28@3: called! 1464911351.328155 usb_allocmem_flags#28@3: use frag=0x9bbecf40 size=4 1464911351.328156 usbd_transfer#36@3: called! 1464911351.328156 usbd_transfer#36@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911351.328156 usb_insert_transfer#36@3: called! 1464911351.328156 usb_insert_transfer#36@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911351.328156 usb_insert_transfer#36@3: <- done xfer 0x919edce0, err 0 1464911351.328157 roothub_ctrl_start#36@3: called! 1464911351.328157 roothub_ctrl_start#36@3: type=0xa3 request= 0 1464911351.328158 ehci_roothub_ctrl#36@3: called! 1464911351.328158 ehci_roothub_ctrl#36@3: type=0xa3 request=00 1464911351.328158 ehci_roothub_ctrl#36@3: get port status i=1 1464911351.328159 ehci_roothub_ctrl#36@3: port status=0x180b 1464911351.328160 ehci_roothub_ctrl#36@3: returning 4 1464911351.328160 roothub_ctrl_start#36@3: xfer 0x919edce0 buflen -1 actlen 4 1464911351.328160 roothub_ctrl_start#36@3: xfer 0x919edce0 err 0 1464911351.328161 usb_transfer_complete#46@3: called! 1464911351.328161 usb_transfer_complete#46@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911351.328161 usb_transfer_complete#46@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911351.328161 usb_transfer_complete#46@3: xfer 0x919edce0 doing done 0x810f9b24 1464911351.328162 usb_transfer_complete#46@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911351.328162 usb_transfer_complete#46@3: <- done xfer 0x919edce0, wakeup 1464911351.328162 usbd_start_next#46@3: called! 1464911351.328162 usbd_start_next#46@3: pipe = 0x9156d3c0, xfer = 0x0 1464911351.328163 usbd_transfer#36@3: <- done transfer 0x919edce0, err = 0 1464911351.328163 usbd_transfer#36@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911351.328163 usbd_free_xfer#36@3: called! 1464911351.328163 usbd_free_xfer#36@3: 0x919edce0 1464911351.328164 usb_freemem#28@3: called! 1464911351.328164 usb_freemem#28@3: frag=0x9bbecf40 1464911351.388153 usbd_get_port_status#29@3: called! 1464911351.388153 usbd_get_port_status#29@3: dev 0x919d95f8 port 1 1464911351.388153 usbd_do_request_flags#37@3: called! 1464911351.388153 usbd_alloc_xfer#37@3: called! 1464911351.388154 usbd_alloc_xfer#37@3: returns 0x919edce0 1464911351.388154 usb_allocmem_flags#29@3: called! 1464911351.388156 usb_allocmem_flags#29@3: use frag=0x9bbecf40 size=4 1464911351.388156 usbd_transfer#37@3: called! 1464911351.388156 usbd_transfer#37@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911351.388156 usb_insert_transfer#37@3: called! 1464911351.388157 usb_insert_transfer#37@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911351.388157 usb_insert_transfer#37@3: <- done xfer 0x919edce0, err 0 1464911351.388158 roothub_ctrl_start#37@3: called! 1464911351.388158 roothub_ctrl_start#37@3: type=0xa3 request= 0 1464911351.388158 ehci_roothub_ctrl#37@3: called! 1464911351.388158 ehci_roothub_ctrl#37@3: type=0xa3 request=00 1464911351.388158 ehci_roothub_ctrl#37@3: get port status i=1 1464911351.388159 ehci_roothub_ctrl#37@3: port status=0x180b 1464911351.388160 ehci_roothub_ctrl#37@3: returning 4 1464911351.388160 roothub_ctrl_start#37@3: xfer 0x919edce0 buflen -1 actlen 4 1464911351.388161 roothub_ctrl_start#37@3: xfer 0x919edce0 err 0 1464911351.388161 usb_transfer_complete#47@3: called! 1464911351.388161 usb_transfer_complete#47@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911351.388161 usb_transfer_complete#47@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911351.388161 usb_transfer_complete#47@3: xfer 0x919edce0 doing done 0x810f9b24 1464911351.388162 usb_transfer_complete#47@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911351.388162 usb_transfer_complete#47@3: <- done xfer 0x919edce0, wakeup 1464911351.388162 usbd_start_next#47@3: called! 1464911351.388162 usbd_start_next#47@3: pipe = 0x9156d3c0, xfer = 0x0 1464911351.388163 usbd_transfer#37@3: <- done transfer 0x919edce0, err = 0 1464911351.388163 usbd_transfer#37@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911351.388163 usbd_free_xfer#37@3: called! 1464911351.388163 usbd_free_xfer#37@3: 0x919edce0 1464911351.388164 usb_freemem#29@3: called! 1464911351.388165 usb_freemem#29@3: frag=0x9bbecf40 1464911351.448153 usbd_get_port_status#30@3: called! 1464911351.448153 usbd_get_port_status#30@3: dev 0x919d95f8 port 1 1464911351.448154 usbd_do_request_flags#38@3: called! 1464911351.448154 usbd_alloc_xfer#38@3: called! 1464911351.448154 usbd_alloc_xfer#38@3: returns 0x919edce0 1464911351.448155 usb_allocmem_flags#30@3: called! 1464911351.448156 usb_allocmem_flags#30@3: use frag=0x9bbecf40 size=4 1464911351.448156 usbd_transfer#38@3: called! 1464911351.448156 usbd_transfer#38@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911351.448157 usb_insert_transfer#38@3: called! 1464911351.448157 usb_insert_transfer#38@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911351.448157 usb_insert_transfer#38@3: <- done xfer 0x919edce0, err 0 1464911351.448158 roothub_ctrl_start#38@3: called! 1464911351.448158 roothub_ctrl_start#38@3: type=0xa3 request= 0 1464911351.448158 ehci_roothub_ctrl#38@3: called! 1464911351.448158 ehci_roothub_ctrl#38@3: type=0xa3 request=00 1464911351.448159 ehci_roothub_ctrl#38@3: get port status i=1 1464911351.448159 ehci_roothub_ctrl#38@3: port status=0x180b 1464911351.448160 ehci_roothub_ctrl#38@3: returning 4 1464911351.448160 roothub_ctrl_start#38@3: xfer 0x919edce0 buflen -1 actlen 4 1464911351.448161 roothub_ctrl_start#38@3: xfer 0x919edce0 err 0 1464911351.448161 usb_transfer_complete#48@3: called! 1464911351.448161 usb_transfer_complete#48@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911351.448161 usb_transfer_complete#48@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911351.448162 usb_transfer_complete#48@3: xfer 0x919edce0 doing done 0x810f9b24 1464911351.448162 usb_transfer_complete#48@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911351.448162 usb_transfer_complete#48@3: <- done xfer 0x919edce0, wakeup 1464911351.448162 usbd_start_next#48@3: called! 1464911351.448163 usbd_start_next#48@3: pipe = 0x9156d3c0, xfer = 0x0 1464911351.448163 usbd_transfer#38@3: <- done transfer 0x919edce0, err = 0 1464911351.448163 usbd_transfer#38@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911351.448164 usbd_free_xfer#38@3: called! 1464911351.448164 usbd_free_xfer#38@3: 0x919edce0 1464911351.448164 usb_freemem#30@3: called! 1464911351.448165 usb_freemem#30@3: frag=0x9bbecf40 1464911351.508154 usbd_get_port_status#31@3: called! 1464911351.508154 usbd_get_port_status#31@3: dev 0x919d95f8 port 1 1464911351.508154 usbd_do_request_flags#39@3: called! 1464911351.508154 usbd_alloc_xfer#39@3: called! 1464911351.508155 usbd_alloc_xfer#39@3: returns 0x919edce0 1464911351.508155 usb_allocmem_flags#31@3: called! 1464911351.508157 usb_allocmem_flags#31@3: use frag=0x9bbecf40 size=4 1464911351.508157 usbd_transfer#39@3: called! 1464911351.508157 usbd_transfer#39@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911351.508157 usb_insert_transfer#39@3: called! 1464911351.508158 usb_insert_transfer#39@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911351.508158 usb_insert_transfer#39@3: <- done xfer 0x919edce0, err 0 1464911351.508158 roothub_ctrl_start#39@3: called! 1464911351.508159 roothub_ctrl_start#39@3: type=0xa3 request= 0 1464911351.508159 ehci_roothub_ctrl#39@3: called! 1464911351.508159 ehci_roothub_ctrl#39@3: type=0xa3 request=00 1464911351.508159 ehci_roothub_ctrl#39@3: get port status i=1 1464911351.508160 ehci_roothub_ctrl#39@3: port status=0x180b 1464911351.508161 ehci_roothub_ctrl#39@3: returning 4 1464911351.508161 roothub_ctrl_start#39@3: xfer 0x919edce0 buflen -1 actlen 4 1464911351.508161 roothub_ctrl_start#39@3: xfer 0x919edce0 err 0 1464911351.508162 usb_transfer_complete#49@3: called! 1464911351.508162 usb_transfer_complete#49@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911351.508162 usb_transfer_complete#49@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911351.508162 usb_transfer_complete#49@3: xfer 0x919edce0 doing done 0x810f9b24 1464911351.508163 usb_transfer_complete#49@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911351.508163 usb_transfer_complete#49@3: <- done xfer 0x919edce0, wakeup 1464911351.508163 usbd_start_next#49@3: called! 1464911351.508163 usbd_start_next#49@3: pipe = 0x9156d3c0, xfer = 0x0 1464911351.508164 usbd_transfer#39@3: <- done transfer 0x919edce0, err = 0 1464911351.508164 usbd_transfer#39@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911351.508164 usbd_free_xfer#39@3: called! 1464911351.508165 usbd_free_xfer#39@3: 0x919edce0 1464911351.508165 usb_freemem#31@3: called! 1464911351.508165 usb_freemem#31@3: frag=0x9bbecf40 1464911351.568154 usbd_get_port_status#32@3: called! 1464911351.568154 usbd_get_port_status#32@3: dev 0x919d95f8 port 1 1464911351.568155 usbd_do_request_flags#40@3: called! 1464911351.568155 usbd_alloc_xfer#40@3: called! 1464911351.568155 usbd_alloc_xfer#40@3: returns 0x919edce0 1464911351.568156 usb_allocmem_flags#32@3: called! 1464911351.568157 usb_allocmem_flags#32@3: use frag=0x9bbecf40 size=4 1464911351.568157 usbd_transfer#40@3: called! 1464911351.568158 usbd_transfer#40@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911351.568158 usb_insert_transfer#40@3: called! 1464911351.568158 usb_insert_transfer#40@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911351.568158 usb_insert_transfer#40@3: <- done xfer 0x919edce0, err 0 1464911351.568159 roothub_ctrl_start#40@3: called! 1464911351.568159 roothub_ctrl_start#40@3: type=0xa3 request= 0 1464911351.568159 ehci_roothub_ctrl#40@3: called! 1464911351.568159 ehci_roothub_ctrl#40@3: type=0xa3 request=00 1464911351.568160 ehci_roothub_ctrl#40@3: get port status i=1 1464911351.568160 ehci_roothub_ctrl#40@3: port status=0x180b 1464911351.568161 ehci_roothub_ctrl#40@3: returning 4 1464911351.568162 roothub_ctrl_start#40@3: xfer 0x919edce0 buflen -1 actlen 4 1464911351.568162 roothub_ctrl_start#40@3: xfer 0x919edce0 err 0 1464911351.568162 usb_transfer_complete#50@3: called! 1464911351.568162 usb_transfer_complete#50@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911351.568162 usb_transfer_complete#50@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911351.568163 usb_transfer_complete#50@3: xfer 0x919edce0 doing done 0x810f9b24 1464911351.568163 usb_transfer_complete#50@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911351.568163 usb_transfer_complete#50@3: <- done xfer 0x919edce0, wakeup 1464911351.568163 usbd_start_next#50@3: called! 1464911351.568163 usbd_start_next#50@3: pipe = 0x9156d3c0, xfer = 0x0 1464911351.568164 usbd_transfer#40@3: <- done transfer 0x919edce0, err = 0 1464911351.568164 usbd_transfer#40@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911351.568164 usbd_free_xfer#40@3: called! 1464911351.568165 usbd_free_xfer#40@3: 0x919edce0 1464911351.568165 usb_freemem#32@3: called! 1464911351.568166 usb_freemem#32@3: frag=0x9bbecf40 1464911351.628155 usbd_get_port_status#33@3: called! 1464911351.628155 usbd_get_port_status#33@3: dev 0x919d95f8 port 1 1464911351.628155 usbd_do_request_flags#41@3: called! 1464911351.628155 usbd_alloc_xfer#41@3: called! 1464911351.628156 usbd_alloc_xfer#41@3: returns 0x919edce0 1464911351.628156 usb_allocmem_flags#33@3: called! 1464911351.628157 usb_allocmem_flags#33@3: use frag=0x9bbecf40 size=4 1464911351.628158 usbd_transfer#41@3: called! 1464911351.628158 usbd_transfer#41@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911351.628158 usb_insert_transfer#41@3: called! 1464911351.628158 usb_insert_transfer#41@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911351.628159 usb_insert_transfer#41@3: <- done xfer 0x919edce0, err 0 1464911351.628159 roothub_ctrl_start#41@3: called! 1464911351.628159 roothub_ctrl_start#41@3: type=0xa3 request= 0 1464911351.628160 ehci_roothub_ctrl#41@3: called! 1464911351.628160 ehci_roothub_ctrl#41@3: type=0xa3 request=00 1464911351.628160 ehci_roothub_ctrl#41@3: get port status i=1 1464911351.628161 ehci_roothub_ctrl#41@3: port status=0x180b 1464911351.628162 ehci_roothub_ctrl#41@3: returning 4 1464911351.628162 roothub_ctrl_start#41@3: xfer 0x919edce0 buflen -1 actlen 4 1464911351.628162 roothub_ctrl_start#41@3: xfer 0x919edce0 err 0 1464911351.628163 usb_transfer_complete#51@3: called! 1464911351.628163 usb_transfer_complete#51@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911351.628163 usb_transfer_complete#51@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911351.628163 usb_transfer_complete#51@3: xfer 0x919edce0 doing done 0x810f9b24 1464911351.628164 usb_transfer_complete#51@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911351.628164 usb_transfer_complete#51@3: <- done xfer 0x919edce0, wakeup 1464911351.628164 usbd_start_next#51@3: called! 1464911351.628164 usbd_start_next#51@3: pipe = 0x9156d3c0, xfer = 0x0 1464911351.628165 usbd_transfer#41@3: <- done transfer 0x919edce0, err = 0 1464911351.628165 usbd_transfer#41@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911351.628165 usbd_free_xfer#41@3: called! 1464911351.628165 usbd_free_xfer#41@3: 0x919edce0 1464911351.628166 usb_freemem#33@3: called! 1464911351.628166 usb_freemem#33@3: frag=0x9bbecf40 1464911351.628612 usb_needs_explore#6@3: called! 1464911351.628614 usbd_get_port_status#34@3: called! 1464911351.628614 usbd_get_port_status#34@3: dev 0x919d95f8 port 1 1464911351.628615 usbd_do_request_flags#42@3: called! 1464911351.628615 usbd_alloc_xfer#42@3: called! 1464911351.628615 usbd_alloc_xfer#42@3: returns 0x919edce0 1464911351.628616 usb_allocmem_flags#34@3: called! 1464911351.628617 usb_allocmem_flags#34@3: use frag=0x9bbecf40 size=4 1464911351.628617 usbd_transfer#42@3: called! 1464911351.628617 usbd_transfer#42@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911351.628618 usb_insert_transfer#42@3: called! 1464911351.628618 usb_insert_transfer#42@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911351.628618 usb_insert_transfer#42@3: <- done xfer 0x919edce0, err 0 1464911351.628619 roothub_ctrl_start#42@3: called! 1464911351.628619 roothub_ctrl_start#42@3: type=0xa3 request= 0 1464911351.628620 ehci_roothub_ctrl#42@3: called! 1464911351.628620 ehci_roothub_ctrl#42@3: type=0xa3 request=00 1464911351.628620 ehci_roothub_ctrl#42@3: get port status i=1 1464911351.628621 ehci_roothub_ctrl#42@3: port status=0x180b 1464911351.628622 ehci_roothub_ctrl#42@3: returning 4 1464911351.628622 roothub_ctrl_start#42@3: xfer 0x919edce0 buflen -1 actlen 4 1464911351.628622 roothub_ctrl_start#42@3: xfer 0x919edce0 err 0 1464911351.628623 usb_transfer_complete#52@3: called! 1464911351.628623 usb_transfer_complete#52@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911351.628623 usb_transfer_complete#52@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911351.628623 usb_transfer_complete#52@3: xfer 0x919edce0 doing done 0x810f9b24 1464911351.628624 usb_transfer_complete#52@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911351.628624 usb_transfer_complete#52@3: <- done xfer 0x919edce0, wakeup 1464911351.628624 usbd_start_next#52@3: called! 1464911351.628624 usbd_start_next#52@3: pipe = 0x9156d3c0, xfer = 0x0 1464911351.628625 usbd_transfer#42@3: <- done transfer 0x919edce0, err = 0 1464911351.628625 usbd_transfer#42@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911351.628625 usbd_free_xfer#42@3: called! 1464911351.628625 usbd_free_xfer#42@3: 0x919edce0 1464911351.628626 usb_freemem#34@3: called! 1464911351.628626 usb_freemem#34@3: frag=0x9bbecf40 1464911351.628628 usbd_clear_port_feature#6@3: called! 1464911351.628628 usbd_clear_port_feature#6@3: dev 0x919d95f8 port 1 sel 17 1464911351.628628 usbd_do_request_flags#43@3: called! 1464911351.628628 usbd_alloc_xfer#43@3: called! 1464911351.628629 usbd_alloc_xfer#43@3: returns 0x919edce0 1464911351.628629 usbd_transfer#43@3: called! 1464911351.628629 usbd_transfer#43@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911351.628630 usb_insert_transfer#43@3: called! 1464911351.628630 usb_insert_transfer#43@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911351.628630 usb_insert_transfer#43@3: <- done xfer 0x919edce0, err 0 1464911351.628631 roothub_ctrl_start#43@3: called! 1464911351.628631 roothub_ctrl_start#43@3: type=0x23 request=0x1 1464911351.628631 ehci_roothub_ctrl#43@3: called! 1464911351.628632 ehci_roothub_ctrl#43@3: type=0x23 request=01 1464911351.628632 ehci_roothub_ctrl#43@3: UR_CLEAR_PORT_FEATURE port=1 feature=17 1464911351.628633 ehci_roothub_ctrl#43@3: portsc=0x0000180b 1464911351.628633 ehci_roothub_ctrl#43@3: returning 0 1464911351.628633 roothub_ctrl_start#43@3: xfer 0x919edce0 buflen -1 actlen 0 1464911351.628634 roothub_ctrl_start#43@3: xfer 0x919edce0 err 0 1464911351.628634 usb_transfer_complete#53@3: called! 1464911351.628634 usb_transfer_complete#53@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 0 1464911351.628634 usb_transfer_complete#53@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911351.628635 usb_transfer_complete#53@3: xfer 0x919edce0 doing done 0x810f9b24 1464911351.628635 usb_transfer_complete#53@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911351.628635 usb_transfer_complete#53@3: <- done xfer 0x919edce0, wakeup 1464911351.628636 usbd_start_next#53@3: called! 1464911351.628636 usbd_start_next#53@3: pipe = 0x9156d3c0, xfer = 0x0 1464911351.628636 usbd_transfer#43@3: <- done transfer 0x919edce0, err = 0 1464911351.628637 usbd_transfer#43@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911351.628637 usbd_free_xfer#43@3: called! 1464911351.628637 usbd_free_xfer#43@3: 0x919edce0 1464911351.628638 usbd_clear_port_feature#7@3: called! 1464911351.628638 usbd_clear_port_feature#7@3: dev 0x919d95f8 port 1 sel 16 1464911351.628639 usbd_do_request_flags#44@3: called! 1464911351.628639 usbd_alloc_xfer#44@3: called! 1464911351.628639 usbd_alloc_xfer#44@3: returns 0x919edce0 1464911351.628640 usbd_transfer#44@3: called! 1464911351.628640 usbd_transfer#44@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911351.628640 usb_insert_transfer#44@3: called! 1464911351.628641 usb_insert_transfer#44@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911351.628641 usb_insert_transfer#44@3: <- done xfer 0x919edce0, err 0 1464911351.628641 roothub_ctrl_start#44@3: called! 1464911351.628642 roothub_ctrl_start#44@3: type=0x23 request=0x1 1464911351.628642 ehci_roothub_ctrl#44@3: called! 1464911351.628642 ehci_roothub_ctrl#44@3: type=0x23 request=01 1464911351.628642 ehci_roothub_ctrl#44@3: UR_CLEAR_PORT_FEATURE port=1 feature=16 1464911351.628643 ehci_roothub_ctrl#44@3: portsc=0x00001803 1464911351.628644 ehci_roothub_ctrl#44@3: returning 0 1464911351.628644 roothub_ctrl_start#44@3: xfer 0x919edce0 buflen -1 actlen 0 1464911351.628644 roothub_ctrl_start#44@3: xfer 0x919edce0 err 0 1464911351.628644 usb_transfer_complete#54@3: called! 1464911351.628644 usb_transfer_complete#54@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 0 1464911351.628645 usb_transfer_complete#54@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911351.628645 usb_transfer_complete#54@3: xfer 0x919edce0 doing done 0x810f9b24 1464911351.628645 usb_transfer_complete#54@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911351.628645 usb_transfer_complete#54@3: <- done xfer 0x919edce0, wakeup 1464911351.628646 usbd_start_next#54@3: called! 1464911351.628646 usbd_start_next#54@3: pipe = 0x9156d3c0, xfer = 0x0 1464911351.628646 usbd_transfer#44@3: <- done transfer 0x919edce0, err = 0 1464911351.628646 usbd_transfer#44@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911351.628647 usbd_free_xfer#44@3: called! 1464911351.628647 usbd_free_xfer#44@3: 0x919edce0 1464911351.938162 usbd_reset_port#4@3: called! 1464911351.938162 usbd_do_request_flags#45@3: called! 1464911351.938163 usbd_alloc_xfer#45@3: called! 1464911351.938163 usbd_alloc_xfer#45@3: returns 0x919edce0 1464911351.938164 usbd_transfer#45@3: called! 1464911351.938164 usbd_transfer#45@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911351.938164 usb_insert_transfer#45@3: called! 1464911351.938164 usb_insert_transfer#45@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911351.938164 usb_insert_transfer#45@3: <- done xfer 0x919edce0, err 0 1464911351.938165 roothub_ctrl_start#45@3: called! 1464911351.938165 roothub_ctrl_start#45@3: type=0x23 request=0x3 1464911351.938165 ehci_roothub_ctrl#45@3: called! 1464911351.938166 ehci_roothub_ctrl#45@3: type=0x23 request=03 1464911351.938166 ehci_roothub_ctrl#45@3: portsc=0x00001801 1464911351.938167 ehci_roothub_ctrl#45@3: reset port 1 1464911351.988169 ehci_intr#11@2: called! 1464911351.988170 ehci_intr1#11@2: called! 1464911351.988170 ehci_intr1#11@2: sc=0x919d7008 intrs=0xc(0xe08c) eintrs=0x4 1464911351.988173 ehci_pcd#11@2: called! 1464911351.988174 usb_transfer_complete#55@2: called! 1464911351.988175 usb_transfer_complete#55@2: pipe = 0x9156d2e0 xfer = 0x919edea0 status = 0 actlen = 1 1464911351.988175 usb_transfer_complete#55@2: xfer 0x919edea0: repeat 1 new head = 0x919edea0 1464911351.988175 usb_transfer_complete#55@2: xfer 0x919edea0 doing done 0x810fa5e8 1464911351.988175 usb_transfer_complete#55@2: xfer 0x919edea0 doing callback 0x81066ed0 status 0 1464911351.988176 usb_needs_explore#7@2: called! 1464911351.988177 usbd_start_next#55@2: called! 1464911351.988177 usbd_start_next#55@2: pipe = 0x9156d2e0, xfer = 0x919edea0 1464911351.988196 ehci_intr#12@0: called! 1464911351.988197 ehci_intr1#12@0: called! 1464911351.988198 ehci_intr1#12@0: sc=0x919d7008 intrs=0x4(0xc084) eintrs=0x4 1464911351.988200 ehci_pcd#12@0: called! 1464911351.988201 usb_transfer_complete#56@0: called! 1464911351.988201 usb_transfer_complete#56@0: pipe = 0x9156d2e0 xfer = 0x919edea0 status = 0 actlen = 1 1464911351.988202 usb_transfer_complete#56@0: xfer 0x919edea0: repeat 1 new head = 0x919edea0 1464911351.988202 usb_transfer_complete#56@0: xfer 0x919edea0 doing done 0x810fa5e8 1464911351.988202 usb_transfer_complete#56@0: xfer 0x919edea0 doing callback 0x81066ed0 status 0 1464911351.988204 usbd_start_next#56@0: called! 1464911351.988204 usbd_start_next#56@0: pipe = 0x9156d2e0, xfer = 0x919edea0 1464911351.991268 ehci_intr#13@1: called! 1464911351.991269 ehci_intr1#13@1: called! 1464911351.991270 ehci_intr1#13@1: sc=0x919d7008 intrs=0x4(0xc084) eintrs=0x4 1464911351.991273 ehci_pcd#13@1: called! 1464911351.991274 usb_transfer_complete#57@1: called! 1464911351.991274 usb_transfer_complete#57@1: pipe = 0x9156d2e0 xfer = 0x919edea0 status = 0 actlen = 1 1464911351.991274 usb_transfer_complete#57@1: xfer 0x919edea0: repeat 1 new head = 0x919edea0 1464911351.991275 usb_transfer_complete#57@1: xfer 0x919edea0 doing done 0x810fa5e8 1464911351.991275 usb_transfer_complete#57@1: xfer 0x919edea0 doing callback 0x81066ed0 status 0 1464911351.991276 usbd_start_next#57@1: called! 1464911351.991276 usbd_start_next#57@1: pipe = 0x9156d2e0, xfer = 0x919edea0 1464911352.145719 ehci_intr#14@2: called! 1464911352.145719 ehci_intr1#14@2: called! 1464911352.145720 ehci_intr1#14@2: sc=0x919d7008 intrs=0xc(0xc08c) eintrs=0x4 1464911352.145722 ehci_pcd#14@2: called! 1464911352.145724 usb_transfer_complete#58@2: called! 1464911352.145724 usb_transfer_complete#58@2: pipe = 0x9156d2e0 xfer = 0x919edea0 status = 0 actlen = 1 1464911352.145724 usb_transfer_complete#58@2: xfer 0x919edea0: repeat 1 new head = 0x919edea0 1464911352.145724 usb_transfer_complete#58@2: xfer 0x919edea0 doing done 0x810fa5e8 1464911352.145724 usb_transfer_complete#58@2: xfer 0x919edea0 doing callback 0x81066ed0 status 0 1464911352.145726 usbd_start_next#58@2: called! 1464911352.145726 usbd_start_next#58@2: pipe = 0x9156d2e0, xfer = 0x919edea0 1464911352.198161 ehci_roothub_ctrl#45@3: ehci after reset, status=0x0000100a 1464911352.198161 ehci_disown#4@3: called! 1464911352.198162 ehci_disown#4@3: index=1 lowspeed=0 1464911352.198193 ehci_roothub_ctrl#45@3: returning 0 1464911352.198194 roothub_ctrl_start#45@3: xfer 0x919edce0 buflen -1 actlen 0 1464911352.198194 roothub_ctrl_start#45@3: xfer 0x919edce0 err 0 1464911352.198194 usb_transfer_complete#59@3: called! 1464911352.198194 usb_transfer_complete#59@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 0 1464911352.198195 usb_transfer_complete#59@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911352.198195 usb_transfer_complete#59@3: xfer 0x919edce0 doing done 0x810f9b24 1464911352.198195 usb_transfer_complete#59@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911352.198195 usb_transfer_complete#59@3: <- done xfer 0x919edce0, wakeup 1464911352.198195 usbd_start_next#59@3: called! 1464911352.198196 usbd_start_next#59@3: pipe = 0x9156d3c0, xfer = 0x0 1464911352.198196 usbd_transfer#45@3: <- done transfer 0x919edce0, err = 0 1464911352.198196 usbd_transfer#45@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911352.198197 usbd_free_xfer#45@3: called! 1464911352.198197 usbd_free_xfer#45@3: 0x919edce0 1464911352.198198 usbd_reset_port#4@3: port 1 reset done, error=0 1464911352.258160 usbd_get_port_status#35@3: called! 1464911352.258161 usbd_get_port_status#35@3: dev 0x919d95f8 port 1 1464911352.258161 usbd_do_request_flags#46@3: called! 1464911352.258161 usbd_alloc_xfer#46@3: called! 1464911352.258162 usbd_alloc_xfer#46@3: returns 0x919edce0 1464911352.258162 usb_allocmem_flags#35@3: called! 1464911352.258163 usb_allocmem_flags#35@3: use frag=0x9bbecf40 size=4 1464911352.258163 usbd_transfer#46@3: called! 1464911352.258164 usbd_transfer#46@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911352.258164 usb_insert_transfer#46@3: called! 1464911352.258164 usb_insert_transfer#46@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911352.258164 usb_insert_transfer#46@3: <- done xfer 0x919edce0, err 0 1464911352.258165 roothub_ctrl_start#46@3: called! 1464911352.258165 roothub_ctrl_start#46@3: type=0xa3 request= 0 1464911352.258166 ehci_roothub_ctrl#46@3: called! 1464911352.258166 ehci_roothub_ctrl#46@3: type=0xa3 request=00 1464911352.258166 ehci_roothub_ctrl#46@3: get port status i=1 1464911352.258167 ehci_roothub_ctrl#46@3: port status=0x100a 1464911352.258168 ehci_roothub_ctrl#46@3: returning 4 1464911352.258168 roothub_ctrl_start#46@3: xfer 0x919edce0 buflen -1 actlen 4 1464911352.258168 roothub_ctrl_start#46@3: xfer 0x919edce0 err 0 1464911352.258169 usb_transfer_complete#60@3: called! 1464911352.258169 usb_transfer_complete#60@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911352.258169 usb_transfer_complete#60@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911352.258169 usb_transfer_complete#60@3: xfer 0x919edce0 doing done 0x810f9b24 1464911352.258169 usb_transfer_complete#60@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911352.258170 usb_transfer_complete#60@3: <- done xfer 0x919edce0, wakeup 1464911352.258170 usbd_start_next#60@3: called! 1464911352.258170 usbd_start_next#60@3: pipe = 0x9156d3c0, xfer = 0x0 1464911352.258171 usbd_transfer#46@3: <- done transfer 0x919edce0, err = 0 1464911352.258171 usbd_transfer#46@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911352.258171 usbd_free_xfer#46@3: called! 1464911352.258171 usbd_free_xfer#46@3: 0x919edce0 1464911352.258172 usb_freemem#35@3: called! 1464911352.258172 usb_freemem#35@3: frag=0x9bbecf40 1464911352.258174 usb_needs_explore#8@3: called! 1464911352.258176 usbd_get_port_status#36@3: called! 1464911352.258176 usbd_get_port_status#36@3: dev 0x919d95f8 port 1 1464911352.258176 usbd_do_request_flags#47@3: called! 1464911352.258176 usbd_alloc_xfer#47@3: called! 1464911352.258177 usbd_alloc_xfer#47@3: returns 0x919edce0 1464911352.258177 usb_allocmem_flags#36@3: called! 1464911352.258179 usb_allocmem_flags#36@3: use frag=0x9bbecf40 size=4 1464911352.258179 usbd_transfer#47@3: called! 1464911352.258179 usbd_transfer#47@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911352.258179 usb_insert_transfer#47@3: called! 1464911352.258179 usb_insert_transfer#47@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911352.258180 usb_insert_transfer#47@3: <- done xfer 0x919edce0, err 0 1464911352.258180 roothub_ctrl_start#47@3: called! 1464911352.258180 roothub_ctrl_start#47@3: type=0xa3 request= 0 1464911352.258181 ehci_roothub_ctrl#47@3: called! 1464911352.258181 ehci_roothub_ctrl#47@3: type=0xa3 request=00 1464911352.258181 ehci_roothub_ctrl#47@3: get port status i=1 1464911352.258182 ehci_roothub_ctrl#47@3: port status=0x100a 1464911352.258183 ehci_roothub_ctrl#47@3: returning 4 1464911352.258183 roothub_ctrl_start#47@3: xfer 0x919edce0 buflen -1 actlen 4 1464911352.258183 roothub_ctrl_start#47@3: xfer 0x919edce0 err 0 1464911352.258183 usb_transfer_complete#61@3: called! 1464911352.258184 usb_transfer_complete#61@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 4 1464911352.258184 usb_transfer_complete#61@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911352.258184 usb_transfer_complete#61@3: xfer 0x919edce0 doing done 0x810f9b24 1464911352.258184 usb_transfer_complete#61@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911352.258185 usb_transfer_complete#61@3: <- done xfer 0x919edce0, wakeup 1464911352.258185 usbd_start_next#61@3: called! 1464911352.258185 usbd_start_next#61@3: pipe = 0x9156d3c0, xfer = 0x0 1464911352.258185 usbd_transfer#47@3: <- done transfer 0x919edce0, err = 0 1464911352.258186 usbd_transfer#47@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911352.258186 usbd_free_xfer#47@3: called! 1464911352.258186 usbd_free_xfer#47@3: 0x919edce0 1464911352.258186 usb_freemem#36@3: called! 1464911352.258187 usb_freemem#36@3: frag=0x9bbecf40 1464911352.258188 usbd_clear_port_feature#8@3: called! 1464911352.258188 usbd_clear_port_feature#8@3: dev 0x919d95f8 port 1 sel 17 1464911352.258188 usbd_do_request_flags#48@3: called! 1464911352.258189 usbd_alloc_xfer#48@3: called! 1464911352.258189 usbd_alloc_xfer#48@3: returns 0x919edce0 1464911352.258189 usbd_transfer#48@3: called! 1464911352.258190 usbd_transfer#48@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911352.258190 usb_insert_transfer#48@3: called! 1464911352.258190 usb_insert_transfer#48@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911352.258190 usb_insert_transfer#48@3: <- done xfer 0x919edce0, err 0 1464911352.258191 roothub_ctrl_start#48@3: called! 1464911352.258191 roothub_ctrl_start#48@3: type=0x23 request=0x1 1464911352.258191 ehci_roothub_ctrl#48@3: called! 1464911352.258191 ehci_roothub_ctrl#48@3: type=0x23 request=01 1464911352.258192 ehci_roothub_ctrl#48@3: UR_CLEAR_PORT_FEATURE port=1 feature=17 1464911352.258192 ehci_roothub_ctrl#48@3: portsc=0x0000100a 1464911352.258193 ehci_roothub_ctrl#48@3: returning 0 1464911352.258193 roothub_ctrl_start#48@3: xfer 0x919edce0 buflen -1 actlen 0 1464911352.258193 roothub_ctrl_start#48@3: xfer 0x919edce0 err 0 1464911352.258194 usb_transfer_complete#62@3: called! 1464911352.258194 usb_transfer_complete#62@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 0 1464911352.258194 usb_transfer_complete#62@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911352.258194 usb_transfer_complete#62@3: xfer 0x919edce0 doing done 0x810f9b24 1464911352.258194 usb_transfer_complete#62@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911352.258195 usb_transfer_complete#62@3: <- done xfer 0x919edce0, wakeup 1464911352.258195 usbd_start_next#62@3: called! 1464911352.258195 usbd_start_next#62@3: pipe = 0x9156d3c0, xfer = 0x0 1464911352.258196 usbd_transfer#48@3: <- done transfer 0x919edce0, err = 0 1464911352.258196 usbd_transfer#48@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911352.258196 usbd_free_xfer#48@3: called! 1464911352.258196 usbd_free_xfer#48@3: 0x919edce0 1464911352.258197 usbd_clear_port_feature#9@3: called! 1464911352.258197 usbd_clear_port_feature#9@3: dev 0x919d95f8 port 1 sel 16 1464911352.258197 usbd_do_request_flags#49@3: called! 1464911352.258198 usbd_alloc_xfer#49@3: called! 1464911352.258198 usbd_alloc_xfer#49@3: returns 0x919edce0 1464911352.258198 usbd_transfer#49@3: called! 1464911352.258199 usbd_transfer#49@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911352.258199 usb_insert_transfer#49@3: called! 1464911352.258199 usb_insert_transfer#49@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911352.258199 usb_insert_transfer#49@3: <- done xfer 0x919edce0, err 0 1464911352.258200 roothub_ctrl_start#49@3: called! 1464911352.258200 roothub_ctrl_start#49@3: type=0x23 request=0x1 1464911352.258200 ehci_roothub_ctrl#49@3: called! 1464911352.258200 ehci_roothub_ctrl#49@3: type=0x23 request=01 1464911352.258201 ehci_roothub_ctrl#49@3: UR_CLEAR_PORT_FEATURE port=1 feature=16 1464911352.258202 ehci_roothub_ctrl#49@3: portsc=0x00001002 1464911352.258202 ehci_roothub_ctrl#49@3: returning 0 1464911352.258202 roothub_ctrl_start#49@3: xfer 0x919edce0 buflen -1 actlen 0 1464911352.258203 roothub_ctrl_start#49@3: xfer 0x919edce0 err 0 1464911352.258203 usb_transfer_complete#63@3: called! 1464911352.258203 usb_transfer_complete#63@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 0 1464911352.258203 usb_transfer_complete#63@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911352.258203 usb_transfer_complete#63@3: xfer 0x919edce0 doing done 0x810f9b24 1464911352.258204 usb_transfer_complete#63@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911352.258204 usb_transfer_complete#63@3: <- done xfer 0x919edce0, wakeup 1464911352.258204 usbd_start_next#63@3: called! 1464911352.258204 usbd_start_next#63@3: pipe = 0x9156d3c0, xfer = 0x0 1464911352.258205 usbd_transfer#49@3: <- done transfer 0x919edce0, err = 0 1464911352.258205 usbd_transfer#49@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911352.258205 usbd_free_xfer#49@3: called! 1464911352.258205 usbd_free_xfer#49@3: 0x919edce0 1464911352.258207 usb_disconnect_port#1@3: called! 1464911352.258207 usb_disconnect_port#1@3: up=0x91894220 dev=0x0 port=1 1464911352.258207 usbd_clear_port_feature#10@3: called! 1464911352.258207 usbd_clear_port_feature#10@3: dev 0x919d95f8 port 1 sel 16 1464911352.258208 usbd_do_request_flags#50@3: called! 1464911352.258208 usbd_alloc_xfer#50@3: called! 1464911352.258208 usbd_alloc_xfer#50@3: returns 0x919edce0 1464911352.258209 usbd_transfer#50@3: called! 1464911352.258209 usbd_transfer#50@3: xfer = 0x919edce0, flags = 0x2, pipe = 0x9156d3c0, running = 0 1464911352.258209 usb_insert_transfer#50@3: called! 1464911352.258209 usb_insert_transfer#50@3: xfer = 0x919edce0 pipe = 0x9156d3c0 running = 0 timeout = 5000 1464911352.258210 usb_insert_transfer#50@3: <- done xfer 0x919edce0, err 0 1464911352.258210 roothub_ctrl_start#50@3: called! 1464911352.258210 roothub_ctrl_start#50@3: type=0x23 request=0x1 1464911352.258211 ehci_roothub_ctrl#50@3: called! 1464911352.258211 ehci_roothub_ctrl#50@3: type=0x23 request=01 1464911352.258211 ehci_roothub_ctrl#50@3: UR_CLEAR_PORT_FEATURE port=1 feature=16 1464911352.258212 ehci_roothub_ctrl#50@3: portsc=0x00001000 1464911352.258212 ehci_roothub_ctrl#50@3: returning 0 1464911352.258212 roothub_ctrl_start#50@3: xfer 0x919edce0 buflen -1 actlen 0 1464911352.258212 roothub_ctrl_start#50@3: xfer 0x919edce0 err 0 1464911352.258213 usb_transfer_complete#64@3: called! 1464911352.258213 usb_transfer_complete#64@3: pipe = 0x9156d3c0 xfer = 0x919edce0 status = 0 actlen = 0 1464911352.258213 usb_transfer_complete#64@3: xfer 0x919edce0: repeat 0 new head = 0x0 1464911352.258213 usb_transfer_complete#64@3: xfer 0x919edce0 doing done 0x810f9b24 1464911352.258214 usb_transfer_complete#64@3: xfer 0x919edce0 doing callback 0x0 status 0 1464911352.258214 usb_transfer_complete#64@3: <- done xfer 0x919edce0, wakeup 1464911352.258214 usbd_start_next#64@3: called! 1464911352.258214 usbd_start_next#64@3: pipe = 0x9156d3c0, xfer = 0x0 1464911352.258215 usbd_transfer#50@3: <- done transfer 0x919edce0, err = 0 1464911352.258215 usbd_transfer#50@3: <- done xfer 0x919edce0, err 0 (complete/error) 1464911352.258215 usbd_free_xfer#50@3: called! 1464911352.258215 usbd_free_xfer#50@3: 0x919edce0 1464911387.118445 usb_event_thread#0@3: sc 0x915ac8d8 woke up 1464911387.118446 usb_discover#2@3: called! 1464911412.258645 usb_event_thread#0@3: sc 0x915ac938 woke up 1464911412.258646 usb_discover#3@3: called! 1464911447.118923 usb_event_thread#0@3: sc 0x915ac8d8 woke up 1464911447.118923 usb_discover#4@3: called! 1464911472.259129 usb_event_thread#0@3: sc 0x915ac938 woke up 1464911472.259130 usb_discover#5@3: called! 1464911507.119414 usb_event_thread#0@3: sc 0x915ac8d8 woke up 1464911507.119414 usb_discover#6@3: called! 1464911532.259615 usb_event_thread#0@3: sc 0x915ac938 woke up 1464911532.259616 usb_discover#7@3: called! 1464911567.119894 usb_event_thread#0@3: sc 0x915ac8d8 woke up 1464911567.119895 usb_discover#8@3: called! 1464911592.260095 usb_event_thread#0@3: sc 0x915ac938 woke up 1464911592.260096 usb_discover#9@3: called! 1464911627.120373 usb_event_thread#0@3: sc 0x915ac8d8 woke up 1464911627.120373 usb_discover#10@3: called! 1464911652.260572 usb_event_thread#0@3: sc 0x915ac938 woke up 1464911652.260573 usb_discover#11@3: called! 1464911687.120850 usb_event_thread#0@3: sc 0x915ac8d8 woke up 1464911687.120851 usb_discover#12@3: called! 1464911712.261050 usb_event_thread#0@3: sc 0x915ac938 woke up 1464911712.261050 usb_discover#13@3: called!