[Nut-upsdev] newhidups (2.03-pre2) not working with APC Back-UPS

[Charlie Brady]

On Tue, 31 Jan 2006, Charlie Brady wrote:

> It looks as though upsd had stopping pinging the driver. Why would that 
> be?

And this is where the first sign of trouble was, in the early hours:

...
Jan 27 19:19:25 test7 nut: upsmon startup succeeded
Jan 27 19:19:25 test7 upsd[11840]: Client monuser at 127.0.0.1 logged into 
UPS [UPS]
Jan 27 19:19:37 test7 upsd[11840]: Connection from 127.0.0.1
Jan 27 19:19:37 test7 upsd[11840]: Client on 127.0.0.1 logged out
Jan 28 00:27:22 test7 kernel: usb 2-2: usbfs: USBDEVFS_CONTROL failed cmd 
newhidups rqt 161 rq 1 len 8 ret -32
Jan 28 00:56:28 test7 upsd[11840]: Data for UPS [UPS] is stale - check 
driver
Jan 28 00:56:31 test7 upsmon[11845]: Poll UPS [UPS at localhost] failed - 
Data stale
Jan 28 00:56:31 test7 upsmon[11845]: Communications with UPS UPS at localhost 
lost
Jan 28 00:56:31 test7 wall[19685]: wall: user nut broadcasted 1 lines (44 
chars)
Jan 28 00:56:36 test7 upsmon[11845]: Poll UPS [UPS at localhost] failed - 
Data stale
Jan 28 00:56:41 test7 upsmon[11845]: Poll UPS [UPS at localhost] failed - 
Data stale
Jan 28 00:56:44 test7 upsd[11840]: UPS [UPS] data is no longer stale
Jan 28 00:56:46 test7 upsmon[11845]: Communications with UPS UPS at localhost 
established
Jan 28 00:56:46 test7 wall[19718]: wall: user nut broadcasted 1 lines (51 
chars)
Jan 28 03:28:45 test7 kernel: usb 2-2: usbfs: USBDEVFS_CONTROL failed cmd 
newhidups rqt 161 rq 1 len 8 ret -32
Jan 28 03:54:56 test7 kernel: usb 2-2: usbfs: USBDEVFS_CONTROL failed cmd 
newhidups rqt 161 rq 1 len 8 ret -32
Jan 28 13:38:00 test7 kernel: usb 2-2: usbfs: USBDEVFS_CONTROL failed cmd 
newhidups rqt 161 rq 1 len 8 ret -32
Jan 28 19:47:01 test7 kernel: usb 2-2: usbfs: USBDEVFS_CONTROL failed cmd 
newhidups rqt 161 rq 1 len 8 ret -32
Jan 28 22:43:34 test7 kernel: usb 2-2: usbfs: USBDEVFS_CONTROL failed cmd 
newhidups rqt 161 rq 1 len 8 ret -32
Jan 29 09:23:43 test7 kernel: usb 2-2: usbfs: USBDEVFS_CONTROL failed cmd 
newhidups rqt 161 rq 1 len 8 ret -32
...

And here's another burst of problem reports:

...
Jan 31 01:38:13 test7 kernel: usb 2-2: usbfs: USBDEVFS_CONTROL failed cmd 
newhidups rqt 161 rq 1 len 8 ret -32
Jan 31 01:38:15 test7 kernel: ohci_hcd 0000:00:02.0: IRQ INTR_SF lossage
Jan 31 02:40:27 test7 upsd[11840]: Data for UPS [UPS] is stale - check 
driver
Jan 31 02:40:28 test7 upsmon[11845]: Poll UPS [UPS at localhost] failed - 
Data stale
Jan 31 02:40:28 test7 upsmon[11845]: Communications with UPS UPS at localhost 
lost
Jan 31 02:40:28 test7 wall[30480]: wall: user nut broadcasted 1 lines (44 
chars)
Jan 31 02:40:33 test7 upsmon[11845]: Poll UPS [UPS at localhost] failed - 
Data stale
Jan 31 02:40:35 test7 upsd[11840]: UPS [UPS] data is no longer stale
Jan 31 02:40:38 test7 upsmon[11845]: Communications with UPS UPS at localhost 
established
...

> What should I do to investigate if/when this happens again?

I'm still looking for pointers on this. Platform is CentOS 4.2 
(essentially RHEL4).

--
Charlie