Jun 08 10:02:14 volumio wpa_supplicant[1281]: wlan0: WNM: Preferred List Available Jun 08 10:02:14 volumio wpa_supplicant[1281]: wlan0: Trying to associate with 08:36:c9:e2:74:60 (SSID='Horizon' freq=5785 MHz) Jun 08 10:02:14 volumio dhcpcd[1008]: wlan0: carrier lost - roaming Jun 08 10:02:14 volumio dhcpcd[1008]: wlan0: changing route to 10.0.0.0/24 Jun 08 10:02:14 volumio dhcpcd[1008]: wlan0: changing default route via 10.0.0.1 Jun 08 10:02:14 volumio kernel: ieee80211 phy0: brcmf_p2p_send_action_frame: Unknown Frame: category 0xa, action 0x8 Jun 08 10:02:14 volumio wpa_supplicant[1281]: wlan0: Associated with 08:36:c9:e2:74:60 Jun 08 10:02:14 volumio wpa_supplicant[1281]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jun 08 10:02:14 volumio wpa_supplicant[1281]: wlan0: WPA: Key negotiation completed with 08:36:c9:e2:74:60 [PTK=CCMP GTK=CCMP] Jun 08 10:02:14 volumio wpa_supplicant[1281]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:36:c9:e2:74:60 completed [id=0 id_str=] Jun 08 10:02:14 volumio dhcpcd[1008]: wlan0: carrier acquired Jun 08 10:02:14 volumio dhcpcd[1008]: wlan0: IAID 67:02:08:9f Jun 08 10:02:15 volumio dhcpcd[1008]: wlan0: soliciting an IPv6 router Jun 08 10:02:15 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 08 10:02:15 volumio dbus-daemon[966]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.4423' (uid=0 pid=6642 comm="timedatectl show --property=NTPSynchronized --valu") Jun 08 10:02:15 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jun 08 10:02:15 volumio dbus-daemon[966]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 08 10:02:15 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Jun 08 10:02:15 volumio setdatetime-helper.sh[6641]: Time is already synchronized. Jun 08 10:02:15 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 08 10:02:15 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 08 10:02:16 volumio dhcpcd[1008]: wlan0: rebinding lease of 10.0.0.164 Jun 08 10:02:21 volumio dhcpcd[1008]: wlan0: probing for an IPv4LL address Jun 08 10:02:21 volumio dhcpcd[1008]: wlan0: DHCP lease expired Jun 08 10:02:21 volumio avahi-daemon[1545]: Withdrawing address record for 10.0.0.164 on wlan0. Jun 08 10:02:21 volumio avahi-daemon[1545]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 10.0.0.164. Jun 08 10:02:21 volumio avahi-daemon[1545]: Interface wlan0.IPv4 no longer relevant for mDNS. Jun 08 10:02:21 volumio dhcpcd[1008]: wlan0: deleting route to 10.0.0.0/24 Jun 08 10:02:21 volumio dhcpcd[1008]: wlan0: deleting default route via 10.0.0.1 Jun 08 10:02:21 volumio volumio[1550]: info: Discovery: A device disappeared from network Jun 08 10:02:21 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 08 10:02:21 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Jun 08 10:02:21 volumio systemd[1]: welcome.service: Deactivated successfully. Jun 08 10:02:21 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Jun 08 10:02:21 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Jun 08 10:02:21 volumio dhcpcd[1008]: wlan0: soliciting a DHCP lease Jun 08 10:02:21 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Jun 08 10:02:21 volumio welcome[6686]: Resolved ip:[1] 10.0.0.162 Jun 08 10:02:21 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Jun 08 10:02:21 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 08 10:02:21 volumio dhcpcd[1008]: wlan0: offered 10.0.0.164 from 10.0.0.1 Jun 08 10:02:21 volumio dhcpcd[1008]: wlan0: probing address 10.0.0.164/24 Jun 08 10:02:23 volumio ntpd[1137]: IO: Deleting interface #15 wlan0, 10.0.0.164#123, interface stats: received=0, sent=0, dropped=0, active_time=163 secs Jun 08 10:02:26 volumio dhcpcd[1008]: wlan0: using IPv4LL address 169.254.80.225 Jun 08 10:02:26 volumio avahi-daemon[1545]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.80.225. Jun 08 10:02:26 volumio avahi-daemon[1545]: New relevant interface wlan0.IPv4 for mDNS. Jun 08 10:02:26 volumio dhcpcd[1008]: wlan0: adding route to 169.254.0.0/16 Jun 08 10:02:26 volumio avahi-daemon[1545]: Registering new address record for 169.254.80.225 on wlan0.IPv4. Jun 08 10:02:26 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 08 10:02:26 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Jun 08 10:02:26 volumio systemd[1]: welcome.service: Deactivated successfully. Jun 08 10:02:26 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Jun 08 10:02:26 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Jun 08 10:02:26 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Jun 08 10:02:26 volumio welcome[6727]: Resolved ip:[2] 10.0.0.162 169.254.80.225 Jun 08 10:02:26 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Jun 08 10:02:26 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 08 10:02:27 volumio dhcpcd[1008]: wlan0: leased 10.0.0.164 for 172800 seconds Jun 08 10:02:27 volumio avahi-daemon[1545]: Registering new address record for 10.0.0.164 on wlan0.IPv4. Jun 08 10:02:27 volumio dhcpcd[1008]: wlan0: adding route to 10.0.0.0/24 Jun 08 10:02:27 volumio dhcpcd[1008]: wlan0: adding default route via 10.0.0.1 Jun 08 10:02:27 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 08 10:02:27 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Jun 08 10:02:27 volumio systemd[1]: welcome.service: Deactivated successfully. Jun 08 10:02:27 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Jun 08 10:02:27 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Jun 08 10:02:27 volumio avahi-daemon[1545]: Withdrawing address record for 169.254.80.225 on wlan0. Jun 08 10:02:27 volumio avahi-daemon[1545]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.80.225. Jun 08 10:02:27 volumio avahi-daemon[1545]: Joining mDNS multicast group on interface wlan0.IPv4 with address 10.0.0.164. Jun 08 10:02:27 volumio avahi-daemon[1545]: Withdrawing address record for 10.0.0.162 on eth0. Jun 08 10:02:27 volumio avahi-daemon[1545]: Withdrawing address record for 127.0.0.1 on lo. Jun 08 10:02:27 volumio dhcpcd[1008]: wlan0: deleting route to 169.254.0.0/16 Jun 08 10:02:27 volumio avahi-daemon[1545]: Host name conflict, retrying with volumio-3 Jun 08 10:02:27 volumio avahi-daemon[1545]: Registering new address record for 10.0.0.164 on wlan0.IPv4. Jun 08 10:02:27 volumio avahi-daemon[1545]: Registering new address record for 10.0.0.162 on eth0.IPv4. Jun 08 10:02:27 volumio avahi-daemon[1545]: Registering new address record for 127.0.0.1 on lo.IPv4. Jun 08 10:02:27 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Jun 08 10:02:27 volumio welcome[6767]: Resolved ip:[2] 10.0.0.162 10.0.0.164 Jun 08 10:02:27 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Jun 08 10:02:27 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 08 10:02:27 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 08 10:02:27 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Jun 08 10:02:27 volumio systemd[1]: welcome.service: Deactivated successfully. Jun 08 10:02:27 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Jun 08 10:02:27 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Jun 08 10:02:27 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Jun 08 10:02:27 volumio welcome[6792]: Resolved ip:[2] 10.0.0.162 10.0.0.164 Jun 08 10:02:27 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Jun 08 10:02:27 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 08 10:02:28 volumio volumio[1550]: info: Discovery: A device disappeared from network Jun 08 10:02:28 volumio volumio[1550]: info: Discovery: A device disappeared from network Jun 08 10:02:28 volumio volumio[1550]: info: Discovery: A device disappeared from network Jun 08 10:02:29 volumio ntpd[1137]: IO: Listen normally on 16 wlan0 10.0.0.164:123 Jun 08 10:02:29 volumio ntpd[1137]: IO: new interface(s) found: waking up resolver Jun 08 10:02:29 volumio avahi-daemon[1545]: Server startup complete. Host name is volumio-3.local. Local service cookie is 3735305920. Jun 08 10:02:30 volumio volumio[1550]: info: Discovery: adding e3d022cd-6b81-400c-a915-1c537439503c Jun 08 10:02:30 volumio volumio[1550]: info: Discovery: Found device Volumio Jun 08 10:02:30 volumio volumio[1550]: info: CoreCommandRouter::volumioGetState Jun 08 10:02:30 volumio volumio[1550]: info: Discovery: this is already registered, e3d022cd-6b81-400c-a915-1c537439503c Jun 08 10:02:30 volumio volumio[1550]: info: Discovery: Found device Volumio Jun 08 10:02:30 volumio volumio[1550]: info: CoreCommandRouter::volumioGetState Jun 08 10:02:30 volumio volumio[1550]: info: Discovery: this is already registered, e3d022cd-6b81-400c-a915-1c537439503c Jun 08 10:02:30 volumio volumio[1550]: info: Discovery: Found device Volumio Jun 08 10:02:30 volumio volumio[1550]: info: CoreCommandRouter::volumioGetState Jun 08 10:02:31 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 08 10:02:31 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 08 10:02:31 volumio volumio[1550]: info: Discovery: Browse raised the following error Error: dns service error: unknown Jun 08 10:02:36 volumio volumio[1550]: info: CoreCommandRouter::volumioGetState Jun 08 10:02:38 volumio volumio[1550]: info: Executing endpoint metavolumio Jun 08 10:02:38 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 10:02:38 volumio volumio[1550]: info: Executing endpoint metavolumio Jun 08 10:02:38 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 10:02:38 volumio volumio[1550]: info: Executing endpoint metavolumio Jun 08 10:02:38 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 10:02:40 volumio wpa_supplicant[1281]: wlan0: WNM: Preferred List Available Jun 08 10:02:40 volumio wpa_supplicant[1281]: wlan0: Trying to associate with 08:36:c9:e2:74:62 (SSID='Horizon' freq=2412 MHz) Jun 08 10:02:40 volumio dhcpcd[1008]: wlan0: carrier lost - roaming Jun 08 10:02:40 volumio dhcpcd[1008]: wlan0: changing route to 10.0.0.0/24 Jun 08 10:02:40 volumio dhcpcd[1008]: wlan0: changing default route via 10.0.0.1 Jun 08 10:02:40 volumio kernel: ieee80211 phy0: brcmf_p2p_send_action_frame: Unknown Frame: category 0xa, action 0x8 Jun 08 10:02:40 volumio wpa_supplicant[1281]: wlan0: Associated with 08:36:c9:e2:74:62 Jun 08 10:02:40 volumio wpa_supplicant[1281]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jun 08 10:02:40 volumio wpa_supplicant[1281]: wlan0: WPA: Key negotiation completed with 08:36:c9:e2:74:62 [PTK=CCMP GTK=CCMP] Jun 08 10:02:40 volumio wpa_supplicant[1281]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:36:c9:e2:74:62 completed [id=0 id_str=] Jun 08 10:02:40 volumio dhcpcd[1008]: wlan0: carrier acquired Jun 08 10:02:40 volumio dhcpcd[1008]: wlan0: IAID 67:02:08:9f Jun 08 10:02:40 volumio dhcpcd[1008]: wlan0: soliciting an IPv6 router Jun 08 10:02:41 volumio dhcpcd[1008]: wlan0: rebinding lease of 10.0.0.164 Jun 08 10:02:41 volumio volumio[1550]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 08 10:02:41 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 08 10:02:41 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Jun 08 10:02:41 volumio sudo[6869]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Jun 08 10:02:41 volumio sudo[6869]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 08 10:02:41 volumio sudo[6874]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jun 08 10:02:41 volumio sudo[6874]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 08 10:02:41 volumio sudo[6874]: pam_unix(sudo:session): session closed for user root Jun 08 10:02:41 volumio sudo[6869]: pam_unix(sudo:session): session closed for user root Jun 08 10:02:41 volumio sudo[6891]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 08 10:02:41 volumio sudo[6886]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jun 08 10:02:41 volumio sudo[6886]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 08 10:02:41 volumio sudo[6891]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 08 10:02:41 volumio sudo[6881]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jun 08 10:02:41 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jun 08 10:02:41 volumio sudo[6881]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 08 10:02:41 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jun 08 10:02:41 volumio sudo[6886]: pam_unix(sudo:session): session closed for user root Jun 08 10:02:41 volumio sudo[6891]: pam_unix(sudo:session): session closed for user root Jun 08 10:02:41 volumio sudo[6881]: pam_unix(sudo:session): session closed for user root Jun 08 10:02:41 volumio sudo[6897]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 08 10:02:41 volumio sudo[6897]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 08 10:02:41 volumio sudo[6897]: pam_unix(sudo:session): session closed for user root Jun 08 10:02:41 volumio sudo[6900]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 08 10:02:41 volumio sudo[6900]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 08 10:02:45 volumio sudo[6900]: pam_unix(sudo:session): session closed for user root Jun 08 10:02:45 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Jun 08 10:02:46 volumio dhcpcd[1008]: wlan0: probing for an IPv4LL address Jun 08 10:02:46 volumio dhcpcd[1008]: wlan0: DHCP lease expired Jun 08 10:02:46 volumio avahi-daemon[1545]: Withdrawing address record for 10.0.0.164 on wlan0. Jun 08 10:02:46 volumio avahi-daemon[1545]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 10.0.0.164. Jun 08 10:02:46 volumio avahi-daemon[1545]: Interface wlan0.IPv4 no longer relevant for mDNS. Jun 08 10:02:46 volumio dhcpcd[1008]: wlan0: deleting route to 10.0.0.0/24 Jun 08 10:02:46 volumio dhcpcd[1008]: wlan0: deleting default route via 10.0.0.1 Jun 08 10:02:46 volumio volumio[1550]: info: Discovery: A device disappeared from network Jun 08 10:02:46 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 08 10:02:46 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Jun 08 10:02:46 volumio systemd[1]: welcome.service: Deactivated successfully. Jun 08 10:02:46 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Jun 08 10:02:46 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Jun 08 10:02:46 volumio dhcpcd[1008]: wlan0: soliciting a DHCP lease Jun 08 10:02:46 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Jun 08 10:02:46 volumio welcome[6922]: Resolved ip:[1] 10.0.0.162 Jun 08 10:02:46 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Jun 08 10:02:46 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 08 10:02:46 volumio dhcpcd[1008]: wlan0: offered 10.0.0.164 from 10.0.0.1 Jun 08 10:02:46 volumio dhcpcd[1008]: wlan0: ignoring offer of 10.0.0.164 from 10.0.0.1 Jun 08 10:02:46 volumio dhcpcd[1008]: wlan0: probing address 10.0.0.164/24 Jun 08 10:02:47 volumio volumio[1550]: info: Volumio Network Manager: Network status updated: 1 Jun 08 10:02:47 volumio ntpd[1137]: IO: Deleting interface #16 wlan0, 10.0.0.164#123, interface stats: received=0, sent=0, dropped=0, active_time=18 secs Jun 08 10:02:50 volumio dhcpcd[1008]: wlan0: leased 10.0.0.164 for 172800 seconds Jun 08 10:02:50 volumio avahi-daemon[1545]: Joining mDNS multicast group on interface wlan0.IPv4 with address 10.0.0.164. Jun 08 10:02:50 volumio avahi-daemon[1545]: New relevant interface wlan0.IPv4 for mDNS. Jun 08 10:02:50 volumio avahi-daemon[1545]: Registering new address record for 10.0.0.164 on wlan0.IPv4. Jun 08 10:02:50 volumio dhcpcd[1008]: wlan0: adding route to 10.0.0.0/24 Jun 08 10:02:50 volumio dhcpcd[1008]: wlan0: adding default route via 10.0.0.1 Jun 08 10:02:50 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 08 10:02:50 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Jun 08 10:02:50 volumio systemd[1]: welcome.service: Deactivated successfully. Jun 08 10:02:50 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Jun 08 10:02:50 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Jun 08 10:02:50 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Jun 08 10:02:50 volumio welcome[6979]: Resolved ip:[2] 10.0.0.162 10.0.0.164 Jun 08 10:02:50 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Jun 08 10:02:50 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 08 10:02:51 volumio volumio[1550]: info: Discovery: adding e3d022cd-6b81-400c-a915-1c537439503c Jun 08 10:02:51 volumio volumio[1550]: info: Discovery: Found device Volumio Jun 08 10:02:51 volumio volumio[1550]: info: CoreCommandRouter::volumioGetState Jun 08 10:02:52 volumio ntpd[1137]: IO: Listen normally on 17 wlan0 10.0.0.164:123 Jun 08 10:02:52 volumio ntpd[1137]: IO: new interface(s) found: waking up resolver Jun 08 10:02:52 volumio volumio[1550]: info: CoreCommandRouter::volumioGetState Jun 08 10:02:54 volumio volumio[1550]: info: Executing endpoint metavolumio Jun 08 10:02:54 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 10:02:54 volumio volumio[1550]: info: Executing endpoint metavolumio Jun 08 10:02:54 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 10:02:54 volumio volumio[1550]: info: Executing endpoint metavolumio Jun 08 10:02:54 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 10:02:56 volumio volumio[1550]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 08 10:02:56 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 08 10:02:56 volumio volumio[1550]: Disk list : [ { device: 'nvme0n1', name: 'NVMe', size: '0B' } ] Jun 08 10:02:56 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 08 10:02:56 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 08 10:02:56 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Jun 08 10:02:57 volumio volumio[1550]: info: Received Get System Version Jun 08 10:02:57 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 08 10:02:57 volumio volumio[1550]: info: Volumio Network Manager: Network status updated: 3 Jun 08 10:03:30 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 08 10:03:30 volumio dbus-daemon[966]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.4430' (uid=0 pid=7152 comm="timedatectl show --property=NTPSynchronized --valu") Jun 08 10:03:30 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jun 08 10:03:30 volumio dbus-daemon[966]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 08 10:03:30 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Jun 08 10:03:30 volumio setdatetime-helper.sh[7151]: Time is already synchronized. Jun 08 10:03:30 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 08 10:03:30 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 08 10:03:36 volumio volumio[1550]: info: CoreCommandRouter::volumioGetState Jun 08 10:03:38 volumio volumio[1550]: info: Executing endpoint metavolumio Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 10:03:38 volumio volumio[1550]: info: Executing endpoint metavolumio Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 10:03:38 volumio volumio[1550]: info: Executing endpoint metavolumio Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 08 10:03:38 volumio volumio[1550]: info: Retrieving Cloud Streaming UI Jun 08 10:03:38 volumio volumio[1550]: info: Getting Tidal Cloud Configuration Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 08 10:03:38 volumio volumio[1550]: info: Getting Qobuz Cloud Configuration Jun 08 10:03:38 volumio volumio[1550]: info: Asking plugin for UI Config Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 08 10:03:38 volumio volumio[1550]: info: Getting Spotify Cloud Configuration Jun 08 10:03:38 volumio volumio[1550]: info: Asking plugin for UI Config Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 08 10:03:38 volumio volumio[1550]: info: Saving Spotify Acccount Jun 08 10:03:38 volumio volumio[1550]: info: Got it Jun 08 10:03:38 volumio volumio[1550]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jun 08 10:03:38 volumio volumio[1550]: info: Got it Jun 08 10:03:38 volumio volumio[1550]: info: Got Tidal Cloud Configuration Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::volumioGetBrowseSources Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::volumioGetBrowseSources Jun 08 10:03:38 volumio volumio[1550]: info: CoreCommandRouter::volumioGetBrowseSources Jun 08 10:03:39 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 10:03:39 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 08 10:03:43 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 10:03:45 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jun 08 10:03:45 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Jun 08 10:03:46 volumio volumio[1550]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L NASEF79F0.local. Jun 08 10:03:46 volumio volumio[1550]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L NASEF79F0.local. Jun 08 10:03:46 volumio volumio[1550]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L Philberts-MacBook-Pro.local. Jun 08 10:03:47 volumio volumio[1550]: info: Error browsing device NASEF79F0 for shares: Command failed: smbclient --no-pass --debuglevel=0 -L NASEF79F0.local. Jun 08 10:03:47 volumio volumio[1550]: gencache_init: Failed to create directory: /home/volumio/.cache/samba - Permission denied Jun 08 10:03:47 volumio volumio[1550]: gencache_init: Failed to create directory: /home/volumio/.cache/samba - Permission denied Jun 08 10:03:47 volumio volumio[1550]: gencache_init: Failed to create directory: /home/volumio/.cache/samba - Permission denied Jun 08 10:03:47 volumio volumio[1550]: info: Error browsing device NASEF79F0(TimeMachine) for shares: Command failed: smbclient --no-pass --debuglevel=0 -L NASEF79F0.local. Jun 08 10:03:47 volumio volumio[1550]: gencache_init: Failed to create directory: /home/volumio/.cache/samba - Permission denied Jun 08 10:03:47 volumio volumio[1550]: gencache_init: Failed to create directory: /home/volumio/.cache/samba - Permission denied Jun 08 10:03:47 volumio volumio[1550]: gencache_init: Failed to create directory: /home/volumio/.cache/samba - Permission denied Jun 08 10:03:47 volumio volumio[1550]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 10:03:48 volumio volumio[1550]: info: Error browsing device Philbert's MacBook Pro for shares: Command failed: smbclient --no-pass --debuglevel=0 -L Philberts-MacBook-Pro.local. Jun 08 10:03:48 volumio volumio[1550]: gencache_init: Failed to create directory: /home/volumio/.cache/samba - Permission denied Jun 08 10:03:48 volumio volumio[1550]: gencache_init: Failed to create directory: /home/volumio/.cache/samba - Permission denied Jun 08 10:03:48 volumio volumio[1550]: gencache_init: Failed to create directory: /home/volumio/.cache/samba - Permission denied Jun 08 10:03:50 volumio volumio[1550]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 08 10:03:50 volumio volumio[1550]: Error: dns service error: unknown Jun 08 10:03:50 volumio volumio[1550]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Jun 08 10:03:50 volumio volumio[1550]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Jun 08 10:03:50 volumio volumio[1550]: errorCode: -65537 Jun 08 10:03:50 volumio volumio[1550]: } Jun 08 10:03:50 volumio volumio[1550]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 08 10:03:50 volumio sudo[7260]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-08 10:02' Jun 08 10:03:50 volumio sudo[7260]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a42e8353c03f8616e137cf760ea618e88c395461" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Jun 2 16:20:51 UTC 2025" VOLUMIO_VERSION="4.010" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="f51ec0ad91e50bdfdb863e902a9e8fa2"