UPS error message

[bent98]

I just realized my USB cable from my CyberPower 1500AVR was disconnected. I am running TRUENAS CORE 13U-6.1.

I am getting this error after hooking cable up and configuring the UPS services. I tried different drivers but it seems usbhid is he one for Cyberpower.

My config.

 

[bent98]

Updated. When I issue upsc ups I get this:

Code:

RESULT IN SYSTEM FAILURE.

root@freenas:~ # upsc -l
ups
root@freenas:~ # upsc ups
battery.charge: 100
battery.charge.low: 10
battery.charge.warning: 20
battery.mfr.date: CPS
battery.runtime: 3270
battery.runtime.low: 300
battery.type: PbAcid
battery.voltage: 13.9
battery.voltage.nominal: 12
device.mfr: CPS
device.model:  CP 1500C
device.type: ups
driver.name: usbhid-ups
driver.parameter.pollfreq: 30
driver.parameter.pollinterval: 2
driver.parameter.port: /dev/ugen0.2
driver.parameter.synchronous: no
driver.version: 2.7.4
driver.version.data: CyberPower HID 0.4
driver.version.internal: 0.41
input.transfer.high: 140
input.transfer.low: 90
input.voltage: 122.0
input.voltage.nominal: 120
output.voltage: 122.0
ups.beeper.status: disabled
ups.delay.shutdown: 20
ups.delay.start: 30
ups.load: 10
ups.mfr: CPS
ups.model:  CP 1500C
ups.productid: 0501
ups.realpower.nominal: 388
ups.status: OL
ups.test.result: Done and passed
ups.timer.shutdown: -60
ups.timer.start: 0
ups.vendorid: 0764
 

 

[elvisimprsntr]

All CP models use the usbhid-ups driver. Any will do.

Network UPS Tools - Hardware compatibility list

Power Devices support

networkupstools.org

When it was unplugged and re-plugged it likely got assigned a different USB bus ID. Just set the port to auto and it will automatically connect.

Type the following commands:

Code:

usbconfig
nut-scanner

 

[bent98]

All CP models use the usbhid-ups driver. Any will do.

Network UPS Tools - Hardware compatibility list

Power Devices support

networkupstools.org

When it was unplugged and re-plugged it likely got assigned a different USB bus ID. Just set the port to auto and it will automatically connect.

Type the following commands:

Code:

usbconfig
nut-scanner

Doesnt seem to work. I also did set the port to Auto. Still getting error

 

[elvisimprsntr]

Doesnt seem to work. I also did set the port to Auto. Still getting error

/dev/ugen0.2 appears to be a KB
/dev/ugen0.3 is your CP UPS

Try stopping and restarting the UPS service, or reboot TrueNAS.

FYI, I personally connect my UPS to my pfSense firewall as a Master and all TrueNAS clients as Slaves because of continual TrueNAS USB UPS issues.

 

[bent98]

/dev/ugen0.2 appears to be a KB
/dev/ugen0.3 is your CP UPS

Try stopping and restarting the UPS service, or reboot TrueNAS.

FYI, I personally connect my UPS to my pfSense firewall as a Master and all TrueNAS clients as Slaves because of continual TrueNAS USB UPS issues.

I just forced it to .3 port, stopped and started service. Lets see what happens. Thanks!

 

[bent98]

looks like that did it. Thanks

 

[bent98]

/dev/ugen0.2 appears to be a KB
/dev/ugen0.3 is your CP UPS

Try stopping and restarting the UPS service, or reboot TrueNAS.

FYI, I personally connect my UPS to my pfSense firewall as a Master and all TrueNAS clients as Slaves because of continual TrueNAS USB UPS issues.

Spoke to soon. doing it not as often .. WTF

 

[joeschmuck]

Let's start all over again... In the Driver section, use : usbhid-ups$AE550
For the port: auto
For Shutdown Timer: 120 as I don't think you really want 4 whole seconds. If it's a quick power drop, let the system run. Or change to 60 seconds.
I would also check the box for Power Off UPS to save the batteries from discharging and shortening life.
Click on Save

Ensure your USP service is still running. Take note of the time and see if you have any further error messages. If so, report those. Now I need to ensure I don't have the same issue.

 

[bent98]

Let's start all over again... In the Driver section, use : usbhid-ups$AE550
For the port: auto
For Shutdown Timer: 120 as I don't think you really want 4 whole seconds. If it's a quick power drop, let the system run. Or change to 60 seconds.
I would also check the box for Power Off UPS to save the batteries from discharging and shortening life.
Click on Save

Ensure your USP service is still running. Take note of the time and see if you have any further error messages. If so, report those. Now I need to ensure I don't have the same issue.

Done. Ill report back. I thought time was in minutes. Good catch.

 

[joeschmuck]

If you want to test if your UPS and computer are talking correctly, just unplug your UPS, you will find out and make sure the computer properly shuts down. It is best in a controlled environment. When I first go into FreeNAS, I tested run times on my UPS and system, I did everything I could think of. I needed to know for myself that it would work as I expected.

 

[bent98]

So it’s still doing it based on your settings

What do you recommend ?

 

[joeschmuck]

What do you recommend ?

A hammer!

Do you have any USB ports in use besides the UPS connection? If yes, disconnect those if you can, such as keyboard and mouse. See if that helps.

Let's say disconnecting those USB devices work and the messages stop coming. I'd reboot and monitor for a while to make sure those messages are clear.

If you are still doing well, you can plug a single USB item back in. Wait to see if the problem returns. Rinse and Repeat and hopefully one item will be the problem.

Now let's say you plug in a USB keyboard and the problem starts up again... Move the keyboard to a different USB port. Keep track of what you are doing. If you can solve the problem by reconfiguring the USB port assignment then great.

So if that fails, move the UPS USB cable to another port (all ports if needed). You see what I'm doing, we are reconfiguring the hardware in small steps and the goal here is to first identify the exact problem. Is it the USB device or the USB port causing the error, or none of the above.

That is all I can think of for now. If it's not a USB issue then I'm not sure what else it could be.

You could try to look in the log files for the time periods listed on your console. To email yourself a copy of these logs, do the following in the Shell:

Code:

cd /var/log

Code:

mail -s “messages” YourEmailAddress.net < messages

Code:

mail -s “dmesg” YourEmailAddress.net < dmesg.today

Code:

mail -s “system” YourEmailAddress.net < system

Code:

mail -s “upslog” YourEmailAddress.net < /var/log/ups/ups.log

Code:

mail -s “daemon” YourEmailAddress.net < daemon.log

The first two are likely the important ones however I included others so you can see what kind of data get logged.

 

[bent98]

A hammer!

Do you have any USB ports in use besides the UPS connection? If yes, disconnect those if you can, such as keyboard and mouse. See if that helps.

Let's say disconnecting those USB devices work and the messages stop coming. I'd reboot and monitor for a while to make sure those messages are clear.

If you are still doing well, you can plug a single USB item back in. Wait to see if the problem returns. Rinse and Repeat and hopefully one item will be the problem.

Now let's say you plug in a USB keyboard and the problem starts up again... Move the keyboard to a different USB port. Keep track of what you are doing. If you can solve the problem by reconfiguring the USB port assignment then great.

So if that fails, move the UPS USB cable to another port (all ports if needed). You see what I'm doing, we are reconfiguring the hardware in small steps and the goal here is to first identify the exact problem. Is it the USB device or the USB port causing the error, or none of the above.

That is all I can think of for now. If it's not a USB issue then I'm not sure what else it could be.

You could try to look in the log files for the time periods listed on your console. To email yourself a copy of these logs, do the following in the Shell:

Code:

cd /var/log

Code:

mail -s “messages” YourEmailAddress.net < messages

Code:

mail -s “dmesg” YourEmailAddress.net < dmesg.today

Code:

mail -s “system” YourEmailAddress.net < system

Code:

mail -s “upslog” YourEmailAddress.net < /var/log/ups/ups.log

Code:

mail -s “daemon” YourEmailAddress.net < daemon.log

The first two are likely the important ones however I included others so you can see what kind of data get logged.

So the only other USB device plugged in is a keyboard. Screenshot shows the time when I disconnected keyboard and then the ensuing errors. it looks like it happens every 2-3 hours.

 

[bent98]

Code:

 Dec 28 00:00:00 freenas newsyslog[5879]: logfile turned over due to size>200K
Dec 28 00:00:00 freenas syslog-ng[2140]: Configuration reload request received, reloading configuration;
Dec 28 00:00:00 freenas syslog-ng[2140]: Configuration reload finished;
Dec 28 00:22:46 freenas 1 2023-12-28T00:22:46.018369-05:00 freenas.local usbhid-ups 1434 - - Got disconnected by another driver: Device busy
Dec 28 00:26:31 freenas 1 2023-12-28T00:26:31.730029-05:00 freenas.local usbhid-ups 1434 - - Got disconnected by another driver: Device busy
Dec 28 00:43:29 freenas 1 2023-12-28T00:43:29.109890-05:00 freenas.local usbhid-ups 1434 - - Got disconnected by another driver: Device busy
Dec 28 00:46:09 freenas 1 2023-12-28T00:46:09.413860-05:00 freenas.local usbhid-ups 1434 - - Got disconnected by another driver: Device busy
Dec 28 01:19:02 freenas 1 2023-12-28T01:19:02.922343-05:00 freenas.local usbhid-ups 1434 - - Got disconnected by another driver: Device busy
Dec 28 04:38:50 freenas 1 2023-12-28T04:38:50.993203-05:00 freenas.local usbhid-ups 1434 - - Got disconnected by another driver: Device busy
Dec 28 05:41:17 freenas 1 2023-12-28T05:41:17.386471-05:00 freenas.local usbhid-ups 1434 - - Got disconnected by another driver: Device busy
Dec 28 05:53:08 freenas 1 2023-12-28T05:53:08.972118-05:00 freenas.local usbhid-ups 1434 - - Got disconnected by another driver: Device busy
Dec 28 07:43:35 freenas 1 2023-12-28T07:43:35.806378-05:00 freenas.local usbhid-ups 1434 - - Got disconnected by another driver: Device busy
Dec 28 09:16:07 freenas 1 2023-12-28T09:16:07.033823-05:00 freenas.local usbhid-ups 1434 - - Got disconnected by another driver: Device busy
Dec 28 09:45:28 freenas 1 2023-12-28T09:45:28.326202-05:00 freenas.local upsmon 1444 - - upsmon parent: read
Dec 28 09:45:28 freenas 1 2023-12-28T09:45:28.343879-05:00 freenas.local upsd 1436 - - mainloop: Interrupted system call
Dec 28 09:45:59 freenas 1 2023-12-28T09:45:59.165343-05:00 freenas.local usbhid-ups 12292 - - Got disconnected by another driver: Device busy
Dec 28 10:01:14 freenas 1 2023-12-28T10:01:14.568832-05:00 freenas.local usbhid-ups 12292 - - Got disconnected by another driver: Device busy
Dec 28 10:01:49 freenas 1 2023-12-28T10:01:49.144021-05:00 freenas.local usbhid-ups 12292 - - Got disconnected by another driver: Device busy
Dec 28 11:49:14 freenas 1 2023-12-28T11:49:14.560372-05:00 freenas.local usbhid-ups 12292 - - Got disconnected by another driver: Device busy
Dec 28 11:51:22 freenas 1 2023-12-28T11:51:22.906746-05:00 freenas.local usbhid-ups 12292 - - Got disconnected by another driver: Device busy
Dec 28 15:46:43 freenas 1 2023-12-28T15:46:43.481540-05:00 freenas.local upsmon 12303 - - upsmon parent: read
Dec 28 15:46:43 freenas 1 2023-12-28T15:46:43.499637-05:00 freenas.local upsd 12294 - - mainloop: Interrupted system call
Dec 28 15:46:51 freenas 1 2023-12-28T15:46:51.985728-05:00 freenas.local upsmon 16374 - - upsmon parent: read
Dec 28 15:46:52 freenas 1 2023-12-28T15:46:52.004581-05:00 freenas.local upsd 16365 - - mainloop: Interrupted system call
Dec 28 15:46:52 freenas 1 2023-12-28T15:46:52.295960-05:00 freenas.local collectd 16522 - - nut plugin: nut_connect: upscli_connect (localhost, 3493) failed: Connection failure: Connection refused
Dec 28 19:32:10 freenas 1 2023-12-28T19:32:10.728264-05:00 freenas.local usbhid-ups 16536 - - Got disconnected by another driver: Device busy
Dec 28 20:36:42 freenas 1 2023-12-28T20:36:42.241636-05:00 freenas.local usbhid-ups 16536 - - Got disconnected by another driver: Device busy
Dec 28 20:44:07 freenas 1 2023-12-28T20:44:07.302246-05:00 freenas.local usbhid-ups 16536 - - Got disconnected by another driver: Device busy
Dec 28 21:42:44 freenas 1 2023-12-28T21:42:44.231599-05:00 freenas.local usbhid-ups 16536 - - Got disconnected by another driver: Device busy
Dec 29 00:00:00 freenas syslog-ng[2140]: Configuration reload request received, reloading configuration;
Dec 29 00:00:00 freenas syslog-ng[2140]: Configuration reload finished;
Dec 29 02:31:34 freenas 1 2023-12-29T02:31:34.567315-05:00 freenas.local usbhid-ups 16536 - - Got disconnected by another driver: Device busy
Dec 29 08:16:55 freenas 1 2023-12-29T08:16:55.523734-05:00 freenas.local usbhid-ups 16536 - - Got disconnected by another driver: Device busy
Dec 29 08:57:30 freenas 1 2023-12-29T08:57:30.483291-05:00 freenas.local usbhid-ups 16536 - - Got disconnected by another driver: Device busy
Dec 29 14:48:29 freenas 1 2023-12-29T14:48:29.410447-05:00 freenas.local usbhid-ups 16536 - - Got disconnected by another driver: Device busy
Dec 29 15:34:24 freenas 1 2023-12-29T15:34:24.719724-05:00 freenas.local usbhid-ups 16536 - - Got disconnected by another driver: Device busy
Dec 29 16:55:56 freenas 1 2023-12-29T16:55:56.447418-05:00 freenas.local usbhid-ups 16536 - - Got disconnected by another driver: Device busy
Dec 29 17:42:11 freenas 1 2023-12-29T17:42:11.403478-05:00 freenas.local usbhid-ups 16536 - - Got disconnected by another driver: Device busy
Dec 29 17:53:55 freenas 1 2023-12-29T17:53:55.148697-05:00 freenas.local usbhid-ups 16536 - - Got disconnected by another driver: Device busy
Dec 30 00:00:00 freenas syslog-ng[2140]: Configuration reload request received, reloading configuration;
Dec 30 00:00:00 freenas syslog-ng[2140]: Configuration reload finished;
Dec 30 01:12:04 freenas 1 2023-12-30T01:12:04.972061-05:00 freenas.local usbhid-ups 16536 - - Got disconnected by another driver: Device busy
Dec 30 01:36:40 freenas 1 2023-12-30T01:36:40.048944-05:00 freenas.local usbhid-ups 16536 - - Got disconnected by another driver: Device busy
Dec 30 07:41:53 freenas 1 2023-12-30T07:41:53.449266-05:00 freenas.local usbhid-ups 16536 - - Got disconnected by another driver: Device busy
Dec 30 08:35:52 freenas 1 2023-12-30T08:35:52.191158-05:00 freenas.local upsmon 16546 - - upsmon parent: read
Dec 30 08:35:52 freenas 1 2023-12-30T08:35:52.210863-05:00 freenas.local upsd 16538 - - mainloop: Interrupted system call
Dec 30 08:35:52 freenas 1 2023-12-30T08:35:52.516301-05:00 freenas.local collectd 42774 - - nut plugin: nut_connect: upscli_connect (localhost, 3493) failed: Connection failure: Connection refused
Dec 30 08:35:57 freenas 1 2023-12-30T08:35:57.311358-05:00 freenas.local root 42793 - - /usr/local/etc/rc.d/nut: WARNING: failed precmd routine for nut
Dec 30 08:35:57 freenas 1 2023-12-30T08:35:57.336523-05:00 freenas.local upsmon 42802 - - UPS [ups@localhost:3493]: connect failed: Connection failure: Connection refused
Dec 30 08:35:57 freenas 1 2023-12-30T08:35:57.336537-05:00 freenas.local upsmon 42802 - - Communications with UPS ups@localhost:3493 lost
Dec 30 08:35:57 freenas 1 2023-12-30T08:35:57.877354-05:00 freenas.local collectd 42871 - - nut plugin: nut_connect: upscli_connect (localhost, 3493) failed: Connection failure: Connection refused
Dec 30 08:36:02 freenas 1 2023-12-30T08:36:02.366934-05:00 freenas.local upsmon 42802 - - UPS [ups@localhost:3493]: connect failed: Connection failure: Connection refused
Dec 30 08:36:02 freenas 1 2023-12-30T08:36:02.366983-05:00 freenas.local upsmon 42802 - - UPS ups@localhost:3493 is unavailable
Dec 30 08:36:07 freenas 1 2023-12-30T08:36:07.536863-05:00 freenas.local upsmon 42802 - - UPS [ups@localhost:3493]: connect failed: Connection failure: Connection refused
Dec 30 08:36:12 freenas 1 2023-12-30T08:36:12.554600-05:00 freenas.local upsmon 42802 - - UPS [ups@localhost:3493]: connect failed: Connection failure: Connection refused
Dec 30 08:36:17 freenas 1 2023-12-30T08:36:17.569899-05:00 freenas.local upsmon 42802 - - UPS [ups@localhost:3493]: connect failed: Connection failure: Connection refused
Dec 30 08:36:17 freenas 1 2023-12-30T08:36:17.782885-05:00 freenas.local collectd 42871 - - nut plugin: nut_connect: upscli_connect (localhost, 3493) failed: Connection failure: Connection refused
Dec 30 08:36:25 freenas 1 2023-12-30T08:36:25.243351-05:00 freenas.local upsmon 42801 - - upsmon parent: read
Dec 30 08:36:25 freenas 1 2023-12-30T08:36:25.583538-05:00 freenas.local collectd 42951 - - nut plugin: nut_connect: upscli_connect (localhost, 3493) failed: Connection failure: Connection refused
Dec 30 08:52:18 freenas 1 2023-12-30T08:52:18.212660-05:00 freenas.local usbhid-ups 42965 - - Got disconnected by another driver: Device busy
Dec 30 09:48:23 freenas 1 2023-12-30T09:48:23.597988-05:00 freenas.local usbhid-ups 42965 - - Got disconnected by another driver: Device busy
Dec 30 10:39:03 freenas 1 2023-12-30T10:39:03.028871-05:00 freenas.local usbhid-ups 42965 - - Got disconnected by another driver: Device busy
Dec 30 13:08:05 freenas 1 2023-12-30T13:08:05.933576-05:00 freenas.local usbhid-ups 42965 - - Got disconnected by another driver: Device busy
Dec 30 17:10:07 freenas ugen0.2: <Chicony Saitek Eclipse Keyboard> at usbus0 (disconnected)
Dec 30 17:10:07 freenas ukbd0: at uhub0, port 9, addr 1 (disconnected)
Dec 30 17:10:07 freenas ukbd0: detached
Dec 30 17:10:07 freenas uhid0: at uhub0, port 9, addr 1 (disconnected)
Dec 30 17:10:07 freenas uhid0: detached
Dec 30 18:52:15 freenas 1 2023-12-30T18:52:15.847830-05:00 freenas.local usbhid-ups 42965 - - Got disconnected by another driver: Device busy
Dec 30 21:56:44 freenas 1 2023-12-30T21:56:44.622092-05:00 freenas.local usbhid-ups 42965 - - Got disconnected by another driver: Device busy
Dec 31 00:00:00 freenas syslog-ng[2140]: Configuration reload request received, reloading configuration;
Dec 31 00:00:00 freenas syslog-ng[2140]: Configuration reload finished;
Dec 31 00:47:55 freenas 1 2023-12-31T00:47:55.095422-05:00 freenas.local usbhid-ups 42965 - - Got disconnected by another driver: Device busy
Dec 31 02:55:05 freenas 1 2023-12-31T02:55:05.119458-05:00 freenas.local usbhid-ups 42965 - - Got disconnected by another driver: Device busy

Code:

Copyright (c) 1992-2018 The FreeBSD Project.
Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
The Regents of the University of California. All rights reserved.
FreeBSD is a registered trademark of The FreeBSD Foundation.
FreeBSD 11.2-STABLE #0 r325575+c9231c7d6bd(HEAD): Mon Nov 18 22:46:47 UTC 2019
root@nemesis:/freenas-releng/freenas/_BE/objs/freenas-releng/freenas/_BE/os/sys/FreeNAS.amd64 amd64
FreeBSD clang version 6.0.0 (tags/RELEASE_600/final 326565) (based on LLVM 6.0.0)
VT(vga): resolution 640x480
CPU: Intel(R) Core(TM) i3-6100 CPU @ 3.70GHz (3696.16-MHz K8-class CPU)
Origin="GenuineIntel" Id=0x506e3 Family=0x6 Model=0x5e Stepping=3
Features=0xbfebfbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CLFLUSH,DTS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,PBE>
Features2=0x7ffafbbf<SSE3,PCLMULQDQ,DTES64,MON,DS_CPL,VMX,EST,TM2,SSSE3,SDBG,FMA,CX16,xTPR,PDCM,PCID,SSE4.1,SSE4.2,x2APIC,MOVBE,POPCNT,TSCDLT,AESNI,XSAVE,OSXSAVE,AVX,F16C,RDRAND>
AMD Features=0x2c100800<SYSCALL,NX,Page1GB,RDTSCP,LM>
AMD Features2=0x121<LAHF,ABM,Prefetch>
Structured Extended Features=0x29c67af<FSGSBASE,TSCADJ,SGX,BMI1,AVX2,SMEP,BMI2,ERMS,INVPCID,NFPUSG,MPX,RDSEED,ADX,SMAP,CLFLUSHOPT,PROCTRACE>
XSAVE Features=0xf<XSAVEOPT,XSAVEC,XINUSE,XSAVES>
VT-x: PAT,HLT,MTF,PAUSE,EPT,UG,VPID
TSC: P-state invariant, performance statistics
real memory = 21474836480 (20480 MB)
avail memory = 20633583616 (19677 MB)
Event timer "LAPIC" quality 600
ACPI APIC Table: <ALASKA A M I >
FreeBSD/SMP: Multiprocessor System Detected: 4 CPUs
FreeBSD/SMP: 1 package(s) x 2 core(s) x 2 hardware threads
WARNING: VIMAGE (virtualized network stack) is a highly experimental feature.
ioapic0 <Version 2.0> irqs 0-119 on motherboard
SMP: AP CPU #1 Launched!
SMP: AP CPU #3 Launched!
SMP: AP CPU #2 Launched!
Timecounter "TSC-low" frequency 1848082065 Hz quality 1000
random: entropy device external interface
random: registering fast source Intel Secure Key RNG
random: fast provider: "Intel Secure Key RNG"
kbd0 at kbdmux0
nexus0
vtvga0: <VT VGA driver> on motherboard
cryptosoft0: <software crypto> on motherboard
aesni0: <AES-CBC,AES-XTS,AES-GCM,AES-ICM> on motherboard
padlock0: No ACE support.
acpi0: <ALASKA A M I > on motherboard
acpi0: Power Button (fixed)
cpu0: <ACPI CPU> on acpi0
cpu1: <ACPI CPU> on acpi0
cpu2: <ACPI CPU> on acpi0
cpu3: <ACPI CPU> on acpi0
hpet0: <High Precision Event Timer> iomem 0xfed00000-0xfed003ff on acpi0
Timecounter "HPET" frequency 24000000 Hz quality 950
Event timer "HPET" frequency 24000000 Hz quality 550
Event timer "HPET1" frequency 24000000 Hz quality 440
Event timer "HPET2" frequency 24000000 Hz quality 440
Event timer "HPET3" frequency 24000000 Hz quality 440
Event timer "HPET4" frequency 24000000 Hz quality 440
atrtc0: <AT realtime clock> port 0x70-0x77 irq 8 on acpi0
atrtc0: Warning: Couldn't map I/O.
atrtc0: registered as a time-of-day clock, resolution 1.000000s
Event timer "RTC" frequency 32768 Hz quality 0
attimer0: <AT timer> port 0x40-0x43,0x50-0x53 irq 0 on acpi0
Timecounter "i8254" frequency 1193182 Hz quality 0
Event timer "i8254" frequency 1193182 Hz quality 100
Timecounter "ACPI-fast" frequency 3579545 Hz quality 900
acpi_timer0: <24-bit timer at 3.579545MHz> port 0x1808-0x180b on acpi0
pcib0: <ACPI Host-PCI bridge> port 0xcf8-0xcff on acpi0
pci0: <ACPI PCI bus> on pcib0
pcib1: <ACPI PCI-PCI bridge> irq 16 at device 1.0 on pci0
pci1: <ACPI PCI bus> on pcib1
pcib2: <ACPI PCI-PCI bridge> irq 16 at device 1.1 on pci0
pci2: <ACPI PCI bus> on pcib2
ahci0: <Marvell 88SE9235 AHCI SATA controller> port 0xe050-0xe057,0xe040-0xe043,0xe030-0xe037,0xe020-0xe023,0xe000-0xe01f mem 0xdf140000-0xdf1407ff irq 17 at device 0.0 on pci2
ahci0: AHCI v1.00 with 4 6Gbps ports, Port Multiplier supported with FBS
ahcich0: <AHCI channel> at channel 0 on ahci0
ahcich1: <AHCI channel> at channel 1 on ahci0
ahcich2: <AHCI channel> at channel 2 on ahci0
ahcich3: <AHCI channel> at channel 3 on ahci0
vgapci0: <VGA-compatible display> port 0xf000-0xf03f mem 0xde000000-0xdeffffff,0xc0000000-0xcfffffff irq 16 at device 2.0 on pci0
vgapci0: Boot video device
xhci0: <Intel Sunrise Point USB 3.0 controller> mem 0xdf220000-0xdf22ffff irq 16 at device 20.0 on pci0
xhci0: 32 bytes context size, 64-bit DMA
usbus0 on xhci0
usbus0: 5.0Gbps Super Speed USB v3.0
pci0: <simple comms> at device 22.0 (no driver attached)
pci0: <simple comms, UART> at device 22.3 (no driver attached)
ahci1: <Intel Sunrise Point AHCI SATA controller> port 0xf090-0xf097,0xf080-0xf083,0xf060-0xf07f mem 0xdf230000-0xdf231fff,0xdf23e000-0xdf23e0ff,0xdf23d000-0xdf23d7ff irq 16 at device 23.0 on pci0
ahci1: AHCI v1.31 with 6 6Gbps ports, Port Multiplier not supported
ahcich4: <AHCI channel> at channel 0 on ahci1
ahcich5: <AHCI channel> at channel 1 on ahci1
ahcich6: <AHCI channel> at channel 2 on ahci1
ahcich7: <AHCI channel> at channel 3 on ahci1
ahcich8: <AHCI channel> at channel 4 on ahci1
ahcich9: <AHCI channel> at channel 5 on ahci1
pcib3: <ACPI PCI-PCI bridge> irq 18 at device 28.0 on pci0
pci3: <ACPI PCI bus> on pcib3
em0: <Intel(R) PRO/1000 Network Connection 7.6.1-k> port 0xd020-0xd03f mem 0xdf060000-0xdf07ffff,0xdf040000-0xdf05ffff irq 18 at device 0.0 on pci3
em0: Using an MSI interrupt
em0: Ethernet address: 00:15:17:2e:f0:0e
em1: <Intel(R) PRO/1000 Network Connection 7.6.1-k> port 0xd000-0xd01f mem 0xdf020000-0xdf03ffff,0xdf000000-0xdf01ffff irq 19 at device 0.1 on pci3
em1: Using an MSI interrupt
em1: Ethernet address: 00:15:17:2e:f0:0f
isab0: <PCI-ISA bridge> at device 31.0 on pci0
isa0: <ISA bus> on isab0
pci0: <memory> at device 31.2 (no driver attached)
em2: <Intel(R) PRO/1000 Network Connection 7.6.1-k> mem 0xdf200000-0xdf21ffff irq 16 at device 31.6 on pci0
em2: Using an MSI interrupt
em2: Ethernet address: e0:07:1b:ff:26:7e
pci0: <unknown> at device 31.7 (no driver attached)
acpi_button0: <Sleep Button> on acpi0
acpi_button1: <Power Button> on acpi0
acpi_tz0: <Thermal Zone> on acpi0
acpi_tz1: <Thermal Zone> on acpi0
orm0: <ISA Option ROMs> at iomem 0xc0000-0xcffff,0xd0000-0xd2fff,0xd3000-0xd3fff on isa0
coretemp0: <CPU On-Die Thermal Sensors> on cpu0
est0: <Enhanced SpeedStep Frequency Control> on cpu0
coretemp1: <CPU On-Die Thermal Sensors> on cpu1
est1: <Enhanced SpeedStep Frequency Control> on cpu1
coretemp2: <CPU On-Die Thermal Sensors> on cpu2
est2: <Enhanced SpeedStep Frequency Control> on cpu2
coretemp3: <CPU On-Die Thermal Sensors> on cpu3
est3: <Enhanced SpeedStep Frequency Control> on cpu3
ZFS filesystem version: 5
ZFS storage pool version: features support (5000)
Timecounters tick every 1.000 msec
freenas_sysctl: adding account.
freenas_sysctl: adding directoryservice.
freenas_sysctl: adding middlewared.
freenas_sysctl: adding network.
freenas_sysctl: adding services.
ipfw2 (+ipv6) initialized, divert enabled, nat enabled, default to accept, logging disabled
ugen0.1: <0x8086 XHCI root HUB> at usbus0
uhub0: <0x8086 XHCI root HUB, class 9/0, rev 3.00/1.00, addr 1> on usbus0
uhub0: 26 ports with 26 removable, self powered
ugen0.2: <CPS CP 1350C> at usbus0
ugen0.3: <Chicony Saitek Eclipse Keyboard> at usbus0
ukbd0 on uhub0
ukbd0: <Chicony Saitek Eclipse Keyboard, class 0/0, rev 2.00/1.30, addr 2> on usbus0
kbd1 at ukbd0
ada0 at ahcich0 bus 0 scbus0 target 0 lun 0
ada0: <WDC WD80EFZX-68UW8N0 83.H0A83> ACS-2 ATA SATA 3.x device
ada0: Serial Number VK1EX8HY
ada0: 600.000MB/s transfers (SATA 3.x, UDMA6, PIO 8192bytes)
ada0: Command Queueing enabled
ada0: 7630885MB (15628053168 512 byte sectors)
ada1 at ahcich2 bus 0 scbus2 target 0 lun 0
ada1: <WDC WD80EFZX-68UW8N0 83.H0A83> ACS-2 ATA SATA 3.x device
ada1: Serial Number VK1GHX4Y
ada1: 600.000MB/s transfers (SATA 3.x, UDMA6, PIO 8192bytes)
ada1: Command Queueing enabled
ada1: 7630885MB (15628053168 512 byte sectors)
ada2 at ahcich3 bus 0 scbus3 target 0 lun 0
ada2: <WDC WD80EFZX-68UW8N0 83.H0A83> ACS-2 ATA SATA 3.x device
ada2: Serial Number VJH5RDPX
ada2: 600.000MB/s transfers (SATA 3.x, UDMA6, PIO 8192bytes)
ada2: Command Queueing enabled
ada2: 7630885MB (15628053168 512 byte sectors)
ada3 at ahcich5 bus 0 scbus5 target 0 lun 0
ada3: <SanDisk SDSSDA120G Z33130RL> ACS-2 ATA SATA 3.x device
ada3: Serial Number 172773801991
ada3: 600.000MB/s transfers (SATA 3.x, UDMA6, PIO 512bytes)
ada3: Command Queueing enabled
ada3: 114473MB (234441648 512 byte sectors)
ada4 at ahcich6 bus 0 scbus6 target 0 lun 0
ada4: <WDC WD80EFZX-68UW8N0 83.H0A83> ACS-2 ATA SATA 3.x device
ada4: Serial Number VK1GJA0Y
ada4: 600.000MB/s transfers (SATA 3.x, UDMA6, PIO 8192bytes)
ada4: Command Queueing enabled
ada4: 7630885MB (15628053168 512 byte sectors)
ada5 at ahcich7 bus 0 scbus7 target 0 lun 0
ada5: <WDC WD80EFZX-68UW8N0 83.H0A83> ACS-2 ATA SATA 3.x device
ada5: Serial Number VK1EXGGY
ada5: 600.000MB/s transfers (SATA 3.x, UDMA6, PIO 8192bytes)
ada5: Command Queueing enabled
ada5: 7630885MB (15628053168 512 byte sectors)
ada6 at ahcich8 bus 0 scbus8 target 0 lun 0
ada6: <WDC WD80EFZX-68UW8N0 83.H0A83> ACS-2 ATA SATA 3.x device
ada6: Serial Number VK1EBZTY
ada6: 600.000MB/s transfers (SATA 3.x, UDMA6, PIO 8192bytes)
ada6: Command Queueing enabled
ada6: 7630885MB (15628053168 512 byte sectors)
ada7 at ahcich9 bus 0 scbus9 target 0 lun 0
ada7: <WDC WD80EFZX-68UW8N0 83.H0A83> ACS-2 ATA SATA 3.x device
ada7: Serial Number VK1EH4BY
ada7: 600.000MB/s transfers (SATA 3.x, UDMA6, PIO 8192bytes)
ada7: Command Queueing enabled
ada7: 7630885MB (15628053168 512 byte sectors)
random: unblocking device.
Trying to mount root from zfs:freenas-boot/ROOT/11.2-U7 []...
em0: link state changed to UP
GEOM_MIRROR: Device mirror/swap0 launched (2/2).
GEOM_MIRROR: Device mirror/swap1 launched (2/2).
GEOM_MIRROR: Device mirror/swap2 launched (2/2).
GEOM_ELI: Device mirror/swap0.eli created.
GEOM_ELI: Encryption: AES-XTS 128
GEOM_ELI: Crypto: hardware
GEOM_ELI: Device mirror/swap1.eli created.
GEOM_ELI: Encryption: AES-XTS 128
GEOM_ELI: Crypto: hardware
GEOM_ELI: Device mirror/swap2.eli created.
GEOM_ELI: Encryption: AES-XTS 128
GEOM_ELI: Crypto: hardware
hwpmc: SOFT/16/64/0x67<INT,USR,SYS,REA,WRI> TSC/1/64/0x20<REA> IAP/4/48/0x3ff<INT,USR,SYS,EDG,THR,REA,WRI,INV,QUA,PRC> IAF/3/48/0x67<INT,USR,SYS,REA,WRI>
lagg0: link state changed to DOWN
uhid0 on uhub0
uhid0: <Chicony Saitek Eclipse Keyboard, class 0/0, rev 2.00/1.30, addr 2> on usbus0
em1: link state changed to UP
lagg0: link state changed to UP
nfsd: can't register svc name

Code:

Sep 28 17:07:33 freenas kernel: arp: 192.168.1.183 moved from 70:85:c2:0d:a6:87 to 70:85:c2:0d:a6:89 on lagg0

 

[bent98]

Code:

Dec 30 00:00:00 freenas newsyslog[37117]: logfile turned over due to size>100K
Dec 30 23:45:09 freenas 1 2023-12-30T23:45:09.544278-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 30 23:50:57 freenas 1 2023-12-30T23:50:57.154869-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 30 23:52:07 freenas 1 2023-12-30T23:52:07.202011-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 30 23:53:42 freenas 1 2023-12-30T23:53:42.926967-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 30 23:56:21 freenas 1 2023-12-30T23:56:21.919304-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 30 23:57:57 freenas 1 2023-12-30T23:57:57.458721-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 30 23:59:04 freenas 1 2023-12-30T23:59:04.769606-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 30 23:59:26 freenas 1 2023-12-30T23:59:26.948124-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 00:04:52 freenas 1 2023-12-31T00:04:52.413192-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 00:09:38 freenas 1 2023-12-31T00:09:38.708542-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 00:10:16 freenas 1 2023-12-31T00:10:16.108987-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 00:12:12 freenas 1 2023-12-31T00:12:12.404654-05:00 freenas.local smartd 1626 - - Device: /dev/ada4, SMART Usage Attribute: 194 Temperature_Celsius changed from 222 to 214
Dec 31 00:12:12 freenas 1 2023-12-31T00:12:12.411388-05:00 freenas.local smartd 1626 - - Device: /dev/ada4, SMART Usage Attribute: 194 Temperature_Celsius changed from 222 to 214
Dec 31 00:12:59 freenas 1 2023-12-31T00:12:59.356925-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 00:15:05 freenas 1 2023-12-31T00:15:05.683376-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 00:15:43 freenas 1 2023-12-31T00:15:43.080991-05:00 freenas.local usbhid-ups 42965 - - libusb_get_string: Unknown error
Dec 31 00:24:08 freenas 1 2023-12-31T00:24:08.711877-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 00:28:20 freenas 1 2023-12-31T00:28:20.834203-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 00:32:02 freenas 1 2023-12-31T00:32:02.267872-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 00:33:12 freenas 1 2023-12-31T00:33:12.265813-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 00:34:47 freenas 1 2023-12-31T00:34:47.890700-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 00:42:12 freenas 1 2023-12-31T00:42:12.548993-05:00 freenas.local smartd 1626 - - Device: /dev/ada6, SMART Usage Attribute: 194 Temperature_Celsius changed from 222 to 230
Dec 31 00:42:12 freenas 1 2023-12-31T00:42:12.556021-05:00 freenas.local smartd 1626 - - Device: /dev/ada6, SMART Usage Attribute: 194 Temperature_Celsius changed from 222 to 230
Dec 31 00:47:55 freenas 1 2023-12-31T00:47:55.095371-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 00:47:55 freenas 1 2023-12-31T00:47:55.095422-05:00 freenas.local usbhid-ups 42965 - - Got disconnected by another driver: Device busy
Dec 31 00:54:15 freenas 1 2023-12-31T00:54:15.596064-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 01:03:13 freenas 1 2023-12-31T01:03:13.293205-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 01:03:15 freenas 1 2023-12-31T01:03:15.364240-05:00 freenas.local usbhid-ups 42965 - - libusb_get_string: Unknown error
Dec 31 01:03:15 freenas 1 2023-12-31T01:03:15.377677-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 01:05:23 freenas 1 2023-12-31T01:05:23.820540-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 01:12:12 freenas 1 2023-12-31T01:12:12.693595-05:00 freenas.local smartd 1626 - - Device: /dev/ada6, SMART Usage Attribute: 194 Temperature_Celsius changed from 230 to 222
Dec 31 01:12:12 freenas 1 2023-12-31T01:12:12.699248-05:00 freenas.local smartd 1626 - - Device: /dev/ada6, SMART Usage Attribute: 194 Temperature_Celsius changed from 230 to 222
Dec 31 01:21:10 freenas 1 2023-12-31T01:21:10.186615-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 01:22:52 freenas 1 2023-12-31T01:22:52.265692-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 01:26:01 freenas 1 2023-12-31T01:26:01.033521-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 01:28:10 freenas 1 2023-12-31T01:28:10.668082-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 01:39:45 freenas 1 2023-12-31T01:39:45.412507-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 01:49:16 freenas 1 2023-12-31T01:49:16.512184-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 02:03:58 freenas 1 2023-12-31T02:03:58.356902-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 02:07:09 freenas 1 2023-12-31T02:07:09.434204-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 02:09:22 freenas 1 2023-12-31T02:09:22.493336-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 02:22:31 freenas 1 2023-12-31T02:22:31.733366-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 02:34:08 freenas 1 2023-12-31T02:34:08.085549-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 02:34:15 freenas 1 2023-12-31T02:34:15.097325-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 02:34:15 freenas 1 2023-12-31T02:34:15.111807-05:00 freenas.local usbhid-ups 42965 - - libusb_get_string: Unknown error
Dec 31 02:35:20 freenas 1 2023-12-31T02:35:20.782990-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 02:35:22 freenas 1 2023-12-31T02:35:22.891122-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 02:37:35 freenas 1 2023-12-31T02:37:35.827314-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 02:39:09 freenas 1 2023-12-31T02:39:09.175818-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 02:46:37 freenas 1 2023-12-31T02:46:37.037092-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 02:50:50 freenas 1 2023-12-31T02:50:50.773252-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 02:51:23 freenas 1 2023-12-31T02:51:23.290298-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 02:55:05 freenas 1 2023-12-31T02:55:05.119411-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 02:55:05 freenas 1 2023-12-31T02:55:05.119458-05:00 freenas.local usbhid-ups 42965 - - Got disconnected by another driver: Device busy
Dec 31 02:55:39 freenas 1 2023-12-31T02:55:39.788942-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 02:58:50 freenas 1 2023-12-31T02:58:50.262063-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 02:58:52 freenas 1 2023-12-31T02:58:52.295556-05:00 freenas.local usbhid-ups 42965 - - libusb_get_string: Unknown error
Dec 31 02:59:24 freenas 1 2023-12-31T02:59:24.742156-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:02:04 freenas 1 2023-12-31T03:02:04.668273-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:04:12 freenas 1 2023-12-31T03:04:12.497979-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:04:45 freenas 1 2023-12-31T03:04:45.116686-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:07:25 freenas 1 2023-12-31T03:07:25.309728-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:09:02 freenas 1 2023-12-31T03:09:02.599269-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:09:09 freenas 1 2023-12-31T03:09:09.573195-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:09:41 freenas 1 2023-12-31T03:09:41.801075-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:12:12 freenas 1 2023-12-31T03:12:12.195701-05:00 freenas.local smartd 1626 - - Device: /dev/ada0, SMART Usage Attribute: 194 Temperature_Celsius changed from 214 to 222
Dec 31 03:12:12 freenas 1 2023-12-31T03:12:12.202802-05:00 freenas.local smartd 1626 - - Device: /dev/ada0, SMART Usage Attribute: 194 Temperature_Celsius changed from 214 to 222
Dec 31 03:12:12 freenas 1 2023-12-31T03:12:12.209405-05:00 freenas.local smartd 1626 - - Device: /dev/ada1, SMART Usage Attribute: 194 Temperature_Celsius changed from 214 to 222
Dec 31 03:12:12 freenas 1 2023-12-31T03:12:12.215411-05:00 freenas.local smartd 1626 - - Device: /dev/ada1, SMART Usage Attribute: 194 Temperature_Celsius changed from 214 to 222
Dec 31 03:12:12 freenas 1 2023-12-31T03:12:12.232299-05:00 freenas.local smartd 1626 - - Device: /dev/ada4, SMART Usage Attribute: 194 Temperature_Celsius changed from 214 to 222
Dec 31 03:12:12 freenas 1 2023-12-31T03:12:12.238008-05:00 freenas.local smartd 1626 - - Device: /dev/ada4, SMART Usage Attribute: 194 Temperature_Celsius changed from 214 to 222
Dec 31 03:14:30 freenas 1 2023-12-31T03:14:30.633146-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:16:11 freenas 1 2023-12-31T03:16:11.229147-05:00 freenas.local usbhid-ups 42965 - - libusb_get_string: Unknown error
Dec 31 03:16:42 freenas 1 2023-12-31T03:16:42.958216-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:17:18 freenas 1 2023-12-31T03:17:18.438886-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:23:10 freenas 1 2023-12-31T03:23:10.742110-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:23:26 freenas 1 2023-12-31T03:23:26.926336-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:26:18 freenas 1 2023-12-31T03:26:18.227758-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:36:52 freenas 1 2023-12-31T03:36:52.549189-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:37:25 freenas 1 2023-12-31T03:37:25.332246-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:40:37 freenas 1 2023-12-31T03:40:37.004012-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:42:12 freenas 1 2023-12-31T03:42:12.413914-05:00 freenas.local smartd 1626 - - Device: /dev/ada4, SMART Usage Attribute: 194 Temperature_Celsius changed from 222 to 214
Dec 31 03:42:12 freenas 1 2023-12-31T03:42:12.419378-05:00 freenas.local smartd 1626 - - Device: /dev/ada4, SMART Usage Attribute: 194 Temperature_Celsius changed from 222 to 214
Dec 31 03:46:56 freenas 1 2023-12-31T03:46:56.996347-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:46:59 freenas 1 2023-12-31T03:46:59.084533-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:49:01 freenas 1 2023-12-31T03:49:01.958035-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:53:20 freenas 1 2023-12-31T03:53:20.868829-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 03:57:33 freenas 1 2023-12-31T03:57:33.954838-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 04:00:48 freenas 1 2023-12-31T04:00:48.219079-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 04:09:13 freenas 1 2023-12-31T04:09:13.496783-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 04:12:12 freenas 1 2023-12-31T04:12:12.545267-05:00 freenas.local smartd 1626 - - Device: /dev/ada5, SMART Usage Attribute: 194 Temperature_Celsius changed from 222 to 230
Dec 31 04:12:12 freenas 1 2023-12-31T04:12:12.551102-05:00 freenas.local smartd 1626 - - Device: /dev/ada5, SMART Usage Attribute: 194 Temperature_Celsius changed from 222 to 230
Dec 31 04:12:12 freenas 1 2023-12-31T04:12:12.557103-05:00 freenas.local smartd 1626 - - Device: /dev/ada6, SMART Usage Attribute: 194 Temperature_Celsius changed from 222 to 230
Dec 31 04:12:12 freenas 1 2023-12-31T04:12:12.562852-05:00 freenas.local smartd 1626 - - Device: /dev/ada6, SMART Usage Attribute: 194 Temperature_Celsius changed from 222 to 230
Dec 31 04:12:24 freenas 1 2023-12-31T04:12:24.764000-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 04:15:03 freenas 1 2023-12-31T04:15:03.094725-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 04:15:42 freenas 1 2023-12-31T04:15:42.491966-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 04:19:27 freenas 1 2023-12-31T04:19:27.053687-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 04:21:02 freenas 1 2023-12-31T04:21:02.926511-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 04:27:53 freenas 1 2023-12-31T04:27:53.906000-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 04:28:26 freenas 1 2023-12-31T04:28:26.197590-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 04:31:37 freenas 1 2023-12-31T04:31:37.439458-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 04:35:19 freenas 1 2023-12-31T04:35:19.106369-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 04:42:12 freenas 1 2023-12-31T04:42:12.661810-05:00 freenas.local smartd 1626 - - Device: /dev/ada2, SMART Usage Attribute: 194 Temperature_Celsius changed from 214 to 222
Dec 31 04:42:12 freenas 1 2023-12-31T04:42:12.667570-05:00 freenas.local smartd 1626 - - Device: /dev/ada2, SMART Usage Attribute: 194 Temperature_Celsius changed from 214 to 222
Dec 31 04:52:45 freenas 1 2023-12-31T04:52:45.185774-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 04:55:55 freenas 1 2023-12-31T04:55:55.918234-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 04:56:28 freenas 1 2023-12-31T04:56:28.249653-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 05:01:15 freenas 1 2023-12-31T05:01:15.039661-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 05:01:49 freenas 1 2023-12-31T05:01:49.529333-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 05:03:59 freenas 1 2023-12-31T05:03:59.019716-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 05:12:12 freenas 1 2023-12-31T05:12:12.879205-05:00 freenas.local smartd 1626 - - Device: /dev/ada0, starting scheduled Short Self-Test.
Dec 31 05:12:12 freenas 1 2023-12-31T05:12:12.883439-05:00 freenas.local smartd 1626 - - Device: /dev/ada0, self-test in progress, 90% remaining
Dec 31 05:12:13 freenas 1 2023-12-31T05:12:13.069784-05:00 freenas.local smartd 1626 - - Device: /dev/ada1, starting scheduled Short Self-Test.
Dec 31 05:12:13 freenas 1 2023-12-31T05:12:13.075083-05:00 freenas.local smartd 1626 - - Device: /dev/ada1, self-test in progress, 90% remaining
Dec 31 05:12:13 freenas 1 2023-12-31T05:12:13.267996-05:00 freenas.local smartd 1626 - - Device: /dev/ada2, starting scheduled Short Self-Test.
Dec 31 05:12:13 freenas 1 2023-12-31T05:12:13.272178-05:00 freenas.local smartd 1626 - - Device: /dev/ada2, self-test in progress, 90% remaining
Dec 31 05:12:13 freenas 1 2023-12-31T05:12:13.462671-05:00 freenas.local smartd 1626 - - Device: /dev/ada4, starting scheduled Short Self-Test.
Dec 31 05:12:13 freenas 1 2023-12-31T05:12:13.467079-05:00 freenas.local smartd 1626 - - Device: /dev/ada4, self-test in progress, 90% remaining
Dec 31 05:12:13 freenas 1 2023-12-31T05:12:13.648312-05:00 freenas.local smartd 1626 - - Device: /dev/ada5, starting scheduled Short Self-Test.
Dec 31 05:12:13 freenas 1 2023-12-31T05:12:13.652538-05:00 freenas.local smartd 1626 - - Device: /dev/ada5, self-test in progress, 90% remaining
Dec 31 05:12:13 freenas 1 2023-12-31T05:12:13.836572-05:00 freenas.local smartd 1626 - - Device: /dev/ada6, starting scheduled Short Self-Test.
Dec 31 05:12:13 freenas 1 2023-12-31T05:12:13.841572-05:00 freenas.local smartd 1626 - - Device: /dev/ada6, self-test in progress, 90% remaining
Dec 31 05:12:14 freenas 1 2023-12-31T05:12:14.038443-05:00 freenas.local smartd 1626 - - Device: /dev/ada7, starting scheduled Short Self-Test.
Dec 31 05:12:14 freenas 1 2023-12-31T05:12:14.042630-05:00 freenas.local smartd 1626 - - Device: /dev/ada7, self-test in progress, 90% remaining
Dec 31 05:17:39 freenas 1 2023-12-31T05:17:39.862080-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 05:18:44 freenas 1 2023-12-31T05:18:44.881210-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 05:20:52 freenas 1 2023-12-31T05:20:52.793837-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 05:28:17 freenas 1 2023-12-31T05:28:17.314925-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 05:28:19 freenas 1 2023-12-31T05:28:19.341076-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 05:37:16 freenas 1 2023-12-31T05:37:16.623944-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 05:42:12 freenas 1 2023-12-31T05:42:12.194088-05:00 freenas.local smartd 1626 - - Device: /dev/ada0, previous self-test completed without error
Dec 31 05:42:12 freenas 1 2023-12-31T05:42:12.199699-05:00 freenas.local smartd 1626 - - Device: /dev/ada0, previous self-test completed without error
Dec 31 05:42:12 freenas 1 2023-12-31T05:42:12.205896-05:00 freenas.local smartd 1626 - - Device: /dev/ada1, previous self-test completed without error
Dec 31 05:42:12 freenas 1 2023-12-31T05:42:12.211545-05:00 freenas.local smartd 1626 - - Device: /dev/ada1, previous self-test completed without error
Dec 31 05:42:12 freenas 1 2023-12-31T05:42:12.216546-05:00 freenas.local smartd 1626 - - Device: /dev/ada2, previous self-test completed without error
Dec 31 05:42:12 freenas 1 2023-12-31T05:42:12.221171-05:00 freenas.local smartd 1626 - - Device: /dev/ada2, previous self-test completed without error
Dec 31 05:42:12 freenas 1 2023-12-31T05:42:12.226602-05:00 freenas.local smartd 1626 - - Device: /dev/ada4, SMART Usage Attribute: 194 Temperature_Celsius changed from 214 to 222
Dec 31 05:42:12 freenas 1 2023-12-31T05:42:12.226661-05:00 freenas.local smartd 1626 - - Device: /dev/ada4, previous self-test completed without error
Dec 31 05:42:12 freenas 1 2023-12-31T05:42:12.232633-05:00 freenas.local smartd 1626 - - Device: /dev/ada4, SMART Usage Attribute: 194 Temperature_Celsius changed from 214 to 222
Dec 31 05:42:12 freenas 1 2023-12-31T05:42:12.232681-05:00 freenas.local smartd 1626 - - Device: /dev/ada4, previous self-test completed without error
Dec 31 05:42:12 freenas 1 2023-12-31T05:42:12.240647-05:00 freenas.local smartd 1626 - - Device: /dev/ada5, previous self-test completed without error
Dec 31 05:42:12 freenas 1 2023-12-31T05:42:12.247027-05:00 freenas.local smartd 1626 - - Device: /dev/ada5, previous self-test completed without error
Dec 31 05:42:12 freenas 1 2023-12-31T05:42:12.252782-05:00 freenas.local smartd 1626 - - Device: /dev/ada6, previous self-test completed without error
Dec 31 05:42:12 freenas 1 2023-12-31T05:42:12.258049-05:00 freenas.local smartd 1626 - - Device: /dev/ada6, previous self-test completed without error
Dec 31 05:42:12 freenas 1 2023-12-31T05:42:12.263673-05:00 freenas.local smartd 1626 - - Device: /dev/ada7, SMART Usage Attribute: 194 Temperature_Celsius changed from 214 to 222
Dec 31 05:42:12 freenas 1 2023-12-31T05:42:12.263754-05:00 freenas.local smartd 1626 - - Device: /dev/ada7, previous self-test completed without error
Dec 31 05:42:12 freenas 1 2023-12-31T05:42:12.269476-05:00 freenas.local smartd 1626 - - Device: /dev/ada7, SMART Usage Attribute: 194 Temperature_Celsius changed from 214 to 222
Dec 31 05:42:12 freenas 1 2023-12-31T05:42:12.269563-05:00 freenas.local smartd 1626 - - Device: /dev/ada7, previous self-test completed without error
Dec 31 05:48:30 freenas 1 2023-12-31T05:48:30.100498-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 05:48:35 freenas 1 2023-12-31T05:48:35.169530-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 05:49:07 freenas 1 2023-12-31T05:49:07.771268-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 05:50:44 freenas 1 2023-12-31T05:50:44.723651-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 05:51:54 freenas 1 2023-12-31T05:51:54.485522-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 05:53:34 freenas 1 2023-12-31T05:53:34.838482-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 05:55:45 freenas 1 2023-12-31T05:55:45.793477-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 05:56:21 freenas 1 2023-12-31T05:56:21.577330-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 06:01:41 freenas 1 2023-12-31T06:01:41.649484-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 06:01:46 freenas 1 2023-12-31T06:01:46.683470-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 06:05:28 freenas 1 2023-12-31T06:05:28.960090-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 06:11:18 freenas 1 2023-12-31T06:11:18.821049-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 06:31:23 freenas 1 2023-12-31T06:31:23.064412-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 06:39:52 freenas 1 2023-12-31T06:39:52.188323-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 06:40:55 freenas 1 2023-12-31T06:40:55.123723-05:00 freenas.local usbhid-ups 42965 - - libusb_get_string: Unknown error
Dec 31 06:41:27 freenas 1 2023-12-31T06:41:27.559651-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 06:41:29 freenas 1 2023-12-31T06:41:29.662160-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 06:41:36 freenas 1 2023-12-31T06:41:36.637321-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 06:42:12 freenas 1 2023-12-31T06:42:12.455220-05:00 freenas.local smartd 1626 - - Device: /dev/ada4, SMART Usage Attribute: 194 Temperature_Celsius changed from 222 to 214
Dec 31 06:42:12 freenas 1 2023-12-31T06:42:12.461094-05:00 freenas.local smartd 1626 - - Device: /dev/ada4, SMART Usage Attribute: 194 Temperature_Celsius changed from 222 to 214
Dec 31 06:42:39 freenas 1 2023-12-31T06:42:39.517830-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 06:44:15 freenas 1 2023-12-31T06:44:15.047056-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 06:44:17 freenas 1 2023-12-31T06:44:17.064795-05:00 freenas.local usbhid-ups 42965 - - libusb_get_string: Unknown error
Dec 31 06:50:36 freenas 1 2023-12-31T06:50:36.793392-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 06:54:50 freenas 1 2023-12-31T06:54:50.891757-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 06:54:52 freenas 1 2023-12-31T06:54:52.930989-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 06:57:00 freenas 1 2023-12-31T06:57:00.675465-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 07:00:10 freenas 1 2023-12-31T07:00:10.893272-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 07:08:04 freenas 1 2023-12-31T07:08:04.472719-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 07:17:32 freenas 1 2023-12-31T07:17:32.724426-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 07:17:34 freenas 1 2023-12-31T07:17:34.762700-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 07:21:16 freenas 1 2023-12-31T07:21:16.088730-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 07:22:53 freenas 1 2023-12-31T07:22:53.703830-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 07:31:21 freenas 1 2023-12-31T07:31:21.492736-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 07:32:28 freenas 1 2023-12-31T07:32:28.395640-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 07:33:33 freenas 1 2023-12-31T07:33:33.265983-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 07:34:07 freenas 1 2023-12-31T07:34:07.679274-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 07:35:43 freenas 1 2023-12-31T07:35:43.140964-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 07:39:25 freenas 1 2023-12-31T07:39:25.416341-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error
Dec 31 07:46:48 freenas 1 2023-12-31T07:46:48.938145-05:00 freenas.local usbhid-ups 42965 - - libusb_get_report: Unknown error

The UPS LOG you asked for didnt exist

 

[joeschmuck]

So I would start to move the UPS USB connection to other ports and see if that makes a difference. This is where the "auto" setting comes in handy so you do not need to manually reconfigure the ports.

 

[bent98]

So I would start to move the UPS USB connection to other ports and see if that makes a difference. This is where the "auto" setting comes in handy so you do not need to manually reconfigure the ports.

will do

 

[joeschmuck]

One last thing... If you cannot isolate the problem, and you can't think of anything else to try, then I would highly recommend that you submit a jira ticket (GUI --> System --> Support).
1) You will need to create a Jira account first, very simple, takes a few minutes. ("Report a Bug" link at the top of the forum page)
2) Now go into the GUI and make sure you check the box marked "Attach Debug" as the developers will ask you for it anyway, it's just easier and faster to provide it up front.

 

[bent98]

Jez, this is turning into a mess. I couldn't isolate. I tried swapping with another UPS same brand a make.

Now, with UPS service turned off im getting this error emailed to me from Freenas server

NOTIFICATION: 'NOCOMM'
UPS: 'ups'
Statistics could not be recovered

I am also seeing this error on the console.

When I enable UPS service it gets this error