Sep 15 09:32:43 volumio ntpd[1123]: CLOCK: time stepped by 8658665.386996 Sep 15 09:32:43 volumio ntpd[1123]: CLOCK: time changed from 2025-06-07 to 2025-09-15 Sep 15 09:32:43 volumio ntpd[1123]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Sep 15 09:32:43 volumio volumio[1311]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 09:32:43 volumio volumio[1311]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 09:32:43 volumio volumio[1311]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 09:32:43 volumio volumio[1311]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 09:32:43 volumio volumio[1311]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 09:32:43 volumio volumio[1311]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 09:32:43 volumio volumio[1311]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 09:32:43 volumio volumio[1311]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 09:32:43 volumio volumio[1311]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 09:32:43 volumio volumio[1311]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 15 09:32:43 volumio volumio[1311]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 09:32:43 volumio volumio[1311]: info: Discovery: adding d1077359-1b85-430d-b24f-6ca67f3e0750 Sep 15 09:32:43 volumio volumio[1311]: info: Discovery: Found device Volumio Sep 15 09:32:43 volumio volumio[1311]: info: CoreCommandRouter::volumioGetState Sep 15 09:32:43 volumio volumio[1311]: info: CorePlayQueue::getTrack 0 Sep 15 09:32:43 volumio volumio[1311]: info: Discovery: this is already registered, d1077359-1b85-430d-b24f-6ca67f3e0750 Sep 15 09:32:43 volumio volumio[1311]: info: Discovery: Found device Volumio Sep 15 09:32:43 volumio volumio[1311]: info: CoreCommandRouter::volumioGetState Sep 15 09:32:43 volumio volumio[1311]: info: CorePlayQueue::getTrack 0 Sep 15 09:32:43 volumio volumio[1311]: info: Discovery: this is already registered, d1077359-1b85-430d-b24f-6ca67f3e0750 Sep 15 09:32:43 volumio volumio[1311]: info: Discovery: Found device Volumio Sep 15 09:32:43 volumio volumio[1311]: info: CoreCommandRouter::volumioGetState Sep 15 09:32:43 volumio volumio[1311]: info: CorePlayQueue::getTrack 0 Sep 15 09:32:43 volumio volumio[1311]: info: Volumio called home Sep 15 09:32:43 volumio volumio[1311]: info: Discovery: A device disappeared from network Sep 15 09:32:43 volumio volumio[1311]: info: Discovery: Device volumio disappeared from network Sep 15 09:32:43 volumio volumio[1311]: info: Starting Shairport Sync Sep 15 09:32:43 volumio volumio[1311]: info: Discovery: A device disappeared from network Sep 15 09:32:43 volumio volumio[1311]: info: Starting Shairport Sync Sep 15 09:32:43 volumio volumio[1311]: info: Starting Shairport Sync Sep 15 09:32:43 volumio volumio[1311]: info: Discovery: A device disappeared from network Sep 15 09:32:43 volumio sudo[1743]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 15 09:32:43 volumio sudo[1743]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 15 09:32:43 volumio sudo[1741]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 15 09:32:43 volumio sudo[1741]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 15 09:32:43 volumio sudo[1739]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 15 09:32:43 volumio sudo[1739]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 15 09:32:43 volumio systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service... Sep 15 09:32:43 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Sep 15 09:32:43 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Sep 15 09:32:43 volumio systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats. Sep 15 09:32:43 volumio systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully. Sep 15 09:32:43 volumio volumio[1311]: info: CoreCommandRouter::volumioGetState Sep 15 09:32:43 volumio volumio[1311]: info: CorePlayQueue::getTrack 0 Sep 15 09:32:43 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Sep 15 09:32:43 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Sep 15 09:32:43 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 15 09:32:43 volumio systemd[1]: shairport-sync.service: Consumed 1.621s CPU time. Sep 15 09:32:43 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Sep 15 09:32:43 volumio volumio[1311]: info: Discovery: adding d1077359-1b85-430d-b24f-6ca67f3e0750 Sep 15 09:32:43 volumio volumio[1311]: info: Discovery: Found device Volumio Sep 15 09:32:43 volumio volumio[1311]: info: CoreCommandRouter::volumioGetState Sep 15 09:32:43 volumio volumio[1311]: info: CorePlayQueue::getTrack 0 Sep 15 09:32:43 volumio volumio[1311]: info: Discovery: this is already registered, d1077359-1b85-430d-b24f-6ca67f3e0750 Sep 15 09:32:43 volumio volumio[1311]: info: Discovery: Found device Volumio Sep 15 09:32:43 volumio sudo[1743]: pam_unix(sudo:session): session closed for user root Sep 15 09:32:43 volumio volumio[1311]: info: CoreCommandRouter::volumioGetState Sep 15 09:32:43 volumio volumio[1311]: info: CorePlayQueue::getTrack 0 Sep 15 09:32:43 volumio sudo[1741]: pam_unix(sudo:session): session closed for user root Sep 15 09:32:43 volumio sudo[1753]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 15 09:32:43 volumio sudo[1753]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 15 09:32:43 volumio sudo[1739]: pam_unix(sudo:session): session closed for user root Sep 15 09:32:43 volumio sudo[1772]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Sep 15 09:32:43 volumio sudo[1753]: pam_unix(sudo:session): session closed for user root Sep 15 09:32:43 volumio volumio[1311]: info: Discovery: this is already registered, d1077359-1b85-430d-b24f-6ca67f3e0750 Sep 15 09:32:43 volumio volumio[1311]: info: Discovery: Found device Volumio Sep 15 09:32:43 volumio volumio[1311]: info: CoreCommandRouter::volumioGetState Sep 15 09:32:43 volumio volumio[1311]: info: CorePlayQueue::getTrack 0 Sep 15 09:32:43 volumio volumio[1311]: info: Shairport-Sync Started Sep 15 09:32:43 volumio volumio[1311]: Error adding Membership: Error: addMembership EINVAL Sep 15 09:32:43 volumio volumio[1311]: info: Shairport-Sync Started Sep 15 09:32:43 volumio volumio[1311]: info: Shairport-Sync Started Sep 15 09:32:44 volumio systemd[1]: dpkg-db-backup.service: Deactivated successfully. Sep 15 09:32:44 volumio systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service. Sep 15 09:32:44 volumio systemd[1]: Reloading. Sep 15 09:32:44 volumio sudo[1851]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf Sep 15 09:32:44 volumio sudo[1851]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 15 09:32:44 volumio systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems... Sep 15 09:32:44 volumio systemd[1]: e2scrub_all.service: Deactivated successfully. Sep 15 09:32:44 volumio systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems. Sep 15 09:32:44 volumio sudo[1851]: pam_unix(sudo:session): session closed for user root Sep 15 09:32:44 volumio volumio[1311]: info: Permissions for /etc/hostapd/hostapd.conf Sep 15 09:32:44 volumio volumio[1311]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Sep 15 09:32:44 volumio volumio[1311]: info: Discovery: Restarting Advertising due to device name change Sep 15 09:32:44 volumio sudo[1858]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Sep 15 09:32:44 volumio sudo[1858]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 15 09:32:44 volumio firststart.sh[1853]: rescue-ssh.target is a disabled or a static unit not running, not starting it. Sep 15 09:32:44 volumio systemd[1]: Starting wireless.service - Wireless Services... Sep 15 09:32:44 volumio firststart.sh[1853]: ssh.service is a disabled or a static unit not running, not starting it. Sep 15 09:32:44 volumio systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 15 09:32:44 volumio dnsmasq[1338]: exiting on receipt of SIGTERM Sep 15 09:32:44 volumio systemd[1]: dnsmasq.service: Deactivated successfully. Sep 15 09:32:44 volumio systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Sep 15 09:32:44 volumio systemd[1]: Stopping hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 15 09:32:45 volumio systemd[1]: Reloading. Sep 15 09:32:45 volumio dhcpcd[955]: wlan0: carrier lost Sep 15 09:32:45 volumio systemd[1]: hostapd.service: Deactivated successfully. Sep 15 09:32:45 volumio systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 15 09:32:45 volumio sudo[1914]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Sep 15 09:32:45 volumio sudo[1914]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 15 09:32:45 volumio avahi-daemon[925]: Withdrawing address record for 192.168.211.1 on wlan0. Sep 15 09:32:45 volumio avahi-daemon[925]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Sep 15 09:32:45 volumio avahi-daemon[925]: Interface wlan0.IPv4 no longer relevant for mDNS. Sep 15 09:32:45 volumio volumio[1311]: info: Discovery: A device disappeared from network Sep 15 09:32:45 volumio volumio[1311]: info: Discovery: Device volumio disappeared from network Sep 15 09:32:45 volumio sudo[1914]: pam_unix(sudo:session): session closed for user root Sep 15 09:32:45 volumio sudo[1935]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Sep 15 09:32:45 volumio sudo[1935]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 15 09:32:45 volumio firststart.sh[1906]: ssh.socket is a disabled or a static unit not running, not starting it. Sep 15 09:32:45 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Sep 15 09:32:45 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Sep 15 09:32:45 volumio systemd[1]: welcome.service: Deactivated successfully. Sep 15 09:32:45 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Sep 15 09:32:45 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Sep 15 09:32:45 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Sep 15 09:32:45 volumio volumio[1311]: info: Discovery: A device disappeared from network Sep 15 09:32:45 volumio volumio[1311]: info: Discovery: A device disappeared from network Sep 15 09:32:45 volumio firststart.sh[1312]: Enabling SSH for first boot Sep 15 09:32:45 volumio systemd[1]: Starting ssh.service - OpenBSD Secure Shell server... Sep 15 09:32:45 volumio welcome[1945]: Resolved ip:[1] 192.168.0.118 Sep 15 09:32:45 volumio sudo[1499]: pam_unix(sudo:session): session closed for user root Sep 15 09:32:45 volumio sudo[1935]: pam_unix(sudo:session): session closed for user root Sep 15 09:32:45 volumio volumio[1311]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Sep 15 09:32:45 volumio volumio[1311]: wlan0 Failed to read scan data : Network is down Sep 15 09:32:45 volumio volumio[1311]: info: Cannot use regular scanning, forcing with ap-force Sep 15 09:32:45 volumio sudo[1954]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Sep 15 09:32:45 volumio sudo[1954]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 15 09:32:45 volumio sudo[1954]: pam_unix(sudo:session): session closed for user root Sep 15 09:32:45 volumio volumio[1311]: command failed: Network is down (-100) Sep 15 09:32:45 volumio volumio[1311]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Sep 15 09:32:45 volumio volumio[1311]: command failed: Network is down (-100) Sep 15 09:32:45 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Sep 15 09:32:45 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Sep 15 09:32:45 volumio sudo[1693]: pam_unix(sudo:session): session closed for user root Sep 15 09:32:45 volumio sudo[1682]: pam_unix(sudo:session): session closed for user root Sep 15 09:32:45 volumio volumio[1311]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Sep 15 09:32:45 volumio volumio[1311]: Terminated Sep 15 09:32:45 volumio volumio[1311]: info: Completed starting Core Plugins Sep 15 09:32:45 volumio volumio[1311]: info: ------------------------------------------- Sep 15 09:32:45 volumio volumio[1311]: info: ----- MyVolumio plugins startup ---- Sep 15 09:32:45 volumio volumio[1311]: info: ------------------------------------------- Sep 15 09:32:45 volumio volumio[1311]: info: [MyVolumio PluginManager] Fetching plans data.... Sep 15 09:32:46 volumio volumio[1311]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Sep 15 09:32:46 volumio volumio[1311]: Terminated Sep 15 09:32:46 volumio volumio[1311]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Sep 15 09:32:46 volumio volumio[1311]: info: CoreStateMachine::getcurrentVolume Sep 15 09:32:46 volumio volumio[1311]: info: CoreCommandRouter::volumioRetrievevolume Sep 15 09:32:46 volumio volumio[1311]: info: CoreStateMachine::pushState Sep 15 09:32:46 volumio volumio[1311]: info: CorePlayQueue::getTrack 0 Sep 15 09:32:46 volumio volumio[1311]: info: CoreCommandRouter::volumioPushState Sep 15 09:32:46 volumio sudo[1963]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Sep 15 09:32:46 volumio sudo[1963]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 15 09:32:46 volumio sudo[1963]: pam_unix(sudo:session): session closed for user root Sep 15 09:32:46 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Sep 15 09:32:46 volumio sudo[1965]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Sep 15 09:32:46 volumio sudo[1965]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 15 09:32:46 volumio sudo[1965]: pam_unix(sudo:session): session closed for user root Sep 15 09:32:46 volumio sshd[1958]: Server listening on 0.0.0.0 port 22. Sep 15 09:32:46 volumio sshd[1958]: Server listening on :: port 22. Sep 15 09:32:46 volumio systemd[1]: Started ssh.service - OpenBSD Secure Shell server. Sep 15 09:32:46 volumio firststart.sh[1312]: Disabling firststart service Sep 15 09:32:46 volumio sudo[1973]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Sep 15 09:32:46 volumio sudo[1973]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 15 09:32:46 volumio sudo[1973]: pam_unix(sudo:session): session closed for user root Sep 15 09:32:46 volumio sudo[1976]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Sep 15 09:32:46 volumio sudo[1976]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 15 09:32:46 volumio systemctl[1974]: Removed "/etc/systemd/system/multi-user.target.wants/firststart.service". Sep 15 09:32:46 volumio systemd[1]: Reloading. Sep 15 09:32:46 volumio firststart.sh[1312]: Finalizing Sep 15 09:32:47 volumio ntpd[1123]: IO: Deleting interface #4 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=10 secs Sep 15 09:32:48 volumio sudo[1976]: pam_unix(sudo:session): session closed for user root Sep 15 09:32:49 volumio volumio[1311]: info: Discovery: Started advertising with name: Volumio Sep 15 09:32:50 volumio sudo[2001]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Sep 15 09:32:50 volumio sudo[2001]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 15 09:32:50 volumio sudo[2001]: pam_unix(sudo:session): session closed for user root Sep 15 09:32:50 volumio sudo[2004]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Sep 15 09:32:50 volumio sudo[2004]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 15 09:32:50 volumio volumio[1311]: compat.c: read() failed: Resource temporarily unavailable Sep 15 09:32:50 volumio volumio[1311]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 15 09:32:50 volumio volumio[1311]: Error: dns service error: unknown Sep 15 09:32:50 volumio volumio[1311]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Sep 15 09:32:50 volumio volumio[1311]: errorCode: -65537 Sep 15 09:32:50 volumio volumio[1311]: } Sep 15 09:32:50 volumio volumio[1311]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 15 09:32:50 volumio sudo[2004]: pam_unix(sudo:session): session closed for user root Sep 15 09:32:50 volumio avahi-daemon[925]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Sep 15 09:32:50 volumio avahi-daemon[925]: New relevant interface wlan0.IPv4 for mDNS. Sep 15 09:32:50 volumio avahi-daemon[925]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Sep 15 09:32:50 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Sep 15 09:32:50 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Sep 15 09:32:50 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Sep 15 09:32:50 volumio systemd[1]: welcome.service: Deactivated successfully. Sep 15 09:32:50 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Sep 15 09:32:50 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Sep 15 09:32:50 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Sep 15 09:32:50 volumio welcome[2023]: Resolved ip:[2] 192.168.0.118 192.168.211.1 Sep 15 09:32:50 volumio systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Sep 15 09:32:50 volumio dhcpcd[955]: wlan0: carrier acquired Sep 15 09:32:50 volumio hostapd[2027]: wlan0: interface state UNINITIALIZED->ENABLED Sep 15 09:32:50 volumio hostapd[2027]: wlan0: AP-ENABLED Sep 15 09:32:50 volumio systemd[1]: Started hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Sep 15 09:32:50 volumio systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Sep 15 09:32:50 volumio iwconfig[2033]: Error for wireless request "Set Power Management" (8B2C) : Sep 15 09:32:50 volumio iwconfig[2033]: SET failed on device wlan0 ; Invalid argument. Sep 15 09:32:50 volumio systemd[1]: wireless.service: Deactivated successfully. Sep 15 09:32:50 volumio systemd[1]: Started wireless.service - Wireless Services. Sep 15 09:32:50 volumio sudo[1858]: pam_unix(sudo:session): session closed for user root Sep 15 09:32:52 volumio ntpd[1123]: IO: Listen normally on 5 wlan0 192.168.211.1:123 Sep 15 09:32:52 volumio ntpd[1123]: IO: new interface(s) found: waking up resolver Sep 15 09:32:57 volumio systemd[1]: systemd-fsckd.service: Deactivated successfully. Sep 15 09:32:59 volumio systemd[1]: systemd-hostnamed.service: Deactivated successfully. Sep 15 09:33:00 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Sep 15 09:33:28 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Sep 15 09:33:28 volumio dbus-daemon[927]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.25' (uid=0 pid=2096 comm="timedatectl show --property=NTPSynchronized --valu") Sep 15 09:33:36 volumio dhcpcd[955]: wlan0: IAID 67:0d:3e:39 Sep 15 09:33:36 volumio dhcpcd[955]: wlan0: soliciting an IPv6 router Sep 15 09:33:37 volumio dhcpcd[955]: wlan0: soliciting a DHCP lease Sep 15 09:33:38 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Sep 15 09:33:38 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Sep 15 09:33:38 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Sep 15 09:33:38 volumio dbus-daemon[927]: [system] Successfully activated service 'org.freedesktop.timedate1' Sep 15 09:33:38 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Sep 15 09:33:38 volumio setdatetime-helper.sh[2095]: Time is not synchronized. Attempting to sync... Sep 15 09:33:41 volumio sudo[2126]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Mon, 15 Sep 2025 09:33:39 GMT#015' Sep 15 09:33:41 volumio dnsmasq[2128]: started, version 2.90 cachesize 150 Sep 15 09:33:41 volumio dnsmasq[2128]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Sep 15 09:33:41 volumio dnsmasq-dhcp[2128]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Sep 15 09:33:41 volumio dnsmasq[2128]: reading /etc/resolv.conf Sep 15 09:33:41 volumio dnsmasq[2128]: using nameserver 192.168.0.1#53 Sep 15 09:33:41 volumio dnsmasq[2128]: using nameserver 208.67.222.222#53 Sep 15 09:33:41 volumio dnsmasq[2128]: using nameserver 208.67.220.220#53 Sep 15 09:33:41 volumio dnsmasq[2128]: read /etc/hosts - 16 names Sep 15 09:33:41 volumio sudo[2126]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 15 09:33:41 volumio sudo[2120]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-09-15 09:32' Sep 15 09:33:41 volumio sudo[2120]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Sep 15 09:33:39 volumio setdatetime-helper.sh[2129]: Mon Sep 15 09:33:39 UTC 2025 Sep 15 09:33:39 volumio sudo[2126]: pam_unix(sudo:session): session closed for user root Sep 15 09:33:39 volumio setdatetime-helper.sh[2095]: Time synchronized successfully. Sep 15 09:33:39 volumio systemd-journald[440]: Time jumped backwards, rotating. Sep 15 09:33:39 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Sep 15 09:33:39 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Sep 15 09:33:39 volumio systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. 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="ecd46641d85b721d58d1c7edd71dd0a358c8514c" 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 Jun 7 04:21:21 UTC 2025" VOLUMIO_VERSION="4.011" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="97f38114d6fd5ff4ce2816f49b632994"