Dreamplug : USB support

Fabien Thomas fabien.thomas at netasq.com
Wed Apr 25 14:15:59 UTC 2012 

	Hi,

It seems that sometimes USB works on Dreamplug and sometimes not.

I've included a working dmesg and a full debug output of the non-working boot.
I've tried to increase the timeout in usb.h but without success.

Maybe someone will have a clue for  this problem ?

Fabien

Success:

uhub0: 1 port with 1 removable, self powered
Root mount waiting for: usbus0
ugen0.2: <vendor 0x1a40> at usbus0
uhub1: <vendor 0x1a40 USB 2.0 Hub, class 9/0, rev 2.00/1.11, addr 2> on usbus0
Root mount waiting for: usbus0
uhub1: 4 ports with 4 removable, self powered
Root mount waiting for: usbus0
Root mount waiting for: usbus0
ugen0.3: <vendor 0x05e3> at usbus0
umass0: <vendor 0x05e3 USB Storage, class 0/0, rev 2.00/99.10, addr 3> on usbus0
umass0:  SCSI over Bulk-Only; quirks = 0x4000
umass0:0:0:-1: Attached to scbus0
da0 at umass-sim0 bus 0 scbus0 target 0 lun 0
da0: <Generic STORAGE DEVICE 9910> Removable Direct Access SCSI-0 device 
da0: 40.000MB/s transfers
da0: 3724MB (7626752 512 byte sectors: 255H 63S/T 474C)
(probe0:umass-sim0:0:0:1): TEST UNIT READY. CDB: 0 20 0 0 0 0 
(probe0:umass-sim0:0:0:1): CAM status: SCSI Status Error
(probe0:umass-sim0:0:0:1): SCSI status: Check Condition
(probe0:umass-sim0:0:0:1): SCSI sense: UNIT ATTENTION asc:28,0 (Not ready to ready change, medium may have changed)
da1 at umass-sim0 bus 0 scbus0 target 0 lun 1
da1: <Generic STORAGE DEVICE 9910> Removable Direct Access SCSI-0 device 
da1: 40.000MB/s transfers
da1: 30959MB (63404032 512 byte sectors: 255H 63S/T 3946C)
ugen0.4: <vendor 0x0d8c> at usbus0
Trying to mount root from ufs:/dev/ufs/dreamplug

Failure:

usb_needs_explore: 
usb_needs_explore: No root HUB
usb_process: Message pm=0xc34eadac, cb=0xc0967474 (enter)
usbus0: 480Mbps High Speed USB v2.0
usb_alloc_device: parent_dev=0xc3500b80, bus=0xc34eac78, parent_hub=0, depth=0, port_index=0, port_no=1, speed=3, usb_mode=0
usb_set_device_state: udev 0xc3686c00 state DETACHED -> POWERED
usbd_req_set_address: setting device address=1
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x00 bRequest=0x05 wValue=0x0001 wIndex=0x0000 wLength=0x0000
usbd_do_request_flags: Handle Request function is set
ad0: 70911MB <WDC WD740GD-00FLC0 33.08F33> at ata0-master UDMA100 SATA 1.5Gb/s
usb_set_device_state: udev 0xc3686c00 state POWERED -> ADDRESSED
usbd_setup_device_desc: Minimum MaxPacketSize is large enough to hold the complete device descriptor
usbd_req_get_device_desc: 
usbd_req_get_desc: id=0, type=1, index=0, max_len=18
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x80 bRequest=0x06 wValue=0x0100 wIndex=0x0000 wLength=0x0012
usbd_do_request_flags: Handle Request function is set
usbd_setup_device_desc: adding unit addr=1, rev=200, class=9, subclass=0, protocol=1, maxpacket=64, len=18, speed=3
usbd_req_get_desc: id=0, type=3, index=0, max_len=4
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x80 bRequest=0x06 wValue=0x0300 wIndex=0x0000 wLength=0x0002
usbd_do_request_flags: Handle Request function is set
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x80 bRequest=0x06 wValue=0x0300 wIndex=0x0000 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
usb_alloc_device: Using first language
usb_alloc_device: Language selected: 0x0001
usbd_req_get_desc: id=1, type=3, index=1, max_len=255
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x80 bRequest=0x06 wValue=0x0301 wIndex=0x0001 wLength=0x0002
usbd_do_request_flags: Handle Request function is set
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x80 bRequest=0x06 wValue=0x0301 wIndex=0x0001 wLength=0x0010
usbd_do_request_flags: Handle Request function is set
usbd_req_get_desc: id=1, type=3, index=2, max_len=255
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x80 bRequest=0x06 wValue=0x0302 wIndex=0x0001 wLength=0x0002
usbd_do_request_flags: Handle Request function is set
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x80 bRequest=0x06 wValue=0x0302 wIndex=0x0001 wLength=0x001c
usbd_do_request_flags: Handle Request function is set
usb_alloc_device: setting config 0
usbd_set_config_index: udev=0xc3686c00 index=0
usb_detach_device: udev=0xc3686c00
usb_cdev_free: Freeing device nodes
usb_config_parse: iface_index=255 cmd=1
usbd_req_get_config_desc_full: index=0
usbd_req_get_config_desc: confidx=0
usbd_req_get_desc: id=0, type=2, index=0, max_len=9
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x80 bRequest=0x06 wValue=0x0200 wIndex=0x0000 wLength=0x0009
usbd_do_request_flags: Handle Request function is set
usbd_req_get_desc: id=0, type=2, index=0, max_len=25
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x80 bRequest=0x06 wValue=0x0200 wIndex=0x0000 wLength=0x0019
usbd_do_request_flags: Handle Request function is set
usbd_set_config_index: udev=0xc3686c00 cdesc=0xc34e5520 (addr 1) cno=1 attr=0x40, selfpowered=1, power=0
usb_set_device_state: udev 0xc3686c00 state ADDRESSED -> CONFIGURED
usbd_req_set_config: setting config 1
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x00 bRequest=0x09 wValue=0x0001 wIndex=0x0000 wLength=0x0000
usbd_do_request_flags: Handle Request function is set
usb_config_parse: iface_index=255 cmd=0
usb_config_parse: found idesc nendpt=1
usb_config_parse: iface_index=255 cmd=2
usb_config_parse: found idesc nendpt=1
usb_cdev_create: Creating device nodes
usbd_set_config_index: error=USB_ERR_NORMAL_COMPLETION
usb_detach_device: udev=0xc3686c00
usb_alloc_device: new dev (addr 1), udev=0xc3686c00, parent_hub=0
usb_bus_port_set_device: bus 0xc34eac78 devices[1] = 0xc3686c00
ugen0.1: <Marvell> at usbus0
usb_probe_and_attach: iclass=9/0/0 iindex=0/0
uhub0: <Marvell EHCI root HUB, class 9/0, rev 2.00/1.00, addr 1> on usbus0
uhub_attach: depth=0 selfpowered=1, parent=0, parent->selfpowered=0
uhub_attach: Getting HUB descriptor
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa0 bRequest=0x06 wValue=0x2900 wIndex=0x0000 wLength=0x0009
usbd_do_request_flags: Handle Request function is set
GEOM: ad0s2: geometry does not match label (255h,63s != 16h,63s).
GEOM: ufsid/4eb8e3d67ec8647c: geometry does not match label (255h,63s != 16h,63s).
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x23 bRequest=0x03 wValue=0x0008 wIndex=0x0001 wLength=0x0000
usbd_do_request_flags: Handle Request function is set
uhub_attach: turn on port 1 power
usb_needs_explore: 
usb_proc_msignal:  t=0, num=0
uhub0: 1 port with 1 removable, self powered
usb_needs_explore: 
usb_proc_msignal:  t=1, num=1
usb_probe_and_attach: end of interfaces at 1
usb_needs_explore: 
usb_proc_msignal:  t=3, num=1
usb_process: Message pm=0xc34eadac (leave)
usb_process: Message pm=0xc34ead5c, cb=0xc0967708 (enter)
usb_bus_powerd: bus=0xc34eac78
usb_bus_powerd: Recomputing power masks
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa3 bRequest=0x00 wValue=0x0000 wIndex=0x0001 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
uhub_read_port_status: port 1, wPortStatus=0x0301, wPortChange=0x0001, err=USB_ERR_NORMAL_COMPLETION
uhub_reattach_port: reattaching port 1
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x23 bRequest=0x01 wValue=0x0010 wIndex=0x0001 wLength=0x0000
usbd_do_request_flags: Handle Request function is set
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa3 bRequest=0x00 wValue=0x0000 wIndex=0x0001 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
uhub_read_port_status: port 1, wPortStatus=0x0301, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION
uhub_reattach_port: Port 1 is in Host Mode
usbd_req_reset_port: 
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x23 bRequest=0x01 wValue=0x0014 wIndex=0x0001 wLength=0x0000
usbd_do_request_flags: Handle Request function is set
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x23 bRequest=0x03 wValue=0x0004 wIndex=0x0001 wLength=0x0000
usbd_do_request_flags: Handle Request function is set
Root mount waiting for: usbus0
usb_needs_explore: 
usb_proc_msignal:  t=3, num=1
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa3 bRequest=0x00 wValue=0x0000 wIndex=0x0001 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x23 bRequest=0x01 wValue=0x0014 wIndex=0x0001 wLength=0x0000
usbd_do_request_flags: Handle Request function is set
usbd_req_reset_port: port 1 reset returning error=USB_ERR_NORMAL_COMPLETION
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa3 bRequest=0x00 wValue=0x0000 wIndex=0x0001 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
uhub_read_port_status: port 1, wPortStatus=0x0303, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION
usb_alloc_device: parent_dev=0xc3461a00, bus=0xc34eac78, parent_hub=0xc3686c00, depth=1, port_index=0, port_no=1, speed=1, usb_mode=0
usb_set_device_state: udev 0xc368d000 state DETACHED -> POWERED
usbd_req_set_address: setting device address=2
usbd_do_request_flags: udev=0xc368d000 bmRequestType=0x00 bRequest=0x05 wValue=0x0002 wIndex=0x0000 wLength=0x0000
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usb_proc_msignal:  t=0, num=0
usb_process: Message pm=0xc371f044, cb=0xc098296c (enter)
usb_command_wrapper: cb 0xc371f0b0 (enter)
usbd_callback_wrapper: case 1-4
usbd_do_request_callback: st=0
usbd_transfer_submit: xfer=0xc371f0b0, endpoint=0xc368d08c, nframes=1, dir=write
usb_dump_endpoint: endpoint=0xc368d08c edesc=0xc368d34c isoc_next=0 toggle_next=0 bEndpointAddress=0x00
usb_dump_queue: endpoint=0xc368d08c xfer: 
usbd_transfer_submit: open
usbd_transfer_power_ref: Adding type 0 to power state
usbd_transfer_power_ref: needs power
usb_command_wrapper: cb 0xc371f0b0 (enter)
usb_command_wrapper: cb 0xc371f0b0 (leave)
usb_command_wrapper: cb 0xc371f0b0 (enter)
usbd_pipe_enter: enter
usb_command_wrapper: cb 0xc371f0b0 (enter)
usbd_pipe_start: start
usb_command_wrapper: cb 0xc371f0b0 (leave)
usb_command_wrapper: cb 0 (leave)
usb_command_wrapper: cb 0 (leave)
usb_process: Message pm=0xc371f044 (leave)
usbd_transfer_done: err=USB_ERR_STALLED
usb_proc_msignal:  t=0, num=0
usb_process: Message pm=0xc371f044, cb=0xc098296c (enter)
usb_command_wrapper: cb 0xc371f0b0 (enter)
usbd_callback_wrapper: case 1-4
usbd_callback_wrapper_sub: xfer=0xc371f0b0 endpoint=0xc368d08c sts=22 alen=0, slen=8, afrm=1, nfrm=1
usbd_do_request_callback: st=2
usb_command_wrapper: cb 0 (leave)
usb_process: Message pm=0xc371f044 (leave)
usbd_transfer_stop: close
usbd_transfer_done: err=USB_ERR_CANCELLED
usbd_transfer_done: not transferring
usb_needs_explore: 
usb_proc_msignal:  t=3, num=1
Root mount waiting for: usbus0
usb_alloc_device: set address 2 failed (USB_ERR_STALLED, ignored)
usb_set_device_state: udev 0xc368d000 state POWERED -> ADDRESSED
usbd_req_get_desc: id=0, type=1, index=0, max_len=8
usbd_do_request_flags: udev=0xc368d000 bmRequestType=0x80 bRequest=0x06 wValue=0x0100 wIndex=0x0000 wLength=0x0008
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usb_proc_msignal:  t=0, num=0
usb_process: Message pm=0xc371e044, cb=0xc098296c (enter)
usb_command_wrapper: cb 0xc371e0b0 (enter)
usbd_callback_wrapper: case 1-4
usbd_do_request_callback: st=0
usbd_transfer_submit: xfer=0xc371e0b0, endpoint=0xc368d08c, nframes=2, dir=write
usb_dump_endpoint: endpoint=0xc368d08c edesc=0xc368d34c isoc_next=0 toggle_next=1 bEndpointAddress=0x00
usb_dump_queue: endpoint=0xc368d08c xfer: 
usbd_transfer_submit: open
usb_command_wrapper: cb 0xc371e0b0 (enter)
usb_command_wrapper: cb 0xc371e0b0 (leave)
usb_command_wrapper: cb 0xc371e0b0 (enter)
usb_command_wrapper: cb 0xc371e0b0 (leave)
usb_command_wrapper: cb 0xc371e0b0 (enter)
usbd_pipe_enter: enter
usb_command_wrapper: cb 0xc371e0b0 (enter)
usbd_pipe_start: start
usb_command_wrapper: cb 0xc371e0b0 (leave)
usb_command_wrapper: cb 0 (leave)
usb_command_wrapper: cb 0 (leave)
usb_process: Message pm=0xc371e044 (leave)
usbd_transfer_done: err=USB_ERR_STALLED
usb_proc_msignal:  t=0, num=0
usb_process: Message pm=0xc371e044, cb=0xc098296c (enter)
usb_command_wrapper: cb 0xc371e0b0 (enter)
usbd_callback_wrapper: case 1-4
usbd_callback_wrapper_sub: xfer=0xc371e0b0 endpoint=0xc368d08c sts=22 alen=0, slen=16, afrm=1, nfrm=2
usbd_do_request_callback: st=2
usb_command_wrapper: cb 0 (leave)
usb_process: Message pm=0xc371e044 (leave)
usbd_transfer_stop: close
usbd_transfer_done: err=USB_ERR_CANCELLED
usbd_transfer_done: not transferring
usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_STALLED
usbd_req_re_enumerate: Trying to reset parent High Speed TT.
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x23 bRequest=0x09 wValue=0x0000 wIndex=0x0001 wLength=0x0000
usbd_do_request_flags: Handle Request function is set
usbd_req_reset_port: 
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x23 bRequest=0x01 wValue=0x0014 wIndex=0x0001 wLength=0x0000
usbd_do_request_flags: Handle Request function is set
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x23 bRequest=0x03 wValue=0x0004 wIndex=0x0001 wLength=0x0000
usbd_do_request_flags: Handle Request function is set
usb_needs_explore: 
usb_proc_msignal:  t=3, num=1
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa3 bRequest=0x00 wValue=0x0000 wIndex=0x0001 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x23 bRequest=0x01 wValue=0x0014 wIndex=0x0001 wLength=0x0000
usbd_do_request_flags: Handle Request function is set
Root mount waiting for: usbus0
usbd_req_reset_port: port 1 reset returning error=USB_ERR_NORMAL_COMPLETION
usb_set_device_state: udev 0xc368d000 state ADDRESSED -> POWERED
usbd_req_set_address: setting device address=2
usbd_do_request_flags: udev=0xc368d000 bmRequestType=0x00 bRequest=0x05 wValue=0x0002 wIndex=0x0000 wLength=0x0000
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usb_proc_msignal:  t=0, num=0
usb_process: Message pm=0xc371e044, cb=0xc098296c (enter)
usb_command_wrapper: cb 0xc371e0b0 (enter)
usbd_callback_wrapper: case 1-4
usbd_do_request_callback: st=0
usbd_transfer_submit: xfer=0xc371e0b0, endpoint=0xc368d08c, nframes=1, dir=write
usb_dump_endpoint: endpoint=0xc368d08c edesc=0xc368d34c isoc_next=0 toggle_next=1 bEndpointAddress=0x00
usb_dump_queue: endpoint=0xc368d08c xfer: 
usbd_transfer_submit: open
usb_command_wrapper: cb 0xc371e0b0 (enter)
usb_command_wrapper: cb 0xc371e0b0 (leave)
usb_command_wrapper: cb 0xc371e0b0 (enter)
usbd_pipe_enter: enter
usb_command_wrapper: cb 0xc371e0b0 (enter)
usbd_pipe_start: start
usb_command_wrapper: cb 0xc371e0b0 (leave)
usb_command_wrapper: cb 0 (leave)
usb_command_wrapper: cb 0 (leave)
usb_process: Message pm=0xc371e044 (leave)
usbd_transfer_done: err=USB_ERR_STALLED
usb_proc_msignal:  t=0, num=0
usb_process: Message pm=0xc371e044, cb=0xc098296c (enter)
usb_command_wrapper: cb 0xc371e0b0 (enter)
usbd_callback_wrapper: case 1-4
usbd_callback_wrapper_sub: xfer=0xc371e0b0 endpoint=0xc368d08c sts=22 alen=0, slen=8, afrm=1, nfrm=1
usbd_do_request_callback: st=2
usb_command_wrapper: cb 0 (leave)
usb_process: Message pm=0xc371e044 (leave)
usbd_transfer_stop: close
usbd_transfer_done: err=USB_ERR_CANCELLED
usbd_transfer_done: not transferring
usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_STALLED, ignored)
usbd_req_get_desc: id=0, type=1, index=0, max_len=8
usbd_do_request_flags: udev=0xc368d000 bmRequestType=0x80 bRequest=0x06 wValue=0x0100 wIndex=0x0000 wLength=0x0008
usb_needs_explore: 
usb_proc_msignal:  t=3, num=1
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usb_proc_msignal:  t=0, num=0
usb_process: Message pm=0xc371f044, cb=0xc098296c (enter)
usb_command_wrapper: cb 0xc371f0b0 (enter)
usbd_callback_wrapper: case 1-4
usbd_do_request_callback: st=0
usbd_transfer_submit: xfer=0xc371f0b0, endpoint=0xc368d08c, nframes=2, dir=write
usb_dump_endpoint: endpoint=0xc368d08c edesc=0xc368d34c isoc_next=0 toggle_next=1 bEndpointAddress=0x00
usb_dump_queue: endpoint=0xc368d08c xfer: 
usbd_transfer_submit: open
usb_command_wrapper: cb 0xc371f0b0 (enter)
usb_command_wrapper: cb 0xc371f0b0 (leave)
usb_command_wrapper: cb 0xc371f0b0 (enter)
usb_command_wrapper: cb 0xc371f0b0 (leave)
usb_command_wrapper: cb 0xc371f0b0 (enter)
usbd_pipe_enter: enter
usb_command_wrapper: cb 0xc371f0b0 (enter)
usbd_pipe_start: start
usb_command_wrapper: cb 0xc371f0b0 (leave)
usb_command_wrapper: cb 0 (leave)
usb_command_wrapper: cb 0 (leave)
usb_process: Message pm=0xc371f044 (leave)
usbd_transfer_done: err=USB_ERR_STALLED
usb_proc_msignal:  t=0, num=0
usb_process: Message pm=0xc371f044, cb=0xc098296c (enter)
usb_command_wrapper: cb 0xc371f0b0 (enter)
usbd_callback_wrapper: case 1-4
usbd_callback_wrapper_sub: xfer=0xc371f0b0 endpoint=0xc368d08c sts=22 alen=0, slen=16, afrm=1, nfrm=2
usbd_do_request_callback: st=2
usb_command_wrapper: cb 0 (leave)
usb_process: Message pm=0xc371f044 (leave)
usbd_transfer_stop: close
usbd_transfer_done: err=USB_ERR_CANCELLED
usbd_transfer_done: not transferring
usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_STALLED
Root mount waiting for: usbus0
usbd_req_re_enumerate: Trying to reset parent High Speed TT.
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x23 bRequest=0x09 wValue=0x0000 wIndex=0x0001 wLength=0x0000
usbd_do_request_flags: Handle Request function is set
usbd_req_reset_port: 
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x23 bRequest=0x01 wValue=0x0014 wIndex=0x0001 wLength=0x0000
usbd_do_request_flags: Handle Request function is set
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x23 bRequest=0x03 wValue=0x0004 wIndex=0x0001 wLength=0x0000
usbd_do_request_flags: Handle Request function is set
usb_needs_explore: 
usb_proc_msignal:  t=3, num=1
usb_needs_explore: 
usb_proc_msignal:  t=3, num=1
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa3 bRequest=0x00 wValue=0x0000 wIndex=0x0001 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x23 bRequest=0x01 wValue=0x0014 wIndex=0x0001 wLength=0x0000
usbd_do_request_flags: Handle Request function is set
usbd_req_reset_port: port 1 reset returning error=USB_ERR_NORMAL_COMPLETION
usb_set_device_state: udev 0xc368d000 state POWERED -> POWERED
usbd_req_set_address: setting device address=2
usbd_do_request_flags: udev=0xc368d000 bmRequestType=0x00 bRequest=0x05 wValue=0x0002 wIndex=0x0000 wLength=0x0000
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usb_proc_msignal:  t=0, num=0
usb_process: Message pm=0xc371f044, cb=0xc098296c (enter)
usb_command_wrapper: cb 0xc371f0b0 (enter)
usbd_callback_wrapper: case 1-4
usbd_do_request_callback: st=0
usbd_transfer_submit: xfer=0xc371f0b0, endpoint=0xc368d08c, nframes=1, dir=write
usb_dump_endpoint: endpoint=0xc368d08c edesc=0xc368d34c isoc_next=0 toggle_next=1 bEndpointAddress=0x00
usb_dump_queue: endpoint=0xc368d08c xfer: 
usbd_transfer_submit: open
usb_command_wrapper: cb 0xc371f0b0 (enter)
usb_command_wrapper: cb 0xc371f0b0 (leave)
usb_command_wrapper: cb 0xc371f0b0 (enter)
usbd_pipe_enter: enter
usb_command_wrapper: cb 0xc371f0b0 (enter)
usbd_pipe_start: start
usb_command_wrapper: cb 0xc371f0b0 (leave)
usb_command_wrapper: cb 0 (leave)
usb_command_wrapper: cb 0 (leave)
usb_process: Message pm=0xc371f044 (leave)
usbd_transfer_done: err=USB_ERR_STALLED
usb_proc_msignal:  t=0, num=0
usb_process: Message pm=0xc371f044, cb=0xc098296c (enter)
usb_command_wrapper: cb 0xc371f0b0 (enter)
usbd_callback_wrapper: case 1-4
usbd_callback_wrapper_sub: xfer=0xc371f0b0 endpoint=0xc368d08c sts=22 alen=0, slen=8, afrm=1, nfrm=1
usbd_do_request_callback: st=2
usb_command_wrapper: cb 0 (leave)
usb_process: Message pm=0xc371f044 (leave)
usbd_transfer_stop: close
usbd_transfer_done: err=USB_ERR_CANCELLED
usbd_transfer_done: not transferring
Root mount waiting for: usbus0
usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_STALLED, ignored)
usbd_req_get_desc: id=0, type=1, index=0, max_len=8
usbd_do_request_flags: udev=0xc368d000 bmRequestType=0x80 bRequest=0x06 wValue=0x0100 wIndex=0x0000 wLength=0x0008
usb_needs_explore: 
usb_proc_msignal:  t=3, num=1
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usbd_get_endpoint: udev=0xc368d000 iface_index=0 address=0x0 type=0x0 dir=0xff index=0
usb_proc_msignal:  t=0, num=0
usb_process: Message pm=0xc371e044, cb=0xc098296c (enter)
usb_command_wrapper: cb 0xc371e0b0 (enter)
usbd_callback_wrapper: case 1-4
usbd_do_request_callback: st=0
usbd_transfer_submit: xfer=0xc371e0b0, endpoint=0xc368d08c, nframes=2, dir=write
usb_dump_endpoint: endpoint=0xc368d08c edesc=0xc368d34c isoc_next=0 toggle_next=1 bEndpointAddress=0x00
usb_dump_queue: endpoint=0xc368d08c xfer: 
usbd_transfer_submit: open
usb_command_wrapper: cb 0xc371e0b0 (enter)
usb_command_wrapper: cb 0xc371e0b0 (leave)
usb_command_wrapper: cb 0xc371e0b0 (enter)
usb_command_wrapper: cb 0xc371e0b0 (leave)
usb_command_wrapper: cb 0xc371e0b0 (enter)
usbd_pipe_enter: enter
usb_command_wrapper: cb 0xc371e0b0 (enter)
usbd_pipe_start: start
usb_command_wrapper: cb 0xc371e0b0 (leave)
usb_command_wrapper: cb 0 (leave)
usb_command_wrapper: cb 0 (leave)
usb_process: Message pm=0xc371e044 (leave)
usbd_transfer_done: err=USB_ERR_STALLED
usb_proc_msignal:  t=0, num=0
usb_process: Message pm=0xc371e044, cb=0xc098296c (enter)
usb_command_wrapper: cb 0xc371e0b0 (enter)
usbd_callback_wrapper: case 1-4
usbd_callback_wrapper_sub: xfer=0xc371e0b0 endpoint=0xc368d08c sts=22 alen=0, slen=16, afrm=1, nfrm=2
usbd_do_request_callback: st=2
usb_command_wrapper: cb 0 (leave)
usb_process: Message pm=0xc371e044 (leave)
usbd_transfer_stop: close
usbd_transfer_done: err=USB_ERR_CANCELLED
usbd_transfer_done: not transferring
usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_STALLED
usb_free_device: udev=0xc368d000 port=1
usb_set_device_state: udev 0xc368d000 state POWERED -> DETACHED
ugen0.2: <Unknown> at usbus0 (disconnected)
usb_bus_port_set_device: bus 0xc34eac78 devices[0] = 0
usb_detach_device: udev=0xc368d000
usb_cdev_free: Freeing device nodes
usb_config_parse: iface_index=255 cmd=1
uhub_reattach_port: could not allocate new device
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0x23 bRequest=0x01 wValue=0x0001 wIndex=0x0001 wLength=0x0000
usbd_do_request_flags: Handle Request function is set
usb_process: Message pm=0xc34ead5c (leave)
usb_process: Message pm=0xc34ead70, cb=0xc0967708 (enter)
usb_bus_powerd: bus=0xc34eac78
usb_bus_powerd: Recomputing power masks
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa3 bRequest=0x00 wValue=0x0000 wIndex=0x0001 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
uhub_read_port_status: port 1, wPortStatus=0x0301, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION
usb_process: Message pm=0xc34ead70 (leave)
Trying to mount root from ufs:/dev/ufs/dreamplug
GEOM: ufsid/4eb8e3d67ec8647c: geometry does not match label (255h,63s != 16h,63s).
usb_needs_explore: 
usb_proc_msignal:  t=0, num=1
usb_process: Message pm=0xc34ead5c, cb=0xc0967708 (enter)
usb_bus_powerd: bus=0xc34eac78
usb_bus_powerd: Recomputing power masks
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa3 bRequest=0x00 wValue=0x0000 wIndex=0x0001 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
uhub_read_port_status: port 1, wPortStatus=0x0301, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION
usb_process: Message pm=0xc34ead5c (leave)
usb_needs_explore: 
usb_proc_msignal:  t=0, num=1
usb_process: Message pm=0xc34ead5c, cb=0xc0967708 (enter)
usb_bus_powerd: bus=0xc34eac78
usb_bus_powerd: Recomputing power masks
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa3 bRequest=0x00 wValue=0x0000 wIndex=0x0001 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
uhub_read_port_status: port 1, wPortStatus=0x0301, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION
usb_process: Message pm=0xc34ead5c (leave)
usb_needs_explore: 
usb_proc_msignal:  t=0, num=1
usb_process: Message pm=0xc34ead5c, cb=0xc0967708 (enter)
usb_bus_powerd: bus=0xc34eac78
usb_bus_powerd: Recomputing power masks
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa3 bRequest=0x00 wValue=0x0000 wIndex=0x0001 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
uhub_read_port_status: port 1, wPortStatus=0x0301, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION
usb_process: Message pm=0xc34ead5c (leave)
usb_needs_explore: 
usb_proc_msignal:  t=0, num=1
usb_process: Message pm=0xc34ead5c, cb=0xc0967708 (enter)
usb_bus_powerd: bus=0xc34eac78
usb_bus_powerd: Recomputing power masks
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa3 bRequest=0x00 wValue=0x0000 wIndex=0x0001 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
uhub_read_port_status: port 1, wPortStatus=0x0301, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION
usb_process: Message pm=0xc34ead5c (leave)
usb_needs_explore: 
usb_proc_msignal:  t=0, num=1
usb_process: Message pm=0xc34ead5c, cb=0xc0967708 (enter)
usb_bus_powerd: bus=0xc34eac78
usb_bus_powerd: Recomputing power masks
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa3 bRequest=0x00 wValue=0x0000 wIndex=0x0001 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
uhub_read_port_status: port 1, wPortStatus=0x0301, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION
usb_process: Message pm=0xc34ead5c (leave)
usb_needs_explore: 
usb_proc_msignal:  t=0, num=1
usb_process: Message pm=0xc34ead5c, cb=0xc0967708 (enter)
usb_bus_powerd: bus=0xc34eac78
usb_bus_powerd: Recomputing power masks
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa3 bRequest=0x00 wValue=0x0000 wIndex=0x0001 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
uhub_read_port_status: port 1, wPortStatus=0x0301, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION
usb_process: Message pm=0xc34ead5c (leave)
usb_needs_explore: 
usb_proc_msignal:  t=0, num=1
usb_process: Message pm=0xc34ead5c, cb=0xc0967708 (enter)
usb_bus_powerd: bus=0xc34eac78
usb_bus_powerd: Recomputing power masks
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa3 bRequest=0x00 wValue=0x0000 wIndex=0x0001 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
uhub_read_port_status: port 1, wPortStatus=0x0301, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION
usb_process: Message pm=0xc34ead5c (leave)
usb_needs_explore: 
usb_proc_msignal:  t=0, num=1
usb_process: Message pm=0xc34ead5c, cb=0xc0967708 (enter)
usb_bus_powerd: bus=0xc34eac78
usb_bus_powerd: Recomputing power masks
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa3 bRequest=0x00 wValue=0x0000 wIndex=0x0001 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
uhub_read_port_status: port 1, wPortStatus=0x0301, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION
usb_process: Message pm=0xc34ead5c (leave)
usb_needs_explore: 
usb_proc_msignal:  t=0, num=1
usb_process: Message pm=0xc34ead5c, cb=0xc0967708 (enter)
usb_bus_powerd: bus=0xc34eac78
usb_bus_powerd: Recomputing power masks
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa3 bRequest=0x00 wValue=0x0000 wIndex=0x0001 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
uhub_read_port_status: port 1, wPortStatus=0x0301, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION
usb_process: Message pm=0xc34ead5c (leave)
usb_needs_explore: 
usb_proc_msignal:  t=0, num=1
usb_process: Message pm=0xc34ead5c, cb=0xc0967708 (enter)
usb_bus_powerd: bus=0xc34eac78
usb_bus_powerd: Recomputing power masks
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa3 bRequest=0x00 wValue=0x0000 wIndex=0x0001 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
uhub_read_port_status: port 1, wPortStatus=0x0301, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION
usb_process: Message pm=0xc34ead5c (leave)
usb_needs_explore: 
usb_proc_msignal:  t=0, num=1
usb_process: Message pm=0xc34ead5c, cb=0xc0967708 (enter)
usb_bus_powerd: bus=0xc34eac78
usb_bus_powerd: Recomputing power masks
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa3 bRequest=0x00 wValue=0x0000 wIndex=0x0001 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
uhub_read_port_status: port 1, wPortStatus=0x0301, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION
usb_process: Message pm=0xc34ead5c (leave)
usb_needs_explore: 
usb_proc_msignal:  t=0, num=1
usb_process: Message pm=0xc34ead5c, cb=0xc0967708 (enter)
usb_bus_powerd: bus=0xc34eac78
usb_bus_powerd: Recomputing power masks
usbd_do_request_flags: udev=0xc3686c00 bmRequestType=0xa3 bRequest=0x00 wValue=0x0000 wIndex=0x0001 wLength=0x0004
usbd_do_request_flags: Handle Request function is set
uhub_read_port_status: port 1, wPortStatus=0x0301, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION
usb_process: Message pm=0xc34ead5c (leave)

More information about the freebsd-arm mailing list