Dec 18 11:55:07 volumio ntpd[1293]: CLOCK: time stepped by 1109549.339962 Dec 18 11:55:07 volumio ntpd[1293]: CLOCK: time changed from 2025-12-05 to 2025-12-18 Dec 18 11:55:07 volumio ntpd[1293]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Dec 18 11:55:07 volumio volumio[1521]: info: Discovery: A device disappeared from network Dec 18 11:55:07 volumio volumio[1521]: info: Discovery: Device volumio disappeared from network Dec 18 11:55:07 volumio volumio[1521]: info: Discovery: A device disappeared from network Dec 18 11:55:07 volumio nmbd[1379]: [2025/12/18 16:55:07.377571, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Dec 18 11:55:07 volumio nmbd[1379]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable Dec 18 11:55:07 volumio nmbd[1379]: [2025/12/18 16:55:07.377709, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Dec 18 11:55:07 volumio nmbd[1379]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 18 11:55:07 volumio nmbd[1379]: [2025/12/18 16:55:07.377731, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 18 11:55:07 volumio nmbd[1379]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 18 11:55:07 volumio nmbd[1379]: [2025/12/18 16:55:07.377755, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Dec 18 11:55:07 volumio nmbd[1379]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 18 11:55:07 volumio nmbd[1379]: [2025/12/18 16:55:07.377771, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 18 11:55:07 volumio nmbd[1379]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 18 11:55:07 volumio nmbd[1379]: [2025/12/18 16:55:07.377787, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Dec 18 11:55:07 volumio nmbd[1379]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 18 11:55:07 volumio nmbd[1379]: [2025/12/18 16:55:07.377801, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 18 11:55:07 volumio nmbd[1379]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 18 11:55:07 volumio nmbd[1379]: [2025/12/18 16:55:07.377816, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Dec 18 11:55:07 volumio nmbd[1379]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 18 11:55:07 volumio nmbd[1379]: [2025/12/18 16:55:07.377834, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 18 11:55:07 volumio nmbd[1379]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 18 11:55:07 volumio nmbd[1379]: [2025/12/18 16:55:07.377851, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Dec 18 11:55:07 volumio nmbd[1379]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 18 11:55:07 volumio nmbd[1379]: [2025/12/18 16:55:07.377864, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 18 11:55:07 volumio nmbd[1379]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 18 11:55:07 volumio volumio[1521]: info: Discovery: adding 84b3c2b0-e8e6-47bd-aa60-afa442748c17 Dec 18 11:55:07 volumio volumio[1521]: info: Discovery: Found device Volumio Dec 18 11:55:07 volumio volumio[1521]: info: CoreCommandRouter::volumioGetState Dec 18 11:55:07 volumio volumio[1521]: info: CorePlayQueue::getTrack 0 Dec 18 11:55:07 volumio volumio[1521]: info: Discovery: this is already registered, 84b3c2b0-e8e6-47bd-aa60-afa442748c17 Dec 18 11:55:07 volumio volumio[1521]: info: Discovery: Found device Volumio Dec 18 11:55:07 volumio volumio[1521]: info: CoreCommandRouter::volumioGetState Dec 18 11:55:07 volumio volumio[1521]: info: CorePlayQueue::getTrack 0 Dec 18 11:55:09 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Dec 18 11:55:09 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Dec 18 11:55:09 volumio volumio[1521]: info: Refreshing Cached IP Addresses Dec 18 11:55:09 volumio sudo[2316]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Dec 18 11:55:09 volumio sudo[2316]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:09 volumio sudo[2318]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 18 11:55:09 volumio sudo[2318]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:09 volumio sudo[2318]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:09 volumio sudo[2316]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:09 volumio sudo[2320]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 18 11:55:09 volumio volumio[1521]: error: Cannot kill upmpdcli Error: Command failed: /usr/bin/sudo /usr/bin/killall upmpdcli Dec 18 11:55:09 volumio volumio[1521]: upmpdcli: no process found Dec 18 11:55:09 volumio sudo[2320]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:09 volumio sudo[2320]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:14 volumio systemd[1]: systemd-fsckd.service: Deactivated successfully. Dec 18 11:55:14 volumio systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service... Dec 18 11:55:14 volumio systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems... Dec 18 11:55:14 volumio systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats. Dec 18 11:55:14 volumio systemd[1]: e2scrub_all.service: Deactivated successfully. Dec 18 11:55:14 volumio systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems. Dec 18 11:55:14 volumio systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully. Dec 18 11:55:14 volumio systemd[1]: dpkg-db-backup.service: Deactivated successfully. Dec 18 11:55:14 volumio systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service. Dec 18 11:55:15 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Dec 18 11:55:15 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 18 11:55:15 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 18 11:55:15 volumio systemd[1]: systemd-hostnamed.service: Deactivated successfully. Dec 18 11:55:15 volumio sudo[2294]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:15 volumio volumio[1521]: info: Upmpdcli Daemon Started Dec 18 11:55:19 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 18 11:55:19 volumio volumio[1521]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Dec 18 11:55:19 volumio volumio[1521]: info: CoreCommandRouter::volumioGetState Dec 18 11:55:19 volumio volumio[1521]: info: CorePlayQueue::getTrack 0 Dec 18 11:55:19 volumio sudo[2423]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 18 11:55:19 volumio sudo[2423]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:19 volumio sudo[2421]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 18 11:55:19 volumio sudo[2421]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:19 volumio sudo[2423]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:19 volumio sudo[2421]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:19 volumio sudo[2425]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 18 11:55:19 volumio sudo[2425]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:19 volumio sudo[2425]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:19 volumio volumio[1521]: info: Upmpdcli Daemon Started Dec 18 11:55:20 volumio sudo[2431]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 18 11:55:20 volumio sudo[2431]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:20 volumio sudo[2433]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 18 11:55:20 volumio sudo[2433]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:20 volumio sudo[2433]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:20 volumio sudo[2431]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:20 volumio volumio[1521]: verbose: New Socket.io Connection to 192.168.1.99 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Dec 18 11:55:20 volumio volumio[1521]: info: CoreCommandRouter::volumioGetVisibleSources Dec 18 11:55:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 11:55:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Dec 18 11:55:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Dec 18 11:55:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 18 11:55:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Dec 18 11:55:20 volumio volumio[1521]: info: Received Get System Info Dec 18 11:55:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 11:55:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 11:55:20 volumio volumio[1521]: info: Discovery: Getting this device information Dec 18 11:55:20 volumio volumio[1521]: info: CoreCommandRouter::volumioGetState Dec 18 11:55:20 volumio volumio[1521]: info: CorePlayQueue::getTrack 0 Dec 18 11:55:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 11:55:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 18 11:55:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 18 11:55:20 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:20 volumio volumio[1521]: info: Retrieving Cloud Streaming UI Dec 18 11:55:20 volumio volumio-remote-updater[1125]: Test mode disabled Dec 18 11:55:20 volumio volumio-remote-updater[1125]: Alpha mode disabled Dec 18 11:55:20 volumio volumio-remote-updater[1125]: Alpha legacy test mode disabled Dec 18 11:55:20 volumio volumio[1521]: info: Getting Tidal Cloud Configuration Dec 18 11:55:20 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:20 volumio volumio[1521]: info: Getting Qobuz Cloud Configuration Dec 18 11:55:20 volumio volumio[1521]: info: Asking plugin for UI Config Dec 18 11:55:20 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:20 volumio volumio[1521]: info: Getting Spotify Cloud Configuration Dec 18 11:55:20 volumio volumio[1521]: info: Asking plugin for UI Config Dec 18 11:55:20 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:20 volumio volumio[1521]: info: Saving Spotify Acccount Dec 18 11:55:20 volumio volumio[1521]: info: Got Tidal Cloud Configuration Dec 18 11:55:20 volumio volumio[1521]: info: Got it Dec 18 11:55:20 volumio volumio[1521]: info: Got it Dec 18 11:55:20 volumio volumio[1521]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 18 11:55:20 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:20 volumio volumio[1521]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Dec 18 11:55:20 volumio volumio[1521]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 18 11:55:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 18 11:55:21 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Dec 18 11:55:21 volumio volumio[1521]: info: Loading i18n strings for locale en Dec 18 11:55:21 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Dec 18 11:55:21 volumio volumio[1521]: info: Setting timezone to America/New_York Dec 18 11:55:21 volumio sudo[2444]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Dec 18 11:55:21 volumio sudo[2444]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:21 volumio sudo[2444]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:21 volumio sudo[2448]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/New_York /etc/localtime Dec 18 11:55:21 volumio sudo[2448]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:21 volumio sudo[2448]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:21 volumio sudo[2452]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Dec 18 11:55:21 volumio sudo[2452]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:21 volumio sudo[2452]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:21 volumio sudo[2456]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/New_York Dec 18 11:55:21 volumio sudo[2456]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:21 volumio dbus-daemon[1112]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.21' (uid=0 pid=2457 comm="/usr/bin/timedatectl set-timezone America/New_York") Dec 18 11:55:21 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Dec 18 11:55:21 volumio dbus-daemon[1112]: [system] Successfully activated service 'org.freedesktop.timedate1' Dec 18 11:55:21 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Dec 18 11:55:21 volumio sudo[2456]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:21 volumio volumio[1521]: Updating browse sources language Dec 18 11:55:21 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 11:55:22 volumio volumio[1521]: info: Fetching Streaming Services browse cache Dec 18 11:55:22 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 18 11:55:23 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Dec 18 11:55:23 volumio volumio[1521]: info: Loading i18n strings for locale en Dec 18 11:55:23 volumio volumio[1521]: Updating browse sources language Dec 18 11:55:23 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 11:55:23 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Dec 18 11:55:23 volumio volumio[1521]: info: Setting timezone to America/New_York Dec 18 11:55:23 volumio sudo[2475]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Dec 18 11:55:23 volumio sudo[2475]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:23 volumio sudo[2475]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:23 volumio sudo[2479]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/New_York /etc/localtime Dec 18 11:55:23 volumio sudo[2479]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:23 volumio sudo[2479]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:23 volumio sudo[2483]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Dec 18 11:55:23 volumio sudo[2483]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:23 volumio sudo[2483]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:23 volumio sudo[2489]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/New_York Dec 18 11:55:23 volumio sudo[2489]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:23 volumio sudo[2489]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:23 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 18 11:55:23 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 18 11:55:23 volumio sudo[2492]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 18 11:55:23 volumio sudo[2492]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::volumioGetBrowseSources Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 18 11:55:24 volumio volumio-remote-updater[1125]: Test mode disabled Dec 18 11:55:24 volumio volumio-remote-updater[1125]: Alpha mode disabled Dec 18 11:55:24 volumio volumio-remote-updater[1125]: Alpha legacy test mode disabled Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Dec 18 11:55:24 volumio volumio[1521]: info: Fetching Streaming Services browse cache Dec 18 11:55:24 volumio volumio[1521]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 18 11:55:24 volumio volumio[1521]: error: MyVolumio Plugin failed to authenticate in a timely fashion Dec 18 11:55:24 volumio volumio[1521]: info: Completed starting MyVolumio Plugin Dec 18 11:55:24 volumio volumio[1521]: [Metrics] CommandRouter: 32s 193.98ms Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::volumiosetStartupVolume Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::Close All Modals sent Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::Close All Modals sent Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:24 volumio volumio[1521]: info: Retrieving Cloud Streaming UI Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:24 volumio volumio[1521]: info: Retrieving Cloud Streaming UI Dec 18 11:55:24 volumio volumio[1521]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Dec 18 11:55:24 volumio volumio[1521]: aplay: main:831: audio open error: Unknown error 524 Dec 18 11:55:24 volumio volumio[1521]: info: Getting Tidal Cloud Configuration Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:24 volumio volumio[1521]: info: Getting Qobuz Cloud Configuration Dec 18 11:55:24 volumio volumio[1521]: info: Asking plugin for UI Config Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:24 volumio volumio[1521]: info: Getting Spotify Cloud Configuration Dec 18 11:55:24 volumio volumio[1521]: info: Asking plugin for UI Config Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:24 volumio volumio[1521]: info: Saving Spotify Acccount Dec 18 11:55:24 volumio volumio[1521]: info: Got Tidal Cloud Configuration Dec 18 11:55:24 volumio volumio[1521]: info: Got it Dec 18 11:55:24 volumio volumio[1521]: info: Got it Dec 18 11:55:24 volumio volumio[1521]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 18 11:55:24 volumio volumio[1521]: info: Getting Tidal Cloud Configuration Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:24 volumio volumio[1521]: info: Getting Qobuz Cloud Configuration Dec 18 11:55:24 volumio volumio[1521]: info: Asking plugin for UI Config Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:24 volumio volumio[1521]: info: Getting Spotify Cloud Configuration Dec 18 11:55:24 volumio volumio[1521]: info: Asking plugin for UI Config Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:24 volumio volumio[1521]: info: Saving Spotify Acccount Dec 18 11:55:24 volumio volumio[1521]: info: Got Tidal Cloud Configuration Dec 18 11:55:24 volumio volumio[1521]: info: Got it Dec 18 11:55:24 volumio volumio[1521]: info: Got it Dec 18 11:55:24 volumio volumio[1521]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:24 volumio volumio[1521]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Dec 18 11:55:24 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:24 volumio volumio[1521]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 18 11:55:25 volumio volumio[1521]: info: Version has changed, forcing UI Reload Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::Reload Ui Dec 18 11:55:25 volumio sudo[2504]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 18 11:55:25 volumio sudo[2504]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:25 volumio sudo[2504]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:25 volumio sudo[2506]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 18 11:55:25 volumio sudo[2506]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:25 volumio sudo[2506]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:25 volumio volumio[1521]: verbose: New Socket.io Connection to 192.168.1.99 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::volumioGetVisibleSources Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Dec 18 11:55:25 volumio volumio[1521]: info: Received Get System Info Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 11:55:25 volumio volumio[1521]: info: Discovery: Getting this device information Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::volumioGetState Dec 18 11:55:25 volumio volumio[1521]: info: CorePlayQueue::getTrack 0 Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 11:55:25 volumio volumio-remote-updater[1125]: Test mode disabled Dec 18 11:55:25 volumio volumio-remote-updater[1125]: Alpha mode disabled Dec 18 11:55:25 volumio volumio-remote-updater[1125]: Alpha legacy test mode disabled Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:25 volumio volumio[1521]: info: Retrieving Cloud Streaming UI Dec 18 11:55:25 volumio volumio[1521]: info: Getting Tidal Cloud Configuration Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:25 volumio volumio[1521]: info: Getting Qobuz Cloud Configuration Dec 18 11:55:25 volumio volumio[1521]: info: Asking plugin for UI Config Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:25 volumio volumio[1521]: info: Getting Spotify Cloud Configuration Dec 18 11:55:25 volumio volumio[1521]: info: Asking plugin for UI Config Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:25 volumio volumio[1521]: info: Saving Spotify Acccount Dec 18 11:55:25 volumio volumio[1521]: info: Got Tidal Cloud Configuration Dec 18 11:55:25 volumio volumio[1521]: info: Got it Dec 18 11:55:25 volumio volumio[1521]: info: Got it Dec 18 11:55:25 volumio volumio[1521]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:55:25 volumio volumio[1521]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Dec 18 11:55:25 volumio volumio[1521]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 18 11:55:25 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 18 11:55:26 volumio upmpdcli[2514]: writing RSA key Dec 18 11:55:26 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Dec 18 11:55:26 volumio volumio[1521]: info: Loading i18n strings for locale en Dec 18 11:55:26 volumio volumio[1521]: Updating browse sources language Dec 18 11:55:26 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 11:55:26 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Dec 18 11:55:26 volumio volumio[1521]: info: Setting timezone to America/New_York Dec 18 11:55:26 volumio sudo[2492]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:26 volumio sudo[2519]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Dec 18 11:55:26 volumio sudo[2519]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:26 volumio sudo[2519]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:26 volumio sudo[2523]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/New_York /etc/localtime Dec 18 11:55:26 volumio sudo[2523]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:26 volumio sudo[2523]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:26 volumio sudo[2528]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Dec 18 11:55:26 volumio sudo[2528]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:26 volumio sudo[2528]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:26 volumio sudo[2532]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/New_York Dec 18 11:55:26 volumio sudo[2532]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:26 volumio sudo[2532]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:26 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 18 11:55:27 volumio volumio[1521]: info: Fetching Streaming Services browse cache Dec 18 11:55:27 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 18 11:55:30 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Dec 18 11:55:30 volumio volumio[1521]: info: Loading i18n strings for locale en Dec 18 11:55:30 volumio volumio[1521]: Updating browse sources language Dec 18 11:55:30 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 11:55:30 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Dec 18 11:55:30 volumio volumio[1521]: info: Setting timezone to America/New_York Dec 18 11:55:30 volumio sudo[2552]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Dec 18 11:55:30 volumio sudo[2552]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:30 volumio sudo[2552]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:30 volumio sudo[2556]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/New_York /etc/localtime Dec 18 11:55:30 volumio sudo[2556]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:30 volumio sudo[2556]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:30 volumio sudo[2560]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Dec 18 11:55:30 volumio sudo[2560]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:30 volumio sudo[2560]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:30 volumio sudo[2564]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/New_York Dec 18 11:55:30 volumio sudo[2564]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:30 volumio sudo[2564]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:30 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 18 11:55:30 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 18 11:55:30 volumio sudo[2567]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 18 11:55:30 volumio sudo[2567]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:30 volumio volumio[1521]: info: Fetching Streaming Services browse cache Dec 18 11:55:31 volumio volumio[1521]: info: BOOT COMPLETED Dec 18 11:55:33 volumio sudo[2567]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:36 volumio sudo[2584]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 18 11:55:36 volumio sudo[2584]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:36 volumio sudo[2586]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 18 11:55:36 volumio sudo[2586]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:55:36 volumio sudo[2584]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:36 volumio sudo[2586]: pam_unix(sudo:session): session closed for user root Dec 18 11:55:36 volumio volumio[1521]: verbose: New Socket.io Connection to 192.168.1.99 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Dec 18 11:55:36 volumio volumio[1521]: info: CoreCommandRouter::volumioGetVisibleSources Dec 18 11:55:36 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 11:55:44 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 18 11:55:44 volumio volumio[1521]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 18 11:55:44 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 18 11:55:44 volumio volumio[1521]: info: Received Get System Version Dec 18 11:55:44 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 18 11:55:44 volumio volumio[1521]: info: Received Get System Info Dec 18 11:55:44 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 11:55:44 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 11:55:44 volumio volumio[1521]: info: Discovery: Getting this device information Dec 18 11:55:44 volumio volumio[1521]: info: CoreCommandRouter::volumioGetState Dec 18 11:55:44 volumio volumio[1521]: info: CorePlayQueue::getTrack 0 Dec 18 11:55:44 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 11:55:47 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Dec 18 11:55:47 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Dec 18 11:55:51 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Dec 18 11:55:51 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 18 11:55:51 volumio volumio-remote-updater[1125]: Test mode disabled Dec 18 11:55:51 volumio volumio-remote-updater[1125]: Alpha mode disabled Dec 18 11:55:51 volumio volumio-remote-updater[1125]: Alpha legacy test mode disabled Dec 18 11:55:51 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Dec 18 11:55:52 volumio volumio[1521]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 18 11:55:52 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 18 11:55:53 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Dec 18 11:55:53 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 18 11:55:53 volumio volumio-remote-updater[1125]: Test mode disabled Dec 18 11:55:53 volumio volumio-remote-updater[1125]: Alpha mode disabled Dec 18 11:55:53 volumio volumio-remote-updater[1125]: Alpha legacy test mode disabled Dec 18 11:55:53 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Dec 18 11:55:53 volumio volumio[1521]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 18 11:55:53 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 18 11:55:56 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Dec 18 11:55:56 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 18 11:55:56 volumio volumio-remote-updater[1125]: Test mode disabled Dec 18 11:55:56 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Dec 18 11:55:56 volumio volumio-remote-updater[1125]: Alpha mode disabled Dec 18 11:55:56 volumio volumio-remote-updater[1125]: Alpha legacy test mode disabled Dec 18 11:55:56 volumio volumio[1521]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 18 11:55:56 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 18 11:56:00 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Dec 18 11:56:00 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 18 11:56:00 volumio volumio-remote-updater[1125]: Test mode disabled Dec 18 11:56:00 volumio volumio-remote-updater[1125]: Alpha mode disabled Dec 18 11:56:00 volumio volumio-remote-updater[1125]: Alpha legacy test mode disabled Dec 18 11:56:00 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Dec 18 11:56:00 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Dec 18 11:56:00 volumio volumio[1521]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 18 11:56:00 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 18 11:56:00 volumio sudo[2640]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 18 11:56:00 volumio sudo[2640]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:56:00 volumio sudo[2642]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 18 11:56:00 volumio sudo[2640]: pam_unix(sudo:session): session closed for user root Dec 18 11:56:00 volumio sudo[2642]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:56:01 volumio sudo[2642]: pam_unix(sudo:session): session closed for user root Dec 18 11:56:01 volumio volumio[1521]: verbose: New Socket.io Connection to 192.168.1.99 from 192.168.1.21 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Dec 18 11:56:01 volumio volumio[1521]: info: CoreCommandRouter::volumioGetVisibleSources Dec 18 11:56:01 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 11:56:01 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Dec 18 11:56:01 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Dec 18 11:56:01 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 18 11:56:01 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Dec 18 11:56:01 volumio volumio[1521]: info: Received Get System Info Dec 18 11:56:01 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 11:56:01 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 11:56:01 volumio volumio[1521]: info: Discovery: Getting this device information Dec 18 11:56:01 volumio volumio[1521]: info: CoreCommandRouter::volumioGetState Dec 18 11:56:01 volumio volumio[1521]: info: CorePlayQueue::getTrack 0 Dec 18 11:56:01 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 11:56:01 volumio volumio-remote-updater[1125]: Test mode disabled Dec 18 11:56:01 volumio volumio-remote-updater[1125]: Alpha mode disabled Dec 18 11:56:01 volumio volumio-remote-updater[1125]: Alpha legacy test mode disabled Dec 18 11:56:01 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:56:01 volumio volumio[1521]: info: Retrieving Cloud Streaming UI Dec 18 11:56:01 volumio volumio[1521]: info: Getting Tidal Cloud Configuration Dec 18 11:56:01 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:56:01 volumio volumio[1521]: info: Getting Qobuz Cloud Configuration Dec 18 11:56:01 volumio volumio[1521]: info: Asking plugin for UI Config Dec 18 11:56:01 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:56:01 volumio volumio[1521]: info: Getting Spotify Cloud Configuration Dec 18 11:56:01 volumio volumio[1521]: info: Asking plugin for UI Config Dec 18 11:56:01 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:56:01 volumio volumio[1521]: info: Saving Spotify Acccount Dec 18 11:56:01 volumio volumio[1521]: info: Got Tidal Cloud Configuration Dec 18 11:56:01 volumio volumio[1521]: info: Got it Dec 18 11:56:01 volumio volumio[1521]: info: Got it Dec 18 11:56:01 volumio volumio[1521]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 18 11:56:01 volumio volumio[1521]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 18 11:56:01 volumio volumio[1521]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Dec 18 11:56:01 volumio volumio[1521]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 18 11:56:01 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 18 11:56:02 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Dec 18 11:56:02 volumio volumio[1521]: info: Loading i18n strings for locale en Dec 18 11:56:02 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Dec 18 11:56:02 volumio volumio[1521]: info: Setting timezone to America/New_York Dec 18 11:56:02 volumio sudo[2653]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Dec 18 11:56:02 volumio sudo[2653]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:56:02 volumio sudo[2653]: pam_unix(sudo:session): session closed for user root Dec 18 11:56:02 volumio sudo[2657]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/New_York /etc/localtime Dec 18 11:56:02 volumio sudo[2657]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:56:02 volumio sudo[2657]: pam_unix(sudo:session): session closed for user root Dec 18 11:56:02 volumio sudo[2661]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Dec 18 11:56:02 volumio sudo[2661]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:56:02 volumio sudo[2661]: pam_unix(sudo:session): session closed for user root Dec 18 11:56:02 volumio sudo[2665]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/New_York Dec 18 11:56:02 volumio sudo[2665]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:56:02 volumio dbus-daemon[1112]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.26' (uid=0 pid=2666 comm="/usr/bin/timedatectl set-timezone America/New_York") Dec 18 11:56:02 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Dec 18 11:56:02 volumio dbus-daemon[1112]: [system] Successfully activated service 'org.freedesktop.timedate1' Dec 18 11:56:02 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Dec 18 11:56:02 volumio sudo[2665]: pam_unix(sudo:session): session closed for user root Dec 18 11:56:02 volumio volumio[1521]: Updating browse sources language Dec 18 11:56:02 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 11:56:02 volumio volumio[1521]: info: Fetching Streaming Services browse cache Dec 18 11:56:03 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Dec 18 11:56:03 volumio volumio[1521]: info: MyVolumio login type: Token Dec 18 11:56:03 volumio volumio[1521]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Dec 18 11:56:03 volumio volumio[1521]: info: MyVolumio token set successfully Dec 18 11:56:03 volumio volumio[1521]: info: MYVOLUMIO: Adding device Dec 18 11:56:03 volumio volumio[1521]: info: MYVOLUMIO: Evaluating Server Dec 18 11:56:03 volumio volumio[1521]: info: MyVolumio status changed Dec 18 11:56:03 volumio volumio[1521]: info: Streaming services startup Dec 18 11:56:03 volumio volumio[1521]: info: Starting Streaming Daemon Dec 18 11:56:03 volumio volumio[1521]: info: Removing browser output: myVolumio user plan is not superstar Dec 18 11:56:03 volumio volumio[1521]: info: Removing audio output: Dec 18 11:56:03 volumio volumio[1521]: info: Stoppping Tunnel 1 Dec 18 11:56:03 volumio sudo[2703]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 18 11:56:03 volumio sudo[2703]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:56:03 volumio sudo[2705]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Dec 18 11:56:03 volumio sudo[2705]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:56:04 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 11:56:04 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 11:56:04 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 11:56:04 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 11:56:04 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 11:56:04 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 11:56:04 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 11:56:04 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 18 11:56:04 volumio sudo[2705]: pam_unix(sudo:session): session closed for user root Dec 18 11:56:04 volumio volumio[1521]: info: Remote SSH Stopped Dec 18 11:56:04 volumio sudo[2703]: pam_unix(sudo:session): session closed for user root Dec 18 11:56:04 volumio volumio[1521]: error: Cannot start Volumio Streaming Daemon Dec 18 11:56:04 volumio volumio[1521]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 18 11:56:04 volumio volumio[1521]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 18 11:56:04 volumio volumio[1521]: info: Setting Geolocation for MyVolumio to us3 Dec 18 11:56:04 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 11:56:04 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 11:56:04 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 11:56:04 volumio volumio[1521]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Dec 18 11:56:05 volumio volumio[1521]: info: Updating MyVolumio device info Dec 18 11:56:05 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 11:56:05 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 11:56:05 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 11:56:05 volumio volumio[1521]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Dec 18 11:56:08 volumio volumio[1521]: info: MYVOLUMIO: Adding device Dec 18 11:56:08 volumio volumio[1521]: info: MYVOLUMIO: Evaluating Server Dec 18 11:56:08 volumio volumio[1521]: info: Setting Geolocation for MyVolumio to us3 Dec 18 11:56:08 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 11:56:08 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 11:56:08 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 11:56:08 volumio volumio[1521]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Dec 18 11:56:09 volumio volumio[1521]: info: Updating MyVolumio device info Dec 18 11:56:09 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 11:56:09 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 11:56:09 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 11:56:10 volumio volumio[1521]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Dec 18 11:56:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Dec 18 11:56:20 volumio volumio[1521]: info: System name has changed, restarting Shairport Sync Dec 18 11:56:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 18 11:56:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 11:56:20 volumio volumio[1521]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 18 11:56:20 volumio volumio[1521]: info: Updating MyVolumio device info Dec 18 11:56:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 11:56:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 11:56:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 11:56:20 volumio volumio[1521]: info: Discovery: Restarting Advertising due to device name change Dec 18 11:56:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Dec 18 11:56:20 volumio sudo[2748]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Dec 18 11:56:20 volumio sudo[2748]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:56:20 volumio sudo[2748]: pam_unix(sudo:session): session closed for user root Dec 18 11:56:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 18 11:56:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 18 11:56:20 volumio volumio[1521]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 18 11:56:20 volumio volumio[1521]: info: Starting Shairport Sync Dec 18 11:56:20 volumio sudo[2754]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Dec 18 11:56:20 volumio sudo[2754]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:56:20 volumio sudo[2756]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 18 11:56:20 volumio sudo[2756]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:56:20 volumio sudo[2754]: pam_unix(sudo:session): session closed for user root Dec 18 11:56:20 volumio volumio[1521]: info: Permissions for /etc/hosts set Dec 18 11:56:20 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 18 11:56:20 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 18 11:56:20 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 18 11:56:20 volumio systemd[1]: shairport-sync.service: Consumed 1.491s CPU time. Dec 18 11:56:20 volumio volumio[1521]: info: Hostname now is volumio01 Dec 18 11:56:20 volumio sudo[2760]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/hostname volumio01 Dec 18 11:56:20 volumio sudo[2760]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:56:20 volumio01 sudo[2760]: pam_unix(sudo:session): session closed for user root Dec 18 11:56:20 volumio01 volumio[1521]: info: New hostname set Dec 18 11:56:20 volumio01 sudo[2764]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /etc/avahi/services/ Dec 18 11:56:20 volumio01 sudo[2764]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 11:56:20 volumio01 sudo[2764]: pam_unix(sudo:session): session closed for user root Dec 18 11:56:20 volumio01 volumio[1521]: info: Permissions for /etc/avahi/services/volumio.service Dec 18 11:56:20 volumio01 avahi-daemon[1110]: Files changed, reloading. Dec 18 11:56:20 volumio01 avahi-daemon[1110]: Loading service file /services/volumio.service. Dec 18 11:56:20 volumio01 volumio[1521]: info: Avahi name changed to volumio01 Dec 18 11:56:20 volumio01 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 18 11:56:20 volumio01 sudo[2756]: pam_unix(sudo:session): session closed for user root Dec 18 11:56:20 volumio01 volumio[1521]: info: Shairport-Sync Started Dec 18 11:56:21 volumio01 systemd[1]: upmpdcli.service: Deactivated successfully. Dec 18 11:56:21 volumio01 systemd[1]: upmpdcli.service: Consumed 10.526s CPU time. Dec 18 11:56:21 volumio01 volumio[1521]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Dec 18 11:56:21 volumio01 avahi-daemon[1110]: Service "volumio01" (/services/volumio.service) successfully established. Dec 18 11:56:21 volumio01 volumio[1521]: info: Discovery: A device disappeared from network Dec 18 11:56:21 volumio01 volumio[1521]: info: Discovery: Device volumio disappeared from network Dec 18 11:56:21 volumio01 volumio[1521]: info: Discovery: A device disappeared from network Dec 18 11:56:25 volumio01 volumio[1521]: info: Discovery: Started advertising with name: volumio01 Dec 18 11:56:26 volumio01 volumio[1521]: compat.c: read() failed: Resource temporarily unavailable Dec 18 11:56:26 volumio01 volumio[1521]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 18 11:56:26 volumio01 volumio[1521]: Error: dns service error: unknown Dec 18 11:56:26 volumio01 volumio[1521]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Dec 18 11:56:26 volumio01 volumio[1521]: errorCode: -65537 Dec 18 11:56:26 volumio01 volumio[1521]: } Dec 18 11:56:26 volumio01 volumio[1521]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 18 11:56:26 volumio01 sudo[2810]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-18 11:55' Dec 18 11:56:26 volumio01 sudo[2810]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"