[Pkg-utopia-maintainers] Bug#764084: avahi-daemon creates eth0:avahi briefly after startup overriding wlan0, no eth0 connected
Ævar Arnfjörð Bjarmason
avarab at gmail.com
Sun Oct 5 11:45:26 UTC 2014
Package: avahi-daemon
Version: 0.6.31-4
Severity: normal
Tags: upstream
I don't know if this bug is properly filed under avahi-daemon or
avahi-autoipd.
When I start up my laptop that's only connected via wlan0 it takes
about a minute until avahi-autoipd/avahi-daemon creates an eth0:avahi
interface, and makes that default route. This renders my Internet
connection useless until I manually remove the route or shut down the
interface.
Before it runs the ifconfig/route output is this (I've removed the
"lo" interface for brevity):
eth0 Link encap:Ethernet HWaddr b8:ca:3a:c0:da:4e
UP BROADCAST MULTICAST MTU:1500 Metric:1
RX packets:0 errors:0 dropped:0 overruns:0 frame:0
TX packets:0 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:1000
RX bytes:0 (0.0 B) TX bytes:0 (0.0 B)
Interrupt:20 Memory:f7e00000-f7e20000
wlan0 Link encap:Ethernet HWaddr 84:3a:4b:12:34:58
inet addr:192.168.0.200 Bcast:192.168.0.255 Mask:255.255.255.0
inet6 addr: fe80::863a:4bff:fe12:3458/64 Scope:Link
UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
RX packets:568 errors:0 dropped:0 overruns:0 frame:0
TX packets:493 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:1000
RX bytes:280017 (273.4 KiB) TX bytes:106784 (104.2 KiB)
Kernel IP routing table
Destination Gateway Genmask Flags Metric Ref Use Iface
0.0.0.0 192.168.0.1 0.0.0.0 UG 1024 0 0 wlan0
169.254.0.0 0.0.0.0 255.255.0.0 U 1000 0 0 wlan0
192.168.0.0 0.0.0.0 255.255.255.0 U 0 0 0 wlan0
And afterwards:
eth0 Link encap:Ethernet HWaddr b8:ca:3a:c0:da:4e
UP BROADCAST MULTICAST MTU:1500 Metric:1
RX packets:0 errors:0 dropped:0 overruns:0 frame:0
TX packets:0 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:1000
RX bytes:0 (0.0 B) TX bytes:0 (0.0 B)
Interrupt:20 Memory:f7e00000-f7e20000
eth0:avahi Link encap:Ethernet HWaddr b8:ca:3a:c0:da:4e
inet addr:169.254.9.109 Bcast:169.254.255.255 Mask:255.255.0.0
UP BROADCAST MULTICAST MTU:1500 Metric:1
Interrupt:20 Memory:f7e00000-f7e20000
wlan0 Link encap:Ethernet HWaddr 84:3a:4b:12:34:58
inet addr:192.168.0.200 Bcast:192.168.0.255 Mask:255.255.255.0
inet6 addr: fe80::863a:4bff:fe12:3458/64 Scope:Link
UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
RX packets:723 errors:0 dropped:0 overruns:0 frame:0
TX packets:625 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:1000
RX bytes:318197 (310.7 KiB) TX bytes:127659 (124.6 KiB)
Kernel IP routing table
Destination Gateway Genmask Flags Metric Ref Use Iface
0.0.0.0 0.0.0.0 0.0.0.0 U 1002 0 0 eth0
0.0.0.0 192.168.0.1 0.0.0.0 UG 1024 0 0 wlan0
169.254.0.0 0.0.0.0 255.255.0.0 U 0 0 0 eth0
169.254.0.0 0.0.0.0 255.255.0.0 U 1000 0 0 wlan0
192.168.0.0 0.0.0.0 255.255.255.0 U 0 0 0 wlan0
This is the full daemon.log as of startup until avahi-daemon creates
the eth0:avahi interface:
Oct 5 13:28:32 snth systemd[1]: Expecting device dev-disk-by\x2duuid-f9a53937\x2d6e8b\x2d438f\x2dac10\x2de372ba1c1030.device...
Oct 5 13:28:32 snth systemd[1]: Expecting device dev-mapper-sda5_crypt.device...
Oct 5 13:28:32 snth systemd[1]: Starting Device-mapper event daemon FIFOs.
Oct 5 13:28:32 snth systemd[1]: Listening on Device-mapper event daemon FIFOs.
Oct 5 13:28:32 snth systemd[1]: Starting LVM2 metadata daemon socket.
Oct 5 13:28:32 snth systemd[1]: Listening on LVM2 metadata daemon socket.
Oct 5 13:28:32 snth systemd[1]: Expecting device dev-mapper-snth\x2d\x2dvg\x2dswap_1.device...
Oct 5 13:28:32 snth systemd[1]: Starting File System Check on Root Device...
Oct 5 13:28:32 snth systemd[1]: Starting udev Kernel Socket.
Oct 5 13:28:32 snth systemd[1]: Listening on udev Kernel Socket.
Oct 5 13:28:32 snth systemd[1]: Starting udev Control Socket.
Oct 5 13:28:32 snth systemd[1]: Started System Logging Service.
Oct 5 13:28:32 snth avahi-daemon[682]: Found user 'avahi' (UID 103) and group 'avahi' (GID 108).
Oct 5 13:28:32 snth avahi-daemon[682]: Successfully dropped root privileges.
Oct 5 13:28:32 snth avahi-daemon[682]: avahi-daemon 0.6.31 starting up.
Oct 5 13:28:32 snth systemd[1]: Mounted Arbitrary Executable File Formats File System.
Oct 5 13:28:32 snth systemd[1]: Started Enable support for additional executable binary formats.
Oct 5 13:28:32 snth ModemManager[685]: <info> ModemManager (version 1.4.0) starting in system bus...
Oct 5 13:28:32 snth systemd[1]: Started Avahi mDNS/DNS-SD Stack.
Oct 5 13:28:32 snth systemd[1]: Starting Make remote CUPS printers available locally...
Oct 5 13:28:32 snth systemd[1]: Started Make remote CUPS printers available locally.
Oct 5 13:28:32 snth systemd[1]: Started Login Service.
Oct 5 13:28:32 snth avahi-daemon[682]: Successfully called chroot().
Oct 5 13:28:32 snth dbus[674]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkitd.service'
Oct 5 13:28:32 snth systemd[1]: Starting Authenticate and Authorize Users to Run Privileged Tasks...
Oct 5 13:28:32 snth NetworkManager[689]: <info> NetworkManager (version 0.9.10.0) is starting...
Oct 5 13:28:32 snth NetworkManager[689]: <info> Read config: /etc/NetworkManager/NetworkManager.conf
Oct 5 13:28:32 snth NetworkManager[689]: <info> WEXT support is enabled
Oct 5 13:28:32 snth polkitd[865]: started daemon version 0.105 using authority implementation `local' version `0.105'
Oct 5 13:28:32 snth dbus[674]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Oct 5 13:28:32 snth systemd[1]: Started Authenticate and Authorize Users to Run Privileged Tasks.
Oct 5 13:28:32 snth accounts-daemon[697]: started daemon version 0.6.37
Oct 5 13:28:32 snth systemd[1]: Started Accounts Service.
Oct 5 13:28:32 snth dbus[674]: [system] Activating via systemd: service name='org.freedesktop.ColorManager' unit='colord.service'
Oct 5 13:28:32 snth systemd[1]: Starting Manage, Install and Generate Color Profiles...
Oct 5 13:28:32 snth colord: Using mapping database file /var/lib/colord/mapping.db
Oct 5 13:28:32 snth systemd[1]: Started Modem Manager.
Oct 5 13:28:32 snth colord: Using device database file /var/lib/colord/storage.db
Oct 5 13:28:32 snth colord: Using profile database file /var/lib/colord/storage.db
Oct 5 13:28:32 snth colord: loaded plugin libcd_plugin_sane.so
Oct 5 13:28:32 snth colord: loaded plugin libcd_plugin_scanner.so
Oct 5 13:28:32 snth colord: loaded plugin libcd_plugin_camera.so
Oct 5 13:28:32 snth colord: Daemon ready for requests
Oct 5 13:28:32 snth dbus[674]: [system] Successfully activated service 'org.freedesktop.ColorManager'
Oct 5 13:28:32 snth systemd[1]: Started Manage, Install and Generate Color Profiles.
Oct 5 13:28:32 snth avahi-daemon[682]: Network interface enumeration completed.
Oct 5 13:28:32 snth minissdpd[716]: setsockopt(udp, IP_ADD_MEMBERSHIP)(0.0.0.0): No such device
Oct 5 13:28:32 snth minissdpd[716]: Failed to add IPv4 multicast membership for interface 0.0.0.0.
Oct 5 13:28:32 snth avahi-daemon[682]: Registering HINFO record with values 'X86_64'/'LINUX'.
Oct 5 13:28:32 snth avahi-daemon[682]: Server startup complete. Host name is snth.local. Local service cookie is 2530708708.
Oct 5 13:28:32 snth minissdpd[666]: Starting UPnP devices daemon: MiniSSDPd.
Oct 5 13:28:32 snth systemd[1]: Started LSB: keep memory of all UPnP devices that announced themselves.
Oct 5 13:28:32 snth NetworkManager[689]: <info> VPN: loaded org.freedesktop.NetworkManager.openvpn
Oct 5 13:28:32 snth NetworkManager[689]: <info> init!
Oct 5 13:28:32 snth NetworkManager[689]: <info> update_system_hostname
Oct 5 13:28:32 snth NetworkManager[689]: <info> interface-parser: parsing file /etc/network/interfaces
Oct 5 13:28:32 snth NetworkManager[689]: <info> interface-parser: finished parsing file /etc/network/interfaces
Oct 5 13:28:32 snth NetworkManager[689]: <info> guessed connection type (eth0) = 802-3-ethernet
Oct 5 13:28:32 snth NetworkManager[689]: <info> update_connection_setting_from_if_block: name:eth0, type:802-3-ethernet, id:Ifupdown (eth0), uuid: 681b428f-beaf-8932-dce4-687ed5bae28e
Oct 5 13:28:32 snth NetworkManager[689]: <info> adding eth0 to connections
Oct 5 13:28:32 snth NetworkManager[689]: <info> adding iface eth0 to eni_ifaces
Oct 5 13:28:32 snth NetworkManager[689]: <info> autoconnect
Oct 5 13:28:32 snth NetworkManager[689]: <info> management mode: unmanaged
Oct 5 13:28:32 snth NetworkManager[689]: <info> Loaded plugin ifupdown: (C) 2008 Canonical Ltd. To report bugs please use the NetworkManager mailing list.
Oct 5 13:28:32 snth NetworkManager[689]: <info> Loaded plugin keyfile: (c) 2007 - 2013 Red Hat, Inc. To report bugs please use the NetworkManager mailing list.
Oct 5 13:28:32 snth NetworkManager[689]: <info> (24187968) ... get_connections.
Oct 5 13:28:32 snth NetworkManager[689]: <info> (24187968) ... get_connections (managed=false): return empty list.
Oct 5 13:28:32 snth exim4[663]: Starting MTA: exim4.
Oct 5 13:28:32 snth systemd[1]: Started LSB: exim Mail Transport Agent.
Oct 5 13:28:32 snth NetworkManager[689]: <info> new connection /etc/NetworkManager/system-connections/hlagh
Oct 5 13:28:32 snth dhclient: Listening on LPF/eth0/b8:ca:3a:c0:da:4e
Oct 5 13:28:32 snth dhclient: Sending on LPF/eth0/b8:ca:3a:c0:da:4e
Oct 5 13:28:32 snth dhclient: Sending on Socket/fallback
Oct 5 13:28:32 snth dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 4
Oct 5 13:28:32 snth ifup[506]: Listening on LPF/eth0/b8:ca:3a:c0:da:4e
Oct 5 13:28:32 snth ifup[506]: Sending on LPF/eth0/b8:ca:3a:c0:da:4e
Oct 5 13:28:32 snth ifup[506]: Sending on Socket/fallback
Oct 5 13:28:32 snth ifup[506]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 4
Oct 5 13:28:32 snth NetworkManager[689]: <info> new connection /etc/NetworkManager/system-connections/Booking.com OpenVPN
Oct 5 13:28:32 snth NetworkManager[689]: <info> get unmanaged devices count: 1
Oct 5 13:28:32 snth NetworkManager[689]: <info> monitoring kernel firmware directory '/lib/firmware'.
Oct 5 13:28:32 snth NetworkManager[689]: <info> monitoring ifupdown state file '/run/network/ifstate'.
Oct 5 13:28:32 snth NetworkManager[689]: <info> rfkill0: found WiFi radio killswitch (at /sys/devices/pci0000:00/0000:00:1c.1/0000:02:00.0/ieee80211/phy0/rfkill0) (driver iwlwifi)
Oct 5 13:28:32 snth NetworkManager[689]: <info> rfkill1: found WiFi radio killswitch (at /sys/devices/platform/dell-laptop/rfkill/rfkill1) (platform driver dell-laptop)
Oct 5 13:28:32 snth NetworkManager[689]: <info> WiFi hardware radio set enabled
Oct 5 13:28:32 snth NetworkManager[689]: <info> WWAN hardware radio set enabled
Oct 5 13:28:32 snth NetworkManager[689]: <info> Loaded device plugin: /usr/lib/x86_64-linux-gnu/NetworkManager/libnm-device-plugin-wwan.so
Oct 5 13:28:32 snth NetworkManager[689]: <info> Loaded device plugin: /usr/lib/x86_64-linux-gnu/NetworkManager/libnm-device-plugin-adsl.so
Oct 5 13:28:32 snth NetworkManager[689]: <info> Loaded device plugin: /usr/lib/x86_64-linux-gnu/NetworkManager/libnm-device-plugin-bluetooth.so
Oct 5 13:28:32 snth NetworkManager[689]: <info> Loaded device plugin: /usr/lib/x86_64-linux-gnu/NetworkManager/libnm-device-plugin-wifi.so
Oct 5 13:28:32 snth NetworkManager[689]: <info> WiFi enabled by radio killswitch; enabled by state file
Oct 5 13:28:32 snth NetworkManager[689]: <info> WWAN enabled by radio killswitch; enabled by state file
Oct 5 13:28:32 snth NetworkManager[689]: <info> WiMAX enabled by radio killswitch; enabled by state file
Oct 5 13:28:32 snth NetworkManager[689]: <info> Networking is enabled by state file
Oct 5 13:28:32 snth NetworkManager[689]: <info> (lo): link connected
Oct 5 13:28:32 snth NetworkManager[689]: <info> (lo): carrier is ON
Oct 5 13:28:32 snth NetworkManager[689]: <info> (lo): new Generic device (driver: 'unknown' ifindex: 1)
Oct 5 13:28:32 snth NetworkManager[689]: <info> (lo): exported as /org/freedesktop/NetworkManager/Devices/0
Oct 5 13:28:32 snth NetworkManager[689]: <info> (eth0): carrier is OFF
Oct 5 13:28:32 snth NetworkManager[689]: <info> (eth0): new Ethernet device (driver: 'e1000e' ifindex: 2)
Oct 5 13:28:32 snth NetworkManager[689]: <info> (eth0): exported as /org/freedesktop/NetworkManager/Devices/1
Oct 5 13:28:32 snth NetworkManager[689]: <info> (wlan0): using nl80211 for WiFi device control
Oct 5 13:28:32 snth NetworkManager[689]: <info> (wlan0): driver supports Access Point (AP) mode
Oct 5 13:28:32 snth NetworkManager[689]: <info> (wlan0): new 802.11 WiFi device (driver: 'iwlwifi' ifindex: 3)
Oct 5 13:28:32 snth NetworkManager[689]: <info> (wlan0): exported as /org/freedesktop/NetworkManager/Devices/2
Oct 5 13:28:32 snth NetworkManager[689]: <info> (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Oct 5 13:28:32 snth systemd[1]: Started Network Manager.
Oct 5 13:28:32 snth systemd[1]: Starting LSB: Openvpn VPN service...
Oct 5 13:28:32 snth openvpn[1005]: Starting virtual private network daemon:.
Oct 5 13:28:32 snth systemd[1]: Started LSB: Openvpn VPN service.
Oct 5 13:28:32 snth systemd[1]: Starting Multi-User System.
Oct 5 13:28:32 snth systemd[1]: Reached target Multi-User System.
Oct 5 13:28:32 snth systemd[1]: Starting GNOME Display Manager...
Oct 5 13:28:32 snth colord: Profile added: hp-LaserJet-4350-Gray..
Oct 5 13:28:32 snth colord[983]: (colord:983): Cd-WARNING **: failed to get session [pid 670]: Unknown error -2
Oct 5 13:28:32 snth colord: Device added: cups-hp-LaserJet-4350
Oct 5 13:28:32 snth systemd[1]: Started GNOME Display Manager.
Oct 5 13:28:32 snth systemd[1]: Starting Graphical Interface.
Oct 5 13:28:32 snth systemd[1]: Reached target Graphical Interface.
Oct 5 13:28:32 snth systemd[1]: Starting Update UTMP about System Runlevel Changes...
Oct 5 13:28:32 snth systemd[1]: Starting X11 Display Manager.
Oct 5 13:28:32 snth systemd[1]: Reached target X11 Display Manager.
Oct 5 13:28:32 snth systemd[1]: Started Update UTMP about System Runlevel Changes.
Oct 5 13:28:32 snth systemd[1]: Startup finished in 8.592s (kernel) + 1.847s (userspace) = 10.439s.
Oct 5 13:28:32 snth colord: Profile added: Lexmark-C925-50412032501V4-LHS2-HV-P244b-Gray..
Oct 5 13:28:32 snth colord: Profile added: Lexmark-C925-50412032501V4-LHS2-HV-P244b-CMYK..
Oct 5 13:28:32 snth colord[983]: (colord:983): Cd-WARNING **: failed to get session [pid 670]: Unknown error -2
Oct 5 13:28:32 snth colord: Device added: cups-Lexmark-C925-50412032501V4-LHS2-HV-P244b
Oct 5 13:28:32 snth colord: Profile added: Lexmark-X548-Series-Gray..
Oct 5 13:28:32 snth colord: Profile added: Lexmark-X548-Series-CMYK..
Oct 5 13:28:32 snth colord[983]: (colord:983): Cd-WARNING **: failed to get session [pid 670]: Unknown error -2
Oct 5 13:28:32 snth colord: Device added: cups-Lexmark-X548-Series
Oct 5 13:28:32 snth gdm3[1019]: Failed to give slave programs access to the display. Trying to proceed.
Oct 5 13:28:33 snth NetworkManager[689]: <info> (wlan0): preparing device
Oct 5 13:28:33 snth dbus[674]: [system] Activating via systemd: service name='fi.w1.wpa_supplicant1' unit='wpa_supplicant.service'
Oct 5 13:28:33 snth NetworkManager[689]: <info> NetworkManager state is now CONNECTED_GLOBAL
Oct 5 13:28:33 snth systemd[1]: Starting WPA supplicant...
Oct 5 13:28:33 snth NetworkManager[689]: <info> ModemManager available in the bus
Oct 5 13:28:33 snth dbus[674]: [system] Successfully activated service 'fi.w1.wpa_supplicant1'
Oct 5 13:28:33 snth NetworkManager[689]: <info> wpa_supplicant started
Oct 5 13:28:33 snth wpa_supplicant[1044]: Successfully initialized wpa_supplicant
Oct 5 13:28:33 snth systemd[1]: Started WPA supplicant.
Oct 5 13:28:33 snth NetworkManager[689]: <info> (wlan0) supports 5 scan SSIDs
Oct 5 13:28:33 snth NetworkManager[689]: <info> (wlan0): supplicant interface state: starting -> ready
Oct 5 13:28:33 snth NetworkManager[689]: <info> (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42]
Oct 5 13:28:33 snth NetworkManager[689]: <info> (wlan0): supplicant interface state: ready -> disconnected
Oct 5 13:28:33 snth NetworkManager[689]: <info> (wlan0) supports 5 scan SSIDs
Oct 5 13:28:33 snth NetworkManager[689]: <info> startup complete
Oct 5 13:28:33 snth wpa_supplicant[1044]: wlan0: CTRL-EVENT-SCAN-STARTED
Oct 5 13:28:33 snth systemd[1]: Starting user-114.slice.
Oct 5 13:28:33 snth systemd[1]: Created slice user-114.slice.
Oct 5 13:28:33 snth systemd[1]: Starting User Manager for 114...
Oct 5 13:28:33 snth systemd[1]: Starting Session c1 of user Debian-gdm.
Oct 5 13:28:33 snth systemd[1]: Started Session c1 of user Debian-gdm.
Oct 5 13:28:33 snth systemd[1046]: Failed to open private bus connection: Failed to connect to socket /run/user/114/dbus/user_bus_socket: No such file or directory
Oct 5 13:28:33 snth systemd[1046]: Starting Default.
Oct 5 13:28:33 snth systemd[1046]: Reached target Default.
Oct 5 13:28:33 snth systemd[1046]: Startup finished in 6ms.
Oct 5 13:28:33 snth systemd[1]: Started User Manager for 114.
Oct 5 13:28:33 snth gnome-session[1048]: WARNING: Could not parse desktop file caribou-autostart.desktop or it references a not found TryExec binary
Oct 5 13:28:33 snth dbus[674]: [system] Activating via systemd: service name='org.freedesktop.UPower' unit='upower.service'
Oct 5 13:28:33 snth systemd[1]: Starting Daemon for power management...
Oct 5 13:28:33 snth dbus[674]: [system] Successfully activated service 'org.freedesktop.UPower'
Oct 5 13:28:33 snth systemd[1]: Started Daemon for power management.
Oct 5 13:28:33 snth dbus[674]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service'
Oct 5 13:28:33 snth systemd[1]: [/lib/systemd/system/rtkit-daemon.service:32] Unknown lvalue 'ControlGroup' in section 'Service'
Oct 5 13:28:33 snth systemd[1]: Starting RealtimeKit Scheduling Policy Service...
Oct 5 13:28:33 snth dbus[674]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1'
Oct 5 13:28:33 snth systemd[1]: Started RealtimeKit Scheduling Policy Service.
Oct 5 13:28:33 snth rtkit-daemon[1102]: Successfully called chroot.
Oct 5 13:28:33 snth rtkit-daemon[1102]: Successfully dropped privileges.
Oct 5 13:28:33 snth rtkit-daemon[1102]: Successfully limited resources.
Oct 5 13:28:33 snth rtkit-daemon[1102]: Running.
Oct 5 13:28:33 snth rtkit-daemon[1102]: Canary thread running.
Oct 5 13:28:33 snth rtkit-daemon[1102]: Watchdog thread running.
Oct 5 13:28:33 snth rtkit-daemon[1102]: Successfully made thread 1101 of process 1101 (/usr/bin/pulseaudio) owned by '114' high priority at nice level -11.
Oct 5 13:28:33 snth rtkit-daemon[1102]: Supervising 1 threads of 1 processes of 1 users.
Oct 5 13:28:33 snth rtkit-daemon[1102]: Supervising 1 threads of 1 processes of 1 users.
Oct 5 13:28:33 snth rtkit-daemon[1102]: Successfully made thread 1109 of process 1101 (/usr/bin/pulseaudio) owned by '114' RT at priority 5.
Oct 5 13:28:33 snth rtkit-daemon[1102]: Supervising 2 threads of 1 processes of 1 users.
Oct 5 13:28:33 snth rtkit-daemon[1102]: Supervising 2 threads of 1 processes of 1 users.
Oct 5 13:28:33 snth rtkit-daemon[1102]: Successfully made thread 1110 of process 1101 (/usr/bin/pulseaudio) owned by '114' RT at priority 5.
Oct 5 13:28:33 snth rtkit-daemon[1102]: Supervising 3 threads of 1 processes of 1 users.
Oct 5 13:28:33 snth rtkit-daemon[1102]: Successfully made thread 1112 of process 1112 (/usr/bin/pulseaudio) owned by '114' high priority at nice level -11.
Oct 5 13:28:33 snth rtkit-daemon[1102]: Supervising 4 threads of 2 processes of 1 users.
Oct 5 13:28:33 snth dbus[674]: [system] Activating via systemd: service name='org.freedesktop.locale1' unit='dbus-org.freedesktop.locale1.service'
Oct 5 13:28:33 snth systemd[1]: Starting Locale Service...
Oct 5 13:28:33 snth dbus[674]: [system] Successfully activated service 'org.freedesktop.locale1'
Oct 5 13:28:33 snth systemd[1]: Started Locale Service.
Oct 5 13:28:33 snth colord: Profile added: icc-898768e766786c23d681fc41635789c0
Oct 5 13:28:33 snth colord: Profile added: icc-8e6f7eb69820340b198c61167d2eabe1
Oct 5 13:28:34 snth dbus[674]: [system] Activating via systemd: service name='org.freedesktop.GeoClue2' unit='geoclue.service'
Oct 5 13:28:34 snth systemd[1]: Starting Location Lookup Service...
Oct 5 13:28:34 snth dbus[674]: [system] Successfully activated service 'org.freedesktop.GeoClue2'
Oct 5 13:28:34 snth systemd[1]: Started Location Lookup Service.
Oct 5 13:28:34 snth colord: Automatic metadata add icc-898768e766786c23d681fc41635789c0 to xrandr-LVDS1
Oct 5 13:28:34 snth colord: Device added: xrandr-LVDS1
Oct 5 13:28:35 snth ModemManager[685]: <warn> Couldn't find support for device at '/sys/devices/pci0000:00/0000:00:19.0': not supported by any plugin
Oct 5 13:28:35 snth ModemManager[685]: <warn> Couldn't find support for device at '/sys/devices/pci0000:00/0000:00:1c.1/0000:02:00.0': not supported by any plugin
Oct 5 13:28:36 snth NetworkManager[689]: <info> (wlan0): supplicant interface state: disconnected -> inactive
Oct 5 13:28:36 snth NetworkManager[689]: <info> Auto-activating connection 'hlagh'.
Oct 5 13:28:36 snth NetworkManager[689]: <info> Activation (wlan0) starting connection 'hlagh'
Oct 5 13:28:36 snth NetworkManager[689]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Oct 5 13:28:36 snth NetworkManager[689]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Oct 5 13:28:36 snth NetworkManager[689]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Oct 5 13:28:36 snth NetworkManager[689]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Oct 5 13:28:36 snth NetworkManager[689]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Oct 5 13:28:36 snth NetworkManager[689]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Oct 5 13:28:36 snth NetworkManager[689]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Oct 5 13:28:36 snth NetworkManager[689]: <info> Activation (wlan0/wireless): connection 'hlagh' has security, and secrets exist. No new secrets needed.
Oct 5 13:28:36 snth NetworkManager[689]: <info> Config: added 'ssid' value 'hlagh'
Oct 5 13:28:36 snth NetworkManager[689]: <info> Config: added 'scan_ssid' value '1'
Oct 5 13:28:36 snth NetworkManager[689]: <info> Config: added 'key_mgmt' value 'WPA-PSK'
Oct 5 13:28:36 snth NetworkManager[689]: <info> Config: added 'auth_alg' value 'OPEN'
Oct 5 13:28:36 snth NetworkManager[689]: <info> Config: added 'psk' value '<omitted>'
Oct 5 13:28:36 snth NetworkManager[689]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Oct 5 13:28:36 snth NetworkManager[689]: <info> Config: set interface ap_scan to 1
Oct 5 13:28:36 snth wpa_supplicant[1044]: wlan0: SME: Trying to authenticate with 54:a0:50:e4:87:d4 (SSID='hlagh' freq=5200 MHz)
Oct 5 13:28:36 snth NetworkManager[689]: <info> (wlan0): supplicant interface state: inactive -> authenticating
Oct 5 13:28:36 snth wpa_supplicant[1044]: wlan0: Trying to associate with 54:a0:50:e4:87:d4 (SSID='hlagh' freq=5200 MHz)
Oct 5 13:28:36 snth NetworkManager[689]: <info> (wlan0): supplicant interface state: authenticating -> associating
Oct 5 13:28:36 snth wpa_supplicant[1044]: wlan0: Associated with 54:a0:50:e4:87:d4
Oct 5 13:28:36 snth NetworkManager[689]: <info> (wlan0): supplicant interface state: associating -> 4-way handshake
Oct 5 13:28:36 snth wpa_supplicant[1044]: wlan0: WPA: Key negotiation completed with 54:a0:50:e4:87:d4 [PTK=CCMP GTK=CCMP]
Oct 5 13:28:36 snth wpa_supplicant[1044]: wlan0: CTRL-EVENT-CONNECTED - Connection to 54:a0:50:e4:87:d4 completed [id=0 id_str=]
Oct 5 13:28:36 snth NetworkManager[689]: <info> (wlan0): supplicant interface state: 4-way handshake -> completed
Oct 5 13:28:36 snth NetworkManager[689]: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to wireless network 'hlagh'.
Oct 5 13:28:36 snth NetworkManager[689]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled.
Oct 5 13:28:36 snth NetworkManager[689]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started...
Oct 5 13:28:36 snth NetworkManager[689]: <info> (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0]
Oct 5 13:28:36 snth NetworkManager[689]: <info> Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds)
Oct 5 13:28:36 snth NetworkManager[689]: <info> dhclient started with pid 1182
Oct 5 13:28:36 snth NetworkManager[689]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete.
Oct 5 13:28:36 snth dhclient: Internet Systems Consortium DHCP Client 4.3.1
Oct 5 13:28:36 snth dhclient: Copyright 2004-2014 Internet Systems Consortium.
Oct 5 13:28:36 snth dhclient: All rights reserved.
Oct 5 13:28:36 snth dhclient: For info, please visit https://www.isc.org/software/dhcp/
Oct 5 13:28:36 snth dhclient:
Oct 5 13:28:36 snth NetworkManager[689]: Internet Systems Consortium DHCP Client 4.3.1
Oct 5 13:28:36 snth NetworkManager[689]: Copyright 2004-2014 Internet Systems Consortium.
Oct 5 13:28:36 snth NetworkManager[689]: All rights reserved.
Oct 5 13:28:36 snth NetworkManager[689]: For info, please visit https://www.isc.org/software/dhcp/
Oct 5 13:28:36 snth NetworkManager[689]: <info> (wlan0): DHCPv4 state changed nbi -> preinit
Oct 5 13:28:36 snth dhclient: Listening on LPF/wlan0/84:3a:4b:12:34:58
Oct 5 13:28:36 snth dhclient: Sending on LPF/wlan0/84:3a:4b:12:34:58
Oct 5 13:28:36 snth dhclient: Sending on Socket/fallback
Oct 5 13:28:36 snth dhclient: DHCPREQUEST on wlan0 to 255.255.255.255 port 67
Oct 5 13:28:36 snth NetworkManager[689]: Listening on LPF/wlan0/84:3a:4b:12:34:58
Oct 5 13:28:36 snth NetworkManager[689]: Sending on LPF/wlan0/84:3a:4b:12:34:58
Oct 5 13:28:36 snth NetworkManager[689]: Sending on Socket/fallback
Oct 5 13:28:36 snth NetworkManager[689]: DHCPREQUEST on wlan0 to 255.255.255.255 port 67
Oct 5 13:28:36 snth dhclient: DHCPACK from 192.168.0.1
Oct 5 13:28:36 snth NetworkManager[689]: DHCPACK from 192.168.0.1
Oct 5 13:28:36 snth NetworkManager[689]: <info> (wlan0): DHCPv4 state changed preinit -> reboot
Oct 5 13:28:36 snth NetworkManager[689]: <info> address 192.168.0.200
Oct 5 13:28:36 snth NetworkManager[689]: <info> plen 24 (255.255.255.0)
Oct 5 13:28:36 snth NetworkManager[689]: <info> gateway 192.168.0.1
Oct 5 13:28:36 snth NetworkManager[689]: <info> server identifier 192.168.0.1
Oct 5 13:28:36 snth NetworkManager[689]: <info> lease time 604800
Oct 5 13:28:36 snth NetworkManager[689]: <info> hostname 'snth'
Oct 5 13:28:36 snth NetworkManager[689]: <info> nameserver '192.168.0.1'
Oct 5 13:28:36 snth NetworkManager[689]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Configure Commit) scheduled...
Oct 5 13:28:36 snth NetworkManager[689]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) started...
Oct 5 13:28:36 snth avahi-daemon[682]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.200.
Oct 5 13:28:36 snth avahi-daemon[682]: New relevant interface wlan0.IPv4 for mDNS.
Oct 5 13:28:36 snth avahi-daemon[682]: Registering new address record for 192.168.0.200 on wlan0.IPv4.
Oct 5 13:28:36 snth NetworkManager[689]: <info> (wlan0): device state change: ip-config -> ip-check (reason 'none') [70 80 0]
Oct 5 13:28:36 snth NetworkManager[689]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) complete.
Oct 5 13:28:36 snth dhclient: bound to 192.168.0.200 -- renewal in 277582 seconds.
Oct 5 13:28:36 snth NetworkManager[689]: bound to 192.168.0.200 -- renewal in 277582 seconds.
Oct 5 13:28:36 snth NetworkManager[689]: <info> (wlan0): device state change: ip-check -> secondaries (reason 'none') [80 90 0]
Oct 5 13:28:36 snth NetworkManager[689]: <info> (wlan0): device state change: secondaries -> activated (reason 'none') [90 100 0]
Oct 5 13:28:36 snth NetworkManager[689]: <info> (wlan0): roamed from BSSID 54:A0:50:E4:87:D0 (hlagh) to 54:A0:50:E4:87:D4 (hlagh)
Oct 5 13:28:36 snth NetworkManager[689]: <info> Policy set 'hlagh' (wlan0) as default for IPv4 routing and DNS.
Oct 5 13:28:36 snth NetworkManager[689]: <info> Activation (wlan0) successful, device activated.
Oct 5 13:28:36 snth dbus[674]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service'
Oct 5 13:28:36 snth systemd[1]: Starting Network Manager Script Dispatcher Service...
Oct 5 13:28:36 snth dbus[674]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Oct 5 13:28:36 snth systemd[1]: Started Network Manager Script Dispatcher Service.
Oct 5 13:28:36 snth nm-dispatcher: Dispatching action 'up' for wlan0
Oct 5 13:28:36 snth dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 7
Oct 5 13:28:36 snth ifup[506]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 7
Oct 5 13:28:38 snth systemd[1]: Starting user-1000.slice.
Oct 5 13:28:38 snth systemd[1]: Created slice user-1000.slice.
Oct 5 13:28:38 snth systemd[1]: Starting User Manager for 1000...
Oct 5 13:28:38 snth systemd[1]: Starting Session 1 of user avar.
Oct 5 13:28:38 snth systemd[1]: Started Session 1 of user avar.
Oct 5 13:28:38 snth systemd[1252]: Failed to open private bus connection: Failed to connect to socket /run/user/1000/dbus/user_bus_socket: No such file or directory
Oct 5 13:28:38 snth systemd[1252]: Starting Default.
Oct 5 13:28:38 snth systemd[1252]: Reached target Default.
Oct 5 13:28:38 snth systemd[1252]: Startup finished in 42ms.
Oct 5 13:28:38 snth systemd[1]: Started User Manager for 1000.
Oct 5 13:28:38 snth avahi-daemon[682]: Joining mDNS multicast group on interface wlan0.IPv6 with address fe80::863a:4bff:fe12:3458.
Oct 5 13:28:38 snth avahi-daemon[682]: New relevant interface wlan0.IPv6 for mDNS.
Oct 5 13:28:38 snth avahi-daemon[682]: Registering new address record for fe80::863a:4bff:fe12:3458 on wlan0.*.
Oct 5 13:28:38 snth colord: Automatic remove of icc-898768e766786c23d681fc41635789c0 from xrandr-LVDS1
Oct 5 13:28:38 snth colord: Profile removed: icc-898768e766786c23d681fc41635789c0
Oct 5 13:28:38 snth colord: Profile removed: icc-8e6f7eb69820340b198c61167d2eabe1
Oct 5 13:28:38 snth colord: device removed: xrandr-LVDS1
Oct 5 13:28:38 snth rtkit-daemon[1102]: Successfully made thread 1341 of process 1341 (/usr/bin/pulseaudio) owned by '1000' high priority at nice level -11.
Oct 5 13:28:38 snth rtkit-daemon[1102]: Supervising 4 threads of 2 processes of 2 users.
Oct 5 13:28:38 snth dbus[674]: [system] Activating via systemd: service name='org.freedesktop.UDisks2' unit='udisks2.service'
Oct 5 13:28:38 snth systemd[1]: Starting Disk Manager...
Oct 5 13:28:38 snth udisksd[1359]: udisks daemon version 2.1.3 starting
Oct 5 13:28:38 snth rtkit-daemon[1102]: Supervising 4 threads of 2 processes of 2 users.
Oct 5 13:28:38 snth rtkit-daemon[1102]: Successfully made thread 1363 of process 1341 (/usr/bin/pulseaudio) owned by '1000' RT at priority 5.
Oct 5 13:28:38 snth rtkit-daemon[1102]: Supervising 5 threads of 2 processes of 2 users.
Oct 5 13:28:38 snth rtkit-daemon[1102]: Supervising 5 threads of 2 processes of 2 users.
Oct 5 13:28:38 snth rtkit-daemon[1102]: Successfully made thread 1365 of process 1341 (/usr/bin/pulseaudio) owned by '1000' RT at priority 5.
Oct 5 13:28:38 snth rtkit-daemon[1102]: Supervising 6 threads of 2 processes of 2 users.
Oct 5 13:28:38 snth dbus[674]: [system] Successfully activated service 'org.freedesktop.UDisks2'
Oct 5 13:28:38 snth udisksd[1359]: Acquired the name org.freedesktop.UDisks2 on the system message bus
Oct 5 13:28:38 snth systemd[1]: Started Disk Manager.
Oct 5 13:28:38 snth udisksd[1359]: Cleaning up mount point /media/avar/4GUSD (device 179:1 is not mounted)
Oct 5 13:28:39 snth dbus[674]: [system] Activating via systemd: service name='org.freedesktop.PackageKit' unit='packagekit.service'
Oct 5 13:28:39 snth systemd[1]: Starting PackageKit Daemon...
Oct 5 13:28:39 snth PackageKit: daemon start
Oct 5 13:28:39 snth dbus[674]: [system] Successfully activated service 'org.freedesktop.PackageKit'
Oct 5 13:28:39 snth systemd[1]: Started PackageKit Daemon.
Oct 5 13:28:39 snth colord: Profile added: icc-eec285bde620704bfc84e7bc097f5e76
Oct 5 13:28:39 snth colord: Profile added: icc-d7610af3c5dc1f8009c85ffc123da2e2
Oct 5 13:28:39 snth colord: Profile added: icc-ce480febebde65873b7cc48a314b0f0f
Oct 5 13:28:39 snth colord: Profile added: icc-42959eae67777ec00aef2bf28e64379a
Oct 5 13:28:39 snth dbus[674]: [system] Activating via systemd: service name='org.freedesktop.GeoClue2' unit='geoclue.service'
Oct 5 13:28:39 snth systemd[1]: Starting Location Lookup Service...
Oct 5 13:28:39 snth dbus[674]: [system] Successfully activated service 'org.freedesktop.GeoClue2'
Oct 5 13:28:39 snth systemd[1]: Started Location Lookup Service.
Oct 5 13:28:40 snth colord: Automatic metadata add icc-42959eae67777ec00aef2bf28e64379a to xrandr-LVDS1
Oct 5 13:28:40 snth colord: Device added: xrandr-LVDS1
Oct 5 13:28:40 snth udisksd[1359]: Mounted /dev/mmcblk0p1 at /media/avar/4GUSD on behalf of uid 1000
Oct 5 13:28:43 snth dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 11
Oct 5 13:28:43 snth ifup[506]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 11
Oct 5 13:28:54 snth dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 16
Oct 5 13:28:54 snth ifup[506]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 16
Oct 5 13:28:56 snth wpa_supplicant[1044]: wlan0: CTRL-EVENT-SCAN-STARTED
Oct 5 13:29:00 snth wpa_supplicant[1044]: nl80211: send_and_recv->nl_recvmsgs failed: -33
Oct 5 13:29:02 snth ntpd[691]: peer 193.170.62.252 now valid
Oct 5 13:29:04 snth ntpd[691]: peer 81.223.20.2 now valid
Oct 5 13:29:05 snth ntpd[691]: peer 86.59.13.46 now valid
Oct 5 13:29:06 snth ntpd[691]: peer 193.171.23.163 now valid
Oct 5 13:29:06 snth ntpd[691]: peer 80.121.153.134 now valid
Oct 5 13:29:06 snth ntpd[691]: peer 92.63.212.161 now valid
Oct 5 13:29:06 snth ntpd[691]: peer 37.235.63.106 now valid
Oct 5 13:29:07 snth ntpd[691]: peer 146.255.62.59 now valid
Oct 5 13:29:08 snth ntpd[691]: peer 78.46.40.125 now valid
Oct 5 13:29:08 snth ntpd[691]: peer 212.186.250.154 now valid
Oct 5 13:29:09 snth ntpd[691]: peer 91.206.8.70 now valid
Oct 5 13:29:09 snth ntpd[691]: peer 83.137.41.12 now valid
Oct 5 13:29:10 snth dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 18
Oct 5 13:29:10 snth ifup[506]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 18
Oct 5 13:29:11 snth ntpd[691]: peer 91.206.8.36 now valid
Oct 5 13:29:11 snth ntpd[691]: peer 86.59.80.170 now valid
Oct 5 13:29:11 snth ntpd[691]: peer 146.255.57.46 now valid
Oct 5 13:29:13 snth ntpd[691]: peer 80.121.153.136 now valid
Oct 5 13:29:28 snth dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 5
Oct 5 13:29:28 snth ifup[506]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 5
Oct 5 13:29:33 snth dhclient: No DHCPOFFERS received.
Oct 5 13:29:33 snth dhclient: No working leases in persistent database - sleeping.
Oct 5 13:29:33 snth ifup[506]: No DHCPOFFERS received.
Oct 5 13:29:33 snth ifup[506]: No working leases in persistent database - sleeping.
Oct 5 13:29:33 snth avahi-autoipd(eth0)[2326]: Found user 'avahi-autoipd' (UID 105) and group 'avahi-autoipd' (GID 111).
Oct 5 13:29:33 snth avahi-autoipd(eth0)[2326]: Successfully called chroot().
Oct 5 13:29:33 snth avahi-autoipd(eth0)[2326]: Successfully dropped root privileges.
Oct 5 13:29:33 snth avahi-autoipd(eth0)[2326]: Starting with address 169.254.9.109
Oct 5 13:29:39 snth wpa_supplicant[1044]: wlan0: CTRL-EVENT-SCAN-STARTED
Oct 5 13:29:39 snth avahi-autoipd(eth0)[2326]: Callout BIND, address 169.254.9.109 on interface eth0
Oct 5 13:29:39 snth avahi-daemon[682]: Joining mDNS multicast group on interface eth0.IPv4 with address 169.254.9.109.
Oct 5 13:29:39 snth avahi-daemon[682]: New relevant interface eth0.IPv4 for mDNS.
Oct 5 13:29:39 snth avahi-daemon[682]: Registering new address record for 169.254.9.109 on eth0.IPv4.
I'm just going to solve this problem my disabling
avahi-autoipd/avahi-daemon, I don't need a ZeroConf daemon for
anything, but this seems like really odd and buggy default
behavior. Why would it be creating an eth0:avahi interface that
overrides the default wlan0 route?
-- System Information:
Debian Release: jessie/sid
APT prefers testing
APT policy: (900, 'testing'), (500, 'testing-updates'), (500, 'stable-updates'), (500, 'stable'), (200, 'unstable'), (100, 'experimental')
Architecture: amd64 (x86_64)
Kernel: Linux 3.16-2-amd64 (SMP w/4 CPU cores)
Locale: LANG=en_US.UTF-8, LC_CTYPE=en_US.UTF-8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/dash
Versions of packages avahi-daemon depends on:
ii adduser 3.113+nmu3
ii bind9-host [host] 1:9.9.5.dfsg-4
ii dbus 1.8.6-2
ii init-system-helpers 1.21
ii libavahi-common3 0.6.31-4
ii libavahi-core7 0.6.31-4
ii libc6 2.19-11
ii libcap2 1:2.24-6
ii libdaemon0 0.14-6
ii libdbus-1-3 1.8.6-2
ii libexpat1 2.1.0-6
ii lsb-base 4.1+Debian13
Versions of packages avahi-daemon recommends:
ii libnss-mdns 0.10-6
Versions of packages avahi-daemon suggests:
ii avahi-autoipd 0.6.31-4
-- no debconf information
More information about the Pkg-utopia-maintainers
mailing list