Re: Problem using USB 2.0 device under -CURRENT (long)

As a data point, here's what happens with mine (this is on current cvsupped 
this morning).  Lots of output that probably isn't very useful.  I'm pretty 
baffled as to why the controller suddenly decides that it doesn't want to 
work.  Guess it's time to try to find the EHCI spec...

usb_event_thread: woke up
usb_discover
ehci_root_ctrl_control type=0xa3 request=00
ehci_root_ctrl_control type=0xa3 request=00
ehci_root_ctrl_control type=0xa3 request=00
ehci_root_ctrl_control type=0xa3 request=00
ehci_root_ctrl_control type=0x23 request=01
ehci_root_ctrl_control type=0x23 request=03
ehci_root_ctrl_transfer: reset port 4
ehci after reset, status=0x00001005
ehci port 4 reset, status = 0x00001005
usbd_reset_port: port 4 reset done, error=NORMAL_COMPLETION
ehci_root_ctrl_control type=0xa3 request=00
ehci_root_ctrl_control type=0x23 request=01
ehci_root_ctrl_control type=0xa3 request=00
usbd_new_device bus=0xc2da4800 port=4 depth=1 speed=3
usbd_setup_pipe: dev=0xc301e680 iface=0 ep=0xc301e6a4 pipe=0xc301e684
ehci_open: pipe=0xc301e600, addr=0, endpt=0 (1)
ehci_add_qh:
QH(0xc2d9af80) at 0x0028ef80:
  link=0x0028efc2<QH>
  endp=0x80082000
    addr=0x00 inact=0 endpt=0 eps=2 dtc=0 hrecl=0
    mpl=0x8 ctl=0 nrl=8
  endphub=0x40000000
    smask=0x00 cmask=0x00 huba=0x00 port=0 mult=1
  curqtd=0x00000001<T>
Overlay qTD:
  next=0x00000001<T> altnext=0x00000001<T>
  status=0x00000000: toggle=0 bytes=0x0 ioc=0 c_page=0x0
    cerr=0 pid=0 stat=0x0
  buffer[0]=0x00000000
  buffer[1]=0x00000000
  buffer[2]=0x00000000
  buffer[3]=0x00000000
  buffer[4]=0x00000000
ehci_device_control type=0x80, request=0x06, wValue=0x0100, wIndex=0x0000 
len=8,
 addr=0, endpt=0
ehci_alloc_sqtd: allocating chunk
usb_allocmem: large alloc 4096
ehci_alloc_sqtd_chain: start len=8
ehci_alloc_sqtd_chain: dataphys=0x002c0e80 dataphyslastpage=0x002c0000 len=8 
cur
len=8
ehci_device_request:
QH(0xc2d9af80) at 0x0028ef80:
  link=0x0028efc2<QH>
  endp=0x80082000
    addr=0x00 inact=0 endpt=0 eps=2 dtc=0 hrecl=0
    mpl=0x8 ctl=0 nrl=8
  endphub=0x40000000
    smask=0x00 cmask=0x00 huba=0x00 port=0 mult=1
  curqtd=0x00000001<T>
Overlay qTD:
  next=0x00000001<T> altnext=0x00000001<T>
  status=0x00000000: toggle=0 bytes=0x0 ioc=0 c_page=0x0
    cerr=0 pid=0 stat=0x0
  buffer[0]=0x00000000
  buffer[1]=0x00000000
  buffer[2]=0x00000000
  buffer[3]=0x00000000
  buffer[4]=0x00000000
QTD(0xc2fd7fc0) at 0x0b86bfc0:
  next=0x0b86bf40<> altnext=0x0b86bf40<>
  status=0x00080e80: toggle=0 bytes=0x8 ioc=0 c_page=0x0
    cerr=3 pid=2 stat=0x80<ACTIVE>
  buffer[0]=0x002c0ec0
  buffer[1]=0x00000000
  buffer[2]=0x00000000
  buffer[3]=0x00000000
  buffer[4]=0x00000000
QTD(0xc2fd7f40) at 0x0b86bf40:
  next=0x0b86bf80<> altnext=0x0b86bf80<>
  status=0x00088d80: toggle=0 bytes=0x8 ioc=1 c_page=0x0
    cerr=3 pid=1 stat=0x80<ACTIVE>
  buffer[0]=0x002c0e80
  buffer[1]=0x00000000
  buffer[2]=0x00000000
  buffer[3]=0x00000000
  buffer[4]=0x00000000
QTD(0xc2fd7f80) at 0x0b86bf80:
  next=0x00000001<T> altnext=0x00000001<T>
  status=0x00008c80: toggle=0 bytes=0x0 ioc=1 c_page=0x0
    cerr=3 pid=0 stat=0x80<ACTIVE>
  buffer[0]=0x00000000
  buffer[1]=0x00000000
  buffer[2]=0x00000000
  buffer[3]=0x00000000
  buffer[4]=0x00000000
usb3: unrecoverable error, controller halted
usb3: blocking intrs 0x10
ehci_pcd_able: on=1
ehci_timeout: exfer=0xc2d49600
usbd_dump_pipe: pipe=0xc301e600
usbd_dump_iface: iface=0
usbd_dump_device: dev=0xc301e680
 bus=0xc2da4800 default_pipe=0xc301e600
 address=0 config=0 depth=1 speed=3 self_powered=0 power=0 langid=-1
usbd_dump_endpoint: endp=0xc301e6a4
 edesc=0xc301e6ac refcnt=1
 bEndpointAddress=0x00
 (usbd_dump_pipe:)
 refcnt=1 running=1 aborting=0
 intrxfer=0, repeat=0, interval=-1
usb_add_task: task=0xc2d4966c
usb_task_thread: woke up task=0xc2d4966c
ehci_timeout_task: xfer=0xc2d49600
ehci_abort_xfer: xfer=0xc2d49600 pipe=0xc301e600
ehci_sync_hc: enter
ehci_sync_hc: cmd=0x00080060 sts=0x0000b000
ehci_sync_hc: cmd=0x00080060 sts=0x0000b000
ehci_sync_hc: exit
ehci_check_intr: ex=0xc2d49600
ehci_abort_xfer: no hit
ehci_ctrl_done: length=0
ehci_device_control type=0x80, request=0x06, wValue=0x0100, wIndex=0x0000 
len=8,
 addr=0, endpt=0
ehci_alloc_sqtd_chain: start len=8
ehci_alloc_sqtd_chain: dataphys=0x002c0e80 dataphyslastpage=0x002c0000 len=8 
cur
len=8
ehci_device_request:
QH(0xc2d9af80) at 0x0028ef80:
  link=0x0028efc2<QH>
  endp=0x80082000
    addr=0x00 inact=0 endpt=0 eps=2 dtc=0 hrecl=0
    mpl=0x8 ctl=0 nrl=8
  endphub=0x40000000
    smask=0x00 cmask=0x00 huba=0x00 port=0 mult=1
  curqtd=0x00000000<>
Overlay qTD:
  next=0x0b86bfc0<> altnext=0x00000001<T>
  status=0x00000040: toggle=0 bytes=0x0 ioc=0 c_page=0x0
    cerr=0 pid=0 stat=0x40<HALTED>
  buffer[0]=0x00000000
  buffer[1]=0x00000000
  buffer[2]=0x00000000
  buffer[3]=0x00000000
  buffer[4]=0x00000000
QTD(0xc2fd7f80) at 0x0b86bf80:
  next=0x0b86bfc0<> altnext=0x0b86bfc0<>
  status=0x00080e80: toggle=0 bytes=0x8 ioc=0 c_page=0x0
    cerr=3 pid=2 stat=0x80<ACTIVE>
  buffer[0]=0x002c0ec0
  buffer[1]=0x00000000
  buffer[2]=0x00000000
  buffer[3]=0x00000000
  buffer[4]=0x00000000
QTD(0xc2fd7fc0) at 0x0b86bfc0:
  next=0x0b86bf40<> altnext=0x0b86bf40<>
  status=0x00088d80: toggle=0 bytes=0x8 ioc=1 c_page=0x0
    cerr=3 pid=1 stat=0x80<ACTIVE>
  buffer[0]=0x002c0e80
  buffer[1]=0x00000000
  buffer[2]=0x00000000
  buffer[3]=0x00000000
  buffer[4]=0x00000000
QTD(0xc2fd7f40) at 0x0b86bf40:
  next=0x00000001<T> altnext=0x00000001<T>
  status=0x00008c80: toggle=0 bytes=0x0 ioc=1 c_page=0x0
    cerr=3 pid=0 stat=0x80<ACTIVE>
  buffer[0]=0x00000000
  buffer[1]=0x00000000
  buffer[2]=0x00000000
  buffer[3]=0x00000000
  buffer[4]=0x00000000