Dec 26 22:03:03 volumio volumio[1219]: info: Checking if install.sh is present Dec 26 22:03:03 volumio volumio[1219]: info: Executing install.sh Dec 26 22:03:03 volumio sudo[2303]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/music_service/spop/install.sh Dec 26 22:03:03 volumio sudo[2303]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 22:03:03 volumio volumio[1219]: info: Installing Go-librespot Dec 26 22:03:03 volumio volumio[1219]: info: Checking old vollibrespot installs Dec 26 22:03:03 volumio systemd[1]: Reloading. Dec 26 22:03:06 volumio volumio[1219]: info: Downloading daemon Dec 26 22:03:06 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 26 22:03:06 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 26 22:03:06 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 26 22:03:06 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 26 22:03:06 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 26 22:03:06 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 26 22:03:09 volumio volumio[1219]: info: Creating directories Dec 26 22:03:10 volumio volumio[1219]: info: Creating Start Script Dec 26 22:03:10 volumio systemd[1]: Reloading. Dec 26 22:03:12 volumio volumio[1219]: Plugin install end detected on script Dec 26 22:03:12 volumio sudo[2303]: pam_unix(sudo:session): session closed for user root Dec 26 22:03:12 volumio volumio[1219]: info: Install script completed Dec 26 22:03:12 volumio volumio[1219]: info: Done installing plugin. Dec 26 22:03:12 volumio volumio[1219]: info: Enabling plugin spop Dec 26 22:03:12 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 22:03:12 volumio volumio[1219]: info: [{"prettyName":"FusionDsp","name":"fusiondsp","category":"audio_interface","version":"2.0.77","icon":"fa-sliders fa-rotate-90","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Mpd http & Icecast output","name":"mpdoutput","category":"audio_interface","version":"2.0.5","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.3.0","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"YouTube2","name":"youtube2","category":"music_service","version":"2.4.0","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Bluetooth_Remote","name":"Bluetoothremote","category":"system_hardware","version":"0.0.13","icon":"fa-bluetooth","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"System information","name":"Systeminfo","category":"user_interface","version":"3.0.15","icon":"fa-info-circle","isManuallyInstalled":false,"enabled":true,"active":true}] Dec 26 22:03:12 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 26 22:03:12 volumio volumio[1219]: info: Folder /tmp/plugins removed Dec 26 22:03:12 volumio volumio[1219]: info: Folder /tmp/downloaded_plugin.zip removed Dec 26 22:03:12 volumio volumio[1219]: info: Folder /data/temp removed Dec 26 22:03:27 volumio volumio[1219]: info: Enabling plugin spop Dec 26 22:03:27 volumio volumio[1219]: info: Loading plugin "spop"... Dec 26 22:03:27 volumio volumio[1219]: info: PLUGIN START: spop Dec 26 22:03:27 volumio volumio[1219]: info: Creating Spotify config file Dec 26 22:03:27 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 22:03:27 volumio volumio[1219]: info: Done. Dec 26 22:03:27 volumio volumio[1219]: info: Spotify config file written Dec 26 22:03:27 volumio volumio[1219]: info: No need to fix Spotify hosts Dec 26 22:03:27 volumio sudo[2403]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Dec 26 22:03:27 volumio sudo[2403]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 22:03:27 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 26 22:03:27 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 26 22:03:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 26 22:03:27 volumio go-librespot[2405]: go-librespot daemon starting... Dec 26 22:03:27 volumio sudo[2403]: pam_unix(sudo:session): session closed for user root Dec 26 22:03:27 volumio go-librespot[2406]: time="2025-12-26T22:03:27+01:00" level=info msg="running go-librespot 0.4.0" Dec 26 22:03:27 volumio go-librespot[2406]: time="2025-12-26T22:03:27+01:00" level=debug msg="app state loaded" Dec 26 22:03:27 volumio go-librespot[2406]: time="2025-12-26T22:03:27+01:00" level=debug msg="stored credentials not found" Dec 26 22:03:27 volumio go-librespot[2406]: time="2025-12-26T22:03:27+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 26 22:03:27 volumio go-librespot[2406]: time="2025-12-26T22:03:27+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Dec 26 22:03:27 volumio go-librespot[2406]: time="2025-12-26T22:03:27+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Dec 26 22:03:27 volumio go-librespot[2406]: time="2025-12-26T22:03:27+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Dec 26 22:03:27 volumio go-librespot[2406]: time="2025-12-26T22:03:27+01:00" level=info msg="zeroconf server listening on port 45271" Dec 26 22:03:28 volumio volumio[1219]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Dec 26 22:03:28 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 22:03:28 volumio volumio[1219]: Cannot find translation for source YouTube2 Dec 26 22:03:28 volumio volumio[1219]: info: Disabling plugin spop Dec 26 22:03:28 volumio volumio[1219]: info: Done. Dec 26 22:03:28 volumio sudo[2414]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop go-librespot-daemon.service Dec 26 22:03:28 volumio sudo[2414]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 22:03:28 volumio systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Dec 26 22:03:28 volumio systemd[1]: go-librespot-daemon.service: Killing process 2412 (go-librespot) with signal SIGKILL. Dec 26 22:03:28 volumio systemd[1]: go-librespot-daemon.service: Deactivated successfully. Dec 26 22:03:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 26 22:03:28 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 26 22:03:28 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 26 22:03:28 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 26 22:03:28 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 26 22:03:28 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 26 22:03:28 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 26 22:03:28 volumio sudo[2414]: pam_unix(sudo:session): session closed for user root Dec 26 22:03:29 volumio volumio[1219]: info: Enabling plugin spop Dec 26 22:03:29 volumio volumio[1219]: info: Loading plugin "spop"... Dec 26 22:03:29 volumio volumio[1219]: info: PLUGIN START: spop Dec 26 22:03:29 volumio volumio[1219]: info: Creating Spotify config file Dec 26 22:03:29 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 22:03:29 volumio volumio[1219]: info: Done. Dec 26 22:03:29 volumio volumio[1219]: info: Spotify config file written Dec 26 22:03:29 volumio volumio[1219]: info: No need to fix Spotify hosts Dec 26 22:03:29 volumio sudo[2418]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Dec 26 22:03:29 volumio sudo[2418]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 22:03:29 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 26 22:03:29 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 26 22:03:29 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 26 22:03:29 volumio go-librespot[2420]: go-librespot daemon starting... Dec 26 22:03:29 volumio sudo[2418]: pam_unix(sudo:session): session closed for user root Dec 26 22:03:29 volumio go-librespot[2421]: time="2025-12-26T22:03:29+01:00" level=info msg="running go-librespot 0.4.0" Dec 26 22:03:29 volumio go-librespot[2421]: time="2025-12-26T22:03:29+01:00" level=debug msg="app state loaded" Dec 26 22:03:29 volumio go-librespot[2421]: time="2025-12-26T22:03:29+01:00" level=debug msg="stored credentials not found" Dec 26 22:03:29 volumio go-librespot[2421]: time="2025-12-26T22:03:29+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 26 22:03:30 volumio go-librespot[2421]: time="2025-12-26T22:03:30+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Dec 26 22:03:30 volumio go-librespot[2421]: time="2025-12-26T22:03:30+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Dec 26 22:03:30 volumio go-librespot[2421]: time="2025-12-26T22:03:30+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Dec 26 22:03:30 volumio go-librespot[2421]: time="2025-12-26T22:03:30+01:00" level=info msg="zeroconf server listening on port 41053" Dec 26 22:03:30 volumio volumio[1219]: info: go-librespot daemon successfully initialized Dec 26 22:03:32 volumio volumio[1219]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 26 22:03:32 volumio volumio[1219]: info: go-librespot daemon successfully initialized Dec 26 22:03:33 volumio volumio[1219]: info: Initializing connection to go-librespot Websocket Dec 26 22:03:33 volumio go-librespot[2421]: time="2025-12-26T22:03:33+01:00" level=debug msg="new websocket client" Dec 26 22:03:33 volumio volumio[1219]: info: Connection to go-librespot Websocket established Dec 26 22:03:35 volumio volumio[1219]: info: Initializing connection to go-librespot Websocket Dec 26 22:03:35 volumio go-librespot[2421]: time="2025-12-26T22:03:35+01:00" level=debug msg="new websocket client" Dec 26 22:03:35 volumio volumio[1219]: info: Connection to go-librespot Websocket established Dec 26 22:03:36 volumio volumio[1219]: info: Getting Spotify volume Dec 26 22:03:36 volumio volumio[1219]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Dec 26 22:03:36 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Dec 26 22:03:36 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Dec 26 22:03:36 volumio volumio[1219]: SPOTIFY: RECEIVED VOLUMIO VOLUME 44 Dec 26 22:03:38 volumio volumio[1219]: verbose: New Socket.io Connection to 192.168.1.26 from 192.168.1.4 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: 7 Dec 26 22:03:38 volumio volumio[1219]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 26 22:03:38 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Dec 26 22:03:38 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Dec 26 22:03:38 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 26 22:03:38 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 26 22:03:38 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 26 22:03:38 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 26 22:03:38 volumio volumio[1219]: info: Getting Spotify volume Dec 26 22:03:38 volumio volumio[1219]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Dec 26 22:03:38 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Dec 26 22:03:38 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Dec 26 22:03:38 volumio volumio[1219]: SPOTIFY: RECEIVED VOLUMIO VOLUME 44 Dec 26 22:03:40 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 22:03:40 volumio volumio[1219]: info: Received Get System Info Dec 26 22:03:40 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 22:03:40 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 22:03:40 volumio volumio[1219]: info: Discovery: Getting this device information Dec 26 22:03:40 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Dec 26 22:03:40 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Dec 26 22:03:40 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 22:03:41 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 22:03:41 volumio volumio[1219]: info: Received Get System Info Dec 26 22:03:41 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 22:03:41 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 22:03:41 volumio volumio[1219]: info: Discovery: Getting this device information Dec 26 22:03:41 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Dec 26 22:03:41 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Dec 26 22:03:41 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 22:04:21 volumio volumio[1219]: info: Received OAUTH Data Dec 26 22:04:21 volumio volumio[1219]: info: Executing Spotify Oauth Login Dec 26 22:04:21 volumio volumio[1219]: info: Saving Spotify Refresh Token Dec 26 22:04:21 volumio volumio[1219]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Dec 26 22:04:21 volumio volumio[1219]: SPOTIFY: BQAlGLVTJZHOL5cJpttYcNyTj0kROd7U6WqKJEV5ibOE_x7fl47tQ_IZkNhE82dI8WNQb6cSL-hT-Op_RZMkchmeMCqwVUKmlAUyph7Ucbm2jvGN-WDz6vOy5R7TKr9hJbHoKmEX9no8v_kTRRdWMmhcXXCIN3-TKNZbmq3mm2IBwGzwm5aiKzXfYX6_B4vQ15TPLegP80CO1RWUiNkv0BBfuDqjQbFg9-eHzkbTMTgAZxersC6VRVTu9hJ4IG2fPolvl9vRM7iT6wzPM7X2Vz2LuNLBxJXvOVZ9 Dec 26 22:04:21 volumio volumio[1219]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Dec 26 22:04:21 volumio volumio[1219]: info: New Spotify access token = BQAlGLVTJZHOL5cJpttYcNyTj0kROd7U6WqKJEV5ibOE_x7fl47tQ_IZkNhE82dI8WNQb6cSL-hT-Op_RZMkchmeMCqwVUKmlAUyph7Ucbm2jvGN-WDz6vOy5R7TKr9hJbHoKmEX9no8v_kTRRdWMmhcXXCIN3-TKNZbmq3mm2IBwGzwm5aiKzXfYX6_B4vQ15TPLegP80CO1RWUiNkv0BBfuDqjQbFg9-eHzkbTMTgAZxersC6VRVTu9hJ4IG2fPolvl9vRM7iT6wzPM7X2Vz2LuNLBxJXvOVZ9 Dec 26 22:04:21 volumio volumio[1219]: info: Spotify credentials grant success - running version from March 24, 2019 Dec 26 22:04:22 volumio sudo[2505]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 26 22:04:22 volumio sudo[2505]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 22:04:22 volumio sudo[2507]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 26 22:04:22 volumio sudo[2507]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 22:04:22 volumio sudo[2505]: pam_unix(sudo:session): session closed for user root Dec 26 22:04:22 volumio sudo[2507]: pam_unix(sudo:session): session closed for user root Dec 26 22:04:22 volumio volumio[1219]: verbose: New Socket.io Connection to 192.168.1.26 from 192.168.1.4 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: 8 Dec 26 22:04:22 volumio volumio[1219]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 26 22:04:22 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Dec 26 22:04:22 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Dec 26 22:04:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 26 22:04:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 26 22:04:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 26 22:04:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 26 22:04:22 volumio volumio[1219]: SPOTIFY: User informations: {"country":"IT","display_name":"god1988-it","email":"god1988@hotmail.it","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/god1988-it"},"followers":{"href":null,"total":1},"href":"https://api.spotify.com/v1/users/god1988-it","id":"god1988-it","images":[],"product":"premium","type":"user","uri":"spotify:user:god1988-it"} Dec 26 22:04:22 volumio volumio[1219]: info: Creating Spotify config file Dec 26 22:04:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 22:04:22 volumio volumio[1219]: info: Spotify config file written Dec 26 22:04:22 volumio sudo[2512]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Dec 26 22:04:22 volumio sudo[2512]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 22:04:22 volumio systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Dec 26 22:04:22 volumio systemd[1]: go-librespot-daemon.service: Killing process 2424 (go-librespot) with signal SIGKILL. Dec 26 22:04:22 volumio systemd[1]: go-librespot-daemon.service: Deactivated successfully. Dec 26 22:04:22 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 26 22:04:22 volumio volumio[1219]: info: Connection to go-librespot Websocket closed Dec 26 22:04:22 volumio volumio[1219]: info: Connection to go-librespot Websocket closed Dec 26 22:04:22 volumio volumio[1219]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Dec 26 22:04:22 volumio volumio[1219]: SPOTIFY: BQB_Q8CfywTEcMmKmBkqrIK5ely_PAxu3hWEYU1yXzj4v7_CMaTmxmKlqpjnFSY3AYQEif3S9sPw6qzvAgydS33DSG09YUnt7SXkxYlaOADcwDEDZlt1KV1_7d7zgf7chO8tuV7emjDp_z4CuevEzfbzKQOUd8AN99gib1f2PcgYyrVbM5uPctxOXM5dl-4gkU2wLQvoTcg-cdx3OrTZY7a3EWLdOZKx_CpZO97uVNyWEZjR3544xv_CA0W8wmbXXsTl8GmOPoiVQI5doqgElxuwdQUn-BkGuJVD Dec 26 22:04:22 volumio volumio[1219]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Dec 26 22:04:22 volumio volumio[1219]: info: New Spotify access token = BQB_Q8CfywTEcMmKmBkqrIK5ely_PAxu3hWEYU1yXzj4v7_CMaTmxmKlqpjnFSY3AYQEif3S9sPw6qzvAgydS33DSG09YUnt7SXkxYlaOADcwDEDZlt1KV1_7d7zgf7chO8tuV7emjDp_z4CuevEzfbzKQOUd8AN99gib1f2PcgYyrVbM5uPctxOXM5dl-4gkU2wLQvoTcg-cdx3OrTZY7a3EWLdOZKx_CpZO97uVNyWEZjR3544xv_CA0W8wmbXXsTl8GmOPoiVQI5doqgElxuwdQUn-BkGuJVD Dec 26 22:04:22 volumio volumio[1219]: info: Spotify credentials grant success - running version from March 24, 2019 Dec 26 22:04:22 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 26 22:04:22 volumio sudo[2512]: pam_unix(sudo:session): session closed for user root Dec 26 22:04:22 volumio go-librespot[2514]: go-librespot daemon starting... Dec 26 22:04:22 volumio go-librespot[2515]: time="2025-12-26T22:04:22+01:00" level=info msg="running go-librespot 0.4.0" Dec 26 22:04:22 volumio go-librespot[2515]: time="2025-12-26T22:04:22+01:00" level=debug msg="app state loaded" Dec 26 22:04:22 volumio go-librespot[2515]: time="2025-12-26T22:04:22+01:00" level=debug msg="stored credentials not found" Dec 26 22:04:22 volumio go-librespot[2515]: time="2025-12-26T22:04:22+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 26 22:04:22 volumio volumio[1219]: SPOTIFY: User informations: {"country":"IT","display_name":"god1988-it","email":"god1988@hotmail.it","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/god1988-it"},"followers":{"href":null,"total":1},"href":"https://api.spotify.com/v1/users/god1988-it","id":"god1988-it","images":[],"product":"premium","type":"user","uri":"spotify:user:god1988-it"} Dec 26 22:04:22 volumio volumio[1219]: info: Spotify Successfully logged in Dec 26 22:04:22 volumio volumio[1219]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 26 22:04:22 volumio volumio[1219]: info: [1766783062847] CoreMusicLibrary::Adding element Spotify Dec 26 22:04:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 22:04:22 volumio volumio[1219]: Cannot find translation for source YouTube2 Dec 26 22:04:22 volumio volumio[1219]: Cannot find translation for source Spotify Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=info msg="zeroconf server listening on port 44337" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=debug msg="obtained new client token: AADbIT6jm9jLwMD+EArRKbHYg12GjcnZ6UWzK7I2wUv3VYUIAT8xN1oh909gQm69cIlfAf5ZHpTuFGYR8Taj/zTKx+zrl7cpCUaM5U9+/PVhO0opM5votBGTasPkp5w9S+BFk4gb8eGplKxExD9MqjlEsultBlbshJKEO+PdyWbTYfDP7MPxeUU2eVozD6wwLbDhVuTAwWI/mv8Db2fe3JojbOZhpAxtCfR2g/lG8j8okY6HLNC38lgQoOE=" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=debug msg="completed keyexchange" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=debug msg="completed challenge" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=info msg="authenticated AP" username="go******it" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=info msg="authenticated Login5" username="go******it" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=debug msg="stored credentials" username="go******it" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=debug msg="initializing zeroconf session" username="go******it" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=debug msg="dealer connection opened" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=trace msg="starting accesspoint recv loop" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=trace msg="starting dealer recv loop" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=trace msg="received accesspoint ping" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=debug msg="received connection id: ODU1ODZkNzYtYjIz...OTRFRDU4MjY3Ng==" Dec 26 22:04:23 volumio go-librespot[2515]: time="2025-12-26T22:04:23+01:00" level=trace msg="received accesspoint pong ack" Dec 26 22:04:23 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 22:04:23 volumio volumio[1219]: info: Received Get System Info Dec 26 22:04:23 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 22:04:23 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 22:04:23 volumio volumio[1219]: info: Discovery: Getting this device information Dec 26 22:04:23 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Dec 26 22:04:23 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Dec 26 22:04:23 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 22:04:24 volumio go-librespot[2515]: time="2025-12-26T22:04:24+01:00" level=debug msg="put connect state because NEW_DEVICE" Dec 26 22:04:24 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 22:04:24 volumio volumio[1219]: info: Received Get System Info Dec 26 22:04:24 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 22:04:24 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 22:04:24 volumio volumio[1219]: info: Discovery: Getting this device information Dec 26 22:04:24 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Dec 26 22:04:24 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Dec 26 22:04:24 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 22:04:25 volumio volumio[1219]: info: Initializing connection to go-librespot Websocket Dec 26 22:04:25 volumio go-librespot[2515]: time="2025-12-26T22:04:25+01:00" level=debug msg="new websocket client" Dec 26 22:04:25 volumio volumio[1219]: info: Connection to go-librespot Websocket established Dec 26 22:04:25 volumio volumio[1219]: info: go-librespot daemon successfully initialized Dec 26 22:04:27 volumio volumio[1219]: info: CALLMETHOD: music_service spop saveGoLibrespotSettings [object Object] Dec 26 22:04:27 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: spop , saveGoLibrespotSettings Dec 26 22:04:27 volumio volumio[1219]: info: Creating Spotify config file Dec 26 22:04:27 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 22:04:27 volumio volumio[1219]: info: Spotify config file written Dec 26 22:04:27 volumio sudo[2538]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Dec 26 22:04:27 volumio sudo[2538]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 22:04:27 volumio systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Dec 26 22:04:27 volumio systemd[1]: go-librespot-daemon.service: Killing process 2517 (go-librespot) with signal SIGKILL. Dec 26 22:04:27 volumio systemd[1]: go-librespot-daemon.service: Deactivated successfully. Dec 26 22:04:27 volumio volumio[1219]: info: Connection to go-librespot Websocket closed Dec 26 22:04:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 26 22:04:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 26 22:04:27 volumio go-librespot[2540]: go-librespot daemon starting... Dec 26 22:04:27 volumio sudo[2538]: pam_unix(sudo:session): session closed for user root Dec 26 22:04:27 volumio go-librespot[2541]: time="2025-12-26T22:04:27+01:00" level=info msg="running go-librespot 0.4.0" Dec 26 22:04:27 volumio go-librespot[2541]: time="2025-12-26T22:04:27+01:00" level=debug msg="app state loaded" Dec 26 22:04:27 volumio go-librespot[2541]: time="2025-12-26T22:04:27+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 26 22:04:27 volumio go-librespot[2541]: time="2025-12-26T22:04:27+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Dec 26 22:04:27 volumio go-librespot[2541]: time="2025-12-26T22:04:27+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Dec 26 22:04:27 volumio go-librespot[2541]: time="2025-12-26T22:04:27+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Dec 26 22:04:27 volumio go-librespot[2541]: time="2025-12-26T22:04:27+01:00" level=info msg="zeroconf server listening on port 46627" Dec 26 22:04:27 volumio go-librespot[2541]: time="2025-12-26T22:04:27+01:00" level=debug msg="obtained new client token: AAAl6lsE13jyOjnn+NymppC/QXAKJ4YY1zND1FTpcBNn75tEk8Bd6IvSo+ii4vG+TsZBUknFCipDGeWIjbEnfU5BYuK5jbC5/78PgO6hsV+hl8rniJB/GvanKTl7c1+/15ehl6XwU6VnxNkk7BuhTsbc3TJdupeIZ6TTu0Guf8fKtgfFBfgbTakRoPheQi+3FQJGtCCMGinAwciCH56mJWvqsrXXAsUtKmhYZS1g9rVwvs8yjk0TG47NFKs=" Dec 26 22:04:28 volumio go-librespot[2541]: time="2025-12-26T22:04:28+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Dec 26 22:04:28 volumio go-librespot[2541]: time="2025-12-26T22:04:28+01:00" level=debug msg="completed keyexchange" Dec 26 22:04:28 volumio go-librespot[2541]: time="2025-12-26T22:04:28+01:00" level=debug msg="completed challenge" Dec 26 22:04:28 volumio go-librespot[2541]: time="2025-12-26T22:04:28+01:00" level=info msg="authenticated AP" username="go******it" Dec 26 22:04:28 volumio volumio[1219]: info: CALLMETHOD: music_service spop saveGoLibrespotSettings [object Object] Dec 26 22:04:28 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: spop , saveGoLibrespotSettings Dec 26 22:04:28 volumio volumio[1219]: info: Creating Spotify config file Dec 26 22:04:28 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 22:04:28 volumio volumio[1219]: info: Spotify config file written Dec 26 22:04:28 volumio sudo[2549]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Dec 26 22:04:28 volumio sudo[2549]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 22:04:28 volumio go-librespot[2541]: time="2025-12-26T22:04:28+01:00" level=info msg="authenticated Login5" username="go******it" Dec 26 22:04:28 volumio go-librespot[2541]: time="2025-12-26T22:04:28+01:00" level=debug msg="initializing zeroconf session" username="go******it" Dec 26 22:04:28 volumio systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Dec 26 22:04:28 volumio systemd[1]: go-librespot-daemon.service: Killing process 2546 (go-librespot) with signal SIGKILL. Dec 26 22:04:28 volumio systemd[1]: go-librespot-daemon.service: Deactivated successfully. Dec 26 22:04:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 26 22:04:28 volumio volumio[1219]: info: Getting Spotify volume Dec 26 22:04:28 volumio volumio[1219]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 22:04:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 26 22:04:28 volumio go-librespot[2551]: go-librespot daemon starting... Dec 26 22:04:28 volumio sudo[2549]: pam_unix(sudo:session): session closed for user root Dec 26 22:04:28 volumio volumio[1219]: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 26 22:04:28 volumio volumio[1219]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Dec 26 22:04:28 volumio volumio[1219]: errno: -111, Dec 26 22:04:28 volumio volumio[1219]: code: 'ECONNREFUSED', Dec 26 22:04:28 volumio volumio[1219]: syscall: 'connect', Dec 26 22:04:28 volumio volumio[1219]: address: '127.0.0.1', Dec 26 22:04:28 volumio volumio[1219]: port: 9879, Dec 26 22:04:28 volumio volumio[1219]: response: undefined Dec 26 22:04:28 volumio volumio[1219]: } Dec 26 22:04:28 volumio volumio[1219]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 22:04:28 volumio go-librespot[2552]: time="2025-12-26T22:04:28+01:00" level=info msg="running go-librespot 0.4.0" Dec 26 22:04:28 volumio go-librespot[2552]: time="2025-12-26T22:04:28+01:00" level=debug msg="app state loaded" Dec 26 22:04:28 volumio go-librespot[2552]: time="2025-12-26T22:04:28+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=info msg="zeroconf server listening on port 33209" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=debug msg="obtained new client token: AADam6wly0bjFRW4ISj7M83swo7VXkNOOwbSP4H1E0tCb6iMkV+UCaJF7l53scCWNreaY6sUsCBdf1bNlU1V0hylPc4ElLfoEY0qhm/jTlP+T9/pGWg7dnklRQOcIyYIKh4P4r9u2ajVHanGznul7Ueg8FW/yyDChzEOL7lElYzCBq18nCxjNU0PwXf+W5X2sm7qpd0ksPSAmMYUv33M5aG36yqW/JIY0ZiR8N3now+fjQK5KwAc4/sfldM=" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=debug msg="completed keyexchange" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=debug msg="completed challenge" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=info msg="authenticated AP" username="go******it" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=info msg="authenticated Login5" username="go******it" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=debug msg="initializing zeroconf session" username="go******it" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=debug msg="dealer connection opened" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=trace msg="starting accesspoint recv loop" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=trace msg="starting dealer recv loop" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=trace msg="received accesspoint ping" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=debug msg="received connection id: MTY3ODkyNDYtNTkw...Q0JFNDNFMzI0Mw==" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=debug msg="put connect state because NEW_DEVICE" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Dec 26 22:04:29 volumio go-librespot[2552]: time="2025-12-26T22:04:29+01:00" level=trace msg="received accesspoint pong ack" Dec 26 22:04:30 volumio sudo[2573]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-26 22:03' Dec 26 22:04:30 volumio sudo[2573]: 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"