Upgrade to 2.2.3 with 46 days uptime



  • Nothing magic or odd or even interesting about my system or setup.

    Core 2 duo 2G
    2G RAM
    2x Intel NICs
    a HDD

    1 WAN (PPPoE)
    1 LAN

    Internal network does DNS & DHCP (So PFSense does't do them)

    Squid 3 0.2.8
    SquidGuard (Since removed I wasn't using it and it was disabled)
    Postfix Forwarder

    Squid didn't reinstall right.  It wasn't listed in the sevices pull down menu until I did a package reinstall.

    It's all working OK now.

    A 2nd restart and the uptime went to the correct figure.


  • Netgate Administrator

    How does the uptime come into play here? You mean it didn't restart correctly?

    What version did you upgrade from?

    Steve


  • LAYER 8 Global Moderator

    your saying your machine actually restarted and still showed a 46 day up time, until you rebooted again??



  • If it is showing 46 days of up time still, check if the value is increasing. Maybe it's being cached.



  • I did the auto upgrade from 2.2.2 x64 to 2.2.3 x64.  Came back and it was saying 2.2.3 and 46 days uptime.  I took a snip.
    It looks like (Sorry for the redirection to a 3rd part site but I couldn't get it to embed nicely)
    https://onedrive.live.com/redir?resid=D9C7768F1F32762B!6912&authkey=!AJtgULhQbMBrcJg&v=3&ithint=photo%2cJPG

    The timer was increasing.  I could access other pages of the web interface, and that has how I rebooted it.



  • The System Widget on the dashboard gets the pfSense version by just reading whatever text is in /etc/version
    On a full install, after putting all the upgraded files in place and before rebooting, /etc/version is going to say the new version but the system uptime reported by the OS is going to be however long the "old" ystem has been up.
    It all points to the system not auto-rebooting for some reason after applying the upgrade.


  • Netgate Administrator

    Yep, ^that.
    Coming from 2.2.X I've not seen that happen. Unless you accidentally switch from 32 to 64bit but you say specifically that was not the case here.
    Anything is the upgrade logs in /conf?

    Steve



  • Pretend I'm a dopey Windows admin guy (Shouldn't be hard, it's true)
    @stephenw10:

    Anything is the upgrade logs in /conf?

    Steve

    How do I check this out?  Or is it below?  Any other log files anyone would like to look at?

    I did manage to find out how to get to the system log entries, back to prior to the upgrade process.
    I would have started the upgrade process, sometime around 17:30.  And I just did the auto upgrade process.

    Uneditted , it looks like

    
    Jun 24 21:13:55 	lighttpd[22743]: (connections.c.137) (warning) close: 13 Connection reset by peer
    Jun 24 21:14:43 	lighttpd[22743]: (connections.c.137) (warning) close: 17 Connection reset by peer
    Jun 25 21:21:16 	php-fpm[31366]: /index.php: Successful login for user 'admin' from: 192.168.10.25
    Jun 25 21:21:16 	php-fpm[31366]: /index.php: Successful login for user 'admin' from: 192.168.10.25
    Jun 26 13:58:57 	check_reload_status: updating dyndns WAN_PPPOE
    Jun 26 13:58:57 	check_reload_status: Restarting ipsec tunnels
    Jun 26 13:58:57 	check_reload_status: Restarting OpenVPN tunnels/interfaces
    Jun 26 13:58:57 	check_reload_status: Reloading filter
    Jun 26 13:59:02 	php-fpm[76653]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (lan).
    Jun 26 13:59:02 	php-fpm[76653]: /rc.filter_configure_sync: Could not find IPv6 gateway for interface (lan).
    Jun 26 13:59:27 	check_reload_status: updating dyndns WAN_PPPOE
    Jun 26 13:59:27 	check_reload_status: Restarting ipsec tunnels
    Jun 26 13:59:27 	check_reload_status: Restarting OpenVPN tunnels/interfaces
    Jun 26 13:59:27 	check_reload_status: Reloading filter
    Jun 26 13:59:29 	php-fpm[76653]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (lan).
    Jun 26 13:59:29 	php-fpm[76653]: /rc.filter_configure_sync: Could not find IPv6 gateway for interface (lan).
    Jun 26 17:53:40 	php-fpm[10966]: /index.php: Successful login for user 'admin' from: 192.168.10.25
    Jun 26 17:53:40 	php-fpm[10966]: /index.php: Successful login for user 'admin' from: 192.168.10.25
    Jun 26 18:08:26 	check_reload_status: check_reload_status is starting.
    Jun 26 18:08:44 	shutdown: reboot by root:
    Jun 26 18:08:44 	shutdown: reboot by root:
    Jun 26 18:16:09 	php-fpm[19855]: /index.php: Successful login for user 'admin' from: 192.168.10.25
    Jun 26 18:16:09 	php-fpm[19855]: /index.php: Successful login for user 'admin' from: 192.168.10.25
    Jun 26 18:16:23 	check_reload_status: Syncing firewall
    Jun 26 18:16:36 	check_reload_status: Syncing firewall
    Jun 26 18:16:37 	check_reload_status: Syncing firewall
    Jun 26 18:16:37 	check_reload_status: Reloading filter
    Jun 26 18:16:38 	kernel: pid 69881 (squid), uid 62: exited on signal 6
    Jun 26 18:16:38 	php-fpm[22628]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan).
    Jun 26 18:16:38 	php-fpm[22628]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan).
    Jun 26 18:16:38 	php-fpm[22628]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (lan).
    Jun 26 18:16:38 	php-fpm[22628]: /rc.filter_configure_sync: Could not find IPv6 gateway for interface (lan).
    Jun 26 18:16:39 	php-fpm[22305]: /pkg_mgr_install.php: Beginning package installation for squid3 .
    Jun 26 18:16:42 	check_reload_status: Syncing firewall
    Jun 26 18:17:48 	check_reload_status: Syncing firewall
    Jun 26 18:17:52 	php-fpm[22305]: /pkg_mgr_install.php: Stopping any running proxy monitors
    Jun 26 18:17:53 	php-fpm[22305]: /pkg_mgr_install.php: Reloading Squid for configuration sync
    Jun 26 18:17:53 	php-fpm[22305]: /pkg_mgr_install.php: Starting a proxy monitor script
    Jun 26 18:17:53 	check_reload_status: Reloading filter
    Jun 26 18:17:53 	php-fpm[22305]: /pkg_mgr_install.php: [Squid] - Squid_resync function call pr:1 bp: rpc:no
    Jun 26 18:17:55 	php-fpm[92440]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan).
    Jun 26 18:17:55 	php-fpm[92440]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan).
    Jun 26 18:17:55 	php-fpm[92440]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (lan).
    Jun 26 18:17:55 	php-fpm[92440]: /rc.filter_configure_sync: Could not find IPv6 gateway for interface (lan).
    Jun 26 18:17:57 	check_reload_status: Syncing firewall
    Jun 26 18:38:49 	kernel: em0: Watchdog timeout -- resetting
    Jun 26 18:38:49 	kernel: em0: link state changed to DOWN
    Jun 26 18:38:50 	check_reload_status: Linkup starting em0
    Jun 26 18:38:51 	php-fpm[27068]: /rc.linkup: DEVD Ethernet detached event for lan
    Jun 26 18:38:52 	check_reload_status: Linkup starting em0
    Jun 26 18:38:52 	kernel: em0: link state changed to UP
    Jun 26 18:38:54 	php-fpm[17542]: /rc.linkup: DEVD Ethernet attached event for lan
    Jun 26 18:38:54 	php-fpm[17542]: /rc.linkup: HOTPLUG: Configuring interface lan
    Jun 26 18:38:54 	php-fpm[17542]: /rc.linkup: Accept router advertisements on interface em0
    Jun 26 18:38:54 	check_reload_status: Restarting ipsec tunnels
    Jun 26 18:38:56 	php-fpm[17542]: /rc.linkup: The command '/usr/local/sbin/unbound -c /var/unbound/unbound.conf' returned exit code '1', the output was '[1435307936] unbound[20835:0] error: bind: address already in use [1435307936] unbound[20835:0] fatal error: could not open ports'
    Jun 26 18:38:57 	check_reload_status: updating dyndns lan
    Jun 26 18:39:50 	lighttpd[22743]: (connections.c.137) (warning) close: 13 Connection reset by peer
    Jun 26 18:44:08 	check_reload_status: Syncing firewall
    Jun 26 18:44:21 	check_reload_status: Syncing firewall
    Jun 26 18:44:21 	php-fpm[96148]: /pkg_mgr_install.php: [Squid] - Squid_resync function call pr:1 bp: rpc:no
    Jun 26 18:46:24 	php-fpm[39537]: /reboot.php: Stopping all packages.
    Jun 26 18:46:27 	shutdown: reboot by root:
    Jun 26 18:46:27 	shutdown: reboot by root:
    Jun 26 18:46:27 	syslogd: exiting on signal 15
    Jun 26 18:47:42 	syslogd: kernel boot file is /boot/kernel/kernel
    Jun 26 18:47:42 	kernel: Copyright (c) 1992-2014 The FreeBSD Project.
    Jun 26 18:47:42 	kernel: Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
    Jun 26 18:47:42 	kernel: The Regents of the University of California. All rights reserved.
    Jun 26 18:47:42 	kernel: FreeBSD is a registered trademark of The FreeBSD Foundation.
    Jun 26 18:47:42 	kernel: FreeBSD 10.1-RELEASE-p13 #0 c77d1b2(releng/10.1)-dirty: Tue Jun 23 17:00:47 CDT 2015
    Jun 26 18:47:42 	kernel: root@pfs22-amd64-builder:/usr/obj.amd64/usr/pfSensesrc/src/sys/pfSense_SMP.10 amd64
    Jun 26 18:47:42 	kernel: FreeBSD clang version 3.4.1 (tags/RELEASE_34/dot1-final 208032) 20140512
    Jun 26 18:47:42 	kernel: CPU: Intel(R) Core(TM)2 CPU 4400 @ 2.00GHz (1995.04-MHz K8-class CPU)
    Jun 26 18:47:42 	kernel: Origin = "GenuineIntel" Id = 0x6f2 Family = 0x6 Model = 0xf Stepping = 2
    Jun 26 18:47:42 	kernel: 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>Jun 26 18:47:42 	kernel: Features2=0xe39d <sse3,dtes64,mon,ds_cpl,est,tm2,ssse3,cx16,xtpr,pdcm>Jun 26 18:47:42 	kernel: AMD Features=0x20100800 <syscall,nx,lm>Jun 26 18:47:42 	kernel: AMD Features2=0x1 <lahf>Jun 26 18:47:42 	kernel: TSC: P-state invariant, performance statistics
    Jun 26 18:47:42 	kernel: real memory = 1073741824 (1024 MB)
    Jun 26 18:47:42 	kernel: avail memory = 988815360 (943 MB)
    Jun 26 18:47:42 	kernel: Event timer "LAPIC" quality 400
    Jun 26 18:47:42 	kernel: ACPI APIC Table: <intel d945gcr="">
    Jun 26 18:47:42 	kernel: FreeBSD/SMP: Multiprocessor System Detected: 2 CPUs
    Jun 26 18:47:42 	kernel: FreeBSD/SMP: 1 package(s) x 2 core(s)
    Jun 26 18:47:42 	kernel: cpu0 (BSP): APIC ID: 0
    Jun 26 18:47:42 	kernel: cpu1 (AP): APIC ID: 1
    Jun 26 18:47:42 	kernel: ioapic0: Changing APIC ID to 2
    Jun 26 18:47:42 	kernel: ioapic0 <version 2.0=""> irqs 0-23 on motherboard
    Jun 26 18:47:42 	kernel: iwi_bss: You need to read the LICENSE file in /usr/share/doc/legal/intel_iwi/.
    Jun 26 18:47:42 	kernel: iwi_bss: If you agree with the license, set legal.intel_iwi.license_ack=1 in /boot/loader.conf.
    Jun 26 18:47:42 	kernel: module_register_init: MOD_LOAD (iwi_bss_fw, 0xffffffff806345e0, 0) error 1
    Jun 26 18:47:42 	kernel: iwi_ibss: You need to read the LICENSE file in /usr/share/doc/legal/intel_iwi/.
    Jun 26 18:47:42 	kernel: iwi_ibss: If you agree with the license, set legal.intel_iwi.license_ack=1 in /boot/loader.conf.
    Jun 26 18:47:42 	kernel: module_register_init: MOD_LOAD (iwi_ibss_fw, 0xffffffff80634690, 0) error 1
    Jun 26 18:47:42 	kernel: iwi_monitor: You need to read the LICENSE file in /usr/share/doc/legal/intel_iwi/.
    Jun 26 18:47:42 	kernel: iwi_monitor: If you agree with the license, set legal.intel_iwi.license_ack=1 in /boot/loader.conf.
    Jun 26 18:47:42 	kernel: module_register_init: MOD_LOAD (iwi_monitor_fw, 0xffffffff80634740, 0) error 1
    Jun 26 18:47:42 	kernel: wlan: mac acl policy registered
    Jun 26 18:47:42 	kernel: ipw_bss: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/.
    Jun 26 18:47:42 	kernel: ipw_bss: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf.
    Jun 26 18:47:42 	kernel: module_register_init: MOD_LOAD (ipw_bss_fw, 0xffffffff8060ce10, 0) error 1
    Jun 26 18:47:42 	kernel: ipw_ibss: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/.
    Jun 26 18:47:42 	kernel: ipw_ibss: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf.
    Jun 26 18:47:42 	kernel: module_register_init: MOD_LOAD (ipw_ibss_fw, 0xffffffff8060cec0, 0) error 1
    Jun 26 18:47:42 	kernel: ipw_monitor: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/.
    Jun 26 18:47:42 	kernel: ipw_monitor: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf.
    Jun 26 18:47:42 	kernel: module_register_init: MOD_LOAD (ipw_monitor_fw, 0xffffffff8060cf70, 0) error 1
    Jun 26 18:47:42 	kernel: random: <software, yarrow=""> initialized
    Jun 26 18:47:42 	kernel: kbd1 at kbdmux0
    Jun 26 18:47:42 	kernel: cryptosoft0: <software crypto=""> on motherboard
    Jun 26 18:47:42 	kernel: padlock0: No ACE support.
    Jun 26 18:47:42 	kernel: acpi0: <intel d945gcr=""> on motherboard
    Jun 26 18:47:42 	kernel: acpi0: Power Button (fixed)
    Jun 26 18:47:42 	kernel: cpu0: <acpi cpu=""> on acpi0
    Jun 26 18:47:42 	kernel: cpu1: <acpi cpu=""> on acpi0
    Jun 26 18:47:42 	kernel: atrtc0: <at realtime="" clock=""> port 0x70-0x71,0x74-0x77 irq 8 on acpi0
    Jun 26 18:47:42 	kernel: Event timer "RTC" frequency 32768 Hz quality 0
    Jun 26 18:47:42 	kernel: attimer0: <at timer=""> port 0x40-0x43,0x50-0x53 irq 0 on acpi0
    Jun 26 18:47:42 	kernel: Timecounter "i8254" frequency 1193182 Hz quality 0
    Jun 26 18:47:42 	kernel: Event timer "i8254" frequency 1193182 Hz quality 100
    Jun 26 18:47:42 	kernel: hpet0: <high precision="" event="" timer=""> iomem 0xfed00000-0xfed003ff on acpi0
    Jun 26 18:47:42 	kernel: Timecounter "HPET" frequency 14318180 Hz quality 950
    Jun 26 18:47:42 	kernel: Event timer "HPET" frequency 14318180 Hz quality 450
    Jun 26 18:47:42 	kernel: Event timer "HPET1" frequency 14318180 Hz quality 440
    Jun 26 18:47:42 	kernel: Event timer "HPET2" frequency 14318180 Hz quality 440
    Jun 26 18:47:42 	kernel: Timecounter "ACPI-fast" frequency 3579545 Hz quality 900
    Jun 26 18:47:42 	kernel: acpi_timer0: <24-bit timer at 3.579545MHz> port 0x408-0x40b on acpi0
    Jun 26 18:47:42 	kernel: acpi_button0: <sleep button=""> on acpi0
    Jun 26 18:47:42 	kernel: pcib0: <acpi host-pci="" bridge=""> port 0xcf8-0xcff on acpi0
    Jun 26 18:47:42 	kernel: pcib0: Length mismatch for 3 range: 6c00000 vs 6bfffff
    Jun 26 18:47:42 	kernel: pcib0: Length mismatch for 3 range: b0000001 vs b0000000
    Jun 26 18:47:42 	kernel: pci0: <acpi pci="" bus=""> on pcib0
    Jun 26 18:47:42 	kernel: vgapci0: <vga-compatible display=""> port 0x20e0-0x20e7 mem 0x50100000-0x5017ffff,0x40000000-0x4fffffff,0x50180000-0x501bffff irq 16 at device 2.0 on pci0
    Jun 26 18:47:42 	kernel: agp0: <intel 82945g="" (945g="" gmch)="" svga="" controller=""> on vgapci0
    Jun 26 18:47:42 	kernel: agp0: aperture size is 256M, detected 7932k stolen memory
    Jun 26 18:47:42 	kernel: vgapci0: Boot video device
    Jun 26 18:47:42 	kernel: pcib1: <acpi pci-pci="" bridge=""> at device 28.0 on pci0
    Jun 26 18:47:42 	kernel: pci1: <acpi pci="" bus=""> on pcib1
    Jun 26 18:47:42 	kernel: pcib2: <acpi pci-pci="" bridge=""> at device 28.1 on pci0
    Jun 26 18:47:42 	kernel: pci2: <acpi pci="" bus=""> on pcib2
    Jun 26 18:47:43 	kernel: pcib3: <acpi pci-pci="" bridge=""> at device 28.2 on pci0
    Jun 26 18:47:43 	kernel: pci3: <acpi pci="" bus=""> on pcib3
    Jun 26 18:47:43 	kernel: pcib4: <acpi pci-pci="" bridge=""> at device 28.3 on pci0
    Jun 26 18:47:43 	kernel: pci4: <acpi pci="" bus=""> on pcib4
    Jun 26 18:47:43 	kernel: uhci0: <intel 82801g="" (ich7)="" usb="" controller="" usb-a=""> port 0x2080-0x209f irq 23 at device 29.0 on pci0
    Jun 26 18:47:43 	kernel: usbus0 on uhci0
    Jun 26 18:47:43 	kernel: uhci1: <intel 82801g="" (ich7)="" usb="" controller="" usb-b=""> port 0x2060-0x207f irq 19 at device 29.1 on pci0
    Jun 26 18:47:43 	kernel: usbus1 on uhci1
    Jun 26 18:47:43 	kernel: uhci2: <intel 82801g="" (ich7)="" usb="" controller="" usb-c=""> port 0x2040-0x205f irq 18 at device 29.2 on pci0
    Jun 26 18:47:43 	kernel: usbus2 on uhci2
    Jun 26 18:47:43 	kernel: uhci3: <intel 82801g="" (ich7)="" usb="" controller="" usb-d=""> port 0x2020-0x203f irq 16 at device 29.3 on pci0
    Jun 26 18:47:43 	kernel: usbus3 on uhci3
    Jun 26 18:47:43 	kernel: ehci0: <intel 82801gb="" r="" (ich7)="" usb="" 2.0="" controller=""> mem 0x501c0000-0x501c03ff irq 23 at device 29.7 on pci0
    Jun 26 18:47:43 	kernel: usbus4: EHCI version 1.0
    Jun 26 18:47:43 	kernel: usbus4 on ehci0
    Jun 26 18:47:43 	kernel: pcib5: <acpi pci-pci="" bridge=""> at device 30.0 on pci0
    Jun 26 18:47:43 	kernel: pci5: <acpi pci="" bus=""> on pcib5
    Jun 26 18:47:43 	kernel: em0: <intel(r) 1000="" pro="" legacy="" network="" connection="" 1.0.6=""> port 0x1040-0x107f mem 0x50060000-0x5007ffff,0x50040000-0x5005ffff irq 18 at device 4.0 on pci5
    Jun 26 18:47:43 	kernel: em1: <intel(r) 1000="" pro="" legacy="" network="" connection="" 1.0.6=""> port 0x1000-0x103f mem 0x50020000-0x5003ffff,0x50000000-0x5001ffff irq 17 at device 5.0 on pci5
    Jun 26 18:47:43 	kernel: isab0: <pci-isa bridge=""> at device 31.0 on pci0
    Jun 26 18:47:43 	kernel: isa0: <isa bus=""> on isab0
    Jun 26 18:47:43 	kernel: atapci0: <intel ich7="" udma100="" controller=""> port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0x20b0-0x20bf irq 18 at device 31.1 on pci0
    Jun 26 18:47:43 	kernel: ata0: <ata channel=""> at channel 0 on atapci0
    Jun 26 18:47:43 	kernel: atapci1: <intel ich7="" sata300="" controller=""> port 0x20c8-0x20cf,0x20ec-0x20ef,0x20c0-0x20c7,0x20e8-0x20eb,0x20a0-0x20af irq 19 at device 31.2 on pci0
    Jun 26 18:47:43 	kernel: ata2: <ata channel=""> at channel 0 on atapci1
    Jun 26 18:47:43 	kernel: ata3: <ata channel=""> at channel 1 on atapci1
    Jun 26 18:47:43 	kernel: atkbdc0: <keyboard controller="" (i8042)=""> port 0x60,0x64 irq 1 on acpi0
    Jun 26 18:47:43 	kernel: atkbd0: <at keyboard=""> irq 1 on atkbdc0
    Jun 26 18:47:43 	kernel: kbd0 at atkbd0
    Jun 26 18:47:43 	kernel: atkbd0: [GIANT-LOCKED]
    Jun 26 18:47:43 	kernel: orm0: <isa option="" roms=""> at iomem 0xcb000-0xcbfff,0xcc000-0xccfff on isa0
    Jun 26 18:47:43 	kernel: sc0: <system console=""> at flags 0x100 on isa0
    Jun 26 18:47:43 	kernel: sc0: VGA <16 virtual consoles, flags=0x300>
    Jun 26 18:47:43 	kernel: vga0: <generic isa="" vga=""> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0
    Jun 26 18:47:43 	kernel: ppc0: cannot reserve I/O port range
    Jun 26 18:47:43 	kernel: est0: <enhanced speedstep="" frequency="" control=""> on cpu0
    Jun 26 18:47:43 	kernel: p4tcc0: <cpu frequency="" thermal="" control=""> on cpu0
    Jun 26 18:47:43 	kernel: est1: <enhanced speedstep="" frequency="" control=""> on cpu1
    Jun 26 18:47:43 	kernel: p4tcc1: <cpu frequency="" thermal="" control=""> on cpu1
    Jun 26 18:47:43 	kernel: Timecounters tick every 1.000 msec
    Jun 26 18:47:43 	kernel: IPsec: Initialized Security Association Processing.
    Jun 26 18:47:43 	kernel: random: unblocking device.
    Jun 26 18:47:43 	kernel: usbus0: 12Mbps Full Speed USB v1.0
    Jun 26 18:47:43 	kernel: usbus1: 12Mbps Full Speed USB v1.0
    Jun 26 18:47:43 	kernel: usbus2: 12Mbps Full Speed USB v1.0
    Jun 26 18:47:43 	kernel: usbus3: 12Mbps Full Speed USB v1.0
    Jun 26 18:47:43 	kernel: usbus4: 480Mbps High Speed USB v2.0
    Jun 26 18:47:43 	kernel: ugen1.1: <intel> at usbus1
    Jun 26 18:47:43 	kernel: uhub0: <intel 1="" 9="" uhci="" root="" hub,="" class="" 0,="" rev="" 1.00="" 1.00,="" addr=""> on usbus1
    Jun 26 18:47:43 	kernel: ugen0.1: <intel> at usbus0
    Jun 26 18:47:43 	kernel: uhub1: <intel 1="" 9="" uhci="" root="" hub,="" class="" 0,="" rev="" 1.00="" 1.00,="" addr=""> on usbus0
    Jun 26 18:47:43 	kernel: ugen4.1: <intel> at usbus4
    Jun 26 18:47:43 	kernel: uhub2: <intel 1="" 9="" ehci="" root="" hub,="" class="" 0,="" rev="" 2.00="" 1.00,="" addr=""> on usbus4
    Jun 26 18:47:43 	kernel: ugen3.1: <intel> at usbus3
    Jun 26 18:47:43 	kernel: uhub3: <intel 1="" 9="" uhci="" root="" hub,="" class="" 0,="" rev="" 1.00="" 1.00,="" addr=""> on usbus3
    Jun 26 18:47:43 	kernel: ugen2.1: <intel> at usbus2
    Jun 26 18:47:43 	kernel: uhub4: <intel 1="" 9="" uhci="" root="" hub,="" class="" 0,="" rev="" 1.00="" 1.00,="" addr=""> on usbus2
    Jun 26 18:47:43 	kernel: uhub0: 2 ports with 2 removable, self powered
    Jun 26 18:47:43 	kernel: uhub1: 2 ports with 2 removable, self powered
    Jun 26 18:47:43 	kernel: uhub3: 2 ports with 2 removable, self powered
    Jun 26 18:47:43 	kernel: uhub4: 2 ports with 2 removable, self powered
    Jun 26 18:47:43 	kernel: ada0 at ata2 bus 0 scbus1 target 0 lun 0
    Jun 26 18:47:43 	kernel: ada0: <wdc wd1600aajs-08waa0="" 58.01d58=""> ATA-8 SATA 2.x device
    Jun 26 18:47:43 	kernel: ada0: Serial Number WD-WCAS23718722
    Jun 26 18:47:43 	kernel: ada0: 150.000MB/s transfers (SATA, UDMA5, PIO 8192bytes)
    Jun 26 18:47:43 	kernel: ada0: 152627MB (312581808 512 byte sectors: 16H 63S/T 16383C)
    Jun 26 18:47:43 	kernel: ada0: Previously was known as ad4
    Jun 26 18:47:43 	kernel: SMP: AP CPU #1 Launched!
    Jun 26 18:47:43 	kernel: Timecounter "TSC" frequency 1995041470 Hz quality 1000
    Jun 26 18:47:43 	kernel: Root mount waiting for: usbus4
    Jun 26 18:47:43 	kernel: Root mount waiting for: usbus4
    Jun 26 18:47:43 	kernel: uhub2: 8 ports with 8 removable, self powered
    Jun 26 18:47:43 	kernel: Trying to mount root from ufs:/dev/ada0s1a [rw,sync]...
    Jun 26 18:47:43 	kernel: coretemp0: <cpu on-die="" thermal="" sensors=""> on cpu0
    Jun 26 18:47:43 	kernel: coretemp1: <cpu on-die="" thermal="" sensors=""> on cpu1
    Jun 26 18:47:44 	check_reload_status: Linkup starting em1
    Jun 26 18:47:44 	kernel: em1: link state changed to UP
    Jun 26 18:47:46 	php-fpm[248]: /rc.newwanipv6: rc.newwanipv6: Failed to update WAN[wan] IPv6, restarting...
    Jun 26 18:47:52 	php: rc.bootup: Accept router advertisements on interface em1
    Jun 26 18:47:53 	php: rc.bootup: Accept router advertisements on interface em0
    Jun 26 18:47:53 	php: rc.bootup: Resyncing OpenVPN instances.
    Jun 26 18:47:53 	kernel: done.
    Jun 26 18:47:53 	kernel: pflog0: promiscuous mode enabled
    Jun 26 18:47:53 	php: rc.bootup: Could not find IPv4 gateway for interface (lan).
    Jun 26 18:47:53 	php: rc.bootup: Could not find IPv6 gateway for interface (lan).
    Jun 26 18:47:54 	kernel: .done.
    Jun 26 18:47:55 	check_reload_status: Linkup starting em0
    Jun 26 18:47:55 	kernel:
    Jun 26 18:47:55 	kernel: em0: link state changed to UP
    Jun 26 18:47:56 	kernel: done.
    Jun 26 18:47:57 	lighttpd[20523]: (log.c.164) server started
    Jun 26 18:47:57 	kernel: done.
    Jun 26 18:47:57 	php: rc.bootup: ROUTING: setting default route to 150.101.32.54
    Jun 26 18:47:58 	kernel: done.
    Jun 26 18:47:58 	check_reload_status: Updating all dyndns
    Jun 26 18:47:58 	php: rc.bootup: Could not find IPv4 gateway for interface (lan).
    Jun 26 18:47:58 	kernel: ...
    Jun 26 18:47:58 	php: rc.bootup: Could not find IPv6 gateway for interface (lan).
    Jun 26 18:47:59 	kernel: .done.
    Jun 26 18:48:03 	php: rc.bootup: Creating rrd update script
    Jun 26 18:48:03 	kernel: done.
    Jun 26 18:48:03 	php: rc.bootup: miniupnpd: Starting service on interface: lan
    Jun 26 18:48:03 	syslogd: exiting on signal 15
    Jun 26 18:48:03 	syslogd: kernel boot file is /boot/kernel/kernel
    Jun 26 18:48:03 	php-fpm[248]: /rc.start_packages: sync_package_postfix called with via_rpc=no
    Jun 26 18:48:03 	syslogd: exiting on signal 15
    Jun 26 18:48:04 	syslogd: kernel boot file is /boot/kernel/kernel
    Jun 26 18:48:06 	php-fpm[248]: /rc.start_packages: Writing rc_file
    Jun 26 18:48:07 	php-fpm[248]: /rc.start_packages: Stopping postfix
    Jun 26 18:48:08 	postfix/postfix-script[74222]: fatal: the Postfix mail system is not running
    Jun 26 18:48:08 	php-fpm[248]: /rc.start_packages: The command '/usr/local/etc/rc.d/postfix.sh stop' returned exit code '1', the output was ''
    Jun 26 18:48:08 	php-fpm[248]: /rc.start_packages: sync_package_postfix called with via_rpc=no
    Jun 26 18:48:09 	syslogd: exiting on signal 15
    Jun 26 18:48:09 	syslogd: kernel boot file is /boot/kernel/kernel
    Jun 26 18:48:12 	php-fpm[248]: /rc.start_packages: Writing rc_file
    Jun 26 18:48:13 	php-fpm[248]: /rc.start_packages: Stopping postfix
    Jun 26 18:48:13 	postfix/postfix-script[99117]: fatal: the Postfix mail system is not running
    Jun 26 18:48:13 	php-fpm[248]: /rc.start_packages: The command '/usr/local/etc/rc.d/postfix.sh stop' returned exit code '1', the output was ''
    Jun 26 18:48:13 	php-fpm[248]: /rc.start_packages: sync_package_postfix called with via_rpc=no
    Jun 26 18:48:13 	syslogd: exiting on signal 15
    Jun 26 18:48:14 	syslogd: kernel boot file is /boot/kernel/kernel
    Jun 26 18:48:15 	check_reload_status: Restarting ipsec tunnels
    Jun 26 18:48:15 	check_reload_status: Restarting OpenVPN tunnels/interfaces
    Jun 26 18:48:15 	check_reload_status: Reloading filter
    Jun 26 18:48:16 	php-fpm[248]: /rc.start_packages: Writing rc_file
    Jun 26 18:48:16 	php-fpm[52623]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (lan).
    Jun 26 18:48:16 	php-fpm[52623]: /rc.filter_configure_sync: Could not find IPv6 gateway for interface (lan).
    Jun 26 18:48:17 	php-fpm[248]: /rc.start_packages: Stopping postfix
    Jun 26 18:48:18 	postfix/postfix-script[27815]: fatal: the Postfix mail system is not running
    Jun 26 18:48:18 	php-fpm[248]: /rc.start_packages: The command '/usr/local/etc/rc.d/postfix.sh stop' returned exit code '1', the output was ''
    Jun 26 18:48:18 	php-fpm[248]: /rc.start_packages: sync_package_postfix called with via_rpc=no
    Jun 26 18:48:18 	check_reload_status: Syncing firewall
    Jun 26 18:48:18 	syslogd: exiting on signal 15
    Jun 26 18:48:18 	syslogd: kernel boot file is /boot/kernel/kernel
    Jun 26 18:48:20 	php-fpm[248]: /rc.start_packages: Writing rc_file
    Jun 26 18:48:21 	php-fpm[248]: /rc.start_packages: Stopping postfix
    Jun 26 18:48:22 	postfix/postfix-script[54296]: fatal: the Postfix mail system is not running
    Jun 26 18:48:22 	php-fpm[248]: /rc.start_packages: The command '/usr/local/etc/rc.d/postfix.sh stop' returned exit code '1', the output was ''
    Jun 26 18:48:22 	php-fpm[248]: /rc.start_packages: sync_package_postfix called with via_rpc=no
    Jun 26 18:48:22 	syslogd: exiting on signal 15
    Jun 26 18:48:22 	syslogd: kernel boot file is /boot/kernel/kernel
    Jun 26 18:48:24 	php-fpm[248]: /rc.start_packages: Writing rc_file
    Jun 26 18:48:25 	php-fpm[248]: /rc.start_packages: Stopping postfix
    Jun 26 18:48:26 	postfix/postfix-script[81024]: fatal: the Postfix mail system is not running
    Jun 26 18:48:26 	php-fpm[248]: /rc.start_packages: The command '/usr/local/etc/rc.d/postfix.sh stop' returned exit code '1', the output was ''
    Jun 26 18:48:26 	php-fpm[248]: /rc.start_packages: sync_package_postfix called with via_rpc=no
    Jun 26 18:48:26 	syslogd: exiting on signal 15
    Jun 26 18:48:26 	syslogd: kernel boot file is /boot/kernel/kernel
    Jun 26 18:48:28 	php-fpm[248]: /rc.start_packages: Writing rc_file
    Jun 26 18:48:29 	php-fpm[248]: /rc.start_packages: Stopping postfix
    Jun 26 18:48:30 	postfix/postfix-script[7143]: fatal: the Postfix mail system is not running
    Jun 26 18:48:30 	php-fpm[248]: /rc.start_packages: The command '/usr/local/etc/rc.d/postfix.sh stop' returned exit code '1', the output was ''
    Jun 26 18:48:30 	php-fpm[248]: /rc.start_packages: [Squid] - Squid_resync function call pr: bp:1 rpc:no
    Jun 26 18:48:32 	php-fpm[248]: /rc.start_packages: Starting Squid
    Jun 26 18:48:33 	squid[22101]: Squid Parent: will start 1 kids
    Jun 26 18:48:33 	squid[22101]: Squid Parent: (squid-1) process 22612 started
    Jun 26 18:48:33 	php-fpm[248]: /rc.start_packages: [Squid] - Squid_resync function call pr:1 bp:1 rpc:no
    Jun 26 18:48:33 	login: login on ttyv0 as root
    Jun 26 18:48:34 	sshlockout[30046]: sshlockout/webConfigurator v3.0 starting up
    Jun 26 18:48:35 	php-fpm[15233]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (lan).
    Jun 26 18:48:35 	php-fpm[15233]: /rc.filter_configure_sync: Could not find IPv6 gateway for interface (lan).
    Jun 26 18:49:05 	php-fpm[36531]: /index.php: Successful login for user 'admin' from: 192.168.10.25
    Jun 26 18:49:05 	php-fpm[36531]: /index.php: Successful login for user 'admin' from: 192.168.10.25
    Jun 26 18:49:26 	check_reload_status: Syncing firewall
    Jun 26 18:49:27 	check_reload_status: Syncing firewall
    Jun 26 18:49:27 	php-fpm[63800]: /pkg_mgr_install.php: [Squid] - Squid_resync function call pr:1 bp: rpc:no
    Jun 26 18:49:28 	php-fpm[63800]: /pkg_mgr_install.php: Reloading Squid for configuration sync
    Jun 26 18:49:28 	check_reload_status: Reloading filter
    Jun 26 18:49:28 	check_reload_status: Syncing firewall
    Jun 26 18:49:28 	check_reload_status: Reloading filter
    Jun 26 18:49:29 	php-fpm[76031]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (lan).
    Jun 26 18:49:29 	php-fpm[76031]: /rc.filter_configure_sync: Could not find IPv6 gateway for interface (lan).
    Jun 26 18:49:29 	php-fpm[99478]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (lan).
    Jun 26 18:49:29 	php-fpm[99478]: /rc.filter_configure_sync: Could not find IPv6 gateway for interface (lan).
    Jun 26 19:02:27 	check_reload_status: Syncing firewall
    Jun 26 19:02:28 	check_reload_status: Syncing firewall
    Jun 26 19:02:28 	check_reload_status: Reloading filter
    Jun 26 19:02:29 	php-fpm[9613]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (lan).
    Jun 26 19:02:29 	php-fpm[9613]: /rc.filter_configure_sync: Could not find IPv6 gateway for interface (lan).
    Jun 26 19:02:30 	php-fpm[7844]: /pkg_mgr_install.php: Beginning package installation for squid3 .
    Jun 26 19:02:32 	check_reload_status: Syncing firewall
    Jun 26 19:03:11 	check_reload_status: Syncing firewall
    Jun 26 19:03:13 	php-fpm[7844]: /pkg_mgr_install.php: Stopping any running proxy monitors
    Jun 26 19:03:14 	php-fpm[7844]: /pkg_mgr_install.php: Starting Squid
    Jun 26 19:03:14 	php-fpm[7844]: /pkg_mgr_install.php: Starting a proxy monitor script
    Jun 26 19:03:14 	check_reload_status: Reloading filter
    Jun 26 19:03:14 	php-fpm[7844]: /pkg_mgr_install.php: [Squid] - Squid_resync function call pr: bp: rpc:no
    Jun 26 19:03:14 	squid[53543]: Squid Parent: will start 1 kids
    Jun 26 19:03:14 	squid[53543]: Squid Parent: (squid-1) process 53951 started
    Jun 26 19:03:15 	check_reload_status: Syncing firewall
    Jun 26 19:03:15 	php-fpm[7844]: /pkg_mgr_install.php: Reloading Squid for configuration sync
    Jun 26 19:03:15 	php-fpm[9613]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (lan).
    Jun 26 19:03:15 	php-fpm[9613]: /rc.filter_configure_sync: Could not find IPv6 gateway for interface (lan).
    Jun 26 19:03:15 	check_reload_status: Reloading filter
    Jun 26 19:03:16 	php-fpm[7844]: /pkg_mgr_install.php: [Squid] - Squid_resync function call pr:1 bp: rpc:no
    Jun 26 19:03:17 	php-fpm[70225]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (lan).
    Jun 26 19:03:17 	php-fpm[70225]: /rc.filter_configure_sync: Could not find IPv6 gateway for interface (lan).
    Jun 26 19:03:17 	php-fpm[7844]: /pkg_mgr_install.php: Reloading Squid for configuration sync
    Jun 26 19:03:17 	check_reload_status: Reloading filter
    Jun 26 19:03:17 	check_reload_status: Syncing firewall
    Jun 26 19:03:17 	php-fpm[7844]: /pkg_mgr_install.php: Successfully installed package: squid3.
    Jun 26 19:03:17 	check_reload_status: Reloading filter
    Jun 26 19:03:17 	check_reload_status: Starting packages
    Jun 26 19:03:18 	php-fpm[9613]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (lan).
    Jun 26 19:03:18 	php-fpm[9613]: /rc.filter_configure_sync: Could not find IPv6 gateway for interface (lan).
    Jun 26 19:03:18 	php-fpm[9613]: /rc.start_packages: Restarting/Starting all packages.
    Jun 26 19:03:18 	php-fpm[9613]: /rc.start_packages: sync_package_postfix called with via_rpc=no
    Jun 26 19:03:18 	check_reload_status: Syncing firewall
    Jun 26 19:03:18 	syslogd: exiting on signal 15
    Jun 26 19:03:19 	syslogd: kernel boot file is /boot/kernel/kernel
    Jun 26 19:03:21 	php-fpm[9613]: /rc.start_packages: Writing rc_file
    Jun 26 19:03:22 	php-fpm[9613]: /rc.start_packages: Stopping postfix
    Jun 26 19:03:22 	postfix/postfix-script[20519]: fatal: the Postfix mail system is not running
    Jun 26 19:03:22 	php-fpm[9613]: /rc.start_packages: The command '/usr/local/etc/rc.d/postfix.sh stop' returned exit code '1', the output was ''
    Jun 26 19:03:22 	php-fpm[9613]: /rc.start_packages: sync_package_postfix called with via_rpc=no
    Jun 26 19:03:23 	syslogd: exiting on signal 15
    Jun 26 19:03:23 	syslogd: kernel boot file is /boot/kernel/kernel
    Jun 26 19:03:25 	php-fpm[9613]: /rc.start_packages: Writing rc_file
    Jun 26 19:03:26 	php-fpm[9613]: /rc.start_packages: Stopping postfix
    Jun 26 19:03:26 	postfix/postfix-script[46478]: fatal: the Postfix mail system is not running
    Jun 26 19:03:26 	php-fpm[9613]: /rc.start_packages: The command '/usr/local/etc/rc.d/postfix.sh stop' returned exit code '1', the output was ''
    Jun 26 19:03:26 	php-fpm[9613]: /rc.start_packages: sync_package_postfix called with via_rpc=no
    Jun 26 19:03:26 	syslogd: exiting on signal 15
    Jun 26 19:03:26 	syslogd: kernel boot file is /boot/kernel/kernel
    Jun 26 19:03:28 	php-fpm[9613]: /rc.start_packages: Writing rc_file
    Jun 26 19:03:29 	php-fpm[9613]: /rc.start_packages: Stopping postfix
    Jun 26 19:03:29 	postfix/postfix-script[73264]: fatal: the Postfix mail system is not running
    Jun 26 19:03:29 	php-fpm[9613]: /rc.start_packages: The command '/usr/local/etc/rc.d/postfix.sh stop' returned exit code '1', the output was ''
    Jun 26 19:03:29 	php-fpm[9613]: /rc.start_packages: sync_package_postfix called with via_rpc=no
    Jun 26 19:03:29 	syslogd: exiting on signal 15
    Jun 26 19:03:29 	syslogd: kernel boot file is /boot/kernel/kernel
    Jun 26 19:03:31 	php-fpm[9613]: /rc.start_packages: Writing rc_file
    Jun 26 19:03:32 	php-fpm[9613]: /rc.start_packages: Stopping postfix
    Jun 26 19:03:32 	postfix/postfix-script[12520]: fatal: the Postfix mail system is not running
    Jun 26 19:03:32 	php-fpm[9613]: /rc.start_packages: The command '/usr/local/etc/rc.d/postfix.sh stop' returned exit code '1', the output was ''
    Jun 26 19:03:32 	php-fpm[9613]: /rc.start_packages: sync_package_postfix called with via_rpc=no
    Jun 26 19:03:33 	syslogd: exiting on signal 15
    Jun 26 19:03:33 	syslogd: kernel boot file is /boot/kernel/kernel
    Jun 26 19:03:35 	php-fpm[9613]: /rc.start_packages: Writing rc_file
    Jun 26 19:03:36 	php-fpm[9613]: /rc.start_packages: Stopping postfix
    Jun 26 19:03:36 	postfix/postfix-script[38583]: fatal: the Postfix mail system is not running
    Jun 26 19:03:36 	php-fpm[9613]: /rc.start_packages: The command '/usr/local/etc/rc.d/postfix.sh stop' returned exit code '1', the output was ''
    Jun 26 19:03:36 	php-fpm[9613]: /rc.start_packages: sync_package_postfix called with via_rpc=no
    Jun 26 19:03:37 	syslogd: exiting on signal 15
    Jun 26 19:03:37 	syslogd: kernel boot file is /boot/kernel/kernel
    Jun 26 19:03:39 	php-fpm[9613]: /rc.start_packages: Writing rc_file
    Jun 26 19:03:40 	php-fpm[9613]: /rc.start_packages: Stopping postfix
    Jun 26 19:03:40 	postfix/postfix-script[62640]: fatal: the Postfix mail system is not running
    Jun 26 19:03:40 	php-fpm[9613]: /rc.start_packages: The command '/usr/local/etc/rc.d/postfix.sh stop' returned exit code '1', the output was ''
    Jun 27 15:13:00 	php-fpm[17734]: /index.php: Successful login for user 'admin' from: 192.168.10.25
    Jun 27 15:13:00 	php-fpm[17734]: /index.php: Successful login for user 'admin' from: 192.168.10.25
    Jun 27 15:13:00 	sshlockout[4705]: sshlockout/webConfigurator v3.0 starting up
    Jun 27 20:25:30 	check_reload_status: Restarting ipsec tunnels
    Jun 27 20:25:30 	check_reload_status: Restarting OpenVPN tunnels/interfaces
    Jun 27 20:25:30 	check_reload_status: Reloading filter
    Jun 27 20:25:32 	php-fpm[42531]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (lan).
    Jun 27 20:25:32 	php-fpm[42531]: /rc.filter_configure_sync: Could not find IPv6 gateway for interface (lan).
    Jun 27 20:25:39 	check_reload_status: updating dyndns WAN_PPPOE
    Jun 27 20:25:39 	check_reload_status: Restarting ipsec tunnels
    Jun 27 20:25:39 	check_reload_status: Restarting OpenVPN tunnels/interfaces
    Jun 27 20:25:39 	check_reload_status: Reloading filter
    Jun 27 20:25:41 	php-fpm[34026]: /rc.filter_configure_sync: Could not find IPv4 gateway for interface (lan).
    Jun 27 20:25:41 	php-fpm[34026]: /rc.filter_configure_sync: Could not find IPv6 gateway for interface (lan).
    Jun 28 16:55:37 	php-fpm[3805]: /index.php: Successful login for user 'admin' from: 192.168.10.25
    Jun 28 16:55:37 	php-fpm[3805]: /index.php: Successful login for user 'admin' from: 192.168.10.25
    Jun 28 17:00:34 	check_reload_status: Syncing firewall
    Jun 28 17:00:34 	syslogd: exiting on signal 15
    Jun 28 17:00:35 	syslogd: kernel boot file is /boot/kernel/kernel
    Jun 28 17:01:40 	syslogd: exiting on signal 15
    Jun 28 17:01:40 	syslogd: kernel boot file is /boot/kernel/kernel
    Jun 28 17:02:07 	syslogd: exiting on signal 15
    Jun 28 17:02:07 	syslogd: kernel boot file is /boot/kernel/kernel</cpu></cpu></wdc></intel></intel></intel></intel></intel></intel></intel></intel></intel></intel></cpu></enhanced></cpu></enhanced></generic></system></isa></at></keyboard></ata></ata></intel></ata></intel></isa></pci-isa></intel(r)></intel(r)></acpi></acpi></intel></intel></intel></intel></intel></acpi></acpi></acpi></acpi></acpi></acpi></acpi></acpi></intel></vga-compatible></acpi></acpi></sleep></high></at></at></acpi></acpi></intel></software></software,></version></intel></lahf></syscall,nx,lm></sse3,dtes64,mon,ds_cpl,est,tm2,ssse3,cx16,xtpr,pdcm></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>
    


  • Diagnostics->Edit file
    /cf/conf/upgrade_log.txt
    (hmmm - might be just /conf/upgrade_log.txt on full installs)



  • /conf/upgrade_log.txt
    Starts looking like

    pfSenseupgrade upgrade starting
    
    Performing full backup
    
    Fri Jun 26 18:07:52 EST 2015
    
    total 12
    dr-xr-xr-x  10 root  wheel      512B May 11 17:05 .
    drwxr-xr-x  24 root  wheel      512B Apr 18 10:54 ..
    crw-r--r--   1 root  wheel      0x22 May 11 17:05 acpi
    lrwxr-xr-x   1 root  wheel        4B May 11 17:05 ad4 -> ada0
    lrwxr-xr-x   1 root  wheel        6B May 11 17:05 ad4s1 -> ada0s1
    lrwxr-xr-x   1 root  wheel        7B May 11 17:05 ad4s1a -> ada0s1a
    lrwxr-xr-x   1 root  wheel        7B May 11 17:05 ad4s1b -> ada0s1b
    crw-r-----   1 root  operator   0x54 May 11 17:05 ada0
    crw-r-----   1 root  operator   0x57 May 11 17:05 ada0s1
    crw-r-----   1 root  operator   0x5a May 11 17:06 ada0s1a
    crw-r-----   1 root  operator   0x5c May 11 17:05 ada0s1b
    crw-------   1 root  wheel      0x25 May 11 17:05 agpgart
    crw-rw-r--   1 root  operator   0x24 May 11 17:05 apm
    crw-rw----   1 root  operator   0x23 May 11 17:05 apmctl
    crw-------   1 root  wheel      0x28 May 11 17:05 atkbd0
    crw-------   1 root  kmem       0x14 May 11 17:05 audit
    crw-------   1 root  wheel      0x20 May 11 17:05 bpf
    lrwxr-xr-x   1 root  wheel        3B May 11 17:05 bpf0 -> bpf
    crw-------   1 root  wheel       0x6 May 22 17:45 console
    crw-------   1 root  wheel      0x3a May 11 17:05 consolectl
    crw-rw-rw-   1 root  wheel      0x3f May 11 17:05 crypto
    crw-rw-rw-   1 root  wheel      0x1c May 11 17:05 ctty
    crw-------   1 root  wheel       0x5 May 11 17:05 devctl
    cr--r--r--   1 root  wheel      0x52 May 11 17:05 devstat
    lrwxr-xr-x   1 root  wheel       12B May 11 17:06 dumpdev -> /dev/ada0s1b
    dr-xr-xr-x   2 root  wheel      512B May 11 17:05 fd
    crw-------   1 root  wheel      0x1f May 11 17:05 fido
    crw-r-----   1 root  operator    0x3 May 11 17:05 geom.ctl
    crw-------   1 root  wheel      0x18 May 11 17:05 io
    lrwxr-xr-x   1 root  wheel        6B May 11 17:05 kbd0 -> atkbd0
    lrwxr-xr-x   1 root  wheel        7B May 11 17:05 kbd1 -> kbdmux0
    crw-------   1 root  wheel      0x1a May 11 17:05 kbdmux0
    crw-------   1 root  wheel      0x17 May 11 17:05 klog
    crw-r-----   1 root  kmem       0x1e May 11 17:05 kmem
    dr-xr-xr-x   2 root  wheel      512B May 11 17:05 led
    crw-r-----   1 root  operator   0x56 May 11 17:06 md0
    crw-------   1 root  wheel      0x42 May 11 17:05 mdctl
    crw-r-----   1 root  kmem       0x1d May 11 17:05 mem
    crw-rw-rw-   1 root  wheel      0x15 May 11 17:05 midistat
    crw-------   1 root  kmem       0x13 May 11 17:05 nfslock
    crw-rw-rw-   1 root  wheel       0x7 Jun 26 18:07 null
    crw-------   1 root  operator   0x53 May 11 17:05 pass0
    crw-r--r--   1 root  wheel       0x9 May 11 17:05 pci
    crw-rw----   1 root  proxy      0x3e May 11 17:05 pf
    crw-rw-rw-   1 root  wheel       0xa May 11 17:05 ptmx
    crw-rw-rw-   1 root  wheel       0xb May 11 17:05 random
    cr--r--r--   1 root  wheel       0x4 May 11 17:05 sndstat
    crw-------   1 root  wheel      0x19 May 11 17:05 speaker
    lrwxr-xr-x   1 root  wheel        4B May 11 17:05 stderr -> fd/2
    lrwxr-xr-x   1 root  wheel        4B May 11 17:05 stdin -> fd/0
    lrwxr-xr-x   1 root  wheel        4B May 11 17:05 stdout -> fd/1
    crw-------   1 root  wheel      0x16 May 11 17:05 sysmouse
    crw-------   1 root  tty        0x2a May 23 15:05 ttyv0
    crw-------   1 root  wheel      0x2b May 11 17:05 ttyv1
    crw-------   1 root  wheel      0x2c May 11 17:05 ttyv2
    crw-------   1 root  wheel      0x2d May 11 17:05 ttyv3
    crw-------   1 root  wheel      0x2e May 11 17:05 ttyv4
    crw-------   1 root  wheel      0x2f May 11 17:05 ttyv5
    crw-------   1 root  wheel      0x30 May 11 17:05 ttyv6
    crw-------   1 root  wheel      0x31 May 11 17:05 ttyv7
    crw-------   1 root  wheel      0x32 May 11 17:05 ttyv8
    crw-------   1 root  wheel      0x33 May 11 17:05 ttyv9
    crw-------   1 root  wheel      0x34 May 11 17:05 ttyva
    crw-------   1 root  wheel      0x35 May 11 17:05 ttyvb
    crw-------   1 root  wheel      0x36 May 11 17:05 ttyvc
    crw-------   1 root  wheel      0x37 May 11 17:05 ttyvd
    crw-------   1 root  wheel      0x38 May 11 17:05 ttyve
    crw-------   1 root  wheel      0x39 May 11 17:05 ttyvf
    crw-------   1 root  wheel      0x3b May 11 17:05 ufssuspend
    lrwxr-xr-x   1 root  wheel        9B May 11 17:05 ugen0.1 -> usb/0.1.0
    lrwxr-xr-x   1 root  wheel        9B May 11 17:05 ugen1.1 -> usb/1.1.0
    lrwxr-xr-x   1 root  wheel        9B May 11 17:05 ugen2.1 -> usb/2.1.0
    lrwxr-xr-x   1 root  wheel        9B May 11 17:05 ugen3.1 -> usb/3.1.0
    lrwxr-xr-x   1 root  wheel        9B May 11 17:05 ugen4.1 -> usb/4.1.0
    lrwxr-xr-x   1 root  wheel        6B May 11 17:05 urandom -> random
    dr-xr-xr-x   2 root  wheel      512B May 11 17:05 usb
    crw-r--r--   1 root  operator   0x40 May 11 17:05 usbctl
    crw-------   1 root  operator   0x41 May 11 17:05 xpt0
    crw-rw-rw-   1 root  wheel       0x8 May 11 17:05 zero
    
    -rw-r--r--  1 root  wheel    82M Jun 26 17:54 /root/latest.tgz
    
    MD5 (/root/latest.tgz) = 6565f3f2a289fee18590a39c5b3244b1
    
    /dev/ada0s1a on / (ufs, local)
    devfs on /dev (devfs, local)
    /dev/md0 on /var/run (ufs, local)
    devfs on /var/dhcpd/dev (devfs, local)
    
    last pid: 61261;  load averages:  0.49,  0.51,  0.38  up 46+01:02:01    18:07:55
    49 processes:  1 running, 48 sleeping
    
    Mem: 286M Active, 434M Inact, 217M Wired, 12M Cache, 108M Buf, 3200K Free
    Swap: 2048M Total, 1067M Used, 981M Free, 52% Inuse
    
      PID USERNAME  THR PRI NICE   SIZE    RES STATE   C   TIME    WCPU COMMAND
    69881 proxy       1  20    0  1212M   227M kqread  1 106:53   0.00% squid
    18373 root        1  20    0 12464K  1768K select  0  70:37   0.00% apinger
    14731 root        1  20    0 16812K  1820K bpf     1  55:36   0.00% filterlog
    19893 clamav      2  20    0   408M   186M select  0  49:43   0.00% clamd
    43581 root        1  20    0 14548K  1624K select  1  27:25   0.00% powerd
    43965 root        1  20    0 21164K  3424K select  1  18:30   0.00% miniupnpd
      246 root        1  20    0   224M  7156K kqread  0  10:14   0.00% php-fpm
    22743 root        1  20    0 46704K  4488K kqread  0   9:50   0.00% lighttpd
    63360 clamav      1  20    0 25388K  2104K select  0   8:11   0.00% c-icap
    25859 root        1  52   20 17144K   740K wait    0   8:11   0.00% sh
     9365 root        1  24    0 17144K   720K wait    0   7:32   0.00% sh
    52081 root        1  20    0 14664K  1964K select  0   5:28   0.00% syslogd
    79475 root        1  20    0 28176K 18060K select  1   5:05   0.00% ntpd
    63810 root        1  20    0 43616K  4208K select  0   4:40   0.00% mpd5
    18475 root        1  20    0 28352K  1956K piperd  1   4:15   0.00% rrdtool
    53982 root        1  20    0 16672K   548K nanslp  1   0:38   0.00% cron
    76755 proxy       1  20    0 26040K  2112K piperd  1   0:31   0.00% unlinkd
     8076 root        1  23    0 12412K   352K nanslp  0   0:10   0.00% minicron
    
    tar: Failed to set default locale
    x ./tmp/pre_upgrade_command
    Firmware upgrade in progress...
    Installing /root/latest.tgz.
    tar: Failed to set default locale
    ./boot/loader.rc: Could not unlink
    tar: Error exit delayed from previous errors.
    Image installed /root/latest.tgz.
    .:      modification time (Sat Apr 18 10:53:50 2015, Fri Jun 26 18:08:26 2015)
    [:      size (11336, 10936)
    	modification time (Tue Apr 14 11:27:26 2015, Wed Jun 24 07:57:33 2015)
    uuidgen: 
    	size (7144, 6752)
    	modification time (Tue Apr 14 11:27:26 2015, Wed Jun 24 07:57:33 2015)
    unlink: size (15592, 15200)
    	modification time (Tue Apr 14 11:27:26 2015, Wed Jun 24 07:57:33 2015)[/code]
    Then a crap load of that stuff, it also altered a lot of squid, squidguard & postfix permissions.  I see no need to post 18,000 lines of that though.
    
    It ends like
    [code]local/etc/rc.d: 
    	modification time (Mon May 11 17:06:49 2015, Wed Jun 24 08:01:55 2015)
    local/etc/pkg.conf: 
    	modification time (Tue Apr 14 11:14:55 2015, Wed Jun 24 07:39:24 2015)
    local/etc/php.ini: 
    	size (1837, 1808)
    	modification time (Mon May 11 17:06:17 2015, Wed Jun 24 08:01:56 2015)
    Checking for /tmp/post_upgrade_command.php... 
    Running /tmp/post_upgrade_command.php 
    Adding serial port settings ()...
    Reading /boot/loader.conf...
    Fri Jun 26 18:08:30 EST 2015
    
    Firmware upgrade is complete. Rebooting in 10 seconds.[/code]
    
    I'd love to say that I sat and watched the console during the process, but I didn't.  I just expected it to work, like it did every other time
    

  • Netgate Administrator

    Hmm, well looks like it tried to reboot at 18.08 and that lines up with both the upgrade and system logs. However it didn't actually reboot until 18.46 which I assume was you doing it manually?

    Steve



  • Correct.  I manually rebooted it because I knew that something wasn't right with a lengthy uptime.

    Any other log or config files you'd like to look at, just ask.


  • Netgate Administrator

    The previous issue of coming from 2.1.X with a different FreeBSD base version doesn't apply here. The reboot binary would run in 2.2.2 or 2.2.3.
    The only thing that might cause that would be coming from 32bit except that you say you didn't and also it wouldn't reboot manually without actually pressing the power button.
    We haven't seen any other reports of this yet in 2.2.3.

    Steve


Log in to reply