OpenVPN status page shows error Unable to contact daemon



  • Remote Home Users UDP:1194 Client connections
    Common Name	Real Address	Virtual Address	Connected Since	Bytes Sent	Bytes Received
    [error]	 Unable to contact daemon	 Service not running?	 0	 0	 0
    

    It appears to be running.  Services shows it running.

    2.2-ALPHA (i386)
    built on Sat Jun 14 01:00:55 CDT 2014
    FreeBSD 10.0-STABLE



  • log messages directly after the upgrade/reboot.  It looks like it might have got started twice after the upgrade/reboot.  I only have 1 openvpn setup configured for mobile clients.  I will reboot it again and see if the same problem exists.

    Jun 15 03:07:23	openvpn[24243]: Initialization Sequence Completed
    Jun 15 03:07:23	openvpn[24243]: UDPv4 link remote: [undef]
    Jun 15 03:07:23	openvpn[24243]: UDPv4 link local (bound): [AF_INET]x.x.x.x:1194
    Jun 15 03:07:22	openvpn[21159]: Exiting due to fatal error
    Jun 15 03:07:22	openvpn[21159]: TCP/UDP: Socket bind failed on local address [AF_INET]x.x.x.x:1194: Address already in use
    Jun 15 03:07:22	openvpn[21159]: Control Channel Authentication: using '/var/etc/openvpn/server1.tls-auth' as a OpenVPN static key file
    Jun 15 03:07:22	openvpn[21159]: NOTE: the current --script-security setting may allow this configuration to call user-defined scripts
    Jun 15 03:07:22	openvpn[20946]: /usr/local/sbin/ovpn-linkup ovpns1 1500 1557 x.x.y.1 x.x.y.2 init
    Jun 15 03:07:22	openvpn[20946]: /sbin/ifconfig ovpns1 x.x.y.1 x.x.y.2 mtu 1500 netmask 255.255.255.255 up
    Jun 15 03:07:22	openvpn[20946]: do_ifconfig, tt->ipv6=1, tt->did_ifconfig_ipv6_setup=0
    Jun 15 03:07:22	openvpn[20946]: TUN/TAP device /dev/tun1 opened
    Jun 15 03:07:22	openvpn[20946]: TUN/TAP device ovpns1 exists previously, keep at program end
    Jun 15 03:07:22	openvpn[20946]: Control Channel Authentication: using '/var/etc/openvpn/server1.tls-auth' as a OpenVPN static key file
    Jun 15 03:07:22	openvpn[21159]: library versions: OpenSSL 1.0.1g-freebsd 7 Apr 2014, LZO 2.06
    Jun 15 03:07:22	openvpn[21159]: OpenVPN 2.3.4 i386-portbld-freebsd10.0 [SSL (OpenSSL)] [LZO] [MH] [IPv6] built on May 29 2014
    Jun 15 03:07:22	openvpn[20946]: NOTE: the current --script-security setting may allow this configuration to call user-defined scripts
    Jun 15 03:07:22	openvpn[20946]: library versions: OpenSSL 1.0.1g-freebsd 7 Apr 2014, LZO 2.06
    Jun 15 03:07:22	openvpn[20946]: OpenVPN 2.3.4 i386-portbld-freebsd10.0 [SSL (OpenSSL)] [LZO] [MH] [IPv6] built on May 29 2014
    


  • Reboot still shows that same result.  error page on the OpenVPN status page.  Restarting OpenVPN using the services page now shows that it is running on the openvpn status page.  It appears that starting OpenVPN service after stopping it causes the ntpd service to fail though.  I will submit that as a different thread though.



  • added version info to first post.

    2.2-ALPHA (i386)
    built on Sat Jun 14 01:00:55 CDT 2014
    FreeBSD 10.0-STABLE


  • Rebel Alliance Developer Netgate

    I can't seem to reproduce this one. My OpenVPN servers and clients are OK at boot time and stay that way. Before and after a firmware upgrade, even.



  • Should I try the previous snapshot to verify it works again under the old snapshot?

    What tells openvpn service to start?  Maybe I can find out why it is starting twice.


  • Rebel Alliance Developer Netgate

    OpenVPN is started from rc.bootup I believe. I can't think of a way that it would start twice without being killed in between though. It might be started from rc.bootup and then again from rc.newwanip. The logs might give some indication.



  • I do see some references to OpenVPN and newwanip but I don't know if that is showing it starting twice or not.  I have the client export and suricata packages installed.  The log below is during an upgrade where the packages get reinstalled.  During a normal boot the packages don't get installed but it OpenVPN still doesn't work until a manual stop and restart (which then causes ntpd service to stop btw).

    EDIT: some of the log data was missing from my paste so I am working on posting a new one…



  • system.log bootup during the upgrade…

    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense syslogd: kernel boot file is /boot/kernel/kernel
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: Copyright (c) 1992-2014 The FreeBSD Project.
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: The Regents of the University of California. All rights reserved.
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: FreeBSD is a registered trademark of The FreeBSD Foundation.
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: FreeBSD 10.0-STABLE #18 e852cd6(HEAD)-dirty: Sat Jun 14 01:31:03 CDT 2014
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: root@pf22-i386-snap:/usr/obj.i386/usr/pfSensesrc/src/sys/pfSense_SMP.10 i386
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: FreeBSD clang version 3.3 (tags/RELEASE_33/final 183502) 20130610
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: CPU: Intel(R) Celeron(R) processor            600MHz (599.94-MHz 686-class CPU)
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: Origin = "GenuineIntel"  Id = 0x695  Family = 0x6  Model = 0x9  Stepping = 5
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: Features=0xa7e9f9bf <fpu,vme,de,pse,tsc,msr,mce,cx8,sep,mtrr,pge,mca,cmov,pat,clflush,dts,acpi,mmx,fxsr,sse,sse2,tm,pbe>Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: real memory  = 1040187392 (992 MB)
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: avail memory = 983924736 (938 MB)
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: wlan: mac acl policy registered
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: ipw_bss: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/.
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: ipw_bss: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf.
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: module_register_init: MOD_LOAD (ipw_bss_fw, 0xc07cd910, 0) error 1
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: ipw_ibss: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/.
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: ipw_ibss: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf.
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: module_register_init: MOD_LOAD (ipw_ibss_fw, 0xc07cd9c0, 0) error 1
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: ipw_monitor: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/.
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: ipw_monitor: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf.
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: module_register_init: MOD_LOAD (ipw_monitor_fw, 0xc07cda70, 0) error 1
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: iwi_bss: You need to read the LICENSE file in /usr/share/doc/legal/intel_iwi/.
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: iwi_bss: If you agree with the license, set legal.intel_iwi.license_ack=1 in /boot/loader.conf.
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: module_register_init: MOD_LOAD (iwi_bss_fw, 0xc07f3e60, 0) error 1
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: iwi_ibss: You need to read the LICENSE file in /usr/share/doc/legal/intel_iwi/.
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: iwi_ibss: If you agree with the license, set legal.intel_iwi.license_ack=1 in /boot/loader.conf.
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: module_register_init: MOD_LOAD (iwi_ibss_fw, 0xc07f3f10, 0) error 1
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: iwi_monitor: You need to read the LICENSE file in /usr/share/doc/legal/intel_iwi/.
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: iwi_monitor: If you agree with the license, set legal.intel_iwi.license_ack=1 in /boot/loader.conf.
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: module_register_init: MOD_LOAD (iwi_monitor_fw, 0xc07f3fc0, 0) error 1
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: kbd1 at kbdmux0
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: random: <software, yarrow=""> initialized
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: ACPI BIOS Error (bug): A valid RSDP was not found (20130823/tbxfroot-223)
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: ACPI: Table initialisation failed: AE_NOT_FOUND
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: ACPI: Try disabling either ACPI or apic support.
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: cryptosoft0: <software crypto=""> on motherboard
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: padlock0: No ACE support.
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: pcib0 pcibus 0 on motherboard
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: pir0: <pci 10="" interrupt="" routing="" table:="" entries=""> on motherboard
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: pci0: <pci bus=""> on pcib0
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: pci0: <base peripheral=""> at device 0.1 (no driver attached)
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: pci0: <base peripheral=""> at device 0.3 (no driver attached)
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: vgapci0: <vga-compatible display=""> port 0xe200-0xe207 mem 0xd8000000-0xdfffffff,0xe8180000-0xe81fffff irq 12 at device 2.0 on pci0
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: agp0: <intel 8285xm="" (85xgm="" gmch)="" svga="" controller=""> on vgapci0
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: agp0: aperture size is 128M, detected 32636k stolen memory
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: vgapci0: Boot video device
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: vgapci1: <vga-compatible display=""> mem 0xe0000000-0xe7ffffff,0xe8100000-0xe817ffff at device 2.1 on pci0
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: uhci0: <intel 82801db="" (ich4)="" usb="" controller="" usb-a=""> port 0xe000-0xe01f irq 12 at device 29.0 on pci0
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: usbus0 on uhci0
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: uhci1: <intel 82801db="" (ich4)="" usb="" controller="" usb-b=""> port 0xe100-0xe11f irq 5 at device 29.1 on pci0
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: usbus1 on uhci1
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: ehci0: <intel 82801db="" l="" m="" (ich4)="" usb="" 2.0="" controller=""> mem 0xe8200000-0xe82003ff irq 9 at device 29.7 on pci0
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: usbus2: EHCI version 1.0
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: usbus2 on ehci0
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: pcib1: <pcibios pci-pci="" bridge=""> at device 30.0 on pci0
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: pci1: <pci bus=""> on pcib1
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: rl0: <realtek 10="" 8139="" 100basetx=""> port 0xd000-0xd0ff mem 0xe8000000-0xe80000ff irq 12 at device 4.0 on pci1
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: miibus0: <mii bus=""> on rl0
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: rlphy0: <realtek internal="" media="" interface=""> PHY 0 on miibus0
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: rlphy0:  10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: rl1: <realtek 10="" 8139="" 100basetx=""> port 0xd100-0xd1ff mem 0xe8001000-0xe80010ff irq 10 at device 5.0 on pci1
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: miibus1: <mii bus=""> on rl1
    Jun 15 03:07:14 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:14 pfsense kernel: rlphy1: <realtek internal="" media="" interface=""> PHY 0 on miibus1
    Jun 15 03:07:14 pfsense kernel: rlphy1:  10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
    Jun 15 03:07:14 pfsense kernel: rl2: <realtek 10="" 8139="" 100basetx=""> port 0xd200-0xd2ff mem 0xe8002000-0xe80020ff irq 11 at device 6.0 on pci1
    Jun 15 03:07:14 pfsense kernel: miibus2: <mii bus=""> on rl2
    Jun 15 03:07:14 pfsense kernel: rlphy2: <realtek internal="" media="" interface=""> PHY 0 on miibus2
    Jun 15 03:07:14 pfsense kernel: rlphy2:  10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
    Jun 15 03:07:14 pfsense kernel: rl3: <realtek 10="" 8139="" 100basetx=""> port 0xd300-0xd3ff mem 0xe8003000-0xe80030ff irq 5 at device 7.0 on pci1
    Jun 15 03:07:14 pfsense kernel: miibus3: <mii bus=""> on rl3
    Jun 15 03:07:14 pfsense kernel: rlphy3: <realtek internal="" media="" interface=""> PHY 0 on miibus3
    Jun 15 03:07:14 pfsense kernel: rlphy3:  10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
    Jun 15 03:07:14 pfsense kernel: isab0: <pci-isa bridge=""> at device 31.0 on pci0
    Jun 15 03:07:14 pfsense kernel: isa0: <isa bus=""> on isab0
    Jun 15 03:07:14 pfsense kernel: atapci0: <intel ich4="" udma100="" controller=""> port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0xf000-0xf00f at device 31.1 on pci0
    Jun 15 03:07:14 pfsense kernel: ata0: <ata channel=""> at channel 0 on atapci0
    Jun 15 03:07:14 pfsense kernel: ata1: <ata channel=""> at channel 1 on atapci0
    Jun 15 03:07:14 pfsense kernel: pci0: <serial bus,="" smbus=""> at device 31.3 (no driver attached)
    Jun 15 03:07:14 pfsense kernel: cpu0 on motherboard
    Jun 15 03:07:14 pfsense kernel: p4tcc0: <cpu frequency="" thermal="" control=""> on cpu0
    Jun 15 03:07:14 pfsense kernel: pmtimer0 on isa0
    Jun 15 03:07:14 pfsense kernel: attimer0: <at timer=""> at port 0x40-0x43 irq 0 pnpid PNP0100 on isa0
    Jun 15 03:07:14 pfsense kernel: Timecounter "i8254" frequency 1193182 Hz quality 0
    Jun 15 03:07:14 pfsense kernel: Event timer "i8254" frequency 1193182 Hz quality 100
    Jun 15 03:07:14 pfsense kernel: atrtc0: <at realtime="" clock=""> at port 0x70-0x71 irq 8 pnpid PNP0b00 on isa0
    Jun 15 03:07:14 pfsense kernel: Event timer "RTC" frequency 32768 Hz quality 0
    Jun 15 03:07:14 pfsense kernel: atkbdc0: <keyboard controller="" (i8042)=""> at port 0x60,0x64 irq 1 pnpid PNP0303 on isa0
    Jun 15 03:07:14 pfsense kernel: atkbd0: <at keyboard=""> irq 1 on atkbdc0
    Jun 15 03:07:14 pfsense kernel: kbd0 at atkbd0
    Jun 15 03:07:14 pfsense kernel: atkbd0: [GIANT-LOCKED]
    Jun 15 03:07:14 pfsense kernel: unknown: <pnp0c01> can't assign resources (memory)
    Jun 15 03:07:14 pfsense kernel: unknown: <pnp0c02> can't assign resources (memory)
    Jun 15 03:07:14 pfsense kernel: uart0: <16550 or compatible> at port 0x3f8-0x3ff irq 4 flags 0x10 pnpid PNP0501 on isa0
    Jun 15 03:07:14 pfsense kernel: uart1: <16550 or compatible> at port 0x2f8-0x2ff irq 3 pnpid PNP0501 on isa0
    Jun 15 03:07:14 pfsense kernel: orm0: <isa option="" roms=""> at iomem 0xc0000-0xcc7ff,0xd0000-0xd3fff pnpid ORM0000 on isa0
    Jun 15 03:07:14 pfsense kernel: sc0: <system console=""> at flags 0x100 on isa0
    Jun 15 03:07:14 pfsense kernel: sc0: VGA <16 virtual consoles, flags=0x300>
    Jun 15 03:07:14 pfsense kernel: vga0: <generic isa="" vga=""> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0
    Jun 15 03:07:14 pfsense kernel: ppc0: parallel port not found.
    Jun 15 03:07:14 pfsense kernel: unknown: <pnp0c01> can't assign resources (memory)
    Jun 15 03:07:14 pfsense kernel: unknown: <pnp0c02> can't assign resources (memory)
    Jun 15 03:07:14 pfsense kernel: Timecounters tick every 1.000 msec
    Jun 15 03:07:14 pfsense kernel: IPsec: Initialized Security Association Processing.
    Jun 15 03:07:14 pfsense kernel: random: unblocking device.
    Jun 15 03:07:14 pfsense kernel: usbus0: 12Mbps Full Speed USB v1.0
    Jun 15 03:07:14 pfsense kernel: usbus1: 12Mbps Full Speed USB v1.0
    Jun 15 03:07:14 pfsense kernel: usbus2: 480Mbps High Speed USB v2.0
    Jun 15 03:07:14 pfsense kernel: ugen1.1: <intel> at usbus1
    Jun 15 03:07:14 pfsense kernel: uhub0: <intel 1="" 9="" uhci="" root="" hub,="" class="" 0,="" rev="" 1.00="" 1.00,="" addr=""> on usbus1
    Jun 15 03:07:14 pfsense kernel: ugen0.1: <intel> at usbus0
    Jun 15 03:07:14 pfsense kernel: uhub1: <intel 1="" 9="" uhci="" root="" hub,="" class="" 0,="" rev="" 1.00="" 1.00,="" addr=""> on usbus0
    Jun 15 03:07:14 pfsense kernel: ugen2.1: <intel> at usbus2
    Jun 15 03:07:14 pfsense kernel: uhub2: <intel 1="" 9="" ehci="" root="" hub,="" class="" 0,="" rev="" 2.00="" 1.00,="" addr=""> on usbus2
    Jun 15 03:07:14 pfsense kernel: ata0: DMA limited to UDMA33, controller found non-ATA66 cable
    Jun 15 03:07:14 pfsense kernel: ada0 at ata0 bus 0 scbus0 target 0 lun 0
    Jun 15 03:07:14 pfsense kernel: ada0: <fujitsu mht2040ah="" 006c=""> ATA-6 device
    Jun 15 03:07:14 pfsense kernel: ada0: Serial Number NP0ET472HS1E
    Jun 15 03:07:14 pfsense kernel: ada0: 33.300MB/s transfers (UDMA2, PIO 8192bytes)
    Jun 15 03:07:14 pfsense kernel: ada0: 38154MB (78140160 512 byte sectors: 16H 63S/T 16383C)
    Jun 15 03:07:14 pfsense kernel: ada0: Previously was known as ad0
    Jun 15 03:07:14 pfsense kernel: Timecounter "TSC" frequency 599944660 Hz quality 800
    Jun 15 03:07:14 pfsense kernel: Root mount waiting for: usbus2 usbus1 usbus0
    Jun 15 03:07:14 pfsense kernel: uhub0: 2 ports with 2 removable, self powered
    Jun 15 03:07:14 pfsense kernel: uhub1: 2 ports with 2 removable, self powered
    Jun 15 03:07:14 pfsense kernel: Root mount waiting for: usbus2
    Jun 15 03:07:14 pfsense kernel: uhub2: 4 ports with 4 removable, self powered
    Jun 15 03:07:14 pfsense kernel: Trying to mount root from ufs:/dev/ad0s1a [rw]...
    Jun 15 03:07:14 pfsense kernel: warning: total configured swap (2097152 pages) exceeds maximum recommended amount (1930656 pages).
    Jun 15 03:07:14 pfsense kernel: warning: increase kern.maxswzone or reduce amount of swap.
    Jun 15 03:07:14 pfsense kernel: rl0: link state changed to DOWN
    Jun 15 03:07:14 pfsense kernel: rl0: link state changed to UP
    Jun 15 03:07:12 pfsense devd: Executing '/usr/local/sbin/pfSctl -c 'interface linkup stop rl0''
    Jun 15 03:07:12 pfsense check_reload_status: Linkup starting rl0
    Jun 15 03:07:12 pfsense sshd[8460]: Server listening on :: port 22.
    Jun 15 03:07:12 pfsense sshd[8460]: Server listening on 0.0.0.0 port 22.
    Jun 15 03:07:14 pfsense devd: Executing '/usr/local/sbin/pfSctl -c 'interface linkup start rl0''
    Jun 15 03:07:14 pfsense check_reload_status: Linkup starting rl0
    Jun 15 03:07:14 pfsense sshlockout[9780]: sshlockout/webConfigurator v3.0 starting up
    Jun 15 03:07:16 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:16 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:16 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:16 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:16 pfsense syslogd: sendto: No route to host
    Jun 15 03:07:17 pfsense check_reload_status: rc.newwanip starting rl0
    Jun 15 03:07:17 pfsense kernel: rl1: link state changed to DOWN
    Jun 15 03:07:17 pfsense devd: Executing '/usr/local/sbin/pfSctl -c 'interface linkup stop rl1''
    Jun 15 03:07:17 pfsense check_reload_status: Linkup starting rl1
    Jun 15 03:07:18 pfsense php-fpm[257]: /rc.newwanip: rc.newwanip: Informational is starting rl0.
    Jun 15 03:07:18 pfsense php-fpm[257]: /rc.newwanip: rc.newwanip: on (IP address: WANNET.103) (interface: WAN[wan]) (real interface: rl0).
    Jun 15 03:07:18 pfsense php: rc.bootup: Resyncing OpenVPN instances.
    Jun 15 03:07:18 pfsense php-fpm[257]: /rc.newwanip: ROUTING: setting default route to WANNET.1
    Jun 15 03:07:19 pfsense kernel: 
    Jun 15 03:07:19 pfsense kernel: tun1: changing name to 'ovpns1'
    Jun 15 03:07:19 pfsense kernel: rl1: link state changed to UP
    Jun 15 03:07:19 pfsense devd: Executing '/usr/local/sbin/pfSctl -c 'interface linkup start rl1''
    Jun 15 03:07:19 pfsense check_reload_status: Linkup starting rl1
    Jun 15 03:07:21 pfsense php-fpm[257]: /rc.newwanip: phpDynDNS (MYDOMAIN.homenet.org): No change in my IP address and/or 25 days has not passed. Not updating dynamic DNS entry.
    Jun 15 03:07:22 pfsense php-fpm[257]: /rc.newwanip: Resyncing OpenVPN instances for interface WAN.
    Jun 15 03:07:22 pfsense check_reload_status: Reloading filter
    Jun 15 03:07:22 pfsense php-fpm[257]: /rc.newwanip: Creating rrd update script
    Jun 15 03:07:22 pfsense kernel: ovpns1: link state changed to UP
    Jun 15 03:07:23 pfsense check_reload_status: rc.newwanip starting ovpns1
    Jun 15 03:07:23 pfsense kernel: pflog0: promiscuous mode enabled
    Jun 15 03:07:23 pfsense kernel: .
    Jun 15 03:07:23 pfsense kernel: .
    Jun 15 03:07:24 pfsense php-fpm[256]: /rc.newwanip: rc.newwanip: Informational is starting ovpns1.
    Jun 15 03:07:24 pfsense php-fpm[256]: /rc.newwanip: rc.newwanip: on (IP address: OPENVPNNET.1) (interface: []) (real interface: ovpns1).
    Jun 15 03:07:24 pfsense check_reload_status: Reloading filter
    Jun 15 03:07:24 pfsense kernel: ..
    Jun 15 03:07:24 pfsense php-fpm[256]: /rc.newwanip: pfSense package system has detected an ip change  ->  OPENVPNNET.1 ... Restarting packages.
    Jun 15 03:07:24 pfsense check_reload_status: Starting packages
    Jun 15 03:07:24 pfsense php-fpm[257]: /rc.newwanip: pfSense package system has detected an ip change WANNET.103 ->  WANNET.103 ... Restarting packages.
    Jun 15 03:07:24 pfsense check_reload_status: Starting packages
    Jun 15 03:07:25 pfsense kernel: .
    Jun 15 03:07:25 pfsense kernel: done.
    Jun 15 03:07:26 pfsense kernel: done.
    Jun 15 03:07:27 pfsense kernel: done.
    Jun 15 03:07:27 pfsense php-fpm[257]: /rc.start_packages: Restarting/Starting all packages.
    Jun 15 03:07:28 pfsense php-fpm[255]: /rc.start_packages: Restarting/Starting all packages.
    Jun 15 03:07:30 pfsense php: rc.bootup: The command '/usr/sbin/pw userdel -n 'admin'' returned exit code '1', the output was 'pw: entry inconsistent pw: gr_copy(): Invalid argument' 
    Jun 15 03:07:31 pfsense check_reload_status: Syncing firewall
    Jun 15 03:07:34 pfsense check_reload_status: Syncing firewall
    Jun 15 03:07:35 pfsense check_reload_status: Syncing firewall
    Jun 15 03:07:36 pfsense check_reload_status: Syncing firewall
    Jun 15 03:07:36 pfsense SuricataStartup[50975]: Suricata START for WAN(34283_rl0)...
    Jun 15 03:07:38 pfsense check_reload_status: Syncing firewall
    Jun 15 03:07:39 pfsense check_reload_status: Syncing firewall
    Jun 15 03:07:40 pfsense SuricataStartup[60500]: Suricata SOFT RESTART for WAN(34283_rl0)...
    Jun 15 03:07:46 pfsense kernel: done.
    Jun 15 03:07:48 pfsense kernel: done.
    Jun 15 03:07:48 pfsense php: rc.bootup: ROUTING: setting default route to WANNET.1
    Jun 15 03:07:48 pfsense kernel: done.
    Jun 15 03:07:52 pfsense kernel: done.
    Jun 15 03:07:52 pfsense check_reload_status: Updating all dyndns
    Jun 15 03:07:53 pfsense kernel: .
    Jun 15 03:07:53 pfsense php-fpm[256]: /rc.dyndns.update: phpDynDNS (MYDOMAIN.homenet.org): No change in my IP address and/or 25 days has not passed. Not updating dynamic DNS entry.
    Jun 15 03:07:54 pfsense kernel: .
    Jun 15 03:07:54 pfsense kernel: ..
    Jun 15 03:07:55 pfsense kernel: .done.
    Jun 15 03:08:04 pfsense php: rc.bootup: Creating rrd update script
    Jun 15 03:08:04 pfsense kernel: done.
    Jun 15 03:08:04 pfsense php: rc.bootup: Attempting to reinstall all packages
    Jun 15 03:08:06 pfsense php: rc.bootup: List of packages to reinstall: suricata, OpenVPN Client Export Utility
    Jun 15 03:08:06 pfsense kernel: Done.
    Jun 15 03:08:06 pfsense php: rc.bootup: Uninstalling package suricata
    Jun 15 03:08:07 pfsense SuricataStartup[96899]: Suricata STOP for WAN(34283_rl0)...
    Jun 15 03:09:20 pfsense check_reload_status: Syncing firewall
    Jun 15 03:09:20 pfsense php: rc.bootup: [Suricata] Suricata package uninstall in progress...
    Jun 15 03:09:20 pfsense php: rc.bootup: [Suricata] Suricata STOP for all interfaces...
    Jun 15 03:09:23 pfsense check_reload_status: Syncing firewall
    Jun 15 03:09:25 pfsense check_reload_status: Syncing firewall
    Jun 15 03:09:29 pfsense check_reload_status: Syncing firewall
    Jun 15 03:09:31 pfsense php: rc.bootup: Finished uninstalling package suricata
    Jun 15 03:09:31 pfsense php: rc.bootup: Reinstalling package suricata
    Jun 15 03:09:31 pfsense check_reload_status: Syncing firewall
    Jun 15 03:09:32 pfsense php: rc.bootup: Beginning package installation for suricata .
    Jun 15 03:09:33 pfsense kernel: 100%
    Jun 15 03:09:34 pfsense check_reload_status: Syncing firewall
    Jun 15 03:09:34 pfsense kernel: 
    Jun 15 03:09:36 pfsense kernel: 0%
    Jun 15 03:09:36 pfsense ker   3%
    Jun 15 03:09:37 pfsense ker   6%
    Jun 15 03:09:37 pfsense ker  10%
    Jun 15 03:09:37 pfsense ker  20%
    Jun 15 03:09:37 pfsense ker  30%
    Jun 15 03:09:38 pfsense ker  40%
    Jun 15 03:09:38 pfsense ker  50%
    Jun 15 03:09:38 pfsense ker  60%
    Jun 15 03:09:39 pfsense ker  70%
    Jun 15 03:09:39 pfsense ker  80%
    Jun 15 03:09:40 pfsense ker  90%
    Jun 15 03:09:40 pfsense ker 100%
    Jun 15 03:10:25 pfsense php-fpm[256]: /index.php: webConfigurator authentication error for 'admin' from LANNET.4
    Jun 15 03:10:25 pfsense php-fpm[256]: /index.php: webConfigurator authentication error for 'admin' from LANNET.4
    Jun 15 03:10:31 pfsense php-fpm[256]: /index.php: Successful login for user 'admin' from: LANNET.4
    Jun 15 03:10:31 pfsense php-fpm[256]: /index.php: Successful login for user 'admin' from: LANNET.4
    Jun 15 03:10:46 pfsense php-fpm[257]: /diag_ipsec.php: IPSec daemon seems to have issues or not running!
    Jun 15 03:11:59 pfsense kernel: 
    Jun 15 03:11:59 pfsense kernel: pid 66896 (suricata), uid 0: exited on signal 11
    Jun 15 03:12:04 pfsense ker 100%
    Jun 15 03:12:06 pfsense kernel: 100%
    Jun 15 03:12:07 pfsense kernel: 100%
    Jun 15 03:12:07 pfsense kernel: 100%
    Jun 15 03:12:07 pfsense kernel: 100%
    Jun 15 03:12:08 pfsense kernel: 100%
    Jun 15 03:12:09 pfsense kernel: 100%
    Jun 15 03:12:10 pfsense kernel: 100%
    Jun 15 03:12:10 pfsense kernel: 100%
    Jun 15 03:12:11 pfsense kernel: 100%
    Jun 15 03:12:14 pfsense kernel: 100%
    Jun 15 03:12:15 pfsense kernel: 100%
    Jun 15 03:12:16 pfsense kernel: 100%
    Jun 15 03:12:20 pfsense php: rc.bootup: [Suricata] Saved settings detected... rebuilding installation with saved settings...
    Jun 15 03:12:20 pfsense php: rc.bootup: [Suricata] Downloading and updating configured rule types...
    Jun 15 03:12:20 pfsense kernel: Saved settings detected...
    Jun 15 03:12:20 pfsense php: rc.bootup: [Suricata] There is a new set of Emerging Threats Open rules posted. Downloading emerging.rules.tar.gz...
    Jun 15 03:12:20 pfsense kerne   2%
    Jun 15 03:12:20 pfsense ker  10%
    Jun 15 03:12:21 pfsense ker  20%
    Jun 15 03:12:21 pfsense ker  40%
    Jun 15 03:12:21 pfsense ker  60%
    Jun 15 03:12:21 pfsense ker  80%
    Jun 15 03:12:21 pfsense php: rc.bootup: [Suricata] Emerging Threats Open rules file update downloaded successfully
    Jun 15 03:12:21 pfsense ker 100%
    Jun 15 03:12:23 pfsense php: rc.bootup: [Suricata] Updating rules configuration for: WAN ...
    Jun 15 03:12:34 pfsense php: rc.bootup: [Suricata] Enabling any flowbit-required rules for: WAN...
    Jun 15 03:12:35 pfsense php: rc.bootup: [Suricata] Building new sig-msg.map file for WAN...
    Jun 15 03:12:39 pfsense php: rc.bootup: [Suricata] The Rules update has finished.
    Jun 15 03:12:41 pfsense check_reload_status: Syncing firewall
    Jun 15 03:12:41 pfsense kernel: Generating suricata.yaml configuration file from saved settings...
    Jun 15 03:12:44 pfsense check_reload_status: Syncing firewall
    Jun 15 03:12:45 pfsense php: rc.bootup: [Suricata] Updating rules configuration for: WAN ...
    Jun 15 03:12:59 pfsense php: rc.bootup: [Suricata] Enabling any flowbit-required rules for: WAN...
    Jun 15 03:13:00 pfsense php: rc.bootup: [Suricata] Building new sig-msg.map file for WAN...
    Jun 15 03:13:05 pfsense check_reload_status: Syncing firewall
    Jun 15 03:13:09 pfsense check_reload_status: Syncing firewall
    Jun 15 03:13:10 pfsense php: rc.bootup: [Suricata] Finished rebuilding installation from saved settings...
    Jun 15 03:13:12 pfsense php: rc.bootup: [Suricata] Package post-installation tasks completed...
    Jun 15 03:13:12 pfsense check_reload_status: Syncing firewall
    Jun 15 03:13:17 pfsense check_reload_status: Syncing firewall
    Jun 15 03:13:19 pfsense check_reload_status: Syncing firewall
    Jun 15 03:13:22 pfsense check_reload_status: Syncing firewall
    Jun 15 03:13:24 pfsense php: rc.bootup: Finished installing package suricata
    Jun 15 03:13:24 pfsense php: rc.bootup: Uninstalling package OpenVPN Client Export Utility
    Jun 15 03:13:24 pfsense check_reload_status: Syncing firewall
    Jun 15 03:13:46 pfsense check_reload_status: Syncing firewall
    Jun 15 03:13:54 pfsense php: rc.bootup: Finished uninstalling package OpenVPN Client Export Utility
    Jun 15 03:13:54 pfsense php: rc.bootup: Reinstalling package OpenVPN Client Export Utility
    Jun 15 03:13:54 pfsense kernel: 
    Jun 15 03:13:54 pfsense check_reload_status: Syncing firewall
    Jun 15 03:13:54 pfsense php: rc.bootup: Beginning package installation for OpenVPN Client Export Utility .
    Jun 15 03:13:55 pfsense check_reload_status: Syncing firewall
    Jun 15 03:13:55 pfsense kernel: 
    Jun 15 03:13:56 pfsense kernel: 1%
    Jun 15 03:13:56 pfsense ker   9%
    Jun 15 03:13:57 pfsense ker  10%
    Jun 15 03:13:57 pfsense ker  30%
    Jun 15 03:13:57 pfsense ker  50%
    Jun 15 03:13:57 pfsense ker  80%
    Jun 15 03:13:57 pfsense ker 100%
    Jun 15 03:14:11 pfsense kernel: 1%
    Jun 15 03:14:11 pfsense ker  10%
    Jun 15 03:14:12 pfsense ker  20%
    Jun 15 03:14:12 pfsense ker  40%
    Jun 15 03:14:12 pfsense ker  50%
    Jun 15 03:14:12 pfsense ker  60%
    Jun 15 03:14:12 pfsense ker  70%
    Jun 15 03:14:12 pfsense ker  80%
    Jun 15 03:14:12 pfsense ker 100%
    Jun 15 03:14:20 pfsense kernel: 50%
    Jun 15 03:14:20 pfsense ker 100%
    Jun 15 03:14:20 pfsense kerne   3%
    Jun 15 03:14:20 pfsense ker  10%
    Jun 15 03:14:21 pfsense ker  20%
    Jun 15 03:14:21 pfsense ker
    Jun 15 03:14:21 pfsense kernel  50%
    Jun 15 03:14:21 pfsense ker  60%
    Jun 15 03:14:21 pfsense ker  70%
    Jun 15 03:14:21 pfsense ker  90%
    Jun 15 03:14:22 pfsense ker 100%
    Jun 15 03:14:22 pfsense kernel: 100%
    Jun 15 03:14:25 pfsense check_reload_status: Syncing firewall
    Jun 15 03:14:26 pfsense php: rc.bootup: Finished installing package OpenVPN Client Export Utility
    Jun 15 03:14:26 pfsense php: rc.bootup: Finished reinstalling all packages.
    Jun 15 03:14:26 pfsense kernel: Starting syslog...
    Jun 15 03:14:26 pfsense kernel: done.
    Jun 15 03:14:26 pfsense php-fpm[257]: /rc.start_packages: Restarting/Starting all packages.</fujitsu></intel></intel></intel></intel></intel></intel></pnp0c02></pnp0c01></generic></system></isa></pnp0c02></pnp0c01></at></keyboard></at></at></cpu></serial></ata></ata></intel></isa></pci-isa></realtek></mii></realtek></realtek></mii></realtek></realtek></mii></realtek></realtek></mii></realtek></pci></pcibios></intel></intel></intel></vga-compatible></intel></vga-compatible></pci></pci></software></software,></fpu,vme,de,pse,tsc,msr,mce,cx8,sep,mtrr,pge,mca,cmov,pat,clflush,dts,acpi,mmx,fxsr,sse,sse2,tm,pbe>
    


  • I'm seeing this too on my Peer to Peer Shared Key Client.

    Jul 1 20:07:42	openvpn[70476]: Initialization Sequence Completed
    Jul 1 20:07:41	openvpn[70476]: Peer Connection Initiated with [AF_INET]XXX.XXX.XXX.XXX:9999
    Jul 1 20:07:41	openvpn[56325]: Exiting due to fatal error
    Jul 1 20:07:41	openvpn[56325]: Cannot open TUN/TAP dev /dev/tun2: Device busy (errno=16)
    Jul 1 20:07:41	openvpn[56325]: TUN/TAP device ovpnc2 exists previously, keep at program end
    


  • As an update… I haven't had this happen in the last 2 weeks or so of snapshots.