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 0It 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 -
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.
-
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.
