From owner-freebsd-usb@FreeBSD.ORG Thu Mar 15 12:48:56 2012 Return-Path: Delivered-To: freebsd-usb@freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [69.147.83.52]) by hub.freebsd.org (Postfix) with ESMTP id 1F1E81065670 for ; Thu, 15 Mar 2012 12:48:56 +0000 (UTC) (envelope-from holm@beast.freibergnet.de) Received: from bmail.freibergnet.de (bmail.freibergnet.de [46.4.195.14]) by mx1.freebsd.org (Postfix) with ESMTP id 0E2718FC0A for ; Thu, 15 Mar 2012 12:48:54 +0000 (UTC) Received: from bmail.freibergnet.de (bmail.freibergnet.de [46.4.195.14]) by bmail.freibergnet.de (Postfix) with ESMTP id B5787929B057 for ; Thu, 15 Mar 2012 13:48:47 +0100 (CET) X-Virus-Scanned: amavisd-new at freibergnet.de Received: from bmail.freibergnet.de ([46.4.195.14]) by bmail.freibergnet.de (bmail.freibergnet.de [46.4.195.14]) (amavisd-new, port 10024) with LMTP id d4JRsjyG3s8I for ; Thu, 15 Mar 2012 13:48:40 +0100 (CET) Received: from beast.freibergnet.de (bmail.freibergnet.de [46.4.195.14]) by bmail.freibergnet.de (Postfix) with ESMTP id CD3D8929B054 for ; Thu, 15 Mar 2012 13:48:40 +0100 (CET) Received: by beast.freibergnet.de (Postfix, from userid 201) id C75724B8040; Thu, 15 Mar 2012 13:48:40 +0100 (CET) Date: Thu, 15 Mar 2012 13:48:40 +0100 From: Holm Tiffe To: freebsd-usb@freebsd.org Message-ID: <20120315124840.GA64319@beast.freibergnet.de> Mime-Version: 1.0 Content-Type: text/plain; charset=iso-8859-1 Content-Disposition: inline Content-Transfer-Encoding: 8bit User-Agent: Mutt/1.4.2.3i Organization: FreibergNet Internet Services, TSHT Priority: normal X-Phone: +49-3731-74222 X-Mobile: +49-172-8790741 X-Fax: +49-3731-74200 Subject: USB UHCI Problems on 8-Stable X-BeenThere: freebsd-usb@freebsd.org X-Mailman-Version: 2.1.5 Precedence: list Reply-To: holm@freibergnet.de List-Id: FreeBSD support for USB List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Thu, 15 Mar 2012 12:48:56 -0000 Hi, For some time I had problems with my Cam (Olympus FE-230), it wouldn't get recognized again after unplugging it from the USB Connector. Now I have a very similar Problem while trying to get an J-Link V8 compatible Jtag debugger working in conjunction with openocd. Maybe there are bugs in openocd, but the bigger ones seems to be in FreeBSDs USB drivers. In the meantime I've cvs-supped to 8.3PRERELEASE (yesterday) built world and kernel. I've commented the ?hci drivers out of the kernel config and set USB_DEBUG. At fist please Cc me, I'm not on freebsd-usb. After Loading the uhci module: Mar 15 13:21:09 unicorn kernel: uhci1: port 0xd000-0xd01f irq 15 at device 16.1 on pci0 Mar 15 13:21:09 unicorn kernel: uhci1: [ITHREAD] Mar 15 13:21:09 unicorn kernel: usbus0: 12Mbps Full Speed USB v1.0 Mar 15 13:21:10 unicorn kernel: usb_bus_port_set_device: bus 0xc6e44cf0 devices[1] = 0xc5608800 Mar 15 13:21:10 unicorn kernel: ugen0.1: at usbus0 Mar 15 13:21:10 unicorn kernel: uhub0: on usbus0 Mar 15 13:21:10 unicorn kernel: uhub_attach: depth=0 selfpowered=1, parent=0, parent->selfpowered=0 Mar 15 13:21:10 unicorn kernel: uhub_attach: Getting HUB descriptor Mar 15 13:21:10 unicorn kernel: usb_needs_explore: Mar 15 13:21:10 unicorn kernel: usb_needs_explore: No root HUB Mar 15 13:21:10 unicorn kernel: usbus1: on uhci1 Mar 15 13:21:10 unicorn kernel: usbus1: 12Mbps Full Speed USB v1.0 Mar 15 13:21:10 unicorn kernel: usb_needs_explore: Mar 15 13:21:10 unicorn kernel: usb_needs_explore: No root HUB Mar 15 13:21:10 unicorn kernel: uhci2: port 0xd400-0xd41f irq 5 at device 16.2 on pci0 Mar 15 13:21:10 unicorn kernel: uhci2: [ITHREAD] Mar 15 13:21:10 unicorn kernel: usb_bus_port_set_device: bus 0xc6ed4cf0 devices[1] = 0xc5511c00 Mar 15 13:21:10 unicorn kernel: ugen1.1: at usbus1 Mar 15 13:21:10 unicorn kernel: uhub1: on usbus1 Mar 15 13:21:10 unicorn kernel: uhub_attach: depth=0 selfpowered=1, parent=0, parent->selfpowered=0 Mar 15 13:21:10 unicorn kernel: uhub_attach: Getting HUB descriptor Mar 15 13:21:10 unicorn kernel: uhub_attach: turn on port 1 power Mar 15 13:21:10 unicorn kernel: usb_needs_explore: Mar 15 13:21:10 unicorn kernel: usb_needs_explore: No root HUB Mar 15 13:21:10 unicorn kernel: usbus2: on uhci2 Mar 15 13:21:10 unicorn kernel: usbus2: 12Mbps Full Speed USB v1.0 Mar 15 13:21:10 unicorn kernel: usb_needs_explore: ... # usbconfig list ugen0.1: at usbus0, cfg=0 md=HOST spd=FULL (12Mbps) pwr=SAVE ugen1.1: at usbus1, cfg=0 md=HOST spd=FULL (12Mbps) pwr=SAVE ugen2.1: at usbus2, cfg=0 md=HOST spd=FULL (12Mbps) pwr=SAVE # Now connecting the J-Link Mar 15 13:23:41 unicorn kernel: usb_bus_powerd: Recomputing power masks Mar 15 13:23:41 unicorn kernel: uhub_explore: udev=0xc5511c00 addr=1 Mar 15 13:23:41 unicorn kernel: uhub_read_port_status: port 1, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:23:41 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x0109, wPortChange=0x0003, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:23:41 unicorn kernel: uhub_reattach_port: reattaching port 2 Mar 15 13:23:41 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x0109, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:23:41 unicorn kernel: uhub_reattach_port: Port 2 is in Host Mode Mar 15 13:23:42 unicorn root: Unknown USB device: vendor 0x1366 product 0x0101 bus uhub1 Mar 15 13:23:42 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x010b, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:23:42 unicorn kernel: usbd_transfer_power_ref: Adding type 0 to power state Mar 15 13:23:42 unicorn kernel: usbd_transfer_power_ref: needs power Mar 15 13:23:42 unicorn kernel: usb_bus_port_set_device: bus 0xc6ed4cf0 devices[2] = 0xc5602400 Mar 15 13:23:42 unicorn kernel: ugen1.2: at usbus1 Mar 15 13:23:42 unicorn kernel: usb_needs_explore: Mar 15 13:23:42 unicorn kernel: usb_bus_powerd: bus=0xc6e44cf0 Mar 15 13:23:42 unicorn kernel: usb_bus_powerd: Recomputing power masks Mar 15 13:23:42 unicorn kernel: uhub_explore: udev=0xc5608800 addr=1 Mar 15 13:23:42 unicorn kernel: uhub_read_port_status: port 1, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:23:42 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:23:42 unicorn kernel: usb_needs_explore: .. # usbconfig list ugen0.1: at usbus0, cfg=0 md=HOST spd=FULL (12Mbps) pwr=SAVE ugen1.1: at usbus1, cfg=0 md=HOST spd=FULL (12Mbps) pwr=SAVE ugen2.1: at usbus2, cfg=0 md=HOST spd=FULL (12Mbps) pwr=SAVE ugen1.2: at usbus1, cfg=0 md=HOST spd=FULL (12Mbps) pwr=ON # now starting openocd: $ openocd -f jlinkv8.cfg Open On-Chip Debugger 0.5.0 (2012-03-15-08:44) Licensed under GNU GPL v2 For bug reports, read http://openocd.berlios.de/doc/doxygen/bugs.html Warn : Adapter driver 'jlink' did not declare which transports it allows; assuming legacy JTAG-only Info : only one transport option; autoselect 'jtag' 1000 kHz adapter_nsrst_delay: 100 jtag_ntrst_delay: 100 cortex_m3 reset_config sysresetreq 250 kHz Info : J-Link initialization started / target CPU reset initiated Info : J-Link ARM V8 compiled Dec 16 2010 20:21:29 Info : J-Link caps 0xb9ff7bbf Info : J-Link hw version 80000 Info : J-Link hw type J-Link Info : J-Link max mem block 8368 Info : J-Link configuration Info : USB-Address: 0x0 Info : Kickstart power on JTAG-pin 19: 0xffffffff Info : Vref = 3.228 TCK = 1 TDI = 0 TDO = 1 TMS = 0 SRST = 0 TRST = 0 Info : J-Link JTAG Interface ready Error: usb_bulk_read failed (requested=1, result=-6) Error: jlink_tap_execute, wrong result -107 (expected 1) Error: J-Link setting speed failed (-60) in procedure 'init' $ every next try end like this: $ openocd -f jlinkv8.cfg Open On-Chip Debugger 0.5.0 (2012-03-15-08:44) Licensed under GNU GPL v2 For bug reports, read http://openocd.berlios.de/doc/doxygen/bugs.html Warn : Adapter driver 'jlink' did not declare which transports it allows; assuming legacy JTAG-only Info : only one transport option; autoselect 'jtag' 1000 kHz adapter_nsrst_delay: 100 jtag_ntrst_delay: 100 cortex_m3 reset_config sysresetreq 250 kHz Info : J-Link initialization started / target CPU reset initiated Error: J-Link command 0xde failed (-60) Error: J-Link command 0xdc failed (-60) Error: J-Link command 0x01 failed (-60) Error: J-Link command EMU_CMD_VERSION failed (-60) Info : J-Link JTAG Interface ready Error: J-Link command 0xdd failed (-60) Error: J-Link command 0xdf failed (-60) Error: usb_bulk_write failed (requested=6, result=-60) Error: jlink_tap_execute, wrong result -107 (expected 1) Error: J-Link setting speed failed (-60) in procedure 'init' $ # usbconfig list ugen0.1: at usbus0, cfg=0 md=HOST spd=FULL (12Mbps) pwr=SAVE ugen1.1: at usbus1, cfg=0 md=HOST spd=FULL (12Mbps) pwr=SAVE ugen2.1: at usbus2, cfg=0 md=HOST spd=FULL (12Mbps) pwr=SAVE ugen1.2: at usbus1, cfg=0 md=HOST spd=FULL (12Mbps) pwr=ON # If I disconnect the J-Link the device disappears: Mar 15 13:27:42 unicorn kernel: uhub_explore: udev=0xc561f000 addr=1 Mar 15 13:27:42 unicorn kernel: uhub_read_port_status: port 1, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:27:42 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:27:46 unicorn kernel: usb_needs_explore: Mar 15 13:27:46 unicorn kernel: usb_bus_powerd: bus=0xc6ed4cf0 Mar 15 13:27:46 unicorn kernel: usb_bus_powerd: Recomputing power masks Mar 15 13:27:46 unicorn kernel: uhub_explore: udev=0xc5511c00 addr=1 Mar 15 13:27:46 unicorn kernel: uhub_read_port_status: port 1, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:27:46 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x0108, wPortChange=0x0003, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:27:46 unicorn kernel: uhub_reattach_port: reattaching port 2 Mar 15 13:27:46 unicorn kernel: ugen1.2: at usbus1 (disconnected) Mar 15 13:27:46 unicorn kernel: usb_bus_port_set_device: bus 0xc6ed4cf0 devices[2] = 0 Mar 15 13:27:46 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:27:46 unicorn kernel: usb_needs_explore: Mar 15 13:27:46 unicorn kernel: usb_bus_powerd: bus=0xc6e44cf0 Mar 15 13:27:46 unicorn kernel: usb_bus_powerd: Recomputing power masks Mar 15 13:27:46 unicorn kernel: uhub_explore: udev=0xc5608800 addr=1 Mar 15 13:27:46 unicorn kernel: uhub_read_port_status: port 1, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION #usbconfig list ugen0.1: at usbus0, cfg=0 md=HOST spd=FULL (12Mbps) pwr=SAVE ugen1.1: at usbus1, cfg=0 md=HOST spd=FULL (12Mbps) pwr=SAVE ugen2.1: at usbus2, cfg=0 md=HOST spd=FULL (12Mbps) pwr=SAVE # but after replugging it, it never gets connected again: Mar 15 13:29:34 unicorn kernel: usb_bus_powerd: Recomputing power masks Mar 15 13:29:34 unicorn kernel: uhub_explore: udev=0xc561f000 addr=1 Mar 15 13:29:34 unicorn kernel: uhub_read_port_status: port 1, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:29:34 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:29:36 unicorn kernel: usb_needs_explore: Mar 15 13:29:36 unicorn kernel: usb_bus_powerd: bus=0xc6ed4cf0 Mar 15 13:29:36 unicorn kernel: usb_bus_powerd: Recomputing power masks Mar 15 13:29:36 unicorn kernel: uhub_explore: udev=0xc5511c00 addr=1 Mar 15 13:29:36 unicorn kernel: uhub_read_port_status: port 1, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:29:36 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x0109, wPortChange=0x0003, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:29:36 unicorn kernel: uhub_reattach_port: reattaching port 2 Mar 15 13:29:36 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x0109, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:29:36 unicorn kernel: uhub_reattach_port: Port 2 is in Host Mode Mar 15 13:29:37 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x010b, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:29:37 unicorn kernel: usbd_transfer_power_ref: Adding type 0 to power state Mar 15 13:29:37 unicorn kernel: usbd_transfer_power_ref: needs power Mar 15 13:29:38 unicorn kernel: usb_alloc_device: set address 2 failed (USB_ERR_TIMEOUT, ignored) Mar 15 13:29:38 unicorn kernel: usb_needs_explore: Mar 15 13:29:38 unicorn kernel: usb_bus_powerd: bus=0xc6e44cf0 Mar 15 13:29:38 unicorn kernel: usb_bus_powerd: Recomputing power masks Mar 15 13:29:38 unicorn kernel: uhub_explore: udev=0xc5608800 addr=1 Mar 15 13:29:38 unicorn kernel: uhub_read_port_status: port 1, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:29:38 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION # usbconfig list ugen0.1: at usbus0, cfg=0 md=HOST spd=FULL (12Mbps) pwr=SAVE ugen1.1: at usbus1, cfg=0 md=HOST spd=FULL (12Mbps) pwr=SAVE ugen2.1: at usbus2, cfg=0 md=HOST spd=FULL (12Mbps) pwr=SAVE # # usbconfig -d ugen1.1 reset usbconfig: could not reset device: Invalid argument # # usbconfig -d ugen1.1 resume usbconfig: could not set resume: Invalid argument # Before I've built the kernel w/o the =hci drivers compiled in a reboot was the only solution to get this device on this port recognized again. Now a simple kldunload/kldload uhci does the job, even w/o disconnecting the J-Linki (it leaves powered up). This is why I thing that the bug sits in FreeBSDs usb driver. Mar 15 13:35:06 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:35:10 unicorn kernel: ugen0.1: at usbus0 (disconnected) Mar 15 13:35:10 unicorn kernel: usb_bus_port_set_device: bus 0xc6e44cf0 devices[1] = 0 Mar 15 13:35:10 unicorn kernel: unknown: at usbus0, port 1, addr 1 (disconnected) Mar 15 13:35:10 unicorn kernel: usbus0: detached Mar 15 13:35:10 unicorn kernel: uhci0: detached Mar 15 13:35:10 unicorn kernel: pci0: at device 16.0 (no driver attached) Mar 15 13:35:10 unicorn kernel: ugen1.1: at usbus1 (disconnected) Mar 15 13:35:10 unicorn kernel: usb_bus_port_set_device: bus 0xc6ed4cf0 devices[1] = 0 Mar 15 13:35:10 unicorn kernel: unknown: at usbus1, port 1, addr 1 (disconnected) Mar 15 13:35:10 unicorn kernel: usbus1: detached Mar 15 13:35:10 unicorn kernel: uhci1: detached Mar 15 13:35:10 unicorn kernel: pci0: at device 16.1 (no driver attached) Mar 15 13:35:10 unicorn kernel: ugen2.1: at usbus2 (disconnected) Mar 15 13:35:10 unicorn kernel: usb_bus_port_set_device: bus 0xc7657cf0 devices[1] = 0 Mar 15 13:35:10 unicorn kernel: unknown: at usbus2, port 1, addr 1 (disconnected) Mar 15 13:35:10 unicorn kernel: usbus2: detached Mar 15 13:35:10 unicorn kernel: uhci2: detached Mar 15 13:35:10 unicorn kernel: pci0: at device 16.2 (no driver attached) Mar 15 13:35:15 unicorn kernel: uhci0: port 0xcc00-0xcc1f irq 15 at device 16.0 on pci0 Mar 15 13:35:15 unicorn kernel: uhci0: [ITHREAD] Mar 15 13:35:16 unicorn kernel: usb_needs_explore: Mar 15 13:35:16 unicorn kernel: usb_needs_explore: No root HUB Mar 15 13:35:16 unicorn kernel: usbus0: on uhci0 Mar 15 13:35:16 unicorn kernel: usb_needs_explore: Mar 15 13:35:16 unicorn kernel: usb_needs_explore: No root HUB Mar 15 13:35:16 unicorn kernel: usbus0: 12Mbps Full Speed USB v1.0 Mar 15 13:35:16 unicorn kernel: uhci1: port 0xd000-0xd01f irq 15 at device 16.1 on pci0 Mar 15 13:35:16 unicorn kernel: uhci1: [ITHREAD] Mar 15 13:35:16 unicorn kernel: usb_bus_port_set_device: bus 0xc6e44cf0 devices[1] = 0xc5591c00 Mar 15 13:35:16 unicorn kernel: ugen0.1: at usbus0 Mar 15 13:35:16 unicorn kernel: uhub0: on usbus0 Mar 15 13:35:16 unicorn kernel: uhub_attach: depth=0 selfpowered=1, parent=0, parent->selfpowered=0 Mar 15 13:35:16 unicorn kernel: uhub_attach: Getting HUB descriptor Mar 15 13:35:16 unicorn kernel: usb_needs_explore: Mar 15 13:35:16 unicorn kernel: usb_needs_explore: No root HUB Mar 15 13:35:16 unicorn kernel: usbus1: on uhci1 Mar 15 13:35:16 unicorn kernel: usbus1: 12Mbps Full Speed USB v1.0 Mar 15 13:35:16 unicorn kernel: usb_needs_explore: Mar 15 13:35:16 unicorn kernel: usb_needs_explore: No root HUB Mar 15 13:35:16 unicorn kernel: uhci2: port 0xd400-0xd41f irq 5 at device 16.2 on pci0 Mar 15 13:35:16 unicorn kernel: uhci2: [ITHREAD] Mar 15 13:35:16 unicorn kernel: usb_bus_port_set_device: bus 0xc6ed4cf0 devices[1] = 0xc5517800 Mar 15 13:35:16 unicorn kernel: ugen1.1: at usbus1 Mar 15 13:35:16 unicorn kernel: uhub1: on usbus1 Mar 15 13:35:16 unicorn kernel: uhub_attach: depth=0 selfpowered=1, parent=0, parent->selfpowered=0 Mar 15 13:35:16 unicorn kernel: uhub_attach: Getting HUB descriptor Mar 15 13:35:16 unicorn kernel: uhub_attach: turn on port 1 power Mar 15 13:35:16 unicorn kernel: usb_needs_explore: Mar 15 13:35:16 unicorn kernel: usb_needs_explore: No root HUB Mar 15 13:35:16 unicorn kernel: usbus2: on uhci2 Mar 15 13:35:16 unicorn kernel: usbus2: 12Mbps Full Speed USB v1.0 Mar 15 13:35:16 unicorn kernel: usb_needs_explore: Mar 15 13:35:16 unicorn kernel: usb_needs_explore: No root HUB Mar 15 13:35:16 unicorn kernel: usb_bus_port_set_device: bus 0xc7657cf0 devices[1] = 0xc5608800 Mar 15 13:35:16 unicorn kernel: ugen2.1: at usbus2 Mar 15 13:35:16 unicorn kernel: uhub2: on usbus2 Mar 15 13:35:16 unicorn kernel: uhub_attach: depth=0 selfpowered=1, parent=0, parent->selfpowered=0 Mar 15 13:35:16 unicorn kernel: uhub_attach: Getting HUB descriptor Mar 15 13:35:16 unicorn kernel: uhub_attach: turn on port 2 power Mar 15 13:35:16 unicorn kernel: uhub_attach: turn on port 1 power Mar 15 13:35:16 unicorn kernel: uhub0: 2 ports with 2 removable, self powered Mar 15 13:35:16 unicorn kernel: usb_needs_explore: Mar 15 13:35:16 unicorn kernel: usb_needs_explore: Mar 15 13:35:16 unicorn kernel: usb_bus_powerd: bus=0xc6e44cf0 Mar 15 13:35:16 unicorn kernel: usb_bus_powerd: Recomputing power masks Mar 15 13:35:16 unicorn kernel: uhub_explore: udev=0xc5591c00 addr=1 Mar 15 13:35:16 unicorn kernel: uhub_read_port_status: port 1, wPortStatus=0x0108, wPortChange=0x0003, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:35:16 unicorn kernel: uhub_reattach_port: reattaching port 1 Mar 15 13:35:16 unicorn kernel: uhub_read_port_status: port 1, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:35:16 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x0108, wPortChange=0x0003, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:35:16 unicorn kernel: uhub_reattach_port: reattaching port 2 Mar 15 13:35:16 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:35:16 unicorn kernel: usb_bus_powerd: bus=0xc6e44cf0 Mar 15 13:35:16 unicorn kernel: usb_bus_powerd: Recomputing power masks Mar 15 13:35:16 unicorn kernel: uhub_explore: udev=0xc5591c00 addr=1 Mar 15 13:35:16 unicorn kernel: uhub_read_port_status: port 1, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:35:16 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:35:16 unicorn kernel: uhub_attach: turn on port 2 power Mar 15 13:35:16 unicorn kernel: uhub_attach: turn on port 1 power Mar 15 13:35:16 unicorn kernel: uhub1: 2 ports with 2 removable, self powered Mar 15 13:35:16 unicorn kernel: usb_needs_explore: Mar 15 13:35:16 unicorn kernel: usb_needs_explore: Mar 15 13:35:16 unicorn kernel: usb_bus_powerd: bus=0xc6ed4cf0 Mar 15 13:35:16 unicorn kernel: usb_bus_powerd: Recomputing power masks Mar 15 13:35:16 unicorn kernel: uhub_explore: udev=0xc5517800 addr=1 Mar 15 13:35:16 unicorn kernel: uhub_read_port_status: port 1, wPortStatus=0x0108, wPortChange=0x0003, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:35:16 unicorn kernel: uhub_reattach_port: reattaching port 1 Mar 15 13:35:16 unicorn kernel: uhub_read_port_status: port 1, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:35:16 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x0109, wPortChange=0x0003, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:35:16 unicorn kernel: uhub_reattach_port: reattaching port 2 Mar 15 13:35:16 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x0109, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:35:16 unicorn kernel: uhub_reattach_port: Port 2 is in Host Mode Mar 15 13:35:16 unicorn kernel: uhub_attach: turn on port 2 power Mar 15 13:35:16 unicorn kernel: uhub2: 2 ports with 2 removable, self powered Mar 15 13:35:16 unicorn kernel: usb_needs_explore: Mar 15 13:35:16 unicorn kernel: usb_needs_explore: Mar 15 13:35:16 unicorn kernel: usb_bus_powerd: bus=0xc7657cf0 Mar 15 13:35:16 unicorn kernel: usb_bus_powerd: Recomputing power masks Mar 15 13:35:16 unicorn kernel: uhub_explore: udev=0xc5608800 addr=1 Mar 15 13:35:16 unicorn kernel: uhub_read_port_status: port 1, wPortStatus=0x0108, wPortChange=0x0003, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:35:16 unicorn kernel: uhub_reattach_port: reattaching port 1 Mar 15 13:35:16 unicorn kernel: uhub_read_port_status: port 1, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:35:16 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x0108, wPortChange=0x0003, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:35:16 unicorn kernel: uhub_reattach_port: reattaching port 2 Mar 15 13:35:16 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:35:16 unicorn kernel: usb_bus_powerd: bus=0xc7657cf0 Mar 15 13:35:16 unicorn kernel: usb_bus_powerd: Recomputing power masks Mar 15 13:35:16 unicorn kernel: uhub_explore: udev=0xc5608800 addr=1 Mar 15 13:35:16 unicorn kernel: uhub_read_port_status: port 1, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:35:16 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:35:17 unicorn kernel: usb_needs_explore: Mar 15 13:35:17 unicorn root: Unknown USB device: vendor 0x1366 product 0x0101 bus uhub1 Mar 15 13:35:17 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x010b, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:35:17 unicorn kernel: usbd_transfer_power_ref: Adding type 0 to power state Mar 15 13:35:17 unicorn kernel: usbd_transfer_power_ref: needs power Mar 15 13:35:17 unicorn kernel: usb_bus_port_set_device: bus 0xc6ed4cf0 devices[2] = 0xc5602000 Mar 15 13:35:17 unicorn kernel: ugen1.2: at usbus1 Mar 15 13:35:17 unicorn kernel: usb_bus_powerd: bus=0xc6ed4cf0 Mar 15 13:35:17 unicorn kernel: uhub_explore: udev=0xc5517800 addr=1 Mar 15 13:35:17 unicorn kernel: uhub_read_port_status: port 1, wPortStatus=0x0108, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION Mar 15 13:35:17 unicorn kernel: uhub_read_port_status: port 2, wPortStatus=0x010b, wPortChange=0x0000, err=USB_ERR_NORMAL_COMPLETION It is exactly the same story with the Olympus Cam, but I need it seldom on my FreeBSD PC. This J-Link I need to make a income, so please can anyobody look at this? I think this misbehavior has popped up between 8.1 and 8.2. $ uname -a FreeBSD unicorn.tsht.lan 8.3-PRERELEASE FreeBSD 8.3-PRERELEASE #22: Thu Mar 15 11:25:58 CET 2012 holm@unicorn.tsht.lan:/data/FreeBSD/obj/data/FreeBSD/src/sys/UNICORN i386 $ Copyright (c) 1992-2012 The FreeBSD Project. Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994 The Regents of the University of California. All rights reserved. FreeBSD is a registered trademark of The FreeBSD Foundation. FreeBSD 8.3-PRERELEASE #22: Thu Mar 15 11:25:58 CET 2012 holm@unicorn.tsht.lan:/data/FreeBSD/obj/data/FreeBSD/src/sys/UNICORN i386 Timecounter "i8254" frequency 1193182 Hz quality 0 CPU: AMD Athlon(tm) XP 3000+ (2109.49-MHz 686-class CPU) Origin = "AuthenticAMD" Id = 0x6a0 Family = 6 Model = a Stepping = 0 Features=0x383fbff AMD Features=0xc0400800 real memory = 2147483648 (2048 MB) avail memory = 2092113920 (1995 MB) kbd1 at kbdmux0 acpi0: on motherboard acpi0: [ITHREAD] acpi0: Power Button (fixed) acpi0: reservation of 0, a0000 (3) failed acpi0: reservation of 100000, 7fef0000 (3) failed cpu0: on acpi0 acpi_button0: on acpi0 pcib0: port 0xcf8-0xcff on acpi0 pci0: on pcib0 agp0: on hostb0 agp0: aperture size is 128M pcib1: at device 1.0 on pci0 pci1: on pcib1 vgapci0: port 0xa000-0xa0ff mem 0xd8000000-0xdfffffff,0xe9000000-0xe900ffff irq 15 at device 0.0 on pci1 drm0: on vgapci0 info: [drm] AGP at 0xd0000000 128MB info: [drm] Initialized radeon 1.31.0 20080613 vgapci1: mem 0xe0000000-0xe7ffffff,0xe9010000-0xe901ffff at device 0.1 on pci1 de0: port 0xb000-0xb07f mem 0xeb002000-0xeb00207f irq 15 at device 9.0 on pci0 de0: Cogent 21040 [10Mb/s] pass 2.3 de0: WARNING: using obsoleted if_watchdog interface de0: Ethernet address: 00:00:92:90:09:8d de0: [ITHREAD] ahd0: port 0xb400-0xb4ff,0xb800-0xb8ff mem 0xeb000000-0xeb001fff irq 11 at device 11.0 on pci0 ahd0: [ITHREAD] aic7901A: Ultra320 Wide Channel A, SCSI Id=7, PCI 33 or 66MHz, 512 SCBs puc0: port 0xbc00-0xbc07,0xc000-0xc007,0xc400-0xc41f mem 0xeb003000-0xeb003fff,0xeb004000-0xeb004fff irq 15 at device 12.0 on pci0 puc0: [FILTER] uart2: <16550 or compatible> at port 1 on puc0 uart2: [FILTER] uart3: <16550 or compatible> at port 2 on puc0 uart3: [FILTER] sym0: <810a> port 0xc800-0xc8ff mem 0xeb005000-0xeb0050ff irq 15 at device 13.0 on pci0 sym0: No NVRAM, ID 7, Fast-10, SE, parity checking sym0: [ITHREAD] pci0: at device 16.0 (no driver attached) pci0: at device 16.1 (no driver attached) pci0: at device 16.2 (no driver attached) pci0: at device 16.3 (no driver attached) isab0: at device 17.0 on pci0 isa0: on isab0 atapci0: port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0xd800-0xd80f at device 17.1 on pci0 ata0: at channel 0 on atapci0 ata0: [ITHREAD] ata1: at channel 1 on atapci0 ata1: [ITHREAD] pcm0: port 0xdc00-0xdcff irq 5 at device 17.5 on pci0 pcm0: [ITHREAD] pcm0: pcm0: rl0: port 0xe000-0xe0ff mem 0xeb007000-0xeb0070ff irq 5 at device 19.0 on pci0 miibus0: on rl0 rlphy0: PHY 0 on miibus0 rlphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto rl0: Ethernet address: 00:0d:61:c3:c4:5a rl0: [ITHREAD] atrtc0: port 0x70-0x73 irq 8 on acpi0 fdc0: port 0x3f0-0x3f5,0x3f7 irq 6 drq 2 on acpi0 fdc0: [FILTER] fd0: <1440-KB 3.5" drive> on fdc0 drive 0 fd1: <1200-KB 5.25" drive> on fdc0 drive 1 uart0: <16550 or compatible> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0 uart0: [FILTER] uart1: <16550 or compatible> port 0x2f8-0x2ff irq 3 on acpi0 uart1: [FILTER] ppc0: port 0x378-0x37f,0x778-0x77b irq 7 drq 3 on acpi0 ppc0: SMC-like chipset (ECP/EPP/PS2/NIBBLE) in COMPATIBLE mode ppc0: FIFO with 16/16/16 bytes threshold ppc0: [ITHREAD] ppbus0: on ppc0 plip0: on ppbus0 plip0: [ITHREAD] lpt0: on ppbus0 lpt0: [ITHREAD] lpt0: Interrupt-driven port ppi0: on ppbus0 atkbdc0: port 0x60,0x64 irq 1 on acpi0 atkbd0: irq 1 on atkbdc0 kbd0 at atkbd0 atkbd0: [GIANT-LOCKED] atkbd0: [ITHREAD] psm0: irq 12 on atkbdc0 psm0: [GIANT-LOCKED] psm0: [ITHREAD] psm0: model MouseMan+, device ID 0 pmtimer0 on isa0 orm0: at iomem 0xc0000-0xccfff,0xd0000-0xd97ff pnpid ORM0000 on isa0 sc0: at flags 0x100 on isa0 sc0: VGA <16 virtual consoles, flags=0x300> vga0: at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0 Timecounter "TSC" frequency 2109485501 Hz quality 800 Timecounters tick every 1.000 msec (probe21:sym0:0:6:0): TEST UNIT READY. CDB: 0 0 0 0 0 0 (probe21:sym0:0:6:0): CAM status: SCSI Status Error (probe21:sym0:0:6:0): SCSI status: Check Condition (probe21:sym0:0:6:0): SCSI sense: UNIT ATTENTION asc:29,0 (Power on, reset, or bus device reset occurred) (probe20:sym0:0:5:0): TEST UNIT READY. CDB: 0 0 0 0 0 0 (probe20:sym0:0:5:0): CAM status: SCSI Status Error (probe20:sym0:0:5:0): SCSI status: Check Condition (probe20:sym0:0:5:0): SCSI sense: UNIT ATTENTION asc:29,0 (Power on, reset, or bus device reset occurred) (probe20:sym0:0:5:0): TEST UNIT READY. CDB: 0 0 0 0 0 0 (probe20:sym0:0:5:0): CAM status: SCSI Status Error (probe20:sym0:0:5:0): SCSI status: Check Condition (probe20:sym0:0:5:0): SCSI sense: NOT READY asc:3a,0 (Medium not present) sa0 at sym0 bus 0 scbus1 target 5 lun 0 sa0: Removable Sequential Access SCSI-2 device sa0: 4.166MB/s transfers (4.166MHz, offset 8) sa1 at sym0 bus 0 scbus1 target 6 lun 0 sa1: Removable Sequential Access SCSI-2 device sa1: 10.000MB/s transfers (10.000MHz, offset 8) da0 at ahd0 bus 0 scbus0 target 0 lun 0 da0: Fixed Direct Access SCSI-3 device da0: 160.000MB/s transfers (80.000MHz DT, offset 63, 16bit) da0: Command Queueing enabled da0: 70006MB (143374000 512 byte sectors: 255H 63S/T 8924C) da1 at ahd0 bus 0 scbus0 target 1 lun 0 da1: Fixed Direct Access SCSI-3 device da1: 160.000MB/s transfers (80.000MHz DT, offset 63, 16bit) da1: Command Queueing enabled da1: 70006MB (143374000 512 byte sectors: 255H 63S/T 8924C) da2 at ahd0 bus 0 scbus0 target 2 lun 0 da2: Fixed Direct Access SCSI-3 device da2: 160.000MB/s transfers (80.000MHz DT, offset 63, 16bit) (probe20:sym0:0:5:0): TEST UNIT READY. CDB: 0 0 0 0 0 0 (probe20:sym0:0:5:0): CAM status: SCSI Status Error (probe20:sym0:0:5:0): SCSI status: Check Condition (probe20:sym0:0:5:0): SCSI sense: UNIT ATTENTION asc:29,0 (Power on, reset, or bus device reset occurred) (probe20:sym0:0:5:0): TEST UNIT READY. CDB: 0 0 0 0 0 0 (probe20:sym0:0:5:0): CAM status: SCSI Status Error (probe20:sym0:0:5:0): SCSI status: Check Condition (probe20:sym0:0:5:0): SCSI sense: NOT READY asc:3a,0 (Medium not present) sa0 at sym0 bus 0 scbus1 target 5 lun 0 sa0: Removable Sequential Access SCSI-2 device sa0: 4.166MB/s transfers (4.166MHz, offset 8) sa1 at sym0 bus 0 scbus1 target 6 lun 0 sa1: Removable Sequential Access SCSI-2 device sa1: 10.000MB/s transfers (10.000MHz, offset 8) da0 at ahd0 bus 0 scbus0 target 0 lun 0 da0: Fixed Direct Access SCSI-3 device da0: 160.000MB/s transfers (80.000MHz DT, offset 63, 16bit) da0: Command Queueing enabled da0: 70006MB (143374000 512 byte sectors: 255H 63S/T 8924C) da1 at ahd0 bus 0 scbus0 target 1 lun 0 da1: Fixed Direct Access SCSI-3 device da1: 160.000MB/s transfers (80.000MHz DT, offset 63, 16bit) da1: Command Queueing enabled da1: 70006MB (143374000 512 byte sectors: 255H 63S/T 8924C) da2 at ahd0 bus 0 scbus0 target 2 lun 0 da2: Fixed Direct Access SCSI-3 device da2: 160.000MB/s transfers (80.000MHz DT, offset 63, 16bit) da2: Command Queueing enabled da2: 70006MB (143374000 512 byte sectors: 255H 63S/T 8924C) da3 at ahd0 bus 0 scbus0 target 3 lun 0 da3: Fixed Direct Access SCSI-3 device da3: 160.000MB/s transfers (80.000MHz DT, offset 63, 16bit) da3: Command Queueing enabled da3: 70006MB (143374000 512 byte sectors: 255H 63S/T 8924C) GEOM_CONCAT: Device gc0d created (id=2065581164). GEOM_CONCAT: Disk da0d attached to gc0d. GEOM_CONCAT: Device data created (id=2038144655). GEOM_CONCAT: Disk da0g attached to data. GEOM_MIRROR: Device mirror/gm0a launched (2/2). GEOM_CONCAT: Disk da1d attached to gc0d. GEOM_CONCAT: Device gc0d activated. GEOM_MIRROR: Device mirror/gm0e launched (2/2). GEOM_MIRROR: Device mirror/gm0f launched (2/2). GEOM_CONCAT: Disk da1g attached to data. GEOM_CONCAT: Disk da2a attached to data. GEOM_CONCAT: Disk da2b attached to data. GEOM_CONCAT: Device data activated. Trying to mount root from ufs:/dev/mirror/gm0a bridge0: Ethernet address: 02:82:44:4d:6c:00 Regards, Holm -- Technik Service u. Handel Tiffe, www.tsht.de, Holm Tiffe, Freiberger Straße 42, 09600 Oberschöna, USt-Id: DE253710583 www.tsht.de, info@tsht.de, Fax +49 3731 74200, Mobil: 0172 8790 741