Dec 05 23:52:20 volumio sudo[3473]: volumio : unable to resolve host volumio: System error Dec 05 23:52:20 volumio sudo[3475]: volumio : unable to resolve host volumio: System error Dec 05 23:52:20 volumio sudo[3475]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 05 23:52:20 volumio sudo[3475]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 23:52:20 volumio sudo[3473]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 05 23:52:20 volumio sudo[3473]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 23:52:20 volumio sudo[3475]: pam_unix(sudo:session): session closed for user root Dec 05 23:52:20 volumio sudo[3473]: pam_unix(sudo:session): session closed for user root Dec 05 23:52:20 volumio volumio[1130]: verbose: New Socket.io Connection to 192.168.8.132 from 192.168.8.2 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Edg/143.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 Dec 05 23:52:20 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 05 23:52:20 volumio volumio[1130]: info: CoreCommandRouter::volumioGetVisibleSources Dec 05 23:52:20 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 05 23:52:20 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 05 23:52:20 volumio volumio[1130]: info: CoreCommandRouter::volumioGetState Dec 05 23:52:20 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Dec 05 23:52:20 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 05 23:52:20 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 05 23:52:20 volumio volumio[1130]: info: Received Get System Info Dec 05 23:52:20 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 05 23:52:20 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 05 23:52:20 volumio volumio[1130]: info: Discovery: Getting this device information Dec 05 23:52:20 volumio volumio[1130]: info: CoreCommandRouter::volumioGetState Dec 05 23:52:20 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Dec 05 23:52:20 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 05 23:52:20 volumio volumio[1130]: info: CoreCommandRouter::volumioGetState Dec 05 23:52:20 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Dec 05 23:52:20 volumio volumio[1130]: info: Listing playlists Dec 05 23:52:20 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 05 23:52:20 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 05 23:52:20 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 05 23:52:20 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 05 23:52:21 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 05 23:52:21 volumio volumio[1130]: info: Received Get System Info Dec 05 23:52:21 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 05 23:52:21 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 05 23:52:21 volumio volumio[1130]: info: Discovery: Getting this device information Dec 05 23:52:21 volumio volumio[1130]: info: CoreCommandRouter::volumioGetState Dec 05 23:52:21 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Dec 05 23:52:21 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 05 23:52:22 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 05 23:52:23 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 05 23:52:23 volumio volumio[1130]: info: Received Get System Info Dec 05 23:52:23 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 05 23:52:23 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 05 23:52:23 volumio volumio[1130]: info: Discovery: Getting this device information Dec 05 23:52:23 volumio volumio[1130]: info: CoreCommandRouter::volumioGetState Dec 05 23:52:23 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Dec 05 23:52:23 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 05 23:52:30 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 05 23:52:36 volumio volumio[1130]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/bookworm/armhf Dec 05 23:52:38 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 05 23:52:38 volumio volumio[1130]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 05 23:52:38 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 05 23:52:38 volumio volumio[1130]: info: Received Get System Version Dec 05 23:52:38 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 05 23:52:38 volumio volumio[1130]: info: Received Get System Info Dec 05 23:52:38 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 05 23:52:38 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 05 23:52:38 volumio volumio[1130]: info: Discovery: Getting this device information Dec 05 23:52:38 volumio volumio[1130]: info: CoreCommandRouter::volumioGetState Dec 05 23:52:38 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Dec 05 23:52:38 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 05 23:52:41 volumio volumio[1130]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/bookworm/armhf Dec 05 23:52:41 volumio volumio[1130]: info: Folder /tmp/plugins removed Dec 05 23:52:42 volumio volumio[1130]: info: Check plugin dependencies Dec 05 23:52:42 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 05 23:52:42 volumio volumio[1130]: info: Checking if plugin already exists Dec 05 23:52:42 volumio volumio[1130]: info: Rename folder Dec 05 23:52:42 volumio volumio[1130]: info: Folder /tmp/downloaded_plugin.zip removed Dec 05 23:52:42 volumio volumio[1130]: info: Move to category Dec 05 23:52:43 volumio volumio[1130]: info: Checking if install.sh is present Dec 05 23:52:43 volumio volumio[1130]: info: Executing install.sh Dec 05 23:52:43 volumio sudo[3533]: volumio : unable to resolve host volumio: System error Dec 05 23:52:43 volumio sudo[3533]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/music_service/spop/install.sh Dec 05 23:52:43 volumio sudo[3533]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 23:52:43 volumio volumio[1130]: info: Installing Go-librespot Dec 05 23:52:43 volumio volumio[1130]: info: Checking old vollibrespot installs Dec 05 23:52:44 volumio systemd[1]: Reloading. Dec 05 23:52:44 volumio volumio[1130]: info: Downloading daemon Dec 05 23:52:54 volumio volumio[1130]: info: Creating directories Dec 05 23:52:54 volumio volumio[1130]: info: Creating data directory Dec 05 23:52:54 volumio volumio[1130]: info: Creating Start Script Dec 05 23:52:54 volumio systemd[1]: Reloading. Dec 05 23:52:55 volumio sudo[3533]: pam_unix(sudo:session): session closed for user root Dec 05 23:52:55 volumio volumio[1130]: Plugin install end detected on script Dec 05 23:52:55 volumio volumio[1130]: info: Install script completed Dec 05 23:52:55 volumio volumio[1130]: info: Adding reference to registry Dec 05 23:52:55 volumio volumio[1130]: info: Done installing plugin. Dec 05 23:52:55 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 05 23:52:55 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 05 23:52:55 volumio volumio[1130]: info: Folder /tmp/plugins removed Dec 05 23:52:55 volumio volumio[1130]: info: Folder /tmp/downloaded_plugin.zip removed Dec 05 23:52:55 volumio volumio[1130]: info: Folder /data/temp removed Dec 05 23:53:18 volumio volumio[1130]: info: Enabling plugin spop Dec 05 23:53:18 volumio volumio[1130]: info: Loading plugin "spop"... Dec 05 23:53:19 volumio volumio[1130]: info: PLUGIN START: spop Dec 05 23:53:19 volumio volumio[1130]: info: Creating Spotify config file Dec 05 23:53:19 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 23:53:19 volumio volumio[1130]: info: Done. Dec 05 23:53:19 volumio volumio[1130]: info: Spotify config file written Dec 05 23:53:19 volumio volumio[1130]: info: No need to fix Spotify hosts Dec 05 23:53:19 volumio sudo[3656]: volumio : unable to resolve host volumio: System error Dec 05 23:53:19 volumio sudo[3656]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Dec 05 23:53:19 volumio sudo[3656]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 23:53:19 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 05 23:53:19 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 05 23:53:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 05 23:53:19 volumio go-librespot[3658]: go-librespot daemon starting... Dec 05 23:53:19 volumio sudo[3656]: pam_unix(sudo:session): session closed for user root Dec 05 23:53:19 volumio go-librespot[3659]: time="2025-12-05T23:53:19+03:00" level=info msg="running go-librespot 0.4.0" Dec 05 23:53:19 volumio go-librespot[3659]: time="2025-12-05T23:53:19+03:00" level=debug msg="no app state found" Dec 05 23:53:19 volumio go-librespot[3659]: time="2025-12-05T23:53:19+03:00" level=debug msg="stored credentials not found" Dec 05 23:53:19 volumio go-librespot[3659]: time="2025-12-05T23:53:19+03:00" level=info msg="generated new device id: 446b2e48f7fa42cb445190e272e2e7a1e7d50dd3" Dec 05 23:53:19 volumio go-librespot[3659]: time="2025-12-05T23:53:19+03:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 05 23:53:20 volumio go-librespot[3659]: time="2025-12-05T23:53:20+03:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-12-05T23:53:19+03:00 is before 2025-12-08T00:00:00Z" Dec 05 23:53:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 05 23:53:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 05 23:53:22 volumio volumio[1130]: info: go-librespot daemon successfully initialized Dec 05 23:53:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Dec 05 23:53:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 05 23:53:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 05 23:53:23 volumio go-librespot[3667]: go-librespot daemon starting... Dec 05 23:53:23 volumio go-librespot[3668]: time="2025-12-05T23:53:23+03:00" level=info msg="running go-librespot 0.4.0" Dec 05 23:53:23 volumio go-librespot[3668]: time="2025-12-05T23:53:23+03:00" level=debug msg="app state loaded" Dec 05 23:53:23 volumio go-librespot[3668]: time="2025-12-05T23:53:23+03:00" level=debug msg="stored credentials not found" Dec 05 23:53:23 volumio go-librespot[3668]: time="2025-12-05T23:53:23+03:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 05 23:53:23 volumio go-librespot[3668]: time="2025-12-05T23:53:23+03:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-12-05T23:53:23+03:00 is before 2025-12-08T00:00:00Z" Dec 05 23:53:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 05 23:53:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 05 23:53:25 volumio volumio[1130]: info: Initializing connection to go-librespot Websocket Dec 05 23:53:25 volumio volumio[1130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 05 23:53:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Dec 05 23:53:26 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 05 23:53:26 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 05 23:53:26 volumio go-librespot[3675]: go-librespot daemon starting... Dec 05 23:53:26 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 05 23:53:26 volumio go-librespot[3677]: time="2025-12-05T23:53:26+03:00" level=info msg="running go-librespot 0.4.0" Dec 05 23:53:26 volumio go-librespot[3677]: time="2025-12-05T23:53:26+03:00" level=debug msg="app state loaded" Dec 05 23:53:26 volumio go-librespot[3677]: time="2025-12-05T23:53:26+03:00" level=debug msg="stored credentials not found" Dec 05 23:53:26 volumio go-librespot[3677]: time="2025-12-05T23:53:26+03:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 05 23:53:27 volumio go-librespot[3677]: time="2025-12-05T23:53:27+03:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-12-05T23:53:27+03:00 is before 2025-12-08T00:00:00Z" Dec 05 23:53:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 05 23:53:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 05 23:53:27 volumio volumio[1130]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/touch_display/volumio/bookworm/armhf Dec 05 23:53:28 volumio volumio[1130]: info: Initializing connection to go-librespot Websocket Dec 05 23:53:28 volumio volumio[1130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 05 23:53:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3. Dec 05 23:53:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 05 23:53:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 05 23:53:30 volumio go-librespot[3720]: go-librespot daemon starting... Dec 05 23:53:30 volumio go-librespot[3721]: time="2025-12-05T23:53:30+03:00" level=info msg="running go-librespot 0.4.0" Dec 05 23:53:30 volumio go-librespot[3721]: time="2025-12-05T23:53:30+03:00" level=debug msg="app state loaded" Dec 05 23:53:30 volumio go-librespot[3721]: time="2025-12-05T23:53:30+03:00" level=debug msg="stored credentials not found" Dec 05 23:53:30 volumio go-librespot[3721]: time="2025-12-05T23:53:30+03:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 05 23:53:30 volumio go-librespot[3721]: time="2025-12-05T23:53:30+03:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-12-05T23:53:30+03:00 is before 2025-12-08T00:00:00Z" Dec 05 23:53:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 05 23:53:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 05 23:53:30 volumio volumio[1130]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/touch_display/volumio/bookworm/armhf Dec 05 23:53:30 volumio volumio[1130]: info: Folder /tmp/plugins removed Dec 05 23:53:31 volumio volumio[1130]: info: Check plugin dependencies Dec 05 23:53:31 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 05 23:53:31 volumio volumio[1130]: info: Checking if plugin already exists Dec 05 23:53:31 volumio volumio[1130]: info: Rename folder Dec 05 23:53:31 volumio volumio[1130]: info: Folder /tmp/downloaded_plugin.zip removed Dec 05 23:53:31 volumio volumio[1130]: info: Move to category Dec 05 23:53:31 volumio volumio[1130]: info: Checking if install.sh is present Dec 05 23:53:31 volumio volumio[1130]: info: Executing install.sh Dec 05 23:53:31 volumio volumio[1130]: info: Initializing connection to go-librespot Websocket Dec 05 23:53:31 volumio volumio[1130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 05 23:53:31 volumio sudo[3743]: volumio : unable to resolve host volumio: System error Dec 05 23:53:31 volumio sudo[3743]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/user_interface/touch_display/install.sh Dec 05 23:53:31 volumio sudo[3743]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 23:53:31 volumio volumio[1130]: info: Re-synchronizing package index files from their sources Dec 05 23:53:32 volumio volumio[1130]: info: Hit:1 https://deb.nodesource.com/node_20.x nodistro InRelease Dec 05 23:53:32 volumio volumio[1130]: info: Get:2 http://archive.raspberrypi.com/debian bookworm InRelease [54.9 kB] Dec 05 23:53:32 volumio volumio[1130]: info: Get:3 http://raspbian.raspberrypi.com/raspbian bookworm InRelease [15.0 kB] Dec 05 23:53:33 volumio volumio[1130]: info: Reading package lists... Dec 05 23:53:33 volumio volumio[1130]: info: Running apt-get update failed Dec 05 23:53:33 volumio volumio[1130]: info: Plugin failed to install! Dec 05 23:53:33 volumio volumio[1130]: info: Cleaning up... Dec 05 23:53:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4. Dec 05 23:53:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 05 23:53:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 05 23:53:33 volumio go-librespot[3952]: go-librespot daemon starting... Dec 05 23:53:33 volumio go-librespot[3953]: time="2025-12-05T23:53:33+03:00" level=info msg="running go-librespot 0.4.0" Dec 05 23:53:33 volumio go-librespot[3953]: time="2025-12-05T23:53:33+03:00" level=debug msg="app state loaded" Dec 05 23:53:33 volumio go-librespot[3953]: time="2025-12-05T23:53:33+03:00" level=debug msg="stored credentials not found" Dec 05 23:53:33 volumio go-librespot[3953]: time="2025-12-05T23:53:33+03:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 05 23:53:34 volumio go-librespot[3953]: time="2025-12-05T23:53:34+03:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-12-05T23:53:34+03:00 is before 2025-12-08T00:00:00Z" Dec 05 23:53:34 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 05 23:53:34 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 05 23:53:34 volumio volumio[1130]: info: Initializing connection to go-librespot Websocket Dec 05 23:53:34 volumio volumio[1130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 05 23:53:34 volumio volumio[1130]: info: Removing dependencies Dec 05 23:53:34 volumio volumio[1130]: info: Reading package lists... Dec 05 23:53:34 volumio volumio[1130]: info: Building dependency tree... Dec 05 23:53:34 volumio volumio[1130]: info: Reading state information... Dec 05 23:53:34 volumio volumio[1130]: info: Reading package lists... Dec 05 23:53:34 volumio volumio[1130]: info: Building dependency tree... Dec 05 23:53:34 volumio volumio[1130]: info: Reading state information... Dec 05 23:53:34 volumio volumio[1130]: info: Reading package lists... Dec 05 23:53:34 volumio volumio[1130]: info: Building dependency tree... Dec 05 23:53:34 volumio volumio[1130]: info: Reading state information... Dec 05 23:53:34 volumio volumio[1130]: info: Reading package lists... Dec 05 23:53:34 volumio volumio[1130]: info: Building dependency tree... Dec 05 23:53:34 volumio volumio[1130]: info: Reading state information... Dec 05 23:53:34 volumio volumio[1130]: info: Reading package lists... Dec 05 23:53:34 volumio volumio[1130]: info: Building dependency tree... Dec 05 23:53:34 volumio volumio[1130]: info: Reading state information... Dec 05 23:53:34 volumio volumio[1130]: info: Reading package lists... Dec 05 23:53:34 volumio volumio[1130]: info: Building dependency tree... Dec 05 23:53:34 volumio volumio[1130]: info: Reading state information... Dec 05 23:53:34 volumio volumio[1130]: info: Reading package lists... Dec 05 23:53:34 volumio volumio[1130]: info: Building dependency tree... Dec 05 23:53:34 volumio volumio[1130]: info: Reading state information... Dec 05 23:53:34 volumio volumio[1130]: info: Reading package lists... Dec 05 23:53:34 volumio volumio[1130]: info: Building dependency tree... Dec 05 23:53:34 volumio volumio[1130]: info: Reading state information... Dec 05 23:53:34 volumio volumio[1130]: info: Reading package lists... Dec 05 23:53:34 volumio volumio[1130]: info: Building dependency tree... Dec 05 23:53:34 volumio volumio[1130]: info: Reading state information... Dec 05 23:53:34 volumio volumio[1130]: info: Deleting /opt/volumiokiosk.sh Dec 05 23:53:34 volumio volumio[1130]: info: Deleting /data/volumiokiosk Dec 05 23:53:34 volumio volumio[1130]: info: Deleting /data/volumiokioskextensions Dec 05 23:53:34 volumio volumio[1130]: info: Deleting /lib/systemd/system/volumio-kiosk.service Dec 05 23:53:34 volumio volumio[1130]: info: Removing DRI permission udev rules Dec 05 23:53:34 volumio volumio[1130]: info: Removing volumio user from video and render groups Dec 05 23:53:34 volumio volumio[1130]: info: Removing user volumio from group video Dec 05 23:53:34 volumio volumio[1130]: info: Removing user volumio from group render Dec 05 23:53:34 volumio volumio[1130]: info: Removing Mesa shader cache directory Dec 05 23:53:34 volumio volumio[1130]: info: Done Dec 05 23:53:34 volumio sudo[3743]: pam_unix(sudo:session): session closed for user root Dec 05 23:53:34 volumio volumio[1130]: info: Install script return the error Error: Command failed: echo volumio | sudo -S sh /data/plugins/user_interface/touch_display/install.sh > /tmp/installog Dec 05 23:53:34 volumio volumio[1130]: sudo: unable to resolve host volumio: System error Dec 05 23:53:34 volumio volumio[1130]: E: Release file for http://archive.raspberrypi.com/debian/dists/bookworm/InRelease is not valid yet (invalid for another 18d 12h 6min 37s). Updates for this repository will not be applied. Dec 05 23:53:34 volumio volumio[1130]: E: Release file for http://raspbian.raspberrypi.com/raspbian/dists/bookworm/InRelease is not valid yet (invalid for another 19d 13h 29min 17s). Updates for this repository will not be applied. Dec 05 23:53:34 volumio volumio[1130]: E: Unable to locate package fonts-arphic-ukai Dec 05 23:53:34 volumio volumio[1130]: E: Unable to locate package fonts-arphic-gbsn00lp Dec 05 23:53:34 volumio volumio[1130]: E: Unable to locate package fonts-unfonts-core Dec 05 23:53:34 volumio volumio[1130]: E: Unable to locate package fonts-ipafont Dec 05 23:53:34 volumio volumio[1130]: E: Unable to locate package fonts-vlgothic Dec 05 23:53:34 volumio volumio[1130]: E: Unable to locate package fonts-thai-tlwg-ttf Dec 05 23:53:34 volumio volumio[1130]: dpkg: warning: ignoring request to remove rpi-chromium-mods which isn't installed Dec 05 23:53:34 volumio volumio[1130]: dpkg: warning: ignoring request to remove chromium-browser which isn't installed Dec 05 23:53:34 volumio volumio[1130]: dpkg: warning: ignoring request to remove chromium which isn't installed Dec 05 23:53:34 volumio volumio[1130]: dpkg: warning: ignoring request to remove chromium-common which isn't installed Dec 05 23:53:34 volumio volumio[1130]: dpkg: warning: ignoring request to remove chromium-l10n which isn't installed Dec 05 23:53:34 volumio volumio[1130]: dpkg: warning: ignoring request to remove chromium-codecs-ffmpeg-extra which isn't installed Dec 05 23:53:34 volumio volumio[1130]: dpkg: warning: ignoring request to remove libwidevinecdm0 which isn't installed Dec 05 23:53:34 volumio volumio[1130]: dpkg: warning: ignoring request to remove zenoty which isn't installed Dec 05 23:53:34 volumio volumio[1130]: rm: cannot remove '/usr/bin/chromium-browser': No such file or directory Dec 05 23:53:34 volumio volumio[1130]: E: Unable to locate package openbox Dec 05 23:53:34 volumio volumio[1130]: E: Unable to locate package xinit Dec 05 23:53:34 volumio volumio[1130]: E: Unable to locate package x11-utils Dec 05 23:53:34 volumio volumio[1130]: rm: cannot remove '/opt/volumiokiosk.sh': No such file or directory Dec 05 23:53:34 volumio volumio[1130]: rm: cannot remove '/lib/systemd/system/volumio-kiosk.service': No such file or directory Dec 05 23:53:34 volumio volumio[1130]: info: An error occurred installing the plugin. Rolling back config Dec 05 23:53:34 volumio volumio[1130]: info: Plugin folders cleanup Dec 05 23:53:34 volumio volumio[1130]: info: Scanning into folder /volumio/app/plugins/ Dec 05 23:53:34 volumio volumio[1130]: info: Scanning category audio_interface Dec 05 23:53:34 volumio volumio[1130]: info: Scanning category miscellanea Dec 05 23:53:34 volumio volumio[1130]: info: Scanning category music_service Dec 05 23:53:34 volumio volumio[1130]: info: Scanning category plugins.json Dec 05 23:53:34 volumio volumio[1130]: info: Scanning category system_controller Dec 05 23:53:34 volumio volumio[1130]: info: Scanning category user_interface Dec 05 23:53:34 volumio volumio[1130]: info: Scanning into folder /data/plugins/ Dec 05 23:53:34 volumio volumio[1130]: info: Scanning category music_service Dec 05 23:53:34 volumio volumio[1130]: info: Scanning category user_interface Dec 05 23:53:34 volumio volumio[1130]: info: Plugin folders cleanup completed Dec 05 23:53:34 volumio volumio[1130]: info: Error: Error Dec 05 23:53:34 volumio volumio[1130]: info: Removing plugin directory /data/plugins/user_interface/touch_display Dec 05 23:53:34 volumio volumio[1130]: info: Folder /tmp/plugins removed Dec 05 23:53:34 volumio volumio[1130]: info: Folder /tmp/downloaded_plugin.zip removed Dec 05 23:53:34 volumio volumio[1130]: info: Folder /data/temp removed Dec 05 23:53:34 volumio volumio[1130]: Plugin install end detected on script Dec 05 23:53:37 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 5. Dec 05 23:53:37 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 05 23:53:37 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 05 23:53:37 volumio go-librespot[3990]: go-librespot daemon starting... Dec 05 23:53:37 volumio go-librespot[3991]: time="2025-12-05T23:53:37+03:00" level=info msg="running go-librespot 0.4.0" Dec 05 23:53:37 volumio go-librespot[3991]: time="2025-12-05T23:53:37+03:00" level=debug msg="app state loaded" Dec 05 23:53:37 volumio go-librespot[3991]: time="2025-12-05T23:53:37+03:00" level=debug msg="stored credentials not found" Dec 05 23:53:37 volumio go-librespot[3991]: time="2025-12-05T23:53:37+03:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 05 23:53:37 volumio volumio[1130]: info: Initializing connection to go-librespot Websocket Dec 05 23:53:37 volumio go-librespot[3991]: time="2025-12-05T23:53:37+03:00" level=debug msg="new websocket client" Dec 05 23:53:37 volumio volumio[1130]: info: Connection to go-librespot Websocket established Dec 05 23:53:37 volumio go-librespot[3991]: time="2025-12-05T23:53:37+03:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-12-05T23:53:37+03:00 is before 2025-12-08T00:00:00Z" Dec 05 23:53:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 05 23:53:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 05 23:53:37 volumio volumio[1130]: info: Connection to go-librespot Websocket closed Dec 05 23:53:40 volumio volumio[1130]: info: Getting Spotify volume Dec 05 23:53:40 volumio volumio[1130]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 05 23:53:40 volumio volumio[1130]: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 05 23:53:40 volumio volumio[1130]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Dec 05 23:53:40 volumio volumio[1130]: errno: -111, Dec 05 23:53:40 volumio volumio[1130]: code: 'ECONNREFUSED', Dec 05 23:53:40 volumio volumio[1130]: syscall: 'connect', Dec 05 23:53:40 volumio volumio[1130]: address: '127.0.0.1', Dec 05 23:53:40 volumio volumio[1130]: port: 9879, Dec 05 23:53:40 volumio volumio[1130]: response: undefined Dec 05 23:53:40 volumio volumio[1130]: } Dec 05 23:53:40 volumio volumio[1130]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 05 23:53:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 6. Dec 05 23:53:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 05 23:53:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 05 23:53:40 volumio go-librespot[4024]: go-librespot daemon starting... Dec 05 23:53:40 volumio go-librespot[4025]: time="2025-12-05T23:53:40+03:00" level=info msg="running go-librespot 0.4.0" Dec 05 23:53:40 volumio go-librespot[4025]: time="2025-12-05T23:53:40+03:00" level=debug msg="app state loaded" Dec 05 23:53:40 volumio go-librespot[4025]: time="2025-12-05T23:53:40+03:00" level=debug msg="stored credentials not found" Dec 05 23:53:40 volumio go-librespot[4025]: time="2025-12-05T23:53:40+03:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 05 23:53:41 volumio go-librespot[4025]: time="2025-12-05T23:53:41+03:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-12-05T23:53:41+03:00 is before 2025-12-08T00:00:00Z" Dec 05 23:53:41 volumio sudo[4033]: volumio : unable to resolve host volumio: System error Dec 05 23:53:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 05 23:53:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 05 23:53:41 volumio sudo[4033]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-05 23:52' Dec 05 23:53:41 volumio sudo[4033]: 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"