[arch-general] Network UPS Tools (AUR) using usbhid

[David C. Rankin]

Archdevs,

Have there been any changes to startup that would impact the Network UPS Tools
startup using the usbhid device?

I ask because the nut-server.service that has worked for years, is now failing
to come up in the normal boot process.

$ upsc phoinix_ups
Error: Driver not connected

However restarting the service after the system is up and running everything
works fine. So it's like there is a new depends for the usbhid driver startup
that means it has to wait until something else is now started before it can
initialize properly.

Any idea what could be causing that or what nut-server.service needs to wait
on before it tries to start?

After kernel update, the failed log messages are:

-- Reboot --
Jan 13 11:06:31 phoinix systemd[1]: Starting Network UPS Tools - power devices
information server...
Jan 13 11:06:32 phoinix upsd[541]: fopen /var/state/ups/upsd.pid: No such file
or directory
Jan 13 11:06:32 phoinix upsd[541]: /etc/ups/upsd.conf is world readable
Jan 13 11:06:32 phoinix upsd[541]: /etc/ups/upsd.conf is world readable
Jan 13 11:06:32 phoinix upsd[541]: listening on 127.0.0.1 port 3493
Jan 13 11:06:32 phoinix upsd[541]: listening on ::1 port 3493
Jan 13 11:06:32 phoinix upsd[541]: listening on 127.0.0.1 port 3493
Jan 13 11:06:32 phoinix upsd[541]: listening on ::1 port 3493
Jan 13 11:06:32 phoinix upsd[541]: Can't connect to UPS [phoinix_ups]
(usbhid-ups-phoinix_ups): No such file or directory
Jan 13 11:06:32 phoinix upsd[541]: Can't connect to UPS [phoinix_ups]
(usbhid-ups-phoinix_ups): No such file or directory
Jan 13 11:06:32 phoinix upsd[561]: Startup successful
Jan 13 11:06:32 phoinix systemd[1]: Started Network UPS Tools - power devices
information server.
Jan 13 11:11:32 phoinix upsd[561]: Can't connect to UPS [phoinix_ups]
(usbhid-ups-phoinix_ups): No such file or directory

Then the restart works fine:

Jan 13 11:19:20 phoinix systemd[1]: Stopped Network UPS Tools - power devices
information server.
Jan 13 11:19:20 phoinix systemd[1]: Starting Network UPS Tools - power devices
information server...
Jan 13 11:19:20 phoinix upsd[823]: fopen /var/state/ups/upsd.pid: No such file
or directory
Jan 13 11:19:20 phoinix upsd[823]: /etc/ups/upsd.conf is world readable
Jan 13 11:19:20 phoinix upsd[823]: /etc/ups/upsd.conf is world readable
Jan 13 11:19:20 phoinix upsd[823]: listening on 127.0.0.1 port 3493
Jan 13 11:19:20 phoinix upsd[823]: listening on 127.0.0.1 port 3493
Jan 13 11:19:20 phoinix upsd[823]: listening on ::1 port 3493
Jan 13 11:19:20 phoinix upsd[823]: listening on ::1 port 3493
Jan 13 11:19:20 phoinix upsd[823]: Connected to UPS [phoinix_ups]:
usbhid-ups-phoinix_ups
Jan 13 11:19:20 phoinix upsd[823]: Connected to UPS [phoinix_ups]:
usbhid-ups-phoinix_ups
Jan 13 11:19:20 phoinix upsd[824]: Startup successful
Jan 13 11:19:20 phoinix systemd[1]: Started Network UPS Tools - power devices
information server.

Any ideas what to check? This just started within the last month or two.

-- 
David C. Rankin, J.D.,P.E.