Arch Linux

jmartl109

Member

Registered: 2011-03-17

Posts: 25

Boot delay related to ordering of /dev/input/eventX

About half the times I boot, I get a roughly 30 second delay before grub displays anything (I never see any error messages related to this), and a 10-40 second delay before I can type my username / pw into the console login prompt. This is on a macbook pro 11,1, and the internal keyboard and trackpad is treated as a usb device. I used to think this just happened on the next boot after having to do a hard reset, but it also seems to happen sometimes when the shutdown process went fine. Here are the most relevant messages in journalctl when this happens (let me know if it would help to have the full log):

Dec 15 13:30:36 hostname kernel: xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
Dec 15 13:30:36 hostname kernel: usb 1-5: new full-speed USB device number 3 using xhci_hcd
Dec 15 13:30:41 hostname kernel: xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
Dec 15 13:30:41 hostname kernel: usb 2-3: device not accepting address 2, error -62
Dec 15 13:30:42 hostname kernel: input: Apple Inc. Apple Internal Keyboard / Trackpad as /devices/pci0000:00/0000:00:14.0/usb1/1-5/1-5:1.0/0003:05AC:0259.0001/input/input13
Dec 15 13:30:42 hostname kernel: input: HID 05ac:820a as /devices/pci0000:00/0000:00:14.0/usb1/1-3/1-3.1/1-3.1:1.0/0003:05AC:820A.0003/input/input14
Dec 15 13:30:42 hostname kernel: apple 0003:05AC:0259.0001: input,hidraw0: USB HID v1.11 Keyboard [Apple Inc. Apple Internal Keyboard / Trackpad] on usb-0000:00:14.0-5/input0
Dec 15 13:30:42 hostname kernel: apple 0003:05AC:0259.0002: hidraw1: USB HID v1.11 Device [Apple Inc. Apple Internal Keyboard / Trackpad] on usb-0000:00:14.0-5/input1
Dec 15 13:30:42 hostname systemd-udevd[208]: Unable to EVIOCGABS device "/dev/input/event13"
Dec 15 13:30:42 hostname systemd-udevd[208]: Unable to EVIOCGABS device "/dev/input/event13"
Dec 15 13:30:42 hostname systemd-udevd[208]: Unable to EVIOCGABS device "/dev/input/event13"
Dec 15 13:30:42 hostname systemd-udevd[208]: Unable to EVIOCGABS device "/dev/input/event13"
Dec 15 13:30:42 hostname kernel: hid-generic 0003:05AC:820A.0003: input,hidraw2: USB HID v1.11 Keyboard [HID 05ac:820a] on usb-0000:00:14.0-3.1/input0
Dec 15 13:30:42 hostname kernel: input: HID 05ac:820b as /devices/pci0000:00/0000:00:14.0/usb1/1-3/1-3.2/1-3.2:1.0/0003:05AC:820B.0004/input/input15
Dec 15 13:30:42 hostname kernel: hid-generic 0003:05AC:820B.0004: input,hidraw3: USB HID v1.11 Mouse [HID 05ac:820b] on usb-0000:00:14.0-3.2/input0
Dec 15 13:30:42 hostname kernel: usb 1-3.1: USB disconnect, device number 4
Dec 15 13:30:42 hostname kernel: usb 1-3.2: USB disconnect, device number 5

Shortly thereafter, I'm able to type.

Actually, I get the EVIOCGABS messages even when things are working properly, but I noticed that when there's no delay, the message refers to /dev/input/event5, and when there is a delay, the message refers to /dev/input/event13 (as above). Here is the contents of /proc/bus/input/devices when the delay happens:

I: Bus=0019 Vendor=0000 Product=0005 Version=0000
N: Name="Lid Switch"
P: Phys=PNP0C0D/button/input0
S: Sysfs=/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0D:00/input/input0
U: Uniq=
H: Handlers=event0 
B: PROP=0
B: EV=21
B: SW=1

I: Bus=0019 Vendor=0000 Product=0001 Version=0000
N: Name="Power Button"
P: Phys=PNP0C0C/button/input0
S: Sysfs=/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input1
U: Uniq=
H: Handlers=kbd event1 
B: PROP=0
B: EV=3
B: KEY=10000000000000 0

I: Bus=0019 Vendor=0000 Product=0003 Version=0000
N: Name="Sleep Button"
P: Phys=PNP0C0E/button/input0
S: Sysfs=/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input2
U: Uniq=
H: Handlers=kbd event2 
B: PROP=0
B: EV=3
B: KEY=4000 0 0

I: Bus=0019 Vendor=0000 Product=0001 Version=0000
N: Name="Power Button"
P: Phys=LNXPWRBN/button/input0
S: Sysfs=/devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
U: Uniq=
H: Handlers=kbd event3 
B: PROP=0
B: EV=3
B: KEY=10000000000000 0

I: Bus=0019 Vendor=0000 Product=0006 Version=0000
N: Name="Video Bus"
P: Phys=LNXVIDEO/video/input0
S: Sysfs=/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input4
U: Uniq=
H: Handlers=kbd event4 
B: PROP=0
B: EV=3
B: KEY=3e000b00000000 0 0 0

I: Bus=0010 Vendor=001f Product=0001 Version=0100
N: Name="PC Speaker"
P: Phys=isa0061/input0
S: Sysfs=/devices/platform/pcspkr/input/input5
U: Uniq=
H: Handlers=kbd event5 
B: PROP=0
B: EV=40001
B: SND=6

I: Bus=0000 Vendor=0000 Product=0000 Version=0000
N: Name="HDA Intel HDMI HDMI/DP,pcm=3"
P: Phys=ALSA
S: Sysfs=/devices/pci0000:00/0000:00:03.0/sound/card1/input6
U: Uniq=
H: Handlers=event6 
B: PROP=0
B: EV=21
B: SW=140

I: Bus=0000 Vendor=0000 Product=0000 Version=0000
N: Name="HDA Intel HDMI HDMI/DP,pcm=7"
P: Phys=ALSA
S: Sysfs=/devices/pci0000:00/0000:00:03.0/sound/card1/input7
U: Uniq=
H: Handlers=event7 
B: PROP=0
B: EV=21
B: SW=140

I: Bus=0000 Vendor=0000 Product=0000 Version=0000
N: Name="HDA Intel HDMI HDMI/DP,pcm=8"
P: Phys=ALSA
S: Sysfs=/devices/pci0000:00/0000:00:03.0/sound/card1/input8
U: Uniq=
H: Handlers=event8 
B: PROP=0
B: EV=21
B: SW=140

I: Bus=0000 Vendor=0000 Product=0000 Version=0000
N: Name="HDA Intel PCH Mic"
P: Phys=ALSA
S: Sysfs=/devices/pci0000:00/0000:00:1b.0/sound/card0/input9
U: Uniq=
H: Handlers=event9 
B: PROP=0
B: EV=21
B: SW=10

I: Bus=0000 Vendor=0000 Product=0000 Version=0000
N: Name="HDA Intel PCH Headphone"
P: Phys=ALSA
S: Sysfs=/devices/pci0000:00/0000:00:1b.0/sound/card0/input10
U: Uniq=
H: Handlers=event10 
B: PROP=0
B: EV=21
B: SW=4

I: Bus=0000 Vendor=0000 Product=0000 Version=0000
N: Name="HDA Intel PCH SPDIF"
P: Phys=ALSA
S: Sysfs=/devices/pci0000:00/0000:00:1b.0/sound/card0/input11
U: Uniq=
H: Handlers=event11 
B: PROP=0
B: EV=21
B: SW=140

I: Bus=0003 Vendor=05ac Product=0259 Version=0001
N: Name="bcm5974"
P: Phys=usb-0000:00:14.0-5/input0
S: Sysfs=/devices/pci0000:00/0000:00:14.0/usb1/1-5/1-5:1.2/input/input12
U: Uniq=
H: Handlers=event12 mouse0 
B: PROP=5
B: EV=b
B: KEY=e520 10000 0 0 0 0
B: ABS=27f800011000003

I: Bus=0003 Vendor=05ac Product=0259 Version=0111
N: Name="Apple Inc. Apple Internal Keyboard / Trackpad"
P: Phys=usb-0000:00:14.0-5/input0
S: Sysfs=/devices/pci0000:00/0000:00:14.0/usb1/1-5/1-5:1.0/0003:05AC:0259.0001/input/input13
U: Uniq=
H: Handlers=sysrq kbd event13 
B: PROP=0
B: EV=120013
B: KEY=10000 0 0 0 1007b00011007 ff9f217ac14057ff ffbeffdfffefffff 7ffffffffffffffe
B: MSC=10
B: LED=1f

and when it doesn't:

I: Bus=0019 Vendor=0000 Product=0005 Version=0000
N: Name="Lid Switch"
P: Phys=PNP0C0D/button/input0
S: Sysfs=/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0D:00/input/input0
U: Uniq=
H: Handlers=event0 
B: PROP=0
B: EV=21
B: SW=1

I: Bus=0019 Vendor=0000 Product=0001 Version=0000
N: Name="Power Button"
P: Phys=PNP0C0C/button/input0
S: Sysfs=/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input1
U: Uniq=
H: Handlers=kbd event1 
B: PROP=0
B: EV=3
B: KEY=10000000000000 0

I: Bus=0019 Vendor=0000 Product=0003 Version=0000
N: Name="Sleep Button"
P: Phys=PNP0C0E/button/input0
S: Sysfs=/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input2
U: Uniq=
H: Handlers=kbd event2 
B: PROP=0
B: EV=3
B: KEY=4000 0 0

I: Bus=0019 Vendor=0000 Product=0001 Version=0000
N: Name="Power Button"
P: Phys=LNXPWRBN/button/input0
S: Sysfs=/devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
U: Uniq=
H: Handlers=kbd event3 
B: PROP=0
B: EV=3
B: KEY=10000000000000 0

I: Bus=0019 Vendor=0000 Product=0006 Version=0000
N: Name="Video Bus"
P: Phys=LNXVIDEO/video/input0
S: Sysfs=/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input4
U: Uniq=
H: Handlers=kbd event4 
B: PROP=0
B: EV=3
B: KEY=3e000b00000000 0 0 0

I: Bus=0010 Vendor=001f Product=0001 Version=0100
N: Name="PC Speaker"
P: Phys=isa0061/input0
S: Sysfs=/devices/platform/pcspkr/input/input6
U: Uniq=
H: Handlers=kbd event6 
B: PROP=0
B: EV=40001
B: SND=6

I: Bus=0000 Vendor=0000 Product=0000 Version=0000
N: Name="HDA Intel HDMI HDMI/DP,pcm=3"
P: Phys=ALSA
S: Sysfs=/devices/pci0000:00/0000:00:03.0/sound/card1/input7
U: Uniq=
H: Handlers=event7 
B: PROP=0
B: EV=21
B: SW=140

I: Bus=0000 Vendor=0000 Product=0000 Version=0000
N: Name="HDA Intel HDMI HDMI/DP,pcm=7"
P: Phys=ALSA
S: Sysfs=/devices/pci0000:00/0000:00:03.0/sound/card1/input8
U: Uniq=
H: Handlers=event8 
B: PROP=0
B: EV=21
B: SW=140

I: Bus=0000 Vendor=0000 Product=0000 Version=0000
N: Name="HDA Intel HDMI HDMI/DP,pcm=8"
P: Phys=ALSA
S: Sysfs=/devices/pci0000:00/0000:00:03.0/sound/card1/input9
U: Uniq=
H: Handlers=event9 
B: PROP=0
B: EV=21
B: SW=140

I: Bus=0000 Vendor=0000 Product=0000 Version=0000
N: Name="HDA Intel PCH Mic"
P: Phys=ALSA
S: Sysfs=/devices/pci0000:00/0000:00:1b.0/sound/card0/input10
U: Uniq=
H: Handlers=event10 
B: PROP=0
B: EV=21
B: SW=10

I: Bus=0000 Vendor=0000 Product=0000 Version=0000
N: Name="HDA Intel PCH Headphone"
P: Phys=ALSA
S: Sysfs=/devices/pci0000:00/0000:00:1b.0/sound/card0/input11
U: Uniq=
H: Handlers=event11 
B: PROP=0
B: EV=21
B: SW=4

I: Bus=0000 Vendor=0000 Product=0000 Version=0000
N: Name="HDA Intel PCH SPDIF"
P: Phys=ALSA
S: Sysfs=/devices/pci0000:00/0000:00:1b.0/sound/card0/input12
U: Uniq=
H: Handlers=event12 
B: PROP=0
B: EV=21
B: SW=140

I: Bus=0003 Vendor=05ac Product=0259 Version=0111
N: Name="Apple Inc. Apple Internal Keyboard / Trackpad"
P: Phys=usb-0000:00:14.0-5/input0
S: Sysfs=/devices/pci0000:00/0000:00:14.0/usb1/1-5/1-5:1.0/0003:05AC:0259.0049/input/input83
U: Uniq=
H: Handlers=sysrq kbd event5 
B: PROP=0
B: EV=120013
B: KEY=10000 0 0 0 1007b00011007 ff9f217ac14057ff ffbeffdfffefffff 7ffffffffffffffe
B: MSC=10
B: LED=1f

I: Bus=0003 Vendor=05ac Product=0259 Version=0001
N: Name="bcm5974"
P: Phys=usb-0000:00:14.0-5/input0
S: Sysfs=/devices/pci0000:00/0000:00:14.0/usb1/1-5/1-5:1.2/input/input84
U: Uniq=
H: Handlers=event13 mouse0 
B: PROP=5
B: EV=b
B: KEY=e520 10000 0 0 0 0
B: ABS=27f800011000003

They're mostly the same, except in the "bad" version, my keyboard is listed as event13, and in the good version, it's listed as event5.

I don't know: (1) what might be causing this, (2) what things in userspace could possibly affect the loading of grub (I only touch /boot to install new kernels, and this doesn't seem related to that), (3) why grub loading has anything to do with usb, or (4) what things could be affected by /dev/input/eventX getting numbered "wrong".

Ideas on any of those questions woul be appreciated!

mich41

Member

Registered: 2012-06-22

Posts: 796

Re: Boot delay related to ordering of /dev/input/eventX

Are there firmware updates available for this thing?

jmartl109

Member

Registered: 2011-03-17

Posts: 25

Re: Boot delay related to ordering of /dev/input/eventX

Just did the firmware update, and it didn't help

Edit: Also, I tried resetting the SMC and PRAM, and that didn't help either. If I boot with Alt held down (i.e. to get into apple's bootloader), the delay happens before I get to the bootloader menu.

Last edited by jmartl109 (2015-12-20 03:49:57)

mich41

Member

Registered: 2012-06-22

Posts: 796

Re: Boot delay related to ordering of /dev/input/eventX

Looks like hardware or firmware failure. Maybe something related to whatever forces you to hard reboot?

Or are you rebooting for no reason and the machine retaliates?

jmartl109

Member

Registered: 2011-03-17

Posts: 25

Re: Boot delay related to ordering of /dev/input/eventX

The hard lockups are a separate issue -- they go away when I downgrade the kernel to 3.19 (this has been going on for a long time).

I tried adding `noefi` to my kernel parameters, and it at least had some effect; when there's a pre-grub delay, I don't get the pre-login delay, but I do get a delay every time I resume from suspend between the time the graphics wakes up and when I can type. (This was happening before, too.) In this case my keyboard is numbered /dev/input/event5 (which, originally, only happened when there was no delay).

I should also note that I'm dual booting with OS X. If I want to boot OS X, instead of hitting the power button and then waiting until I get to grub, I can boot with Alt held down, which opens apple's bootloader menu, at which point I can either choose to boot OS X or load grub. In this case, the pre-bootloader delay happens before apple's bootloader menu, but if I boot OS X I notice no keyboard-related delays, either before logging in or after suspend. I would consider this solved if I can get rid of the post-suspend delay, as that bothers me a lot more than the boot or login delays which (ideally!) should not happen that often.