From owner-freebsd-usb@FreeBSD.ORG Sat Oct 4 13:53:19 2014 Return-Path: Delivered-To: freebsd-usb@freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [8.8.178.115]) (using TLSv1.2 with cipher AECDH-AES256-SHA (256/256 bits)) (No client certificate requested) by hub.freebsd.org (Postfix) with ESMTPS id C76203B8 for ; Sat, 4 Oct 2014 13:53:19 +0000 (UTC) Received: from mail-lb0-x234.google.com (mail-lb0-x234.google.com [IPv6:2a00:1450:4010:c04::234]) (using TLSv1 with cipher ECDHE-RSA-RC4-SHA (128/128 bits)) (Client CN "smtp.gmail.com", Issuer "Google Internet Authority G2" (verified OK)) by mx1.freebsd.org (Postfix) with ESMTPS id 256976C2 for ; Sat, 4 Oct 2014 13:53:18 +0000 (UTC) Received: by mail-lb0-f180.google.com with SMTP id f15so2284208lbj.39 for ; Sat, 04 Oct 2014 06:53:16 -0700 (PDT) DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=gmail.com; s=20120113; h=mime-version:sender:in-reply-to:references:date:message-id:subject :from:to:content-type:content-transfer-encoding; bh=PKOnjRVWfrZF/Cz4uY+TLFnMy4He1abbddxnqW8tJy0=; b=T51oO6piCDf7vc/swzSognh0dlxuQgCHV5NYUoTTY1q5teRh1gQryyetUwkIMxuCqE y6HP626vRp61Acw9APPSmxJxlyvVpTuIghqkp30eK82bMAU+iS8pk1Is4wKLpvzcnkbk 2g5vjCCvuSDHQjyIR5PpZGRQ1Bt933aQe7EDuNid7KUph7axDfqminAQadiu6BQkE/bE K6p8DFclvbUmJwaa/ya0u62RNiTaNMx3+ps29fcFu8Bb0dL1UHzRFEaq0UXzmeOoeR5I 2ZAB8w2JGQVN51fDORB0fuieiKPQt6FeNTDBrVo6aqzQbt9GQOZc6xLuDbclEax8H5yI 7EzQ== MIME-Version: 1.0 X-Received: by 10.112.180.137 with SMTP id do9mr11910290lbc.63.1412430796511; Sat, 04 Oct 2014 06:53:16 -0700 (PDT) Sender: uspoerlein@gmail.com Received: by 10.152.170.135 with HTTP; Sat, 4 Oct 2014 06:53:16 -0700 (PDT) In-Reply-To: <20140929174904.GA15642@coyote.spoerlein.net> References: <20140929174904.GA15642@coyote.spoerlein.net> Date: Sat, 4 Oct 2014 15:53:16 +0200 X-Google-Sender-Auth: RN7u4h_7HFYQAKk6Y4VC_5QqdbM Message-ID: Subject: Re: CEC device not attaching to xHCI port From: =?UTF-8?Q?Ulrich_Sp=C3=B6rlein?= To: freebsd-usb@freebsd.org, hps@selasky.org Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: quoted-printable X-BeenThere: freebsd-usb@freebsd.org X-Mailman-Version: 2.1.18-1 Precedence: list List-Id: FreeBSD support for USB List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Sat, 04 Oct 2014 13:53:19 -0000 2014-09-29 19:49 GMT+02:00 Ulrich Sp=C3=B6rlein : > Hi, > > I got a CEC adapter using libCEC to bridge the gap between my XBMC and > TV. The device works fine *if* I plug it into the front ports (which is > a bit ugly, so I was wondering why this is not working on the other USB > hub). > > Non-working: > ugen0.2: at usbus0 (disconnected) > root@coyote:~# usbconfig -u 0 -a 1 > ugen0.1: at usbus0, cfg=3D0 md=3DHOST spd=3DSUPER = (5.0Gbps) pwr=3DSAVE (0mA) > > Working: > ugen1.4: at usbus1 > ums0: on= usbus1 > ums0: 3 buttons and [XY] coordinates ID=3D0 > umodem0: = on usbus1 > umodem0: data interface 1, has CM over data, has break > root@coyote:~# usbconfig -u 1 -a 4 > ugen1.4: at usbus1, cfg=3D0 md=3DHOST spd= =3DFULL (12Mbps) pwr=3DON (10mA) > > The hubs: > root@coyote:~# pciconf -l -v xhci0 > xhci0@pci0:0:20:0: class=3D0x0c0330 card=3D0x72708086 chip=3D0x1e318= 086 rev=3D0x04 hdr=3D0x00 > vendor =3D 'Intel Corporation' > device =3D '7 Series/C210 Series Chipset Family USB xHCI Host Con= troller' > class =3D serial bus > subclass =3D USB > root@coyote:~# pciconf -l -v ehci0 > ehci0@pci0:0:26:0: class=3D0x0c0320 card=3D0x72708086 chip=3D0x1e2d8= 086 rev=3D0x04 hdr=3D0x00 > vendor =3D 'Intel Corporation' > device =3D '7 Series/C210 Series Chipset Family USB Enhanced Host= Controller' > class =3D serial bus > subclass =3D USB > > This is on 10.1-BETA1 and I found this post and workaround, which seem to= be relevant: > http://unix.derkeiler.com/Mailing-Lists/FreeBSD/current/2013-02/msg00701.= html > > But I haven't rebooted yet with hw.usb.xhci.xhci_port_route -1 > > Any more info you'd require on this? Should I file a PR to track this? > > Cheers, > Uli Sorry for the delay, I'm not subscribed to freebsd-usb, please keep me CC'ed on replies. The flag hw.usb.xhci.xhci_port_route does nothing for me, as it doesn't even exist yet. I had to recompile my kernel to get USB_DEBUG and there's quite a bunch of repetitive output when plugging in the device into the non-working hub. Here we go: Oct 4 15:41:12 coyote kernel: usb_needs_explore: Oct 4 15:41:12 coyote kernel: usb_bus_powerd: bus=3D0xfffffe0000b54cd8 Oct 4 15:41:12 coyote kernel: usb_bus_powerd: Recomputing power masks Oct 4 15:41:12 coyote kernel: uhub_explore: udev=3D0xfffff800047e6000 addr= =3D1 Oct 4 15:41:12 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0503, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:12 coyote kernel: uhub_explore: udev=3D0xfffff800048b0000 addr= =3D2 Oct 4 15:41:12 coyote kernel: usbd_transfer_power_ref: Adding type 0 to power state Oct 4 15:41:12 coyote kernel: usbd_transfer_power_ref: needs power Oct 4 15:41:12 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:12 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:12 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:12 coyote kernel: uhub_read_port_status: port 4, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:13 coyote kernel: uhub_read_port_status: port 5, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:13 coyote kernel: uhub_read_port_status: port 6, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:13 coyote kernel: uhub_read_port_status: port 7, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:13 coyote kernel: uhub_read_port_status: port 8, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:13 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:13 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:14 coyote kernel: usb_needs_explore: Oct 4 15:41:14 coyote kernel: usb_bus_powerd: bus=3D0xfffffe0000ab4528 Oct 4 15:41:14 coyote kernel: usb_bus_powerd: Recomputing power masks Oct 4 15:41:14 coyote kernel: uhub_explore: udev=3D0xfffff800047e4000 addr= =3D1 Oct 4 15:41:14 coyote kernel: usb_needs_explore: Oct 4 15:41:14 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x07a0, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:14 coyote kernel: usb_bus_powerd: bus=3D0xfffffe0000ad0cd8 Oct 4 15:41:14 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x07a0, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:14 coyote kernel: uhub_explore: udev=3D0xfffff800047e5000 addr= =3D1 Oct 4 15:41:14 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x07a0, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:16 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0503, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:16 coyote kernel: uhub_explore: udev=3D0xfffff800048a9000 addr= =3D2 Oct 4 15:41:16 coyote kernel: uhub_read_port_status: port 4, wPortStatus=3D0x07a0, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:16 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:16 coyote kernel: uhub_read_port_status: port 5, wPortStatus=3D0x07a0, wPortChange=3D0x0020, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:16 coyote kernel: uhub_read_port_status: port 6, wPortStatus=3D0x07a0, wPortChange=3D0x0020, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:16 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:16 coyote kernel: uhub_read_port_status: port 7, wPortStatus=3D0x07a0, wPortChange=3D0x0020, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:16 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0103, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:16 coyote kernel: uhub_read_port_status: port 8, wPortStatus=3D0x07a0, wPortChange=3D0x0020, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:16 coyote kernel: uhub_read_port_status: port 4, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:16 coyote kernel: uhub_read_port_status: port 5, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:16 coyote kernel: uhub_read_port_status: port 6, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:16 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:16 coyote kernel: usb_needs_explore: Oct 4 15:41:16 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:16 coyote kernel: usb_bus_powerd: bus=3D0xfffffe0000b54cd8 Oct 4 15:41:16 coyote kernel: usb_bus_powerd: Recomputing power masks Oct 4 15:41:16 coyote kernel: uhub_explore: udev=3D0xfffff800047e6000 addr= =3D1 Oct 4 15:41:16 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0503, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:16 coyote kernel: uhub_explore: udev=3D0xfffff800048b0000 addr= =3D2 Oct 4 15:41:16 coyote kernel: usbd_transfer_power_ref: Adding type 0 to power state Oct 4 15:41:16 coyote kernel: usbd_transfer_power_ref: needs power Oct 4 15:41:16 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:17 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:17 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:17 coyote kernel: uhub_read_port_status: port 4, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:17 coyote kernel: uhub_read_port_status: port 5, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:17 coyote kernel: uhub_read_port_status: port 6, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:17 coyote kernel: uhub_read_port_status: port 7, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:17 coyote kernel: uhub_read_port_status: port 8, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:17 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:18 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:18 coyote kernel: usb_needs_explore: Oct 4 15:41:18 coyote kernel: usb_bus_powerd: bus=3D0xfffffe0000ab4528 Oct 4 15:41:18 coyote kernel: usb_bus_powerd: Recomputing power masks Oct 4 15:41:18 coyote kernel: uhub_explore: udev=3D0xfffff800047e4000 addr= =3D1 Oct 4 15:41:18 coyote kernel: usb_needs_explore: Oct 4 15:41:18 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x07a0, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:18 coyote kernel: usb_bus_powerd: bus=3D0xfffffe0000ad0cd8 Oct 4 15:41:18 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x07a0, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:18 coyote kernel: uhub_explore: udev=3D0xfffff800047e5000 addr= =3D1 Oct 4 15:41:18 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x07a0, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:20 coyote kernel: uhub_read_port_status: port 4, wPortStatus=3D0x07a0, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:20 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0503, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:20 coyote kernel: uhub_explore: udev=3D0xfffff800048a9000 addr= =3D2 Oct 4 15:41:20 coyote kernel: uhub_read_port_status: port 5, wPortStatus=3D0x07a0, wPortChange=3D0x0020, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:20 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:20 coyote kernel: uhub_read_port_status: port 6, wPortStatus=3D0x07a0, wPortChange=3D0x0020, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:20 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:20 coyote kernel: uhub_read_port_status: port 7, wPortStatus=3D0x07a0, wPortChange=3D0x0020, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:20 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0103, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:20 coyote kernel: uhub_read_port_status: port 8, wPortStatus=3D0x07a0, wPortChange=3D0x0020, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:20 coyote kernel: uhub_read_port_status: port 4, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:20 coyote kernel: uhub_read_port_status: port 5, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:20 coyote kernel: uhub_read_port_status: port 6, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:20 coyote kernel: usb_needs_explore: Oct 4 15:41:20 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:20 coyote kernel: usb_bus_powerd: bus=3D0xfffffe0000b54cd8 Oct 4 15:41:20 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:20 coyote kernel: usb_bus_powerd: Recomputing power masks Oct 4 15:41:20 coyote kernel: uhub_explore: udev=3D0xfffff800047e6000 addr= =3D1 Oct 4 15:41:20 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0503, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:20 coyote kernel: uhub_explore: udev=3D0xfffff800048b0000 addr= =3D2 Oct 4 15:41:20 coyote kernel: usbd_transfer_power_ref: Adding type 0 to power state Oct 4 15:41:20 coyote kernel: usbd_transfer_power_ref: needs power Oct 4 15:41:20 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:21 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:21 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:21 coyote kernel: uhub_read_port_status: port 4, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:21 coyote kernel: uhub_read_port_status: port 5, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:21 coyote kernel: uhub_read_port_status: port 6, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:21 coyote kernel: uhub_read_port_status: port 7, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:21 coyote kernel: uhub_read_port_status: port 8, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:21 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:21 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:22 coyote kernel: usb_needs_explore: Oct 4 15:41:22 coyote kernel: usb_bus_powerd: bus=3D0xfffffe0000ab4528 Oct 4 15:41:22 coyote kernel: usb_bus_powerd: Recomputing power masks Oct 4 15:41:22 coyote kernel: uhub_explore: udev=3D0xfffff800047e4000 addr= =3D1 Oct 4 15:41:22 coyote kernel: usb_needs_explore: Oct 4 15:41:22 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x07a0, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:22 coyote kernel: usb_bus_powerd: bus=3D0xfffffe0000ad0cd8 Oct 4 15:41:22 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x07a0, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:22 coyote kernel: uhub_explore: udev=3D0xfffff800047e5000 addr= =3D1 Oct 4 15:41:22 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x07a0, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:22 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0503, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:23 coyote kernel: uhub_explore: udev=3D0xfffff800048a9000 addr= =3D2 Oct 4 15:41:23 coyote kernel: uhub_read_port_status: port 4, wPortStatus=3D0x07a0, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:23 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:23 coyote kernel: uhub_read_port_status: port 5, wPortStatus=3D0x07a0, wPortChange=3D0x0020, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:23 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:23 coyote kernel: uhub_read_port_status: port 6, wPortStatus=3D0x07a0, wPortChange=3D0x0020, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:23 coyote kernel: uhub_read_port_status: port 7, wPortStatus=3D0x07a0, wPortChange=3D0x0020, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:23 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0103, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:23 coyote kernel: usb_needs_explore: Oct 4 15:41:23 coyote kernel: uhub_read_port_status: port 4, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:24 coyote kernel: uhub_read_port_status: port 8, wPortStatus=3D0x07a0, wPortChange=3D0x0020, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:24 coyote kernel: uhub_read_port_status: port 5, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:24 coyote kernel: usb_bus_powerd: bus=3D0xfffffe0000ab4528 Oct 4 15:41:24 coyote kernel: uhub_read_port_status: port 6, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:25 coyote kernel: usb_bus_powerd: Recomputing power masks Oct 4 15:41:25 coyote kernel: usb_needs_explore: Oct 4 15:41:25 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:25 coyote kernel: uhub_explore: udev=3D0xfffff800047e4000 addr= =3D1 Oct 4 15:41:25 coyote kernel: usb_bus_powerd: bus=3D0xfffffe0000b54cd8 Oct 4 15:41:25 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x07a0, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:25 coyote kernel: usb_bus_powerd: Recomputing power masks Oct 4 15:41:25 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:25 coyote kernel: uhub_explore: udev=3D0xfffff800047e6000 addr= =3D1 Oct 4 15:41:25 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x07a0, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:25 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x07a0, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:25 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0503, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:25 coyote kernel: uhub_explore: udev=3D0xfffff800048b0000 addr= =3D2 Oct 4 15:41:25 coyote kernel: uhub_read_port_status: port 4, wPortStatus=3D0x01e1, wPortChange=3D0x0001, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:25 coyote kernel: usbd_transfer_power_ref: Adding type 0 to power state Oct 4 15:41:25 coyote kernel: uhub_reattach_port: reattaching port 4 Oct 4 15:41:25 coyote kernel: usbd_transfer_power_ref: needs power Oct 4 15:41:25 coyote kernel: uhub_read_port_status: port 4, wPortStatus=3D0x01e1, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:25 coyote kernel: uhub_reattach_port: Port 4 is in Host Mode Oct 4 15:41:25 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:25 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:25 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:26 coyote kernel: uhub_read_port_status: port 4, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:26 coyote kernel: usb_needs_explore: Oct 4 15:41:26 coyote kernel: uhub_read_port_status: port 5, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:26 coyote kernel: uhub_read_port_status: port 6, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:26 coyote kernel: uhub_read_port_status: port 7, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:26 coyote kernel: usb_needs_explore: Oct 4 15:41:26 coyote kernel: uhub_read_port_status: port 4, wPortStatus=3D0x0103, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:26 coyote kernel: uhub_read_port_status: port 8, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:26 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:26 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:26 coyote kernel: usb_needs_explore: Oct 4 15:41:26 coyote kernel: usbd_transfer_power_ref: Adding type 0 to power state Oct 4 15:41:26 coyote kernel: usb_bus_powerd: bus=3D0xfffffe0000ad0cd8 Oct 4 15:41:27 coyote kernel: usbd_transfer_power_ref: needs power Oct 4 15:41:27 coyote kernel: uhub_explore: udev=3D0xfffff800047e5000 addr= =3D1 Oct 4 15:41:27 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0503, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:27 coyote kernel: uhub_explore: udev=3D0xfffff800048a9000 addr= =3D2 Oct 4 15:41:27 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:27 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:27 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0103, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:27 coyote kernel: uhub_read_port_status: port 4, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:27 coyote kernel: uhub_read_port_status: port 5, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:27 coyote kernel: uhub_read_port_status: port 6, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:28 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:28 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:28 coyote kernel: usb_needs_explore: Oct 4 15:41:28 coyote kernel: usb_bus_powerd: bus=3D0xfffffe0000b54cd8 Oct 4 15:41:28 coyote kernel: usb_bus_powerd: Recomputing power masks Oct 4 15:41:28 coyote kernel: uhub_explore: udev=3D0xfffff800047e6000 addr= =3D1 Oct 4 15:41:28 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0503, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:28 coyote kernel: uhub_explore: udev=3D0xfffff800048b0000 addr= =3D2 Oct 4 15:41:28 coyote kernel: usbd_transfer_power_ref: Adding type 0 to power state Oct 4 15:41:28 coyote kernel: usbd_transfer_power_ref: needs power Oct 4 15:41:28 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:28 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:29 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:29 coyote kernel: uhub_read_port_status: port 4, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:29 coyote kernel: uhub_read_port_status: port 5, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:29 coyote kernel: uhub_read_port_status: port 6, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:29 coyote kernel: uhub_read_port_status: port 7, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:29 coyote kernel: uhub_read_port_status: port 8, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:29 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:29 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:30 coyote kernel: usbd_setup_device_desc: getting device descriptor at addr 3 failed, USB_ERR_TIMEOUT Oct 4 15:41:30 coyote kernel: usb_needs_explore: Oct 4 15:41:30 coyote last message repeated 2 times Oct 4 15:41:30 coyote kernel: usb_bus_powerd: bus=3D0xfffffe0000ad0cd8 Oct 4 15:41:30 coyote kernel: uhub_explore: udev=3D0xfffff800047e5000 addr= =3D1 Oct 4 15:41:31 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0503, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:31 coyote kernel: uhub_explore: udev=3D0xfffff800048a9000 addr= =3D2 Oct 4 15:41:31 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:31 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:31 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0103, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:31 coyote kernel: uhub_read_port_status: port 4, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:31 coyote kernel: usbd_req_re_enumerate: addr=3D3, set address failed! (USB_ERR_TIMEOUT, ignored) Oct 4 15:41:31 coyote kernel: uhub_read_port_status: port 5, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:31 coyote kernel: uhub_read_port_status: port 6, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:31 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:31 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0500, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:32 coyote kernel: usbd_setup_device_desc: getting device descriptor at addr 3 failed, USB_ERR_TIMEOUT Oct 4 15:41:32 coyote kernel: usb_needs_explore: Oct 4 15:41:32 coyote kernel: usb_bus_powerd: bus=3D0xfffffe0000b54cd8 Oct 4 15:41:32 coyote kernel: usb_bus_powerd: Recomputing power masks Oct 4 15:41:32 coyote kernel: uhub_explore: udev=3D0xfffff800047e6000 addr= =3D1 Oct 4 15:41:32 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0503, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:32 coyote kernel: uhub_explore: udev=3D0xfffff800048b0000 addr= =3D2 Oct 4 15:41:32 coyote kernel: usbd_transfer_power_ref: Adding type 0 to power state Oct 4 15:41:32 coyote kernel: usbd_transfer_power_ref: needs power Oct 4 15:41:32 coyote kernel: uhub_read_port_status: port 1, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:32 coyote kernel: uhub_read_port_status: port 2, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:33 coyote kernel: usb_needs_explore: Oct 4 15:41:33 coyote kernel: uhub_read_port_status: port 3, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:33 coyote kernel: uhub_read_port_status: port 4, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:33 coyote kernel: uhub_read_port_status: port 5, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:33 coyote kernel: uhub_read_port_status: port 6, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:33 coyote kernel: uhub_read_port_status: port 7, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:33 coyote kernel: uhub_read_port_status: port 8, wPortStatus=3D0x0100, wPortChange=3D0x0000, err=3DUSB_ERR_NORMAL_COMPLETION Oct 4 15:41:34 coyote kernel: usbd_req_re_enumerate: addr=3D3, set address failed! (USB_ERR_TIMEOUT, ignored) Oct 4 15:41:35 coyote kernel: usbd_setup_device_desc: getting device descriptor at addr 3 failed, USB_ERR_TIMEOUT Oct 4 15:41:36 coyote kernel: usbd_req_re_enumerate: addr=3D3, set address failed! (USB_ERR_TIMEOUT, ignored) Oct 4 15:41:36 coyote kernel: usbd_setup_device_desc: getting device descriptor at addr 3 failed, USB_ERR_TIMEOUT Oct 4 15:41:38 coyote kernel: usbd_req_re_enumerate: addr=3D3, set address failed! (USB_ERR_TIMEOUT, ignored) Oct 4 15:41:39 coyote kernel: ugen0.2: at usbus0 (disconnected) Oct 4 15:41:39 coyote kernel: uhub_reattach_port: could not allocate new d= evice