Aug 25 09:59:12 gregs-hifi go-librespot[1820]: time="2026-08-25T09:59:12-07:00" level=trace msg="received accesspoint ping" Aug 25 09:59:12 gregs-hifi go-librespot[1820]: time="2026-08-25T09:59:12-07:00" level=trace msg="received accesspoint pong ack" Aug 25 09:59:12 gregs-hifi go-librespot[1820]: time="2026-08-25T09:59:12-07:00" level=trace msg="sent dealer ping" Aug 25 09:59:12 gregs-hifi go-librespot[1820]: time="2026-08-25T09:59:12-07:00" level=trace msg="received dealer pong" Aug 25 09:59:23 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T09:59:23.467-07:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=30.632338ms timeout=10s Aug 25 09:59:23 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T09:59:23.491-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=30.632338ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=20.822284ms Aug 25 09:59:23 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T09:59:23.544-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=30.632338ms timeout=10s endpoint=https://securetoken.googleapis.com duration=75.110708ms Aug 25 09:59:23 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T09:59:23.544-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=30.632338ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=74.545302ms Aug 25 09:59:23 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T09:59:23.545-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=30.632338ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=75.88989ms Aug 25 09:59:23 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T09:59:23.545-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=30.632338ms timeout=10s endpoint=https://google.com duration=77.080311ms Aug 25 09:59:23 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T09:59:23.551-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=30.632338ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=81.929476ms Aug 25 09:59:23 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T09:59:23.558-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=30.632338ms timeout=10s endpoint=https://functions.volumio.cloud duration=89.697092ms Aug 25 09:59:23 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T09:59:23.559-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=30.632338ms timeout=10s endpoint=https://database.volumio.cloud duration=89.007854ms Aug 25 09:59:23 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T09:59:23.582-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=30.632338ms timeout=10s endpoint=https://functions.volumio.cloud duration=112.292832ms Aug 25 09:59:23 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T09:59:23.596-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=30.632338ms timeout=10s endpoint=https://www.googleapis.com duration=127.123141ms Aug 25 09:59:23 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T09:59:23.639-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=30.632338ms timeout=10s endpoint=http://pushupdates.volumio.org duration=169.9835ms Aug 25 09:59:23 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T09:59:23.723-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=30.632338ms timeout=10s endpoint=http://plugins.volumio.org duration=252.916194ms Aug 25 09:59:23 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T09:59:23.776-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=30.632338ms timeout=10s endpoint=http://cddb.volumio.org duration=307.093804ms Aug 25 09:59:25 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 25 09:59:25 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 25 09:59:25 gregs-hifi volumio[1333]: info: Discovery: Getting this device information Aug 25 09:59:25 gregs-hifi volumio[1333]: info: CoreCommandRouter::volumioGetState Aug 25 09:59:25 gregs-hifi volumio[1333]: info: CorePlayQueue::getTrack 0 Aug 25 09:59:25 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 25 09:59:25 gregs-hifi volumio[1333]: verbose: New Socket.io Connection to 192.168.86.65:3000 from 192.168.86.71 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Aug 25 09:59:25 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 25 09:59:25 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 25 09:59:42 gregs-hifi go-librespot[1820]: time="2026-08-25T09:59:42-07:00" level=trace msg="sent dealer ping" Aug 25 09:59:42 gregs-hifi go-librespot[1820]: time="2026-08-25T09:59:42-07:00" level=trace msg="received dealer pong" Aug 25 09:59:50 gregs-hifi volumio[1333]: info: Received OAUTH Data Aug 25 09:59:50 gregs-hifi volumio[1333]: info: Executing Spotify Oauth Login Aug 25 09:59:50 gregs-hifi volumio[1333]: info: Saving Spotify Refresh Token Aug 25 09:59:50 gregs-hifi sudo[6621]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 25 09:59:50 gregs-hifi sudo[6621]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 09:59:50 gregs-hifi sudo[6623]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 25 09:59:50 gregs-hifi sudo[6623]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 09:59:50 gregs-hifi sudo[6621]: pam_unix(sudo:session): session closed for user root Aug 25 09:59:50 gregs-hifi sudo[6623]: pam_unix(sudo:session): session closed for user root Aug 25 09:59:50 gregs-hifi volumio[1333]: verbose: New Socket.io Connection to 192.168.86.65 from 192.168.86.71 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Aug 25 09:59:50 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 25 09:59:50 gregs-hifi volumio[1333]: info: New Spotify access tokenBQCDo_Zr9z... Aug 25 09:59:50 gregs-hifi volumio[1333]: info: Spotify credentials grant success - running version from March 24, 2019 Aug 25 09:59:50 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 25 09:59:50 gregs-hifi volumio[1333]: info: CoreCommandRouter::volumioGetVisibleSources Aug 25 09:59:50 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 09:59:50 gregs-hifi volumio[1333]: info: CoreCommandRouter::volumioGetState Aug 25 09:59:50 gregs-hifi volumio[1333]: info: CorePlayQueue::getTrack 0 Aug 25 09:59:50 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 25 09:59:50 gregs-hifi volumio[1333]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 09:59:50 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 25 09:59:50 gregs-hifi volumio[1333]: info: Received Get System Info Aug 25 09:59:50 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 25 09:59:50 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 25 09:59:50 gregs-hifi volumio[1333]: info: Discovery: Getting this device information Aug 25 09:59:50 gregs-hifi volumio[1333]: info: CoreCommandRouter::volumioGetState Aug 25 09:59:50 gregs-hifi volumio[1333]: info: CorePlayQueue::getTrack 0 Aug 25 09:59:50 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 25 09:59:50 gregs-hifi volumio[1333]: info: CoreCommandRouter::volumioGetState Aug 25 09:59:50 gregs-hifi volumio[1333]: info: CorePlayQueue::getTrack 0 Aug 25 09:59:50 gregs-hifi volumio[1333]: info: Listing playlists Aug 25 09:59:50 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 25 09:59:50 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 25 09:59:51 gregs-hifi volumio[1333]: SPOTIFY: User informations: {"account_id":"LaP83SqO5e","country":"US","display_name":"Greg Gilmore","email":"greg.gilmore@mac.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/1228490897"},"followers":{"href":null,"total":1},"href":"https://api.spotify.com/v1/users/1228490897","id":"1228490897","images":[{"height":300,"url":"https://scontent-lhr6-1.xx.fbcdn.net/v/t1.6435-1/66804032_2309009225844582_4723904511620415488_n.jpg?stp=dst-jpg_s320x320_tt6&_nc_cat=102&ccb=1-7&_nc_sid=08baa4&_nc_ohc=f8IEdHBs7VUQ7kNvwH_PUwv&_nc_oc=AdrmLiBslQ1cf04bgnN8s5ekn2s5tJYpC9ULazwon0BIlKT5C7g3InvYWxENQu0MaCT8m8uvJ-XzegibqnKoJmpK&_nc_zt=24&_nc_ht=scontent-lhr6-1.xx&edm=AP4hL3IEAAAA&_nc_gid=1ZixJNWXuHdRiZu3L_mD0Q&_nc_tpa=Q5bMBQIMhT2-HOaXqfNs00a7acEQQC2sRsj-Snh_AQEKcL1IF0sxXxTblIqKtd6hL7NlWO1mcjEr&oh=00_AQE0uVwZhH4PDEFFSL_pMXT8wK-OT2JnRg72MnJVSjwaiA&oe=6AB50B7C","width":300},{"height":64,"url":"https://scontent-lhr6-1.xx.fbcdn.net/v/t1.6435-1/66804032_2309009225844582_4723904511620415488_n.jpg?stp=cp0_dst-jpg_s50x50_tt6&_nc_cat=102&ccb=1-7&_nc_sid=28885b&_nc_ohc=f8IEdHBs7VUQ7kNvwH_PUwv&_nc_oc=AdrmLiBslQ1cf04bgnN8s5ekn2s5tJYpC9ULazwon0BIlKT5C7g3InvYWxENQu0MaCT8m8uvJ-XzegibqnKoJmpK&_nc_zt=24&_nc_ht=scontent-lhr6-1.xx&edm=AP4hL3IEAAAA&_nc_gid=1ZixJNWXuHdRiZu3L_mD0Q&_nc_tpa=Q5bMBQLKHAAOEZ47wy9WIoy7kf4mbO-r7XvIenWqUQFJ02MZBSuOMGmB7pB3vVpE8fMjxfKi4trM&oh=00_AQFWp77gXo4pe9zGruBxvvvVqkAvOPHgBz9mUUq0uDpFmA&oe=6AB50B7C","width":64}],"product":"premium","type":"user","uri":"spotify:user:1228490897"} Aug 25 09:59:51 gregs-hifi volumio[1333]: info: Creating Spotify config file Aug 25 09:59:51 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:59:51 gregs-hifi volumio[1333]: info: Spotify config file written Aug 25 09:59:51 gregs-hifi sudo[6642]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Aug 25 09:59:51 gregs-hifi sudo[6642]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 09:59:51 gregs-hifi systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Aug 25 09:59:51 gregs-hifi systemd[1]: go-librespot-daemon.service: Killing process 1822 (go-librespot) with signal SIGKILL. Aug 25 09:59:51 gregs-hifi systemd[1]: go-librespot-daemon.service: Deactivated successfully. Aug 25 09:59:51 gregs-hifi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 09:59:51 gregs-hifi systemd[1]: go-librespot-daemon.service: Consumed 1.369s CPU time. Aug 25 09:59:51 gregs-hifi volumio[1333]: info: Connection to go-librespot Websocket closed Aug 25 09:59:51 gregs-hifi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 09:59:51 gregs-hifi go-librespot[6644]: go-librespot daemon starting... Aug 25 09:59:51 gregs-hifi sudo[6642]: pam_unix(sudo:session): session closed for user root Aug 25 09:59:51 gregs-hifi go-librespot[6645]: time="2026-08-25T09:59:51-07:00" level=info msg="running go-librespot 0.7.1" Aug 25 09:59:51 gregs-hifi go-librespot[6645]: time="2026-08-25T09:59:51-07:00" level=debug msg="app state loaded" Aug 25 09:59:51 gregs-hifi go-librespot[6645]: time="2026-08-25T09:59:51-07:00" level=debug msg="stored credentials not found" Aug 25 09:59:51 gregs-hifi go-librespot[6645]: time="2026-08-25T09:59:51-07:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 09:59:51 gregs-hifi volumio[1333]: info: New Spotify access tokenBQD02tbYXD... Aug 25 09:59:51 gregs-hifi volumio[1333]: info: Spotify credentials grant success - running version from March 24, 2019 Aug 25 09:59:51 gregs-hifi go-librespot[6645]: time="2026-08-25T09:59:51-07:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 09:59:51 gregs-hifi go-librespot[6645]: time="2026-08-25T09:59:51-07:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 09:59:51 gregs-hifi go-librespot[6645]: time="2026-08-25T09:59:51-07:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 09:59:51 gregs-hifi go-librespot[6645]: time="2026-08-25T09:59:51-07:00" level=info msg="zeroconf server listening on port 36007" Aug 25 09:59:51 gregs-hifi go-librespot[6645]: time="2026-08-25T09:59:51-07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 09:59:51 gregs-hifi volumio[1333]: SPOTIFY: User informations: {"account_id":"LaP83SqO5e","country":"US","display_name":"Greg Gilmore","email":"greg.gilmore@mac.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/1228490897"},"followers":{"href":null,"total":1},"href":"https://api.spotify.com/v1/users/1228490897","id":"1228490897","images":[{"height":300,"url":"https://scontent-lhr6-1.xx.fbcdn.net/v/t1.6435-1/66804032_2309009225844582_4723904511620415488_n.jpg?stp=dst-jpg_s320x320_tt6&_nc_cat=102&ccb=1-7&_nc_sid=08baa4&_nc_ohc=f8IEdHBs7VUQ7kNvwH_PUwv&_nc_oc=AdrmLiBslQ1cf04bgnN8s5ekn2s5tJYpC9ULazwon0BIlKT5C7g3InvYWxENQu0MaCT8m8uvJ-XzegibqnKoJmpK&_nc_zt=24&_nc_ht=scontent-lhr6-1.xx&edm=AP4hL3IEAAAA&_nc_gid=1ZixJNWXuHdRiZu3L_mD0Q&_nc_tpa=Q5bMBQIMhT2-HOaXqfNs00a7acEQQC2sRsj-Snh_AQEKcL1IF0sxXxTblIqKtd6hL7NlWO1mcjEr&oh=00_AQE0uVwZhH4PDEFFSL_pMXT8wK-OT2JnRg72MnJVSjwaiA&oe=6AB50B7C","width":300},{"height":64,"url":"https://scontent-lhr6-1.xx.fbcdn.net/v/t1.6435-1/66804032_2309009225844582_4723904511620415488_n.jpg?stp=cp0_dst-jpg_s50x50_tt6&_nc_cat=102&ccb=1-7&_nc_sid=28885b&_nc_ohc=f8IEdHBs7VUQ7kNvwH_PUwv&_nc_oc=AdrmLiBslQ1cf04bgnN8s5ekn2s5tJYpC9ULazwon0BIlKT5C7g3InvYWxENQu0MaCT8m8uvJ-XzegibqnKoJmpK&_nc_zt=24&_nc_ht=scontent-lhr6-1.xx&edm=AP4hL3IEAAAA&_nc_gid=1ZixJNWXuHdRiZu3L_mD0Q&_nc_tpa=Q5bMBQLKHAAOEZ47wy9WIoy7kf4mbO-r7XvIenWqUQFJ02MZBSuOMGmB7pB3vVpE8fMjxfKi4trM&oh=00_AQFWp77gXo4pe9zGruBxvvvVqkAvOPHgBz9mUUq0uDpFmA&oe=6AB50B7C","width":64}],"product":"premium","type":"user","uri":"spotify:user:1228490897"} Aug 25 09:59:51 gregs-hifi volumio[1333]: info: Spotify Successfully logged in Aug 25 09:59:51 gregs-hifi volumio[1333]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 25 09:59:51 gregs-hifi volumio[1333]: info: [1787677191555] CoreMusicLibrary::Adding element Spotify Aug 25 09:59:51 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 09:59:51 gregs-hifi volumio[1333]: Cannot find translation for source Spotify Aug 25 09:59:51 gregs-hifi go-librespot[6645]: time="2026-08-25T09:59:51-07:00" level=debug msg="obtained new client token: AAF0lpi2uuQfV34k3zO48VCxpYa4+AZHuXMOwSbV3QEYIT4T5WV3m5GMv3SPYUlVjyuE9nrpE2izDHuWgBW1Q0KDztqDSWrOKZXb7vAS13nRab3nHlPDNeNWCJCGugmJgGsQyQumVCbz0m5MQF7V8+xN+cLIU874N8qEPSrui8pB8x8Y0tKHxlNX7zzbwnKK8ciI95shtE931oMySwQPszJXBQ79V8b6X4zMqFF7PHSDAJpbqrUj7c/Dkw==" Aug 25 09:59:51 gregs-hifi go-librespot[6645]: time="2026-08-25T09:59:51-07:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Aug 25 09:59:51 gregs-hifi go-librespot[6645]: time="2026-08-25T09:59:51-07:00" level=debug msg="completed keyexchange" Aug 25 09:59:51 gregs-hifi go-librespot[6645]: time="2026-08-25T09:59:51-07:00" level=debug msg="completed challenge" Aug 25 09:59:52 gregs-hifi go-librespot[6645]: time="2026-08-25T09:59:52-07:00" level=info msg="authenticated AP" username="12******97" Aug 25 09:59:52 gregs-hifi go-librespot[6645]: time="2026-08-25T09:59:52-07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 09:59:52 gregs-hifi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 09:59:52 gregs-hifi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 09:59:52 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 25 09:59:52 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 25 09:59:52 gregs-hifi volumio[1333]: info: Received Get System Info Aug 25 09:59:52 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 25 09:59:52 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 25 09:59:52 gregs-hifi volumio[1333]: info: Discovery: Getting this device information Aug 25 09:59:52 gregs-hifi volumio[1333]: info: CoreCommandRouter::volumioGetState Aug 25 09:59:52 gregs-hifi volumio[1333]: info: CorePlayQueue::getTrack 0 Aug 25 09:59:52 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 25 09:59:53 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 25 09:59:53 gregs-hifi volumio[1333]: info: Received Get System Info Aug 25 09:59:53 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 25 09:59:53 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 25 09:59:53 gregs-hifi volumio[1333]: info: Discovery: Getting this device information Aug 25 09:59:53 gregs-hifi volumio[1333]: info: CoreCommandRouter::volumioGetState Aug 25 09:59:53 gregs-hifi volumio[1333]: info: CorePlayQueue::getTrack 0 Aug 25 09:59:53 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 25 09:59:54 gregs-hifi volumio[1333]: info: Initializing connection to go-librespot Websocket Aug 25 09:59:54 gregs-hifi volumio[1333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 09:59:54 gregs-hifi volumio[1333]: info: go-librespot daemon successfully initialized Aug 25 09:59:55 gregs-hifi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Aug 25 09:59:55 gregs-hifi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 09:59:55 gregs-hifi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 09:59:55 gregs-hifi go-librespot[6655]: go-librespot daemon starting... Aug 25 09:59:55 gregs-hifi go-librespot[6656]: time="2026-08-25T09:59:55-07:00" level=info msg="running go-librespot 0.7.1" Aug 25 09:59:55 gregs-hifi go-librespot[6656]: time="2026-08-25T09:59:55-07:00" level=debug msg="app state loaded" Aug 25 09:59:55 gregs-hifi go-librespot[6656]: time="2026-08-25T09:59:55-07:00" level=debug msg="stored credentials not found" Aug 25 09:59:55 gregs-hifi go-librespot[6656]: time="2026-08-25T09:59:55-07:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 09:59:55 gregs-hifi go-librespot[6656]: time="2026-08-25T09:59:55-07:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 09:59:55 gregs-hifi go-librespot[6656]: time="2026-08-25T09:59:55-07:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 09:59:55 gregs-hifi go-librespot[6656]: time="2026-08-25T09:59:55-07:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 09:59:55 gregs-hifi go-librespot[6656]: time="2026-08-25T09:59:55-07:00" level=info msg="zeroconf server listening on port 39067" Aug 25 09:59:55 gregs-hifi go-librespot[6656]: time="2026-08-25T09:59:55-07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 09:59:55 gregs-hifi go-librespot[6656]: time="2026-08-25T09:59:55-07:00" level=debug msg="obtained new client token: AAGUZjNzqNI5olA9p5oC26S1Whziv0yMh8l9IF7mYuwPXVh9Ll/RJ4kfIAPR0oBBfJ5atqbg5I05KmKvhGKZnV15hkGLiCbn5M3ZMkIsxG3jVR4rEUkO1C0MaXCF6KTG8rRy2EybSrVECSZDF+YAUePZGHYLtLj2ytOTA4Eblc9ISctkk0Nl1opgKZ/fFMe/nXQXPH2ATy8fdfmRfVZW24BKm3p5EyWyLL0F5eObkizw4+LGOTa3zEyclg==" Aug 25 09:59:56 gregs-hifi go-librespot[6656]: time="2026-08-25T09:59:56-07:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Aug 25 09:59:56 gregs-hifi volumio[1333]: info: CoreCommandRouter::volumioPlay Aug 25 09:59:56 gregs-hifi volumio[1333]: info: CoreStateMachine::play index undefined Aug 25 09:59:56 gregs-hifi volumio[1333]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 25 09:59:56 gregs-hifi volumio[1333]: info: CorePlayQueue::getTrack 0 Aug 25 09:59:56 gregs-hifi go-librespot[6656]: time="2026-08-25T09:59:56-07:00" level=debug msg="completed keyexchange" Aug 25 09:59:56 gregs-hifi go-librespot[6656]: time="2026-08-25T09:59:56-07:00" level=debug msg="completed challenge" Aug 25 09:59:56 gregs-hifi go-librespot[6656]: time="2026-08-25T09:59:56-07:00" level=info msg="authenticated AP" username="12******97" Aug 25 09:59:56 gregs-hifi go-librespot[6656]: time="2026-08-25T09:59:56-07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 09:59:56 gregs-hifi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 09:59:56 gregs-hifi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 09:59:57 gregs-hifi volumio[1333]: info: Initializing connection to go-librespot Websocket Aug 25 09:59:57 gregs-hifi volumio[1333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 09:59:57 gregs-hifi volumio[1333]: info: Initializing connection to go-librespot Websocket Aug 25 09:59:57 gregs-hifi volumio[1333]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 09:59:59 gregs-hifi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Aug 25 09:59:59 gregs-hifi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 09:59:59 gregs-hifi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 09:59:59 gregs-hifi go-librespot[6666]: go-librespot daemon starting... Aug 25 09:59:59 gregs-hifi go-librespot[6667]: time="2026-08-25T09:59:59-07:00" level=info msg="running go-librespot 0.7.1" Aug 25 09:59:59 gregs-hifi go-librespot[6667]: time="2026-08-25T09:59:59-07:00" level=debug msg="app state loaded" Aug 25 09:59:59 gregs-hifi go-librespot[6667]: time="2026-08-25T09:59:59-07:00" level=debug msg="stored credentials not found" Aug 25 09:59:59 gregs-hifi go-librespot[6667]: time="2026-08-25T09:59:59-07:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 10:00:00 gregs-hifi go-librespot[6667]: time="2026-08-25T10:00:00-07:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 10:00:00 gregs-hifi go-librespot[6667]: time="2026-08-25T10:00:00-07:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 10:00:00 gregs-hifi go-librespot[6667]: time="2026-08-25T10:00:00-07:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 10:00:00 gregs-hifi go-librespot[6667]: time="2026-08-25T10:00:00-07:00" level=info msg="zeroconf server listening on port 46173" Aug 25 10:00:00 gregs-hifi go-librespot[6667]: time="2026-08-25T10:00:00-07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 10:00:00 gregs-hifi volumio[1333]: info: Initializing connection to go-librespot Websocket Aug 25 10:00:00 gregs-hifi go-librespot[6667]: time="2026-08-25T10:00:00-07:00" level=debug msg="new websocket client" Aug 25 10:00:00 gregs-hifi volumio[1333]: info: Connection to go-librespot Websocket established Aug 25 10:00:00 gregs-hifi go-librespot[6667]: time="2026-08-25T10:00:00-07:00" level=debug msg="obtained new client token: AAGhEUaooM58p46IeFrMJZKfblhrHI0Sy2Bc82KgLm8s3T/7BssSR+Qj1aciD2nZrpJmZxlbUrWTX8bS9a/E6L466e9DudriEbDl0fNqvxNTEQnO23ajWuns+5t/P5pGhjUtfhRXMSvzuQfjyPopClTngVLJcrYQp7dNvW5lb6UWdNRci75ww2k3hPGmjqk3+seCrDIId4+pvFGxBn4TCdwfipGmiMqoj9yysuExmx5+c2yW2BhnxnE=" Aug 25 10:00:00 gregs-hifi go-librespot[6667]: time="2026-08-25T10:00:00-07:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Aug 25 10:00:00 gregs-hifi go-librespot[6667]: time="2026-08-25T10:00:00-07:00" level=debug msg="completed keyexchange" Aug 25 10:00:00 gregs-hifi go-librespot[6667]: time="2026-08-25T10:00:00-07:00" level=debug msg="completed challenge" Aug 25 10:00:00 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T10:00:00.633-07:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=14.664115ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Aug 25 10:00:00 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T10:00:00.654-07:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=12.930189ms timeout=10s Aug 25 10:00:00 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T10:00:00.680-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=12.930189ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=25.920591ms Aug 25 10:00:00 gregs-hifi go-librespot[6667]: time="2026-08-25T10:00:00-07:00" level=info msg="authenticated AP" username="12******97" Aug 25 10:00:00 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 25 10:00:00 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T10:00:00.731-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=12.930189ms timeout=10s endpoint=https://securetoken.googleapis.com duration=77.013222ms Aug 25 10:00:00 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T10:00:00.732-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=12.930189ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=77.963792ms Aug 25 10:00:00 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T10:00:00.735-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=12.930189ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=81.39424ms Aug 25 10:00:00 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T10:00:00.738-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=12.930189ms timeout=10s endpoint=https://google.com duration=83.76436ms Aug 25 10:00:00 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T10:00:00.738-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=12.930189ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=84.036988ms Aug 25 10:00:00 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T10:00:00.760-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=12.930189ms timeout=10s endpoint=https://database.volumio.cloud duration=105.012786ms Aug 25 10:00:00 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T10:00:00.762-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=12.930189ms timeout=10s endpoint=https://functions.volumio.cloud duration=107.420238ms Aug 25 10:00:00 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T10:00:00.763-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=12.930189ms timeout=10s endpoint=https://functions.volumio.cloud duration=108.76088ms Aug 25 10:00:00 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T10:00:00.784-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=12.930189ms timeout=10s endpoint=https://www.googleapis.com duration=129.983974ms Aug 25 10:00:00 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T10:00:00.827-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=12.930189ms timeout=10s endpoint=http://pushupdates.volumio.org duration=172.643826ms Aug 25 10:00:00 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T10:00:00.876-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=12.930189ms timeout=10s endpoint=http://plugins.volumio.org duration=221.443245ms Aug 25 10:00:00 gregs-hifi sudo[6677]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 25 10:00:00 gregs-hifi sudo[6677]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 10:00:00 gregs-hifi sudo[6677]: pam_unix(sudo:session): session closed for user root Aug 25 10:00:00 gregs-hifi go-librespot[6667]: time="2026-08-25T10:00:00-07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 10:00:00 gregs-hifi sudo[6679]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 25 10:00:00 gregs-hifi sudo[6679]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 10:00:00 gregs-hifi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 10:00:00 gregs-hifi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 10:00:00 gregs-hifi volumio[1333]: info: Connection to go-librespot Websocket closed Aug 25 10:00:00 gregs-hifi sudo[6679]: pam_unix(sudo:session): session closed for user root Aug 25 10:00:00 gregs-hifi volumio[1333]: verbose: New Socket.io Connection to 192.168.86.65 from 192.168.86.71 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Aug 25 10:00:00 gregs-hifi volumio5-onboarding[2231]: time=2026-08-25T10:00:00.966-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.71:63616,00:00:00:00:00:00%01 @ 0x3000900" latency=12.930189ms timeout=10s endpoint=http://cddb.volumio.org duration=312.031111ms Aug 25 10:00:01 gregs-hifi sudo[6697]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 25 10:00:01 gregs-hifi sudo[6697]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 10:00:01 gregs-hifi sudo[6697]: pam_unix(sudo:session): session closed for user root Aug 25 10:00:01 gregs-hifi sudo[6699]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 25 10:00:01 gregs-hifi sudo[6699]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 10:00:01 gregs-hifi sudo[6699]: pam_unix(sudo:session): session closed for user root Aug 25 10:00:01 gregs-hifi volumio[1333]: verbose: New Socket.io Connection to 192.168.86.65 from 192.168.86.71 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 10 Aug 25 10:00:01 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 25 10:00:01 gregs-hifi volumio[1333]: info: CoreCommandRouter::volumioGetVisibleSources Aug 25 10:00:01 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 10:00:01 gregs-hifi volumio[1333]: info: CoreCommandRouter::volumioGetState Aug 25 10:00:01 gregs-hifi volumio[1333]: info: CorePlayQueue::getTrack 0 Aug 25 10:00:01 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 25 10:00:01 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 25 10:00:01 gregs-hifi volumio[1333]: info: Received Get System Info Aug 25 10:00:01 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 25 10:00:01 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 25 10:00:01 gregs-hifi volumio[1333]: info: Discovery: Getting this device information Aug 25 10:00:01 gregs-hifi volumio[1333]: info: CoreCommandRouter::volumioGetState Aug 25 10:00:01 gregs-hifi volumio[1333]: info: CorePlayQueue::getTrack 0 Aug 25 10:00:01 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 25 10:00:01 gregs-hifi volumio[1333]: info: CoreCommandRouter::volumioGetState Aug 25 10:00:01 gregs-hifi volumio[1333]: info: CorePlayQueue::getTrack 0 Aug 25 10:00:01 gregs-hifi volumio[1333]: info: Listing playlists Aug 25 10:00:01 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 25 10:00:01 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 25 10:00:01 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 25 10:00:02 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 25 10:00:03 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 25 10:00:03 gregs-hifi volumio[1333]: info: Received Get System Info Aug 25 10:00:03 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 25 10:00:03 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 25 10:00:03 gregs-hifi volumio[1333]: info: Discovery: Getting this device information Aug 25 10:00:03 gregs-hifi volumio[1333]: info: CoreCommandRouter::volumioGetState Aug 25 10:00:03 gregs-hifi volumio[1333]: info: CorePlayQueue::getTrack 0 Aug 25 10:00:03 gregs-hifi volumio[1333]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 25 10:00:03 gregs-hifi volumio[1333]: info: Getting Spotify volume Aug 25 10:00:03 gregs-hifi volumio[1333]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 10:00:03 gregs-hifi volumio[1333]: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 10:00:03 gregs-hifi volumio[1333]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Aug 25 10:00:03 gregs-hifi volumio[1333]: errno: -111, Aug 25 10:00:03 gregs-hifi volumio[1333]: code: 'ECONNREFUSED', Aug 25 10:00:03 gregs-hifi volumio[1333]: syscall: 'connect', Aug 25 10:00:03 gregs-hifi volumio[1333]: address: '127.0.0.1', Aug 25 10:00:03 gregs-hifi volumio[1333]: port: 9879, Aug 25 10:00:03 gregs-hifi volumio[1333]: response: undefined Aug 25 10:00:03 gregs-hifi volumio[1333]: } Aug 25 10:00:03 gregs-hifi volumio[1333]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 10:00:03 gregs-hifi sudo[6718]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-25 09:59' Aug 25 10:00:03 gregs-hifi sudo[6718]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"