Oct 16 00:26:00 bcik volumio[2628]: info: Updating MyVolumio device info Oct 16 00:26:00 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 00:26:00 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 00:26:00 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 00:26:00 bcik volumio[2628]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 16 00:26:01 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2341. Oct 16 00:26:01 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:01 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:01 bcik go-librespot[2993]: go-librespot daemon starting... Oct 16 00:26:01 bcik go-librespot[2994]: time="2026-10-16T00:26:01+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:26:01 bcik go-librespot[2994]: time="2026-10-16T00:26:01+02:00" level=debug msg="app state loaded" Oct 16 00:26:01 bcik go-librespot[2994]: time="2026-10-16T00:26:01+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:26:01 bcik go-librespot[2994]: time="2026-10-16T00:26:01+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 16 00:26:01 bcik go-librespot[2994]: time="2026-10-16T00:26:01+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 16 00:26:01 bcik go-librespot[2994]: time="2026-10-16T00:26:01+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 16 00:26:01 bcik go-librespot[2994]: time="2026-10-16T00:26:01+02:00" level=info msg="zeroconf server listening on port 39565" Oct 16 00:26:01 bcik go-librespot[2994]: time="2026-10-16T00:26:01+02:00" level=debug msg="obtained new client token: AAFVKgA5OgNzerIuz9BzzoVo5BvGL26nlM88W83Sd6Z98OTFoDctvHD9YXgCJeCCL89I7E46+XWSqSlrNvhJgaBsNyCzTM5H68XnAK6nWKanVRFK884sLMb3JNWji3uTEjLDSnA6LDbRcZrM8E1jyiBKu13OiPWI9x1kyfMy5L+yqca9ILAje8qQZYmWQIgvtSapK+3zT5X9I+ygr9vkEa3nJt831e9jXfSwBRctkcRQiTyBPqD/lSQ=" Oct 16 00:26:02 bcik go-librespot[2994]: time="2026-10-16T00:26:02+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 16 00:26:02 bcik go-librespot[2994]: time="2026-10-16T00:26:02+02:00" level=debug msg="completed keyexchange" Oct 16 00:26:02 bcik go-librespot[2994]: time="2026-10-16T00:26:02+02:00" level=debug msg="completed challenge" Oct 16 00:26:02 bcik go-librespot[2994]: time="2026-10-16T00:26:02+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:26:02 bcik go-librespot[2994]: time="2026-10-16T00:26:02+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:26:02 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:26:02 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:26:02 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:02 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:26:05 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:05 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:26:05 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2342. Oct 16 00:26:05 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:05 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:05 bcik go-librespot[3018]: go-librespot daemon starting... Oct 16 00:26:05 bcik go-librespot[3019]: time="2026-10-16T00:26:05+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:26:05 bcik go-librespot[3019]: time="2026-10-16T00:26:05+02:00" level=debug msg="app state loaded" Oct 16 00:26:05 bcik go-librespot[3019]: time="2026-10-16T00:26:05+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:26:05 bcik go-librespot[3019]: time="2026-10-16T00:26:05+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 16 00:26:05 bcik go-librespot[3019]: time="2026-10-16T00:26:05+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 16 00:26:05 bcik go-librespot[3019]: time="2026-10-16T00:26:05+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 16 00:26:05 bcik go-librespot[3019]: time="2026-10-16T00:26:05+02:00" level=info msg="zeroconf server listening on port 44811" Oct 16 00:26:05 bcik go-librespot[3019]: time="2026-10-16T00:26:05+02:00" level=debug msg="obtained new client token: AAF2N1q2re6rNUcFVqWjdr7ptNyOSb4WsN3zy2PIFjdcH7RWPfJ6h/6/8Yc6ZaLhvpj5yFFT98QICIrpPMe1ze/oL6uUcspcPYeABCKpkR7MLa4DQJcejZZYHFCzuxjrNE4vpgOfU0Ul8xN0xI7nj4UlUWEUzyip0M/otQUh57tuSTifzcKOG2qMGxoM2HdXeAMZ57DAkhWDzRm+G8ja2F35hTzVl9UPNDBrgdRZT2NGgexa0cmhHbk=" Oct 16 00:26:05 bcik go-librespot[3019]: time="2026-10-16T00:26:05+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 16 00:26:05 bcik go-librespot[3019]: time="2026-10-16T00:26:05+02:00" level=debug msg="completed keyexchange" Oct 16 00:26:05 bcik go-librespot[3019]: time="2026-10-16T00:26:05+02:00" level=debug msg="completed challenge" Oct 16 00:26:05 bcik go-librespot[3019]: time="2026-10-16T00:26:05+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:26:05 bcik go-librespot[3019]: time="2026-10-16T00:26:05+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:26:05 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:26:05 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:26:08 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 16 00:26:08 bcik volumio[2628]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Oct 16 00:26:08 bcik volumio[2628]: info: CoreCommandRouter::volumioGetState Oct 16 00:26:08 bcik volumio[2628]: info: CorePlayQueue::getTrack 0 Oct 16 00:26:08 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:08 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:26:08 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2343. Oct 16 00:26:08 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:08 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:08 bcik go-librespot[3028]: go-librespot daemon starting... Oct 16 00:26:08 bcik go-librespot[3029]: time="2026-10-16T00:26:08+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:26:08 bcik go-librespot[3029]: time="2026-10-16T00:26:08+02:00" level=debug msg="app state loaded" Oct 16 00:26:08 bcik go-librespot[3029]: time="2026-10-16T00:26:08+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:26:08 bcik go-librespot[3029]: time="2026-10-16T00:26:08+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 16 00:26:08 bcik go-librespot[3029]: time="2026-10-16T00:26:08+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 16 00:26:08 bcik go-librespot[3029]: time="2026-10-16T00:26:08+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 16 00:26:08 bcik go-librespot[3029]: time="2026-10-16T00:26:08+02:00" level=info msg="zeroconf server listening on port 39783" Oct 16 00:26:08 bcik go-librespot[3029]: time="2026-10-16T00:26:08+02:00" level=debug msg="obtained new client token: AAEwyjcJkqykVxHf6j70wJ4tR475cRFxGFttbiirROM2+cM020Q8je/VTvenp//sCxUGjZwZkf/lvk43qoVDeADvrPOfDf84njr2ZOEY2/Wcy0ir0oKAP/zg3a//O0aifQf0s5u3nN5+JX32Krp1GgQ2tbKxwv4qDmb/GZSgDwj2pLcOazawuZBruzTu+OBqFHlINQwZ2iSxpZF6F0J+2Fsu+OZXX8RhSs61AOdaRcnKG2piLFLA2WQ=" Oct 16 00:26:09 bcik go-librespot[3029]: time="2026-10-16T00:26:09+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 16 00:26:09 bcik go-librespot[3029]: time="2026-10-16T00:26:09+02:00" level=debug msg="completed keyexchange" Oct 16 00:26:09 bcik go-librespot[3029]: time="2026-10-16T00:26:09+02:00" level=debug msg="completed challenge" Oct 16 00:26:09 bcik go-librespot[3029]: time="2026-10-16T00:26:09+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:26:09 bcik go-librespot[3029]: time="2026-10-16T00:26:09+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:26:09 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:26:09 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:26:11 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:11 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:26:12 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2344. Oct 16 00:26:12 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:12 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:12 bcik go-librespot[3038]: go-librespot daemon starting... Oct 16 00:26:12 bcik go-librespot[3039]: time="2026-10-16T00:26:12+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:26:12 bcik go-librespot[3039]: time="2026-10-16T00:26:12+02:00" level=debug msg="app state loaded" Oct 16 00:26:12 bcik go-librespot[3039]: time="2026-10-16T00:26:12+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:26:12 bcik go-librespot[3039]: time="2026-10-16T00:26:12+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 16 00:26:12 bcik go-librespot[3039]: time="2026-10-16T00:26:12+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 16 00:26:12 bcik go-librespot[3039]: time="2026-10-16T00:26:12+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 16 00:26:12 bcik go-librespot[3039]: time="2026-10-16T00:26:12+02:00" level=info msg="zeroconf server listening on port 44203" Oct 16 00:26:12 bcik go-librespot[3039]: time="2026-10-16T00:26:12+02:00" level=debug msg="obtained new client token: AAGjE+3/YTx9lp66tS8YBCvYQI6jrNv4SOD4zRRQlQObX0PL4YaF2ITqXdXPeKgdMvMCIFDex35BGdxIxHcPyGjuJ2xmCOJPouYfNFi+ma9HeTukDrBGXj+MqoJpxQufcecryqzn98tiHxgmIojtqWCpUBQDYbbBGfE00J5QJVXq2SOHaYHuQCnMSNMIXxUR6RC8L5EMIp1Vr5pkimvnshul5Z+wRXcco8H9R6pg6+S6VAldHdSPWIg=" Oct 16 00:26:12 bcik go-librespot[3039]: time="2026-10-16T00:26:12+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 16 00:26:12 bcik go-librespot[3039]: time="2026-10-16T00:26:12+02:00" level=debug msg="completed keyexchange" Oct 16 00:26:12 bcik go-librespot[3039]: time="2026-10-16T00:26:12+02:00" level=debug msg="completed challenge" Oct 16 00:26:12 bcik go-librespot[3039]: time="2026-10-16T00:26:12+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:26:12 bcik go-librespot[3039]: time="2026-10-16T00:26:12+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:26:12 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:26:12 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:26:13 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 00:26:13 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 00:26:13 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 16 00:26:13 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 16 00:26:13 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 16 00:26:13 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 16 00:26:13 bcik volumio[2628]: info: CoreCommandRouter::volumioGetBrowseSources Oct 16 00:26:13 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 00:26:13 bcik volumio[2628]: error: MyVolumio Plugin failed to authenticate in a timely fashion Oct 16 00:26:13 bcik volumio[2628]: info: Completed starting MyVolumio Plugin Oct 16 00:26:13 bcik volumio[2628]: [Metrics] CommandRouter: 30s 782.88ms Oct 16 00:26:13 bcik volumio[2628]: info: CoreCommandRouter::volumiosetStartupVolume Oct 16 00:26:13 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 00:26:13 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 00:26:13 bcik volumio[2628]: info: CoreCommandRouter::Close All Modals sent Oct 16 00:26:13 bcik volumio[2628]: info: CoreCommandRouter::Close All Modals sent Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 16 00:26:14 bcik volumio-remote-updater[9031]: Test mode disabled Oct 16 00:26:14 bcik volumio-remote-updater[9031]: Alpha mode disabled Oct 16 00:26:14 bcik volumio-remote-updater[9031]: Alpha legacy test mode disabled Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 16 00:26:14 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:14 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:26:14 bcik volumio5-onboarding[2829]: failed to bootstrap state: failed to check for software update: could not check for updates: context deadline exceeded Oct 16 00:26:14 bcik systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:26:14 bcik systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Oct 16 00:26:14 bcik systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 352. Oct 16 00:26:14 bcik systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 16 00:26:14 bcik systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 16 00:26:14 bcik volumio5-onboarding[3068]: time=2026-10-16T00:26:14.584+02:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z Oct 16 00:26:14 bcik volumio[2628]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Oct 16 00:26:14 bcik volumio[2628]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Oct 16 00:26:14 bcik volumio[2628]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 16 00:26:14 bcik volumio[2628]: info: Received Get System Info Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 00:26:14 bcik volumio[2628]: info: Discovery: Getting this device information Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::volumioGetState Oct 16 00:26:14 bcik volumio[2628]: info: CorePlayQueue::getTrack 0 Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 00:26:14 bcik volumio5-onboarding[3068]: time=2026-10-16T00:26:14.602+02:00 level=INFO msg="system info for 7d49fb3f7a1eba2a5cb01ee26de5f650" deviceName=BÄ…cik deviceVariant=volumio deviceModel= softwareVersion=4.119 Oct 16 00:26:14 bcik volumio5-onboarding[3068]: time=2026-10-16T00:26:14.609+02:00 level=INFO msg="bootstrapping state" hasInternet=true Oct 16 00:26:14 bcik volumio[2628]: info: Received Get System Info Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 00:26:14 bcik volumio[2628]: info: Discovery: Getting this device information Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::volumioGetState Oct 16 00:26:14 bcik volumio[2628]: info: CorePlayQueue::getTrack 0 Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 00:26:14 bcik volumio-remote-updater[9031]: Test mode disabled Oct 16 00:26:14 bcik volumio-remote-updater[9031]: Alpha mode disabled Oct 16 00:26:14 bcik volumio-remote-updater[9031]: Alpha legacy test mode disabled Oct 16 00:26:14 bcik volumio[2628]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 00:26:14 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 16 00:26:15 bcik volumio5-onboarding[3068]: time=2026-10-16T00:26:15.393+02:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=tidal error="could not open plugin config file for \"tidal\": open /data/configuration/music_service/tidal/config.json: no such file or directory" Oct 16 00:26:15 bcik volumio5-onboarding[3068]: time=2026-10-16T00:26:15.393+02:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=qobuz error="could not open plugin config file for \"qobuz\": open /data/configuration/music_service/qobuz/config.json: no such file or directory" Oct 16 00:26:15 bcik volumio5-onboarding[3068]: time=2026-10-16T00:26:15.393+02:00 level=WARN msg="could not read username/password data for music provider" component=volumio provider=hi_res_audio error="could not open plugin config file for \"hi_res_audio\": open /data/configuration/music_service/hi_res_audio/config.json: no such file or directory" Oct 16 00:26:15 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 00:26:15 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 00:26:15 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 16 00:26:15 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 00:26:15 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 16 00:26:15 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2345. Oct 16 00:26:15 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:15 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:15 bcik go-librespot[3080]: go-librespot daemon starting... Oct 16 00:26:15 bcik go-librespot[3081]: time="2026-10-16T00:26:15+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:26:15 bcik go-librespot[3081]: time="2026-10-16T00:26:15+02:00" level=debug msg="app state loaded" Oct 16 00:26:15 bcik go-librespot[3081]: time="2026-10-16T00:26:15+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:26:15 bcik go-librespot[3081]: time="2026-10-16T00:26:15+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 16 00:26:15 bcik go-librespot[3081]: time="2026-10-16T00:26:15+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 16 00:26:15 bcik go-librespot[3081]: time="2026-10-16T00:26:15+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 16 00:26:15 bcik go-librespot[3081]: time="2026-10-16T00:26:15+02:00" level=info msg="zeroconf server listening on port 40463" Oct 16 00:26:15 bcik go-librespot[3081]: time="2026-10-16T00:26:15+02:00" level=debug msg="obtained new client token: AAENuS2e3dBX1Q8MrK16LidL5ItYVqt+9c3fHM3Ip3ddSJ9ke5fttOl+gE1D2OOkddHLe05Hj9d4qa5CAHv9/X6TappFbyaK1u/VWsiRHCsDeGTleuTHuu79axqY0BfLgNm26uKCarseTMO8AD2gMoMbCIk1nGuetqinPu3+VDnAQx1rrh8klOAtWMCusBl19kyp+rZ3k7WzFe94ZnYHkj2oa2p1BejrhE6NgX59aVmwPntsB1xY0J4=" Oct 16 00:26:16 bcik go-librespot[3081]: time="2026-10-16T00:26:16+02:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.1.133:4070: connect: connection refused" Oct 16 00:26:16 bcik go-librespot[3081]: time="2026-10-16T00:26:16+02:00" level=debug msg="connected to ap-gew4.spotify.com:443" Oct 16 00:26:16 bcik go-librespot[3081]: time="2026-10-16T00:26:16+02:00" level=debug msg="completed keyexchange" Oct 16 00:26:16 bcik go-librespot[3081]: time="2026-10-16T00:26:16+02:00" level=debug msg="completed challenge" Oct 16 00:26:16 bcik go-librespot[3081]: time="2026-10-16T00:26:16+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:26:16 bcik go-librespot[3081]: time="2026-10-16T00:26:16+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:26:16 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:26:16 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:26:16 bcik volumio5-onboarding[3068]: time=2026-10-16T00:26:16.473+02:00 level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=9ixt1umkBgVYLY7gQzekBTAkTI72 tokenExpiry=2026-10-16T01:26:16.473+02:00 Oct 16 00:26:17 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:17 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:26:17 bcik volumio[2628]: info: Received Get System Info Oct 16 00:26:17 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 00:26:17 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 00:26:17 bcik volumio[2628]: info: Discovery: Getting this device information Oct 16 00:26:17 bcik volumio[2628]: info: CoreCommandRouter::volumioGetState Oct 16 00:26:17 bcik volumio[2628]: info: CorePlayQueue::getTrack 0 Oct 16 00:26:17 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 00:26:17 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 00:26:17 bcik volumio[2628]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 00:26:17 bcik volumio5-onboarding[3068]: time=2026-10-16T00:26:17.597+02:00 level=INFO msg="enabling local network discovery" Oct 16 00:26:17 bcik volumio5-onboarding[3068]: time=2026-10-16T00:26:17.604+02:00 level=INFO msg="enabling BLE discovery" Oct 16 00:26:18 bcik volumio5-onboarding[3068]: time=2026-10-16T00:26:18.396+02:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 16 00:26:19 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2346. Oct 16 00:26:19 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:19 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:19 bcik go-librespot[3092]: go-librespot daemon starting... Oct 16 00:26:19 bcik go-librespot[3093]: time="2026-10-16T00:26:19+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:26:19 bcik go-librespot[3093]: time="2026-10-16T00:26:19+02:00" level=debug msg="app state loaded" Oct 16 00:26:19 bcik go-librespot[3093]: time="2026-10-16T00:26:19+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:26:19 bcik go-librespot[3093]: time="2026-10-16T00:26:19+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 16 00:26:19 bcik go-librespot[3093]: time="2026-10-16T00:26:19+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 16 00:26:19 bcik go-librespot[3093]: time="2026-10-16T00:26:19+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 16 00:26:19 bcik go-librespot[3093]: time="2026-10-16T00:26:19+02:00" level=info msg="zeroconf server listening on port 41015" Oct 16 00:26:19 bcik go-librespot[3093]: time="2026-10-16T00:26:19+02:00" level=debug msg="obtained new client token: AAHJfJOmXx+TfkckcabTNaoMblEqSrmCiQ1FI54Md2I4e6m56B4m5uRHkkGaKRzWPEh5u+mZT5o5jptfZTIizmv+RVJVEGGRWs0XL6reDWq+bS1EMhwME0OsHZ/jIYE/B4JRGIrfKNpSk0n2e+otLZZHUt9aDiiO6DD/sm5YS/+mWsAZalVBeP5gmRG9YUG8Tm5KUjHRfSBaGxS8XhwIS6MZHRaIQJ0Q7WvLXmaINEWlmi1usQzvQec=" Oct 16 00:26:19 bcik go-librespot[3093]: time="2026-10-16T00:26:19+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 16 00:26:19 bcik go-librespot[3093]: time="2026-10-16T00:26:19+02:00" level=debug msg="completed keyexchange" Oct 16 00:26:19 bcik go-librespot[3093]: time="2026-10-16T00:26:19+02:00" level=debug msg="completed challenge" Oct 16 00:26:19 bcik go-librespot[3093]: time="2026-10-16T00:26:19+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:26:19 bcik go-librespot[3093]: time="2026-10-16T00:26:19+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:26:19 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:26:19 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:26:20 bcik volumio[2628]: info: BOOT COMPLETED Oct 16 00:26:20 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:20 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:26:22 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2347. Oct 16 00:26:22 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:22 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:22 bcik go-librespot[3102]: go-librespot daemon starting... Oct 16 00:26:22 bcik go-librespot[3103]: time="2026-10-16T00:26:22+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:26:22 bcik go-librespot[3103]: time="2026-10-16T00:26:22+02:00" level=debug msg="app state loaded" Oct 16 00:26:22 bcik go-librespot[3103]: time="2026-10-16T00:26:22+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:26:22 bcik go-librespot[3103]: time="2026-10-16T00:26:22+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 16 00:26:22 bcik go-librespot[3103]: time="2026-10-16T00:26:22+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 16 00:26:22 bcik go-librespot[3103]: time="2026-10-16T00:26:22+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 16 00:26:22 bcik go-librespot[3103]: time="2026-10-16T00:26:22+02:00" level=info msg="zeroconf server listening on port 41291" Oct 16 00:26:22 bcik go-librespot[3103]: time="2026-10-16T00:26:22+02:00" level=debug msg="obtained new client token: AAE36n1m9KhYSrIKHK9ufCzd9ow7C7Hj81W08EY/cnMGw82jewOBmN9AhBBSpvZXGfyijuWfZMI/s++NPWtjlZOyauRc7a8hxHzQhBFG0lJxa4FnD+vdZSY04n0WErALHNCXMSdQZLtjbJC6AywzoSVdLZruR8i7aA5OZ3qkXh97dqAIYslFCbsGTQU2twl9wYKGisz0/MXXkSVoxVliYpsYD+nLvCvyAaAXG1jNu5X2kWCdqWIbUG4=" Oct 16 00:26:23 bcik go-librespot[3103]: time="2026-10-16T00:26:23+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 16 00:26:23 bcik go-librespot[3103]: time="2026-10-16T00:26:23+02:00" level=debug msg="completed keyexchange" Oct 16 00:26:23 bcik go-librespot[3103]: time="2026-10-16T00:26:23+02:00" level=debug msg="completed challenge" Oct 16 00:26:23 bcik go-librespot[3103]: time="2026-10-16T00:26:23+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:26:23 bcik go-librespot[3103]: time="2026-10-16T00:26:23+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:26:23 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:26:23 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:26:23 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:23 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:26:26 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:26 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:26:26 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2348. Oct 16 00:26:26 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:26 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:26 bcik go-librespot[3126]: go-librespot daemon starting... Oct 16 00:26:26 bcik go-librespot[3127]: time="2026-10-16T00:26:26+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:26:26 bcik go-librespot[3127]: time="2026-10-16T00:26:26+02:00" level=debug msg="app state loaded" Oct 16 00:26:26 bcik go-librespot[3127]: time="2026-10-16T00:26:26+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:26:26 bcik go-librespot[3127]: time="2026-10-16T00:26:26+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 16 00:26:26 bcik go-librespot[3127]: time="2026-10-16T00:26:26+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 16 00:26:26 bcik go-librespot[3127]: time="2026-10-16T00:26:26+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 16 00:26:26 bcik go-librespot[3127]: time="2026-10-16T00:26:26+02:00" level=info msg="zeroconf server listening on port 35629" Oct 16 00:26:26 bcik go-librespot[3127]: time="2026-10-16T00:26:26+02:00" level=debug msg="obtained new client token: AAHUz1ng+aqaDDA37t89/OR8Ao2Up2SQaudPkVMCgzDeyDwfUO23vq/Q2a7IeQQoCIyW7IOJgupXSaI5SMtwlsYuBSPi9Imh1licI4Vw5KtOPnxeBUXJx3Cmt+vbTla99iaULwzPu9YmUIZFh9uCbNpstkWfBjftVxZZ+eXZHauU5ShNHFA70PtZRVHHBG3dev7QdiZZ5gKugjd/W78HA6xiyBJSEOl0CGWlZmA+I1mWJPkpQj2Hcj8=" Oct 16 00:26:26 bcik go-librespot[3127]: time="2026-10-16T00:26:26+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 16 00:26:26 bcik go-librespot[3127]: time="2026-10-16T00:26:26+02:00" level=debug msg="completed keyexchange" Oct 16 00:26:26 bcik go-librespot[3127]: time="2026-10-16T00:26:26+02:00" level=debug msg="completed challenge" Oct 16 00:26:26 bcik go-librespot[3127]: time="2026-10-16T00:26:26+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:26:26 bcik go-librespot[3127]: time="2026-10-16T00:26:26+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:26:26 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:26:26 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:26:29 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:29 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:26:29 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2349. Oct 16 00:26:29 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:29 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:29 bcik go-librespot[3136]: go-librespot daemon starting... Oct 16 00:26:29 bcik go-librespot[3137]: time="2026-10-16T00:26:29+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:26:29 bcik go-librespot[3137]: time="2026-10-16T00:26:29+02:00" level=debug msg="app state loaded" Oct 16 00:26:29 bcik go-librespot[3137]: time="2026-10-16T00:26:29+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:26:29 bcik go-librespot[3137]: time="2026-10-16T00:26:29+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 16 00:26:29 bcik go-librespot[3137]: time="2026-10-16T00:26:29+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 16 00:26:29 bcik go-librespot[3137]: time="2026-10-16T00:26:29+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 16 00:26:29 bcik go-librespot[3137]: time="2026-10-16T00:26:29+02:00" level=info msg="zeroconf server listening on port 46287" Oct 16 00:26:30 bcik go-librespot[3137]: time="2026-10-16T00:26:30+02:00" level=debug msg="obtained new client token: AAEM3bKMujeQzZodi9aKhg8iyDelvXYVkSgixhMdHwUoSsvsbguUQNo4OdvVoirNcWhJp7whFZUz/p5MyAFmTM64KafrfVrxGIxlR8mCyHz0mkKuRrwZf48unfUmToPu2rzrLo61PeHHFR/YWpKphod0x+rd3FYadhaICaiA2OGvVDNn8X42zHEWFqPUJc/nR1YdfwxUiJ7fhsz6xuS7rvkgtoiNx6UPc3v9mm2Vis3kDhmBgWhS6OA=" Oct 16 00:26:30 bcik go-librespot[3137]: time="2026-10-16T00:26:30+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 16 00:26:30 bcik go-librespot[3137]: time="2026-10-16T00:26:30+02:00" level=debug msg="completed keyexchange" Oct 16 00:26:30 bcik go-librespot[3137]: time="2026-10-16T00:26:30+02:00" level=debug msg="completed challenge" Oct 16 00:26:30 bcik go-librespot[3137]: time="2026-10-16T00:26:30+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:26:30 bcik go-librespot[3137]: time="2026-10-16T00:26:30+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:26:30 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:26:30 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:26:32 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:32 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:26:33 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2350. Oct 16 00:26:33 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:33 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:33 bcik go-librespot[3161]: go-librespot daemon starting... Oct 16 00:26:33 bcik go-librespot[3162]: time="2026-10-16T00:26:33+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:26:33 bcik go-librespot[3162]: time="2026-10-16T00:26:33+02:00" level=debug msg="app state loaded" Oct 16 00:26:33 bcik go-librespot[3162]: time="2026-10-16T00:26:33+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:26:33 bcik go-librespot[3162]: time="2026-10-16T00:26:33+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 16 00:26:33 bcik go-librespot[3162]: time="2026-10-16T00:26:33+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 16 00:26:33 bcik go-librespot[3162]: time="2026-10-16T00:26:33+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 16 00:26:33 bcik go-librespot[3162]: time="2026-10-16T00:26:33+02:00" level=info msg="zeroconf server listening on port 34429" Oct 16 00:26:33 bcik go-librespot[3162]: time="2026-10-16T00:26:33+02:00" level=debug msg="obtained new client token: AAFBbycTx6Jxs7Izu1r+yAJ4BoVPxHJg/4JS0WqHw7ryEAOImBAc9r6UOtqufNML4INrDmtOMdIzxHBYTfC2+gU0YnVs550/CYAewnKtInpS3CxaA6BtBsiHhQqoDnVMlSXzR4hSQRTODuFFKa+gT4Ew05Uxu9G/G6bQr7KSvRwAqQj7dekeDmWeWDiXKwtJIsidrQWBiM88ZbgQ60C1fkiInc5WIUpfogsmNWicyrPbYZKbUvPu+oU=" Oct 16 00:26:33 bcik go-librespot[3162]: time="2026-10-16T00:26:33+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 16 00:26:33 bcik go-librespot[3162]: time="2026-10-16T00:26:33+02:00" level=debug msg="completed keyexchange" Oct 16 00:26:33 bcik go-librespot[3162]: time="2026-10-16T00:26:33+02:00" level=debug msg="completed challenge" Oct 16 00:26:33 bcik go-librespot[3162]: time="2026-10-16T00:26:33+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:26:33 bcik go-librespot[3162]: time="2026-10-16T00:26:33+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:26:33 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:26:33 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:26:35 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:35 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:26:36 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2351. Oct 16 00:26:36 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:36 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:36 bcik go-librespot[3172]: go-librespot daemon starting... Oct 16 00:26:36 bcik go-librespot[3173]: time="2026-10-16T00:26:36+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:26:36 bcik go-librespot[3173]: time="2026-10-16T00:26:36+02:00" level=debug msg="app state loaded" Oct 16 00:26:36 bcik go-librespot[3173]: time="2026-10-16T00:26:36+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:26:36 bcik go-librespot[3173]: time="2026-10-16T00:26:36+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 16 00:26:36 bcik go-librespot[3173]: time="2026-10-16T00:26:36+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 16 00:26:36 bcik go-librespot[3173]: time="2026-10-16T00:26:36+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 16 00:26:36 bcik go-librespot[3173]: time="2026-10-16T00:26:36+02:00" level=info msg="zeroconf server listening on port 42905" Oct 16 00:26:36 bcik go-librespot[3173]: time="2026-10-16T00:26:36+02:00" level=debug msg="obtained new client token: AAFYR4w+pgN9GTonYVwh7MupsqJIf3M+xi/HD5IJvFV6iHysHiOpSOCyJpoX5TJz+1u+Fy1pijyUE165VxJ7ZLGi1GwTRIh+Lf57vPu8htBoxR5Q97FNrjDCX22NMYwlU99TqrsGrF5EQYokm7ZhL7SVgL4c02JLaZz0X4me8foDoAFs1neDZioCjom4fAywvJDNNLu41oCcr+Liaep6SpP8IkgQd02CPpjj9mlBa/OUpAHlzpg4h2g=" Oct 16 00:26:37 bcik go-librespot[3173]: time="2026-10-16T00:26:37+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 16 00:26:37 bcik go-librespot[3173]: time="2026-10-16T00:26:37+02:00" level=debug msg="completed keyexchange" Oct 16 00:26:37 bcik go-librespot[3173]: time="2026-10-16T00:26:37+02:00" level=debug msg="completed challenge" Oct 16 00:26:37 bcik go-librespot[3173]: time="2026-10-16T00:26:37+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:26:37 bcik go-librespot[3173]: time="2026-10-16T00:26:37+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:26:37 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:26:37 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:26:38 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:38 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:26:40 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2352. Oct 16 00:26:40 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:40 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:40 bcik go-librespot[3182]: go-librespot daemon starting... Oct 16 00:26:40 bcik go-librespot[3183]: time="2026-10-16T00:26:40+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:26:40 bcik go-librespot[3183]: time="2026-10-16T00:26:40+02:00" level=debug msg="app state loaded" Oct 16 00:26:40 bcik go-librespot[3183]: time="2026-10-16T00:26:40+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:26:40 bcik go-librespot[3183]: time="2026-10-16T00:26:40+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 16 00:26:40 bcik go-librespot[3183]: time="2026-10-16T00:26:40+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 16 00:26:40 bcik go-librespot[3183]: time="2026-10-16T00:26:40+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 16 00:26:40 bcik go-librespot[3183]: time="2026-10-16T00:26:40+02:00" level=info msg="zeroconf server listening on port 42385" Oct 16 00:26:40 bcik go-librespot[3183]: time="2026-10-16T00:26:40+02:00" level=debug msg="obtained new client token: AAHuDy0nEE+Ney53MJi1dEIXmhdLZ7o0ZB6aoEEfOLOZvg+u909Db/0/gfFmGoGZCf5N1TX4o8BBEJstigxB4BhwnrJ3iH+s6XLttCjCXP6Clfj/Dnvr5hZdbudJzMpaZe9MfogudfVtpeDXWNAnpajzY6zQfmrTqWWPYY6a0MOhxJkUDrUxBKHkxCkNSr9V6mzO00RgFLFVX/vP2VKd/5mYRZW2P4N4eHoME6rclW8z/BpevSDFDZc=" Oct 16 00:26:40 bcik go-librespot[3183]: time="2026-10-16T00:26:40+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 16 00:26:40 bcik go-librespot[3183]: time="2026-10-16T00:26:40+02:00" level=debug msg="completed keyexchange" Oct 16 00:26:40 bcik go-librespot[3183]: time="2026-10-16T00:26:40+02:00" level=debug msg="completed challenge" Oct 16 00:26:40 bcik go-librespot[3183]: time="2026-10-16T00:26:40+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:26:40 bcik go-librespot[3183]: time="2026-10-16T00:26:40+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:26:40 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:26:40 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:26:41 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:41 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:26:43 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2353. Oct 16 00:26:43 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:43 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:43 bcik go-librespot[3207]: go-librespot daemon starting... Oct 16 00:26:43 bcik go-librespot[3208]: time="2026-10-16T00:26:43+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:26:43 bcik go-librespot[3208]: time="2026-10-16T00:26:43+02:00" level=debug msg="app state loaded" Oct 16 00:26:43 bcik go-librespot[3208]: time="2026-10-16T00:26:43+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:26:43 bcik go-librespot[3208]: time="2026-10-16T00:26:43+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 16 00:26:43 bcik go-librespot[3208]: time="2026-10-16T00:26:43+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 16 00:26:43 bcik go-librespot[3208]: time="2026-10-16T00:26:43+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 16 00:26:43 bcik go-librespot[3208]: time="2026-10-16T00:26:43+02:00" level=info msg="zeroconf server listening on port 44781" Oct 16 00:26:43 bcik go-librespot[3208]: time="2026-10-16T00:26:43+02:00" level=debug msg="obtained new client token: AAFDsGPpLKiNn+LoZ937uqXFXJZs7Nr6KoUYQjGq6vdtGeuOTNUQFGodqqt/8PCAA4w2lgbSnBz+x6i55u1mAA9JNPX6Qoq2S0/+CmOMmE4+gzj4M5vP4Kwe+cjzpILehXgk8zQT2YtirYNUoRA27dYXvA1VsFQCGsSaixG/nxKQ9DwnfOzNLBcKLnp6wfwPi9tsezirWRzE/q1xmsPlpM1YokNBNLt4NsLRNLxydfQfs2zxxoMTQTw=" Oct 16 00:26:44 bcik go-librespot[3208]: time="2026-10-16T00:26:44+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 16 00:26:44 bcik go-librespot[3208]: time="2026-10-16T00:26:44+02:00" level=debug msg="completed keyexchange" Oct 16 00:26:44 bcik go-librespot[3208]: time="2026-10-16T00:26:44+02:00" level=debug msg="completed challenge" Oct 16 00:26:44 bcik go-librespot[3208]: time="2026-10-16T00:26:44+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:26:44 bcik go-librespot[3208]: time="2026-10-16T00:26:44+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:26:44 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:26:44 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:26:44 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:44 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:26:47 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2354. Oct 16 00:26:47 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:47 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:47 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:26:47 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:47 bcik go-librespot[3217]: go-librespot daemon starting... Oct 16 00:26:47 bcik go-librespot[3218]: time="2026-10-16T00:26:47+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:26:47 bcik go-librespot[3218]: time="2026-10-16T00:26:47+02:00" level=debug msg="app state loaded" Oct 16 00:26:47 bcik go-librespot[3218]: time="2026-10-16T00:26:47+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:26:47 bcik go-librespot[3218]: time="2026-10-16T00:26:47+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 16 00:26:47 bcik go-librespot[3218]: time="2026-10-16T00:26:47+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 16 00:26:47 bcik go-librespot[3218]: time="2026-10-16T00:26:47+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 16 00:26:47 bcik go-librespot[3218]: time="2026-10-16T00:26:47+02:00" level=info msg="zeroconf server listening on port 37067" Oct 16 00:26:47 bcik go-librespot[3218]: time="2026-10-16T00:26:47+02:00" level=debug msg="obtained new client token: AAHBiUha0LM8DY94jt0xNkytkhXU5a1dXusvcy5SMcPGiUULAB8O7LzjpawDOj8iSbxuH714x7tbwhg7dbmXtfR3yC3VtTsPcKDB+0Rn6ZlnFbW8vrzgomK7fXMAyJ8rUTzQA5zEX/lAChL7nGTH6zRDTtwvhzXEX8oeJLWpQFalWldwBY52ZDmYWxVC12qkP/TSYIk5iWw3P3EuYJTKNES824LkfPwh4kmIR5UGm2ai9NWxxfF2hKo=" Oct 16 00:26:47 bcik go-librespot[3218]: time="2026-10-16T00:26:47+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 16 00:26:47 bcik go-librespot[3218]: time="2026-10-16T00:26:47+02:00" level=debug msg="completed keyexchange" Oct 16 00:26:47 bcik go-librespot[3218]: time="2026-10-16T00:26:47+02:00" level=debug msg="completed challenge" Oct 16 00:26:47 bcik go-librespot[3218]: time="2026-10-16T00:26:47+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:26:47 bcik go-librespot[3218]: time="2026-10-16T00:26:47+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:26:47 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:26:47 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:26:50 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:50 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:26:50 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2355. Oct 16 00:26:50 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:50 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:50 bcik go-librespot[3227]: go-librespot daemon starting... Oct 16 00:26:50 bcik go-librespot[3228]: time="2026-10-16T00:26:50+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:26:50 bcik go-librespot[3228]: time="2026-10-16T00:26:50+02:00" level=debug msg="app state loaded" Oct 16 00:26:50 bcik go-librespot[3228]: time="2026-10-16T00:26:50+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:26:50 bcik go-librespot[3228]: time="2026-10-16T00:26:50+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 16 00:26:50 bcik go-librespot[3228]: time="2026-10-16T00:26:50+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 16 00:26:50 bcik go-librespot[3228]: time="2026-10-16T00:26:50+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 16 00:26:50 bcik go-librespot[3228]: time="2026-10-16T00:26:50+02:00" level=info msg="zeroconf server listening on port 45615" Oct 16 00:26:50 bcik go-librespot[3228]: time="2026-10-16T00:26:50+02:00" level=debug msg="obtained new client token: AAGtaK3rkn5a/FAG20xRXkrdSidplfX5vtV+PwAET5sHPVGiTjd04RuQim4ge5J6GhjHC9S2X0lLIwOPFeB4fMjSpHPU8FhT+cIIRjO/nKkkut/+9oKjQJdzBs+fWGDKYuT1ooe4wrnrje5jp/pEuqwZxnGxSkcqfRS0nHyfQi0r+YtSz0ILZFnlrUIYyFuG449nmNPJAmuDiyxulnJ/sbxduAahWIdftPxBVUp5Ky6WZXAO74Gz0OQ=" Oct 16 00:26:51 bcik go-librespot[3228]: time="2026-10-16T00:26:51+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 16 00:26:51 bcik go-librespot[3228]: time="2026-10-16T00:26:51+02:00" level=debug msg="completed keyexchange" Oct 16 00:26:51 bcik go-librespot[3228]: time="2026-10-16T00:26:51+02:00" level=debug msg="completed challenge" Oct 16 00:26:51 bcik go-librespot[3228]: time="2026-10-16T00:26:51+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:26:51 bcik go-librespot[3228]: time="2026-10-16T00:26:51+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:26:51 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:26:51 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:26:53 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:53 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:26:54 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2356. Oct 16 00:26:54 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:54 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:54 bcik go-librespot[3251]: go-librespot daemon starting... Oct 16 00:26:54 bcik go-librespot[3252]: time="2026-10-16T00:26:54+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:26:54 bcik go-librespot[3252]: time="2026-10-16T00:26:54+02:00" level=debug msg="app state loaded" Oct 16 00:26:54 bcik go-librespot[3252]: time="2026-10-16T00:26:54+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:26:54 bcik go-librespot[3252]: time="2026-10-16T00:26:54+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 16 00:26:54 bcik go-librespot[3252]: time="2026-10-16T00:26:54+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 16 00:26:54 bcik go-librespot[3252]: time="2026-10-16T00:26:54+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 16 00:26:54 bcik go-librespot[3252]: time="2026-10-16T00:26:54+02:00" level=info msg="zeroconf server listening on port 41925" Oct 16 00:26:54 bcik go-librespot[3252]: time="2026-10-16T00:26:54+02:00" level=debug msg="obtained new client token: AAHpKF4g3PRj1Cd7jzJVPXFe+hH/CYGNLZpVEzErrAp7huvxwyHvgfg8ewTKhPkGiv2RoT/coue+yM6YqV8Z60+NIXR2YyoZESgYCaQRx8Dyocs6NhxbuVVtzJJql6etEqvqHbfZj4yloMkeUAt8U36IjKpq7Bip6OegViJoI9yFJMuTU5+RHP+UQOcUPmB6UpzSLhpK8HTXXR618q1xSEH+g5IFkQilz3fnj7lmVNWjpv/j59g4FHA=" Oct 16 00:26:54 bcik go-librespot[3252]: time="2026-10-16T00:26:54+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 16 00:26:54 bcik go-librespot[3252]: time="2026-10-16T00:26:54+02:00" level=debug msg="completed keyexchange" Oct 16 00:26:54 bcik go-librespot[3252]: time="2026-10-16T00:26:54+02:00" level=debug msg="completed challenge" Oct 16 00:26:54 bcik go-librespot[3252]: time="2026-10-16T00:26:54+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:26:54 bcik go-librespot[3252]: time="2026-10-16T00:26:54+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:26:54 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:26:54 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:26:56 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:56 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:26:57 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2357. Oct 16 00:26:57 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:57 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:26:57 bcik go-librespot[3262]: go-librespot daemon starting... Oct 16 00:26:57 bcik go-librespot[3263]: time="2026-10-16T00:26:57+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:26:57 bcik go-librespot[3263]: time="2026-10-16T00:26:57+02:00" level=debug msg="app state loaded" Oct 16 00:26:57 bcik go-librespot[3263]: time="2026-10-16T00:26:57+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:26:57 bcik go-librespot[3263]: time="2026-10-16T00:26:57+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 16 00:26:57 bcik go-librespot[3263]: time="2026-10-16T00:26:57+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 16 00:26:57 bcik go-librespot[3263]: time="2026-10-16T00:26:57+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 16 00:26:57 bcik go-librespot[3263]: time="2026-10-16T00:26:57+02:00" level=info msg="zeroconf server listening on port 45233" Oct 16 00:26:57 bcik go-librespot[3263]: time="2026-10-16T00:26:57+02:00" level=debug msg="obtained new client token: AAFnPBVBbpZn1Ftc3ln/Pk8eLXMu3/JlgIwifKBBBwY8/DFkwDOo5SxgGPg3kKrL3Z0WcCymeSEzUY+KIkjuD1feoKL9/6zwN3FHgCeYe2h/4dxxijxHKgMZ0NuKU6psRUCYIhZreLKVItIPWiDaL/y+dGZbS4I6N5Zqe2dHw4oN9+Jgchj0lfX777As+MjFEGm/wo7UbtUnCbgoCR6K5nzoJ1SLLJf3BdwAoSKep6ySJol59mYeNbw=" Oct 16 00:26:58 bcik go-librespot[3263]: time="2026-10-16T00:26:58+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 16 00:26:58 bcik go-librespot[3263]: time="2026-10-16T00:26:58+02:00" level=debug msg="completed keyexchange" Oct 16 00:26:58 bcik go-librespot[3263]: time="2026-10-16T00:26:58+02:00" level=debug msg="completed challenge" Oct 16 00:26:58 bcik go-librespot[3263]: time="2026-10-16T00:26:58+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:26:58 bcik go-librespot[3263]: time="2026-10-16T00:26:58+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:26:58 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:26:58 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:26:59 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:26:59 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:27:01 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2358. Oct 16 00:27:01 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:27:01 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:27:01 bcik go-librespot[3273]: go-librespot daemon starting... Oct 16 00:27:01 bcik go-librespot[3274]: time="2026-10-16T00:27:01+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:27:01 bcik go-librespot[3274]: time="2026-10-16T00:27:01+02:00" level=debug msg="app state loaded" Oct 16 00:27:01 bcik go-librespot[3274]: time="2026-10-16T00:27:01+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:27:01 bcik go-librespot[3274]: time="2026-10-16T00:27:01+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 16 00:27:01 bcik go-librespot[3274]: time="2026-10-16T00:27:01+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 16 00:27:01 bcik go-librespot[3274]: time="2026-10-16T00:27:01+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 16 00:27:01 bcik go-librespot[3274]: time="2026-10-16T00:27:01+02:00" level=info msg="zeroconf server listening on port 38261" Oct 16 00:27:01 bcik go-librespot[3274]: time="2026-10-16T00:27:01+02:00" level=debug msg="obtained new client token: AAFugvb+tofA8MYuSRCXHVo7SHP3oLoVrT+dw3mtdA4CqNu5KzQF0B754z70e8BEWGLE/SonI42fCcNCjulo706i+AFEU3ChKyaqQr4zaeGH9PZYsJ6QasD3rHNo86Rd4KXVvb88SXzr+y/23ze2fxTcmCfOqE/Cu10ilnqtIWz5IEjzIvYPMy8Y2QOSkNTp8J2nPFwHHH1APJz8fgVtmSgIeF12onuB4NjqB5JTFoXIxxBC5swazLg=" Oct 16 00:27:01 bcik go-librespot[3274]: time="2026-10-16T00:27:01+02:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.1.133:4070: connect: connection refused" Oct 16 00:27:01 bcik go-librespot[3274]: time="2026-10-16T00:27:01+02:00" level=debug msg="connected to ap-gew4.spotify.com:443" Oct 16 00:27:01 bcik go-librespot[3274]: time="2026-10-16T00:27:01+02:00" level=debug msg="completed keyexchange" Oct 16 00:27:01 bcik go-librespot[3274]: time="2026-10-16T00:27:01+02:00" level=debug msg="completed challenge" Oct 16 00:27:01 bcik go-librespot[3274]: time="2026-10-16T00:27:01+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:27:01 bcik go-librespot[3274]: time="2026-10-16T00:27:01+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:27:01 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:27:01 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:27:02 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:27:02 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:27:04 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2359. Oct 16 00:27:04 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:27:04 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:27:04 bcik go-librespot[3297]: go-librespot daemon starting... Oct 16 00:27:04 bcik go-librespot[3298]: time="2026-10-16T00:27:04+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:27:04 bcik go-librespot[3298]: time="2026-10-16T00:27:04+02:00" level=debug msg="app state loaded" Oct 16 00:27:04 bcik go-librespot[3298]: time="2026-10-16T00:27:04+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:27:04 bcik go-librespot[3298]: time="2026-10-16T00:27:04+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 16 00:27:04 bcik go-librespot[3298]: time="2026-10-16T00:27:04+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 16 00:27:04 bcik go-librespot[3298]: time="2026-10-16T00:27:04+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 16 00:27:04 bcik go-librespot[3298]: time="2026-10-16T00:27:04+02:00" level=info msg="zeroconf server listening on port 36111" Oct 16 00:27:04 bcik go-librespot[3298]: time="2026-10-16T00:27:04+02:00" level=debug msg="obtained new client token: AAHXKy5uJalobxc31IPbe2vjBkgyuIPUs8NM2mB2pN/TSpxtqk3PbbE9bpLELt24kQfm4cmdq/1M4dvB9jdqQRfTpyKLTLsj9tqDqRp4jWbLx8cq6biHnWaxF9PZT1WGqdkb8fpOiaPb+cVD3fUzeHLR8quzcM926pxG4hJTTElXLeJtZs0vUOay5SjrwHOOmnFMCm2l2IGOycoiVKEKWXQhXBS6sDEBljChQaVencjoQk0+tezfLJs=" Oct 16 00:27:05 bcik go-librespot[3298]: time="2026-10-16T00:27:05+02:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.1.133:4070: connect: connection refused" Oct 16 00:27:05 bcik go-librespot[3298]: time="2026-10-16T00:27:05+02:00" level=debug msg="connected to ap-gew4.spotify.com:443" Oct 16 00:27:05 bcik go-librespot[3298]: time="2026-10-16T00:27:05+02:00" level=debug msg="completed keyexchange" Oct 16 00:27:05 bcik go-librespot[3298]: time="2026-10-16T00:27:05+02:00" level=debug msg="completed challenge" Oct 16 00:27:05 bcik go-librespot[3298]: time="2026-10-16T00:27:05+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:27:05 bcik go-librespot[3298]: time="2026-10-16T00:27:05+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:27:05 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:27:05 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:27:05 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:27:05 bcik volumio[2628]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:27:08 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2360. Oct 16 00:27:08 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:27:08 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 00:27:08 bcik go-librespot[3307]: go-librespot daemon starting... Oct 16 00:27:08 bcik go-librespot[3308]: time="2026-10-16T00:27:08+02:00" level=info msg="running go-librespot 0.6.2" Oct 16 00:27:08 bcik go-librespot[3308]: time="2026-10-16T00:27:08+02:00" level=debug msg="app state loaded" Oct 16 00:27:08 bcik go-librespot[3308]: time="2026-10-16T00:27:08+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 00:27:08 bcik volumio[2628]: info: Initializing connection to go-librespot Websocket Oct 16 00:27:08 bcik go-librespot[3308]: time="2026-10-16T00:27:08+02:00" level=debug msg="new websocket client" Oct 16 00:27:08 bcik volumio[2628]: info: Connection to go-librespot Websocket established Oct 16 00:27:08 bcik go-librespot[3308]: time="2026-10-16T00:27:08+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 16 00:27:08 bcik go-librespot[3308]: time="2026-10-16T00:27:08+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 16 00:27:08 bcik go-librespot[3308]: time="2026-10-16T00:27:08+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 16 00:27:08 bcik go-librespot[3308]: time="2026-10-16T00:27:08+02:00" level=info msg="zeroconf server listening on port 36433" Oct 16 00:27:08 bcik go-librespot[3308]: time="2026-10-16T00:27:08+02:00" level=debug msg="obtained new client token: AAGN7j5cqo6qEpZqUaH67kQ2rLVEhhBuynEJG31piWbAJRJ9FzslUdnjgw0+3/4Jl8/fogMaRbmQgoEbaLuwsLtHRXebPoWh1igKgxFXbmVPTr5I12edHX90hL68HdgeFtHTvj1/8wPw+sBL9q1DqpIkoxuNijA5gMotRJ+gzDTCztRELtXsBhYKWSP61wfvn0bs2KO/ElPQ9Io+Dd1JjGTKNzGuvHbF+gj9TEQEnyDA4Gov+TtpIrg=" Oct 16 00:27:08 bcik go-librespot[3308]: time="2026-10-16T00:27:08+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 16 00:27:08 bcik go-librespot[3308]: time="2026-10-16T00:27:08+02:00" level=debug msg="completed keyexchange" Oct 16 00:27:08 bcik go-librespot[3308]: time="2026-10-16T00:27:08+02:00" level=debug msg="completed challenge" Oct 16 00:27:08 bcik go-librespot[3308]: time="2026-10-16T00:27:08+02:00" level=info msg="authenticated AP" username="la***pl" Oct 16 00:27:08 bcik go-librespot[3308]: time="2026-10-16T00:27:08+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 16 00:27:08 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 16 00:27:08 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 16 00:27:08 bcik volumio[2628]: info: Connection to go-librespot Websocket closed Oct 16 00:27:11 bcik volumio[2628]: info: Getting Spotify volume Oct 16 00:27:11 bcik volumio[2628]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 00:27:11 bcik volumio[2628]: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 16 00:27:11 bcik volumio[2628]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 16 00:27:11 bcik volumio[2628]: errno: -111, Oct 16 00:27:11 bcik volumio[2628]: code: 'ECONNREFUSED', Oct 16 00:27:11 bcik volumio[2628]: syscall: 'connect', Oct 16 00:27:11 bcik volumio[2628]: address: '127.0.0.1', Oct 16 00:27:11 bcik volumio[2628]: port: 9879, Oct 16 00:27:11 bcik volumio[2628]: response: undefined Oct 16 00:27:11 bcik volumio[2628]: } Oct 16 00:27:11 bcik volumio[2628]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 00:27:11 bcik sudo[3331]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-16 00:26' Oct 16 00:27:11 bcik sudo[3331]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"