2.0.1 vm that was running previously on ESXi 5.0U1 with the
kern.timecounter.hardware=i8254 fix implemented in
GUI>System>Advanced>System Tunables. This fix is still implemented. Did
a fresh install of ESXi 5.1, now am getting the following sets of errors
in syslog. The only thing I changed between the previous setup and the
fresh install was a reconfig of the default ESXi 5.1 networking to match
the previous setup--the configuration is identical as far as I can tell.
Can't tell if the errors are related; some appear to be but maybe they
all are. Entries are from the GUI so they're listed topmost being the
more recent entry.
It's worth mentioning that aside from these errors in syslog, and the
last set of errors appearing only in the console window, pfsense appears
to work correctly--doing "date" in the shell reveals that the hardware
clock appears to be ticking normally. Figured the i8254 bug regression
in 5.0 was fixed in 5.1, so maybe removing the fix will resolve it, but
I thought I should see what everyone thinks first before I start
changing things. I am using Open-VM-tools 8.7.0.3046 (build-313025),
which is the same I was using before the fresh install.
Error set #1: Errors regarding ACPI CPU throttling during bootup: (These
might have been there before the reinstall, but I'm pretty sure they
weren't)
Sep 25 09:36:33 kernel: device_attach: acpi_throttle3 attach returned 6
Sep 25 09:36:33 kernel: acpi_throttle3: failed to attach P_CNT
Sep 25 09:36:33 kernel: acpi_throttle3: <ACPI CPU Throttling> on cpu3
Sep 25 09:36:33 kernel: device_attach: acpi_throttle2 attach returned 6
Sep 25 09:36:33 kernel: acpi_throttle2: failed to attach P_CNT
Sep 25 09:36:33 kernel: acpi_throttle2: <ACPI CPU Throttling> on cpu2
Sep 25 09:36:33 kernel: device_attach: acpi_throttle1 attach returned 6
Sep 25 09:36:33 kernel: acpi_throttle1: failed to attach P_CNT
Sep 25 09:36:33 kernel: acpi_throttle1: <ACPI CPU Throttling> on cpu1
Sep 25 09:36:33 kernel: acpi_throttle0: <ACPI CPU Throttling> on cpu0
Error set #2: Errors regarding routes during bootup: (I have no static
routes, this is communication between pfsense and the modem so I've
obscured my external IP address)
Sep 25 09:33:31 php: : ROUTING: setting default route to xxx.xxx.xxx.1
Sep 25 09:33:31 php: : The command 'route change -host xxx.xxx.xxx.1'
returned exit code '1', the output was 'route: writing to routing
socket: No such process route: writing to routing socket: Invalid
argument change host xxx.xxx.xxx.1: Invalid argument'
Sep 25 09:33:31 php: : The command 'route change -host xxx.xxx.xxx.1'
returned exit code '1', the output was 'route: writing to routing
socket: No such process route: writing to routing socket: Invalid
argument change host xxx.xxx.xxx.1: Invalid argument'
Sep 25 09:33:31 php: : rc.newwanip: on (IP address: xxx.xxx.xxx.62)
(interface: wan) (real interface: em1).
Sep 25 09:33:31 php: : rc.newwanip: Informational is starting em1.
Error set #3: Errors regarding timing during bootup:
Sep 25 09:33:35 php: : Creating rrd update script
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/system-memory.rrd N:U:U:U:U:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583707 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/system-processor.rrd
N:U:U:U:U:U' returned exit code '1', the output was 'ERROR: illegal
attempt to update using time 1348583615 when last update time is
1348583707 (minimum one second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/system-states.rrd N:U:U:U:U:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583706 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/ovpns4-vpnusers.rrd N:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583706 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/ovpns4-packets.rrd N:U:U:U:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583706 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/ovpns4-traffic.rrd N:U:U:U:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583706 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/ovpns5-vpnusers.rrd N:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583706 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/ovpns5-packets.rrd N:U:U:U:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583705 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/ovpns5-traffic.rrd N:U:U:U:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583705 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/ovpns3-vpnusers.rrd N:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583705 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/ovpns3-packets.rrd N:U:U:U:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583705 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/ovpns3-traffic.rrd N:U:U:U:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583705 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/ovpns2-vpnusers.rrd N:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583705 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/ovpns2-packets.rrd N:U:U:U:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583704 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/ovpns2-traffic.rrd N:U:U:U:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583704 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/ovpns1-vpnusers.rrd N:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583704 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/ovpns1-packets.rrd N:U:U:U:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583704 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/ovpns1-traffic.rrd N:U:U:U:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583704 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/ipsec-packets.rrd N:U:U:U:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583704 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/ipsec-traffic.rrd N:U:U:U:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583704 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/lan-packets.rrd N:U:U:U:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583704 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/lan-traffic.rrd N:U:U:U:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583704 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/wan-packets.rrd N:U:U:U:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583704 (minimum one
second step)'
Sep 25 09:33:35 php: : The command '/usr/bin/nice -n20
/usr/local/bin/rrdtool update /var/db/rrd/wan-traffic.rrd N:U:U:U:U'
returned exit code '1', the output was 'ERROR: illegal attempt to update
using time 1348583615 when last update time is 1348583704 (minimum one
second step)'
Sep 25 09:33:33 check_reload_status: Restarting ipsec tunnels
Error set #4: Errors regarding "runtime went backwards" (these errors do
not appear in syslog, they appear in the console window. I think they
might only occur when I'm using the GUI):
calcru: runtime went backwards from 34650 usec to 34236 useg for pid
62944 (login)
calcru: runtime went backwards from 543 usec to 536 usec for pid 61178
(minicron)
calcru: runtime went backwards from 19029 usec to 18802 usec for pid
19656 (apinger)
calcru: runtime went backwards from 562 usec to 556 usec for pid 62431
(dhcpleases)
calcru: runtime went backwards from 27798 usec to 27466 usec for pid
53993 (php)
calcru: runtime went backwards from 36060 usec to 35629 usec for pid
49825 (php)
calcru: runtime went backwards from 2138 usec to 2113 usec for pid 31618
(inetd)
calcru: runtime went backwards from 516 usec to 510 usec for pid 7957
(dhclient)
calcru: runtime went backwards from 24745 usec to 24450 usec for pid
7957 (dhclient)
calcru: runtime went backwards from 3018 usec to 2982 usec for pid 257
(check_reload_status)
calcru: runtime went backwards from 3749 usec to 3711 usec for pid 43901
(cron)
calcru: runtime went backwards from 222 usec to 219 usec for pid 52586 (php)
calcru: runtime went backwards from 236 usec to 233 usec for pid 259
(check_reload_status)
_______________________________________________
List mailing list
[email protected]
http://lists.pfsense.org/mailman/listinfo/list
