-- Logs begin at Thu 2026-10-15 12:26:21 UTC, end at Thu 2026-10-15 15:02:14 UTC. -- Oct 15 15:01:00 studio-volumio go-librespot[1617]: time="2026-10-15T15:01:00Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 15 15:01:00 studio-volumio volumio[810]: info: Connection to go-librespot Websocket closed Oct 15 15:01:00 studio-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 15 15:01:00 studio-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 15 15:01:02 studio-volumio volumio[810]: info: Getting Spotify volume Oct 15 15:01:02 studio-volumio volumio[810]: (node:810) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 15 15:01:02 studio-volumio volumio[810]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 15 15:01:02 studio-volumio volumio[810]: (node:810) 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: 18346) Oct 15 15:01:02 studio-volumio volumio[810]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Oct 15 15:01:02 studio-volumio volumio[810]: info: CoreCommandRouter::volumioGetState Oct 15 15:01:02 studio-volumio volumio[810]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Oct 15 15:01:03 studio-volumio volumio[810]: info: Initializing connection to go-librespot Websocket Oct 15 15:01:03 studio-volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 15 15:01:03 studio-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20806. Oct 15 15:01:03 studio-volumio systemd[1]: Stopped go-librespot Daemon. Oct 15 15:01:03 studio-volumio systemd[1]: Started go-librespot Daemon. Oct 15 15:01:03 studio-volumio go-librespot[1626]: go-librespot daemon starting... Oct 15 15:01:03 studio-volumio go-librespot[1626]: time="2026-10-15T15:01:03Z" level=info msg="running go-librespot 0.4.0" Oct 15 15:01:03 studio-volumio go-librespot[1626]: time="2026-10-15T15:01:03Z" level=debug msg="app state loaded" Oct 15 15:01:03 studio-volumio go-librespot[1626]: time="2026-10-15T15:01:03Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 15 15:01:04 studio-volumio go-librespot[1626]: time="2026-10-15T15:01:04Z" level=debug msg="new websocket client" Oct 15 15:01:04 studio-volumio volumio[810]: info: Connection to go-librespot Websocket established Oct 15 15:01:04 studio-volumio go-librespot[1626]: time="2026-10-15T15:01:04Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 15 15:01:04 studio-volumio go-librespot[1626]: time="2026-10-15T15:01:04Z" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 15 15:01:04 studio-volumio go-librespot[1626]: time="2026-10-15T15:01:04Z" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 15 15:01:04 studio-volumio go-librespot[1626]: time="2026-10-15T15:01:04Z" level=info msg="zeroconf server listening on port 43227" Oct 15 15:01:04 studio-volumio go-librespot[1626]: time="2026-10-15T15:01:04Z" level=debug msg="obtained new client token: AAF7WYiNoNt7KxGe7Qa4kS4bUElJc676dk31y98zottC/N8djJB0dBXmfN4hcTZ9KtdT28xAJqf/KEjjk8eVCOTBQvWgW0NT2yVhlhfxugUlbIVyWxpUplCp/GsMCFc941FsGkl2s1SOBnknjbXI6Y62Q27k8eeiKGCOPuK6AviqsN2nTmFh89KBiFC1admlx+GwoLl/MyhkEM0UqwhDfIIG5kCKpi9gaeYvz599quCqiX0MT9STS+ln7A==" Oct 15 15:01:05 studio-volumio go-librespot[1626]: time="2026-10-15T15:01:05Z" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 15 15:01:05 studio-volumio go-librespot[1626]: time="2026-10-15T15:01:05Z" level=debug msg="completed keyexchange" Oct 15 15:01:05 studio-volumio go-librespot[1626]: time="2026-10-15T15:01:05Z" level=debug msg="completed challenge" Oct 15 15:01:05 studio-volumio go-librespot[1626]: time="2026-10-15T15:01:05Z" level=info msg="authenticated AP" username="an*********te" Oct 15 15:01:05 studio-volumio go-librespot[1626]: time="2026-10-15T15:01:05Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 15 15:01:05 studio-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 15 15:01:05 studio-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 15 15:01:05 studio-volumio volumio[810]: info: Connection to go-librespot Websocket closed Oct 15 15:01:07 studio-volumio volumio[810]: info: Getting Spotify volume Oct 15 15:01:07 studio-volumio volumio[810]: (node:810) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 15 15:01:07 studio-volumio volumio[810]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 15 15:01:07 studio-volumio volumio[810]: (node:810) 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: 18347) Oct 15 15:01:07 studio-volumio volumio[810]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Oct 15 15:01:07 studio-volumio volumio[810]: info: CoreCommandRouter::volumioGetState Oct 15 15:01:07 studio-volumio volumio[810]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Oct 15 15:01:08 studio-volumio volumio[810]: info: Initializing connection to go-librespot Websocket Oct 15 15:01:08 studio-volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 15 15:01:08 studio-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20807. Oct 15 15:01:08 studio-volumio systemd[1]: Stopped go-librespot Daemon. Oct 15 15:01:08 studio-volumio systemd[1]: Started go-librespot Daemon. Oct 15 15:01:08 studio-volumio go-librespot[1634]: go-librespot daemon starting... Oct 15 15:01:08 studio-volumio go-librespot[1634]: time="2026-10-15T15:01:08Z" level=info msg="running go-librespot 0.4.0" Oct 15 15:01:08 studio-volumio go-librespot[1634]: time="2026-10-15T15:01:08Z" level=debug msg="app state loaded" Oct 15 15:01:08 studio-volumio go-librespot[1634]: time="2026-10-15T15:01:08Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 15 15:01:09 studio-volumio go-librespot[1634]: time="2026-10-15T15:01:09Z" level=debug msg="new websocket client" Oct 15 15:01:09 studio-volumio volumio[810]: info: Connection to go-librespot Websocket established Oct 15 15:01:09 studio-volumio go-librespot[1634]: time="2026-10-15T15:01:09Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 15 15:01:09 studio-volumio go-librespot[1634]: time="2026-10-15T15:01:09Z" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 15 15:01:09 studio-volumio go-librespot[1634]: time="2026-10-15T15:01:09Z" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 15 15:01:09 studio-volumio go-librespot[1634]: time="2026-10-15T15:01:09Z" level=info msg="zeroconf server listening on port 46423" Oct 15 15:01:10 studio-volumio go-librespot[1634]: time="2026-10-15T15:01:10Z" level=debug msg="obtained new client token: AAEuzuv1QgI0g/TsHAaiQTn3mgGQ5/yPQehLuN00FxEmtLvAHUIpBhulITowV69DHTS4lNaOU3466jjkTY20+04eIefrBsT5Dp932zRXO/NxNM4t4m5V1NY36r71E8lcLN2K4rSeiAT/BNP47EN4J4tF8AkTVduxqpB4a9dGi5nzAh7a8Ihok+51pRPv0PYjywJQYhBK/mb0mxqdGpE7IqU7U+OR3dxYMWMReJ7WWIrSUjOUbs3xpUAbHQ==" Oct 15 15:01:10 studio-volumio go-librespot[1634]: time="2026-10-15T15:01:10Z" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 15 15:01:10 studio-volumio go-librespot[1634]: time="2026-10-15T15:01:10Z" level=debug msg="completed keyexchange" Oct 15 15:01:10 studio-volumio go-librespot[1634]: time="2026-10-15T15:01:10Z" level=debug msg="completed challenge" Oct 15 15:01:10 studio-volumio go-librespot[1634]: time="2026-10-15T15:01:10Z" level=info msg="authenticated AP" username="an*********te" Oct 15 15:01:10 studio-volumio go-librespot[1634]: time="2026-10-15T15:01:10Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 15 15:01:10 studio-volumio volumio[810]: info: Connection to go-librespot Websocket closed Oct 15 15:01:10 studio-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 15 15:01:10 studio-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 15 15:01:12 studio-volumio volumio[810]: info: Getting Spotify volume Oct 15 15:01:12 studio-volumio volumio[810]: (node:810) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 15 15:01:12 studio-volumio volumio[810]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 15 15:01:12 studio-volumio volumio[810]: (node:810) 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: 18348) Oct 15 15:01:12 studio-volumio volumio[810]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Oct 15 15:01:12 studio-volumio volumio[810]: info: CoreCommandRouter::volumioGetState Oct 15 15:01:12 studio-volumio volumio[810]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Oct 15 15:01:13 studio-volumio volumio[810]: info: Initializing connection to go-librespot Websocket Oct 15 15:01:13 studio-volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 15 15:01:13 studio-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20808. Oct 15 15:01:13 studio-volumio systemd[1]: Stopped go-librespot Daemon. Oct 15 15:01:13 studio-volumio systemd[1]: Started go-librespot Daemon. Oct 15 15:01:13 studio-volumio go-librespot[1642]: go-librespot daemon starting... Oct 15 15:01:13 studio-volumio go-librespot[1642]: time="2026-10-15T15:01:13Z" level=info msg="running go-librespot 0.4.0" Oct 15 15:01:13 studio-volumio go-librespot[1642]: time="2026-10-15T15:01:13Z" level=debug msg="app state loaded" Oct 15 15:01:13 studio-volumio go-librespot[1642]: time="2026-10-15T15:01:13Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 15 15:01:14 studio-volumio go-librespot[1642]: time="2026-10-15T15:01:14Z" level=debug msg="new websocket client" Oct 15 15:01:14 studio-volumio volumio[810]: info: Connection to go-librespot Websocket established Oct 15 15:01:14 studio-volumio go-librespot[1642]: time="2026-10-15T15:01:14Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 15 15:01:14 studio-volumio go-librespot[1642]: time="2026-10-15T15:01:14Z" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 15 15:01:14 studio-volumio go-librespot[1642]: time="2026-10-15T15:01:14Z" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 15 15:01:14 studio-volumio go-librespot[1642]: time="2026-10-15T15:01:14Z" level=info msg="zeroconf server listening on port 45837" Oct 15 15:01:14 studio-volumio go-librespot[1642]: time="2026-10-15T15:01:14Z" level=debug msg="obtained new client token: AAHZBEQkRA7yzoMk5AYdMBuiOF17rh/ZYQBIQvUXw6Y8UNw3sXQR0a+TLopnJ0aW8WyeAdHm+epNlu4jMTVxf5u6x+AREeAoeBR/K78SMI3d6oCJxxpmHL0JjFTMhd0ST/w7cPCQHi8aACJDL6gYi8GNeOTsOhP4QUkrzCujwIHJvyMppF4BFUTEnmjCP47M9ZdnkDdT3EDseGoZG+780smFgNkqux3ubv9ShzTfRfzSbJtvl88ycRRUng==" Oct 15 15:01:14 studio-volumio go-librespot[1642]: time="2026-10-15T15:01:14Z" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.1.133:4070: connect: connection refused" Oct 15 15:01:14 studio-volumio go-librespot[1642]: time="2026-10-15T15:01:14Z" level=debug msg="connected to ap-gew4.spotify.com:443" Oct 15 15:01:15 studio-volumio go-librespot[1642]: time="2026-10-15T15:01:15Z" level=debug msg="completed keyexchange" Oct 15 15:01:15 studio-volumio go-librespot[1642]: time="2026-10-15T15:01:15Z" level=debug msg="completed challenge" Oct 15 15:01:15 studio-volumio go-librespot[1642]: time="2026-10-15T15:01:15Z" level=info msg="authenticated AP" username="an*********te" Oct 15 15:01:15 studio-volumio go-librespot[1642]: time="2026-10-15T15:01:15Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 15 15:01:15 studio-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 15 15:01:15 studio-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 15 15:01:15 studio-volumio volumio[810]: info: Connection to go-librespot Websocket closed Oct 15 15:01:17 studio-volumio volumio[810]: info: Getting Spotify volume Oct 15 15:01:17 studio-volumio volumio[810]: (node:810) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 15 15:01:17 studio-volumio volumio[810]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 15 15:01:17 studio-volumio volumio[810]: (node:810) 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: 18349) Oct 15 15:01:17 studio-volumio volumio[810]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Oct 15 15:01:17 studio-volumio volumio[810]: info: CoreCommandRouter::volumioGetState Oct 15 15:01:17 studio-volumio volumio[810]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Oct 15 15:01:18 studio-volumio volumio[810]: info: Initializing connection to go-librespot Websocket Oct 15 15:01:18 studio-volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 15 15:01:18 studio-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20809. Oct 15 15:01:18 studio-volumio systemd[1]: Stopped go-librespot Daemon. Oct 15 15:01:18 studio-volumio systemd[1]: Started go-librespot Daemon. Oct 15 15:01:18 studio-volumio go-librespot[1651]: go-librespot daemon starting... Oct 15 15:01:18 studio-volumio go-librespot[1651]: time="2026-10-15T15:01:18Z" level=info msg="running go-librespot 0.4.0" Oct 15 15:01:18 studio-volumio go-librespot[1651]: time="2026-10-15T15:01:18Z" level=debug msg="app state loaded" Oct 15 15:01:18 studio-volumio go-librespot[1651]: time="2026-10-15T15:01:18Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 15 15:01:19 studio-volumio go-librespot[1651]: time="2026-10-15T15:01:19Z" level=debug msg="new websocket client" Oct 15 15:01:19 studio-volumio volumio[810]: info: Connection to go-librespot Websocket established Oct 15 15:01:19 studio-volumio go-librespot[1651]: time="2026-10-15T15:01:19Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 15 15:01:19 studio-volumio go-librespot[1651]: time="2026-10-15T15:01:19Z" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 15 15:01:19 studio-volumio go-librespot[1651]: time="2026-10-15T15:01:19Z" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 15 15:01:19 studio-volumio go-librespot[1651]: time="2026-10-15T15:01:19Z" level=info msg="zeroconf server listening on port 33457" Oct 15 15:01:19 studio-volumio go-librespot[1651]: time="2026-10-15T15:01:19Z" level=debug msg="obtained new client token: AAEmyloy6xGtvxR7YH6tOaw75gNu9ClSH0EOld30RyEJQEYGLWSd2dQpJmHgzcEM1faBo9LOTIc0tewF2YthqREifrjGAL7wYUctYol6TFKeXdm30CtzspAwmTYDbkLbwgzQrND6QZy57jl0EzKh9Jw7KoF4VMEP0KPzaif+x+SaGh+vr+vzSlEsreqdvErlLYJPsNiEM73ZQNqo1xE2RR9U6PjyNYzgf4BmMM71Zn7oEHPkBbMTx5mnIw==" Oct 15 15:01:19 studio-volumio go-librespot[1651]: time="2026-10-15T15:01:19Z" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 15 15:01:19 studio-volumio go-librespot[1651]: time="2026-10-15T15:01:19Z" level=debug msg="completed keyexchange" Oct 15 15:01:20 studio-volumio go-librespot[1651]: time="2026-10-15T15:01:20Z" level=debug msg="completed challenge" Oct 15 15:01:20 studio-volumio go-librespot[1651]: time="2026-10-15T15:01:20Z" level=info msg="authenticated AP" username="an*********te" Oct 15 15:01:20 studio-volumio go-librespot[1651]: time="2026-10-15T15:01:20Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 15 15:01:20 studio-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 15 15:01:20 studio-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 15 15:01:20 studio-volumio volumio[810]: info: Connection to go-librespot Websocket closed Oct 15 15:01:22 studio-volumio volumio[810]: info: Getting Spotify volume Oct 15 15:01:22 studio-volumio volumio[810]: (node:810) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 15 15:01:22 studio-volumio volumio[810]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 15 15:01:22 studio-volumio volumio[810]: (node:810) 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: 18350) Oct 15 15:01:22 studio-volumio volumio[810]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Oct 15 15:01:22 studio-volumio volumio[810]: info: CoreCommandRouter::volumioGetState Oct 15 15:01:22 studio-volumio volumio[810]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Oct 15 15:01:23 studio-volumio volumio[810]: info: Initializing connection to go-librespot Websocket Oct 15 15:01:23 studio-volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 15 15:01:23 studio-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20810. Oct 15 15:01:23 studio-volumio systemd[1]: Stopped go-librespot Daemon. Oct 15 15:01:23 studio-volumio systemd[1]: Started go-librespot Daemon. Oct 15 15:01:23 studio-volumio go-librespot[1660]: go-librespot daemon starting... Oct 15 15:01:23 studio-volumio go-librespot[1660]: time="2026-10-15T15:01:23Z" level=info msg="running go-librespot 0.4.0" Oct 15 15:01:23 studio-volumio go-librespot[1660]: time="2026-10-15T15:01:23Z" level=debug msg="app state loaded" Oct 15 15:01:23 studio-volumio go-librespot[1660]: time="2026-10-15T15:01:23Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 15 15:01:24 studio-volumio go-librespot[1660]: time="2026-10-15T15:01:24Z" level=debug msg="new websocket client" Oct 15 15:01:24 studio-volumio volumio[810]: info: Connection to go-librespot Websocket established Oct 15 15:01:24 studio-volumio go-librespot[1660]: time="2026-10-15T15:01:24Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 15 15:01:24 studio-volumio go-librespot[1660]: time="2026-10-15T15:01:24Z" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 15 15:01:24 studio-volumio go-librespot[1660]: time="2026-10-15T15:01:24Z" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 15 15:01:24 studio-volumio go-librespot[1660]: time="2026-10-15T15:01:24Z" level=info msg="zeroconf server listening on port 36349" Oct 15 15:01:24 studio-volumio go-librespot[1660]: time="2026-10-15T15:01:24Z" level=debug msg="obtained new client token: AAFk9ZZeLilHUlrKsPfnc3bkyEJ5QnlP90zAKQBs0CkcIZWgmqSDH7XeF2AT+Ju0tvjlw1xH76qpe6SyZCFKF1toTePVMixzB/ON5GfujQH7vEWRGPmiS2zxhmJTKsNr3JIJqJB3rM6+oiybAjyXgaura9ef/tx8xwirsKjcfF2jGGAi9DOJL2NDDMjb5NSu+iW0ve5QiUUw4691g0rECynfRoNdoOSZZ8EIG2WTGEzI+XD5U6ILuGtUoQ==" Oct 15 15:01:24 studio-volumio go-librespot[1660]: time="2026-10-15T15:01:24Z" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 15 15:01:25 studio-volumio go-librespot[1660]: time="2026-10-15T15:01:25Z" level=debug msg="completed keyexchange" Oct 15 15:01:25 studio-volumio go-librespot[1660]: time="2026-10-15T15:01:25Z" level=debug msg="completed challenge" Oct 15 15:01:25 studio-volumio go-librespot[1660]: time="2026-10-15T15:01:25Z" level=info msg="authenticated AP" username="an*********te" Oct 15 15:01:25 studio-volumio go-librespot[1660]: time="2026-10-15T15:01:25Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 15 15:01:25 studio-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 15 15:01:25 studio-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 15 15:01:25 studio-volumio volumio[810]: info: Connection to go-librespot Websocket closed Oct 15 15:01:27 studio-volumio volumio[810]: info: Getting Spotify volume Oct 15 15:01:27 studio-volumio volumio[810]: (node:810) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 15 15:01:27 studio-volumio volumio[810]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 15 15:01:27 studio-volumio volumio[810]: (node:810) 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: 18351) Oct 15 15:01:27 studio-volumio volumio[810]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Oct 15 15:01:27 studio-volumio volumio[810]: info: CoreCommandRouter::volumioGetState Oct 15 15:01:27 studio-volumio volumio[810]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Oct 15 15:01:28 studio-volumio volumio[810]: info: Initializing connection to go-librespot Websocket Oct 15 15:01:28 studio-volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 15 15:01:28 studio-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20811. Oct 15 15:01:28 studio-volumio systemd[1]: Stopped go-librespot Daemon. Oct 15 15:01:28 studio-volumio systemd[1]: Started go-librespot Daemon. Oct 15 15:01:28 studio-volumio go-librespot[1668]: go-librespot daemon starting... Oct 15 15:01:28 studio-volumio go-librespot[1668]: time="2026-10-15T15:01:28Z" level=info msg="running go-librespot 0.4.0" Oct 15 15:01:28 studio-volumio go-librespot[1668]: time="2026-10-15T15:01:28Z" level=debug msg="app state loaded" Oct 15 15:01:28 studio-volumio go-librespot[1668]: time="2026-10-15T15:01:28Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 15 15:01:29 studio-volumio go-librespot[1668]: time="2026-10-15T15:01:29Z" level=debug msg="new websocket client" Oct 15 15:01:29 studio-volumio volumio[810]: info: Connection to go-librespot Websocket established Oct 15 15:01:29 studio-volumio go-librespot[1668]: time="2026-10-15T15:01:29Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 15 15:01:29 studio-volumio go-librespot[1668]: time="2026-10-15T15:01:29Z" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 15 15:01:29 studio-volumio go-librespot[1668]: time="2026-10-15T15:01:29Z" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 15 15:01:29 studio-volumio go-librespot[1668]: time="2026-10-15T15:01:29Z" level=info msg="zeroconf server listening on port 42875" Oct 15 15:01:30 studio-volumio go-librespot[1668]: time="2026-10-15T15:01:30Z" level=debug msg="obtained new client token: AAGfSjZjkiWRzRvDS1Lw38bLvU9B3JhjBi5YX4JB16BWWbSGlfjFmkNmqOOujkdfO2TYmIDq4/1E2Ua3ZeJIK98OKddsbGNcTLuNt/XgoJmfeIasYXoC+P5B7hJS3Mkvr+obNi5X72CYXCvWn19qM0AmVARZVh5TdNA4nwc4BkfoODXUcc8qXyKCVhlDYj6fq+0B8tvcKS1b7nOCS9RAWiQJivUcts4YAAaGZmo4KG8IGBkentmO0eA=" Oct 15 15:01:30 studio-volumio go-librespot[1668]: time="2026-10-15T15:01:30Z" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 15 15:01:30 studio-volumio go-librespot[1668]: time="2026-10-15T15:01:30Z" level=debug msg="completed keyexchange" Oct 15 15:01:30 studio-volumio go-librespot[1668]: time="2026-10-15T15:01:30Z" level=debug msg="completed challenge" Oct 15 15:01:30 studio-volumio go-librespot[1668]: time="2026-10-15T15:01:30Z" level=info msg="authenticated AP" username="an*********te" Oct 15 15:01:30 studio-volumio go-librespot[1668]: time="2026-10-15T15:01:30Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 15 15:01:32 studio-volumio volumio[810]: info: Connection to go-librespot Websocket closed Oct 15 15:01:32 studio-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 15 15:01:32 studio-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 15 15:01:32 studio-volumio volumio[810]: info: Getting Spotify volume Oct 15 15:01:32 studio-volumio volumio[810]: (node:810) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 15 15:01:32 studio-volumio volumio[810]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 15 15:01:32 studio-volumio volumio[810]: (node:810) 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: 18352) Oct 15 15:01:32 studio-volumio volumio[810]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Oct 15 15:01:32 studio-volumio volumio[810]: info: CoreCommandRouter::volumioGetState Oct 15 15:01:32 studio-volumio volumio[810]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Oct 15 15:01:35 studio-volumio volumio[810]: info: Initializing connection to go-librespot Websocket Oct 15 15:01:35 studio-volumio volumio[810]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 15 15:01:35 studio-volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 15 15:01:35 studio-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20812. Oct 15 15:01:35 studio-volumio systemd[1]: Stopped go-librespot Daemon. Oct 15 15:01:35 studio-volumio systemd[1]: Started go-librespot Daemon. Oct 15 15:01:35 studio-volumio go-librespot[1676]: go-librespot daemon starting... Oct 15 15:01:35 studio-volumio go-librespot[1676]: time="2026-10-15T15:01:35Z" level=info msg="running go-librespot 0.4.0" Oct 15 15:01:35 studio-volumio go-librespot[1676]: time="2026-10-15T15:01:35Z" level=debug msg="app state loaded" Oct 15 15:01:35 studio-volumio go-librespot[1676]: time="2026-10-15T15:01:35Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 15 15:01:35 studio-volumio go-librespot[1676]: time="2026-10-15T15:01:35Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 15 15:01:35 studio-volumio go-librespot[1676]: time="2026-10-15T15:01:35Z" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 15 15:01:35 studio-volumio go-librespot[1676]: time="2026-10-15T15:01:35Z" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 15 15:01:35 studio-volumio go-librespot[1676]: time="2026-10-15T15:01:35Z" level=info msg="zeroconf server listening on port 32955" Oct 15 15:01:35 studio-volumio go-librespot[1676]: time="2026-10-15T15:01:35Z" level=debug msg="obtained new client token: AAFI/ZWETpDBeO8JBtfJ80uynZdtKIQqq3ErrEMXt+Jh+31xCO8/ZDYjOKMNzl1zKh9ALU2yJQxjld2fqrP7JFMFOfPTvO7+ZlX7Nh0D7pP8FdGs91CvbATBWspDkHTFMHdZGFlFDSgMOzwG3e8nvN4C3oZYD+v2Wa70ISJ2n5pUDkuoENRrjKHBNfSDyp0TtVB51cGNWR15oj4bmeK2EhW8Pzzi39dj9bDc42eCmtesomX+BjypyFGWMg==" Oct 15 15:01:35 studio-volumio go-librespot[1676]: time="2026-10-15T15:01:35Z" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 15 15:01:35 studio-volumio go-librespot[1676]: time="2026-10-15T15:01:35Z" level=debug msg="completed keyexchange" Oct 15 15:01:35 studio-volumio go-librespot[1676]: time="2026-10-15T15:01:35Z" level=debug msg="completed challenge" Oct 15 15:01:35 studio-volumio go-librespot[1676]: time="2026-10-15T15:01:35Z" level=info msg="authenticated AP" username="an*********te" Oct 15 15:01:37 studio-volumio go-librespot[1676]: time="2026-10-15T15:01:37Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 15 15:01:37 studio-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 15 15:01:37 studio-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 15 15:01:38 studio-volumio volumio[810]: info: Initializing connection to go-librespot Websocket Oct 15 15:01:38 studio-volumio volumio[810]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 15 15:01:40 studio-volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 15 15:01:40 studio-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20813. Oct 15 15:01:40 studio-volumio systemd[1]: Stopped go-librespot Daemon. Oct 15 15:01:40 studio-volumio systemd[1]: Started go-librespot Daemon. Oct 15 15:01:40 studio-volumio go-librespot[1684]: go-librespot daemon starting... Oct 15 15:01:40 studio-volumio go-librespot[1684]: time="2026-10-15T15:01:40Z" level=info msg="running go-librespot 0.4.0" Oct 15 15:01:40 studio-volumio go-librespot[1684]: time="2026-10-15T15:01:40Z" level=debug msg="app state loaded" Oct 15 15:01:40 studio-volumio go-librespot[1684]: time="2026-10-15T15:01:40Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 15 15:01:40 studio-volumio go-librespot[1684]: time="2026-10-15T15:01:40Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 15 15:01:40 studio-volumio go-librespot[1684]: time="2026-10-15T15:01:40Z" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 15 15:01:40 studio-volumio go-librespot[1684]: time="2026-10-15T15:01:40Z" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 15 15:01:40 studio-volumio go-librespot[1684]: time="2026-10-15T15:01:40Z" level=info msg="zeroconf server listening on port 46687" Oct 15 15:01:41 studio-volumio volumio[810]: info: Initializing connection to go-librespot Websocket Oct 15 15:01:42 studio-volumio go-librespot[1684]: time="2026-10-15T15:01:42Z" level=debug msg="new websocket client" Oct 15 15:01:42 studio-volumio volumio[810]: info: Connection to go-librespot Websocket established Oct 15 15:01:42 studio-volumio go-librespot[1684]: time="2026-10-15T15:01:42Z" level=debug msg="obtained new client token: AAGnhyn1O4GJWsJXBgERx/dKdbwY8/4tcuFmgyfnnQVLRHyth3Ezgo8Bv4in0jnwQIYmLMqpoa2KB6erh6Fn3dDPkSoomi7vAYPCXgASz6nIKya+B4TJ8eNA480+RTI36CADVYlwdgywj0pxzbQsa7QMw0iQba6XNsnN4KjAZX0G8mLmgpA7ewqrysdD9LnBhwOhZMOZCRAFH4pbIwh2GZAUzJ73WMffcKINpRy7CicYlTIs0ylovU8=" Oct 15 15:01:42 studio-volumio go-librespot[1684]: time="2026-10-15T15:01:42Z" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 15 15:01:42 studio-volumio go-librespot[1684]: time="2026-10-15T15:01:42Z" level=debug msg="completed keyexchange" Oct 15 15:01:42 studio-volumio go-librespot[1684]: time="2026-10-15T15:01:42Z" level=debug msg="completed challenge" Oct 15 15:01:42 studio-volumio go-librespot[1684]: time="2026-10-15T15:01:42Z" level=info msg="authenticated AP" username="an*********te" Oct 15 15:01:42 studio-volumio go-librespot[1684]: time="2026-10-15T15:01:42Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 15 15:01:42 studio-volumio volumio[810]: info: Connection to go-librespot Websocket closed Oct 15 15:01:42 studio-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 15 15:01:42 studio-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 15 15:01:45 studio-volumio volumio[810]: info: Getting Spotify volume Oct 15 15:01:45 studio-volumio volumio[810]: (node:810) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 15 15:01:45 studio-volumio volumio[810]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 15 15:01:45 studio-volumio volumio[810]: (node:810) 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: 18353) Oct 15 15:01:45 studio-volumio volumio[810]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Oct 15 15:01:45 studio-volumio volumio[810]: info: CoreCommandRouter::volumioGetState Oct 15 15:01:45 studio-volumio volumio[810]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Oct 15 15:01:45 studio-volumio volumio[810]: info: Initializing connection to go-librespot Websocket Oct 15 15:01:45 studio-volumio volumio[810]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 15 15:01:45 studio-volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 15 15:01:45 studio-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20814. Oct 15 15:01:45 studio-volumio systemd[1]: Stopped go-librespot Daemon. Oct 15 15:01:45 studio-volumio systemd[1]: Started go-librespot Daemon. Oct 15 15:01:45 studio-volumio go-librespot[1693]: go-librespot daemon starting... Oct 15 15:01:45 studio-volumio go-librespot[1693]: time="2026-10-15T15:01:45Z" level=info msg="running go-librespot 0.4.0" Oct 15 15:01:45 studio-volumio go-librespot[1693]: time="2026-10-15T15:01:45Z" level=debug msg="app state loaded" Oct 15 15:01:45 studio-volumio go-librespot[1693]: time="2026-10-15T15:01:45Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 15 15:01:47 studio-volumio go-librespot[1693]: time="2026-10-15T15:01:47Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 15 15:01:47 studio-volumio go-librespot[1693]: time="2026-10-15T15:01:47Z" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 15 15:01:47 studio-volumio go-librespot[1693]: time="2026-10-15T15:01:47Z" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 15 15:01:47 studio-volumio go-librespot[1693]: time="2026-10-15T15:01:47Z" level=info msg="zeroconf server listening on port 43847" Oct 15 15:01:47 studio-volumio go-librespot[1693]: time="2026-10-15T15:01:47Z" level=debug msg="obtained new client token: AAFX69csNDZ/isw86C1S3XJOrdiGxFqXDUp/B2RvGRuEZhtCl32CKNww2z3Uklwcv8QA1m+eURuWY2blMeSBIs2mvvtleqNXvDC2/uzDdRHnSpxMMm/LYROE6NtNO9BYX4WlroaGeLfMqsCIlbsE+Dy/f58EaPtU9qLhf//wUamd8kYezsYAiyv1mlbu9viTlZXs4TsGQb7GOeds1cyFswsU/rGfwrqoCzaH9pJauq66vEya6Qjoh0gbgw==" Oct 15 15:01:47 studio-volumio go-librespot[1693]: time="2026-10-15T15:01:47Z" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 15 15:01:47 studio-volumio go-librespot[1693]: time="2026-10-15T15:01:47Z" level=debug msg="completed keyexchange" Oct 15 15:01:47 studio-volumio go-librespot[1693]: time="2026-10-15T15:01:47Z" level=debug msg="completed challenge" Oct 15 15:01:47 studio-volumio go-librespot[1693]: time="2026-10-15T15:01:47Z" level=info msg="authenticated AP" username="an*********te" Oct 15 15:01:47 studio-volumio go-librespot[1693]: time="2026-10-15T15:01:47Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 15 15:01:47 studio-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 15 15:01:47 studio-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 15 15:01:48 studio-volumio volumio[810]: info: Initializing connection to go-librespot Websocket Oct 15 15:01:49 studio-volumio volumio[810]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 15 15:01:50 studio-volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 15 15:01:50 studio-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20815. Oct 15 15:01:50 studio-volumio systemd[1]: Stopped go-librespot Daemon. Oct 15 15:01:50 studio-volumio systemd[1]: Started go-librespot Daemon. Oct 15 15:01:50 studio-volumio go-librespot[1701]: go-librespot daemon starting... Oct 15 15:01:50 studio-volumio go-librespot[1701]: time="2026-10-15T15:01:50Z" level=info msg="running go-librespot 0.4.0" Oct 15 15:01:50 studio-volumio go-librespot[1701]: time="2026-10-15T15:01:50Z" level=debug msg="app state loaded" Oct 15 15:01:50 studio-volumio go-librespot[1701]: time="2026-10-15T15:01:50Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 15 15:01:52 studio-volumio go-librespot[1701]: time="2026-10-15T15:01:52Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 15 15:01:52 studio-volumio go-librespot[1701]: time="2026-10-15T15:01:52Z" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 15 15:01:52 studio-volumio go-librespot[1701]: time="2026-10-15T15:01:52Z" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 15 15:01:52 studio-volumio go-librespot[1701]: time="2026-10-15T15:01:52Z" level=info msg="zeroconf server listening on port 37671" Oct 15 15:01:52 studio-volumio go-librespot[1701]: time="2026-10-15T15:01:52Z" level=debug msg="obtained new client token: AAGm/mS6lyfyhgMgUPzrjsXmC5lms386lDmHY5CeD+vHZP2MBPF/tqEEktMZ8mgvpNi7U/DhuTdekDX7aqTq+at/D8NdzeSTF7MhyjdJZ6VrbhqY+JGHOHx2Wk2+YF6de/AyG0+BmAEpXeO/XVb2Xq0PB8bc1e6z2XOvLLkLCHBl33zo07N0W9Oxy1zcThPpCH3tMAbQSKU0SkhQNbbOtQT3NX+A1d/6lsvnI7AQ0o7iwSSaWhi2lN7zEw==" Oct 15 15:01:52 studio-volumio go-librespot[1701]: time="2026-10-15T15:01:52Z" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 15 15:01:52 studio-volumio go-librespot[1701]: time="2026-10-15T15:01:52Z" level=debug msg="completed keyexchange" Oct 15 15:01:52 studio-volumio go-librespot[1701]: time="2026-10-15T15:01:52Z" level=debug msg="completed challenge" Oct 15 15:01:52 studio-volumio volumio[810]: info: Initializing connection to go-librespot Websocket Oct 15 15:01:52 studio-volumio go-librespot[1701]: time="2026-10-15T15:01:52Z" level=debug msg="new websocket client" Oct 15 15:01:52 studio-volumio volumio[810]: info: Connection to go-librespot Websocket established Oct 15 15:01:52 studio-volumio go-librespot[1701]: time="2026-10-15T15:01:52Z" level=info msg="authenticated AP" username="an*********te" Oct 15 15:01:52 studio-volumio go-librespot[1701]: time="2026-10-15T15:01:52Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 15 15:01:52 studio-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 15 15:01:52 studio-volumio volumio[810]: info: Connection to go-librespot Websocket closed Oct 15 15:01:52 studio-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 15 15:01:55 studio-volumio volumio[810]: info: Getting Spotify volume Oct 15 15:01:55 studio-volumio volumio[810]: (node:810) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 15 15:01:55 studio-volumio volumio[810]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 15 15:01:55 studio-volumio volumio[810]: (node:810) 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: 18354) Oct 15 15:01:55 studio-volumio volumio[810]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Oct 15 15:01:55 studio-volumio volumio[810]: info: Initializing connection to go-librespot Websocket Oct 15 15:01:56 studio-volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 15 15:01:56 studio-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20816. Oct 15 15:01:56 studio-volumio systemd[1]: Stopped go-librespot Daemon. Oct 15 15:01:56 studio-volumio systemd[1]: Started go-librespot Daemon. Oct 15 15:01:56 studio-volumio go-librespot[1709]: go-librespot daemon starting... Oct 15 15:01:56 studio-volumio go-librespot[1709]: time="2026-10-15T15:01:56Z" level=info msg="running go-librespot 0.4.0" Oct 15 15:01:56 studio-volumio go-librespot[1709]: time="2026-10-15T15:01:56Z" level=debug msg="app state loaded" Oct 15 15:01:56 studio-volumio go-librespot[1709]: time="2026-10-15T15:01:56Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 15 15:01:57 studio-volumio go-librespot[1709]: time="2026-10-15T15:01:57Z" level=debug msg="new websocket client" Oct 15 15:01:57 studio-volumio volumio[810]: info: Connection to go-librespot Websocket established Oct 15 15:01:57 studio-volumio volumio[810]: info: CoreCommandRouter::volumioGetState Oct 15 15:01:57 studio-volumio volumio[810]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Oct 15 15:01:57 studio-volumio go-librespot[1709]: time="2026-10-15T15:01:57Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 15 15:01:57 studio-volumio go-librespot[1709]: time="2026-10-15T15:01:57Z" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 15 15:01:57 studio-volumio go-librespot[1709]: time="2026-10-15T15:01:57Z" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 15 15:01:57 studio-volumio go-librespot[1709]: time="2026-10-15T15:01:57Z" level=info msg="zeroconf server listening on port 44991" Oct 15 15:01:57 studio-volumio go-librespot[1709]: time="2026-10-15T15:01:57Z" level=debug msg="obtained new client token: AAFUtK8jqXurrGvIAX/mKlPDaepjW1F4R9R5BGtydCt7rFoA+I8EjhuLdKRMz1bO/D93bjV0VJkTZzRY6uUzldTXDV6IJ95Vwjl+/WUTho1QCL4f583BQYJliEILrixUBd5Z361RcX3SMDHvac5Xf+SbICDbVaBjy/zCVIhJpi7W9famp4ZpDQ9qXvkYMHAfjXn34qOwKJYprmhimqtp3lCuFsnKw2M9EnjJcKIIhfFEDeQyAsYJVDYCTA==" Oct 15 15:01:57 studio-volumio go-librespot[1709]: time="2026-10-15T15:01:57Z" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 15 15:01:57 studio-volumio go-librespot[1709]: time="2026-10-15T15:01:57Z" level=debug msg="completed keyexchange" Oct 15 15:01:57 studio-volumio go-librespot[1709]: time="2026-10-15T15:01:57Z" level=debug msg="completed challenge" Oct 15 15:01:57 studio-volumio go-librespot[1709]: time="2026-10-15T15:01:57Z" level=info msg="authenticated AP" username="an*********te" Oct 15 15:01:58 studio-volumio go-librespot[1709]: time="2026-10-15T15:01:58Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 15 15:01:58 studio-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 15 15:01:58 studio-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 15 15:01:58 studio-volumio volumio[810]: info: Connection to go-librespot Websocket closed Oct 15 15:02:00 studio-volumio volumio[810]: info: Getting Spotify volume Oct 15 15:02:00 studio-volumio volumio[810]: (node:810) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 15 15:02:00 studio-volumio volumio[810]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 15 15:02:00 studio-volumio volumio[810]: (node:810) 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: 18355) Oct 15 15:02:00 studio-volumio volumio[810]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Oct 15 15:02:00 studio-volumio volumio[810]: info: CoreCommandRouter::volumioGetState Oct 15 15:02:00 studio-volumio volumio[810]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Oct 15 15:02:01 studio-volumio volumio[810]: info: Initializing connection to go-librespot Websocket Oct 15 15:02:01 studio-volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 15 15:02:01 studio-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20817. Oct 15 15:02:01 studio-volumio systemd[1]: Stopped go-librespot Daemon. Oct 15 15:02:01 studio-volumio systemd[1]: Started go-librespot Daemon. Oct 15 15:02:01 studio-volumio go-librespot[1717]: go-librespot daemon starting... Oct 15 15:02:01 studio-volumio go-librespot[1717]: time="2026-10-15T15:02:01Z" level=info msg="running go-librespot 0.4.0" Oct 15 15:02:01 studio-volumio go-librespot[1717]: time="2026-10-15T15:02:01Z" level=debug msg="app state loaded" Oct 15 15:02:01 studio-volumio go-librespot[1717]: time="2026-10-15T15:02:01Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 15 15:02:02 studio-volumio go-librespot[1717]: time="2026-10-15T15:02:02Z" level=debug msg="new websocket client" Oct 15 15:02:02 studio-volumio volumio[810]: info: Connection to go-librespot Websocket established Oct 15 15:02:02 studio-volumio go-librespot[1717]: time="2026-10-15T15:02:02Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 15 15:02:02 studio-volumio go-librespot[1717]: time="2026-10-15T15:02:02Z" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 15 15:02:02 studio-volumio go-librespot[1717]: time="2026-10-15T15:02:02Z" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 15 15:02:02 studio-volumio go-librespot[1717]: time="2026-10-15T15:02:02Z" level=info msg="zeroconf server listening on port 45003" Oct 15 15:02:02 studio-volumio go-librespot[1717]: time="2026-10-15T15:02:02Z" level=debug msg="obtained new client token: AAF+2OburK3Uctr+H5Ac/Tir6LjPFlQ96rmQvHUMybg/xZaBcnjQJ2mFVt6p1UcjQHzjRxeMtJGysqb0nCRA2VCNp7EMbYJDzop+NClqRFfVtTLUP4VLOUVW13dT+tWUL3BCqcIhgUn2bBfMAWgDQafAAruIiPbBIE0PNapbrjYINtt+kCTAzwQdDkspcZZ9B1J79UYMIs3fVPoH/vb4ux/cKk0hTXypHb4+pIy4IVobnDycrgNQEYGkSA==" Oct 15 15:02:02 studio-volumio go-librespot[1717]: time="2026-10-15T15:02:02Z" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 15 15:02:02 studio-volumio go-librespot[1717]: time="2026-10-15T15:02:02Z" level=debug msg="completed keyexchange" Oct 15 15:02:02 studio-volumio go-librespot[1717]: time="2026-10-15T15:02:02Z" level=debug msg="completed challenge" Oct 15 15:02:02 studio-volumio go-librespot[1717]: time="2026-10-15T15:02:02Z" level=info msg="authenticated AP" username="an*********te" Oct 15 15:02:02 studio-volumio go-librespot[1717]: time="2026-10-15T15:02:02Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 15 15:02:02 studio-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 15 15:02:02 studio-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 15 15:02:02 studio-volumio volumio[810]: info: Connection to go-librespot Websocket closed Oct 15 15:02:05 studio-volumio volumio[810]: info: Getting Spotify volume Oct 15 15:02:05 studio-volumio volumio[810]: (node:810) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 15 15:02:05 studio-volumio volumio[810]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 15 15:02:05 studio-volumio volumio[810]: (node:810) 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: 18356) Oct 15 15:02:05 studio-volumio volumio[810]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Oct 15 15:02:05 studio-volumio volumio[810]: info: CoreCommandRouter::volumioGetState Oct 15 15:02:05 studio-volumio volumio[810]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Oct 15 15:02:05 studio-volumio volumio[810]: info: Initializing connection to go-librespot Websocket Oct 15 15:02:06 studio-volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 15 15:02:06 studio-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20818. Oct 15 15:02:06 studio-volumio systemd[1]: Stopped go-librespot Daemon. Oct 15 15:02:06 studio-volumio systemd[1]: Started go-librespot Daemon. Oct 15 15:02:06 studio-volumio go-librespot[1726]: go-librespot daemon starting... Oct 15 15:02:06 studio-volumio go-librespot[1726]: time="2026-10-15T15:02:06Z" level=info msg="running go-librespot 0.4.0" Oct 15 15:02:06 studio-volumio go-librespot[1726]: time="2026-10-15T15:02:06Z" level=debug msg="app state loaded" Oct 15 15:02:06 studio-volumio go-librespot[1726]: time="2026-10-15T15:02:06Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 15 15:02:07 studio-volumio go-librespot[1726]: time="2026-10-15T15:02:07Z" level=debug msg="new websocket client" Oct 15 15:02:07 studio-volumio volumio[810]: info: Connection to go-librespot Websocket established Oct 15 15:02:07 studio-volumio go-librespot[1726]: time="2026-10-15T15:02:07Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 15 15:02:07 studio-volumio go-librespot[1726]: time="2026-10-15T15:02:07Z" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 15 15:02:07 studio-volumio go-librespot[1726]: time="2026-10-15T15:02:07Z" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 15 15:02:07 studio-volumio go-librespot[1726]: time="2026-10-15T15:02:07Z" level=info msg="zeroconf server listening on port 35799" Oct 15 15:02:07 studio-volumio go-librespot[1726]: time="2026-10-15T15:02:07Z" level=debug msg="obtained new client token: AAEEkphinvzelNwhE+7CfA7nd9ZuUl+BxTkDYQ9EiOgp2wUo1ovBdhyJ5gIsnj/rMs9REpOqrnmsvgFFh82Ie2r2QeDibJOi39RnNeFYYCmOKseYuEduGu4L7QvQP30G93l64jO6EKCVFWXaUmZSHhpXmoZws1wyOrt17WF1rk/lCf26KyvNsR3KDRIxmxLdyYPss+BssG15DkHGutCwNjp80rdCMKTP7IUbrkb4KQwDAFpjTGOzmAViYA==" Oct 15 15:02:07 studio-volumio go-librespot[1726]: time="2026-10-15T15:02:07Z" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 15 15:02:07 studio-volumio go-librespot[1726]: time="2026-10-15T15:02:07Z" level=debug msg="completed keyexchange" Oct 15 15:02:07 studio-volumio go-librespot[1726]: time="2026-10-15T15:02:07Z" level=debug msg="completed challenge" Oct 15 15:02:07 studio-volumio go-librespot[1726]: time="2026-10-15T15:02:07Z" level=info msg="authenticated AP" username="an*********te" Oct 15 15:02:07 studio-volumio go-librespot[1726]: time="2026-10-15T15:02:07Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 15 15:02:07 studio-volumio volumio[810]: info: Connection to go-librespot Websocket closed Oct 15 15:02:07 studio-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 15 15:02:07 studio-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 15 15:02:10 studio-volumio volumio[810]: info: Getting Spotify volume Oct 15 15:02:10 studio-volumio volumio[810]: (node:810) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 15 15:02:10 studio-volumio volumio[810]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 15 15:02:10 studio-volumio volumio[810]: (node:810) 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: 18357) Oct 15 15:02:10 studio-volumio volumio[810]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Oct 15 15:02:10 studio-volumio volumio[810]: info: CoreCommandRouter::volumioGetState Oct 15 15:02:10 studio-volumio volumio[810]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Oct 15 15:02:10 studio-volumio volumio[810]: info: Initializing connection to go-librespot Websocket Oct 15 15:02:11 studio-volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 15 15:02:11 studio-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20819. Oct 15 15:02:11 studio-volumio systemd[1]: Stopped go-librespot Daemon. Oct 15 15:02:11 studio-volumio systemd[1]: Started go-librespot Daemon. Oct 15 15:02:11 studio-volumio go-librespot[1734]: go-librespot daemon starting... Oct 15 15:02:11 studio-volumio go-librespot[1734]: time="2026-10-15T15:02:11Z" level=info msg="running go-librespot 0.4.0" Oct 15 15:02:11 studio-volumio go-librespot[1734]: time="2026-10-15T15:02:11Z" level=debug msg="app state loaded" Oct 15 15:02:11 studio-volumio go-librespot[1734]: time="2026-10-15T15:02:11Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 15 15:02:12 studio-volumio go-librespot[1734]: time="2026-10-15T15:02:12Z" level=debug msg="new websocket client" Oct 15 15:02:12 studio-volumio volumio[810]: info: Connection to go-librespot Websocket established Oct 15 15:02:12 studio-volumio go-librespot[1734]: time="2026-10-15T15:02:12Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 15 15:02:12 studio-volumio go-librespot[1734]: time="2026-10-15T15:02:12Z" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 15 15:02:12 studio-volumio go-librespot[1734]: time="2026-10-15T15:02:12Z" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 15 15:02:12 studio-volumio go-librespot[1734]: time="2026-10-15T15:02:12Z" level=info msg="zeroconf server listening on port 32821" Oct 15 15:02:12 studio-volumio vtcs[1456]: [2026-10-15 15:02:12.529] [tisoc] [error] [avahiImpl.cpp:113] avahiClientCallback() AVAHI_CLIENT_S_COLLISION/AVAHI_CLIENT_FAILURE Oct 15 15:02:12 studio-volumio systemd[1]: avahi-daemon.service: Main process exited, code=killed, status=11/SEGV Oct 15 15:02:12 studio-volumio systemd[1]: avahi-daemon.service: Failed with result 'signal'. Oct 15 15:02:12 studio-volumio volumio[810]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 15:02:12 studio-volumio systemd[1]: wpa_supplicant.service: Succeeded. Oct 15 15:02:12 studio-volumio systemd[1]: bluetooth.service: Main process exited, code=killed, status=11/SEGV Oct 15 15:02:12 studio-volumio systemd[1]: bluetooth.service: Failed with result 'signal'. Oct 15 15:02:12 studio-volumio sudo[1743]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Oct 15 15:02:12 studio-volumio systemd[1]: dbus.service: Main process exited, code=killed, status=11/SEGV Oct 15 15:02:12 studio-volumio systemd[1]: dbus.service: Failed with result 'signal'. Oct 15 15:02:12 studio-volumio sudo[1743]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 15:02:12 studio-volumio volumio[810]: Error: dns service error: unknown Oct 15 15:02:12 studio-volumio volumio[810]: at Browser.on_service_changed (/volumio/node_modules/mdns/lib/browser.js:84:33) Oct 15 15:02:12 studio-volumio volumio[810]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Oct 15 15:02:12 studio-volumio volumio[810]: errorCode: -65537 Oct 15 15:02:12 studio-volumio volumio[810]: } Oct 15 15:02:12 studio-volumio volumio[810]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 15:02:12 studio-volumio volumiobt[1438]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Oct 15 15:02:12 studio-volumio sudo[1743]: pam_unix(sudo:session): session closed for user root Oct 15 15:02:12 studio-volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=11/SEGV Oct 15 15:02:12 studio-volumio systemd[1]: shairport-sync.service: Failed with result 'signal'. Oct 15 15:02:12 studio-volumio systemd[1]: volumiobt.service: Main process exited, code=exited, status=1/FAILURE Oct 15 15:02:12 studio-volumio systemd[1]: rtkit-daemon.service: Main process exited, code=killed, status=11/SEGV Oct 15 15:02:12 studio-volumio systemd[1]: rtkit-daemon.service: Failed with result 'signal'. Oct 15 15:02:12 studio-volumio systemd[1]: Started D-Bus System Message Bus. Oct 15 15:02:12 studio-volumio go-librespot[1734]: time="2026-10-15T15:02:12Z" level=debug msg="obtained new client token: AAEd6qSqaJTH2qu6u79HomCWDYGUn/Ga2ou7C4ZgI+YYE8jDaOcWZmLl3ClVjCksggJ6Vnhiw1DgGuZlQAiTBBdz84ujOUtgZfLVZhV/BDQ/G3NDqrPxerUsiiQl2ykK7DhtwKodnyUiBAagjhKISkuuFiLgilWbRKPlkXl4UQ94BT+B2br/+ewlSeSUp7gKTl9zTCZxJe8hifQh5ePkUBLk1LlKf6EHitJFW3KeEn/OVKhiWVSAs9DOpQ==" Oct 15 15:02:12 studio-volumio systemd[1]: polkit.service: Main process exited, code=killed, status=11/SEGV Oct 15 15:02:12 studio-volumio systemd[1]: polkit.service: Failed with result 'signal'. Oct 15 15:02:12 studio-volumio systemd[1]: volumiobt.service: Failed with result 'exit-code'. Oct 15 15:02:12 studio-volumio dbus-daemon[1748]: [system] Activating via systemd: service name='org.freedesktop.Avahi' unit='dbus-org.freedesktop.Avahi.service' requested by ':1.0' (uid=0 pid=826 comm="/usr/sbin/smbd --foreground --no-process-group ") Oct 15 15:02:12 studio-volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Oct 15 15:02:12 studio-volumio systemd[1]: systemd-logind.service: Succeeded. Oct 15 15:02:12 studio-volumio go-librespot[1734]: time="2026-10-15T15:02:12Z" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 15 15:02:12 studio-volumio avahi-daemon[1756]: Process 474 died: No such process; trying to remove PID file. (/run/avahi-daemon//pid) Oct 15 15:02:12 studio-volumio avahi-daemon[1756]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Oct 15 15:02:12 studio-volumio avahi-daemon[1756]: Successfully dropped root privileges. Oct 15 15:02:12 studio-volumio avahi-daemon[1756]: avahi-daemon 0.7 starting up. Oct 15 15:02:12 studio-volumio systemd[1]: systemd-logind.service: Service has no hold-off time (RestartSec=0), scheduling restart. Oct 15 15:02:12 studio-volumio systemd[1]: systemd-logind.service: Scheduled restart job, restart counter is at 1. Oct 15 15:02:12 studio-volumio systemd[1]: Stopped Login Service. Oct 15 15:02:12 studio-volumio dbus-daemon[1748]: [system] Successfully activated service 'org.freedesktop.Avahi' Oct 15 15:02:12 studio-volumio systemd[1]: Starting Login Service... Oct 15 15:02:12 studio-volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack. Oct 15 15:02:12 studio-volumio avahi-daemon[1756]: Successfully called chroot(). Oct 15 15:02:12 studio-volumio avahi-daemon[1756]: Successfully dropped remaining capabilities. Oct 15 15:02:12 studio-volumio avahi-daemon[1756]: Loading service file /services/volumio.service. Oct 15 15:02:12 studio-volumio avahi-daemon[1756]: *** WARNING: Detected another IPv4 mDNS stack running on this host. This makes mDNS unreliable and is thus not recommended. *** Oct 15 15:02:12 studio-volumio avahi-daemon[1756]: *** WARNING: Detected another IPv6 mDNS stack running on this host. This makes mDNS unreliable and is thus not recommended. *** Oct 15 15:02:12 studio-volumio avahi-daemon[1756]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.89. Oct 15 15:02:12 studio-volumio avahi-daemon[1756]: New relevant interface wlan0.IPv4 for mDNS. Oct 15 15:02:12 studio-volumio avahi-daemon[1756]: Network interface enumeration completed. Oct 15 15:02:12 studio-volumio avahi-daemon[1756]: Registering new address record for 192.168.178.89 on wlan0.IPv4. Oct 15 15:02:12 studio-volumio go-librespot[1734]: time="2026-10-15T15:02:12Z" level=debug msg="completed keyexchange" Oct 15 15:02:12 studio-volumio go-librespot[1734]: time="2026-10-15T15:02:12Z" level=debug msg="completed challenge" Oct 15 15:02:12 studio-volumio systemd-logind[1758]: New seat seat0. Oct 15 15:02:12 studio-volumio go-librespot[1734]: time="2026-10-15T15:02:12Z" level=info msg="authenticated AP" username="an*********te" Oct 15 15:02:12 studio-volumio systemd[1]: Started Login Service. Oct 15 15:02:12 studio-volumio go-librespot[1734]: time="2026-10-15T15:02:12Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 15 15:02:12 studio-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 15 15:02:12 studio-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 15 15:02:13 studio-volumio avahi-daemon[1756]: Server startup complete. Host name is studio-volumio.local. Local service cookie is 1002267709. Oct 15 15:02:14 studio-volumio avahi-daemon[1756]: Service "Studio-Volumio" (/services/volumio.service) successfully established. Oct 15 15:02:14 studio-volumio sudo[1762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-15 15:01 Oct 15 15:02:14 studio-volumio sudo[1762]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="91e88ea6c5c4ec4f00aff63f7c3a2944b14ec939" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="8e6823482d6af342172ec9fdc1c15b0dd02653d2" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 04 Dec 2022 08:41:29 PM CET" VOLUMIO_VERSION="3.396" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d460c75d04818d0f55c67627fa362668"