-- Logs begin at Mon 2026-08-31 00:23:59 EEST, end at Mon 2026-08-31 20:02:39 EEST. -- Aug 31 20:01:00 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:01 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:01:01 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 16. Aug 31 20:01:01 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:01:01 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:01:01 olohuone go-librespot[32065]: go-librespot daemon starting... Aug 31 20:01:01 olohuone go-librespot[32065]: time="2026-08-31T20:01:01+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:01:01 olohuone go-librespot[32065]: time="2026-08-31T20:01:01+03:00" level=debug msg="app state loaded" Aug 31 20:01:01 olohuone go-librespot[32065]: time="2026-08-31T20:01:01+03:00" level=debug msg="stored credentials not found" Aug 31 20:01:01 olohuone go-librespot[32065]: time="2026-08-31T20:01:01+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:01:01 olohuone go-librespot[32065]: time="2026-08-31T20:01:01+03: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]" Aug 31 20:01:01 olohuone go-librespot[32065]: time="2026-08-31T20:01:01+03: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]" Aug 31 20:01:01 olohuone go-librespot[32065]: time="2026-08-31T20:01:01+03: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]" Aug 31 20:01:01 olohuone go-librespot[32065]: time="2026-08-31T20:01:01+03:00" level=info msg="zeroconf server listening on port 40799" Aug 31 20:01:01 olohuone go-librespot[32065]: time="2026-08-31T20:01:01+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:01:01 olohuone go-librespot[32065]: time="2026-08-31T20:01:01+03:00" level=debug msg="obtained new client token: AAEoepwKKC4qf5aw6VGPND7YVJOYRTeROjy+LiuscCHR9K0u0oFEkrJo59H9VkOTwO0731+OslQJJ/UDQmni9VHhI4n/4HM/ocnsJQqi/9igFwABVFujB2UyGnM3H2RAqfGHUvIBLeDlkhCtWsMl1yS2DKbTAR+q5DDIJNnGSKU1/GqPvRhHiG4WLyYhgE+eUuDDD1Hsh3smh3BDQWFQx+IzAp3gpKQWkCx/uhDAgeiG6DUsigkiykF8FQ==" Aug 31 20:01:01 olohuone go-librespot[32065]: time="2026-08-31T20:01:01+03: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" Aug 31 20:01:01 olohuone go-librespot[32065]: time="2026-08-31T20:01:01+03:00" level=debug msg="connected to ap-gew4.spotify.com:443" Aug 31 20:01:01 olohuone go-librespot[32065]: time="2026-08-31T20:01:01+03:00" level=debug msg="completed keyexchange" Aug 31 20:01:01 olohuone go-librespot[32065]: time="2026-08-31T20:01:01+03:00" level=debug msg="completed challenge" Aug 31 20:01:02 olohuone go-librespot[32065]: time="2026-08-31T20:01:02+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:01:02 olohuone go-librespot[32065]: time="2026-08-31T20:01:02+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:01:02 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:01:02 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:01:03 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:01:03 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:05 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:01:05 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 17. Aug 31 20:01:05 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:01:05 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:01:05 olohuone go-librespot[32087]: go-librespot daemon starting... Aug 31 20:01:05 olohuone go-librespot[32087]: time="2026-08-31T20:01:05+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:01:05 olohuone go-librespot[32087]: time="2026-08-31T20:01:05+03:00" level=debug msg="app state loaded" Aug 31 20:01:05 olohuone go-librespot[32087]: time="2026-08-31T20:01:05+03:00" level=debug msg="stored credentials not found" Aug 31 20:01:05 olohuone go-librespot[32087]: time="2026-08-31T20:01:05+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:01:05 olohuone go-librespot[32087]: time="2026-08-31T20:01:05+03: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]" Aug 31 20:01:05 olohuone go-librespot[32087]: time="2026-08-31T20:01:05+03: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]" Aug 31 20:01:05 olohuone go-librespot[32087]: time="2026-08-31T20:01:05+03: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]" Aug 31 20:01:05 olohuone go-librespot[32087]: time="2026-08-31T20:01:05+03:00" level=info msg="zeroconf server listening on port 37209" Aug 31 20:01:05 olohuone go-librespot[32087]: time="2026-08-31T20:01:05+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:01:05 olohuone go-librespot[32087]: time="2026-08-31T20:01:05+03:00" level=debug msg="obtained new client token: AAHkL1ILI+x9+iZGIIjQbV52bln/4pk75jh+lnaAB37DBRqViseJKhQLoYYQNNK4gaRc+nOQbs3nAA42cr33aTy6NGi5sc5cyHHOQKcljAhvM5hCoDvRALmwayMNIbT9PGkJ5oZuW6FRbCVte5HKyevRdlxyl9B0ycLiA8hkEFULGvvEm+S4Svo2b8eEGvwofQTry7yqnsZbYanqHPhIZJXOBbpsv2kQLb8McpOfa/yK8bGCqzt7gOjCRg==" Aug 31 20:01:05 olohuone go-librespot[32087]: time="2026-08-31T20:01:05+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 31 20:01:05 olohuone go-librespot[32087]: time="2026-08-31T20:01:05+03:00" level=debug msg="completed keyexchange" Aug 31 20:01:05 olohuone go-librespot[32087]: time="2026-08-31T20:01:05+03:00" level=debug msg="completed challenge" Aug 31 20:01:05 olohuone go-librespot[32087]: time="2026-08-31T20:01:05+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:01:05 olohuone go-librespot[32087]: time="2026-08-31T20:01:05+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:01:06 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:01:06 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:01:06 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:01:06 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:07 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 31 20:01:07 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 31 20:01:07 olohuone sudo[32096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 31 20:01:07 olohuone sudo[32096]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 20:01:07 olohuone sudo[32096]: pam_unix(sudo:session): session closed for user root Aug 31 20:01:07 olohuone sudo[32099]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 31 20:01:07 olohuone sudo[32099]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 20:01:07 olohuone sudo[32099]: pam_unix(sudo:session): session closed for user root Aug 31 20:01:07 olohuone volumio[717]: verbose: New Socket.io Connection to 192.168.1.189 from 192.168.1.24 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 11 Aug 31 20:01:07 olohuone sudo[32104]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 31 20:01:07 olohuone sudo[32104]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 20:01:07 olohuone sudo[32104]: pam_unix(sudo:session): session closed for user root Aug 31 20:01:07 olohuone sudo[32107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 31 20:01:07 olohuone sudo[32107]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 20:01:08 olohuone sudo[32107]: pam_unix(sudo:session): session closed for user root Aug 31 20:01:08 olohuone volumio[717]: verbose: New Socket.io Connection to 192.168.1.189 from 192.168.1.24 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 12 Aug 31 20:01:08 olohuone volumio[717]: info: CoreCommandRouter::volumioGetState Aug 31 20:01:08 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:08 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 31 20:01:08 olohuone volumio[717]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Aug 31 20:01:08 olohuone volumio[717]: info: Listing playlists Aug 31 20:01:08 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 31 20:01:08 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 31 20:01:08 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 31 20:01:08 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 31 20:01:09 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:01:09 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 18. Aug 31 20:01:09 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:01:09 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:01:09 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:01:09 olohuone go-librespot[32111]: go-librespot daemon starting... Aug 31 20:01:09 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:09 olohuone go-librespot[32111]: time="2026-08-31T20:01:09+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:01:09 olohuone go-librespot[32111]: time="2026-08-31T20:01:09+03:00" level=debug msg="app state loaded" Aug 31 20:01:09 olohuone go-librespot[32111]: time="2026-08-31T20:01:09+03:00" level=debug msg="stored credentials not found" Aug 31 20:01:09 olohuone go-librespot[32111]: time="2026-08-31T20:01:09+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:01:09 olohuone go-librespot[32111]: time="2026-08-31T20:01:09+03: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]" Aug 31 20:01:09 olohuone go-librespot[32111]: time="2026-08-31T20:01:09+03: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]" Aug 31 20:01:09 olohuone go-librespot[32111]: time="2026-08-31T20:01:09+03: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]" Aug 31 20:01:09 olohuone go-librespot[32111]: time="2026-08-31T20:01:09+03:00" level=info msg="zeroconf server listening on port 35099" Aug 31 20:01:09 olohuone go-librespot[32111]: time="2026-08-31T20:01:09+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:01:09 olohuone go-librespot[32111]: time="2026-08-31T20:01:09+03:00" level=debug msg="obtained new client token: AAG9HyiP4iGlblnb6zVaVigrKbfF/FYB7evGHMfbfCGoQh+Sbx+ItvGM7EYZClkNGxiW1pj3vBC+a2Gv5dccs9cj8qq5/73Lo1xZC0TGKzTPasnGxTPivskRf+PcNMvLTRIZmz7gf1vg8YcdZWAZ2VNJjxtvb5NyB9hMriadYCqxGW84eK09Seu4qs/2x1eyjjob/AFZde0pogvhVxbhXm1sYX0cuhoEf8yIO2noH7ebFrXRdCMHyL0CpA==" Aug 31 20:01:09 olohuone go-librespot[32111]: time="2026-08-31T20:01:09+03: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" Aug 31 20:01:09 olohuone go-librespot[32111]: time="2026-08-31T20:01:09+03:00" level=debug msg="connected to ap-gew4.spotify.com:443" Aug 31 20:01:09 olohuone go-librespot[32111]: time="2026-08-31T20:01:09+03:00" level=debug msg="completed keyexchange" Aug 31 20:01:09 olohuone go-librespot[32111]: time="2026-08-31T20:01:09+03:00" level=debug msg="completed challenge" Aug 31 20:01:09 olohuone go-librespot[32111]: time="2026-08-31T20:01:09+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:01:09 olohuone go-librespot[32111]: time="2026-08-31T20:01:09+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:01:09 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:01:09 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:01:11 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 20:01:11 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 20:01:11 olohuone volumio[717]: info: Discovery: Getting this device information Aug 31 20:01:11 olohuone volumio[717]: info: CoreCommandRouter::volumioGetState Aug 31 20:01:11 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:11 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 20:01:11 olohuone volumio[717]: verbose: New Socket.io Connection to 192.168.1.189:3000 from 192.168.1.24 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 13 Aug 31 20:01:11 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 31 20:01:11 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 31 20:01:12 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:01:12 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:13 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:01:13 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 19. Aug 31 20:01:13 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:01:13 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:01:13 olohuone go-librespot[32133]: go-librespot daemon starting... Aug 31 20:01:13 olohuone go-librespot[32133]: time="2026-08-31T20:01:13+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:01:13 olohuone go-librespot[32133]: time="2026-08-31T20:01:13+03:00" level=debug msg="app state loaded" Aug 31 20:01:13 olohuone go-librespot[32133]: time="2026-08-31T20:01:13+03:00" level=debug msg="stored credentials not found" Aug 31 20:01:13 olohuone go-librespot[32133]: time="2026-08-31T20:01:13+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:01:13 olohuone go-librespot[32133]: time="2026-08-31T20:01:13+03: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]" Aug 31 20:01:13 olohuone go-librespot[32133]: time="2026-08-31T20:01:13+03: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]" Aug 31 20:01:13 olohuone go-librespot[32133]: time="2026-08-31T20:01:13+03: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]" Aug 31 20:01:13 olohuone go-librespot[32133]: time="2026-08-31T20:01:13+03:00" level=info msg="zeroconf server listening on port 33999" Aug 31 20:01:13 olohuone go-librespot[32133]: time="2026-08-31T20:01:13+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:01:13 olohuone go-librespot[32133]: time="2026-08-31T20:01:13+03:00" level=debug msg="obtained new client token: AAGduawXE58zJ48PTjEjq58M6/Axi7enkjUXr/4Go2Ri5+xRiJ8KdJ/XFor5iqBi/H+ztB8b3Qs9ljyAybNJyoDYfd/wIVB3Dj5D7TpSaQDx2t6owVfyXYRd5yfEDxe2WlW1mc+7+vwZfpzMjZ7iDjhe4+vnMzi22cAfwggI4DoMyL8VRi/84NQUDRkzpakqz3LF90ejFgj1AfIN26q4U9QE1fYL0s3wHQ6LDmkshfpsHLni1jEyix0qlw==" Aug 31 20:01:13 olohuone go-librespot[32133]: time="2026-08-31T20:01:13+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 31 20:01:13 olohuone go-librespot[32133]: time="2026-08-31T20:01:13+03:00" level=debug msg="completed keyexchange" Aug 31 20:01:13 olohuone go-librespot[32133]: time="2026-08-31T20:01:13+03:00" level=debug msg="completed challenge" Aug 31 20:01:13 olohuone go-librespot[32133]: time="2026-08-31T20:01:13+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:01:13 olohuone go-librespot[32133]: time="2026-08-31T20:01:13+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:01:13 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:01:13 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:01:15 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:01:15 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:17 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:01:17 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20. Aug 31 20:01:17 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:01:17 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:01:17 olohuone go-librespot[32141]: go-librespot daemon starting... Aug 31 20:01:17 olohuone go-librespot[32141]: time="2026-08-31T20:01:17+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:01:17 olohuone go-librespot[32141]: time="2026-08-31T20:01:17+03:00" level=debug msg="app state loaded" Aug 31 20:01:17 olohuone go-librespot[32141]: time="2026-08-31T20:01:17+03:00" level=debug msg="stored credentials not found" Aug 31 20:01:17 olohuone go-librespot[32141]: time="2026-08-31T20:01:17+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:01:17 olohuone go-librespot[32141]: time="2026-08-31T20:01:17+03: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]" Aug 31 20:01:17 olohuone go-librespot[32141]: time="2026-08-31T20:01:17+03: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]" Aug 31 20:01:17 olohuone go-librespot[32141]: time="2026-08-31T20:01:17+03: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]" Aug 31 20:01:17 olohuone go-librespot[32141]: time="2026-08-31T20:01:17+03:00" level=info msg="zeroconf server listening on port 44861" Aug 31 20:01:17 olohuone go-librespot[32141]: time="2026-08-31T20:01:17+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:01:17 olohuone go-librespot[32141]: time="2026-08-31T20:01:17+03:00" level=debug msg="obtained new client token: AAGOBk6sAC74SiTPkEyTyOPEZ4vfRnuAzxy5dchnM4YfdcXBae2mYuIGoINU1edTqo8uE+Andgl75hnnp131MWzWKDjwrbOYvx3WQKVwHUhe0ADDUeFwjEXjFblMxZA9PSpKg8V1Iriw+GVC2IEj1O/8sgw5oA6LD8x7tiupdOfvIvXVWbyLbgez5xEJU8NVg0KH7NWTw2wGEjdIPCoV9YXzhP+CI6lnznRaozmIs7MS9AvVtF2h/sLjzQ==" Aug 31 20:01:17 olohuone go-librespot[32141]: time="2026-08-31T20:01:17+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 31 20:01:17 olohuone go-librespot[32141]: time="2026-08-31T20:01:17+03:00" level=debug msg="completed keyexchange" Aug 31 20:01:17 olohuone go-librespot[32141]: time="2026-08-31T20:01:17+03:00" level=debug msg="completed challenge" Aug 31 20:01:17 olohuone go-librespot[32141]: time="2026-08-31T20:01:17+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:01:17 olohuone go-librespot[32141]: time="2026-08-31T20:01:17+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:01:17 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:01:17 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:01:18 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:01:18 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:20 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Aug 31 20:01:20 olohuone volumio[717]: info: Playing Remote Device: http://192.168.1.189 Aug 31 20:01:20 olohuone volumio[717]: info: Aug 31 20:01:20 olohuone volumio[717]: ---------------------------- Client requests Volumio play Aug 31 20:01:20 olohuone volumio[717]: info: CoreCommandRouter::volumioPlay Aug 31 20:01:20 olohuone volumio[717]: info: CoreStateMachine::play index undefined Aug 31 20:01:20 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:01:20 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:20 olohuone volumio[717]: info: CoreStateMachine::startPlaybackTimer Aug 31 20:01:20 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:20 olohuone volumio[717]: info: [1788195680550] ControllerSpotify::clearAddPlayTrack Aug 31 20:01:20 olohuone volumio[717]: info: Sending Spotify command with payload to local API: /player/play Aug 31 20:01:20 olohuone volumio[717]: info: Done playing: Aug 31 20:01:20 olohuone volumio[717]: error: Failed to send command to Spotify local API: /player/play: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:21 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:01:21 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 21. Aug 31 20:01:21 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:01:21 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:01:21 olohuone go-librespot[32150]: go-librespot daemon starting... Aug 31 20:01:21 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:01:21 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:21 olohuone go-librespot[32150]: time="2026-08-31T20:01:21+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:01:21 olohuone go-librespot[32150]: time="2026-08-31T20:01:21+03:00" level=debug msg="app state loaded" Aug 31 20:01:21 olohuone go-librespot[32150]: time="2026-08-31T20:01:21+03:00" level=debug msg="stored credentials not found" Aug 31 20:01:21 olohuone go-librespot[32150]: time="2026-08-31T20:01:21+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:01:21 olohuone go-librespot[32150]: time="2026-08-31T20:01:21+03: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]" Aug 31 20:01:21 olohuone go-librespot[32150]: time="2026-08-31T20:01:21+03: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]" Aug 31 20:01:21 olohuone go-librespot[32150]: time="2026-08-31T20:01:21+03: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]" Aug 31 20:01:21 olohuone go-librespot[32150]: time="2026-08-31T20:01:21+03:00" level=info msg="zeroconf server listening on port 37717" Aug 31 20:01:21 olohuone go-librespot[32150]: time="2026-08-31T20:01:21+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:01:21 olohuone go-librespot[32150]: time="2026-08-31T20:01:21+03:00" level=debug msg="obtained new client token: AAGOFmDL2c3xrqeQG3xjH2jy/6Bfn/Am7lnuqmgCrpca2gQH3Qu2DmemqSUXTh/HiohfL9K9JNT3BXjvvAcQmo/VjMGqcUIqxChuwE/Ze1MQdGI6ZUCFbLGyMS52YWvtHfnQfsCMLOB37WnWWG//5gRRhNUKWTpKtbdD0c6tWxJDk/5DEgmQBIipleJJBrgfcksSLQiY2R29OFv4NKMsP0Zle5+0kmMOOvSTQaCWHOCF+qNmZr65EdGnzA==" Aug 31 20:01:21 olohuone go-librespot[32150]: time="2026-08-31T20:01:21+03: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" Aug 31 20:01:21 olohuone go-librespot[32150]: time="2026-08-31T20:01:21+03:00" level=debug msg="connected to ap-gew4.spotify.com:443" Aug 31 20:01:21 olohuone go-librespot[32150]: time="2026-08-31T20:01:21+03:00" level=debug msg="completed keyexchange" Aug 31 20:01:21 olohuone go-librespot[32150]: time="2026-08-31T20:01:21+03:00" level=debug msg="completed challenge" Aug 31 20:01:21 olohuone go-librespot[32150]: time="2026-08-31T20:01:21+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:01:21 olohuone go-librespot[32150]: time="2026-08-31T20:01:21+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:01:21 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:01:21 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:01:22 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Aug 31 20:01:22 olohuone volumio[717]: info: Playing Remote Device: http://192.168.1.189 Aug 31 20:01:22 olohuone volumio[717]: info: Aug 31 20:01:22 olohuone volumio[717]: ---------------------------- Client requests Volumio play Aug 31 20:01:22 olohuone volumio[717]: info: CoreCommandRouter::volumioPlay Aug 31 20:01:22 olohuone volumio[717]: info: CoreStateMachine::play index undefined Aug 31 20:01:22 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:01:22 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:22 olohuone volumio[717]: info: CoreStateMachine::startPlaybackTimer Aug 31 20:01:22 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:22 olohuone volumio[717]: info: [1788195682049] ControllerSpotify::clearAddPlayTrack Aug 31 20:01:22 olohuone volumio[717]: info: Sending Spotify command with payload to local API: /player/play Aug 31 20:01:22 olohuone volumio[717]: info: Done playing: Aug 31 20:01:22 olohuone volumio[717]: error: Failed to send command to Spotify local API: /player/play: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:24 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:01:24 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:24 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Aug 31 20:01:24 olohuone volumio[717]: info: Playing Remote Device: http://192.168.1.189 Aug 31 20:01:24 olohuone volumio[717]: info: Aug 31 20:01:24 olohuone volumio[717]: ---------------------------- Client requests Volumio play Aug 31 20:01:24 olohuone volumio[717]: info: CoreCommandRouter::volumioPlay Aug 31 20:01:24 olohuone volumio[717]: info: CoreStateMachine::play index undefined Aug 31 20:01:24 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:01:24 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:24 olohuone volumio[717]: info: CoreStateMachine::startPlaybackTimer Aug 31 20:01:24 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:24 olohuone volumio[717]: info: [1788195684846] ControllerSpotify::clearAddPlayTrack Aug 31 20:01:24 olohuone volumio[717]: info: Sending Spotify command with payload to local API: /player/play Aug 31 20:01:24 olohuone volumio[717]: info: Done playing: Aug 31 20:01:24 olohuone volumio[717]: error: Failed to send command to Spotify local API: /player/play: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:25 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:01:25 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 22. Aug 31 20:01:25 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:01:25 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:01:25 olohuone go-librespot[32173]: go-librespot daemon starting... Aug 31 20:01:25 olohuone go-librespot[32173]: time="2026-08-31T20:01:25+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:01:25 olohuone go-librespot[32173]: time="2026-08-31T20:01:25+03:00" level=debug msg="app state loaded" Aug 31 20:01:25 olohuone go-librespot[32173]: time="2026-08-31T20:01:25+03:00" level=debug msg="stored credentials not found" Aug 31 20:01:25 olohuone go-librespot[32173]: time="2026-08-31T20:01:25+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:01:25 olohuone go-librespot[32173]: time="2026-08-31T20:01:25+03: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]" Aug 31 20:01:25 olohuone go-librespot[32173]: time="2026-08-31T20:01:25+03: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]" Aug 31 20:01:25 olohuone go-librespot[32173]: time="2026-08-31T20:01:25+03: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]" Aug 31 20:01:25 olohuone go-librespot[32173]: time="2026-08-31T20:01:25+03:00" level=info msg="zeroconf server listening on port 39891" Aug 31 20:01:25 olohuone go-librespot[32173]: time="2026-08-31T20:01:25+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:01:25 olohuone go-librespot[32173]: time="2026-08-31T20:01:25+03:00" level=debug msg="obtained new client token: AAHgz3w6iXG9L5LNk0eVC79lKkWEQtLAXFGUuDh7co1uTTzZZ4zW2RWwlV4H/V0axRhOvq/PP6oKml62azH2Spc3KT2nWPBs7iMBGmWfMsUsyTSUubcRXwNC4ol7uwOUB4Xhv4oiy876I+LQ1OEGOh8aJ8rhIB3minc4lFwhT8/NKuqiIMHa82GPMPzn/aKsl0R/m2nNEHt/RnBaACHKCeWyLJmMBzinXuVInHFHlGAEuUVnVybuFvDgHg==" Aug 31 20:01:25 olohuone go-librespot[32173]: time="2026-08-31T20:01:25+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 31 20:01:25 olohuone go-librespot[32173]: time="2026-08-31T20:01:25+03:00" level=debug msg="completed keyexchange" Aug 31 20:01:25 olohuone go-librespot[32173]: time="2026-08-31T20:01:25+03:00" level=debug msg="completed challenge" Aug 31 20:01:25 olohuone go-librespot[32173]: time="2026-08-31T20:01:25+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:01:25 olohuone go-librespot[32173]: time="2026-08-31T20:01:25+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:01:25 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:01:25 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:01:26 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 31 20:01:26 olohuone volumio[717]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 31 20:01:26 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 31 20:01:26 olohuone volumio[717]: info: Received Get System Version Aug 31 20:01:26 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 31 20:01:26 olohuone volumio[717]: info: Received Get System Info Aug 31 20:01:26 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 20:01:26 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 20:01:26 olohuone volumio[717]: info: Discovery: Getting this device information Aug 31 20:01:26 olohuone volumio[717]: info: CoreCommandRouter::volumioGetState Aug 31 20:01:26 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:26 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 20:01:27 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:01:27 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:29 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:01:29 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 23. Aug 31 20:01:29 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:01:29 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:01:29 olohuone go-librespot[32182]: go-librespot daemon starting... Aug 31 20:01:29 olohuone go-librespot[32182]: time="2026-08-31T20:01:29+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:01:29 olohuone go-librespot[32182]: time="2026-08-31T20:01:29+03:00" level=debug msg="app state loaded" Aug 31 20:01:29 olohuone go-librespot[32182]: time="2026-08-31T20:01:29+03:00" level=debug msg="stored credentials not found" Aug 31 20:01:29 olohuone go-librespot[32182]: time="2026-08-31T20:01:29+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:01:29 olohuone go-librespot[32182]: time="2026-08-31T20:01:29+03: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]" Aug 31 20:01:29 olohuone go-librespot[32182]: time="2026-08-31T20:01:29+03: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]" Aug 31 20:01:29 olohuone go-librespot[32182]: time="2026-08-31T20:01:29+03: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]" Aug 31 20:01:29 olohuone go-librespot[32182]: time="2026-08-31T20:01:29+03:00" level=info msg="zeroconf server listening on port 38221" Aug 31 20:01:29 olohuone go-librespot[32182]: time="2026-08-31T20:01:29+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:01:29 olohuone go-librespot[32182]: time="2026-08-31T20:01:29+03:00" level=debug msg="obtained new client token: AAHNYUVW9irSYlzcphK8clrYQl1I29RhZ5SMQYtIoq69Y0Bz68S+b+gTfi5D6xJNMnfqG9nq55e8I46UNk1AzdG6LDVb+hHgV/m5pkKfxKJmYy3mSJ5Z3iPPoJ/LPv048FCnyY6rsmke220OCVusnxuwswigvVr0TTzhfOta8a4UPboGP3AGqY3f5WY27kpnXC9FCKbgDuT2pwzdcvmoAyrJqsDn/qkUqC0nEj65jq43Vb2rtkkoS/d/rg==" Aug 31 20:01:29 olohuone go-librespot[32182]: time="2026-08-31T20:01:29+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 31 20:01:29 olohuone go-librespot[32182]: time="2026-08-31T20:01:29+03:00" level=debug msg="completed keyexchange" Aug 31 20:01:29 olohuone go-librespot[32182]: time="2026-08-31T20:01:29+03:00" level=debug msg="completed challenge" Aug 31 20:01:29 olohuone go-librespot[32182]: time="2026-08-31T20:01:29+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:01:29 olohuone go-librespot[32182]: time="2026-08-31T20:01:29+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:01:29 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:01:29 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:01:30 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:01:30 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:33 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:01:33 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 24. Aug 31 20:01:33 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:01:33 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:01:33 olohuone go-librespot[32204]: go-librespot daemon starting... Aug 31 20:01:33 olohuone go-librespot[32204]: time="2026-08-31T20:01:33+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:01:33 olohuone go-librespot[32204]: time="2026-08-31T20:01:33+03:00" level=debug msg="app state loaded" Aug 31 20:01:33 olohuone go-librespot[32204]: time="2026-08-31T20:01:33+03:00" level=debug msg="stored credentials not found" Aug 31 20:01:33 olohuone go-librespot[32204]: time="2026-08-31T20:01:33+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:01:33 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:01:33 olohuone go-librespot[32204]: time="2026-08-31T20:01:33+03:00" level=debug msg="new websocket client" Aug 31 20:01:33 olohuone volumio[717]: info: Connection to go-librespot Websocket established Aug 31 20:01:33 olohuone go-librespot[32204]: time="2026-08-31T20:01:33+03: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]" Aug 31 20:01:33 olohuone go-librespot[32204]: time="2026-08-31T20:01:33+03: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]" Aug 31 20:01:33 olohuone go-librespot[32204]: time="2026-08-31T20:01:33+03: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]" Aug 31 20:01:33 olohuone go-librespot[32204]: time="2026-08-31T20:01:33+03:00" level=info msg="zeroconf server listening on port 46327" Aug 31 20:01:33 olohuone go-librespot[32204]: time="2026-08-31T20:01:33+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:01:33 olohuone go-librespot[32204]: time="2026-08-31T20:01:33+03:00" level=debug msg="obtained new client token: AAENDqpcI8iOZVPK3sOWjidklkLVDee6NnPBc4+c3bz2Agb+PwT1P0Di8UNzKxDu7ZQ74sgDI4NEqQ9rGhF39kVtUd7o+McF2jeNNsi+XofHUy8NwntS0kgTy6N8ak7jiJkkwsNhe7C6GzhfMPRO6t5Ogh/mEzs7VY/9WMbewi5xmDATiW6U8JDFoVXRpwNexPhIH+Q/Wr4pVl39MkaBWvUim7xlkQceFmYA18ILJHrNpOiz83OXr+tPHQ==" Aug 31 20:01:33 olohuone go-librespot[32204]: time="2026-08-31T20:01:33+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 31 20:01:33 olohuone go-librespot[32204]: time="2026-08-31T20:01:33+03:00" level=debug msg="completed keyexchange" Aug 31 20:01:33 olohuone go-librespot[32204]: time="2026-08-31T20:01:33+03:00" level=debug msg="completed challenge" Aug 31 20:01:33 olohuone go-librespot[32204]: time="2026-08-31T20:01:33+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:01:33 olohuone go-librespot[32204]: time="2026-08-31T20:01:33+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:01:33 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:01:33 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:01:33 olohuone volumio[717]: info: Connection to go-librespot Websocket closed Aug 31 20:01:36 olohuone volumio[717]: info: Getting Spotify volume Aug 31 20:01:36 olohuone volumio[717]: (node:717) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:36 olohuone volumio[717]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) Aug 31 20:01:36 olohuone volumio[717]: (node:717) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 21) Aug 31 20:01:36 olohuone volumio[717]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Aug 31 20:01:36 olohuone volumio[717]: info: CoreCommandRouter::volumioGetState Aug 31 20:01:36 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:36 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:01:36 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:01:36 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 25. Aug 31 20:01:36 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:01:36 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:36 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:01:36 olohuone go-librespot[32212]: go-librespot daemon starting... Aug 31 20:01:36 olohuone go-librespot[32212]: time="2026-08-31T20:01:36+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:01:36 olohuone go-librespot[32212]: time="2026-08-31T20:01:36+03:00" level=debug msg="app state loaded" Aug 31 20:01:36 olohuone go-librespot[32212]: time="2026-08-31T20:01:36+03:00" level=debug msg="stored credentials not found" Aug 31 20:01:36 olohuone go-librespot[32212]: time="2026-08-31T20:01:36+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:01:37 olohuone go-librespot[32212]: time="2026-08-31T20:01:37+03: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]" Aug 31 20:01:37 olohuone go-librespot[32212]: time="2026-08-31T20:01:37+03: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]" Aug 31 20:01:37 olohuone go-librespot[32212]: time="2026-08-31T20:01:37+03: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]" Aug 31 20:01:37 olohuone go-librespot[32212]: time="2026-08-31T20:01:37+03:00" level=info msg="zeroconf server listening on port 45233" Aug 31 20:01:37 olohuone go-librespot[32212]: time="2026-08-31T20:01:37+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:01:37 olohuone go-librespot[32212]: time="2026-08-31T20:01:37+03:00" level=debug msg="obtained new client token: AAH6ROBidppRA3MO7KxacdDyWOsMGvp//7p3mfXCwjacHkMZAT8Z+4Qj5K443JySiQe8C4tjdoxEj6h/+IC5pzXnOLTzweXGJS8I4SLB35ZxxrNpgjlO+TVY32PzquU3ZpaodS3mpWTmBnqmRVahswZ1HV8CEzb/JlBn8RgGMAFY/6CQvuxSRsjUzi6+6UYZPAzVfJVKHiVOBkSNdFVYC3AuRTrYHgtAC4Bt7EKZehfEpNAnajDFDRQ=" Aug 31 20:01:37 olohuone go-librespot[32212]: time="2026-08-31T20:01:37+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 31 20:01:37 olohuone go-librespot[32212]: time="2026-08-31T20:01:37+03:00" level=debug msg="completed keyexchange" Aug 31 20:01:37 olohuone go-librespot[32212]: time="2026-08-31T20:01:37+03:00" level=debug msg="completed challenge" Aug 31 20:01:37 olohuone go-librespot[32212]: time="2026-08-31T20:01:37+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:01:37 olohuone go-librespot[32212]: time="2026-08-31T20:01:37+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:01:37 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:01:37 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:01:39 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:01:39 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:40 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:01:40 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 26. Aug 31 20:01:40 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:01:40 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:01:40 olohuone go-librespot[32222]: go-librespot daemon starting... Aug 31 20:01:40 olohuone go-librespot[32222]: time="2026-08-31T20:01:40+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:01:40 olohuone go-librespot[32222]: time="2026-08-31T20:01:40+03:00" level=debug msg="app state loaded" Aug 31 20:01:40 olohuone go-librespot[32222]: time="2026-08-31T20:01:40+03:00" level=debug msg="stored credentials not found" Aug 31 20:01:40 olohuone go-librespot[32222]: time="2026-08-31T20:01:40+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:01:41 olohuone go-librespot[32222]: time="2026-08-31T20:01:41+03: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]" Aug 31 20:01:41 olohuone go-librespot[32222]: time="2026-08-31T20:01:41+03: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]" Aug 31 20:01:41 olohuone go-librespot[32222]: time="2026-08-31T20:01:41+03: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]" Aug 31 20:01:41 olohuone go-librespot[32222]: time="2026-08-31T20:01:41+03:00" level=info msg="zeroconf server listening on port 39527" Aug 31 20:01:41 olohuone go-librespot[32222]: time="2026-08-31T20:01:41+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:01:41 olohuone go-librespot[32222]: time="2026-08-31T20:01:41+03:00" level=debug msg="obtained new client token: AAE1/IcVoLkEn7GJhwnWc/nmyb+M0qaL8NCbTLYwzzovhIXU5EKc9qr2l97ZlFVvvUVUNMJsp0KaOvJbn+6WL7yf6qsWnze6lM2LfRDjNYye0pvccIV1E4/8asUBGcj2sSlmza8UC7DjmT8VHhVF8olKHrwxtrk0HEmrcliE+TpJMuO8dTT2fe9sUaQL5QaO8rdntzSDh0vZhHuSR3hcLi9PqlhC9bfbCR+71BbtQusC93HKRweYpyI=" Aug 31 20:01:41 olohuone go-librespot[32222]: time="2026-08-31T20:01:41+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 31 20:01:41 olohuone go-librespot[32222]: time="2026-08-31T20:01:41+03:00" level=debug msg="completed keyexchange" Aug 31 20:01:41 olohuone go-librespot[32222]: time="2026-08-31T20:01:41+03:00" level=debug msg="completed challenge" Aug 31 20:01:41 olohuone go-librespot[32222]: time="2026-08-31T20:01:41+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:01:41 olohuone go-librespot[32222]: time="2026-08-31T20:01:41+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:01:41 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:01:41 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:01:42 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:01:42 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:44 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:01:44 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 27. Aug 31 20:01:44 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:01:44 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:01:44 olohuone go-librespot[32245]: go-librespot daemon starting... Aug 31 20:01:44 olohuone go-librespot[32245]: time="2026-08-31T20:01:44+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:01:44 olohuone go-librespot[32245]: time="2026-08-31T20:01:44+03:00" level=debug msg="app state loaded" Aug 31 20:01:44 olohuone go-librespot[32245]: time="2026-08-31T20:01:44+03:00" level=debug msg="stored credentials not found" Aug 31 20:01:44 olohuone go-librespot[32245]: time="2026-08-31T20:01:44+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:01:44 olohuone volumio[717]: info: CoreCommandRouter::volumioPlay Aug 31 20:01:44 olohuone volumio[717]: info: CoreStateMachine::play index undefined Aug 31 20:01:44 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:01:44 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:44 olohuone volumio[717]: info: CoreStateMachine::startPlaybackTimer Aug 31 20:01:44 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:44 olohuone volumio[717]: info: [1788195704751] ControllerSpotify::clearAddPlayTrack Aug 31 20:01:44 olohuone volumio[717]: info: Sending Spotify command with payload to local API: /player/play Aug 31 20:01:44 olohuone go-librespot[32245]: time="2026-08-31T20:01:44+03: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]" Aug 31 20:01:44 olohuone go-librespot[32245]: time="2026-08-31T20:01:44+03: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]" Aug 31 20:01:44 olohuone go-librespot[32245]: time="2026-08-31T20:01:44+03: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]" Aug 31 20:01:44 olohuone go-librespot[32245]: time="2026-08-31T20:01:44+03:00" level=info msg="zeroconf server listening on port 43211" Aug 31 20:01:44 olohuone go-librespot[32245]: time="2026-08-31T20:01:44+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:01:44 olohuone go-librespot[32245]: time="2026-08-31T20:01:44+03:00" level=debug msg="obtained new client token: AAES0eiFmfsafCmsqPeWPEKXejHgje4yMKQl71Ek9YM1ozx5UrkHCTFCFHbYcNUcx6gRc8npXGCyMBGr1QtCFMfDHMRf40fs5TsLWNFWj+7y+rfSDtowtcGhXjfdIqGI4F0jVnT3LV1LAc4wSnBU9ggiWgk4dr2ksrsNgjXcWjbUwUtQs9jzTtPDjKoYpkG/d5SI6iYLUqeIe+AzMl/rIsxcOYeTHqNd7OvpGq1yps1u9pF6yTh+nbu4nQ==" Aug 31 20:01:45 olohuone go-librespot[32245]: time="2026-08-31T20:01:45+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 31 20:01:45 olohuone go-librespot[32245]: time="2026-08-31T20:01:45+03:00" level=debug msg="completed keyexchange" Aug 31 20:01:45 olohuone go-librespot[32245]: time="2026-08-31T20:01:45+03:00" level=debug msg="completed challenge" Aug 31 20:01:45 olohuone go-librespot[32245]: time="2026-08-31T20:01:45+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:01:45 olohuone go-librespot[32245]: time="2026-08-31T20:01:45+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:01:45 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:01:45 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:01:45 olohuone volumio[717]: error: Failed to send command to Spotify local API: /player/play: Error: socket hang up Aug 31 20:01:45 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:01:45 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:48 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:01:48 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 28. Aug 31 20:01:48 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:01:48 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:01:48 olohuone go-librespot[32254]: go-librespot daemon starting... Aug 31 20:01:48 olohuone go-librespot[32254]: time="2026-08-31T20:01:48+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:01:48 olohuone go-librespot[32254]: time="2026-08-31T20:01:48+03:00" level=debug msg="app state loaded" Aug 31 20:01:48 olohuone go-librespot[32254]: time="2026-08-31T20:01:48+03:00" level=debug msg="stored credentials not found" Aug 31 20:01:48 olohuone go-librespot[32254]: time="2026-08-31T20:01:48+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:01:48 olohuone volumio[717]: info: CoreCommandRouter::volumioPlay Aug 31 20:01:48 olohuone volumio[717]: info: CoreStateMachine::play index undefined Aug 31 20:01:48 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:01:48 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:48 olohuone volumio[717]: info: CoreStateMachine::startPlaybackTimer Aug 31 20:01:48 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:48 olohuone volumio[717]: info: [1788195708625] ControllerSpotify::clearAddPlayTrack Aug 31 20:01:48 olohuone volumio[717]: info: Sending Spotify command with payload to local API: /player/play Aug 31 20:01:48 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:01:48 olohuone go-librespot[32254]: time="2026-08-31T20:01:48+03:00" level=debug msg="new websocket client" Aug 31 20:01:48 olohuone volumio[717]: info: Connection to go-librespot Websocket established Aug 31 20:01:48 olohuone go-librespot[32254]: time="2026-08-31T20:01:48+03: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]" Aug 31 20:01:48 olohuone go-librespot[32254]: time="2026-08-31T20:01:48+03: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]" Aug 31 20:01:48 olohuone go-librespot[32254]: time="2026-08-31T20:01:48+03: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]" Aug 31 20:01:48 olohuone go-librespot[32254]: time="2026-08-31T20:01:48+03:00" level=info msg="zeroconf server listening on port 37519" Aug 31 20:01:48 olohuone go-librespot[32254]: time="2026-08-31T20:01:48+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:01:49 olohuone go-librespot[32254]: time="2026-08-31T20:01:49+03:00" level=debug msg="obtained new client token: AAHMfMJrMK7mP53+1lN4UinHCnRf2G139JSLIAUDlo+7s+OMJBCOhuW2S6g0b9F0LEA+P7CB/tmJQuYcXlLWCkI+VqM+S/GH58cgd9m8Cru46PxxYHy118D6XZVBBnLBzYqI0Rv6gLmOTtUAh8EAPa7P9VGsfF+mBitkRVcyZ9uxdeepGpTITHBApEu1dBpv8rqXMYTrbl8rkl1eocVtBmWUkqnsaQagQDKdCtZCU2CJ8GPTDf/A9yA=" Aug 31 20:01:49 olohuone go-librespot[32254]: time="2026-08-31T20:01:49+03: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" Aug 31 20:01:49 olohuone go-librespot[32254]: time="2026-08-31T20:01:49+03:00" level=debug msg="connected to ap-gew4.spotify.com:443" Aug 31 20:01:49 olohuone go-librespot[32254]: time="2026-08-31T20:01:49+03:00" level=debug msg="completed keyexchange" Aug 31 20:01:49 olohuone go-librespot[32254]: time="2026-08-31T20:01:49+03:00" level=debug msg="completed challenge" Aug 31 20:01:49 olohuone volumio[717]: info: CoreCommandRouter::volumioPlay Aug 31 20:01:49 olohuone volumio[717]: info: CoreStateMachine::play index undefined Aug 31 20:01:49 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:01:49 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:49 olohuone volumio[717]: info: CoreStateMachine::startPlaybackTimer Aug 31 20:01:49 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:49 olohuone volumio[717]: info: [1788195709252] ControllerSpotify::clearAddPlayTrack Aug 31 20:01:49 olohuone volumio[717]: info: Sending Spotify command with payload to local API: /player/play Aug 31 20:01:49 olohuone go-librespot[32254]: time="2026-08-31T20:01:49+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:01:49 olohuone go-librespot[32254]: time="2026-08-31T20:01:49+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:01:49 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:01:49 olohuone volumio[717]: error: Failed to send command to Spotify local API: /player/play: Error: socket hang up Aug 31 20:01:49 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:01:49 olohuone volumio[717]: error: Failed to send command to Spotify local API: /player/play: Error: socket hang up Aug 31 20:01:49 olohuone volumio[717]: info: Connection to go-librespot Websocket closed Aug 31 20:01:50 olohuone volumio[717]: info: CoreCommandRouter::volumioPlay Aug 31 20:01:50 olohuone volumio[717]: info: CoreStateMachine::play index undefined Aug 31 20:01:50 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:01:50 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:50 olohuone volumio[717]: info: CoreStateMachine::startPlaybackTimer Aug 31 20:01:50 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:50 olohuone volumio[717]: info: [1788195710007] ControllerSpotify::clearAddPlayTrack Aug 31 20:01:50 olohuone volumio[717]: info: Sending Spotify command with payload to local API: /player/play Aug 31 20:01:50 olohuone volumio[717]: error: Failed to send command to Spotify local API: /player/play: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:51 olohuone volumio[717]: info: Getting Spotify volume Aug 31 20:01:51 olohuone volumio[717]: (node:717) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:51 olohuone volumio[717]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) Aug 31 20:01:51 olohuone volumio[717]: (node:717) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 22) Aug 31 20:01:51 olohuone volumio[717]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Aug 31 20:01:51 olohuone volumio[717]: info: CoreCommandRouter::volumioGetState Aug 31 20:01:51 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:52 olohuone volumio[717]: info: CoreCommandRouter::volumioSeek Aug 31 20:01:52 olohuone volumio[717]: info: CoreStateMachine::seek Aug 31 20:01:52 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:52 olohuone volumio[717]: info: TRACKBLOCK {"service":"spop","type":"song","name":"Sylvian joululaulu (Vain elämää joulu)","title":"Sylvian joululaulu (Vain elämää joulu)","artist":"Vesala","album":"Sylvian joululaulu (Vain elämää joulu)","uri":"spotify:track:2jA4X9A0dLRocCpVX6rHIY","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify","albumart":"https://i.scdn.co/image/ab67616d0000b2739aaa6d6b5b8de5f67b78119d","duration":271} Aug 31 20:01:52 olohuone volumio[717]: info: CoreStateMachine::startPlaybackTimer Aug 31 20:01:52 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:52 olohuone volumio[717]: info: Spotify seek to: 105000 Aug 31 20:01:52 olohuone volumio[717]: info: Sending Spotify command with payload to local API: /player/seek Aug 31 20:01:52 olohuone volumio[717]: info: CoreStateMachine::pushState Aug 31 20:01:52 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:52 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 20:01:52 olohuone volumio[717]: info: CoreCommandRouter::volumioPushState Aug 31 20:01:52 olohuone volumio[717]: info: CoreCommandRouter::volumioGetState Aug 31 20:01:52 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:52 olohuone volumio[717]: info: MRS: Pushing multiroomSync output update for this device Aug 31 20:01:52 olohuone volumio[717]: info: MRS: Pushing multiroomSync output Aug 31 20:01:52 olohuone volumio[717]: error: Failed to send command to Spotify local API: /player/seek: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:52 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:01:52 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:52 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:01:52 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 29. Aug 31 20:01:52 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:01:52 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:01:52 olohuone go-librespot[32276]: go-librespot daemon starting... Aug 31 20:01:52 olohuone go-librespot[32276]: time="2026-08-31T20:01:52+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:01:52 olohuone go-librespot[32276]: time="2026-08-31T20:01:52+03:00" level=debug msg="app state loaded" Aug 31 20:01:52 olohuone go-librespot[32276]: time="2026-08-31T20:01:52+03:00" level=debug msg="stored credentials not found" Aug 31 20:01:52 olohuone go-librespot[32276]: time="2026-08-31T20:01:52+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:01:52 olohuone go-librespot[32276]: time="2026-08-31T20:01:52+03: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]" Aug 31 20:01:52 olohuone go-librespot[32276]: time="2026-08-31T20:01:52+03: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]" Aug 31 20:01:52 olohuone go-librespot[32276]: time="2026-08-31T20:01:52+03: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]" Aug 31 20:01:52 olohuone go-librespot[32276]: time="2026-08-31T20:01:52+03:00" level=info msg="zeroconf server listening on port 42115" Aug 31 20:01:52 olohuone go-librespot[32276]: time="2026-08-31T20:01:52+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:01:53 olohuone go-librespot[32276]: time="2026-08-31T20:01:53+03:00" level=debug msg="obtained new client token: AAGKaArDcQyre2izIy7qR9Z6VuVcWCqQ94NTKtngZ9tR7xMfLJotBFVgpQIuO4dfjs4WIFvNhAh0ZbxKc+J5PR5ZLV5mHYaQEhewGUSh2eralLzGVEfC5VZwyQN7KP2mDthUUn3JTu3vgt6QyfPLri5XCzwERFoMMswcDN/egGoPko+6AHRq9sTiXFqjPHALf9Y7YfNIa8xW+6rjbIC/iuJBZoUw86SDrXhAOk1ySK5S5gfeZVWvDDQ=" Aug 31 20:01:53 olohuone go-librespot[32276]: time="2026-08-31T20:01:53+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 31 20:01:53 olohuone go-librespot[32276]: time="2026-08-31T20:01:53+03:00" level=debug msg="completed keyexchange" Aug 31 20:01:53 olohuone go-librespot[32276]: time="2026-08-31T20:01:53+03:00" level=debug msg="completed challenge" Aug 31 20:01:53 olohuone go-librespot[32276]: time="2026-08-31T20:01:53+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:01:53 olohuone go-librespot[32276]: time="2026-08-31T20:01:53+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:01:53 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:01:53 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:01:53 olohuone volumio[717]: info: CoreCommandRouter::volumioPlay Aug 31 20:01:53 olohuone volumio[717]: info: CoreStateMachine::play index undefined Aug 31 20:01:53 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:01:53 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:53 olohuone volumio[717]: info: CoreStateMachine::startPlaybackTimer Aug 31 20:01:53 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:01:53 olohuone volumio[717]: info: [1788195713618] ControllerSpotify::clearAddPlayTrack Aug 31 20:01:53 olohuone volumio[717]: info: Sending Spotify command with payload to local API: /player/play Aug 31 20:01:53 olohuone volumio[717]: error: Failed to send command to Spotify local API: /player/play: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:55 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:01:55 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:01:56 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:01:56 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 30. Aug 31 20:01:56 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:01:56 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:01:56 olohuone go-librespot[32323]: go-librespot daemon starting... Aug 31 20:01:56 olohuone go-librespot[32323]: time="2026-08-31T20:01:56+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:01:56 olohuone go-librespot[32323]: time="2026-08-31T20:01:56+03:00" level=debug msg="app state loaded" Aug 31 20:01:56 olohuone go-librespot[32323]: time="2026-08-31T20:01:56+03:00" level=debug msg="stored credentials not found" Aug 31 20:01:56 olohuone go-librespot[32323]: time="2026-08-31T20:01:56+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:01:56 olohuone go-librespot[32323]: time="2026-08-31T20:01:56+03: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]" Aug 31 20:01:56 olohuone go-librespot[32323]: time="2026-08-31T20:01:56+03: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]" Aug 31 20:01:56 olohuone go-librespot[32323]: time="2026-08-31T20:01:56+03: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]" Aug 31 20:01:56 olohuone go-librespot[32323]: time="2026-08-31T20:01:56+03:00" level=info msg="zeroconf server listening on port 44287" Aug 31 20:01:56 olohuone go-librespot[32323]: time="2026-08-31T20:01:56+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:01:57 olohuone go-librespot[32323]: time="2026-08-31T20:01:57+03:00" level=debug msg="obtained new client token: AAFsXEfwmVV3zPeiZnYdx3YvujSjIodBvtqQDm21Nw8z1pEp3b2Hrp0/7QhMBG7zLm74O+g/s5tjVUxoNK+tHMSBckbcSLf9yHdko++A2fXCtWrAzYRPUvLO9ZEojhGfkYzLwRDdT0iXYdhmwhC7kwpJK8MQUEV8wDZjJbv9PPkNQtEIFHxdTfJNQRlgKjVtUUVxR9YgR5lIoVRCBfiq3AG93tnVpVE7PpWN0nyK0AKS5aIRfTd1" Aug 31 20:01:57 olohuone go-librespot[32323]: time="2026-08-31T20:01:57+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 31 20:01:57 olohuone go-librespot[32323]: time="2026-08-31T20:01:57+03:00" level=debug msg="completed keyexchange" Aug 31 20:01:57 olohuone go-librespot[32323]: time="2026-08-31T20:01:57+03:00" level=debug msg="completed challenge" Aug 31 20:01:57 olohuone go-librespot[32323]: time="2026-08-31T20:01:57+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:01:57 olohuone go-librespot[32323]: time="2026-08-31T20:01:57+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:01:57 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:01:57 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:01:58 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:01:58 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:02:00 olohuone volumio[717]: info: CoreCommandRouter::volumioGetQueue Aug 31 20:02:00 olohuone volumio[717]: info: CoreStateMachine::getQueue Aug 31 20:02:00 olohuone volumio[717]: info: CorePlayQueue::getQueue Aug 31 20:02:00 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:02:00 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 31. Aug 31 20:02:00 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:02:00 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:02:00 olohuone go-librespot[32332]: go-librespot daemon starting... Aug 31 20:02:00 olohuone go-librespot[32332]: time="2026-08-31T20:02:00+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:02:00 olohuone go-librespot[32332]: time="2026-08-31T20:02:00+03:00" level=debug msg="app state loaded" Aug 31 20:02:00 olohuone go-librespot[32332]: time="2026-08-31T20:02:00+03:00" level=debug msg="stored credentials not found" Aug 31 20:02:00 olohuone go-librespot[32332]: time="2026-08-31T20:02:00+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:02:00 olohuone go-librespot[32332]: time="2026-08-31T20:02:00+03: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]" Aug 31 20:02:00 olohuone go-librespot[32332]: time="2026-08-31T20:02:00+03: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]" Aug 31 20:02:00 olohuone go-librespot[32332]: time="2026-08-31T20:02:00+03: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]" Aug 31 20:02:00 olohuone go-librespot[32332]: time="2026-08-31T20:02:00+03:00" level=info msg="zeroconf server listening on port 38897" Aug 31 20:02:00 olohuone go-librespot[32332]: time="2026-08-31T20:02:00+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:02:00 olohuone go-librespot[32332]: time="2026-08-31T20:02:00+03:00" level=debug msg="obtained new client token: AAGg4wn8tRKPiRgl61QxyT1TeNk3kdpNEO35ddUEsp3LB5gyJGpfd1ouvQ7HP1Luvh/ATPgxkN1xqorahtIXGPq7PB3xPj0gbC65pUuym/t0tZJaDPSX78mob53kO02k81TQSKBO+wdvkbxk7b0Et1upTqjw+JbGogxpifdSIhlRbqCTWdF6JBk7ZYxQgZBoRFnIx06cBca+RqVv4xYWRibGZY4oDSxUAPTcMqMGRTOYbjHpfpfq/o77oA==" Aug 31 20:02:01 olohuone go-librespot[32332]: time="2026-08-31T20:02:01+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 31 20:02:01 olohuone go-librespot[32332]: time="2026-08-31T20:02:01+03:00" level=debug msg="completed keyexchange" Aug 31 20:02:01 olohuone go-librespot[32332]: time="2026-08-31T20:02:01+03:00" level=debug msg="completed challenge" Aug 31 20:02:01 olohuone go-librespot[32332]: time="2026-08-31T20:02:01+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:02:01 olohuone go-librespot[32332]: time="2026-08-31T20:02:01+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:02:01 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:02:01 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:02:01 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:02:01 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:02:04 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:02:04 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 32. Aug 31 20:02:04 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:02:04 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:02:04 olohuone go-librespot[32355]: go-librespot daemon starting... Aug 31 20:02:04 olohuone go-librespot[32355]: time="2026-08-31T20:02:04+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:02:04 olohuone go-librespot[32355]: time="2026-08-31T20:02:04+03:00" level=debug msg="app state loaded" Aug 31 20:02:04 olohuone go-librespot[32355]: time="2026-08-31T20:02:04+03:00" level=debug msg="stored credentials not found" Aug 31 20:02:04 olohuone go-librespot[32355]: time="2026-08-31T20:02:04+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:02:04 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:02:04 olohuone go-librespot[32355]: time="2026-08-31T20:02:04+03:00" level=debug msg="new websocket client" Aug 31 20:02:04 olohuone volumio[717]: info: Connection to go-librespot Websocket established Aug 31 20:02:04 olohuone go-librespot[32355]: time="2026-08-31T20:02:04+03: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]" Aug 31 20:02:04 olohuone go-librespot[32355]: time="2026-08-31T20:02:04+03: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]" Aug 31 20:02:04 olohuone go-librespot[32355]: time="2026-08-31T20:02:04+03: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]" Aug 31 20:02:04 olohuone go-librespot[32355]: time="2026-08-31T20:02:04+03:00" level=info msg="zeroconf server listening on port 39071" Aug 31 20:02:04 olohuone go-librespot[32355]: time="2026-08-31T20:02:04+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:02:04 olohuone go-librespot[32355]: time="2026-08-31T20:02:04+03:00" level=debug msg="obtained new client token: AAEiX8FgbgXrBptSsv1FhNqbhX5vUyakaoZTxOdyWbghpPX+zE/1KC7DM0Q/98K7uo6Qj3HjUbcmhu8+t3n6LVKNq47eNbYPNPwV+mKQjVV0HZsSYEtVgust6dqqc5JPDu1mPEpeB8Qkq4KPUPs0DLv83kH1mtCv01DOTjRionN2xuMbv1wuI5XFnrKJ2lmey7TNABS/LDbykjiAZICTBJgG/LgbOaokdM0zoqbhYiTBWImsNN5cauR8oQ==" Aug 31 20:02:04 olohuone go-librespot[32355]: time="2026-08-31T20:02:04+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 31 20:02:06 olohuone go-librespot[32355]: time="2026-08-31T20:02:06+03:00" level=debug msg="completed keyexchange" Aug 31 20:02:06 olohuone go-librespot[32355]: time="2026-08-31T20:02:06+03:00" level=debug msg="completed challenge" Aug 31 20:02:06 olohuone go-librespot[32355]: time="2026-08-31T20:02:06+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:02:06 olohuone go-librespot[32355]: time="2026-08-31T20:02:06+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:02:06 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:02:06 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:02:06 olohuone volumio[717]: info: Connection to go-librespot Websocket closed Aug 31 20:02:07 olohuone volumio[717]: info: Getting Spotify volume Aug 31 20:02:07 olohuone volumio[717]: (node:717) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:02:07 olohuone volumio[717]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) Aug 31 20:02:07 olohuone volumio[717]: (node:717) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 23) Aug 31 20:02:07 olohuone volumio[717]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Aug 31 20:02:07 olohuone volumio[717]: info: CoreCommandRouter::volumioGetState Aug 31 20:02:07 olohuone volumio[717]: info: CorePlayQueue::getTrack 2 Aug 31 20:02:09 olohuone volumio[717]: info: CoreCommandRouter::volumioPlay Aug 31 20:02:09 olohuone volumio[717]: info: CoreStateMachine::play index 7 Aug 31 20:02:09 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:02:09 olohuone volumio[717]: info: CoreStateMachine::stop Aug 31 20:02:09 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:02:09 olohuone volumio[717]: info: CoreStateMachine::play index undefined Aug 31 20:02:09 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:02:09 olohuone volumio[717]: info: CorePlayQueue::getTrack 7 Aug 31 20:02:09 olohuone volumio[717]: info: CoreStateMachine::startPlaybackTimer Aug 31 20:02:09 olohuone volumio[717]: info: CorePlayQueue::getTrack 7 Aug 31 20:02:09 olohuone volumio[717]: info: [1788195729658] ControllerSpotify::clearAddPlayTrack Aug 31 20:02:09 olohuone volumio[717]: info: Sending Spotify command with payload to local API: /player/play Aug 31 20:02:09 olohuone volumio[717]: error: Failed to send command to Spotify local API: /player/play: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:02:09 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:02:09 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:02:09 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:02:09 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 33. Aug 31 20:02:09 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:02:09 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:02:09 olohuone go-librespot[32363]: go-librespot daemon starting... Aug 31 20:02:09 olohuone go-librespot[32363]: time="2026-08-31T20:02:09+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:02:09 olohuone go-librespot[32363]: time="2026-08-31T20:02:09+03:00" level=debug msg="app state loaded" Aug 31 20:02:09 olohuone go-librespot[32363]: time="2026-08-31T20:02:09+03:00" level=debug msg="stored credentials not found" Aug 31 20:02:09 olohuone go-librespot[32363]: time="2026-08-31T20:02:09+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:02:10 olohuone go-librespot[32363]: time="2026-08-31T20:02:10+03: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]" Aug 31 20:02:10 olohuone go-librespot[32363]: time="2026-08-31T20:02:10+03: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]" Aug 31 20:02:10 olohuone go-librespot[32363]: time="2026-08-31T20:02:10+03: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]" Aug 31 20:02:10 olohuone go-librespot[32363]: time="2026-08-31T20:02:10+03:00" level=info msg="zeroconf server listening on port 44691" Aug 31 20:02:10 olohuone go-librespot[32363]: time="2026-08-31T20:02:10+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:02:10 olohuone go-librespot[32363]: time="2026-08-31T20:02:10+03:00" level=debug msg="obtained new client token: AAHeCB5DQ1a5256CfU8bV4bAkd8zOwkQ8lZ65EHZzZ+oO8UWfhJX/DonC2rAU+ui3UTSfWpWzjxquSiaj04g0EwmQ+mRmz5ES5zNt10/42Qn0krUjotLoARGV/gagr38jr0W3SnfLaZdM5txTopzmdNvv34gyMSUB2fYZb2xOt9RuSNhiWxAUHtUfaB+2J3iJ7DDJp++pijlQioyAZhmSqVj8NuWhkMNWCoeNvNl2JnYCABUUmk0bp3E2A==" Aug 31 20:02:10 olohuone go-librespot[32363]: time="2026-08-31T20:02:10+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 31 20:02:10 olohuone go-librespot[32363]: time="2026-08-31T20:02:10+03:00" level=debug msg="completed keyexchange" Aug 31 20:02:10 olohuone go-librespot[32363]: time="2026-08-31T20:02:10+03:00" level=debug msg="completed challenge" Aug 31 20:02:10 olohuone go-librespot[32363]: time="2026-08-31T20:02:10+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:02:10 olohuone go-librespot[32363]: time="2026-08-31T20:02:10+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:02:10 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:02:10 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:02:10 olohuone volumio[717]: info: CoreCommandRouter::volumioPlay Aug 31 20:02:10 olohuone volumio[717]: info: CoreStateMachine::play index 7 Aug 31 20:02:10 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:02:10 olohuone volumio[717]: info: CoreStateMachine::stop Aug 31 20:02:10 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:02:10 olohuone volumio[717]: info: CoreStateMachine::play index undefined Aug 31 20:02:10 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:02:10 olohuone volumio[717]: info: CorePlayQueue::getTrack 7 Aug 31 20:02:10 olohuone volumio[717]: info: CoreStateMachine::startPlaybackTimer Aug 31 20:02:10 olohuone volumio[717]: info: CorePlayQueue::getTrack 7 Aug 31 20:02:10 olohuone volumio[717]: info: [1788195730824] ControllerSpotify::clearAddPlayTrack Aug 31 20:02:10 olohuone volumio[717]: info: Sending Spotify command with payload to local API: /player/play Aug 31 20:02:10 olohuone volumio[717]: error: Failed to send command to Spotify local API: /player/play: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:02:12 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:02:12 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:02:13 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:02:13 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 34. Aug 31 20:02:13 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:02:13 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:02:13 olohuone go-librespot[32385]: go-librespot daemon starting... Aug 31 20:02:13 olohuone go-librespot[32385]: time="2026-08-31T20:02:13+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:02:13 olohuone go-librespot[32385]: time="2026-08-31T20:02:13+03:00" level=debug msg="app state loaded" Aug 31 20:02:13 olohuone go-librespot[32385]: time="2026-08-31T20:02:13+03:00" level=debug msg="stored credentials not found" Aug 31 20:02:13 olohuone go-librespot[32385]: time="2026-08-31T20:02:13+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:02:14 olohuone go-librespot[32385]: time="2026-08-31T20:02:14+03: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]" Aug 31 20:02:14 olohuone go-librespot[32385]: time="2026-08-31T20:02:14+03: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]" Aug 31 20:02:14 olohuone go-librespot[32385]: time="2026-08-31T20:02:14+03: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]" Aug 31 20:02:14 olohuone go-librespot[32385]: time="2026-08-31T20:02:14+03:00" level=info msg="zeroconf server listening on port 36579" Aug 31 20:02:14 olohuone go-librespot[32385]: time="2026-08-31T20:02:14+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:02:14 olohuone go-librespot[32385]: time="2026-08-31T20:02:14+03:00" level=debug msg="obtained new client token: AAGdJIVnjbfGz0bAh6HhMCUC6nRLIAlOS7+jlH2/Vklc6R2wX6rS/x6Po6UcfLJgjoAIVhk5RmRR1T8yYC30LlPzK2YHLyZxZE2f7r4QO953l/j9DO1PBRAuoB4dWZV+dl8iivUa5aGLGyUPQVYeFAC44kpKaDRy/4Tnxq2ahKTRmAMJhOR7ieEBSatH3tmHqjmIT+nBhi2MU0RDoMBx1GXsrR2RZV3RPPw2IL7y+mjZx4tqX8rj69M=" Aug 31 20:02:14 olohuone go-librespot[32385]: time="2026-08-31T20:02:14+03: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" Aug 31 20:02:14 olohuone go-librespot[32385]: time="2026-08-31T20:02:14+03:00" level=debug msg="connected to ap-gew4.spotify.com:443" Aug 31 20:02:14 olohuone go-librespot[32385]: time="2026-08-31T20:02:14+03:00" level=debug msg="completed keyexchange" Aug 31 20:02:14 olohuone go-librespot[32385]: time="2026-08-31T20:02:14+03:00" level=debug msg="completed challenge" Aug 31 20:02:14 olohuone go-librespot[32385]: time="2026-08-31T20:02:14+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:02:14 olohuone go-librespot[32385]: time="2026-08-31T20:02:14+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:02:14 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:02:14 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:02:15 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:02:15 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:02:16 olohuone volumio[717]: info: CoreCommandRouter::volumioPlay Aug 31 20:02:16 olohuone volumio[717]: info: CoreStateMachine::play index 7 Aug 31 20:02:16 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:02:16 olohuone volumio[717]: info: CoreStateMachine::stop Aug 31 20:02:16 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:02:16 olohuone volumio[717]: info: CoreStateMachine::play index undefined Aug 31 20:02:16 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:02:16 olohuone volumio[717]: info: CorePlayQueue::getTrack 7 Aug 31 20:02:16 olohuone volumio[717]: info: CoreStateMachine::startPlaybackTimer Aug 31 20:02:16 olohuone volumio[717]: info: CorePlayQueue::getTrack 7 Aug 31 20:02:16 olohuone volumio[717]: info: [1788195736855] ControllerSpotify::clearAddPlayTrack Aug 31 20:02:16 olohuone volumio[717]: info: Sending Spotify command with payload to local API: /player/play Aug 31 20:02:16 olohuone volumio[717]: error: Failed to send command to Spotify local API: /player/play: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:02:17 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:02:17 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 35. Aug 31 20:02:17 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:02:17 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:02:17 olohuone go-librespot[32393]: go-librespot daemon starting... Aug 31 20:02:17 olohuone go-librespot[32393]: time="2026-08-31T20:02:17+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:02:17 olohuone go-librespot[32393]: time="2026-08-31T20:02:17+03:00" level=debug msg="app state loaded" Aug 31 20:02:17 olohuone go-librespot[32393]: time="2026-08-31T20:02:17+03:00" level=debug msg="stored credentials not found" Aug 31 20:02:17 olohuone go-librespot[32393]: time="2026-08-31T20:02:17+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:02:18 olohuone go-librespot[32393]: time="2026-08-31T20:02:18+03: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]" Aug 31 20:02:18 olohuone go-librespot[32393]: time="2026-08-31T20:02:18+03: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]" Aug 31 20:02:18 olohuone go-librespot[32393]: time="2026-08-31T20:02:18+03: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]" Aug 31 20:02:18 olohuone go-librespot[32393]: time="2026-08-31T20:02:18+03:00" level=info msg="zeroconf server listening on port 33361" Aug 31 20:02:18 olohuone go-librespot[32393]: time="2026-08-31T20:02:18+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:02:18 olohuone go-librespot[32393]: time="2026-08-31T20:02:18+03:00" level=debug msg="obtained new client token: AAF2ftFK3Qvq8zbJ5BTEPyUULVca4xIik37n2OxzvW3FiFw1u201HP2ZOyqQyex+veaq6CI5skMeU6dZeityDtz/S0WWXZxwSxUzSPElJFrLo/WZid7fIyehkZ2Xmm7YrNXDtRYn2UBGjdBCqWPfj0HQyfbRi7zxG+ed6wcuOq3Dv2PI0Kyzt/14cZ1bRL25htVfh1fGDaPsmR735Vx2dgpWcdoblDyDH0cmz9duVoDc5hPKVY4cQq0=" Aug 31 20:02:18 olohuone go-librespot[32393]: time="2026-08-31T20:02:18+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 31 20:02:18 olohuone go-librespot[32393]: time="2026-08-31T20:02:18+03:00" level=debug msg="completed keyexchange" Aug 31 20:02:18 olohuone go-librespot[32393]: time="2026-08-31T20:02:18+03:00" level=debug msg="completed challenge" Aug 31 20:02:18 olohuone go-librespot[32393]: time="2026-08-31T20:02:18+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:02:18 olohuone go-librespot[32393]: time="2026-08-31T20:02:18+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:02:18 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:02:18 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:02:18 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:02:18 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:02:21 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:02:21 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:02:21 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:02:21 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 36. Aug 31 20:02:21 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:02:21 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:02:21 olohuone go-librespot[32415]: go-librespot daemon starting... Aug 31 20:02:21 olohuone go-librespot[32415]: time="2026-08-31T20:02:21+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:02:21 olohuone go-librespot[32415]: time="2026-08-31T20:02:21+03:00" level=debug msg="app state loaded" Aug 31 20:02:21 olohuone go-librespot[32415]: time="2026-08-31T20:02:21+03:00" level=debug msg="stored credentials not found" Aug 31 20:02:21 olohuone go-librespot[32415]: time="2026-08-31T20:02:21+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:02:22 olohuone go-librespot[32415]: time="2026-08-31T20:02:22+03: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]" Aug 31 20:02:22 olohuone go-librespot[32415]: time="2026-08-31T20:02:22+03: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]" Aug 31 20:02:22 olohuone go-librespot[32415]: time="2026-08-31T20:02:22+03: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]" Aug 31 20:02:22 olohuone go-librespot[32415]: time="2026-08-31T20:02:22+03:00" level=info msg="zeroconf server listening on port 45325" Aug 31 20:02:22 olohuone go-librespot[32415]: time="2026-08-31T20:02:22+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:02:22 olohuone volumio[717]: info: CoreCommandRouter::volumioPlay Aug 31 20:02:22 olohuone volumio[717]: info: CoreStateMachine::play index 7 Aug 31 20:02:22 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:02:22 olohuone volumio[717]: info: CoreStateMachine::stop Aug 31 20:02:22 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:02:22 olohuone volumio[717]: info: CoreStateMachine::play index undefined Aug 31 20:02:22 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:02:22 olohuone volumio[717]: info: CorePlayQueue::getTrack 7 Aug 31 20:02:22 olohuone volumio[717]: info: CoreStateMachine::startPlaybackTimer Aug 31 20:02:22 olohuone volumio[717]: info: CorePlayQueue::getTrack 7 Aug 31 20:02:22 olohuone volumio[717]: info: [1788195742265] ControllerSpotify::clearAddPlayTrack Aug 31 20:02:22 olohuone volumio[717]: info: Sending Spotify command with payload to local API: /player/play Aug 31 20:02:22 olohuone go-librespot[32415]: time="2026-08-31T20:02:22+03:00" level=debug msg="obtained new client token: AAFuJYyQBI3aqRHErY0LyATAF7rXnh2xc6lcropCT7kgjT/9s35Dn6iAVLBnw00edbPhPI3FWkYItMQH5XarUw8DvBk12QKuXLteK0Tod1SgNw5OkIvpjpDqkuGxJQsyanrLPhR62jsvqDBEE5hxWJYSP+DQzJGIZ3w08Mgd5EDbbpcCK5vSBTbKdHDfb7EAqe5Q7OwJTBKJfdFRkpgr2ycckQ005FHO4z6zMEYX/kOzQIXxLgwTAjA=" Aug 31 20:02:22 olohuone go-librespot[32415]: time="2026-08-31T20:02:22+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 31 20:02:22 olohuone go-librespot[32415]: time="2026-08-31T20:02:22+03:00" level=debug msg="completed keyexchange" Aug 31 20:02:22 olohuone go-librespot[32415]: time="2026-08-31T20:02:22+03:00" level=debug msg="completed challenge" Aug 31 20:02:22 olohuone go-librespot[32415]: time="2026-08-31T20:02:22+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:02:22 olohuone go-librespot[32415]: time="2026-08-31T20:02:22+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:02:22 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:02:22 olohuone volumio[717]: error: Failed to send command to Spotify local API: /player/play: Error: socket hang up Aug 31 20:02:22 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:02:24 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:02:24 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:02:25 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:02:25 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 37. Aug 31 20:02:25 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:02:25 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:02:25 olohuone go-librespot[32424]: go-librespot daemon starting... Aug 31 20:02:25 olohuone go-librespot[32424]: time="2026-08-31T20:02:25+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:02:25 olohuone go-librespot[32424]: time="2026-08-31T20:02:25+03:00" level=debug msg="app state loaded" Aug 31 20:02:25 olohuone go-librespot[32424]: time="2026-08-31T20:02:25+03:00" level=debug msg="stored credentials not found" Aug 31 20:02:25 olohuone go-librespot[32424]: time="2026-08-31T20:02:25+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:02:26 olohuone go-librespot[32424]: time="2026-08-31T20:02:26+03: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]" Aug 31 20:02:26 olohuone go-librespot[32424]: time="2026-08-31T20:02:26+03: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]" Aug 31 20:02:26 olohuone go-librespot[32424]: time="2026-08-31T20:02:26+03: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]" Aug 31 20:02:26 olohuone go-librespot[32424]: time="2026-08-31T20:02:26+03:00" level=info msg="zeroconf server listening on port 41067" Aug 31 20:02:26 olohuone go-librespot[32424]: time="2026-08-31T20:02:26+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:02:26 olohuone go-librespot[32424]: time="2026-08-31T20:02:26+03:00" level=debug msg="obtained new client token: AAE7aqJ+57pjziPK2mRpZSnVykLXB92yz4w402roKVvIVXyKnWkyY4ih+PRWHD38cBYif3egvfUGNinNW+VpRdsOUoVvgEMOZ7gsPGpax5+ENeoMXZ5ge31y9W1GKAFTI0HP8bSAilSkyPm5DBAi/JaOfGMnU1XgCSo6soHkp7Ck9PYabGbHkHb3frxk7mm+bxOGwvgpQQdiH0FAoBWVSEGCJanvzbAyz3l/AGjAs8H3ZBfqTRE6ADAniA==" Aug 31 20:02:26 olohuone go-librespot[32424]: time="2026-08-31T20:02:26+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 31 20:02:26 olohuone go-librespot[32424]: time="2026-08-31T20:02:26+03:00" level=debug msg="completed keyexchange" Aug 31 20:02:26 olohuone go-librespot[32424]: time="2026-08-31T20:02:26+03:00" level=debug msg="completed challenge" Aug 31 20:02:26 olohuone go-librespot[32424]: time="2026-08-31T20:02:26+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:02:26 olohuone go-librespot[32424]: time="2026-08-31T20:02:26+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:02:26 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:02:26 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:02:27 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:02:27 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:02:28 olohuone volumio[717]: info: CoreCommandRouter::volumioSeek Aug 31 20:02:28 olohuone volumio[717]: info: CoreStateMachine::seek Aug 31 20:02:28 olohuone volumio[717]: info: CorePlayQueue::getTrack 7 Aug 31 20:02:28 olohuone volumio[717]: info: TRACKBLOCK {"service":"spop","type":"song","name":"Super Smooth","title":"Super Smooth","artist":"Dreamfield","album":"Sentimental Journey","uri":"spotify:track:0UsDabxx31rNxftbBIe86H","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify","albumart":"https://i.scdn.co/image/ab67616d0000b273d48cad367a8d8fe79fe40d45","duration":118} Aug 31 20:02:28 olohuone volumio[717]: info: CoreStateMachine::startPlaybackTimer Aug 31 20:02:28 olohuone volumio[717]: info: CorePlayQueue::getTrack 7 Aug 31 20:02:28 olohuone volumio[717]: info: Spotify seek to: 44000 Aug 31 20:02:28 olohuone volumio[717]: info: Sending Spotify command with payload to local API: /player/seek Aug 31 20:02:28 olohuone volumio[717]: info: CoreStateMachine::pushState Aug 31 20:02:28 olohuone volumio[717]: info: CorePlayQueue::getTrack 7 Aug 31 20:02:28 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 20:02:28 olohuone volumio[717]: info: CoreCommandRouter::volumioPushState Aug 31 20:02:28 olohuone volumio[717]: info: CoreCommandRouter::volumioGetState Aug 31 20:02:28 olohuone volumio[717]: info: CorePlayQueue::getTrack 7 Aug 31 20:02:28 olohuone volumio[717]: info: MRS: Pushing multiroomSync output update for this device Aug 31 20:02:28 olohuone volumio[717]: info: MRS: Pushing multiroomSync output Aug 31 20:02:28 olohuone volumio[717]: error: Failed to send command to Spotify local API: /player/seek: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:02:29 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:02:29 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 38. Aug 31 20:02:29 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:02:29 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:02:29 olohuone go-librespot[32432]: go-librespot daemon starting... Aug 31 20:02:29 olohuone go-librespot[32432]: time="2026-08-31T20:02:29+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:02:29 olohuone go-librespot[32432]: time="2026-08-31T20:02:29+03:00" level=debug msg="app state loaded" Aug 31 20:02:29 olohuone go-librespot[32432]: time="2026-08-31T20:02:29+03:00" level=debug msg="stored credentials not found" Aug 31 20:02:29 olohuone go-librespot[32432]: time="2026-08-31T20:02:29+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:02:30 olohuone volumio[717]: info: CoreCommandRouter::volumioPlay Aug 31 20:02:30 olohuone volumio[717]: info: CoreStateMachine::play index undefined Aug 31 20:02:30 olohuone volumio[717]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 20:02:30 olohuone volumio[717]: info: CorePlayQueue::getTrack 7 Aug 31 20:02:30 olohuone volumio[717]: info: CoreStateMachine::startPlaybackTimer Aug 31 20:02:30 olohuone volumio[717]: info: CorePlayQueue::getTrack 7 Aug 31 20:02:30 olohuone volumio[717]: info: [1788195750080] ControllerSpotify::clearAddPlayTrack Aug 31 20:02:30 olohuone volumio[717]: info: Sending Spotify command with payload to local API: /player/play Aug 31 20:02:30 olohuone go-librespot[32432]: time="2026-08-31T20:02:30+03: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]" Aug 31 20:02:30 olohuone go-librespot[32432]: time="2026-08-31T20:02:30+03: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]" Aug 31 20:02:30 olohuone go-librespot[32432]: time="2026-08-31T20:02:30+03: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]" Aug 31 20:02:30 olohuone go-librespot[32432]: time="2026-08-31T20:02:30+03:00" level=info msg="zeroconf server listening on port 42429" Aug 31 20:02:30 olohuone go-librespot[32432]: time="2026-08-31T20:02:30+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:02:30 olohuone go-librespot[32432]: time="2026-08-31T20:02:30+03:00" level=debug msg="obtained new client token: AAHdz6T/0cgsgXsa2wzBWjtjMHPGOpAeB1oE2v8rhLmY5NqqFwUQEmn9vXNxalrQWuxtfV8gWHUge6B0A/O71EGjUBHqNEp9bVIJVWXYMAfyoH93m3kskkeZpXLIjYEpMbbZxCJBCrXMQ0fJ4WOUl+pBn91OUZpwDB1GFLFKxXJNLA1S44UaWHlWUUDr0qc+Qu0qxS90kND4l+uWa9x7VwO0Ff16N9byLDuR8vfeIlloOqh2VkrXS34=" Aug 31 20:02:30 olohuone go-librespot[32432]: time="2026-08-31T20:02:30+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 31 20:02:30 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:02:30 olohuone go-librespot[32432]: time="2026-08-31T20:02:30+03:00" level=debug msg="new websocket client" Aug 31 20:02:30 olohuone volumio[717]: info: Connection to go-librespot Websocket established Aug 31 20:02:32 olohuone go-librespot[32432]: time="2026-08-31T20:02:32+03:00" level=debug msg="completed keyexchange" Aug 31 20:02:32 olohuone go-librespot[32432]: time="2026-08-31T20:02:32+03:00" level=debug msg="completed challenge" Aug 31 20:02:32 olohuone go-librespot[32432]: time="2026-08-31T20:02:32+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:02:32 olohuone go-librespot[32432]: time="2026-08-31T20:02:32+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:02:32 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:02:32 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:02:32 olohuone volumio[717]: error: Failed to send command to Spotify local API: /player/play: Error: socket hang up Aug 31 20:02:32 olohuone volumio[717]: info: Connection to go-librespot Websocket closed Aug 31 20:02:33 olohuone volumio[717]: info: Getting Spotify volume Aug 31 20:02:33 olohuone volumio[717]: (node:717) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:02:33 olohuone volumio[717]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) Aug 31 20:02:33 olohuone volumio[717]: (node:717) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 24) Aug 31 20:02:33 olohuone volumio[717]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Aug 31 20:02:33 olohuone volumio[717]: info: CoreCommandRouter::volumioGetState Aug 31 20:02:33 olohuone volumio[717]: info: CorePlayQueue::getTrack 7 Aug 31 20:02:35 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:02:35 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:02:35 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 39. Aug 31 20:02:35 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:02:35 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:02:35 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:02:35 olohuone go-librespot[32454]: go-librespot daemon starting... Aug 31 20:02:35 olohuone go-librespot[32454]: time="2026-08-31T20:02:35+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:02:35 olohuone go-librespot[32454]: time="2026-08-31T20:02:35+03:00" level=debug msg="app state loaded" Aug 31 20:02:35 olohuone go-librespot[32454]: time="2026-08-31T20:02:35+03:00" level=debug msg="stored credentials not found" Aug 31 20:02:35 olohuone go-librespot[32454]: time="2026-08-31T20:02:35+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:02:35 olohuone go-librespot[32454]: time="2026-08-31T20:02:35+03: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]" Aug 31 20:02:35 olohuone go-librespot[32454]: time="2026-08-31T20:02:35+03: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]" Aug 31 20:02:35 olohuone go-librespot[32454]: time="2026-08-31T20:02:35+03: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]" Aug 31 20:02:35 olohuone go-librespot[32454]: time="2026-08-31T20:02:35+03:00" level=info msg="zeroconf server listening on port 43715" Aug 31 20:02:35 olohuone go-librespot[32454]: time="2026-08-31T20:02:35+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 31 20:02:35 olohuone go-librespot[32454]: time="2026-08-31T20:02:35+03:00" level=debug msg="obtained new client token: AAGWtwd6cBruwr66wZSckF1xr8dtsxYrNgxIi8LfExGkp6KCPe0HN1bpZmWVrwph1kKWPsJwLro+PqP96bl3JSM+HBUJO+YiEb0xLFfAT09RZtjvE7eOD58ZvUmz/eZr/SZ/rMaWOi1QQ0JzZJUnw93GpKYMnxirsG/MXh6EyEFl6S0UxBWv2NbWI/WGiVEqa9vwAK01z8KpPPI0gTkPBnNR24zAwEoMFvWXwNEo7TdfDYHtvpoTciYfPg==" Aug 31 20:02:36 olohuone go-librespot[32454]: time="2026-08-31T20:02:36+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 31 20:02:36 olohuone go-librespot[32454]: time="2026-08-31T20:02:36+03:00" level=debug msg="completed keyexchange" Aug 31 20:02:36 olohuone go-librespot[32454]: time="2026-08-31T20:02:36+03:00" level=debug msg="completed challenge" Aug 31 20:02:36 olohuone go-librespot[32454]: time="2026-08-31T20:02:36+03:00" level=info msg="authenticated AP" username="fl*m0" Aug 31 20:02:36 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 20:02:36 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 20:02:36 olohuone volumio[717]: info: Discovery: Getting this device information Aug 31 20:02:36 olohuone volumio[717]: info: CoreCommandRouter::volumioGetState Aug 31 20:02:36 olohuone volumio[717]: info: CorePlayQueue::getTrack 7 Aug 31 20:02:36 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 20:02:36 olohuone go-librespot[32454]: time="2026-08-31T20:02:36+03:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 31 20:02:36 olohuone systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 31 20:02:36 olohuone volumio[717]: verbose: New Socket.io Connection to 192.168.1.189:3000 from 192.168.1.24 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Aug 31 20:02:36 olohuone systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 31 20:02:36 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 31 20:02:36 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 31 20:02:36 olohuone volumio[717]: verbose: New Socket.io Connection to 192.168.1.189 from 192.168.1.24 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 11 Aug 31 20:02:36 olohuone volumio[717]: info: CoreCommandRouter::volumioGetState Aug 31 20:02:36 olohuone volumio[717]: info: CorePlayQueue::getTrack 7 Aug 31 20:02:37 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 31 20:02:37 olohuone volumio[717]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Aug 31 20:02:37 olohuone volumio[717]: info: Listing playlists Aug 31 20:02:37 olohuone volumio[717]: info: CoreCommandRouter::volumioGetQueue Aug 31 20:02:37 olohuone volumio[717]: info: CoreStateMachine::getQueue Aug 31 20:02:37 olohuone volumio[717]: info: CorePlayQueue::getQueue Aug 31 20:02:38 olohuone volumio[717]: info: Initializing connection to go-librespot Websocket Aug 31 20:02:38 olohuone volumio[717]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 31 20:02:38 olohuone volumio[717]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay Aug 31 20:02:38 olohuone volumio[717]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom Aug 31 20:02:38 olohuone volumio[717]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 20:02:38 olohuone volumio[717]: TypeError: Cannot read property 'then' of undefined Aug 31 20:02:38 olohuone volumio[717]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9) Aug 31 20:02:38 olohuone volumio[717]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2279:30) Aug 31 20:02:38 olohuone volumio[717]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1467:26) Aug 31 20:02:38 olohuone volumio[717]: at Socket.emit (events.js:400:28) Aug 31 20:02:38 olohuone volumio[717]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Aug 31 20:02:38 olohuone volumio[717]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Aug 31 20:02:38 olohuone volumio[717]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 20:02:39 olohuone systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 31 20:02:39 olohuone systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 40. Aug 31 20:02:39 olohuone systemd[1]: Stopped go-librespot Daemon. Aug 31 20:02:39 olohuone systemd[1]: Started go-librespot Daemon. Aug 31 20:02:39 olohuone go-librespot[32471]: go-librespot daemon starting... Aug 31 20:02:39 olohuone go-librespot[32471]: time="2026-08-31T20:02:39+03:00" level=info msg="running go-librespot 0.7.1" Aug 31 20:02:39 olohuone go-librespot[32471]: time="2026-08-31T20:02:39+03:00" level=debug msg="app state loaded" Aug 31 20:02:39 olohuone go-librespot[32471]: time="2026-08-31T20:02:39+03:00" level=debug msg="stored credentials not found" Aug 31 20:02:39 olohuone go-librespot[32471]: time="2026-08-31T20:02:39+03:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 31 20:02:39 olohuone sudo[32480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-31 20:01 Aug 31 20:02:39 olohuone sudo[32480]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 20:02:39 olohuone go-librespot[32471]: time="2026-08-31T20:02:39+03: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]" Aug 31 20:02:39 olohuone go-librespot[32471]: time="2026-08-31T20:02:39+03: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]" Aug 31 20:02:39 olohuone go-librespot[32471]: time="2026-08-31T20:02:39+03: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]" Aug 31 20:02:39 olohuone go-librespot[32471]: time="2026-08-31T20:02:39+03:00" level=info msg="zeroconf server listening on port 45283" Aug 31 20:02:39 olohuone go-librespot[32471]: time="2026-08-31T20:02:39+03:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="3dada8b1e619a5feb94867e0865ace17474d7bce" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="30045b259d1a704a832ca7c1460c1fdfa4b723f9" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Mar 2026 11:08:05 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="2435172a9e07e22ce77410ca4817b0fa"