Feb 17 11:45:00 volumio go-librespot[13875]: time="2026-02-17T11:45:00+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 17 11:45:00 volumio go-librespot[13875]: time="2026-02-17T11:45:00+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 17 11:45:00 volumio go-librespot[13875]: time="2026-02-17T11:45:00+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 17 11:45:00 volumio go-librespot[13875]: time="2026-02-17T11:45:00+07:00" level=info msg="zeroconf server listening on port 41377" Feb 17 11:45:00 volumio go-librespot[13875]: time="2026-02-17T11:45:00+07:00" level=debug msg="obtained new client token: AADxvPVAxWwaT8CFp5hbcJGjoEn2Ewdpki2Jcn9ly0gdFVAm2SGmU7+o2lhGDeIosHKhhp75/N9WbFu2RRJ88z26WEJ19nsUiQuCsjDocU8xjYfOCfmpewGeiydklxGNyiQoBlNhGKwz1gHwsyKS6aPXCC8cpM2xL820qOyBPxVA71EQ4J5VuDfPqLSSxqpVEfLTOICGPvluQ42UkAX5K6gFAmeWmH9TOotCjWu3cq4GKgd9hVuNBXQRnw==" Feb 17 11:45:00 volumio go-librespot[13875]: time="2026-02-17T11:45:00+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:45:00 volumio go-librespot[13875]: time="2026-02-17T11:45:00+07:00" level=debug msg="completed keyexchange" Feb 17 11:45:00 volumio go-librespot[13875]: time="2026-02-17T11:45:00+07:00" level=debug msg="completed challenge" Feb 17 11:45:01 volumio go-librespot[13875]: time="2026-02-17T11:45:01+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:45:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:45:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:45:01 volumio volumio[13636]: info: Volumio called home Feb 17 11:45:01 volumio volumio[13636]: info: Starting Shairport Sync Feb 17 11:45:01 volumio volumio[13636]: info: Starting Shairport Sync Feb 17 11:45:01 volumio volumio[13636]: info: Starting Shairport Sync Feb 17 11:45:01 volumio sudo[13908]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 17 11:45:01 volumio sudo[13908]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:45:01 volumio sudo[13910]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 17 11:45:01 volumio sudo[13910]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:45:01 volumio sudo[13912]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 17 11:45:01 volumio sudo[13912]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:45:01 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 17 11:45:01 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 17 11:45:01 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 17 11:45:01 volumio systemd[1]: shairport-sync.service: Consumed 2.415s CPU time. Feb 17 11:45:01 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 17 11:45:01 volumio sudo[13908]: pam_unix(sudo:session): session closed for user root Feb 17 11:45:01 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 17 11:45:01 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 17 11:45:01 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 17 11:45:01 volumio volumio[13636]: info: Shairport-Sync Started Feb 17 11:45:01 volumio volumio[13636]: Error adding Membership: Error: addMembership EINVAL Feb 17 11:45:01 volumio volumio[13636]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Feb 17 11:45:01 volumio volumio[13636]: SPOTIFY: BQBi4VCkJpv48F5LycqtaxQbDI87Uh9-EYxyroK2r40wEfZM9UTETUa7RvWBj_S6BrfUE4kidq1NgvCZcqLNp2QVkBKAjrdWYYkTY_-7JipkdMinyX-kexbR3_yw3pbZp3MxB91dn101lh8VNVLwVFWaaMOTl56pA21yaOyJRI5IKAd1qkgw56-5MHFr_jooMJgej1PlsWh0M83Ipc3IpCbM60aQfC_KnNIgOEPGWp6wEXV5axru0bB_YQSbvgpHVEdR7KB_7jRPfGGczvV3kUkNf2x_RK9FztJPMVh7bcffY7QnnzS8NzpG Feb 17 11:45:01 volumio volumio[13636]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Feb 17 11:45:01 volumio volumio[13636]: info: New Spotify access token = BQBi4VCkJpv48F5LycqtaxQbDI87Uh9-EYxyroK2r40wEfZM9UTETUa7RvWBj_S6BrfUE4kidq1NgvCZcqLNp2QVkBKAjrdWYYkTY_-7JipkdMinyX-kexbR3_yw3pbZp3MxB91dn101lh8VNVLwVFWaaMOTl56pA21yaOyJRI5IKAd1qkgw56-5MHFr_jooMJgej1PlsWh0M83Ipc3IpCbM60aQfC_KnNIgOEPGWp6wEXV5axru0bB_YQSbvgpHVEdR7KB_7jRPfGGczvV3kUkNf2x_RK9FztJPMVh7bcffY7QnnzS8NzpG Feb 17 11:45:01 volumio volumio[13636]: info: Spotify credentials grant success - running version from March 24, 2019 Feb 17 11:45:01 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 17 11:45:01 volumio sudo[13910]: pam_unix(sudo:session): session closed for user root Feb 17 11:45:01 volumio sudo[13912]: pam_unix(sudo:session): session closed for user root Feb 17 11:45:01 volumio volumio[13636]: info: Shairport-Sync Started Feb 17 11:45:01 volumio volumio[13636]: info: Shairport-Sync Started Feb 17 11:45:01 volumio volumio[13636]: info: CoreCommandRouter::volumioGetState Feb 17 11:45:01 volumio volumio[13636]: info: CorePlayQueue::getTrack 0 Feb 17 11:45:02 volumio volumio[13636]: SPOTIFY: User informations: {"country":"PK","display_name":"215mmgea6kss3jxeqsqdquvji","email":"linh.ngotran@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/215mmgea6kss3jxeqsqdquvji"},"followers":{"href":null,"total":1},"href":"https://api.spotify.com/v1/users/215mmgea6kss3jxeqsqdquvji","id":"215mmgea6kss3jxeqsqdquvji","images":[],"product":"premium","type":"user","uri":"spotify:user:215mmgea6kss3jxeqsqdquvji"} Feb 17 11:45:02 volumio volumio[13636]: info: Spotify Successfully logged in Feb 17 11:45:02 volumio volumio[13636]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 17 11:45:02 volumio volumio[13636]: info: [1771303502306] CoreMusicLibrary::Adding element Spotify Feb 17 11:45:02 volumio volumio[13636]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 17 11:45:02 volumio volumio[13636]: Cannot find translation for source YouTube Music Feb 17 11:45:02 volumio volumio[13636]: Cannot find translation for source Spotify Feb 17 11:45:02 volumio volumio[13636]: info: [yt-cast-receiver] DIAL server listening on port 8098 Feb 17 11:45:02 volumio volumio[13636]: info: CoreCommandRouter::volumioRetrievevolume Feb 17 11:45:03 volumio volumio[13636]: info: VolumeController:: Volume=100 Mute =false Feb 17 11:45:03 volumio volumio[13636]: info: CoreCommandRouter::volumioGetState Feb 17 11:45:03 volumio volumio[13636]: info: CorePlayQueue::getTrack 0 Feb 17 11:45:03 volumio volumio[13636]: info: CoreStateMachine::pushState Feb 17 11:45:03 volumio volumio[13636]: info: CorePlayQueue::getTrack 0 Feb 17 11:45:03 volumio volumio[13636]: info: CoreCommandRouter::volumioPushState Feb 17 11:45:04 volumio volumio[13636]: info: go-librespot daemon successfully initialized Feb 17 11:45:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 22. Feb 17 11:45:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:04 volumio go-librespot[13949]: go-librespot daemon starting... Feb 17 11:45:04 volumio mpd[13857]: 2026-02-17T11:45:04 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 17 11:45:04 volumio systemd[1]: Started mpd.service - Music Player Daemon. Feb 17 11:45:04 volumio sudo[13810]: pam_unix(sudo:session): session closed for user root Feb 17 11:45:04 volumio sudo[13821]: pam_unix(sudo:session): session closed for user root Feb 17 11:45:04 volumio go-librespot[13950]: time="2026-02-17T11:45:04+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:45:04 volumio go-librespot[13950]: time="2026-02-17T11:45:04+07:00" level=debug msg="app state loaded" Feb 17 11:45:04 volumio go-librespot[13950]: time="2026-02-17T11:45:04+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:45:04 volumio volumio[13636]: error: MPD error: The expression evaluated to a falsy value: Feb 17 11:45:04 volumio volumio[13636]: assert.ok(self.idling) Feb 17 11:45:04 volumio volumio[13636]: error: The expression evaluated to a falsy value: Feb 17 11:45:04 volumio volumio[13636]: assert.ok(self.idling) Feb 17 11:45:04 volumio volumio[13636]: info: MPD running with PID13857 Feb 17 11:45:04 volumio volumio[13636]: ,establishing connection Feb 17 11:45:04 volumio volumio[13636]: error: updateQueue error: null Feb 17 11:45:04 volumio volumio[13636]: info: Completed starting Core Plugins Feb 17 11:45:04 volumio volumio[13636]: info: ------------------------------------------- Feb 17 11:45:04 volumio volumio[13636]: info: ----- MyVolumio plugins startup ---- Feb 17 11:45:04 volumio volumio[13636]: info: ------------------------------------------- Feb 17 11:45:04 volumio volumio[13636]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 17 11:45:04 volumio volumio[13636]: error: updateQueue error: null Feb 17 11:45:04 volumio go-librespot[13950]: time="2026-02-17T11:45:04+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 17 11:45:04 volumio go-librespot[13950]: time="2026-02-17T11:45:04+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 17 11:45:04 volumio go-librespot[13950]: time="2026-02-17T11:45:04+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 17 11:45:04 volumio go-librespot[13950]: time="2026-02-17T11:45:04+07:00" level=info msg="zeroconf server listening on port 44003" Feb 17 11:45:05 volumio go-librespot[13950]: time="2026-02-17T11:45:05+07:00" level=debug msg="obtained new client token: AAAuU9Fe4JUXgBUkeSDsVCG3OxdxYQgF8znA4ePZ4bEb7zaFLLcqPlLreYp6zEdt9Fwqbngxh5CwOQVfH6y4ipzuYckQQlRYTqyK5JToWt+7qijGl9EGX9xKi/QUaMuJfAF6q5/snWZwinQCc7j1ST83Uc5H1yQxHuGccR9kBh8ElM7nKxa4jJOcKn3InvPMz0PKtKvsE/u63DSf8Yn1QQd4XMI58lnlX3dIjADyojyM9+vZb7QNhoI=" Feb 17 11:45:05 volumio go-librespot[13950]: time="2026-02-17T11:45:05+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:45:05 volumio go-librespot[13950]: time="2026-02-17T11:45:05+07:00" level=debug msg="completed keyexchange" Feb 17 11:45:05 volumio go-librespot[13950]: time="2026-02-17T11:45:05+07:00" level=debug msg="completed challenge" Feb 17 11:45:05 volumio go-librespot[13950]: time="2026-02-17T11:45:05+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:45:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:45:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:45:06 volumio nmbd[966]: [2026/02/17 11:45:06.143661, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Feb 17 11:45:06 volumio nmbd[966]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.23 for name WORKGROUP<1d>. Feb 17 11:45:06 volumio nmbd[966]: This response was from IP 192.168.1.237, reporting an IP address of 192.168.1.237. Feb 17 11:45:07 volumio volumio[13636]: info: Initializing connection to go-librespot Websocket Feb 17 11:45:07 volumio volumio[13636]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 17 11:45:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 23. Feb 17 11:45:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:08 volumio go-librespot[13962]: go-librespot daemon starting... Feb 17 11:45:08 volumio go-librespot[13963]: time="2026-02-17T11:45:08+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:45:08 volumio go-librespot[13963]: time="2026-02-17T11:45:08+07:00" level=debug msg="app state loaded" Feb 17 11:45:08 volumio go-librespot[13963]: time="2026-02-17T11:45:08+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:45:09 volumio go-librespot[13963]: time="2026-02-17T11:45:09+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 17 11:45:09 volumio go-librespot[13963]: time="2026-02-17T11:45:09+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 17 11:45:09 volumio go-librespot[13963]: time="2026-02-17T11:45:09+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 17 11:45:09 volumio go-librespot[13963]: time="2026-02-17T11:45:09+07:00" level=info msg="zeroconf server listening on port 37125" Feb 17 11:45:09 volumio go-librespot[13963]: time="2026-02-17T11:45:09+07:00" level=debug msg="obtained new client token: AADtUASJ4/yqQQo30anbqQWDhxhBjFew0zWDJwXv+ZOjTZlWsOIQieGU8unX/Q3VzuDHOkx3JWqFYHGlRC+xln+bS8f82HdR2z9P87eCb14TmOHiU/fq/IpHIaVpD4CyMHZRDDkSQrYTnflxkEg508+NEvZVRrzHAJxnPsdQRvvRoK/OtSM1yyDT9yPtkrRHa0diR4/EiF0WMxgkcYAYyY1t/Xycs/H5HJPg6KjtvcrROVc+P364Dt6hfA==" Feb 17 11:45:09 volumio volumio[13636]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Feb 17 11:45:09 volumio go-librespot[13963]: time="2026-02-17T11:45:09+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:45:09 volumio go-librespot[13963]: time="2026-02-17T11:45:09+07:00" level=debug msg="completed keyexchange" Feb 17 11:45:09 volumio go-librespot[13963]: time="2026-02-17T11:45:09+07:00" level=debug msg="completed challenge" Feb 17 11:45:09 volumio go-librespot[13963]: time="2026-02-17T11:45:09+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:45:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:45:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:45:10 volumio volumio[13636]: info: Initializing connection to go-librespot Websocket Feb 17 11:45:10 volumio volumio[13636]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 17 11:45:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 24. Feb 17 11:45:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:12 volumio go-librespot[13971]: go-librespot daemon starting... Feb 17 11:45:12 volumio go-librespot[13972]: time="2026-02-17T11:45:12+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:45:12 volumio go-librespot[13972]: time="2026-02-17T11:45:12+07:00" level=debug msg="app state loaded" Feb 17 11:45:12 volumio go-librespot[13972]: time="2026-02-17T11:45:12+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:45:13 volumio volumio[13636]: info: Initializing connection to go-librespot Websocket Feb 17 11:45:13 volumio go-librespot[13972]: time="2026-02-17T11:45:13+07:00" level=debug msg="new websocket client" Feb 17 11:45:13 volumio volumio[13636]: info: Connection to go-librespot Websocket established Feb 17 11:45:13 volumio go-librespot[13972]: time="2026-02-17T11:45:13+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 17 11:45:13 volumio go-librespot[13972]: time="2026-02-17T11:45:13+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 17 11:45:13 volumio go-librespot[13972]: time="2026-02-17T11:45:13+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 17 11:45:13 volumio go-librespot[13972]: time="2026-02-17T11:45:13+07:00" level=info msg="zeroconf server listening on port 40397" Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Feb 17 11:45:13 volumio volumio[13636]: info: Adding plugin bluetooth to MyMusic Plugins Feb 17 11:45:13 volumio volumio[13636]: info: Adding plugin multiroom to MyMusic Plugins Feb 17 11:45:13 volumio volumio[13636]: info: Adding plugin metavolumio to MyMusic Plugins Feb 17 11:45:13 volumio volumio[13636]: info: Adding plugin cd_controller to MyMusic Plugins Feb 17 11:45:13 volumio volumio[13636]: info: Adding plugin qobuzconnect to MyMusic Plugins Feb 17 11:45:13 volumio volumio[13636]: info: Adding plugin smart_inputs to MyMusic Plugins Feb 17 11:45:13 volumio volumio[13636]: info: Adding plugin tidalconnect to MyMusic Plugins Feb 17 11:45:13 volumio volumio[13636]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Feb 17 11:45:13 volumio go-librespot[13972]: time="2026-02-17T11:45:13+07:00" level=debug msg="obtained new client token: AACaNt0j4RgK42Xr53Yu51L5NG+dbVFk0Dg+gRjrVaeH2qSDMKgINcv1bLtz1jUrgZi+kQWClKCh2FjClolLTLQQAkMNMu9KDxySD8Z8Ux+6YW4dygP63p1FtHok2zVdlVxkWEzgHBCXTpCotlETkAGunumVjFf1l788clz3FelYPuK8D6d7WylPgX+KQ4qHbA3ojjzMLrbgUQ9hcTilWf0B61qC8PUu++Pc9wXhTlTjMWT2Cft9langaQ==" Feb 17 11:45:13 volumio go-librespot[13972]: time="2026-02-17T11:45:13+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:45:13 volumio go-librespot[13972]: time="2026-02-17T11:45:13+07:00" level=debug msg="completed keyexchange" Feb 17 11:45:13 volumio go-librespot[13972]: time="2026-02-17T11:45:13+07:00" level=debug msg="completed challenge" Feb 17 11:45:13 volumio go-librespot[13972]: time="2026-02-17T11:45:13+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:45:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:45:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:45:15 volumio volumio[13636]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 17 11:45:15 volumio volumio[13636]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 17 11:45:15 volumio volumio[13636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 17 11:45:15 volumio volumio[13636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 17 11:45:15 volumio volumio[13636]: info: Starting MyVolumio Remote Streaming Endpoints Feb 17 11:45:15 volumio volumio[13636]: info: MyVolumio login type: Token Feb 17 11:45:15 volumio volumio[13636]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 17 11:45:15 volumio volumio[13636]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Feb 17 11:45:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 25. Feb 17 11:45:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:17 volumio go-librespot[13995]: go-librespot daemon starting... Feb 17 11:45:17 volumio go-librespot[13996]: time="2026-02-17T11:45:17+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:45:17 volumio go-librespot[13996]: time="2026-02-17T11:45:17+07:00" level=debug msg="app state loaded" Feb 17 11:45:17 volumio go-librespot[13996]: time="2026-02-17T11:45:17+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:45:17 volumio volumio[13636]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Feb 17 11:45:17 volumio volumio[13636]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Feb 17 11:45:17 volumio volumio[13636]: info: Streaming services startup Feb 17 11:45:17 volumio volumio[13636]: info: Starting Streaming Daemon Feb 17 11:45:17 volumio sudo[14003]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 17 11:45:17 volumio sudo[14003]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:45:17 volumio volumio[13636]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Feb 17 11:45:17 volumio sudo[14003]: pam_unix(sudo:session): session closed for user root Feb 17 11:45:17 volumio volumio[13636]: info: Getting Spotify volume Feb 17 11:45:17 volumio volumio[13636]: info: Connection to go-librespot Websocket closed Feb 17 11:45:17 volumio volumio[13636]: error: Cannot start Volumio Streaming Daemon Feb 17 11:45:17 volumio volumio[13636]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 17 11:45:17 volumio volumio[13636]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 17 11:45:17 volumio volumio[13636]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Feb 17 11:45:17 volumio go-librespot[13996]: time="2026-02-17T11:45:17+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 17 11:45:17 volumio go-librespot[13996]: time="2026-02-17T11:45:17+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 17 11:45:17 volumio go-librespot[13996]: time="2026-02-17T11:45:17+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 17 11:45:17 volumio go-librespot[13996]: time="2026-02-17T11:45:17+07:00" level=info msg="zeroconf server listening on port 40999" Feb 17 11:45:17 volumio volumio[13636]: info: CoreCommandRouter::volumioGetState Feb 17 11:45:17 volumio volumio[13636]: info: CorePlayQueue::getTrack 0 Feb 17 11:45:17 volumio volumio[13636]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 11:45:17 volumio volumio[13636]: SPOTIFY: SPOTIFY VOLUME undefined Feb 17 11:45:17 volumio volumio[13636]: SPOTIFY: VOLUMIO VOLUME 100 Feb 17 11:45:17 volumio volumio[13636]: info: Aligning Spotify Volume to Volumio Volume Feb 17 11:45:17 volumio volumio[13636]: info: CoreCommandRouter::volumioGetState Feb 17 11:45:17 volumio volumio[13636]: info: CorePlayQueue::getTrack 0 Feb 17 11:45:17 volumio volumio[13636]: info: Setting Spotify Volume from Volumio: 100 Feb 17 11:45:18 volumio go-librespot[13996]: time="2026-02-17T11:45:18+07:00" level=debug msg="obtained new client token: AADIYKFjiPkGJU4p5D2RTuae8fN4oWN7Sll5886UnIdSCuxYhRqauK3KIxyqvy+jqLVgkynK7WHpYShaOJq3ASsHkq8qHdqYCrpsLHIR6R8hbELirRFbZXGnkyVB83Yav1w7P7tlgv2SP7Ycn5WfYAj/N6Z8UEqaVbDMz6S+ksZlDgJjZDWi9X8pkA+idGiZKrzq+TqcYsxEE74maN29gga2bF0BOWl4iB4/fSxhf/HM1q3qLlJvxqA=" Feb 17 11:45:18 volumio go-librespot[13996]: time="2026-02-17T11:45:18+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:45:18 volumio go-librespot[13996]: time="2026-02-17T11:45:18+07:00" level=debug msg="completed keyexchange" Feb 17 11:45:18 volumio go-librespot[13996]: time="2026-02-17T11:45:18+07:00" level=debug msg="completed challenge" Feb 17 11:45:18 volumio go-librespot[13996]: time="2026-02-17T11:45:18+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:45:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:45:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:45:18 volumio volumio[13636]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 11:45:18 volumio volumio[13636]: Error: socket hang up Feb 17 11:45:18 volumio volumio[13636]: at connResetException (node:internal/errors:720:14) Feb 17 11:45:18 volumio volumio[13636]: at Socket.socketOnEnd (node:_http_client:519:23) Feb 17 11:45:18 volumio volumio[13636]: at Socket.emit (node:events:526:35) Feb 17 11:45:18 volumio volumio[13636]: at endReadableNT (node:internal/streams/readable:1376:12) Feb 17 11:45:18 volumio volumio[13636]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Feb 17 11:45:18 volumio volumio[13636]: code: 'ECONNRESET', Feb 17 11:45:18 volumio volumio[13636]: response: undefined Feb 17 11:45:18 volumio volumio[13636]: } Feb 17 11:45:18 volumio volumio[13636]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 11:45:19 volumio sudo[14025]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-17 11:44' Feb 17 11:45:19 volumio sudo[14025]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:45:20 volumio sudo[14025]: pam_unix(sudo:session): session closed for user root Feb 17 11:45:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 26. Feb 17 11:45:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:21 volumio go-librespot[14033]: go-librespot daemon starting... Feb 17 11:45:21 volumio go-librespot[14034]: time="2026-02-17T11:45:21+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:45:21 volumio go-librespot[14034]: time="2026-02-17T11:45:21+07:00" level=debug msg="app state loaded" Feb 17 11:45:21 volumio go-librespot[14034]: time="2026-02-17T11:45:21+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:45:22 volumio go-librespot[14034]: time="2026-02-17T11:45:22+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 17 11:45:22 volumio go-librespot[14034]: time="2026-02-17T11:45:22+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 17 11:45:22 volumio go-librespot[14034]: time="2026-02-17T11:45:22+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 17 11:45:22 volumio go-librespot[14034]: time="2026-02-17T11:45:22+07:00" level=info msg="zeroconf server listening on port 40041" Feb 17 11:45:22 volumio go-librespot[14034]: time="2026-02-17T11:45:22+07:00" level=debug msg="obtained new client token: AADPwrpnFse7X+sLoh/ye5AZCkLJiXHmD7avY6SIy8lhCCWHcTXZg9ItAVTIigqHPSBNrc9RH8ialmRxqyuXVU/6W5LrFHaP34onLMcjyFTu7bZIhn2NJLqZ/x3a9Jv1IYWggqI0IXBzOa8j/hr8XOTUR3HBN6jkhpQctFBBOHwMIJjcPdt351+IGt4fvXT5k999slXakk22qZz7/iFpwiqgm4ES3iz1kC4Fukq3tc+C/UQkFTLgro3Zaw==" Feb 17 11:45:22 volumio go-librespot[14034]: time="2026-02-17T11:45:22+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:45:22 volumio go-librespot[14034]: time="2026-02-17T11:45:22+07:00" level=debug msg="completed keyexchange" Feb 17 11:45:22 volumio go-librespot[14034]: time="2026-02-17T11:45:22+07:00" level=debug msg="completed challenge" Feb 17 11:45:22 volumio go-librespot[14034]: time="2026-02-17T11:45:22+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:45:22 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:45:22 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:45:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 27. Feb 17 11:45:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:25 volumio go-librespot[14055]: go-librespot daemon starting... Feb 17 11:45:25 volumio go-librespot[14056]: time="2026-02-17T11:45:25+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:45:25 volumio go-librespot[14056]: time="2026-02-17T11:45:25+07:00" level=debug msg="app state loaded" Feb 17 11:45:25 volumio go-librespot[14056]: time="2026-02-17T11:45:25+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:45:26 volumio go-librespot[14056]: time="2026-02-17T11:45:26+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 17 11:45:26 volumio go-librespot[14056]: time="2026-02-17T11:45:26+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 17 11:45:26 volumio go-librespot[14056]: time="2026-02-17T11:45:26+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 17 11:45:26 volumio go-librespot[14056]: time="2026-02-17T11:45:26+07:00" level=info msg="zeroconf server listening on port 36309" Feb 17 11:45:26 volumio go-librespot[14056]: time="2026-02-17T11:45:26+07:00" level=debug msg="obtained new client token: AABRRh2BQxaW2d/R0Uc1Dd4TYKU8vLFfZJBt3ex55Zr7+UT/IV3/fq26sZ0PC3R0sknGIZUgVXL6Qt6fTOMdK+RUTOmBe8uqc8XBXDnR+15Bz5hY3/BbUk03e4TlO7yuBDJndQR+mv/cjivdKO2ODtmD/z7Y6eQvV+lqXnB99qiVEBMXw5PR6i5Vfu8ry0nBeSqoZOoFLykLNbQr65nra2Om17ISK0BDMtFeyv7FhmRS5WJC1e/uNjeQ6g==" Feb 17 11:45:26 volumio go-librespot[14056]: time="2026-02-17T11:45:26+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:45:26 volumio go-librespot[14056]: time="2026-02-17T11:45:26+07:00" level=debug msg="completed keyexchange" Feb 17 11:45:26 volumio go-librespot[14056]: time="2026-02-17T11:45:26+07:00" level=debug msg="completed challenge" Feb 17 11:45:26 volumio go-librespot[14056]: time="2026-02-17T11:45:26+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:45:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:45:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:45:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 28. Feb 17 11:45:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:30 volumio go-librespot[14063]: go-librespot daemon starting... Feb 17 11:45:30 volumio go-librespot[14064]: time="2026-02-17T11:45:30+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:45:30 volumio go-librespot[14064]: time="2026-02-17T11:45:30+07:00" level=debug msg="app state loaded" Feb 17 11:45:30 volumio go-librespot[14064]: time="2026-02-17T11:45:30+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:45:30 volumio go-librespot[14064]: time="2026-02-17T11:45:30+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 17 11:45:30 volumio go-librespot[14064]: time="2026-02-17T11:45:30+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 17 11:45:30 volumio go-librespot[14064]: time="2026-02-17T11:45:30+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 17 11:45:30 volumio go-librespot[14064]: time="2026-02-17T11:45:30+07:00" level=info msg="zeroconf server listening on port 43673" Feb 17 11:45:30 volumio go-librespot[14064]: time="2026-02-17T11:45:30+07:00" level=debug msg="obtained new client token: AACBst48my6nMknNa6tn0s00x62c+TwSgZI5ikHrPmJ9aMT3K5D91Rb9fClcJtlW94jQHlXnoRuFESVdMzIvO7aqu2r/8WjinTi1BpQ4pKwVZpvLYCpaAjrqXveVlynma8x3Oi57GjpF+fNLcFiCXZapyoAtRm8TOZFhvgnBMVuzN7vm7znhZ+Zq/n/6OjI564gmxdc0wabmuwP6nfTuG2DqTZ1qIDCZw5B8AE4zPP9AlChzThoOT7LIFg==" Feb 17 11:45:31 volumio go-librespot[14064]: time="2026-02-17T11:45:31+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:45:31 volumio go-librespot[14064]: time="2026-02-17T11:45:31+07:00" level=debug msg="completed keyexchange" Feb 17 11:45:31 volumio go-librespot[14064]: time="2026-02-17T11:45:31+07:00" level=debug msg="completed challenge" Feb 17 11:45:31 volumio go-librespot[14064]: time="2026-02-17T11:45:31+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:45:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:45:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:45:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 29. Feb 17 11:45:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:34 volumio go-librespot[14087]: go-librespot daemon starting... Feb 17 11:45:34 volumio go-librespot[14088]: time="2026-02-17T11:45:34+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:45:34 volumio go-librespot[14088]: time="2026-02-17T11:45:34+07:00" level=debug msg="app state loaded" Feb 17 11:45:34 volumio go-librespot[14088]: time="2026-02-17T11:45:34+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:45:34 volumio go-librespot[14088]: time="2026-02-17T11:45:34+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 17 11:45:34 volumio go-librespot[14088]: time="2026-02-17T11:45:34+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 17 11:45:34 volumio go-librespot[14088]: time="2026-02-17T11:45:34+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 17 11:45:34 volumio go-librespot[14088]: time="2026-02-17T11:45:34+07:00" level=info msg="zeroconf server listening on port 44767" Feb 17 11:45:35 volumio go-librespot[14088]: time="2026-02-17T11:45:35+07:00" level=debug msg="obtained new client token: AABKSJMJbM5imzL7eJZNgPMgRKeZ40jGxArsu8RLyh2vK8iQSVdTmV/kvi9/xHXqw0fafFS3IGi3XtviqHqPYVoHeEtXydKf81fhiFyx0WjdL4+f70p1QBxZKnUWsA3957HqpCoMHLZjKQcBd89AJx1MqxU58tN+7qIIL8NXCiE5HEtrE++l2NAsESWJYw5j8xDy/RjOd9fSOy9cvgjTIp/beMnmTScEOxCQidsb3jHvlmRyGqu2eEM=" Feb 17 11:45:35 volumio go-librespot[14088]: time="2026-02-17T11:45:35+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:45:35 volumio go-librespot[14088]: time="2026-02-17T11:45:35+07:00" level=debug msg="completed keyexchange" Feb 17 11:45:35 volumio go-librespot[14088]: time="2026-02-17T11:45:35+07:00" level=debug msg="completed challenge" Feb 17 11:45:35 volumio go-librespot[14088]: time="2026-02-17T11:45:35+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:45:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:45:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:45:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 30. Feb 17 11:45:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:38 volumio go-librespot[14095]: go-librespot daemon starting... Feb 17 11:45:38 volumio go-librespot[14096]: time="2026-02-17T11:45:38+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:45:38 volumio go-librespot[14096]: time="2026-02-17T11:45:38+07:00" level=debug msg="app state loaded" Feb 17 11:45:38 volumio go-librespot[14096]: time="2026-02-17T11:45:38+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:45:39 volumio go-librespot[14096]: time="2026-02-17T11:45:39+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 17 11:45:39 volumio go-librespot[14096]: time="2026-02-17T11:45:39+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 17 11:45:39 volumio go-librespot[14096]: time="2026-02-17T11:45:39+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 17 11:45:39 volumio go-librespot[14096]: time="2026-02-17T11:45:39+07:00" level=info msg="zeroconf server listening on port 41395" Feb 17 11:45:39 volumio go-librespot[14096]: time="2026-02-17T11:45:39+07:00" level=debug msg="obtained new client token: AAAf5GnBDdA/vPV+Xx8ExPYiz0MOMKhuuiBhrVhM2V5bUcBstjqgfr0FYfeUTk8L6cRgRWYJa3eWS2YlJYVwBR5lKGYMq8lOcaWOgphB4uWV7sFg42de3kmxgtaFtFllLByLTq+dLyn0TTQGiuAd7DWvPH7J8HeH5UETS+Xj6dFo/NkrGAbrQbD1PXvMUQI4jjzHpN+oinpVNgdkToEUZX9nqyfzeSsYrzCAno9hZ1OpwZa1PYJX0NKkPQ==" Feb 17 11:45:39 volumio go-librespot[14096]: time="2026-02-17T11:45:39+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:45:39 volumio go-librespot[14096]: time="2026-02-17T11:45:39+07:00" level=debug msg="completed keyexchange" Feb 17 11:45:39 volumio go-librespot[14096]: time="2026-02-17T11:45:39+07:00" level=debug msg="completed challenge" Feb 17 11:45:39 volumio go-librespot[14096]: time="2026-02-17T11:45:39+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:45:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:45:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:45:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 31. Feb 17 11:45:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:42 volumio go-librespot[14104]: go-librespot daemon starting... Feb 17 11:45:42 volumio go-librespot[14105]: time="2026-02-17T11:45:42+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:45:42 volumio go-librespot[14105]: time="2026-02-17T11:45:42+07:00" level=debug msg="app state loaded" Feb 17 11:45:42 volumio go-librespot[14105]: time="2026-02-17T11:45:42+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:45:43 volumio go-librespot[14105]: time="2026-02-17T11:45:43+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 17 11:45:43 volumio go-librespot[14105]: time="2026-02-17T11:45:43+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 17 11:45:43 volumio go-librespot[14105]: time="2026-02-17T11:45:43+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 17 11:45:43 volumio go-librespot[14105]: time="2026-02-17T11:45:43+07:00" level=info msg="zeroconf server listening on port 37477" Feb 17 11:45:43 volumio go-librespot[14105]: time="2026-02-17T11:45:43+07:00" level=debug msg="obtained new client token: AAANj+7kmr4SyltUnFH7qo4mZvde8BrFDydTQ84YKP1DSOeul7s04e7kkgjiB3b/6UGiYdP2GZOdWtkib66/9ODa3ohxJOxBFmwxSh4QMcfLSgjH7r1UCXCotCVwQGV3x0LEsQfCuPI8cWMIh6VyY+w6RDBJ5H6E41YKrRM54CQneQDfU+AQ1onHOlVmrHslUySB09N5Y1LtSi2tTjZ6zJtPw4b3wSyVUWKueZVWyEqoDMmuT/TL/R5UIQ==" Feb 17 11:45:43 volumio go-librespot[14105]: time="2026-02-17T11:45:43+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:45:43 volumio go-librespot[14105]: time="2026-02-17T11:45:43+07:00" level=debug msg="completed keyexchange" Feb 17 11:45:43 volumio go-librespot[14105]: time="2026-02-17T11:45:43+07:00" level=debug msg="completed challenge" Feb 17 11:45:43 volumio go-librespot[14105]: time="2026-02-17T11:45:43+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:45:43 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:45:43 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:45:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 32. Feb 17 11:45:47 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:47 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:47 volumio go-librespot[14127]: go-librespot daemon starting... Feb 17 11:45:47 volumio go-librespot[14128]: time="2026-02-17T11:45:47+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:45:47 volumio go-librespot[14128]: time="2026-02-17T11:45:47+07:00" level=debug msg="app state loaded" Feb 17 11:45:47 volumio go-librespot[14128]: time="2026-02-17T11:45:47+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:45:47 volumio go-librespot[14128]: time="2026-02-17T11:45:47+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 17 11:45:47 volumio go-librespot[14128]: time="2026-02-17T11:45:47+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 17 11:45:47 volumio go-librespot[14128]: time="2026-02-17T11:45:47+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 17 11:45:47 volumio go-librespot[14128]: time="2026-02-17T11:45:47+07:00" level=info msg="zeroconf server listening on port 33893" Feb 17 11:45:47 volumio go-librespot[14128]: time="2026-02-17T11:45:47+07:00" level=debug msg="obtained new client token: AABdN6yu20cD+SVaGw6OuowBRHczESJZJJIgLU7sMnWve6ruGg/4DLnMQ26cHLnpbglfxvAEAGUYfqZDU9Mxpk+cOCQEngpIkaRgwl7P1YtSrI5WKq7qNu1HKRAc7P/3JezySDDhFURmUCVxG87XTmHsX2AxfyEw35DFD2tEqNDXaw+5fnKivZGGnk/nyLCZNVryiVDyj55NpsFDfh7HkixRMv9AIp6x3rCzRlAWZs409DVtczLY+dr/HQ==" Feb 17 11:45:48 volumio go-librespot[14128]: time="2026-02-17T11:45:48+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:45:48 volumio go-librespot[14128]: time="2026-02-17T11:45:48+07:00" level=debug msg="completed keyexchange" Feb 17 11:45:48 volumio go-librespot[14128]: time="2026-02-17T11:45:48+07:00" level=debug msg="completed challenge" Feb 17 11:45:48 volumio go-librespot[14128]: time="2026-02-17T11:45:48+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:45:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:45:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:45:51 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 33. Feb 17 11:45:51 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:51 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:51 volumio go-librespot[14135]: go-librespot daemon starting... Feb 17 11:45:51 volumio go-librespot[14136]: time="2026-02-17T11:45:51+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:45:51 volumio go-librespot[14136]: time="2026-02-17T11:45:51+07:00" level=debug msg="app state loaded" Feb 17 11:45:51 volumio go-librespot[14136]: time="2026-02-17T11:45:51+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:45:51 volumio go-librespot[14136]: time="2026-02-17T11:45:51+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 17 11:45:51 volumio go-librespot[14136]: time="2026-02-17T11:45:51+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 17 11:45:51 volumio go-librespot[14136]: time="2026-02-17T11:45:51+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 17 11:45:51 volumio go-librespot[14136]: time="2026-02-17T11:45:51+07:00" level=info msg="zeroconf server listening on port 46817" Feb 17 11:45:52 volumio go-librespot[14136]: time="2026-02-17T11:45:52+07:00" level=debug msg="obtained new client token: AACc1xfZ5Hu7wzHJ9Xh7f/24TTJJ6e9YxlbWGCyTod3gjykliQKPhlGOXVG8eZ0t9WIOahSOa1cEhriJEkSnDZmcCMF9MY9vl+vU4julzm4x0Rx2nJmD01pAOYFMjbxwvHuFQ2TF99VT4nVZObtMsr2L+VAeOCtwyDrWClumg8jsqGttlPwj44swwCjDPPYLAuUUNLiXtzrjCJQ2Y/Qvy5CM5exNPm6XqZoDPLGxBAY+W0O2ieSxnQA=" Feb 17 11:45:52 volumio go-librespot[14136]: time="2026-02-17T11:45:52+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:45:52 volumio go-librespot[14136]: time="2026-02-17T11:45:52+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed performing keyexchange: failed reading APResponseMessage message: failed reading message length: EOF" Feb 17 11:45:52 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:45:52 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:45:55 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 34. Feb 17 11:45:55 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:55 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:55 volumio go-librespot[14157]: go-librespot daemon starting... Feb 17 11:45:55 volumio go-librespot[14158]: time="2026-02-17T11:45:55+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:45:55 volumio go-librespot[14158]: time="2026-02-17T11:45:55+07:00" level=debug msg="app state loaded" Feb 17 11:45:55 volumio go-librespot[14158]: time="2026-02-17T11:45:55+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:45:56 volumio go-librespot[14158]: time="2026-02-17T11:45:56+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 17 11:45:56 volumio go-librespot[14158]: time="2026-02-17T11:45:56+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 17 11:45:56 volumio go-librespot[14158]: time="2026-02-17T11:45:56+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 17 11:45:56 volumio go-librespot[14158]: time="2026-02-17T11:45:56+07:00" level=info msg="zeroconf server listening on port 39275" Feb 17 11:45:56 volumio go-librespot[14158]: time="2026-02-17T11:45:56+07:00" level=debug msg="obtained new client token: AAAIJlcu8CzSthGWVUCtYkWsjUdjZab7c+8RSD0bSDuSVyFDRYNdISiKjF3YC9M/sXMFJwX+xlDxeLAW1vHbd1GRzC52YWBvOgfEVcl2aL/LIV/1J5lGslj+S/AaEjFrWUY9FJqTvDgPUr11+4BaFMSJxI+2Vx/QH45E9ToAJxMZTtCwTLP5s80e+88wPA6To0Tbzgkkrv0N6OYuwNrvjZccuqzYvv90oC4UQ/acmGhcV3YsQCsdGKpT5g==" Feb 17 11:45:56 volumio go-librespot[14158]: time="2026-02-17T11:45:56+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:45:56 volumio go-librespot[14158]: time="2026-02-17T11:45:56+07:00" level=debug msg="completed keyexchange" Feb 17 11:45:56 volumio go-librespot[14158]: time="2026-02-17T11:45:56+07:00" level=debug msg="completed challenge" Feb 17 11:45:56 volumio go-librespot[14158]: time="2026-02-17T11:45:56+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:45:56 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:45:56 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:45:58 volumio volumio-remote-updater[25144]: [2026-02-17 11:45:58] [error] handle_read_frame error: asio.system:104 (Connection reset by peer) Feb 17 11:45:58 volumio volumio-remote-updater[25144]: [2026-02-17 11:45:58] [disconnect] Disconnect close local:[1006,Connection reset by peer] remote:[1006] Feb 17 11:45:58 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:45:58 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 17 11:45:58 volumio systemd[1]: volumio.service: Consumed 57.820s CPU time. Feb 17 11:45:58 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Feb 17 11:45:58 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Feb 17 11:45:58 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 20332. Feb 17 11:45:58 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Feb 17 11:45:58 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module. Feb 17 11:45:58 volumio systemd[1]: volumio.service: Consumed 57.820s CPU time. Feb 17 11:45:58 volumio systemd[1]: Started volumio.service - Volumio Backend Module. Feb 17 11:45:58 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Feb 17 11:45:59 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 35. Feb 17 11:45:59 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:59 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:45:59 volumio go-librespot[14193]: go-librespot daemon starting... Feb 17 11:45:59 volumio go-librespot[14194]: time="2026-02-17T11:45:59+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:45:59 volumio go-librespot[14194]: time="2026-02-17T11:45:59+07:00" level=debug msg="app state loaded" Feb 17 11:45:59 volumio go-librespot[14194]: time="2026-02-17T11:45:59+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:46:00 volumio go-librespot[14194]: time="2026-02-17T11:46:00+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 17 11:46:00 volumio go-librespot[14194]: time="2026-02-17T11:46:00+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 17 11:46:00 volumio go-librespot[14194]: time="2026-02-17T11:46:00+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 17 11:46:00 volumio go-librespot[14194]: time="2026-02-17T11:46:00+07:00" level=info msg="zeroconf server listening on port 42475" Feb 17 11:46:00 volumio go-librespot[14194]: time="2026-02-17T11:46:00+07:00" level=debug msg="obtained new client token: AADDM1BAQ+81SXF9cfcbLpcebdV4yIdDtjME1PxAjZxcT4Up7JRE7FI+mqdGR8zsuw3JKwUeZz9umid5BShSnT7i5xRPfl2X0SismsynD/6RAoMRphN2zKTZb21urjOkSU+M9eOQGyvX2SpSo7U6vKJmu/gYoonKINkHomfJuMGYpRCwkan8M8EcoqW5ahAFZJ4Stp55qpY+V2ABYKQjxBECjCcIwhgnRlVYFJQgb5v3HjnYEZ3GCAFNFQ==" Feb 17 11:46:00 volumio go-librespot[14194]: time="2026-02-17T11:46:00+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:46:00 volumio go-librespot[14194]: time="2026-02-17T11:46:00+07:00" level=debug msg="completed keyexchange" Feb 17 11:46:00 volumio go-librespot[14194]: time="2026-02-17T11:46:00+07:00" level=debug msg="completed challenge" Feb 17 11:46:01 volumio go-librespot[14194]: time="2026-02-17T11:46:01+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:46:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:46:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:46:02 volumio volumio[14178]: info: ------------------------------------------- Feb 17 11:46:02 volumio volumio[14178]: info: ----- Volumio3 ---- Feb 17 11:46:02 volumio volumio[14178]: info: ------------------------------------------- Feb 17 11:46:02 volumio volumio[14178]: info: ----- System startup ---- Feb 17 11:46:02 volumio volumio[14178]: info: ------------------------------------------- Feb 17 11:46:03 volumio volumio-remote-updater[25144]: [2026-02-17 11:46:03] [connect] Successful connection Feb 17 11:46:03 volumio volumio[14178]: info: MYVOLUMIO Environment detected Feb 17 11:46:03 volumio volumio[14178]: info: Plugin folders cleanup Feb 17 11:46:03 volumio volumio[14178]: info: Scanning into folder /volumio/app/plugins/ Feb 17 11:46:03 volumio volumio[14178]: info: Scanning category audio_interface Feb 17 11:46:03 volumio volumio[14178]: info: Scanning category miscellanea Feb 17 11:46:03 volumio volumio[14178]: info: Scanning category music_service Feb 17 11:46:03 volumio volumio[14178]: info: Scanning category plugins.json Feb 17 11:46:03 volumio volumio[14178]: info: Scanning category system_controller Feb 17 11:46:03 volumio volumio[14178]: info: Scanning category user_interface Feb 17 11:46:03 volumio volumio[14178]: info: Scanning into folder /data/plugins/ Feb 17 11:46:03 volumio volumio[14178]: info: Scanning category music_service Feb 17 11:46:03 volumio volumio[14178]: info: Plugin folders cleanup completed Feb 17 11:46:03 volumio volumio[14178]: info: ------------------------------------------- Feb 17 11:46:03 volumio volumio[14178]: info: ----- Core plugins startup ---- Feb 17 11:46:03 volumio volumio[14178]: info: ------------------------------------------- Feb 17 11:46:03 volumio volumio[14178]: info: Loading plugins from folder /volumio/app/plugins/ Feb 17 11:46:03 volumio volumio[14178]: info: Adding plugin upnp to MyMusic Plugins Feb 17 11:46:03 volumio volumio[14178]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 17 11:46:03 volumio volumio[14178]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 17 11:46:03 volumio volumio[14178]: info: Loading plugins from folder /data/plugins/ Feb 17 11:46:03 volumio volumio[14178]: info: Loading plugin "system"... Feb 17 11:46:04 volumio volumio[14178]: info: Loading plugin "appearance"... Feb 17 11:46:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 36. Feb 17 11:46:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:46:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:46:04 volumio go-librespot[14213]: go-librespot daemon starting... Feb 17 11:46:04 volumio go-librespot[14214]: time="2026-02-17T11:46:04+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:46:04 volumio go-librespot[14214]: time="2026-02-17T11:46:04+07:00" level=debug msg="app state loaded" Feb 17 11:46:04 volumio go-librespot[14214]: time="2026-02-17T11:46:04+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:46:04 volumio go-librespot[14214]: time="2026-02-17T11:46:04+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 17 11:46:04 volumio go-librespot[14214]: time="2026-02-17T11:46:04+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 17 11:46:04 volumio go-librespot[14214]: time="2026-02-17T11:46:04+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 17 11:46:04 volumio go-librespot[14214]: time="2026-02-17T11:46:04+07:00" level=info msg="zeroconf server listening on port 44405" Feb 17 11:46:05 volumio go-librespot[14214]: time="2026-02-17T11:46:05+07:00" level=debug msg="obtained new client token: AADh7YGQP+1WlW+nXPeCMi3PKW4OcaUzeX2GCPibqJen/Vy9NOiVEVoPkuOJ598DKAOvdodaKys2+oG6hqrcvOr29jMC9DyD8Z+JDRBjVka+MxCnvBE7qQXzoUVnEgvVm+gp33Mfo6Rgzf7xP5SSAbAwIIA0sv4tCUjkHxp4UFh/as73nRyNbsW2j0zAB2EZCzviPfI94ELqQ2wkjni014rHzSjt8bs3YeC6ZqNNrwpZSW8UN8S3CbA=" Feb 17 11:46:05 volumio go-librespot[14214]: time="2026-02-17T11:46:05+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:46:05 volumio go-librespot[14214]: time="2026-02-17T11:46:05+07:00" level=debug msg="completed keyexchange" Feb 17 11:46:05 volumio go-librespot[14214]: time="2026-02-17T11:46:05+07:00" level=debug msg="completed challenge" Feb 17 11:46:05 volumio go-librespot[14214]: time="2026-02-17T11:46:05+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:46:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:46:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:46:05 volumio volumio[14178]: info: Loading plugin "network"... Feb 17 11:46:05 volumio volumio[14178]: info: Refreshing Cached IP Addresses Feb 17 11:46:06 volumio sudo[14222]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 17 11:46:06 volumio sudo[14222]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:46:06 volumio sudo[14224]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 17 11:46:06 volumio sudo[14224]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:46:06 volumio sudo[14222]: pam_unix(sudo:session): session closed for user root Feb 17 11:46:06 volumio volumio[14178]: info: Loading plugin "services"... Feb 17 11:46:06 volumio volumio[14178]: info: Loading plugin "alsa_controller"... Feb 17 11:46:06 volumio sudo[14224]: pam_unix(sudo:session): session closed for user root Feb 17 11:46:06 volumio sudo[14231]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 17 11:46:06 volumio sudo[14231]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:46:06 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 17 11:46:06 volumio volumio[14178]: info: Loading plugin "wizard"... Feb 17 11:46:06 volumio volumio[14178]: info: Loading plugin "networkfs"... Feb 17 11:46:06 volumio volumio[14178]: info: Starting Udev Watcher for removable devices Feb 17 11:46:06 volumio volumio[14178]: info: Ignoring mount for partition: boot Feb 17 11:46:06 volumio volumio[14178]: info: Ignoring mount for partition: volumio Feb 17 11:46:06 volumio volumio[14178]: info: Ignoring mount for partition: volumio_data Feb 17 11:46:06 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 17 11:46:06 volumio volumio[14178]: info: Loading plugin "volumio_command_line_client"... Feb 17 11:46:06 volumio volumio[14178]: info: Loading plugin "upnp"... Feb 17 11:46:06 volumio volumio[14178]: info: [1771303566377] Starting Upmpd Daemon Feb 17 11:46:06 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 17 11:46:06 volumio volumio[14178]: info: Loading plugin "my_music"... Feb 17 11:46:06 volumio volumio[14178]: info: Loading plugin "mpd"... Feb 17 11:46:07 volumio volumio[14178]: info: Loading plugin "upnp_browser"... Feb 17 11:46:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 37. Feb 17 11:46:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:46:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:46:08 volumio go-librespot[14255]: go-librespot daemon starting... Feb 17 11:46:08 volumio go-librespot[14256]: time="2026-02-17T11:46:08+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:46:08 volumio go-librespot[14256]: time="2026-02-17T11:46:08+07:00" level=debug msg="app state loaded" Feb 17 11:46:08 volumio go-librespot[14256]: time="2026-02-17T11:46:08+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:46:08 volumio sudo[14231]: pam_unix(sudo:session): session closed for user root Feb 17 11:46:09 volumio go-librespot[14256]: time="2026-02-17T11:46:09+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 17 11:46:09 volumio go-librespot[14256]: time="2026-02-17T11:46:09+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 17 11:46:09 volumio go-librespot[14256]: time="2026-02-17T11:46:09+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 17 11:46:09 volumio go-librespot[14256]: time="2026-02-17T11:46:09+07:00" level=info msg="zeroconf server listening on port 40031" Feb 17 11:46:09 volumio go-librespot[14256]: time="2026-02-17T11:46:09+07:00" level=debug msg="obtained new client token: AAB1sgHdtKurr/sJurlgDXVUtUkloWc5Ys+y120lC+5Cj42+Hh6uyCCGroyrQttnEr7FpGF3aP2WKptF63Bn7zdYR8jd7NRIukO7FScyE54dU4y8QyOQDdVMf7fJSrPB9oULuIoI2FfFP3+pJEl+90tGCK4mGmRDfdPLZWFiksejeAhxZraJrSmXibqeoyiL3gm1Y2LOd+TMFSw/U08zb81OXW4tayBiViM/h4RKyCOVUaysxnA0apuPAw==" Feb 17 11:46:09 volumio go-librespot[14256]: time="2026-02-17T11:46:09+07:00" level=warning msg="failed to connect to AP ap-gae2.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.241.202:4070: connect: connection refused" Feb 17 11:46:09 volumio go-librespot[14256]: time="2026-02-17T11:46:09+07:00" level=debug msg="connected to ap-gae2.spotify.com:443" Feb 17 11:46:09 volumio go-librespot[14256]: time="2026-02-17T11:46:09+07:00" level=debug msg="completed keyexchange" Feb 17 11:46:09 volumio go-librespot[14256]: time="2026-02-17T11:46:09+07:00" level=debug msg="completed challenge" Feb 17 11:46:09 volumio go-librespot[14256]: time="2026-02-17T11:46:09+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:46:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:46:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:46:10 volumio volumio[14178]: info: Starting UPNP Browser Feb 17 11:46:10 volumio volumio[14178]: info: Loading plugin "alarm-clock"... Feb 17 11:46:10 volumio volumio[14178]: info: Loading plugin "airplay_emulation"... Feb 17 11:46:10 volumio volumio[14178]: info: Starting Shairport Sync Feb 17 11:46:10 volumio volumio[14178]: info: Loading plugin "last_100"... Feb 17 11:46:10 volumio volumio[14178]: info: Loading plugin "webradio"... Feb 17 11:46:10 volumio volumio[14178]: info: Loading plugin "i2s_dacs"... Feb 17 11:46:10 volumio volumio[14178]: info: Loading plugin "volumiodiscovery"... Feb 17 11:46:10 volumio volumio[14178]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 17 11:46:10 volumio volumio[14178]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 17 11:46:10 volumio volumio[14178]: *** WARNING *** For more information see Feb 17 11:46:10 volumio volumio[14178]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 17 11:46:10 volumio volumio[14178]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 17 11:46:10 volumio volumio[14178]: *** WARNING *** For more information see Feb 17 11:46:10 volumio node[14178]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 17 11:46:10 volumio node[14178]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 17 11:46:10 volumio node[14178]: *** WARNING *** For more information see Feb 17 11:46:10 volumio node[14178]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 17 11:46:10 volumio node[14178]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 17 11:46:10 volumio node[14178]: *** WARNING *** For more information see Feb 17 11:46:10 volumio volumio[14178]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 17 11:46:10 volumio volumio[14178]: info: Discovery: Started advertising with name: Volumio Feb 17 11:46:10 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 17 11:46:10 volumio volumio[14178]: info: Loading plugin "spop"... Feb 17 11:46:12 volumio volumio[14178]: info: Loading plugin "ytcr"... Feb 17 11:46:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 38. Feb 17 11:46:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:46:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:46:13 volumio go-librespot[14268]: go-librespot daemon starting... Feb 17 11:46:13 volumio go-librespot[14269]: time="2026-02-17T11:46:13+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:46:13 volumio go-librespot[14269]: time="2026-02-17T11:46:13+07:00" level=debug msg="app state loaded" Feb 17 11:46:13 volumio go-librespot[14269]: time="2026-02-17T11:46:13+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:46:13 volumio go-librespot[14269]: time="2026-02-17T11:46:13+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 17 11:46:13 volumio go-librespot[14269]: time="2026-02-17T11:46:13+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 17 11:46:13 volumio go-librespot[14269]: time="2026-02-17T11:46:13+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 17 11:46:13 volumio go-librespot[14269]: time="2026-02-17T11:46:13+07:00" level=info msg="zeroconf server listening on port 44995" Feb 17 11:46:13 volumio go-librespot[14269]: time="2026-02-17T11:46:13+07:00" level=debug msg="obtained new client token: AACltV00/cZj3BZuGv6oEf3adMtlFWtaT7vE28rsepbBx8rms/VPQOET6yRzcelmHyw3fgdQtIU6R8zg0zIRYWVF8Y3WtPZr1ebedP+FmcIRnQk6JVfZq8RYYYEuYiQQHtqM9c7p2lFDeHDGLFOxzSzQRQIDSEPw0UbckJ7l4m06SVHfZ03OxGZdrgHyoOMe26CMtgG22Itbwh7TYLZ3k2vDdSumOw0riOjAQKtlmbU/1Tzd3K3nfEZ4bg==" Feb 17 11:46:14 volumio go-librespot[14269]: time="2026-02-17T11:46:14+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:46:14 volumio go-librespot[14269]: time="2026-02-17T11:46:14+07:00" level=debug msg="completed keyexchange" Feb 17 11:46:14 volumio go-librespot[14269]: time="2026-02-17T11:46:14+07:00" level=debug msg="completed challenge" Feb 17 11:46:14 volumio go-librespot[14269]: time="2026-02-17T11:46:14+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:46:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:46:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:46:15 volumio volumio[14178]: info: Loading plugin "ytmusic"... Feb 17 11:46:16 volumio volumio-remote-updater[25144]: [2026-02-17 11:46:16] [connect] Successful connection Feb 17 11:46:16 volumio volumio[14178]: info: Loading plugin "outputs"... Feb 17 11:46:16 volumio volumio[14178]: info: Loading plugin "albumart"... Feb 17 11:46:16 volumio volumio[14178]: info: Plugin example_plugin is not enabled Feb 17 11:46:16 volumio volumio[14178]: info: Loading plugin "inputs"... Feb 17 11:46:16 volumio volumio[14178]: info: Loading plugin "updater_comm"... Feb 17 11:46:16 volumio volumio[14178]: info: Plugin mpdemulation is not enabled Feb 17 11:46:16 volumio volumio[14178]: info: Loading plugin "rest_api"... Feb 17 11:46:16 volumio volumio[14178]: info: Loading plugin "websocket"... Feb 17 11:46:16 volumio volumio[14178]: info: Starting Socket.io Server version 1.7.4 Feb 17 11:46:16 volumio volumio[14178]: info: Loading plugin "RoonBridge"... Feb 17 11:46:17 volumio volumio[14178]: info: Applying required configuration parameters for plugin RoonBridge Feb 17 11:46:17 volumio volumio[14178]: info: Loading i18n strings for locale en Feb 17 11:46:17 volumio volumio[14178]: Updating browse sources language Feb 17 11:46:17 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 17 11:46:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 39. Feb 17 11:46:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:46:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:46:17 volumio go-librespot[14301]: go-librespot daemon starting... Feb 17 11:46:17 volumio go-librespot[14302]: time="2026-02-17T11:46:17+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:46:17 volumio go-librespot[14302]: time="2026-02-17T11:46:17+07:00" level=debug msg="app state loaded" Feb 17 11:46:17 volumio volumio[14291]: Forking 3 albumart workers Feb 17 11:46:17 volumio go-librespot[14302]: time="2026-02-17T11:46:17+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:46:17 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 11:46:17 volumio volumio[14178]: info: CoreCommandRouter::initPlayerControls Feb 17 11:46:17 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:17 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:17 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:17 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:17 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:17 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:17 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:17 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:17 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 11:46:17 volumio volumio[14178]: Express server listening on port 3000 Feb 17 11:46:17 volumio volumio[14178]: [Metrics] WebUI: 16s 41.47ms Feb 17 11:46:17 volumio volumio[14178]: info: CoreStateMachine::resetVolumioState Feb 17 11:46:17 volumio volumio[14178]: info: CoreStateMachine::getcurrentVolume Feb 17 11:46:17 volumio volumio[14178]: info: CoreCommandRouter::volumioRetrievevolume Feb 17 11:46:17 volumio sudo[14341]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 17 11:46:17 volumio sudo[14341]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:46:17 volumio sudo[14341]: pam_unix(sudo:session): session closed for user root Feb 17 11:46:17 volumio sudo[14342]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 17 11:46:17 volumio sudo[14342]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:46:17 volumio sudo[14342]: pam_unix(sudo:session): session closed for user root Feb 17 11:46:17 volumio volumio[14178]: info: Volumio Network Manager: Network status updated: 1 Feb 17 11:46:18 volumio go-librespot[14302]: time="2026-02-17T11:46:18+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 17 11:46:18 volumio go-librespot[14302]: time="2026-02-17T11:46:18+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 17 11:46:18 volumio go-librespot[14302]: time="2026-02-17T11:46:18+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 17 11:46:18 volumio go-librespot[14302]: time="2026-02-17T11:46:18+07:00" level=info msg="zeroconf server listening on port 46087" Feb 17 11:46:18 volumio volumio-remote-updater[25144]: [2026-02-17 11:46:18] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1771303576 101 Feb 17 11:46:18 volumio volumio[14178]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 1 Feb 17 11:46:18 volumio volumio[14178]: info: VolumeController:: Volume=100 Mute =false Feb 17 11:46:18 volumio volumio[14178]: info: CoreStateMachine::pushState Feb 17 11:46:18 volumio volumio[14178]: info: CorePlayQueue::getTrack 0 Feb 17 11:46:18 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 11:46:18 volumio volumio[14178]: info: CoreCommandRouter::volumioPushState Feb 17 11:46:18 volumio volumio[14178]: info: CoreStateMachine::updateTrackBlock Feb 17 11:46:18 volumio volumio[14178]: info: CorePlayQueue::getTrackBlock Feb 17 11:46:18 volumio volumio[14178]: info: CoreCommandRouter::volumioRetrievevolume Feb 17 11:46:18 volumio go-librespot[14302]: time="2026-02-17T11:46:18+07:00" level=debug msg="obtained new client token: AAAFiHUsSM7FdNJBvbGcOp1jHj0/9QrS77Gl5+r7K/Mv8PFrF+b3BZ76YJx+l43FZJiQidHzz8AOJqOydTWy9jVOQiFb9bKc0vcQZelUNUP7IOt1bL6jE1Hg1pZEIf/cjwHf4xHgT1qLBdu6ogkO1Khf+10kLGFg24ECWiXm18G//zsA6XfsO4nNOgCgeSrqYF/+52KDnyz3Z0NhZDAHNqMqNdR3Z9asswufcCVp5g97k9GKA+CDttXbOA==" Feb 17 11:46:18 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 17 11:46:18 volumio volumio[14178]: info: Reloading queue from file Feb 17 11:46:18 volumio volumio[14178]: info: CoreStateMachine::setRepeat null single undefined Feb 17 11:46:18 volumio volumio[14178]: info: CoreStateMachine::pushState Feb 17 11:46:18 volumio volumio[14178]: info: CorePlayQueue::getTrack 0 Feb 17 11:46:18 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 11:46:18 volumio volumio[14178]: info: CoreCommandRouter::volumioPushState Feb 17 11:46:18 volumio go-librespot[14302]: time="2026-02-17T11:46:18+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:46:18 volumio volumio[14178]: info: CoreStateMachine::setRandom null Feb 17 11:46:18 volumio volumio[14178]: info: CoreStateMachine::pushState Feb 17 11:46:18 volumio volumio[14178]: info: CorePlayQueue::getTrack 0 Feb 17 11:46:18 volumio volumio[14178]: info: CoreCommandRouter::volumioPushState Feb 17 11:46:18 volumio volumio[14178]: info: Setting Device type: Raspberry PI Feb 17 11:46:18 volumio volumio[14178]: info: Completed loading Core Plugins Feb 17 11:46:18 volumio volumio[14178]: info: Preparing to generate the ALSA configuration file Feb 17 11:46:18 volumio go-librespot[14302]: time="2026-02-17T11:46:18+07:00" level=debug msg="completed keyexchange" Feb 17 11:46:18 volumio go-librespot[14302]: time="2026-02-17T11:46:18+07:00" level=debug msg="completed challenge" Feb 17 11:46:18 volumio go-librespot[14302]: time="2026-02-17T11:46:18+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:46:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:46:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:46:18 volumio volumio[14178]: info: VolumeController:: Volume=100 Mute =false Feb 17 11:46:18 volumio volumio[14178]: info: CoreStateMachine::pushState Feb 17 11:46:18 volumio volumio[14178]: info: CorePlayQueue::getTrack 0 Feb 17 11:46:18 volumio volumio[14178]: info: CoreCommandRouter::volumioPushState Feb 17 11:46:18 volumio volumio[14178]: info: Asound.conf file unchanged, so no further update is needed Feb 17 11:46:18 volumio volumio[14178]: info: Output device has changed, restarting MPD Feb 17 11:46:18 volumio volumio[14178]: info: Output device has changed, restarting Shairport Sync Feb 17 11:46:18 volumio sudo[14361]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 17 11:46:18 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:18 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 17 11:46:18 volumio sudo[14361]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:46:18 volumio sudo[14365]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 17 11:46:18 volumio sudo[14363]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 17 11:46:18 volumio sudo[14365]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:46:18 volumio sudo[14363]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:46:18 volumio volumio[14178]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 17 11:46:18 volumio volumio[14178]: info: ___________ START PLUGINS ___________ Feb 17 11:46:18 volumio volumio[14178]: info: ControllerMpd::onStart: Initializing MPD Feb 17 11:46:18 volumio sudo[14363]: pam_unix(sudo:session): session closed for user root Feb 17 11:46:18 volumio volumio[14178]: info: Creating MPD Configuration file Feb 17 11:46:18 volumio sudo[14361]: pam_unix(sudo:session): session closed for user root Feb 17 11:46:19 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 11:46:19 volumio volumio[14178]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 17 11:46:19 volumio volumio[14178]: info: [1771303579044] CoreMusicLibrary::Adding element Media Servers Feb 17 11:46:19 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 17 11:46:19 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 17 11:46:19 volumio sudo[14374]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 17 11:46:19 volumio sudo[14374]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:46:19 volumio sudo[14374]: pam_unix(sudo:session): session closed for user root Feb 17 11:46:19 volumio sudo[14376]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 17 11:46:19 volumio sudo[14376]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:46:19 volumio volumio[14178]: info: UPNP Browser: Client initialized successfully Feb 17 11:46:19 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:19 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 17 11:46:19 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 17 11:46:19 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 17 11:46:19 volumio systemd[1]: mpd.service: Consumed 7.221s CPU time. Feb 17 11:46:19 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 17 11:46:19 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 17 11:46:19 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 17 11:46:19 volumio volumio[14178]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 17 11:46:19 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:19 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 17 11:46:19 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 17 11:46:19 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 17 11:46:19 volumio volumio[14178]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 17 11:46:19 volumio volumio[14178]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 17 11:46:19 volumio volumio[14178]: info: [1771303579450] CoreMusicLibrary::Adding element Last_100 Feb 17 11:46:19 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 17 11:46:19 volumio volumio[14178]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 17 11:46:19 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 17 11:46:19 volumio volumio[14178]: info: [1771303579465] CoreMusicLibrary::Adding element Webradio Feb 17 11:46:19 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 17 11:46:19 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 17 11:46:19 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 17 11:46:19 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 17 11:46:19 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 17 11:46:19 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 17 11:46:19 volumio volumio[14178]: info: Initializing BBC Radios Feb 17 11:46:19 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 17 11:46:19 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 17 11:46:19 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 17 11:46:19 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 17 11:46:19 volumio volumio[14178]: info: Creating Spotify config file Feb 17 11:46:19 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:20 volumio sudo[14398]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 17 11:46:20 volumio sudo[14398]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 17 11:46:20 volumio sudo[14398]: pam_unix(sudo:session): session closed for user root Feb 17 11:46:20 volumio volumio[14309]: Starting albumart workers Feb 17 11:46:20 volumio volumio[14178]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 17 11:46:20 volumio volumio[14178]: info: [1771303580858] CoreMusicLibrary::Adding element YouTube Music Feb 17 11:46:20 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 17 11:46:20 volumio volumio[14178]: Cannot find translation for source YouTube Music Feb 17 11:46:20 volumio volumio[14178]: info: Volumio Calling Home Feb 17 11:46:21 volumio sudo[14407]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Feb 17 11:46:21 volumio volumio[14310]: Starting albumart workers Feb 17 11:46:21 volumio sudo[14407]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:46:21 volumio volumio[14308]: Starting albumart workers Feb 17 11:46:21 volumio sudo[14407]: pam_unix(sudo:session): session closed for user root Feb 17 11:46:21 volumio volumio[14178]: info: Discovery: adding 921648ed-0557-4d70-9927-1420682efcc7 Feb 17 11:46:21 volumio volumio[14178]: info: Discovery: Found device Volumio Feb 17 11:46:21 volumio volumio[14178]: info: CoreCommandRouter::volumioGetState Feb 17 11:46:21 volumio volumio[14178]: info: CorePlayQueue::getTrack 0 Feb 17 11:46:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 40. Feb 17 11:46:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:46:21 volumio volumio[14178]: info: MPD Permissions set Feb 17 11:46:21 volumio volumio[14178]: info: MPD Permissions set Feb 17 11:46:21 volumio volumio[14178]: info: Upmpdcli Daemon Started Feb 17 11:46:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:46:21 volumio volumio[14178]: info: Discovery: this is already registered, 921648ed-0557-4d70-9927-1420682efcc7 Feb 17 11:46:21 volumio go-librespot[14412]: go-librespot daemon starting... Feb 17 11:46:21 volumio volumio[14178]: info: Discovery: Found device Volumio Feb 17 11:46:21 volumio volumio[14178]: info: CoreCommandRouter::volumioGetState Feb 17 11:46:21 volumio volumio[14178]: info: CorePlayQueue::getTrack 0 Feb 17 11:46:22 volumio go-librespot[14413]: time="2026-02-17T11:46:22+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:46:22 volumio go-librespot[14413]: time="2026-02-17T11:46:22+07:00" level=debug msg="app state loaded" Feb 17 11:46:22 volumio go-librespot[14413]: time="2026-02-17T11:46:22+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:46:22 volumio volumio[14178]: info: Volumio called home Feb 17 11:46:22 volumio volumio[14178]: info: Spotify config file written Feb 17 11:46:22 volumio sudo[14420]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Feb 17 11:46:22 volumio sudo[14420]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:46:22 volumio volumio[14178]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 17 11:46:22 volumio systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Feb 17 11:46:22 volumio systemd[1]: go-librespot-daemon.service: Deactivated successfully. Feb 17 11:46:22 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:22 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:46:22 volumio go-librespot[14423]: go-librespot daemon starting... Feb 17 11:46:22 volumio sudo[14420]: pam_unix(sudo:session): session closed for user root Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:22 volumio go-librespot[14426]: time="2026-02-17T11:46:22+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:46:22 volumio go-librespot[14426]: time="2026-02-17T11:46:22+07:00" level=debug msg="app state loaded" Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 17 11:46:22 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:46:22 volumio go-librespot[14426]: time="2026-02-17T11:46:22+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:46:22 volumio volumio[14178]: info: No need to fix Spotify hosts Feb 17 11:46:23 volumio go-librespot[14426]: time="2026-02-17T11:46:23+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 17 11:46:23 volumio go-librespot[14426]: time="2026-02-17T11:46:23+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 17 11:46:23 volumio go-librespot[14426]: time="2026-02-17T11:46:23+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 17 11:46:23 volumio go-librespot[14426]: time="2026-02-17T11:46:23+07:00" level=info msg="zeroconf server listening on port 40673" Feb 17 11:46:23 volumio volumio[14178]: info: Starting Shairport Sync Feb 17 11:46:23 volumio volumio[14178]: info: Starting Shairport Sync Feb 17 11:46:23 volumio go-librespot[14426]: time="2026-02-17T11:46:23+07:00" level=debug msg="obtained new client token: AAA/J/uWxhDzttKhEHxrY96TE64IGs1gkSSlu1XiShqsf+iytv2zN/l3/S1KHxFVsYicJtcl2Lkh4+lFzQ7ar8WDMGeAA0K+RZ1tWhlPmKBuwT+PiXeMW6h2Efp++QdpkPvXnaAD4seAW5OlQZ/1jvERADukVrNpQX9I1YGVdPMtHnJ4/JssVshRwWKU0Jt6qS/AVL0xHcR0SMUwslj/xUMkRGhh8XdD2Q/JWwcIQpGY25cyq2x7Blrr0Q==" Feb 17 11:46:23 volumio volumio[14178]: info: Starting Shairport Sync Feb 17 11:46:23 volumio sudo[14461]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 17 11:46:23 volumio sudo[14461]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:46:23 volumio sudo[14463]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 17 11:46:23 volumio sudo[14463]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:46:23 volumio sudo[14465]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 17 11:46:23 volumio sudo[14465]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 17 11:46:24 volumio go-librespot[14426]: time="2026-02-17T11:46:24+07:00" level=warning msg="failed to connect to AP ap-gae2.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.241.202:4070: connect: connection refused" Feb 17 11:46:24 volumio go-librespot[14426]: time="2026-02-17T11:46:24+07:00" level=debug msg="connected to ap-gae2.spotify.com:443" Feb 17 11:46:24 volumio volumio[14178]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Feb 17 11:46:24 volumio volumio[14178]: SPOTIFY: BQADZYCtKYhO5f3IOQf89MA23gkcCfEluPFxGRfmZKwM5jSLDFgr_ohfbUGdksBiiIJzWobH41q1SpLKwbo6BkipqnP6ChR_Fsm1ourQFkH3VVuBNnXpAY3o2vO2F3OhOkTHrhN2ohMWHbYyfgeteizTfeexpnjuNdx-hdITbC4dYZ45Sbp8a-swJDCbEweJwDDbe55Gd_9U-By5TKGwq_5CNgxpzDiiyquMJlWn7-ydEGrF3OjMrr8imMBf8YJTNzL5qcatE92kONxhGz2MxNDKiX2rr5Z9n8rhTbe7wxDZHqqkjVz_a4Hs Feb 17 11:46:24 volumio volumio[14178]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Feb 17 11:46:24 volumio volumio[14178]: info: New Spotify access token = BQADZYCtKYhO5f3IOQf89MA23gkcCfEluPFxGRfmZKwM5jSLDFgr_ohfbUGdksBiiIJzWobH41q1SpLKwbo6BkipqnP6ChR_Fsm1ourQFkH3VVuBNnXpAY3o2vO2F3OhOkTHrhN2ohMWHbYyfgeteizTfeexpnjuNdx-hdITbC4dYZ45Sbp8a-swJDCbEweJwDDbe55Gd_9U-By5TKGwq_5CNgxpzDiiyquMJlWn7-ydEGrF3OjMrr8imMBf8YJTNzL5qcatE92kONxhGz2MxNDKiX2rr5Z9n8rhTbe7wxDZHqqkjVz_a4Hs Feb 17 11:46:24 volumio volumio[14178]: info: Spotify credentials grant success - running version from March 24, 2019 Feb 17 11:46:24 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 17 11:46:24 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 17 11:46:24 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 17 11:46:24 volumio systemd[1]: shairport-sync.service: Consumed 2.580s CPU time. Feb 17 11:46:24 volumio go-librespot[14426]: time="2026-02-17T11:46:24+07:00" level=debug msg="completed keyexchange" Feb 17 11:46:24 volumio go-librespot[14426]: time="2026-02-17T11:46:24+07:00" level=debug msg="completed challenge" Feb 17 11:46:24 volumio go-librespot[14426]: time="2026-02-17T11:46:24+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:46:24 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 17 11:46:24 volumio volumio[14178]: info: CoreCommandRouter::volumioGetState Feb 17 11:46:24 volumio volumio[14178]: info: CorePlayQueue::getTrack 0 Feb 17 11:46:24 volumio sudo[14461]: pam_unix(sudo:session): session closed for user root Feb 17 11:46:24 volumio sudo[14463]: pam_unix(sudo:session): session closed for user root Feb 17 11:46:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:46:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:46:24 volumio sudo[14465]: pam_unix(sudo:session): session closed for user root Feb 17 11:46:24 volumio volumio[14178]: info: Shairport-Sync Started Feb 17 11:46:24 volumio volumio[14178]: Error adding Membership: Error: addMembership EINVAL Feb 17 11:46:24 volumio volumio[14178]: info: Shairport-Sync Started Feb 17 11:46:24 volumio volumio[14178]: info: Shairport-Sync Started Feb 17 11:46:24 volumio volumio[14178]: SPOTIFY: User informations: {"country":"PK","display_name":"215mmgea6kss3jxeqsqdquvji","email":"linh.ngotran@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/215mmgea6kss3jxeqsqdquvji"},"followers":{"href":null,"total":1},"href":"https://api.spotify.com/v1/users/215mmgea6kss3jxeqsqdquvji","id":"215mmgea6kss3jxeqsqdquvji","images":[],"product":"premium","type":"user","uri":"spotify:user:215mmgea6kss3jxeqsqdquvji"} Feb 17 11:46:24 volumio volumio[14178]: info: Spotify Successfully logged in Feb 17 11:46:24 volumio volumio[14178]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 17 11:46:24 volumio volumio[14178]: info: [1771303584745] CoreMusicLibrary::Adding element Spotify Feb 17 11:46:24 volumio volumio[14178]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 17 11:46:24 volumio volumio[14178]: Cannot find translation for source YouTube Music Feb 17 11:46:24 volumio volumio[14178]: Cannot find translation for source Spotify Feb 17 11:46:25 volumio volumio[14178]: info: [yt-cast-receiver] DIAL server listening on port 8098 Feb 17 11:46:25 volumio volumio[14178]: info: CoreCommandRouter::volumioRetrievevolume Feb 17 11:46:25 volumio volumio[14178]: info: VolumeController:: Volume=100 Mute =false Feb 17 11:46:25 volumio volumio[14178]: info: CoreCommandRouter::volumioGetState Feb 17 11:46:25 volumio volumio[14178]: info: CorePlayQueue::getTrack 0 Feb 17 11:46:25 volumio volumio[14178]: info: CoreStateMachine::pushState Feb 17 11:46:25 volumio volumio[14178]: info: CorePlayQueue::getTrack 0 Feb 17 11:46:25 volumio volumio[14178]: info: CoreCommandRouter::volumioPushState Feb 17 11:46:26 volumio volumio[14178]: info: go-librespot daemon successfully initialized Feb 17 11:46:27 volumio mpd[14405]: 2026-02-17T11:46:27 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 17 11:46:27 volumio systemd[1]: Started mpd.service - Music Player Daemon. Feb 17 11:46:27 volumio sudo[14365]: pam_unix(sudo:session): session closed for user root Feb 17 11:46:27 volumio sudo[14376]: pam_unix(sudo:session): session closed for user root Feb 17 11:46:27 volumio volumio[14178]: error: MPD error: The expression evaluated to a falsy value: Feb 17 11:46:27 volumio volumio[14178]: assert.ok(self.idling) Feb 17 11:46:27 volumio volumio[14178]: error: The expression evaluated to a falsy value: Feb 17 11:46:27 volumio volumio[14178]: assert.ok(self.idling) Feb 17 11:46:27 volumio volumio[14178]: error: updateQueue error: null Feb 17 11:46:27 volumio volumio[14178]: info: MPD running with PID14405 Feb 17 11:46:27 volumio volumio[14178]: ,establishing connection Feb 17 11:46:27 volumio volumio[14178]: info: Completed starting Core Plugins Feb 17 11:46:27 volumio volumio[14178]: info: ------------------------------------------- Feb 17 11:46:27 volumio volumio[14178]: info: ----- MyVolumio plugins startup ---- Feb 17 11:46:27 volumio volumio[14178]: info: ------------------------------------------- Feb 17 11:46:27 volumio volumio[14178]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 17 11:46:27 volumio volumio[14178]: error: updateQueue error: null Feb 17 11:46:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Feb 17 11:46:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:46:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:46:27 volumio go-librespot[14505]: go-librespot daemon starting... Feb 17 11:46:27 volumio go-librespot[14506]: time="2026-02-17T11:46:27+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:46:27 volumio go-librespot[14506]: time="2026-02-17T11:46:27+07:00" level=debug msg="app state loaded" Feb 17 11:46:27 volumio go-librespot[14506]: time="2026-02-17T11:46:27+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:46:28 volumio go-librespot[14506]: time="2026-02-17T11:46:28+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Feb 17 11:46:28 volumio go-librespot[14506]: time="2026-02-17T11:46:28+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Feb 17 11:46:28 volumio go-librespot[14506]: time="2026-02-17T11:46:28+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Feb 17 11:46:28 volumio go-librespot[14506]: time="2026-02-17T11:46:28+07:00" level=info msg="zeroconf server listening on port 39861" Feb 17 11:46:28 volumio go-librespot[14506]: time="2026-02-17T11:46:28+07:00" level=debug msg="obtained new client token: AAC0obw7MHhb9iB/Zuek2sZdxtQp7sIJ7OZNibNOVdhCu3lQPE8sJ3fZ8fXE+ADhEUmfiQNgeLs2azpnAKht5R0DfBrsne+Mu3Dbagr7SV3X3+QRa1/Ph9xRDOuwFPipgQB17q8xODLPBL2pDEtwcddMwDTh3T1iwnNUeagrGLMBs5HbhUjxTGYmUUTlJZ7bzSkwu1i49gAEaLJptQv8VcEi0/6I40FhgfMOzjbMca3Tgr5SvsxJxHJxTA==" Feb 17 11:46:28 volumio go-librespot[14506]: time="2026-02-17T11:46:28+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:46:28 volumio go-librespot[14506]: time="2026-02-17T11:46:28+07:00" level=debug msg="completed keyexchange" Feb 17 11:46:28 volumio go-librespot[14506]: time="2026-02-17T11:46:28+07:00" level=debug msg="completed challenge" Feb 17 11:46:28 volumio go-librespot[14506]: time="2026-02-17T11:46:28+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:46:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:46:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:46:29 volumio volumio[14178]: info: Initializing connection to go-librespot Websocket Feb 17 11:46:29 volumio volumio[14178]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 17 11:46:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Feb 17 11:46:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:46:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:46:31 volumio go-librespot[14514]: go-librespot daemon starting... Feb 17 11:46:31 volumio go-librespot[14515]: time="2026-02-17T11:46:31+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:46:31 volumio go-librespot[14515]: time="2026-02-17T11:46:31+07:00" level=debug msg="app state loaded" Feb 17 11:46:31 volumio go-librespot[14515]: time="2026-02-17T11:46:31+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:46:32 volumio volumio[14178]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Feb 17 11:46:32 volumio go-librespot[14515]: time="2026-02-17T11:46:32+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 17 11:46:32 volumio go-librespot[14515]: time="2026-02-17T11:46:32+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 17 11:46:32 volumio go-librespot[14515]: time="2026-02-17T11:46:32+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 17 11:46:32 volumio go-librespot[14515]: time="2026-02-17T11:46:32+07:00" level=info msg="zeroconf server listening on port 35849" Feb 17 11:46:32 volumio go-librespot[14515]: time="2026-02-17T11:46:32+07:00" level=debug msg="obtained new client token: AADHmzkO94/lyCzBOBPJ46g9Et5yPQDfmXg2Fxp/0j4z1sKhEhuZKevst6PyVDVp0VYgyIoEt4Pfc9kmUxquD6D6cjF1IYxPK5ZMRlOhg6cwxZ/ZDJLtYuM5A4he5KIMbMNjj+sbzRrisjLl/ZODeZfNCHAE5DvYC7e0XIXclFQ7B7p35kw6p5uiaFqxcEYK3mjKhkmM54d/UlE2iN9tH5Ym/YL2+OoUgXB5B4IqPBPioOjUqo9o74MOnw==" Feb 17 11:46:32 volumio go-librespot[14515]: time="2026-02-17T11:46:32+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:46:32 volumio go-librespot[14515]: time="2026-02-17T11:46:32+07:00" level=debug msg="completed keyexchange" Feb 17 11:46:32 volumio go-librespot[14515]: time="2026-02-17T11:46:32+07:00" level=debug msg="completed challenge" Feb 17 11:46:32 volumio volumio[14178]: info: Initializing connection to go-librespot Websocket Feb 17 11:46:32 volumio go-librespot[14515]: time="2026-02-17T11:46:32+07:00" level=debug msg="new websocket client" Feb 17 11:46:32 volumio go-librespot[14515]: time="2026-02-17T11:46:32+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:46:32 volumio volumio[14178]: info: Connection to go-librespot Websocket established Feb 17 11:46:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:46:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:46:32 volumio volumio[14178]: info: Connection to go-librespot Websocket closed Feb 17 11:46:35 volumio volumio[14178]: info: Getting Spotify volume Feb 17 11:46:35 volumio volumio[14178]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 11:46:35 volumio volumio[14178]: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 17 11:46:35 volumio volumio[14178]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Feb 17 11:46:35 volumio volumio[14178]: errno: -111, Feb 17 11:46:35 volumio volumio[14178]: code: 'ECONNREFUSED', Feb 17 11:46:35 volumio volumio[14178]: syscall: 'connect', Feb 17 11:46:35 volumio volumio[14178]: address: '127.0.0.1', Feb 17 11:46:35 volumio volumio[14178]: port: 9879, Feb 17 11:46:35 volumio volumio[14178]: response: undefined Feb 17 11:46:35 volumio volumio[14178]: } Feb 17 11:46:35 volumio volumio[14178]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 11:46:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3. Feb 17 11:46:36 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:46:36 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 17 11:46:36 volumio go-librespot[14534]: go-librespot daemon starting... Feb 17 11:46:36 volumio go-librespot[14535]: time="2026-02-17T11:46:36+07:00" level=info msg="running go-librespot 0.4.0" Feb 17 11:46:36 volumio go-librespot[14535]: time="2026-02-17T11:46:36+07:00" level=debug msg="app state loaded" Feb 17 11:46:36 volumio go-librespot[14535]: time="2026-02-17T11:46:36+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 17 11:46:36 volumio go-librespot[14535]: time="2026-02-17T11:46:36+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 17 11:46:36 volumio go-librespot[14535]: time="2026-02-17T11:46:36+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 17 11:46:36 volumio go-librespot[14535]: time="2026-02-17T11:46:36+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 17 11:46:36 volumio go-librespot[14535]: time="2026-02-17T11:46:36+07:00" level=info msg="zeroconf server listening on port 34585" Feb 17 11:46:36 volumio go-librespot[14535]: time="2026-02-17T11:46:36+07:00" level=debug msg="obtained new client token: AADo0l4FxlAxA0UcX2QnTf7QjHdeWRdk4xESttgZoGRo6Ko5H0h58iemNUX6fTxsgh0rLk4x2d2yp9zRVdR+QfDx1N5bdzdECZB9NVmAgIVPYUdMHQJQloKvAxaEI7ZrIxR90eMpTKOjinVh5bFrxmVIA/v19vVaBV+c7r1HUXkm2TSCiLI7Zx36GUrt2jkJMkHQ5YmasJGjr7wZMuzTBEIAj2MF1OeAScaJTkumy1YkS+EJARVBlJ+IuQ==" Feb 17 11:46:37 volumio go-librespot[14535]: time="2026-02-17T11:46:37+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Feb 17 11:46:37 volumio go-librespot[14535]: time="2026-02-17T11:46:37+07:00" level=debug msg="completed keyexchange" Feb 17 11:46:37 volumio go-librespot[14535]: time="2026-02-17T11:46:37+07:00" level=debug msg="completed challenge" Feb 17 11:46:37 volumio go-librespot[14535]: time="2026-02-17T11:46:37+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials " Feb 17 11:46:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 17 11:46:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 17 11:46:37 volumio sudo[14559]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-17 11:45' Feb 17 11:46:37 volumio sudo[14559]: 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"