What does this error mean please?

[VladTepes]

This is a long code block, just to show you what has been happening and how regularly.
The initial stuff from Sept 6 would be, I presume, from when I powered up the box and did the upgrade to FreeNAS 11

You'll notice after that, each day including today (10 September) there are some errors that are still reporting.
particularly

I'd really appreciate if someone could tell me what the upshot of this is, and how I go about fixing / remedying the situation.

Thank You !

Code:

Sep  6 22:32:51 Remus est0: <Enhanced SpeedStep Frequency Control> on cpu0
Sep  6 22:32:51 Remus coretemp1: <CPU On-Die Thermal Sensors> on cpu1
Sep  6 22:32:51 Remus est1: <Enhanced SpeedStep Frequency Control> on cpu1
Sep  6 22:32:51 Remus coretemp2: <CPU On-Die Thermal Sensors> on cpu2
Sep  6 22:32:51 Remus est2: <Enhanced SpeedStep Frequency Control> on cpu2
Sep  6 22:32:51 Remus coretemp3: <CPU On-Die Thermal Sensors> on cpu3
Sep  6 22:32:51 Remus est3: <Enhanced SpeedStep Frequency Control> on cpu3
Sep  6 22:32:51 Remus ZFS filesystem version: 5
Sep  6 22:32:51 Remus ZFS storage pool version: features support (5000)
Sep  6 22:32:51 Remus Timecounters tick every 1.000 msec
Sep  6 22:32:51 Remus freenas_sysctl: adding account.
Sep  6 22:32:51 Remus freenas_sysctl: adding directoryservice.
Sep  6 22:32:51 Remus freenas_sysctl: adding middlewared.
Sep  6 22:32:51 Remus freenas_sysctl: adding network.
Sep  6 22:32:51 Remus freenas_sysctl: adding services.
Sep  6 22:32:51 Remus ipfw2 (+ipv6) initialized, divert enabled, nat enabled, default to accept, logging disabled
Sep  6 22:32:51 Remus nvme cam probe device init
Sep  6 22:32:51 Remus usbus0: 5.0Gbps Super Speed USB v3.0
Sep  6 22:32:51 Remus ugen0.1: <0x8086 XHCI root HUB> at usbus0
Sep  6 22:32:51 Remus uhub0: <0x8086 XHCI root HUB, class 9/0, rev 3.00/1.00, addr 1> on usbus0
Sep  6 22:32:51 Remus uhub0: 22 ports with 22 removable, self powered
Sep  6 22:32:51 Remus ugen0.2: <Microsoft Wired Keyboard 600> at usbus0
Sep  6 22:32:51 Remus ukbd0 on uhub0
Sep  6 22:32:51 Remus ukbd0: <Microsoft Wired Keyboard 600, class 0/0, rev 1.10/1.10, addr 1> on usbus0
Sep  6 22:32:51 Remus kbd0 at ukbd0
Sep  6 22:32:51 Remus ugen0.3: <vendor 0x0557 product 0x7000> at usbus0
Sep  6 22:32:51 Remus uhub1 on uhub0
Sep  6 22:32:51 Remus uhub1: <vendor 0x0557 product 0x7000, class 9/0, rev 2.00/0.00, addr 2> on usbus0
Sep  6 22:32:51 Remus uhub1: 4 ports with 3 removable, self powered
Sep  6 22:32:51 Remus ugen0.4: <vendor 0x0557 product 0x2419> at usbus0
Sep  6 22:32:51 Remus ukbd1 on uhub1
Sep  6 22:32:51 Remus ukbd1: <vendor 0x0557 product 0x2419, class 0/0, rev 1.10/1.00, addr 3> on usbus0
Sep  6 22:32:51 Remus kbd2 at ukbd1
Sep  6 22:32:51 Remus ada0 at ahcich1 bus 0 scbus1 target 0 lun 0
Sep  6 22:32:51 Remus ada0: <KINGSTON SUV400S37120G 0C3FD6SD> ACS-4 ATA SATA 3.x device
Sep  6 22:32:51 Remus ada0: Serial Number 50026B72640360A4
Sep  6 22:32:51 Remus ada0: 600.000MB/s transfers (SATA 3.x, UDMA6, PIO 8192bytes)
Sep  6 22:32:51 Remus ada0: Command Queueing enabled
Sep  6 22:32:51 Remus ada0: 114473MB (234441648 512 byte sectors)
Sep  6 22:32:51 Remus ada1 at ahcich4 bus 0 scbus4 target 0 lun 0
Sep  6 22:32:51 Remus ada1: <WDC WD30EFRX-68EUZN0 82.00A82> ACS-2 ATA SATA 3.x device
Sep  6 22:32:51 Remus ada1: Serial Number WD-WCC4N6FEUPEX
Sep  6 22:32:51 Remus ada1: 600.000MB/s transfers (SATA 3.x, UDMA6, PIO 8192bytes)
Sep  6 22:32:51 Remus ada1: Command Queueing enabled
Sep  6 22:32:51 Remus ada1: 2861588MB (5860533168 512 byte sectors)
Sep  6 22:32:51 Remus ada1: quirks=0x1<4K>
Sep  6 22:32:51 Remus ada2 at ahcich5 bus 0 scbus5 target 0 lun 0
Sep  6 22:32:51 Remus ada2: <WDC WD30EFRX-68EUZN0 82.00A82> ACS-2 ATA SATA 3.x device
Sep  6 22:32:51 Remus ada2: Serial Number WD-WCC4N2KVS36D
Sep  6 22:32:51 Remus ada2: 600.000MB/s transfers (SATA 3.x, UDMA6, PIO 8192bytes)
Sep  6 22:32:51 Remus ada2: Command Queueing enabled
Sep  6 22:32:51 Remus ada2: 2861588MB (5860533168 512 byte sectors)
Sep  6 22:32:51 Remus ada2: quirks=0x1<4K>
Sep  6 22:32:51 Remus ada3 at ahcich6 bus 0 scbus6 target 0 lun 0
Sep  6 22:32:51 Remus ada3: <WDC WD30EFRX-68EUZN0 82.00A82> ACS-2 ATA SATA 3.x device
Sep  6 22:32:51 Remus ada3: Serial Number WD-WCC4N4TKRL47
Sep  6 22:32:51 Remus ada3: 600.000MB/s transfers (SATA 3.x, UDMA6, PIO 8192bytes)
Sep  6 22:32:51 Remus ada3: Command Queueing enabled
Sep  6 22:32:51 Remus ada3: 2861588MB (5860533168 512 byte sectors)
Sep  6 22:32:51 Remus ada3: quirks=0x1<4K>
Sep  6 22:32:51 Remus ada4 at ahcich7 bus 0 scbus7 target 0 lun 0
Sep  6 22:32:51 Remus ada4: <WDC WD30EFRX-68AX9N0 80.00A80> ACS-2 ATA SATA 3.x device
Sep  6 22:32:51 Remus ada4: Serial Number WD-WMC1T3860035
Sep  6 22:32:51 Remus ada4: 600.000MB/s transfers (SATA 3.x, UDMA6, PIO 8192bytes)
Sep  6 22:32:51 Remus ada4: Command Queueing enabled
Sep  6 22:32:51 Remus ada4: 2861588MB (5860533168 512 byte sectors)
Sep  6 22:32:51 Remus ada4: quirks=0x1<4K>
Sep  6 22:32:51 Remus ada5 at ahcich8 bus 0 scbus8 target 0 lun 0
Sep  6 22:32:51 Remus ada5: <WDC WD30EFRX-68AX9N0 80.00A80> ACS-2 ATA SATA 3.x device
Sep  6 22:32:51 Remus ada5: Serial Number WD-WMC1T3796164
Sep  6 22:32:51 Remus ada5: 600.000MB/s transfers (SATA 3.x, UDMA6, PIO 8192bytes)
Sep  6 22:32:51 Remus ada5: Command Queueing enabled
Sep  6 22:32:51 Remus ada5: 2861588MB (5860533168 512 byte sectors)
Sep  6 22:32:51 Remus ada5: quirks=0x1<4K>
Sep  6 22:32:51 Remus ada6 at ahcich9 bus 0 scbus9 target 0 lun 0
Sep  6 22:32:51 Remus ada6: <WDC WD30EFRX-68AX9N0 80.00A80> ACS-2 ATA SATA 3.x device
Sep  6 22:32:51 Remus ada6: Serial Number WD-WMC1T3798899
Sep  6 22:32:51 Remus ada6: 600.000MB/s transfers (SATA 3.x, UDMA6, PIO 8192bytes)
Sep  6 22:32:51 Remus ada6: Command Queueing enabled
Sep  6 22:32:51 Remus ada6: 2861588MB (5860533168 512 byte sectors)
Sep  6 22:32:51 Remus ada6: quirks=0x1<4K>
Sep  6 22:32:51 Remus random: unblocking device.
Sep  6 22:32:51 Remus SMP: AP CPU #1 Launched!
Sep  6 22:32:51 Remus SMP: AP CPU #3 Launched!
Sep  6 22:32:51 Remus SMP: AP CPU #2 Launched!
Sep  6 22:32:51 Remus Timecounter "TSC-low" frequency 1848062188 Hz quality 1000
Sep  6 22:32:51 Remus Trying to mount root from zfs:freenas-boot/ROOT/11.0-U3 []...
Sep  6 22:32:51 Remus GEOM_RAID5: Module loaded, version 1.3.20140711.62 (rev f91e28e40bf7)
Sep  6 22:32:51 Remus ipmi0: <IPMI System Interface> port 0xca4,0xca5 on acpi0
Sep  6 22:32:51 Remus ipmi0: KCS mode found at io 0xca4 on acpi
Sep  6 22:32:51 Remus ipmi0: IPMI device rev. 1, firmware rev. 1.13, version 2.0
Sep  6 22:32:51 Remus ipmi0: Number of channels 2
Sep  6 22:32:51 Remus ipmi0: Attached watchdog
Sep  6 22:32:51 Remus 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>
Sep  6 22:32:51 Remus kernel: igb0: link state changed to UP
Sep  6 22:32:51 Remus kernel: igb0: link state changed to UP
Sep  6 22:32:51 Remus kernel: igb1: link state changed to UP
Sep  6 22:32:51 Remus kernel: igb1: link state changed to UP
Sep  6 22:32:51 Remus uhid0 on uhub0
Sep  6 22:32:51 Remus uhid0: <Microsoft Wired Keyboard 600, class 0/0, rev 1.10/1.10, addr 1> on usbus0
Sep  6 22:32:51 Remus ums0 on uhub1
Sep  6 22:32:51 Remus ums0: <vendor 0x0557 product 0x2419, class 0/0, rev 1.10/1.00, addr 3> on usbus0
Sep  6 22:32:51 Remus ums0: 3 buttons and [Z] coordinates ID=0
Sep  6 22:32:51 Remus GEOM_ELI: Device ada1p1.eli created.
Sep  6 22:32:51 Remus GEOM_ELI: Encryption: AES-XTS 128
Sep  6 22:32:51 Remus GEOM_ELI:	 Crypto: hardware
Sep  6 22:32:51 Remus GEOM_ELI: Device ada2p1.eli created.
Sep  6 22:32:51 Remus GEOM_ELI: Encryption: AES-XTS 128
Sep  6 22:32:51 Remus GEOM_ELI:	 Crypto: hardware
Sep  6 22:32:51 Remus GEOM_ELI: Device ada3p1.eli created.
Sep  6 22:32:51 Remus GEOM_ELI: Encryption: AES-XTS 128
Sep  6 22:32:51 Remus GEOM_ELI:	 Crypto: hardware
Sep  6 22:32:52 Remus GEOM_ELI: Device ada4p1.eli created.
Sep  6 22:32:52 Remus GEOM_ELI: Encryption: AES-XTS 128
Sep  6 22:32:52 Remus GEOM_ELI:	 Crypto: hardware
Sep  6 22:32:52 Remus GEOM_ELI: Device ada5p1.eli created.
Sep  6 22:32:52 Remus GEOM_ELI: Encryption: AES-XTS 128
Sep  6 22:32:52 Remus GEOM_ELI:	 Crypto: hardware
Sep  6 22:32:52 Remus GEOM_ELI: Device ada6p1.eli created.
Sep  6 22:32:52 Remus GEOM_ELI: Encryption: AES-XTS 128
Sep  6 22:32:52 Remus GEOM_ELI:	 Crypto: hardware
Sep  6 22:32:52 Remus ntpd[2049]: ntpd 4.2.8p10-a (1): Starting
Sep  6 22:32:54 Remus root: /etc/rc: WARNING: failed precmd routine for vmware_guestd
Sep  6 22:32:54 Remus smbd: dnssd_clientstub ConnectToServer: connect()-> No of tries: 1
Sep  6 22:32:55 Remus smbd: dnssd_clientstub ConnectToServer: connect()-> No of tries: 2
Sep  6 22:32:56 Remus smbd: dnssd_clientstub ConnectToServer: connect()-> No of tries: 3
Sep  6 22:32:57 Remus smbd: dnssd_clientstub ConnectToServer: connect() failed path:/var/run/mdnsd Socket:36 Err:-1 Errno:2 No such file or directory
Sep  6 22:32:58 Remus root: /etc/rc: WARNING: failed precmd routine for minio
Sep  6 22:33:02 Remus bridge0: Ethernet address: 02:23:3a:4d:a8:00
Sep  6 22:33:02 Remus kernel: bridge0: link state changed to UP
Sep  6 22:33:02 Remus kernel: bridge0: link state changed to UP
Sep  6 22:33:02 Remus kernel: igb0: promiscuous mode enabled
Sep  6 22:33:02 Remus epair0a: Ethernet address: 02:ff:e0:00:05:0a
Sep  6 22:33:02 Remus epair0b: Ethernet address: 02:ff:30:00:06:0b
Sep  6 22:33:02 Remus kernel: epair0a: link state changed to UP
Sep  6 22:33:02 Remus kernel: epair0a: link state changed to UP
Sep  6 22:33:02 Remus kernel: epair0b: link state changed to UP
Sep  6 22:33:02 Remus kernel: epair0b: link state changed to UP
Sep  6 22:33:02 Remus kernel: igb0: link state changed to DOWN
Sep  6 22:33:02 Remus kernel: igb0: link state changed to DOWN
Sep  6 22:33:02 Remus kernel: epair0a: promiscuous mode enabled
Sep  6 22:33:05 Remus kernel: igb0: link state changed to UP
Sep  6 22:33:05 Remus kernel: igb0: link state changed to UP
Sep  6 22:33:05 Remus dhclient: New IP Address (igb0): 192.168.178.3
Sep  6 22:33:05 Remus dhclient: New Subnet Mask (igb0): 255.255.255.0
Sep  6 22:33:05 Remus dhclient: New Broadcast Address (igb0): 192.168.178.255
Sep  6 22:33:05 Remus dhclient: New Routers (igb0): 192.168.178.1
Sep  6 22:52:41 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-0/cpu-system".
Sep  6 22:52:41 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Sep  6 23:20:41 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-2/cpu-user".
Sep  6 23:20:41 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Sep  6 23:42:31 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-0/cpu-user".
Sep  6 23:42:31 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
... 
Sep 10 00:00:00 Remus syslog-ng[1602]: Configuration reload request received, reloading configuration;
Sep 10 01:28:31 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-1/cpu-user".
Sep 10 01:28:31 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Sep 10 01:50:01 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-2/cpu-idle".
Sep 10 01:50:01 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Sep 10 02:32:21 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-2/cpu-idle".
Sep 10 02:32:21 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Sep 10 03:01:07 Remus /find_alias_for_smtplib.py: [common.system:293] Failed to send email: (535, b'5.7.8 Username and Password not accepted. Learn more at\n5.7.8  https://support.google.com/mail/?p=BadCredentials p88sm7360632pfi.174 - gsmtp')
Traceback (most recent call last):
  File "/usr/local/www/freenasUI/common/system.py", line 274, in send_mail
	server = _get_smtp_server(timeout, local_hostname=local_hostname)
  File "/usr/local/www/freenasUI/common/system.py", line 207, in _get_smtp_server
	server.login(em.em_user, em.em_pass)
  File "/usr/local/lib/python3.6/smtplib.py", line 729, in login
	raise last_exception
  File "/usr/local/lib/python3.6/smtplib.py", line 720, in login
	initial_response_ok=initial_response_ok)
  File "/usr/local/lib/python3.6/smtplib.py", line 641, in auth
	raise SMTPAuthenticationError(code, resp)
smtplib.SMTPAuthenticationError: (535, b'5.7.8 Username and Password not accepted. Learn more at\n5.7.8  https://support.google.com/mail/?p=Bad
Sep 10 03:01:07 Remus /find_alias_for_smtplib.py: Credentials p88sm7360632pfi.174 - gsmtp')
Sep 10 03:10:11 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-2/cpu-nice".
Sep 10 03:10:11 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Sep 10 04:17:31 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-3/cpu-system".
Sep 10 04:17:31 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Sep 10 05:00:51 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-1/cpu-user".
Sep 10 05:00:51 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Sep 10 05:51:41 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-0/cpu-user".
Sep 10 05:51:41 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Sep 10 06:27:41 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-0/cpu-user".
Sep 10 06:27:41 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Sep 10 09:19:31 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-0/cpu-user".
Sep 10 09:19:31 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Sep 10 09:34:31 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-0/cpu-idle".
Sep 10 09:34:31 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Sep 10 09:46:11 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-1/cpu-system".
Sep 10 09:46:11 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Sep 10 09:53:51 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-0/cpu-user".
Sep 10 09:53:51 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Sep 10 10:53:11 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-0/cpu-nice".
Sep 10 10:53:11 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Sep 10 12:00:31 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-0/cpu-user".
Sep 10 12:00:31 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Sep 10 12:11:01 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-3/cpu-user".
Sep 10 12:11:01 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Sep 10 13:03:01 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-0/cpu-system".
Sep 10 13:03:01 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Sep 10 13:50:11 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-2/cpu-idle".
Sep 10 13:50:11 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Sep 10 14:44:01 Remus collectd[3212]: aggregation plugin: Unable to read the current rate of "Remus.local/cpu-0/cpu-interrupt".
Sep 10 14:44:01 Remus collectd[3212]: utils_vl_lookup: The user object callback failed with status 2.
Stop refresh

 

[BigDave]

I believe it's related to this bug. I too have issues with this log spam.
They have this slated to be fixed in 11.1 version. Here's a link...

https://bugs.freenas.org/issues/23857

 

[VladTepes]

Thanks as long as its nothing to worry about - all good. Cheers