strange errors when removing a second USB keyboard

From: Gary Jennejohn <garyj_at_gmx.de>
Date: Thu, 10 Nov 2022 14:36:47 UTC
This is a weird USB error.

Sorry for all this trace, but I wanted to include all the relevant errors.

Nov 10 14:54:54 ernst kernel: umass0: at uhub1, port 9, addr 4 (disconnected)
Nov 10 14:54:54 ernst kernel: da0 at umass-sim0 bus 0 scbus6 target 0 lun 0
Nov 10 14:54:54 ernst kernel: da0: < USB DISK 2.0 PMAP>  s/n 078211AD0C98 detached
Nov 10 14:54:54 ernst kernel: (da0:umass-sim0:0:0:0): Periph destroyed
Nov 10 14:54:54 ernst kernel: umass0: detached

I had a USB2 thumb drive plugged into a USB2 port which I removed because..

Nov 10 14:55:02 ernst kernel: ugen0.5: <vendor 0x1241 USB Keyboard> at usbus0
Nov 10 14:55:02 ernst kernel: ukbd1 on uhub1
Nov 10 14:55:02 ernst kernel: ukbd1: <vendor 0x1241 USB Keyboard, class 0/0, rev 1.10/2.90, addr 5> on usbus0
Nov 10 14:55:02 ernst kernel: kbd3 at ukbd1
Nov 10 14:55:02 ernst kernel: uhid0 on uhub1
Nov 10 14:55:02 ernst kernel: uhid0: <vendor 0x1241 USB Keyboard, class 0/0, rev 1.10/2.90, addr 5> on usbus0
Nov 10 14:55:10 ernst kernel: ugen0.5: <vendor 0x1241 USB Keyboard> at usbus0 (disconnected)

I wanted to check whether this keyboard was recognized, after which I
unplugged it.

Nov 10 14:55:10 ernst kernel: ukbd1: at uhub1, port 9, addr 5 (disconnected)
Nov 10 14:55:10 ernst kernel: ukbd1: detached
Nov 10 14:55:10 ernst kernel: uhid0: at uhub1, port 9, addr 5 (disconnected)
Nov 10 14:55:10 ernst kernel: uhid0: detached
Nov 10 14:55:11 ernst kernel: xhci0: Resetting controller
Nov 10 14:55:11 ernst kernel: usb_alloc_device: set address 5 failed (USB_ERR_TIMEOUT, ignored)
Nov 10 14:55:21 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 5 failed, USB_ERR_TIMEOUT
Nov 10 14:55:21 ernst kernel: usbd_req_re_enumerate: addr=5, set address failed! (USB_ERR_IOERROR, ignored)
Nov 10 14:55:31 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 5 failed, USB_ERR_TIMEOUT
Nov 10 14:55:31 ernst kernel: usbd_req_re_enumerate: addr=5, set address failed! (USB_ERR_IOERROR, ignored)
Nov 10 14:55:41 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 5 failed, USB_ERR_TIMEOUT
Nov 10 14:55:41 ernst kernel: usbd_req_re_enumerate: addr=5, set address failed! (USB_ERR_IOERROR, ignored)
Nov 10 14:55:50 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 5 failed, USB_ERR_TIMEOUT
Nov 10 14:55:51 ernst kernel: usbd_req_re_enumerate: addr=5, set address failed! (USB_ERR_IOERROR, ignored)
Nov 10 14:56:01 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 5 failed, USB_ERR_TIMEOUT
Nov 10 14:56:01 ernst kernel: ugen0.5: <Unknown > at usbus0 (disconnected)
Nov 10 14:56:01 ernst kernel: uhub_reattach_port: could not allocate new device
Nov 10 14:56:04 ernst kernel: uhub1: at usbus0, port 1, addr 1 (disconnected)
Nov 10 14:56:04 ernst kernel: ugen0.2: <Chicony Generic USB Hub> at usbus0 (disconnected)
Nov 10 14:56:04 ernst kernel: uhub4: at uhub1, port 10, addr 1 (disconnected)
Nov 10 14:56:04 ernst kernel: ugen0.3: <Chicony PFU-65 USB Keyboard> at usbus0 (disconnected)
Nov 10 14:56:04 ernst kernel: ukbd0: at uhub4, port 1, addr 2 (disconnected)
Nov 10 14:56:04 ernst kernel: ukbd0: detached
Nov 10 14:56:04 ernst kernel: ugen0.4: <Logitech Trackball> at usbus0 (disconnected)
Nov 10 14:56:04 ernst kernel: ums0: at uhub4, port 2, addr 3 (disconnected)
Nov 10 14:56:04 ernst kernel: ums0: detached

The result was these strange errors which led to me losing the keyboaard
and the mouse, which was plugged into its hub!  The keyboard was plugged
into a USB2 port to the right of the port where I'd plugged in the other
keyboard.

Nov 10 14:56:04 ernst kernel: uhub4: detached
Nov 10 14:56:04 ernst kernel: uhub1: detached
Nov 10 14:56:04 ernst kernel: uhub1 on usbus0
Nov 10 14:56:04 ernst kernel: uhub1: <AMD XHCI root HUB, class 9/0, rev 3.00/1.00, addr 1> on usbus0
Nov 10 14:56:05 ernst kernel: uhub1: 22 ports with 22 removable, self powered
Nov 10 14:56:06 ernst kernel: xhci0: Resetting controller
Nov 10 14:56:06 ernst kernel: usb_alloc_device: set address 2 failed (USB_ERR_TIMEOUT, ignored)
Nov 10 14:56:22 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 14:56:23 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_TIMEOUT, ignored)
Nov 10 14:56:40 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 14:56:41 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_TIMEOUT, ignored)
Nov 10 14:56:58 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 14:56:59 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_TIMEOUT, ignored)
Nov 10 14:57:16 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 14:57:17 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_TIMEOUT, ignored)
Nov 10 14:57:34 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 14:57:34 ernst kernel: ugen0.2: <Unknown > at usbus0 (disconnected)
Nov 10 14:57:34 ernst kernel: uhub_reattach_port: could not allocate new device
Nov 10 14:57:34 ernst kernel: uhub1: at usbus0, port 1, addr 1 (disconnected)
Nov 10 14:57:34 ernst kernel: uhub1: detached
Nov 10 14:57:34 ernst kernel: uhub1 on usbus0
Nov 10 14:57:34 ernst kernel: uhub1: <AMD XHCI root HUB, class 9/0, rev 3.00/1.00, addr 1> on usbus0
Nov 10 14:57:37 ernst kernel: uhub1: 22 ports with 22 removable, self powered
Nov 10 14:57:37 ernst kernel: xhci0: Resetting controller
Nov 10 14:57:37 ernst kernel: usb_alloc_device: set address 2 failed (USB_ERR_TIMEOUT, ignored)
Nov 10 14:57:53 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 14:57:54 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_TIMEOUT, ignored)
Nov 10 14:58:10 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 14:58:12 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_TIMEOUT, ignored)
Nov 10 14:58:28 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 14:58:29 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_TIMEOUT, ignored)
Nov 10 14:58:46 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 14:58:48 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_TIMEOUT, ignored)
Nov 10 14:59:04 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 14:59:04 ernst kernel: ugen0.2: <Unknown > at usbus0 (disconnected)
Nov 10 14:59:04 ernst kernel: uhub_reattach_port: could not allocate new device
Nov 10 14:59:04 ernst kernel: uhub1: at usbus0, port 1, addr 1 (disconnected)
Nov 10 14:59:04 ernst kernel: uhub1: detached
Nov 10 14:59:04 ernst kernel: uhub1 on usbus0
Nov 10 14:59:04 ernst kernel: uhub1: <AMD XHCI root HUB, class 9/0, rev 3.00/1.00, addr 1> on usbus0
Nov 10 14:59:07 ernst kernel: uhub1: 22 ports with 22 removable, self powered
Nov 10 14:59:07 ernst kernel: xhci0: Resetting controller
Nov 10 14:59:07 ernst kernel: usb_alloc_device: set address 2 failed (USB_ERR_TIMEOUT, ignored)
Nov 10 14:59:23 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 14:59:24 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_TIMEOUT, ignored)
Nov 10 14:59:40 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 14:59:42 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_TIMEOUT, ignored)
Nov 10 14:59:59 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 15:00:00 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_TIMEOUT, ignored)
Nov 10 15:00:16 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 15:00:18 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_TIMEOUT, ignored)
Nov 10 15:00:35 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 15:00:35 ernst kernel: ugen0.2: <Unknown > at usbus0 (disconnected)
Nov 10 15:00:35 ernst kernel: uhub_reattach_port: could not allocate new device
Nov 10 15:00:35 ernst kernel: uhub1: at usbus0, port 1, addr 1 (disconnected)
Nov 10 15:00:35 ernst kernel: uhub1: detached
Nov 10 15:00:35 ernst kernel: uhub1 on usbus0
Nov 10 15:00:35 ernst kernel: uhub1: <AMD XHCI root HUB, class 9/0, rev 3.00/1.00, addr 1> on usbus0
Nov 10 15:00:37 ernst kernel: uhub1: 22 ports with 22 removable, self powered
Nov 10 15:00:37 ernst kernel: xhci0: Resetting controller
Nov 10 15:00:37 ernst kernel: usb_alloc_device: set address 2 failed (USB_ERR_TIMEOUT, ignored)
Nov 10 15:00:53 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 15:00:54 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_TIMEOUT, ignored)
Nov 10 15:01:11 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 15:01:12 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_TIMEOUT, ignored)
Nov 10 15:01:29 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 15:01:30 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_TIMEOUT, ignored)
Nov 10 15:01:47 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 15:01:48 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_TIMEOUT, ignored)
Nov 10 15:02:03 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_IOERROR
Nov 10 15:02:03 ernst kernel: ugen0.2: <Unknown > at usbus0 (disconnected)
Nov 10 15:02:03 ernst kernel: uhub_reattach_port: could not allocate new device
Nov 10 15:02:03 ernst kernel: uhub1: at usbus0, port 1, addr 1 (disconnected)
Nov 10 15:02:03 ernst kernel: uhub1: detached
Nov 10 15:02:03 ernst kernel: uhub1 on usbus0
Nov 10 15:02:03 ernst kernel: uhub1: <AMD XHCI root HUB, class 9/0, rev 3.00/1.00, addr 1> on usbus0
Nov 10 15:02:05 ernst kernel: uhub1: 22 ports with 22 removable, self powered
Nov 10 15:02:08 ernst kernel: xhci0: Resetting controller
Nov 10 15:02:08 ernst kernel: usb_alloc_device: set address 2 failed (USB_ERR_TIMEOUT, ignored)
Nov 10 15:02:17 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_IOERROR
Nov 10 15:02:17 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_IOERROR, ignored)
Nov 10 15:02:20 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_IOERROR
Nov 10 15:02:21 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_IOERROR, ignored)
Nov 10 15:02:23 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_IOERROR
Nov 10 15:02:23 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_IOERROR, ignored)
Nov 10 15:02:26 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_IOERROR
Nov 10 15:02:27 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_IOERROR, ignored)
Nov 10 15:02:29 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_IOERROR
Nov 10 15:02:29 ernst kernel: ugen0.2: <Unknown > at usbus0 (disconnected)
Nov 10 15:02:29 ernst kernel: uhub_reattach_port: could not allocate new device
Nov 10 15:02:29 ernst kernel: uhub1: at usbus0, port 1, addr 1 (disconnected)
Nov 10 15:02:29 ernst kernel: uhub1: detached
Nov 10 15:02:29 ernst kernel: uhub1 on usbus0
Nov 10 15:02:29 ernst kernel: uhub1: <AMD XHCI root HUB, class 9/0, rev 3.00/1.00, addr 1> on usbus0
Nov 10 15:02:32 ernst kernel: uhub1: 22 ports with 22 removable, self powered
Nov 10 15:02:32 ernst kernel: xhci0: Resetting controller
Nov 10 15:02:32 ernst kernel: usb_alloc_device: set address 2 failed (USB_ERR_TIMEOUT, ignored)
Nov 10 15:02:48 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_TIMEOUT
Nov 10 15:02:49 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_TIMEOUT, ignored)
Nov 10 15:02:57 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_IOERROR
Nov 10 15:02:57 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_IOERROR, ignored)
Nov 10 15:03:00 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_IOERROR
Nov 10 15:03:00 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_IOERROR, ignored)
Nov 10 15:03:03 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_IOERROR
Nov 10 15:03:03 ernst kernel: usbd_req_re_enumerate: addr=2, set address failed! (USB_ERR_IOERROR, ignored)
Nov 10 15:03:06 ernst kernel: usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_IOERROR
Nov 10 15:03:06 ernst kernel: ugen0.2: <Unknown > at usbus0 (disconnected)
Nov 10 15:03:06 ernst kernel: uhub_reattach_port: could not allocate new device
Nov 10 15:03:06 ernst kernel: uhub1: at usbus0, port 1, addr 1 (disconnected)
Nov 10 15:03:06 ernst kernel: uhub1: detached
Nov 10 15:03:06 ernst kernel: uhub1 on usbus0
Nov 10 15:03:06 ernst kernel: uhub1: <AMD XHCI root HUB, class 9/0, rev 3.00/1.00, addr 1> on usbus0
Nov 10 15:03:08 ernst kernel: uhub1: 22 ports with 22 removable, self powered

It looks like the removal of the second keyboard was not handled correctly.

Nov 10 15:03:08 ernst kernel: ugen2.5: <Chicony Generic USB Hub> at usbus2
Nov 10 15:03:08 ernst kernel: uhub4 on uhub3
Nov 10 15:03:08 ernst kernel: uhub4: <Chicony Generic USB Hub, class 9/0, rev 1.10/1.02, addr 4> on usbus2
Nov 10 15:03:09 ernst kernel: uhub4: 3 ports with 2 removable, bus powered
Nov 10 15:03:09 ernst kernel: ugen2.6: <Chicony PFU-65 USB Keyboard> at usbus2
Nov 10 15:03:09 ernst kernel: ukbd0 on uhub4
Nov 10 15:03:09 ernst kernel: ukbd0: <Chicony PFU-65 USB Keyboard, class 0/0, rev 1.10/1.02, addr 5> on usbus2
Nov 10 15:03:09 ernst kernel: kbd2 at ukbd0
Nov 10 15:03:10 ernst kernel: ugen2.7: <Logitech Trackball> at usbus2
Nov 10 15:03:10 ernst kernel: ums0 on uhub4
Nov 10 15:03:10 ernst kernel: ums0: <Logitech Trackball, class 0/0, rev 1.10/2.20, addr 6> on usbus2
Nov 10 15:03:10 ernst kernel: ums0: 3 buttons and [XYZ] coordinates ID=0

I only got the keyboard and mouse back after plugging the keyboard into
a USB3 hub.

Interestingly, I could then plug a USB thumb drive into one of the
USB2 ports and it was recognized, but trying to plug the keyboard into
the adjacent USB2 port resulted in lots of errors and I had to plug it
back into the USB3 hub.

So, it almost appears that having two USB keyboards plugged into USB2
ports, and then removiing one,  resulted in the errors.

--
Gary Jennejohn