May 31 18:20:06 volumio-alpha-2b systemd[1]: systemd-timedated.service: Deactivated successfully. May 31 18:20:49 volumio-alpha-2b systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... May 31 18:20:49 volumio-alpha-2b dbus-daemon[483]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.32' (uid=0 pid=1919 comm="timedatectl show --property=NTPSynchronized --valu") May 31 18:20:49 volumio-alpha-2b systemd[1]: Starting systemd-timedated.service - Time & Date Service... May 31 18:20:49 volumio-alpha-2b dbus-daemon[483]: [system] Successfully activated service 'org.freedesktop.timedate1' May 31 18:20:49 volumio-alpha-2b systemd[1]: Started systemd-timedated.service - Time & Date Service. May 31 18:20:49 volumio-alpha-2b setdatetime-helper.sh[1918]: Time is not synchronized. Attempting to sync... May 31 18:20:50 volumio-alpha-2b sudo[1927]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Sat, 31 May 2025 17:20:50 GMT#015' May 31 18:20:50 volumio-alpha-2b sudo[1927]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 31 18:20:50 volumio-alpha-2b setdatetime-helper.sh[1928]: Sat May 31 18:20:50 BST 2025 May 31 18:20:50 volumio-alpha-2b systemd-journald[319]: Time jumped backwards, rotating. May 31 18:20:50 volumio-alpha-2b systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. May 31 18:20:50 volumio-alpha-2b setdatetime-helper.sh[1918]: Time synchronized successfully. May 31 18:20:50 volumio-alpha-2b sudo[1927]: pam_unix(sudo:session): session closed for user root May 31 18:20:50 volumio-alpha-2b systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. May 31 18:21:19 volumio-alpha-2b systemd[1]: systemd-timedated.service: Deactivated successfully. May 31 18:21:27 volumio-alpha-2b volumio[1017]: info: CoreCommandRouter::executeOnPlugin: wizard , connectWirelessNetwork May 31 18:21:27 volumio-alpha-2b volumio[1017]: info: CoreCommandRouter::executeOnPlugin: network , getWiredInfo May 31 18:21:28 volumio-alpha-2b sudo[1989]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 31 18:21:28 volumio-alpha-2b sudo[1989]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:28 volumio-alpha-2b sudo[1989]: pam_unix(sudo:session): session closed for user root May 31 18:21:28 volumio-alpha-2b volumio[1017]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings May 31 18:21:28 volumio-alpha-2b volumio[1017]: info: Saving new wireless network May 31 18:21:28 volumio-alpha-2b sudo[1992]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf May 31 18:21:28 volumio-alpha-2b sudo[1992]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:28 volumio-alpha-2b sudo[1992]: pam_unix(sudo:session): session closed for user root May 31 18:21:28 volumio-alpha-2b volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart May 31 18:21:28 volumio-alpha-2b volumio[1017]: info: Discovery: Restarting Advertising due to device name change May 31 18:21:28 volumio-alpha-2b sudo[1995]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service May 31 18:21:28 volumio-alpha-2b sudo[1995]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:29 volumio-alpha-2b systemd[1]: Starting wireless.service - Wireless Services... May 31 18:21:29 volumio-alpha-2b volumio[1017]: info: Discovery: A device disappeared from network May 31 18:21:29 volumio-alpha-2b volumio[1017]: info: Discovery: A device disappeared from network May 31 18:21:30 volumio-alpha-2b volumio[1017]: info: Discovery: A device disappeared from network May 31 18:21:32 volumio-alpha-2b systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... May 31 18:21:32 volumio-alpha-2b dnsmasq[1035]: exiting on receipt of SIGTERM May 31 18:21:32 volumio-alpha-2b systemd[1]: dnsmasq.service: Deactivated successfully. May 31 18:21:32 volumio-alpha-2b systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. May 31 18:21:32 volumio-alpha-2b dhcpcd[617]: wlan0: carrier lost May 31 18:21:32 volumio-alpha-2b systemd[1]: Stopping hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... May 31 18:21:32 volumio-alpha-2b avahi-daemon[478]: Interface wlan0.IPv4 no longer relevant for mDNS. May 31 18:21:32 volumio-alpha-2b avahi-daemon[478]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. May 31 18:21:32 volumio-alpha-2b avahi-daemon[478]: Withdrawing address record for 169.254.115.225 on wlan0. May 31 18:21:32 volumio-alpha-2b avahi-daemon[478]: Withdrawing address record for 192.168.211.1 on wlan0. May 31 18:21:32 volumio-alpha-2b dhcpcd[617]: wlan0: deleting route to 169.254.0.0/16 May 31 18:21:32 volumio-alpha-2b systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. May 31 18:21:32 volumio-alpha-2b systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... May 31 18:21:32 volumio-alpha-2b systemd[1]: welcome.service: Deactivated successfully. May 31 18:21:32 volumio-alpha-2b systemd[1]: Stopped welcome.service - Show a welcome message on console. May 31 18:21:32 volumio-alpha-2b systemd[1]: Stopping welcome.service - Show a welcome message on console... May 31 18:21:32 volumio-alpha-2b systemd[1]: Starting welcome.service - Show a welcome message on console... May 31 18:21:32 volumio-alpha-2b avahi-daemon[478]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. May 31 18:21:32 volumio-alpha-2b systemd[1]: hostapd.service: Deactivated successfully. May 31 18:21:32 volumio-alpha-2b avahi-daemon[478]: New relevant interface wlan0.IPv4 for mDNS. May 31 18:21:32 volumio-alpha-2b avahi-daemon[478]: Registering new address record for 192.168.211.1 on wlan0.IPv4. May 31 18:21:32 volumio-alpha-2b welcome[2060]: Resolved ip:[2] 192.168.1.168 192.168.211.1 May 31 18:21:32 volumio-alpha-2b systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. May 31 18:21:32 volumio-alpha-2b systemd[1]: Finished welcome.service - Show a welcome message on console. May 31 18:21:32 volumio-alpha-2b systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. May 31 18:21:32 volumio-alpha-2b sudo[2081]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 May 31 18:21:32 volumio-alpha-2b sudo[2081]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 31 18:21:33 volumio-alpha-2b avahi-daemon[478]: Withdrawing address record for 192.168.211.1 on wlan0. May 31 18:21:33 volumio-alpha-2b avahi-daemon[478]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. May 31 18:21:33 volumio-alpha-2b avahi-daemon[478]: Interface wlan0.IPv4 no longer relevant for mDNS. May 31 18:21:33 volumio-alpha-2b sudo[2081]: pam_unix(sudo:session): session closed for user root May 31 18:21:33 volumio-alpha-2b systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. May 31 18:21:33 volumio-alpha-2b systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... May 31 18:21:33 volumio-alpha-2b systemd[1]: welcome.service: Deactivated successfully. May 31 18:21:33 volumio-alpha-2b systemd[1]: Stopped welcome.service - Show a welcome message on console. May 31 18:21:33 volumio-alpha-2b systemd[1]: Stopping welcome.service - Show a welcome message on console... May 31 18:21:33 volumio-alpha-2b sudo[2084]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down May 31 18:21:33 volumio-alpha-2b sudo[2084]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 31 18:21:33 volumio-alpha-2b systemd[1]: Starting welcome.service - Show a welcome message on console... May 31 18:21:33 volumio-alpha-2b welcome[2085]: Resolved ip:[1] 192.168.1.168 May 31 18:21:33 volumio-alpha-2b sudo[2084]: pam_unix(sudo:session): session closed for user root May 31 18:21:33 volumio-alpha-2b systemd[1]: Finished welcome.service - Show a welcome message on console. May 31 18:21:33 volumio-alpha-2b systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. May 31 18:21:33 volumio-alpha-2b volumio[1017]: info: Discovery: Started advertising with name: Volumio-alpha-2B May 31 18:21:34 volumio-alpha-2b sudo[2098]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 31 18:21:34 volumio-alpha-2b sudo[2098]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:34 volumio-alpha-2b sudo[2098]: pam_unix(sudo:session): session closed for user root May 31 18:21:34 volumio-alpha-2b sudo[2100]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get May 31 18:21:34 volumio-alpha-2b sudo[2100]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:34 volumio-alpha-2b sudo[2100]: pam_unix(sudo:session): session closed for user root May 31 18:21:35 volumio-alpha-2b sudo[2109]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 31 18:21:35 volumio-alpha-2b sudo[2109]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:35 volumio-alpha-2b sudo[2109]: pam_unix(sudo:session): session closed for user root May 31 18:21:35 volumio-alpha-2b sudo[2112]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan May 31 18:21:35 volumio-alpha-2b sudo[2112]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:35 volumio-alpha-2b volumio[1017]: info: Discovery: adding 9f173dce-968c-47e7-8e70-83da6550a2df May 31 18:21:35 volumio-alpha-2b volumio[1017]: info: Discovery: Found device Volumio-alpha-2B May 31 18:21:35 volumio-alpha-2b volumio[1017]: info: CoreCommandRouter::volumioGetState May 31 18:21:35 volumio-alpha-2b volumio[1017]: info: CorePlayQueue::getTrack 0 May 31 18:21:35 volumio-alpha-2b volumio[1017]: info: Discovery: this is already registered, 9f173dce-968c-47e7-8e70-83da6550a2df May 31 18:21:35 volumio-alpha-2b volumio[1017]: info: Discovery: Found device Volumio-alpha-2B May 31 18:21:35 volumio-alpha-2b volumio[1017]: info: CoreCommandRouter::volumioGetState May 31 18:21:35 volumio-alpha-2b volumio[1017]: info: CorePlayQueue::getTrack 0 May 31 18:21:35 volumio-alpha-2b ntpd[686]: IO: Deleting interface #4 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=242 secs May 31 18:21:35 volumio-alpha-2b ntpd[686]: IO: Deleting interface #5 wlan0, 169.254.115.225#123, interface stats: received=0, sent=0, dropped=0, active_time=231 secs May 31 18:21:36 volumio-alpha-2b sudo[2112]: pam_unix(sudo:session): session closed for user root May 31 18:21:36 volumio-alpha-2b sudo[2120]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 May 31 18:21:36 volumio-alpha-2b sudo[2120]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 31 18:21:36 volumio-alpha-2b sudo[2120]: pam_unix(sudo:session): session closed for user root May 31 18:21:36 volumio-alpha-2b sudo[2122]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down May 31 18:21:36 volumio-alpha-2b sudo[2122]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 31 18:21:37 volumio-alpha-2b sudo[2122]: pam_unix(sudo:session): session closed for user root May 31 18:21:37 volumio-alpha-2b wpa_supplicant[2127]: Successfully initialized wpa_supplicant May 31 18:21:37 volumio-alpha-2b sudo[2128]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd May 31 18:21:37 volumio-alpha-2b sudo[2128]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 31 18:21:37 volumio-alpha-2b dhcpcd[617]: control command: /sbin/dhcpcd May 31 18:21:37 volumio-alpha-2b dhcpcd[617]: control_free: No such file or directory May 31 18:21:37 volumio-alpha-2b sudo[2128]: pam_unix(sudo:session): session closed for user root May 31 18:21:37 volumio-alpha-2b dhcpcd[617]: lo: IAID 00:00:00:00 May 31 18:21:37 volumio-alpha-2b dhcpcd[617]: lo: adding address fe80::6cb0:434c:4295:ea7d May 31 18:21:37 volumio-alpha-2b dhcpcd[617]: ipv6_addaddr1: Permission denied May 31 18:21:37 volumio-alpha-2b dhcpcd[617]: lo: using static address 127.0.0.1/8 May 31 18:21:37 volumio-alpha-2b dhcpcd[617]: lo: adding route to 127.0.0.0/8 May 31 18:21:37 volumio-alpha-2b systemd[1]: Reached target ip-changed@lo.target - IP Address changed on lo. May 31 18:21:37 volumio-alpha-2b systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. May 31 18:21:37 volumio-alpha-2b systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... May 31 18:21:37 volumio-alpha-2b systemd[1]: welcome.service: Deactivated successfully. May 31 18:21:37 volumio-alpha-2b systemd[1]: Stopped welcome.service - Show a welcome message on console. May 31 18:21:37 volumio-alpha-2b systemd[1]: Stopping welcome.service - Show a welcome message on console... May 31 18:21:37 volumio-alpha-2b systemd[1]: Starting welcome.service - Show a welcome message on console... May 31 18:21:37 volumio-alpha-2b welcome[2161]: Resolved ip:[1] 192.168.1.168 May 31 18:21:38 volumio-alpha-2b systemd[1]: Finished welcome.service - Show a welcome message on console. May 31 18:21:38 volumio-alpha-2b systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. May 31 18:21:38 volumio-alpha-2b sudo[2201]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 18:21:38 volumio-alpha-2b sudo[2201]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:38 volumio-alpha-2b sudo[2201]: pam_unix(sudo:session): session closed for user root May 31 18:21:39 volumio-alpha-2b wpa_supplicant[2148]: wlan0: SME: Trying to authenticate with 5c:e9:31:56:2a:2c (SSID='Vodafone3CADBD-EXT2' freq=2452 MHz) May 31 18:21:39 volumio-alpha-2b wpa_supplicant[2148]: wlan0: Trying to associate with 5c:e9:31:56:2a:2c (SSID='Vodafone3CADBD-EXT2' freq=2452 MHz) May 31 18:21:39 volumio-alpha-2b kernel: wlan0: authenticate with 5c:e9:31:56:2a:2c (local address=00:0f:13:40:19:2d) May 31 18:21:39 volumio-alpha-2b kernel: wlan0: send auth to 5c:e9:31:56:2a:2c (try 1/3) May 31 18:21:39 volumio-alpha-2b kernel: wlan0: authenticated May 31 18:21:39 volumio-alpha-2b kernel: wlan0: associate with 5c:e9:31:56:2a:2c (try 1/3) May 31 18:21:39 volumio-alpha-2b kernel: wlan0: RX AssocResp from 5c:e9:31:56:2a:2c (capab=0x1411 status=0 aid=2) May 31 18:21:39 volumio-alpha-2b kernel: wlan0: associated May 31 18:21:39 volumio-alpha-2b wpa_supplicant[2148]: wlan0: Associated with 5c:e9:31:56:2a:2c May 31 18:21:39 volumio-alpha-2b wpa_supplicant[2148]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 May 31 18:21:39 volumio-alpha-2b wpa_supplicant[2148]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE May 31 18:21:39 volumio-alpha-2b sudo[2213]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 18:21:39 volumio-alpha-2b sudo[2213]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:39 volumio-alpha-2b kernel: cryptd: max_cpu_qlen set to 1000 May 31 18:21:39 volumio-alpha-2b sudo[2213]: pam_unix(sudo:session): session closed for user root May 31 18:21:39 volumio-alpha-2b kernel: wlan0: Limiting TX power to 20 (20 - 0) dBm as advertised by 5c:e9:31:56:2a:2c May 31 18:21:39 volumio-alpha-2b wpa_supplicant[2148]: wlan0: WPA: Key negotiation completed with 5c:e9:31:56:2a:2c [PTK=CCMP GTK=CCMP] May 31 18:21:39 volumio-alpha-2b wpa_supplicant[2148]: wlan0: CTRL-EVENT-CONNECTED - Connection to 5c:e9:31:56:2a:2c completed [id=0 id_str=] May 31 18:21:39 volumio-alpha-2b dhcpcd[617]: wlan0: carrier acquired May 31 18:21:39 volumio-alpha-2b dhcpcd[617]: wlan0: connected to Access Point: Vodafone3CADBD-EXT2 May 31 18:21:39 volumio-alpha-2b dhcpcd[617]: wlan0: IAID 13:40:19:2d May 31 18:21:40 volumio-alpha-2b dhcpcd[617]: wlan0: soliciting an IPv6 router May 31 18:21:40 volumio-alpha-2b sudo[2232]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 18:21:40 volumio-alpha-2b sudo[2232]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:40 volumio-alpha-2b sudo[2232]: pam_unix(sudo:session): session closed for user root May 31 18:21:41 volumio-alpha-2b dhcpcd[617]: wlan0: soliciting a DHCP lease May 31 18:21:41 volumio-alpha-2b sudo[2237]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 18:21:41 volumio-alpha-2b sudo[2237]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:41 volumio-alpha-2b sudo[2237]: pam_unix(sudo:session): session closed for user root May 31 18:21:42 volumio-alpha-2b sudo[2247]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 18:21:42 volumio-alpha-2b sudo[2247]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:42 volumio-alpha-2b sudo[2247]: pam_unix(sudo:session): session closed for user root May 31 18:21:43 volumio-alpha-2b sudo[2259]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 18:21:43 volumio-alpha-2b sudo[2259]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:43 volumio-alpha-2b sudo[2259]: pam_unix(sudo:session): session closed for user root May 31 18:21:44 volumio-alpha-2b sudo[2263]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 18:21:44 volumio-alpha-2b sudo[2263]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:44 volumio-alpha-2b sudo[2263]: pam_unix(sudo:session): session closed for user root May 31 18:21:44 volumio-alpha-2b dhcpcd[617]: wlan0: offered 192.168.1.175 from 192.168.1.1 May 31 18:21:44 volumio-alpha-2b dhcpcd[617]: wlan0: ignoring offer of 192.168.1.175 from 192.168.1.1 May 31 18:21:44 volumio-alpha-2b dhcpcd[617]: wlan0: probing address 192.168.1.175/24 May 31 18:21:45 volumio-alpha-2b sudo[2268]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 18:21:45 volumio-alpha-2b sudo[2268]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:45 volumio-alpha-2b sudo[2268]: pam_unix(sudo:session): session closed for user root May 31 18:21:46 volumio-alpha-2b sudo[2272]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 18:21:46 volumio-alpha-2b sudo[2272]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:46 volumio-alpha-2b sudo[2272]: pam_unix(sudo:session): session closed for user root May 31 18:21:47 volumio-alpha-2b sudo[2276]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 18:21:47 volumio-alpha-2b sudo[2276]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:47 volumio-alpha-2b sudo[2276]: pam_unix(sudo:session): session closed for user root May 31 18:21:48 volumio-alpha-2b sudo[2280]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 18:21:48 volumio-alpha-2b sudo[2280]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:48 volumio-alpha-2b sudo[2280]: pam_unix(sudo:session): session closed for user root May 31 18:21:49 volumio-alpha-2b sudo[2284]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 18:21:49 volumio-alpha-2b sudo[2284]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:49 volumio-alpha-2b sudo[2284]: pam_unix(sudo:session): session closed for user root May 31 18:21:49 volumio-alpha-2b dhcpcd[617]: wlan0: leased 192.168.1.175 for infinity May 31 18:21:49 volumio-alpha-2b avahi-daemon[478]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.175. May 31 18:21:49 volumio-alpha-2b avahi-daemon[478]: New relevant interface wlan0.IPv4 for mDNS. May 31 18:21:49 volumio-alpha-2b dhcpcd[617]: wlan0: adding route to 192.168.1.0/24 May 31 18:21:49 volumio-alpha-2b avahi-daemon[478]: Registering new address record for 192.168.1.175 on wlan0.IPv4. May 31 18:21:49 volumio-alpha-2b dhcpcd[617]: wlan0: adding default route via 192.168.1.1 May 31 18:21:49 volumio-alpha-2b systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... May 31 18:21:49 volumio-alpha-2b systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. May 31 18:21:49 volumio-alpha-2b systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... May 31 18:21:49 volumio-alpha-2b systemd[1]: welcome.service: Deactivated successfully. May 31 18:21:49 volumio-alpha-2b systemd[1]: Stopped welcome.service - Show a welcome message on console. May 31 18:21:49 volumio-alpha-2b systemd[1]: Stopping welcome.service - Show a welcome message on console... May 31 18:21:49 volumio-alpha-2b systemd[1]: Starting welcome.service - Show a welcome message on console... May 31 18:21:49 volumio-alpha-2b welcome[2311]: Resolved ip:[2] 192.168.1.168 192.168.1.175 May 31 18:21:49 volumio-alpha-2b dbus-daemon[483]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.38' (uid=0 pid=2308 comm="timedatectl show --property=NTPSynchronized --valu") May 31 18:21:49 volumio-alpha-2b volumio[1017]: compat.c: read() failed: Resource temporarily unavailable May 31 18:21:49 volumio-alpha-2b volumio[1017]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 18:21:49 volumio-alpha-2b volumio[1017]: Error: dns service error: unknown May 31 18:21:49 volumio-alpha-2b volumio[1017]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { May 31 18:21:49 volumio-alpha-2b volumio[1017]: errorCode: -65537 May 31 18:21:49 volumio-alpha-2b volumio[1017]: } May 31 18:21:49 volumio-alpha-2b volumio[1017]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 18:21:50 volumio-alpha-2b systemd[1]: Starting systemd-timedated.service - Time & Date Service... May 31 18:21:50 volumio-alpha-2b systemd[1]: Finished welcome.service - Show a welcome message on console. May 31 18:21:50 volumio-alpha-2b systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. May 31 18:21:50 volumio-alpha-2b sudo[2331]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 18:21:50 volumio-alpha-2b sudo[2331]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 18:21:50 volumio-alpha-2b sudo[2331]: pam_unix(sudo:session): session closed for user root May 31 18:21:50 volumio-alpha-2b sudo[2334]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 31 18:21:50 volumio-alpha-2b sudo[2334]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 31 18:21:50 volumio-alpha-2b sudo[2334]: pam_unix(sudo:session): session closed for user root May 31 18:21:50 volumio-alpha-2b systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 31 18:21:50 volumio-alpha-2b systemd[1]: shairport-sync.service: Deactivated successfully. May 31 18:21:50 volumio-alpha-2b systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 31 18:21:50 volumio-alpha-2b systemd[1]: shairport-sync.service: Consumed 2.720s CPU time. May 31 18:21:50 volumio-alpha-2b systemd[1]: Stopping avahi-daemon.service - Avahi mDNS/DNS-SD Stack... May 31 18:21:50 volumio-alpha-2b avahi-daemon[478]: Got SIGTERM, quitting. May 31 18:21:50 volumio-alpha-2b avahi-daemon[478]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.175. May 31 18:21:50 volumio-alpha-2b avahi-daemon[478]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.1.168. May 31 18:21:50 volumio-alpha-2b avahi-daemon[478]: Leaving mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. May 31 18:21:50 volumio-alpha-2b dbus-daemon[483]: [system] Activating via systemd: service name='org.freedesktop.Avahi' unit='dbus-org.freedesktop.Avahi.service' requested by ':1.39' (uid=0 pid=1631 comm="/usr/sbin/smbd --foreground --no-process-group") May 31 18:21:50 volumio-alpha-2b avahi-daemon[478]: avahi-daemon 0.8 exiting. May 31 18:21:50 volumio-alpha-2b systemd[1]: avahi-daemon.service: Deactivated successfully. May 31 18:21:50 volumio-alpha-2b systemd[1]: Stopped avahi-daemon.service - Avahi mDNS/DNS-SD Stack. May 31 18:21:50 volumio-alpha-2b systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack... May 31 18:21:50 volumio-alpha-2b avahi-daemon[2339]: Process 478 died: No such process; trying to remove PID file. (/run/avahi-daemon//pid) May 31 18:21:50 volumio-alpha-2b avahi-daemon[2339]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109). May 31 18:21:50 volumio-alpha-2b avahi-daemon[2339]: Successfully dropped root privileges. May 31 18:21:50 volumio-alpha-2b avahi-daemon[2339]: avahi-daemon 0.8 starting up. May 31 18:21:50 volumio-alpha-2b dbus-daemon[483]: [system] Successfully activated service 'org.freedesktop.Avahi' May 31 18:21:50 volumio-alpha-2b systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack. May 31 18:21:50 volumio-alpha-2b avahi-daemon[2339]: Successfully called chroot(). May 31 18:21:50 volumio-alpha-2b avahi-daemon[2339]: Successfully dropped remaining capabilities. May 31 18:21:50 volumio-alpha-2b dbus-daemon[483]: [system] Successfully activated service 'org.freedesktop.timedate1' May 31 18:21:50 volumio-alpha-2b avahi-daemon[2339]: Loading service file /services/volumio.service. May 31 18:21:50 volumio-alpha-2b avahi-daemon[2339]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.175. May 31 18:21:50 volumio-alpha-2b ntpd[686]: IO: Listen normally on 6 wlan0 192.168.1.175:123 May 31 18:21:50 volumio-alpha-2b ntpd[686]: IO: new interface(s) found: waking up resolver May 31 18:21:50 volumio-alpha-2b systemd[1]: Started systemd-timedated.service - Time & Date Service. May 31 18:21:50 volumio-alpha-2b avahi-daemon[2339]: New relevant interface wlan0.IPv4 for mDNS. May 31 18:21:50 volumio-alpha-2b setdatetime-helper.sh[2303]: Time is not synchronized. Attempting to sync... May 31 18:21:50 volumio-alpha-2b avahi-daemon[2339]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.168. May 31 18:21:50 volumio-alpha-2b avahi-daemon[2339]: New relevant interface eth0.IPv4 for mDNS. May 31 18:21:50 volumio-alpha-2b avahi-daemon[2339]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. May 31 18:21:50 volumio-alpha-2b avahi-daemon[2339]: New relevant interface lo.IPv4 for mDNS. May 31 18:21:50 volumio-alpha-2b avahi-daemon[2339]: Network interface enumeration completed. May 31 18:21:50 volumio-alpha-2b avahi-daemon[2339]: Registering new address record for 192.168.1.175 on wlan0.IPv4. May 31 18:21:50 volumio-alpha-2b avahi-daemon[2339]: Registering new address record for 192.168.1.168 on eth0.IPv4. May 31 18:21:50 volumio-alpha-2b avahi-daemon[2339]: Registering new address record for 127.0.0.1 on lo.IPv4. May 31 18:21:50 volumio-alpha-2b systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 31 18:21:50 volumio-alpha-2b systemd[1]: Started wireless.service - Wireless Services. May 31 18:21:50 volumio-alpha-2b sudo[1995]: pam_unix(sudo:session): session closed for user root May 31 18:21:51 volumio-alpha-2b sudo[2362]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Sat, 31 May 2025 17:21:51 GMT#015' May 31 18:21:51 volumio-alpha-2b sudo[2362]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 31 18:21:51 volumio-alpha-2b setdatetime-helper.sh[2364]: Sat May 31 18:21:51 BST 2025 May 31 18:21:51 volumio-alpha-2b systemd-journald[319]: Time jumped backwards, rotating. May 31 18:21:51 volumio-alpha-2b setdatetime-helper.sh[2303]: Time synchronized successfully. May 31 18:21:51 volumio-alpha-2b sudo[2362]: pam_unix(sudo:session): session closed for user root May 31 18:21:51 volumio-alpha-2b systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. May 31 18:21:51 volumio-alpha-2b systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. May 31 18:21:51 volumio-alpha-2b avahi-daemon[2339]: Server startup complete. Host name is volumio-alpha-2b.local. Local service cookie is 4213614529. May 31 18:21:51 volumio-alpha-2b sudo[2368]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-05-31 18:20' May 31 18:21:51 volumio-alpha-2b sudo[2368]: 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="4a70cb031e64a8e498efc3e29470650871ff7d54" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat May 31 04:09:10 UTC 2025" VOLUMIO_VERSION="4.005" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="f9bd4447a30d4b2c74b3880e7a50e48b"