Netgate Discussion Forum
    • Categories
    • Recent
    • Tags
    • Popular
    • Users
    • Search
    • Register
    • Login

    Avahi stopping after VPN IP Change

    Scheduled Pinned Locked Moved pfSense Packages
    2 Posts 2 Posters 1.1k Views
    Loading More Posts
    • Oldest to Newest
    • Newest to Oldest
    • Most Votes
    Reply
    • Reply as topic
    Log in to reply
    This topic has been deleted. Only users with topic management privileges can see it.
    • R
      Rexyboy
      last edited by

      I am having some problems with Avahi stopping occasionally which I think I have tracked down to occurring when my VPN client connection restarts.  From the logs it appears that the sequence of events are:

      • VPN connection drops (perfectly normal) on my dodgy WAN connection

      • VPN reconnects and is allocated a new address

      • rc.newwanip notices the change and restarts Avahi(not sure why)

      • Avahi fails to come up correctly

      I am not sure whether the problem is that Avahi should go through this process but is hanging or if rc.newwanip shouldn't be touching Avahi.  The strange thing (to me) about this is that the VPN interface (BLA_VPN) is set as an excluded interface in the Avahi config page.

      I am running: pfSense 2.3-RELEASE (amd64) and Avahi 1.11_2 - let men now if you need other details.

      Any help to get to the bottom of this one would be appreciated.

      Logs as follows:

      
      Jun 6 23:39:21	kernel		ovpnc1: link state changed to DOWN
      Jun 6 23:39:21	avahi-daemon	22575	Withdrawing workstation service for ovpnc1.
      Jun 6 23:39:21	check_reload_status		Reloading filter
      Jun 6 23:39:22	kernel		ovpnc1: link state changed to UP
      Jun 6 23:39:22	check_reload_status		rc.newwanip starting ovpnc1
      Jun 6 23:39:22	xinetd	17441	Starting reconfiguration
      Jun 6 23:39:22	xinetd	17441	Swapping defaults
      Jun 6 23:39:22	xinetd	17441	readjusting service 6969-udp
      Jun 6 23:39:22	xinetd	17441	Reconfigured: new=0 old=1 dropped=0 (services)
      Jun 6 23:39:23	php-fpm	30725	/rc.newwanip: rc.newwanip: Info: starting on ovpnc1.
      Jun 6 23:39:23	php-fpm	30725	/rc.newwanip: rc.newwanip: on (IP address: xx.xx.xx.198) (interface: BLA_VPN[opt5]) (real interface: ovpnc1).
      Jun 6 23:39:23	php-fpm	30725	/rc.newwanip: IP has changed, killing states on former IP xx.xx.xx.195.
      Jun 6 23:39:23	xinetd	17441	Starting reconfiguration
      Jun 6 23:39:23	xinetd	17441	Swapping defaults
      Jun 6 23:39:23	xinetd	17441	readjusting service 6969-udp
      Jun 6 23:39:23	xinetd	17441	Reconfigured: new=0 old=1 dropped=0 (services)
      Jun 6 23:39:27	php-fpm	30725	/rc.newwanip: Creating rrd update script
      Jun 6 23:39:29	php-fpm	30725	/rc.newwanip: pfSense package system has detected an IP change or dynamic WAN reconnection - xx.xx.xx.195 -> xx.xx.xx.198 - Restarting packages.
      Jun 6 23:39:29	check_reload_status		Starting packages
      Jun 6 23:39:30	php-fpm	30725	/rc.start_packages: Restarting/Starting all packages.
      Jun 6 23:39:30	avahi-daemon	22575	Got SIGTERM, quitting.
      Jun 6 23:39:30	avahi-daemon	22575	Leaving mDNS multicast group on interface ovpns2.IPv4 with address 192.168.100.1.
      Jun 6 23:39:30	avahi-daemon	22575	avahi-daemon 0.6.31 exiting.
      Jun 6 23:39:30	php-fpm	30725	/rc.start_packages: The command '/usr/local/etc/rc.d/avahi-daemon.sh stop' returned exit code '1', the output was 'Stopping dbus. Waiting for PIDS: 20535.'
      Jun 6 23:39:30	root		/usr/local/etc/rc.d/dbus: WARNING: failed to start dbus
      Jun 6 23:39:30	root		/usr/local/etc/rc.d/dbus: WARNING: failed to start dbus
      Jun 6 23:39:35	avahi-daemon	386	Found user 'avahi' (UID 558) and group 'avahi' (GID 558).
      Jun 6 23:39:35	avahi-daemon	386	Successfully dropped root privileges.
      Jun 6 23:39:35	avahi-daemon	1696	Found user 'avahi' (UID 558) and group 'avahi' (GID 558).
      Jun 6 23:39:35	avahi-daemon	1549	Found user 'avahi' (UID 558) and group 'avahi' (GID 558).
      Jun 6 23:39:35	avahi-daemon	386	avahi-daemon 0.6.31 starting up.
      Jun 6 23:39:35	avahi-daemon	1696	Successfully dropped root privileges.
      Jun 6 23:39:35	avahi-daemon	1549	Successfully dropped root privileges.
      Jun 6 23:39:35	avahi-daemon	386	WARNING: No NSS support for mDNS detected, consider installing nss-mdns!
      Jun 6 23:39:35	avahi-daemon	1696	open(/var/run/avahi-daemon//pid): File exists
      Jun 6 23:39:35	avahi-daemon	1696	Failed to create PID file: File exists
      Jun 6 23:39:35	avahi-daemon	1549	open(/var/run/avahi-daemon//pid): File exists
      Jun 6 23:39:35	avahi-daemon	1549	Failed to create PID file: File exists
      Jun 6 23:39:35	avahi-daemon	386	dbus_bus_get_private(): Failed to connect to socket /var/run/dbus/system_bus_socket: No such file or directory
      Jun 6 23:39:35	avahi-daemon	386	WARNING: Failed to contact D-Bus daemon.
      Jun 6 23:39:35	avahi-daemon	386	avahi-daemon 0.6.31 exiting.
      
      
      1 Reply Last reply Reply Quote 0
      • K
        kpa
        last edited by

        The avahi shutdown seems to kill the dbus daemon as well which is required for avahi to run. It then fails to start the dbus daemon before attemping to start the avahi daemon again. I would say that restarting of the dbus daemon is unnecessary because it doesn't listen on IP addresses/interfaces and could be left running.

        1 Reply Last reply Reply Quote 0
        • First post
          Last post
        Copyright 2025 Rubicon Communications LLC (Netgate). All rights reserved.