Oct 14 23:06:00 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:00 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:02 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70342. Oct 14 23:06:02 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:02 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:02 khanh-pham go-librespot[2045323]: go-librespot daemon starting... Oct 14 23:06:02 khanh-pham go-librespot[2045324]: time="2026-10-14T23:06:02+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:06:02 khanh-pham go-librespot[2045324]: time="2026-10-14T23:06:02+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:06:02 khanh-pham go-librespot[2045324]: time="2026-10-14T23:06:02+07:00" level=debug msg="app state loaded" Oct 14 23:06:02 khanh-pham go-librespot[2045324]: time="2026-10-14T23:06:02+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:06:02 khanh-pham go-librespot[2045324]: time="2026-10-14T23:06:02+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:06:02 khanh-pham go-librespot[2045324]: time="2026-10-14T23:06:02+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:06:02 khanh-pham go-librespot[2045324]: time="2026-10-14T23:06:02+07:00" level=info msg="zeroconf server listening on port 37933" Oct 14 23:06:02 khanh-pham go-librespot[2045324]: time="2026-10-14T23:06:02+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:06:02 khanh-pham go-librespot[2045324]: time="2026-10-14T23:06:02+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:06:02 khanh-pham go-librespot[2045324]: time="2026-10-14T23:06:02+07:00" level=debug msg="obtained new client token: AAErvyu1NvAGp4wMu6XCyE99p5/onVrQnT/WV9bUEpg8tJVMDuP5+315opHMHxtRYOp3yojtx7XLYaHUAqeANQJwPUN3KfV3WaMmVHxYDAmG2fR46HUv1xCMv8Qc5VQsdBmgdW7UGUCX7ODtb5Q+VIgqYAYOJMk0xikS2JjQtDJvhCuXeW9Nsqm2uHqPPenXILWLfL8p2hWHcltBs5S2V3RiQKKmRI6abvZQx3ZErSc9/frFA1M6Wp9Hhec=" Oct 14 23:06:02 khanh-pham go-librespot[2045324]: time="2026-10-14T23:06:02+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:06:02 khanh-pham go-librespot[2045324]: time="2026-10-14T23:06:02+07:00" level=debug msg="completed keyexchange" Oct 14 23:06:02 khanh-pham go-librespot[2045324]: time="2026-10-14T23:06:02+07:00" level=debug msg="completed challenge" Oct 14 23:06:03 khanh-pham go-librespot[2045324]: time="2026-10-14T23:06:03+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:06:03 khanh-pham go-librespot[2045324]: time="2026-10-14T23:06:03+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:06:03 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:06:03 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:06:03 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:03 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:06 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:06 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:06 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70343. Oct 14 23:06:06 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:06 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:06 khanh-pham go-librespot[2045355]: go-librespot daemon starting... Oct 14 23:06:06 khanh-pham go-librespot[2045356]: time="2026-10-14T23:06:06+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:06:06 khanh-pham go-librespot[2045356]: time="2026-10-14T23:06:06+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:06:06 khanh-pham go-librespot[2045356]: time="2026-10-14T23:06:06+07:00" level=debug msg="app state loaded" Oct 14 23:06:06 khanh-pham go-librespot[2045356]: time="2026-10-14T23:06:06+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:06:06 khanh-pham go-librespot[2045356]: time="2026-10-14T23:06:06+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:06:06 khanh-pham go-librespot[2045356]: time="2026-10-14T23:06:06+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:06:06 khanh-pham go-librespot[2045356]: time="2026-10-14T23:06:06+07:00" level=info msg="zeroconf server listening on port 37197" Oct 14 23:06:06 khanh-pham go-librespot[2045356]: time="2026-10-14T23:06:06+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:06:06 khanh-pham go-librespot[2045356]: time="2026-10-14T23:06:06+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:06:06 khanh-pham go-librespot[2045356]: time="2026-10-14T23:06:06+07:00" level=debug msg="obtained new client token: AAEsS+ch/LLrxnQ6m6Oqv0fr3edptH9REd10tXYYEo3jo+64jnXsAP6s4VhwKyb+Nv7/jnFnkFn/n8jySIcAF7Wgo0LJEAH/CfNGqr8xeYFia88qD7GdQG/b2nR8lGYEXxezXl2vJKvisQ7xXKu8mdNqw8KsCdvBNM30hEkOk0z00V9BdoMB9iweDaCLP5hju750QUBTb64kYPmNTwiiVY+JQU5/3xLdnSCKJQhP9yw063KD9EsPwTCkWQQ=" Oct 14 23:06:06 khanh-pham go-librespot[2045356]: time="2026-10-14T23:06:06+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:06:06 khanh-pham go-librespot[2045356]: time="2026-10-14T23:06:06+07:00" level=debug msg="completed keyexchange" Oct 14 23:06:06 khanh-pham go-librespot[2045356]: time="2026-10-14T23:06:06+07:00" level=debug msg="completed challenge" Oct 14 23:06:07 khanh-pham go-librespot[2045356]: time="2026-10-14T23:06:07+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:06:07 khanh-pham go-librespot[2045356]: time="2026-10-14T23:06:07+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:06:07 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:06:07 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:06:09 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:09 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:10 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70344. Oct 14 23:06:10 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:10 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:10 khanh-pham go-librespot[2045372]: go-librespot daemon starting... Oct 14 23:06:10 khanh-pham systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Oct 14 23:06:10 khanh-pham go-librespot[2045373]: time="2026-10-14T23:06:10+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:06:10 khanh-pham go-librespot[2045373]: time="2026-10-14T23:06:10+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:06:10 khanh-pham go-librespot[2045373]: time="2026-10-14T23:06:10+07:00" level=debug msg="app state loaded" Oct 14 23:06:10 khanh-pham go-librespot[2045373]: time="2026-10-14T23:06:10+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:06:10 khanh-pham go-librespot[2045373]: time="2026-10-14T23:06:10+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:06:10 khanh-pham go-librespot[2045373]: time="2026-10-14T23:06:10+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:06:10 khanh-pham go-librespot[2045373]: time="2026-10-14T23:06:10+07:00" level=info msg="zeroconf server listening on port 43999" Oct 14 23:06:10 khanh-pham go-librespot[2045373]: time="2026-10-14T23:06:10+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:06:10 khanh-pham go-librespot[2045373]: time="2026-10-14T23:06:10+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:06:10 khanh-pham go-librespot[2045373]: time="2026-10-14T23:06:10+07:00" level=debug msg="obtained new client token: AAFGK1TFZnHH7st+4xl4T6CHvH9xpBhljJaP35y5YKhslt2/eaNSPHU1ppdDuaYHlQ6RYlesnfjDXBREhf+T4jY3lksciSbUsIy1DiZKLZWoE3SrH+EBVwI4cnMT5d++DAc4Ht7QSZqrlFwpBrt01qPn2bV2roaT19x5V9e1v1gg/9iKVk4f9LXUvrGIwnPijPhJ9SoCx/LaIJBWLSNvRCWSbl6+d2cFrebfnrxp6mepV0HqT/4yxBKGQDM=" Oct 14 23:06:10 khanh-pham go-librespot[2045373]: time="2026-10-14T23:06:10+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:06:10 khanh-pham go-librespot[2045373]: time="2026-10-14T23:06:10+07:00" level=debug msg="completed keyexchange" Oct 14 23:06:10 khanh-pham go-librespot[2045373]: time="2026-10-14T23:06:10+07:00" level=debug msg="completed challenge" Oct 14 23:06:11 khanh-pham go-librespot[2045373]: time="2026-10-14T23:06:11+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:06:11 khanh-pham go-librespot[2045373]: time="2026-10-14T23:06:11+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:06:11 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:06:11 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:06:11 khanh-pham systemd[1]: setdatetime-helper.service: Deactivated successfully. Oct 14 23:06:11 khanh-pham systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Oct 14 23:06:12 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:12 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:14 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70345. Oct 14 23:06:14 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:14 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:14 khanh-pham go-librespot[2045413]: go-librespot daemon starting... Oct 14 23:06:14 khanh-pham go-librespot[2045415]: time="2026-10-14T23:06:14+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:06:14 khanh-pham go-librespot[2045415]: time="2026-10-14T23:06:14+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:06:14 khanh-pham go-librespot[2045415]: time="2026-10-14T23:06:14+07:00" level=debug msg="app state loaded" Oct 14 23:06:14 khanh-pham go-librespot[2045415]: time="2026-10-14T23:06:14+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:06:14 khanh-pham go-librespot[2045415]: time="2026-10-14T23:06:14+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:06:14 khanh-pham go-librespot[2045415]: time="2026-10-14T23:06:14+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:06:14 khanh-pham go-librespot[2045415]: time="2026-10-14T23:06:14+07:00" level=info msg="zeroconf server listening on port 38171" Oct 14 23:06:14 khanh-pham go-librespot[2045415]: time="2026-10-14T23:06:14+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:06:14 khanh-pham go-librespot[2045415]: time="2026-10-14T23:06:14+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:06:14 khanh-pham go-librespot[2045415]: time="2026-10-14T23:06:14+07:00" level=debug msg="obtained new client token: AAHycq7cSYZI8cC61DVkZits1on5llN5+OXb5BCRE8lvdvWA8fdRCYAO79g6QsCXGIp5nOCxKX83t/m5SghJRIA6OwAAEVOWTHgdR8ZGNaVfYrBNv5qETPZMlq6kWpK2IW1HrPpo8tvrTCzrVm5g2wCJsSD+vKBtf+ycyMiIRwAepTm2hZnWbQqJKIIKlKcCeS1NuC30BC3WRy6nJwfQQapmnSlco6bbp9P0/o8woN5951eAWNdiwV6cx9E=" Oct 14 23:06:14 khanh-pham go-librespot[2045415]: time="2026-10-14T23:06:14+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:06:14 khanh-pham go-librespot[2045415]: time="2026-10-14T23:06:14+07:00" level=debug msg="completed keyexchange" Oct 14 23:06:14 khanh-pham go-librespot[2045415]: time="2026-10-14T23:06:14+07:00" level=debug msg="completed challenge" Oct 14 23:06:15 khanh-pham go-librespot[2045415]: time="2026-10-14T23:06:15+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:06:15 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:15 khanh-pham go-librespot[2045415]: time="2026-10-14T23:06:15+07:00" level=debug msg="new websocket client" Oct 14 23:06:15 khanh-pham volumio[1392]: info: Connection to go-librespot Websocket established Oct 14 23:06:15 khanh-pham go-librespot[2045415]: time="2026-10-14T23:06:15+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:06:15 khanh-pham volumio[1392]: info: Connection to go-librespot Websocket closed Oct 14 23:06:15 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:06:15 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:06:18 khanh-pham volumio[1392]: info: Getting Spotify volume Oct 14 23:06:18 khanh-pham volumio[1392]: error: Failed to get Spotify volume from local API: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:18 khanh-pham volumio[1392]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 14 23:06:18 khanh-pham volumio[1392]: info: CoreCommandRouter::volumioGetState Oct 14 23:06:18 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:18 khanh-pham volumio[1392]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Oct 14 23:06:18 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:18 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70346. Oct 14 23:06:18 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:18 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:18 khanh-pham go-librespot[2045447]: go-librespot daemon starting... Oct 14 23:06:18 khanh-pham go-librespot[2045448]: time="2026-10-14T23:06:18+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:06:18 khanh-pham go-librespot[2045448]: time="2026-10-14T23:06:18+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:06:18 khanh-pham go-librespot[2045448]: time="2026-10-14T23:06:18+07:00" level=debug msg="app state loaded" Oct 14 23:06:18 khanh-pham go-librespot[2045448]: time="2026-10-14T23:06:18+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:06:18 khanh-pham go-librespot[2045448]: time="2026-10-14T23:06:18+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:06:18 khanh-pham go-librespot[2045448]: time="2026-10-14T23:06:18+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:06:18 khanh-pham go-librespot[2045448]: time="2026-10-14T23:06:18+07:00" level=info msg="zeroconf server listening on port 45673" Oct 14 23:06:18 khanh-pham go-librespot[2045448]: time="2026-10-14T23:06:18+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:06:18 khanh-pham go-librespot[2045448]: time="2026-10-14T23:06:18+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:06:19 khanh-pham go-librespot[2045448]: time="2026-10-14T23:06:19+07:00" level=debug msg="obtained new client token: AAH/Pg47XNhIeNg0YCii/NjXAIeqYi+WVOVeEuVw+hHPszs7nI2zZ3QP1SUylPXaoUSU6B6SRUW6WjnxSf6E2x77egEpdZ1nqkuiERQWUK3JwXMDKSS8GSQFLMmfqT92u1Yo+Nnh4uCFjui7k6zsH8wuOiOiDN/UScmy6la4GR2Kr21VC56bBqgTame2FBtYAG2/IKe6x1NFMYzj5B/tscPKER1UWJE3zgMWD6FFbDkTMYcZ8yKHcUr+" Oct 14 23:06:19 khanh-pham go-librespot[2045448]: time="2026-10-14T23:06:19+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:06:19 khanh-pham go-librespot[2045448]: time="2026-10-14T23:06:19+07:00" level=debug msg="completed keyexchange" Oct 14 23:06:19 khanh-pham go-librespot[2045448]: time="2026-10-14T23:06:19+07:00" level=debug msg="completed challenge" Oct 14 23:06:19 khanh-pham go-librespot[2045448]: time="2026-10-14T23:06:19+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:06:19 khanh-pham go-librespot[2045448]: time="2026-10-14T23:06:19+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:06:19 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:06:19 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:06:21 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:21 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:22 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70347. Oct 14 23:06:22 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:22 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:22 khanh-pham go-librespot[2045463]: go-librespot daemon starting... Oct 14 23:06:22 khanh-pham go-librespot[2045464]: time="2026-10-14T23:06:22+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:06:22 khanh-pham go-librespot[2045464]: time="2026-10-14T23:06:22+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:06:22 khanh-pham go-librespot[2045464]: time="2026-10-14T23:06:22+07:00" level=debug msg="app state loaded" Oct 14 23:06:22 khanh-pham go-librespot[2045464]: time="2026-10-14T23:06:22+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:06:22 khanh-pham go-librespot[2045464]: time="2026-10-14T23:06:22+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:06:22 khanh-pham go-librespot[2045464]: time="2026-10-14T23:06:22+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:06:22 khanh-pham go-librespot[2045464]: time="2026-10-14T23:06:22+07:00" level=info msg="zeroconf server listening on port 41859" Oct 14 23:06:22 khanh-pham go-librespot[2045464]: time="2026-10-14T23:06:22+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:06:22 khanh-pham go-librespot[2045464]: time="2026-10-14T23:06:22+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:06:23 khanh-pham go-librespot[2045464]: time="2026-10-14T23:06:23+07:00" level=debug msg="obtained new client token: AAFr1gkJaF5Ttd7Yjw34OXgCv+DaLef6uAl+lUjI+kNWqRD6ZUHiZ3KRJn649IpEiKXPXwi/Ql4oy+/f+ISR0KWT7bRZiKKzXoY9wvZGawOoLnvy3B5Q/yE6s5le7vVGwIOMhSiMrFRKvyV0Qg0Lph8uVfxCnSJfJW0YWrDpRnNIdfFsXbmIN6T/whG4BaqiwlJJUBm0wRPwcp1+tpnJFnjdkPVpA746uYsSSznmWuww1RZ4IE0tEGoA" Oct 14 23:06:23 khanh-pham go-librespot[2045464]: time="2026-10-14T23:06:23+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:06:23 khanh-pham go-librespot[2045464]: time="2026-10-14T23:06:23+07:00" level=debug msg="completed keyexchange" Oct 14 23:06:23 khanh-pham go-librespot[2045464]: time="2026-10-14T23:06:23+07:00" level=debug msg="completed challenge" Oct 14 23:06:23 khanh-pham go-librespot[2045464]: time="2026-10-14T23:06:23+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:06:23 khanh-pham go-librespot[2045464]: time="2026-10-14T23:06:23+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:06:23 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:06:23 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:06:24 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:24 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:26 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70348. Oct 14 23:06:26 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:26 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:26 khanh-pham go-librespot[2045494]: go-librespot daemon starting... Oct 14 23:06:26 khanh-pham go-librespot[2045495]: time="2026-10-14T23:06:26+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:06:26 khanh-pham go-librespot[2045495]: time="2026-10-14T23:06:26+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:06:26 khanh-pham go-librespot[2045495]: time="2026-10-14T23:06:26+07:00" level=debug msg="app state loaded" Oct 14 23:06:26 khanh-pham go-librespot[2045495]: time="2026-10-14T23:06:26+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:06:26 khanh-pham go-librespot[2045495]: time="2026-10-14T23:06:26+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:06:26 khanh-pham go-librespot[2045495]: time="2026-10-14T23:06:26+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:06:26 khanh-pham go-librespot[2045495]: time="2026-10-14T23:06:26+07:00" level=info msg="zeroconf server listening on port 39859" Oct 14 23:06:26 khanh-pham go-librespot[2045495]: time="2026-10-14T23:06:26+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:06:26 khanh-pham go-librespot[2045495]: time="2026-10-14T23:06:26+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:06:27 khanh-pham go-librespot[2045495]: time="2026-10-14T23:06:27+07:00" level=debug msg="obtained new client token: AAHIO2XvNzNkFWAasU/xALU1uH1a15myqzBxv13D2LV0F0fbT63YqKD79tLWuHHDnxRqrxSpbuaM70C2YoJdIetxbbVLpiqHFfb8Fdsb7JY6f+SBIiQjE/8td8zVa8vo4DdWpzwnicfH17kUpifWKXlwfTYrlf4fyRAkvNcI6dieHKDrUEvyI9mfLB1Beg/yFuxpuejwKwHgv/K7EsrSgSbs8vUf/WkHLDQYN7qDzo4tdylXBGoAUwuOLrU=" Oct 14 23:06:27 khanh-pham go-librespot[2045495]: time="2026-10-14T23:06:27+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:06:27 khanh-pham go-librespot[2045495]: time="2026-10-14T23:06:27+07:00" level=debug msg="completed keyexchange" Oct 14 23:06:27 khanh-pham go-librespot[2045495]: time="2026-10-14T23:06:27+07:00" level=debug msg="completed challenge" Oct 14 23:06:27 khanh-pham go-librespot[2045495]: time="2026-10-14T23:06:27+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:06:27 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:27 khanh-pham go-librespot[2045495]: time="2026-10-14T23:06:27+07:00" level=debug msg="new websocket client" Oct 14 23:06:27 khanh-pham volumio[1392]: info: Connection to go-librespot Websocket established Oct 14 23:06:27 khanh-pham go-librespot[2045495]: time="2026-10-14T23:06:27+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:06:27 khanh-pham volumio[1392]: info: Connection to go-librespot Websocket closed Oct 14 23:06:27 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:06:27 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:06:30 khanh-pham volumio[1392]: info: Getting Spotify volume Oct 14 23:06:30 khanh-pham volumio[1392]: error: Failed to get Spotify volume from local API: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:30 khanh-pham volumio[1392]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 14 23:06:30 khanh-pham volumio[1392]: info: CoreCommandRouter::volumioGetState Oct 14 23:06:30 khanh-pham volumio[1392]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Oct 14 23:06:30 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:30 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:30 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70349. Oct 14 23:06:30 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:30 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:30 khanh-pham go-librespot[2045511]: go-librespot daemon starting... Oct 14 23:06:30 khanh-pham go-librespot[2045512]: time="2026-10-14T23:06:30+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:06:30 khanh-pham go-librespot[2045512]: time="2026-10-14T23:06:30+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:06:30 khanh-pham go-librespot[2045512]: time="2026-10-14T23:06:30+07:00" level=debug msg="app state loaded" Oct 14 23:06:30 khanh-pham go-librespot[2045512]: time="2026-10-14T23:06:30+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:06:30 khanh-pham go-librespot[2045512]: time="2026-10-14T23:06:30+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:06:30 khanh-pham go-librespot[2045512]: time="2026-10-14T23:06:30+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:06:30 khanh-pham go-librespot[2045512]: time="2026-10-14T23:06:30+07:00" level=info msg="zeroconf server listening on port 34321" Oct 14 23:06:30 khanh-pham go-librespot[2045512]: time="2026-10-14T23:06:30+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:06:30 khanh-pham go-librespot[2045512]: time="2026-10-14T23:06:30+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:06:31 khanh-pham go-librespot[2045512]: time="2026-10-14T23:06:31+07:00" level=debug msg="obtained new client token: AAHbiEtpu+mZqoXA7Myv2lr2enbsPVtyAJca1lHStrAxcPJBjqTtqyerXqoat6KpZlh9LVNZsHS4LciX+Rs1LLunz8MaV1yizkDamsY2XEtEd2JWd9JzVlSl5bBcUAxJUgY7tGdTcrK88VNPRffD2wRfXsA3mYxsLsu6kqTralY/7RulY+18jV9aVfB/uyE+zNnZaAX3LgUGZbFaOV3gK/sOZW8WNAVLhx4wqis+6LFthc38UDetneGI" Oct 14 23:06:31 khanh-pham go-librespot[2045512]: time="2026-10-14T23:06:31+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:06:31 khanh-pham go-librespot[2045512]: time="2026-10-14T23:06:31+07:00" level=debug msg="completed keyexchange" Oct 14 23:06:31 khanh-pham go-librespot[2045512]: time="2026-10-14T23:06:31+07:00" level=debug msg="completed challenge" Oct 14 23:06:31 khanh-pham go-librespot[2045512]: time="2026-10-14T23:06:31+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:06:31 khanh-pham go-librespot[2045512]: time="2026-10-14T23:06:31+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:06:31 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:06:31 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:06:33 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:33 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:34 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70350. Oct 14 23:06:34 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:34 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:34 khanh-pham go-librespot[2045527]: go-librespot daemon starting... Oct 14 23:06:34 khanh-pham go-librespot[2045528]: time="2026-10-14T23:06:34+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:06:34 khanh-pham go-librespot[2045528]: time="2026-10-14T23:06:34+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:06:34 khanh-pham go-librespot[2045528]: time="2026-10-14T23:06:34+07:00" level=debug msg="app state loaded" Oct 14 23:06:34 khanh-pham go-librespot[2045528]: time="2026-10-14T23:06:34+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:06:34 khanh-pham go-librespot[2045528]: time="2026-10-14T23:06:34+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:06:34 khanh-pham go-librespot[2045528]: time="2026-10-14T23:06:34+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:06:34 khanh-pham go-librespot[2045528]: time="2026-10-14T23:06:34+07:00" level=info msg="zeroconf server listening on port 37081" Oct 14 23:06:34 khanh-pham go-librespot[2045528]: time="2026-10-14T23:06:34+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:06:34 khanh-pham go-librespot[2045528]: time="2026-10-14T23:06:34+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:06:35 khanh-pham go-librespot[2045528]: time="2026-10-14T23:06:35+07:00" level=debug msg="obtained new client token: AAHr6Uftv6mLJFQgOtMkxlvXvbGj8ZZ0sFnkrzjl4N5XNKxVaFjn6sz08mV2qFKIbkUnb8KbBtN7dtsLBpmLqoPeKawY3E4ZsGcjK4HHycVAiU8kUgg/JgajhluFzvcP6cfGXoZ+NihdMVoU9p0Zk7GnzQOZSSbHogXp4EG00A4rAFUS1Kf08nP5YlBnaiu79EGhfjlp8+daDxEG4g0y590nEutvUHHMKeWTx8/uAZlZhnu82j+HdzOY" Oct 14 23:06:35 khanh-pham go-librespot[2045528]: time="2026-10-14T23:06:35+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:06:35 khanh-pham go-librespot[2045528]: time="2026-10-14T23:06:35+07:00" level=debug msg="completed keyexchange" Oct 14 23:06:35 khanh-pham go-librespot[2045528]: time="2026-10-14T23:06:35+07:00" level=debug msg="completed challenge" Oct 14 23:06:35 khanh-pham go-librespot[2045528]: time="2026-10-14T23:06:35+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:06:35 khanh-pham go-librespot[2045528]: time="2026-10-14T23:06:35+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:06:35 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:06:35 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:06:36 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:36 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:38 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70351. Oct 14 23:06:38 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:38 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:38 khanh-pham go-librespot[2045559]: go-librespot daemon starting... Oct 14 23:06:38 khanh-pham go-librespot[2045560]: time="2026-10-14T23:06:38+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:06:38 khanh-pham go-librespot[2045560]: time="2026-10-14T23:06:38+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:06:38 khanh-pham go-librespot[2045560]: time="2026-10-14T23:06:38+07:00" level=debug msg="app state loaded" Oct 14 23:06:39 khanh-pham go-librespot[2045560]: time="2026-10-14T23:06:39+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:06:39 khanh-pham go-librespot[2045560]: time="2026-10-14T23:06:39+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:06:39 khanh-pham go-librespot[2045560]: time="2026-10-14T23:06:39+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:06:39 khanh-pham go-librespot[2045560]: time="2026-10-14T23:06:39+07:00" level=info msg="zeroconf server listening on port 33321" Oct 14 23:06:39 khanh-pham go-librespot[2045560]: time="2026-10-14T23:06:39+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:06:39 khanh-pham go-librespot[2045560]: time="2026-10-14T23:06:39+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:06:39 khanh-pham go-librespot[2045560]: time="2026-10-14T23:06:39+07:00" level=debug msg="obtained new client token: AAEcHLD9Vvv8n4okpPBmYzS5XdRlYpMbKUq7giR4wriZ7NKxxSFhJHucS4e1/O/kb7QC0le/VNsDNJII7lKcK7dLFeUz6AEZJ+ThauDupZL2Klb3zLg7bTttU9FPdtkbD1lEvAnuMb+RGbDXwUI3iJpfhlbH76Nn8Hzynha2a/gr0Hvmm6Nm3RMPJygEdSA4ID3UJO1XUvW6n3HPYr7zi2XKLL0PRioaCDxjnKFi9gHZTmOjG1fdtyjRLTU=" Oct 14 23:06:39 khanh-pham go-librespot[2045560]: time="2026-10-14T23:06:39+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:06:39 khanh-pham go-librespot[2045560]: time="2026-10-14T23:06:39+07:00" level=debug msg="completed keyexchange" Oct 14 23:06:39 khanh-pham go-librespot[2045560]: time="2026-10-14T23:06:39+07:00" level=debug msg="completed challenge" Oct 14 23:06:39 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:39 khanh-pham go-librespot[2045560]: time="2026-10-14T23:06:39+07:00" level=debug msg="new websocket client" Oct 14 23:06:39 khanh-pham volumio[1392]: info: Connection to go-librespot Websocket established Oct 14 23:06:39 khanh-pham go-librespot[2045560]: time="2026-10-14T23:06:39+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:06:39 khanh-pham go-librespot[2045560]: time="2026-10-14T23:06:39+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:06:39 khanh-pham volumio[1392]: info: Connection to go-librespot Websocket closed Oct 14 23:06:39 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:06:39 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:06:42 khanh-pham volumio[1392]: info: Getting Spotify volume Oct 14 23:06:42 khanh-pham volumio[1392]: error: Failed to get Spotify volume from local API: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:42 khanh-pham volumio[1392]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 14 23:06:42 khanh-pham volumio[1392]: info: CoreCommandRouter::volumioGetState Oct 14 23:06:42 khanh-pham volumio[1392]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Oct 14 23:06:42 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:42 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:43 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70352. Oct 14 23:06:43 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:43 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:43 khanh-pham go-librespot[2045576]: go-librespot daemon starting... Oct 14 23:06:43 khanh-pham go-librespot[2045577]: time="2026-10-14T23:06:43+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:06:43 khanh-pham go-librespot[2045577]: time="2026-10-14T23:06:43+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:06:43 khanh-pham go-librespot[2045577]: time="2026-10-14T23:06:43+07:00" level=debug msg="app state loaded" Oct 14 23:06:43 khanh-pham go-librespot[2045577]: time="2026-10-14T23:06:43+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:06:43 khanh-pham go-librespot[2045577]: time="2026-10-14T23:06:43+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:06:43 khanh-pham go-librespot[2045577]: time="2026-10-14T23:06:43+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:06:43 khanh-pham go-librespot[2045577]: time="2026-10-14T23:06:43+07:00" level=info msg="zeroconf server listening on port 41047" Oct 14 23:06:43 khanh-pham go-librespot[2045577]: time="2026-10-14T23:06:43+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:06:43 khanh-pham go-librespot[2045577]: time="2026-10-14T23:06:43+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:06:43 khanh-pham go-librespot[2045577]: time="2026-10-14T23:06:43+07:00" level=debug msg="obtained new client token: AAHnaG7lyqB3GfXNWjVyICaVgKPT2EySknEBdoRSe5Bx7ycE026VQi8dVBgml56ZbDVXKfqLchWQD4bXcw+OXzB2FEZar9YJD+ruzoY9BKzvi6FzFR8k4XpTyZdb+Bo72oaifRf2It/KLnBf3RIZDcsjomeT2dPjmcYxuPLXcB3lRqxETsNBKz8b6PnOLdyw5oRM9S6wF8NvV6akOEdAyHAvz6De4E+qooV9EY7RiHSKXQ5Trq2/FjOmoD8=" Oct 14 23:06:43 khanh-pham go-librespot[2045577]: time="2026-10-14T23:06:43+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:06:43 khanh-pham go-librespot[2045577]: time="2026-10-14T23:06:43+07:00" level=debug msg="completed keyexchange" Oct 14 23:06:43 khanh-pham go-librespot[2045577]: time="2026-10-14T23:06:43+07:00" level=debug msg="completed challenge" Oct 14 23:06:43 khanh-pham go-librespot[2045577]: time="2026-10-14T23:06:43+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:06:44 khanh-pham go-librespot[2045577]: time="2026-10-14T23:06:44+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:06:44 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:06:44 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:06:45 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:45 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:47 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70353. Oct 14 23:06:47 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:47 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:47 khanh-pham go-librespot[2045608]: go-librespot daemon starting... Oct 14 23:06:47 khanh-pham go-librespot[2045609]: time="2026-10-14T23:06:47+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:06:47 khanh-pham go-librespot[2045609]: time="2026-10-14T23:06:47+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:06:47 khanh-pham go-librespot[2045609]: time="2026-10-14T23:06:47+07:00" level=debug msg="app state loaded" Oct 14 23:06:47 khanh-pham volumio[1392]: info: Received Get System Info Oct 14 23:06:47 khanh-pham volumio[1392]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 14 23:06:47 khanh-pham volumio[1392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 14 23:06:47 khanh-pham volumio[1392]: info: Discovery: Getting this device information Oct 14 23:06:47 khanh-pham volumio[1392]: info: CoreCommandRouter::volumioGetState Oct 14 23:06:47 khanh-pham volumio[1392]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 14 23:06:47 khanh-pham volumio[1392]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 14 23:06:47 khanh-pham volumio[1392]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 14 23:06:47 khanh-pham go-librespot[2045609]: time="2026-10-14T23:06:47+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:06:47 khanh-pham go-librespot[2045609]: time="2026-10-14T23:06:47+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:06:47 khanh-pham go-librespot[2045609]: time="2026-10-14T23:06:47+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:06:47 khanh-pham go-librespot[2045609]: time="2026-10-14T23:06:47+07:00" level=info msg="zeroconf server listening on port 43907" Oct 14 23:06:47 khanh-pham go-librespot[2045609]: time="2026-10-14T23:06:47+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:06:47 khanh-pham go-librespot[2045609]: time="2026-10-14T23:06:47+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:06:47 khanh-pham go-librespot[2045609]: time="2026-10-14T23:06:47+07:00" level=debug msg="obtained new client token: AAGhOP6tCRF5WgibmYhrKwODBHCxs+iFdyZLIZOVYzsyX7RRguU15bYw8vnqTohe2o2d/A2/EMmVFLvFN9C16Kb/ljuyZ7KcMUWukleYMyGjG/R9aRYMqCSJ3gSetoKOIl9e133CgmcEQCUEaYqBgoVVPyuf8bgz6vPdKEV2OjKU1sO6lFSyh41FtQM3kgXOWwBWVvfU1qI32340y6ZNjA5JsOmI/CBjoMAGYmYI1Lz4mdVwAHedSRrm0OI=" Oct 14 23:06:47 khanh-pham go-librespot[2045609]: time="2026-10-14T23:06:47+07:00" level=warning msg="failed to connect to AP ap-gae2.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.241.202:4070: connect: connection refused" Oct 14 23:06:47 khanh-pham go-librespot[2045609]: time="2026-10-14T23:06:47+07:00" level=debug msg="connected to ap-gae2.spotify.com:443" Oct 14 23:06:47 khanh-pham go-librespot[2045609]: time="2026-10-14T23:06:47+07:00" level=debug msg="completed keyexchange" Oct 14 23:06:47 khanh-pham go-librespot[2045609]: time="2026-10-14T23:06:47+07:00" level=debug msg="completed challenge" Oct 14 23:06:47 khanh-pham go-librespot[2045609]: time="2026-10-14T23:06:47+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:06:48 khanh-pham volumio5-onboarding[2429]: time=2026-10-14T23:06:48.058+07:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 14 23:06:48 khanh-pham go-librespot[2045609]: time="2026-10-14T23:06:48+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:06:48 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:06:48 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:06:48 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:48 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:51 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70354. Oct 14 23:06:51 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:51 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:51 khanh-pham go-librespot[2045625]: go-librespot daemon starting... Oct 14 23:06:51 khanh-pham go-librespot[2045626]: time="2026-10-14T23:06:51+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:06:51 khanh-pham go-librespot[2045626]: time="2026-10-14T23:06:51+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:06:51 khanh-pham go-librespot[2045626]: time="2026-10-14T23:06:51+07:00" level=debug msg="app state loaded" Oct 14 23:06:51 khanh-pham go-librespot[2045626]: time="2026-10-14T23:06:51+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:06:51 khanh-pham go-librespot[2045626]: time="2026-10-14T23:06:51+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:06:51 khanh-pham go-librespot[2045626]: time="2026-10-14T23:06:51+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:06:51 khanh-pham go-librespot[2045626]: time="2026-10-14T23:06:51+07:00" level=info msg="zeroconf server listening on port 38623" Oct 14 23:06:51 khanh-pham go-librespot[2045626]: time="2026-10-14T23:06:51+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:06:51 khanh-pham go-librespot[2045626]: time="2026-10-14T23:06:51+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:06:51 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:51 khanh-pham go-librespot[2045626]: time="2026-10-14T23:06:51+07:00" level=debug msg="new websocket client" Oct 14 23:06:51 khanh-pham volumio[1392]: info: Connection to go-librespot Websocket established Oct 14 23:06:51 khanh-pham go-librespot[2045626]: time="2026-10-14T23:06:51+07:00" level=debug msg="obtained new client token: AAHvslpJkICzbUppA4+DbgTdjyGnpOsdmJb4P7PqDPB/N0srCUl9cfCk1S7uo4R9XYS7uV6DhIv2DF+EJxQ0RZIvz9Sx0vI5z5jV5F1ZzxpQ+Mcpp7P9/IiiR5n86TFefy2b9pxI4DVGzTPdcSGSZgi1vHjalad2H3vgUYyPSzhqM4RbXJYp6v7QBJz7q2g95BeM37CtJ9lU0XUlN7W3ZTLsHfOke/3IcYm59dzYMrmyvYAychZQDrjv0oA=" Oct 14 23:06:51 khanh-pham go-librespot[2045626]: time="2026-10-14T23:06:51+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:06:51 khanh-pham go-librespot[2045626]: time="2026-10-14T23:06:51+07:00" level=debug msg="completed keyexchange" Oct 14 23:06:51 khanh-pham go-librespot[2045626]: time="2026-10-14T23:06:51+07:00" level=debug msg="completed challenge" Oct 14 23:06:52 khanh-pham go-librespot[2045626]: time="2026-10-14T23:06:52+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:06:52 khanh-pham go-librespot[2045626]: time="2026-10-14T23:06:52+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:06:52 khanh-pham volumio[1392]: info: Connection to go-librespot Websocket closed Oct 14 23:06:52 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:06:52 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:06:54 khanh-pham volumio[1392]: info: Getting Spotify volume Oct 14 23:06:54 khanh-pham volumio[1392]: error: Failed to get Spotify volume from local API: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:54 khanh-pham volumio[1392]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 14 23:06:54 khanh-pham volumio[1392]: info: CoreCommandRouter::volumioGetState Oct 14 23:06:54 khanh-pham volumio[1392]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Oct 14 23:06:55 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:55 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:55 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70355. Oct 14 23:06:55 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:55 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:55 khanh-pham go-librespot[2045655]: go-librespot daemon starting... Oct 14 23:06:55 khanh-pham go-librespot[2045656]: time="2026-10-14T23:06:55+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:06:55 khanh-pham go-librespot[2045656]: time="2026-10-14T23:06:55+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:06:55 khanh-pham go-librespot[2045656]: time="2026-10-14T23:06:55+07:00" level=debug msg="app state loaded" Oct 14 23:06:55 khanh-pham go-librespot[2045656]: time="2026-10-14T23:06:55+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:06:55 khanh-pham go-librespot[2045656]: time="2026-10-14T23:06:55+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:06:55 khanh-pham go-librespot[2045656]: time="2026-10-14T23:06:55+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:06:55 khanh-pham go-librespot[2045656]: time="2026-10-14T23:06:55+07:00" level=info msg="zeroconf server listening on port 43809" Oct 14 23:06:55 khanh-pham go-librespot[2045656]: time="2026-10-14T23:06:55+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:06:55 khanh-pham go-librespot[2045656]: time="2026-10-14T23:06:55+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:06:55 khanh-pham go-librespot[2045656]: time="2026-10-14T23:06:55+07:00" level=debug msg="obtained new client token: AAHhV1OdadmynHUJTapFPL4RoQm+hLGniJ0hSI8LR30pfuDBey3p7vyJgk7hBRoEf3aXMqXKtrttiYGLX4KA21S259pH/AXE60na45/4u+fVaGAirhherm0SOsD65H1OAj5x5XRUcp/MxxtGJXaYZNWyFrgstNxnwlXa5zHIl0LB0La7pqKkHs0p17HkB0Md44aolL746FKpWWBveZdeB4FDlI1AORv6m9pJ15M+jgXVPQ1fNxGRW8QAhTw=" Oct 14 23:06:55 khanh-pham go-librespot[2045656]: time="2026-10-14T23:06:55+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:06:55 khanh-pham go-librespot[2045656]: time="2026-10-14T23:06:55+07:00" level=debug msg="completed keyexchange" Oct 14 23:06:55 khanh-pham go-librespot[2045656]: time="2026-10-14T23:06:55+07:00" level=debug msg="completed challenge" Oct 14 23:06:56 khanh-pham go-librespot[2045656]: time="2026-10-14T23:06:56+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:06:56 khanh-pham go-librespot[2045656]: time="2026-10-14T23:06:56+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:06:56 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:06:56 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:06:58 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:06:58 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:06:59 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70356. Oct 14 23:06:59 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:59 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:06:59 khanh-pham go-librespot[2045671]: go-librespot daemon starting... Oct 14 23:06:59 khanh-pham go-librespot[2045672]: time="2026-10-14T23:06:59+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:06:59 khanh-pham go-librespot[2045672]: time="2026-10-14T23:06:59+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:06:59 khanh-pham go-librespot[2045672]: time="2026-10-14T23:06:59+07:00" level=debug msg="app state loaded" Oct 14 23:06:59 khanh-pham go-librespot[2045672]: time="2026-10-14T23:06:59+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:06:59 khanh-pham go-librespot[2045672]: time="2026-10-14T23:06:59+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:06:59 khanh-pham go-librespot[2045672]: time="2026-10-14T23:06:59+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:06:59 khanh-pham go-librespot[2045672]: time="2026-10-14T23:06:59+07:00" level=info msg="zeroconf server listening on port 36841" Oct 14 23:06:59 khanh-pham go-librespot[2045672]: time="2026-10-14T23:06:59+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:06:59 khanh-pham go-librespot[2045672]: time="2026-10-14T23:06:59+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:06:59 khanh-pham go-librespot[2045672]: time="2026-10-14T23:06:59+07:00" level=debug msg="obtained new client token: AAFFmGqByPCMXxuKxH0dpb0P22RDpQmArhQb+vXrRvimgOfUcJReOA9tL3a3NsIkeqEVu1C2wwPmownSlyRgnyp3V6rdFugPWQTMqJDNUtGeI0Zjmln8fHHN+3ewlCqOYLwNn1ETXF9fj3VvGNudIcKsBYt/K3rSJg9b4+gjy4b0L2JqSt1azn2QpHyNtq05IqTyNcIkXnN4DyzHq1h0apPtIdrUr1C+c9HsXrE7tlqloAp2zAanu7tRnLo=" Oct 14 23:06:59 khanh-pham go-librespot[2045672]: time="2026-10-14T23:06:59+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:06:59 khanh-pham go-librespot[2045672]: time="2026-10-14T23:06:59+07:00" level=debug msg="completed keyexchange" Oct 14 23:06:59 khanh-pham go-librespot[2045672]: time="2026-10-14T23:06:59+07:00" level=debug msg="completed challenge" Oct 14 23:07:00 khanh-pham go-librespot[2045672]: time="2026-10-14T23:07:00+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:07:00 khanh-pham go-librespot[2045672]: time="2026-10-14T23:07:00+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:07:00 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:07:00 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:07:01 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:07:01 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:07:03 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70357. Oct 14 23:07:03 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:03 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:03 khanh-pham go-librespot[2045688]: go-librespot daemon starting... Oct 14 23:07:03 khanh-pham go-librespot[2045689]: time="2026-10-14T23:07:03+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:07:03 khanh-pham go-librespot[2045689]: time="2026-10-14T23:07:03+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:07:03 khanh-pham go-librespot[2045689]: time="2026-10-14T23:07:03+07:00" level=debug msg="app state loaded" Oct 14 23:07:03 khanh-pham go-librespot[2045689]: time="2026-10-14T23:07:03+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 14 23:07:03 khanh-pham go-librespot[2045689]: time="2026-10-14T23:07:03+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 14 23:07:03 khanh-pham go-librespot[2045689]: time="2026-10-14T23:07:03+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 14 23:07:03 khanh-pham go-librespot[2045689]: time="2026-10-14T23:07:03+07:00" level=info msg="zeroconf server listening on port 45307" Oct 14 23:07:03 khanh-pham go-librespot[2045689]: time="2026-10-14T23:07:03+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:07:03 khanh-pham go-librespot[2045689]: time="2026-10-14T23:07:03+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:07:03 khanh-pham go-librespot[2045689]: time="2026-10-14T23:07:03+07:00" level=debug msg="obtained new client token: AAGSpwWN6nJqSU500h7enG2C2C5gHPsXQWcdpL42wad2Q/7aPq/vSitFjrj0ruZ5JoQgoeSbU+NPZZaJOrNnMXc7ELsb9sypr9HOHMO1kUnz5YPf7bZR17KB3lMzEsNe0Qtm1ByGXxppqe4NeBx+BytM4a6cZHoVW/BfZzll8MF6lyRK5g/IVaMpMd1OwHIWtJTKSTd0yigE28A4WGtUQKAtKrxaOXlCBperdqa8q6AhgZQzeQEigtt3QGs=" Oct 14 23:07:03 khanh-pham go-librespot[2045689]: time="2026-10-14T23:07:03+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:07:03 khanh-pham go-librespot[2045689]: time="2026-10-14T23:07:03+07:00" level=debug msg="completed keyexchange" Oct 14 23:07:03 khanh-pham go-librespot[2045689]: time="2026-10-14T23:07:03+07:00" level=debug msg="completed challenge" Oct 14 23:07:03 khanh-pham go-librespot[2045689]: time="2026-10-14T23:07:03+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:07:04 khanh-pham go-librespot[2045689]: time="2026-10-14T23:07:04+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:07:04 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:07:04 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:07:04 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:07:04 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:07:07 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:07:07 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:07:07 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70358. Oct 14 23:07:07 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:07 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:07 khanh-pham go-librespot[2045719]: go-librespot daemon starting... Oct 14 23:07:07 khanh-pham go-librespot[2045720]: time="2026-10-14T23:07:07+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:07:07 khanh-pham go-librespot[2045720]: time="2026-10-14T23:07:07+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:07:07 khanh-pham go-librespot[2045720]: time="2026-10-14T23:07:07+07:00" level=debug msg="app state loaded" Oct 14 23:07:07 khanh-pham go-librespot[2045720]: time="2026-10-14T23:07:07+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:07:07 khanh-pham go-librespot[2045720]: time="2026-10-14T23:07:07+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:07:07 khanh-pham go-librespot[2045720]: time="2026-10-14T23:07:07+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:07:07 khanh-pham go-librespot[2045720]: time="2026-10-14T23:07:07+07:00" level=info msg="zeroconf server listening on port 43367" Oct 14 23:07:07 khanh-pham go-librespot[2045720]: time="2026-10-14T23:07:07+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:07:07 khanh-pham go-librespot[2045720]: time="2026-10-14T23:07:07+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:07:07 khanh-pham go-librespot[2045720]: time="2026-10-14T23:07:07+07:00" level=debug msg="obtained new client token: AAFjWcwnd71fzuSOAByqVkXEpt4Kz1/vJ6l7xbIbY0S/1HjxyS+h6YetjsQmxz2YVGIKaBJNs60N8uehaLCPB4Gn8dhS84+fmvYwimZoJjWUWVJX6/xK/rx7TDPGX94ZOaPEJfbX5jUJvEK2ba9qRPNT5yNEC90zAQQfXbYPqyyOQRF331I9ahF/JPaTCBOgrNGnWPmnrdZkA8aKaznvJJGmm5nT3cfGyrMTlJQY/n6Q6kgJ0Ei0d2iPx40=" Oct 14 23:07:07 khanh-pham go-librespot[2045720]: time="2026-10-14T23:07:07+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:07:07 khanh-pham go-librespot[2045720]: time="2026-10-14T23:07:07+07:00" level=debug msg="completed keyexchange" Oct 14 23:07:07 khanh-pham go-librespot[2045720]: time="2026-10-14T23:07:07+07:00" level=debug msg="completed challenge" Oct 14 23:07:07 khanh-pham go-librespot[2045720]: time="2026-10-14T23:07:07+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:07:08 khanh-pham go-librespot[2045720]: time="2026-10-14T23:07:08+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:07:08 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:07:08 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:07:10 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:07:10 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:07:11 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70359. Oct 14 23:07:11 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:11 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:11 khanh-pham go-librespot[2045736]: go-librespot daemon starting... Oct 14 23:07:11 khanh-pham go-librespot[2045737]: time="2026-10-14T23:07:11+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:07:11 khanh-pham go-librespot[2045737]: time="2026-10-14T23:07:11+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:07:11 khanh-pham go-librespot[2045737]: time="2026-10-14T23:07:11+07:00" level=debug msg="app state loaded" Oct 14 23:07:11 khanh-pham go-librespot[2045737]: time="2026-10-14T23:07:11+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:07:11 khanh-pham go-librespot[2045737]: time="2026-10-14T23:07:11+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:07:11 khanh-pham go-librespot[2045737]: time="2026-10-14T23:07:11+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:07:11 khanh-pham go-librespot[2045737]: time="2026-10-14T23:07:11+07:00" level=info msg="zeroconf server listening on port 36383" Oct 14 23:07:11 khanh-pham go-librespot[2045737]: time="2026-10-14T23:07:11+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:07:11 khanh-pham go-librespot[2045737]: time="2026-10-14T23:07:11+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:07:11 khanh-pham go-librespot[2045737]: time="2026-10-14T23:07:11+07:00" level=debug msg="obtained new client token: AAF6zDKFdXYnNICQJeZl2Eo6TrHpLFFDVLsB/DhtLxGo2D+tCTZ21m3DRjnLcX4M1v6+EQo/TawJoZm+/jaqoeaWAuV9Gfom2XztE2skS9hDL4bvcSwrjusutwQZ6tBueeZLiQyYPmMSVUX+dEFlczZWp9ec2OALQi/zWcb4x8ETO7LMo/rANlAr1QEWamDXVBFyV0Yf3ORFZ0XxFNP958X3lNVu7dxOqTFbNc3S7X3nyJaEe8lWrA8eyak=" Oct 14 23:07:11 khanh-pham go-librespot[2045737]: time="2026-10-14T23:07:11+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:07:11 khanh-pham go-librespot[2045737]: time="2026-10-14T23:07:11+07:00" level=debug msg="completed keyexchange" Oct 14 23:07:11 khanh-pham go-librespot[2045737]: time="2026-10-14T23:07:11+07:00" level=debug msg="completed challenge" Oct 14 23:07:11 khanh-pham go-librespot[2045737]: time="2026-10-14T23:07:11+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:07:12 khanh-pham go-librespot[2045737]: time="2026-10-14T23:07:12+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:07:12 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:07:12 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:07:13 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:07:13 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:07:15 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70360. Oct 14 23:07:15 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:15 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:15 khanh-pham go-librespot[2045767]: go-librespot daemon starting... Oct 14 23:07:15 khanh-pham go-librespot[2045768]: time="2026-10-14T23:07:15+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:07:15 khanh-pham go-librespot[2045768]: time="2026-10-14T23:07:15+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:07:15 khanh-pham go-librespot[2045768]: time="2026-10-14T23:07:15+07:00" level=debug msg="app state loaded" Oct 14 23:07:15 khanh-pham go-librespot[2045768]: time="2026-10-14T23:07:15+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:07:15 khanh-pham go-librespot[2045768]: time="2026-10-14T23:07:15+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:07:15 khanh-pham go-librespot[2045768]: time="2026-10-14T23:07:15+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:07:15 khanh-pham go-librespot[2045768]: time="2026-10-14T23:07:15+07:00" level=info msg="zeroconf server listening on port 32843" Oct 14 23:07:15 khanh-pham go-librespot[2045768]: time="2026-10-14T23:07:15+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:07:15 khanh-pham go-librespot[2045768]: time="2026-10-14T23:07:15+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:07:15 khanh-pham go-librespot[2045768]: time="2026-10-14T23:07:15+07:00" level=debug msg="obtained new client token: AAExPBD8gDzx+YfJsfBionct/rr3fpSRZqPqi1BMfnuk4hgRD5tEMsiwXR7tDt/nsidvij/+jV1n/tWn82UuVfKU5UNySex2i8VbCy4D0EkR8FG8JdCXySr59un1E/yDPj934iC4AKpJDImWkkNnw1/zfdXCqLwZDHQENOJeLQTv8SrSInduwkft8yxIJAf+M8i8jdiSVUZsSrk2uHw0ho5GLgbFUdgaGgciVQkYGlf5NJM/lotkkvbkAKU=" Oct 14 23:07:15 khanh-pham go-librespot[2045768]: time="2026-10-14T23:07:15+07:00" level=warning msg="failed to connect to AP ap-gae2.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.241.202:4070: connect: connection refused" Oct 14 23:07:15 khanh-pham go-librespot[2045768]: time="2026-10-14T23:07:15+07:00" level=debug msg="connected to ap-gae2.spotify.com:443" Oct 14 23:07:16 khanh-pham go-librespot[2045768]: time="2026-10-14T23:07:16+07:00" level=debug msg="completed keyexchange" Oct 14 23:07:16 khanh-pham go-librespot[2045768]: time="2026-10-14T23:07:16+07:00" level=debug msg="completed challenge" Oct 14 23:07:16 khanh-pham go-librespot[2045768]: time="2026-10-14T23:07:16+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:07:16 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:07:16 khanh-pham go-librespot[2045768]: time="2026-10-14T23:07:16+07:00" level=debug msg="new websocket client" Oct 14 23:07:16 khanh-pham volumio[1392]: info: Connection to go-librespot Websocket established Oct 14 23:07:16 khanh-pham go-librespot[2045768]: time="2026-10-14T23:07:16+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:07:16 khanh-pham volumio[1392]: info: Connection to go-librespot Websocket closed Oct 14 23:07:16 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:07:16 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:07:19 khanh-pham volumio[1392]: info: Getting Spotify volume Oct 14 23:07:19 khanh-pham volumio[1392]: error: Failed to get Spotify volume from local API: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:07:19 khanh-pham volumio[1392]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 14 23:07:19 khanh-pham volumio[1392]: info: CoreCommandRouter::volumioGetState Oct 14 23:07:19 khanh-pham volumio[1392]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Oct 14 23:07:19 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:07:19 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:07:19 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70361. Oct 14 23:07:19 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:19 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:19 khanh-pham go-librespot[2045786]: go-librespot daemon starting... Oct 14 23:07:19 khanh-pham go-librespot[2045787]: time="2026-10-14T23:07:19+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:07:19 khanh-pham go-librespot[2045787]: time="2026-10-14T23:07:19+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:07:19 khanh-pham go-librespot[2045787]: time="2026-10-14T23:07:19+07:00" level=debug msg="app state loaded" Oct 14 23:07:19 khanh-pham go-librespot[2045787]: time="2026-10-14T23:07:19+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:07:19 khanh-pham go-librespot[2045787]: time="2026-10-14T23:07:19+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:07:19 khanh-pham go-librespot[2045787]: time="2026-10-14T23:07:19+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:07:19 khanh-pham go-librespot[2045787]: time="2026-10-14T23:07:19+07:00" level=info msg="zeroconf server listening on port 44403" Oct 14 23:07:19 khanh-pham go-librespot[2045787]: time="2026-10-14T23:07:19+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:07:19 khanh-pham go-librespot[2045787]: time="2026-10-14T23:07:19+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:07:20 khanh-pham go-librespot[2045787]: time="2026-10-14T23:07:20+07:00" level=debug msg="obtained new client token: AAHT3TPgLfQ7j0aU20LPiTallk/i0MoUMk6wX3RhzMmqmKeyV3+ZZKaRspd8uo+J+VWxRkwEgxfEJXI0lY9/lcPu9dfcfNw4dfbu44ztUdRQfovLCV6Xv7ir+p03Jys84rY+Hv0GBoiGJKAOxNNQAI8mxASdIXbV0TINfR9jn2JJ+DDZijdmpVKUIAcopVHO60giOINuwkd4wVPMs1eqF/+vAgfNT/rePNPyD95m+IbeYoo2PtTRssFzqxQ=" Oct 14 23:07:20 khanh-pham go-librespot[2045787]: time="2026-10-14T23:07:20+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:07:20 khanh-pham go-librespot[2045787]: time="2026-10-14T23:07:20+07:00" level=debug msg="completed keyexchange" Oct 14 23:07:20 khanh-pham go-librespot[2045787]: time="2026-10-14T23:07:20+07:00" level=debug msg="completed challenge" Oct 14 23:07:20 khanh-pham go-librespot[2045787]: time="2026-10-14T23:07:20+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:07:20 khanh-pham go-librespot[2045787]: time="2026-10-14T23:07:20+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:07:20 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:07:20 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:07:22 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:07:22 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:07:23 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70362. Oct 14 23:07:23 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:23 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:23 khanh-pham go-librespot[2045802]: go-librespot daemon starting... Oct 14 23:07:23 khanh-pham go-librespot[2045803]: time="2026-10-14T23:07:23+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:07:23 khanh-pham go-librespot[2045803]: time="2026-10-14T23:07:23+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:07:23 khanh-pham go-librespot[2045803]: time="2026-10-14T23:07:23+07:00" level=debug msg="app state loaded" Oct 14 23:07:23 khanh-pham go-librespot[2045803]: time="2026-10-14T23:07:23+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 14 23:07:23 khanh-pham go-librespot[2045803]: time="2026-10-14T23:07:23+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 14 23:07:23 khanh-pham go-librespot[2045803]: time="2026-10-14T23:07:23+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 14 23:07:23 khanh-pham go-librespot[2045803]: time="2026-10-14T23:07:23+07:00" level=info msg="zeroconf server listening on port 44827" Oct 14 23:07:23 khanh-pham go-librespot[2045803]: time="2026-10-14T23:07:23+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:07:23 khanh-pham go-librespot[2045803]: time="2026-10-14T23:07:23+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:07:24 khanh-pham go-librespot[2045803]: time="2026-10-14T23:07:24+07:00" level=debug msg="obtained new client token: AAFDLJv8v1Y/bO5miYzCSujcukc5GYXKv/0UthCOqyvjwg72dGpV3n/gSfis/7KjHN9PAnJEN9YvCOrn6xHnJQeUiW9eAXtS2ShexDCuDT5+JkEzARXO/qrRU7pvObUCBMP4lqS6pPaz2x3ySUglIXFLEsTbiHSHYr+RWhI1X3Otg/E0mW/kDflU755vou8NEKCC1pVbGhLIcjolUE5+pq0XN73iVhsGIb7dVEZq8Y5D0kJAmmUGpcjBMbE=" Oct 14 23:07:24 khanh-pham go-librespot[2045803]: time="2026-10-14T23:07:24+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:07:24 khanh-pham go-librespot[2045803]: time="2026-10-14T23:07:24+07:00" level=debug msg="completed keyexchange" Oct 14 23:07:24 khanh-pham go-librespot[2045803]: time="2026-10-14T23:07:24+07:00" level=debug msg="completed challenge" Oct 14 23:07:24 khanh-pham go-librespot[2045803]: time="2026-10-14T23:07:24+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:07:24 khanh-pham go-librespot[2045803]: time="2026-10-14T23:07:24+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:07:24 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:07:24 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:07:25 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:07:25 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:07:27 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70363. Oct 14 23:07:27 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:27 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:27 khanh-pham go-librespot[2045833]: go-librespot daemon starting... Oct 14 23:07:27 khanh-pham go-librespot[2045834]: time="2026-10-14T23:07:27+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:07:27 khanh-pham go-librespot[2045834]: time="2026-10-14T23:07:27+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:07:27 khanh-pham go-librespot[2045834]: time="2026-10-14T23:07:27+07:00" level=debug msg="app state loaded" Oct 14 23:07:27 khanh-pham go-librespot[2045834]: time="2026-10-14T23:07:27+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 14 23:07:27 khanh-pham go-librespot[2045834]: time="2026-10-14T23:07:27+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 14 23:07:27 khanh-pham go-librespot[2045834]: time="2026-10-14T23:07:27+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 14 23:07:27 khanh-pham go-librespot[2045834]: time="2026-10-14T23:07:27+07:00" level=info msg="zeroconf server listening on port 33867" Oct 14 23:07:27 khanh-pham go-librespot[2045834]: time="2026-10-14T23:07:27+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:07:27 khanh-pham go-librespot[2045834]: time="2026-10-14T23:07:27+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:07:28 khanh-pham go-librespot[2045834]: time="2026-10-14T23:07:28+07:00" level=debug msg="obtained new client token: AAEJ30pBYYEfZYM+Z3bamtE/HL3j2RvOI/EqJUZcLE3V+Cf/5+bAmFMhGlAHr0rXFijH947Q4dA14SWuu8PduwTwNnFyKfMeKh8Bc4dLE+suAyIFhSg8yXXJ2SmGeQBPsI+iXM/WT9g2QmhhZQo84k+XvL2uh64T4mzOlUVbyDUwYJt7SGK1i6Wz457Yws0m93uNGeqcSQk0FiRPK9TBurN2xCmw71jagfXbbDaKY34MFPX8bP6HT3YURCE=" Oct 14 23:07:28 khanh-pham go-librespot[2045834]: time="2026-10-14T23:07:28+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:07:28 khanh-pham go-librespot[2045834]: time="2026-10-14T23:07:28+07:00" level=debug msg="completed keyexchange" Oct 14 23:07:28 khanh-pham go-librespot[2045834]: time="2026-10-14T23:07:28+07:00" level=debug msg="completed challenge" Oct 14 23:07:28 khanh-pham go-librespot[2045834]: time="2026-10-14T23:07:28+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:07:28 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:07:28 khanh-pham go-librespot[2045834]: time="2026-10-14T23:07:28+07:00" level=debug msg="new websocket client" Oct 14 23:07:28 khanh-pham volumio[1392]: info: Connection to go-librespot Websocket established Oct 14 23:07:28 khanh-pham go-librespot[2045834]: time="2026-10-14T23:07:28+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:07:28 khanh-pham volumio[1392]: info: Connection to go-librespot Websocket closed Oct 14 23:07:28 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:07:28 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:07:31 khanh-pham volumio[1392]: info: Getting Spotify volume Oct 14 23:07:31 khanh-pham volumio[1392]: error: Failed to get Spotify volume from local API: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:07:31 khanh-pham volumio[1392]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 14 23:07:31 khanh-pham volumio[1392]: info: CoreCommandRouter::volumioGetState Oct 14 23:07:31 khanh-pham volumio[1392]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Oct 14 23:07:31 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:07:31 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:07:31 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70364. Oct 14 23:07:31 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:31 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:31 khanh-pham go-librespot[2045850]: go-librespot daemon starting... Oct 14 23:07:31 khanh-pham go-librespot[2045851]: time="2026-10-14T23:07:31+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:07:31 khanh-pham go-librespot[2045851]: time="2026-10-14T23:07:31+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:07:31 khanh-pham go-librespot[2045851]: time="2026-10-14T23:07:31+07:00" level=debug msg="app state loaded" Oct 14 23:07:31 khanh-pham go-librespot[2045851]: time="2026-10-14T23:07:31+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:07:31 khanh-pham go-librespot[2045851]: time="2026-10-14T23:07:31+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:07:31 khanh-pham go-librespot[2045851]: time="2026-10-14T23:07:31+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:07:31 khanh-pham go-librespot[2045851]: time="2026-10-14T23:07:31+07:00" level=info msg="zeroconf server listening on port 44309" Oct 14 23:07:31 khanh-pham go-librespot[2045851]: time="2026-10-14T23:07:31+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:07:31 khanh-pham go-librespot[2045851]: time="2026-10-14T23:07:31+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:07:32 khanh-pham go-librespot[2045851]: time="2026-10-14T23:07:32+07:00" level=debug msg="obtained new client token: AAFO/RdBG0opJ2jpLtd5s+GzvptzHNVTBBdU7AtXBNAgXDM/p6xT9jZzVKL8QtBzAcv7GRNQINAFvUDQwgJ3Y8jT3FgqM1IECb659pFnAM5S0J4+b6FbqPdnViBbOKCP4E82cSK33ipErWCxTJ0WykIA0SqE2itsufi/wGGUHJtsyuMC6ftswDLD2BXz+Q4VBeP9wKv1gaQktpoTMQBnGfEVoZHN1BGY4+P9Lma5G//gpVnJ0bAyYO0O" Oct 14 23:07:32 khanh-pham go-librespot[2045851]: time="2026-10-14T23:07:32+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:07:32 khanh-pham go-librespot[2045851]: time="2026-10-14T23:07:32+07:00" level=debug msg="completed keyexchange" Oct 14 23:07:32 khanh-pham go-librespot[2045851]: time="2026-10-14T23:07:32+07:00" level=debug msg="completed challenge" Oct 14 23:07:32 khanh-pham go-librespot[2045851]: time="2026-10-14T23:07:32+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:07:32 khanh-pham go-librespot[2045851]: time="2026-10-14T23:07:32+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:07:32 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:07:32 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:07:34 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:07:34 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:07:35 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70365. Oct 14 23:07:35 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:35 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:35 khanh-pham go-librespot[2045880]: go-librespot daemon starting... Oct 14 23:07:35 khanh-pham go-librespot[2045881]: time="2026-10-14T23:07:35+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:07:35 khanh-pham go-librespot[2045881]: time="2026-10-14T23:07:35+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:07:35 khanh-pham go-librespot[2045881]: time="2026-10-14T23:07:35+07:00" level=debug msg="app state loaded" Oct 14 23:07:35 khanh-pham go-librespot[2045881]: time="2026-10-14T23:07:35+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 14 23:07:35 khanh-pham go-librespot[2045881]: time="2026-10-14T23:07:35+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 14 23:07:35 khanh-pham go-librespot[2045881]: time="2026-10-14T23:07:35+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 14 23:07:35 khanh-pham go-librespot[2045881]: time="2026-10-14T23:07:35+07:00" level=info msg="zeroconf server listening on port 44527" Oct 14 23:07:35 khanh-pham go-librespot[2045881]: time="2026-10-14T23:07:35+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:07:35 khanh-pham go-librespot[2045881]: time="2026-10-14T23:07:35+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:07:36 khanh-pham go-librespot[2045881]: time="2026-10-14T23:07:36+07:00" level=debug msg="obtained new client token: AAFEZLgGIs8G8RIgsue11JXht9pkJe62+t3JSXcjG4R3bV7cO5iMW2rlltRh7d5G/Oj+2+8UvxujVkByyWZlajRlOuS8hSMr0CYiscNcWp9zB8X6kvtSdtPm//RwPxibiE2tpab+viZt1SCDxCkQUCg1PVdLM7Hz+dihw4PCsRSBjkNT1oHzu/FbpzzRGdp7bYUcwKkumW0JrTu8U2rNWyG2sBPjMk3iswcRsFHS5Fgg/tLmXbZ9bMRW" Oct 14 23:07:36 khanh-pham go-librespot[2045881]: time="2026-10-14T23:07:36+07:00" level=warning msg="failed to connect to AP ap-gae2.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.241.202:4070: connect: connection refused" Oct 14 23:07:36 khanh-pham go-librespot[2045881]: time="2026-10-14T23:07:36+07:00" level=debug msg="connected to ap-gae2.spotify.com:443" Oct 14 23:07:36 khanh-pham go-librespot[2045881]: time="2026-10-14T23:07:36+07:00" level=debug msg="completed keyexchange" Oct 14 23:07:36 khanh-pham go-librespot[2045881]: time="2026-10-14T23:07:36+07:00" level=debug msg="completed challenge" Oct 14 23:07:36 khanh-pham go-librespot[2045881]: time="2026-10-14T23:07:36+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:07:36 khanh-pham go-librespot[2045881]: time="2026-10-14T23:07:36+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:07:36 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:07:36 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:07:37 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:07:37 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:07:39 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70366. Oct 14 23:07:39 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:39 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:39 khanh-pham go-librespot[2045897]: go-librespot daemon starting... Oct 14 23:07:39 khanh-pham go-librespot[2045898]: time="2026-10-14T23:07:39+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:07:39 khanh-pham go-librespot[2045898]: time="2026-10-14T23:07:39+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:07:39 khanh-pham go-librespot[2045898]: time="2026-10-14T23:07:39+07:00" level=debug msg="app state loaded" Oct 14 23:07:40 khanh-pham go-librespot[2045898]: time="2026-10-14T23:07:40+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:07:40 khanh-pham go-librespot[2045898]: time="2026-10-14T23:07:40+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:07:40 khanh-pham go-librespot[2045898]: time="2026-10-14T23:07:40+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:07:40 khanh-pham go-librespot[2045898]: time="2026-10-14T23:07:40+07:00" level=info msg="zeroconf server listening on port 45781" Oct 14 23:07:40 khanh-pham go-librespot[2045898]: time="2026-10-14T23:07:40+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:07:40 khanh-pham go-librespot[2045898]: time="2026-10-14T23:07:40+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:07:40 khanh-pham go-librespot[2045898]: time="2026-10-14T23:07:40+07:00" level=debug msg="obtained new client token: AAE2tqVcJgY9vKlqnQ0exeD7/jfdB0/+QzprVVHfwJeOPkOHv342ccfXYe2LITuw1zk0aOmRxNa84DpoBeGQW3EoVdwwHj4VZqTnabAl74qU12j9n2aKvG4+wSpNQ6HzvyXLWx3qrAAI0v53pIWmrDzlpLfYljclPsT3meSsOua1X9eSGdWilPRKPXbN3KKy5QMIEXh90Etif0Fk5mQHMOWln26LEE7X0bb0d/Pm84QXJuK7ny9oIaDX" Oct 14 23:07:40 khanh-pham go-librespot[2045898]: time="2026-10-14T23:07:40+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:07:40 khanh-pham go-librespot[2045898]: time="2026-10-14T23:07:40+07:00" level=debug msg="completed keyexchange" Oct 14 23:07:40 khanh-pham go-librespot[2045898]: time="2026-10-14T23:07:40+07:00" level=debug msg="completed challenge" Oct 14 23:07:40 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:07:40 khanh-pham go-librespot[2045898]: time="2026-10-14T23:07:40+07:00" level=debug msg="new websocket client" Oct 14 23:07:40 khanh-pham volumio[1392]: info: Connection to go-librespot Websocket established Oct 14 23:07:40 khanh-pham go-librespot[2045898]: time="2026-10-14T23:07:40+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:07:40 khanh-pham go-librespot[2045898]: time="2026-10-14T23:07:40+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:07:40 khanh-pham volumio[1392]: info: Connection to go-librespot Websocket closed Oct 14 23:07:40 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:07:40 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:07:43 khanh-pham volumio[1392]: info: Getting Spotify volume Oct 14 23:07:43 khanh-pham volumio[1392]: error: Failed to get Spotify volume from local API: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:07:43 khanh-pham volumio[1392]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 14 23:07:43 khanh-pham volumio[1392]: info: CoreCommandRouter::volumioGetState Oct 14 23:07:43 khanh-pham volumio[1392]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Oct 14 23:07:43 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:07:43 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:07:43 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70367. Oct 14 23:07:43 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:43 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:43 khanh-pham go-librespot[2045913]: go-librespot daemon starting... Oct 14 23:07:43 khanh-pham go-librespot[2045914]: time="2026-10-14T23:07:43+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:07:43 khanh-pham go-librespot[2045914]: time="2026-10-14T23:07:43+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:07:43 khanh-pham go-librespot[2045914]: time="2026-10-14T23:07:43+07:00" level=debug msg="app state loaded" Oct 14 23:07:44 khanh-pham go-librespot[2045914]: time="2026-10-14T23:07:44+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:07:44 khanh-pham go-librespot[2045914]: time="2026-10-14T23:07:44+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:07:44 khanh-pham go-librespot[2045914]: time="2026-10-14T23:07:44+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:07:44 khanh-pham go-librespot[2045914]: time="2026-10-14T23:07:44+07:00" level=info msg="zeroconf server listening on port 40003" Oct 14 23:07:44 khanh-pham go-librespot[2045914]: time="2026-10-14T23:07:44+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:07:44 khanh-pham go-librespot[2045914]: time="2026-10-14T23:07:44+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:07:44 khanh-pham go-librespot[2045914]: time="2026-10-14T23:07:44+07:00" level=debug msg="obtained new client token: AAFQO4C2xiFeFo2dVZJMpOyHGzNsdPhuVjH+MLF81LHChqpxzdwWlnfeqVlPxBG/rV6xCzryFxv5nCFYaSrlroXtkFGLojIQe1KXFf2gi8dAuiPWJVINl/0NhL3x8rlNtWCqWD8pa24P7AHL09LTzc9FO7H9tDNlneBBGP1Wf/AREnmAT02HwonkS5NidPy019syRXlxAA6EMsHKmWvb2Fqi0YUjRXCYLjGV4GVCsKMUi/dR8vhZHKZz" Oct 14 23:07:44 khanh-pham go-librespot[2045914]: time="2026-10-14T23:07:44+07:00" level=warning msg="failed to connect to AP ap-gae2.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.241.202:4070: connect: connection refused" Oct 14 23:07:44 khanh-pham go-librespot[2045914]: time="2026-10-14T23:07:44+07:00" level=warning msg="failed to connect to AP ap-gae2.spotify.com:443, retrying with a different AP" error="dial tcp 104.199.241.202:443: connect: connection refused" Oct 14 23:07:44 khanh-pham go-librespot[2045914]: time="2026-10-14T23:07:44+07:00" level=debug msg="connected to ap-gae2.spotify.com:80" Oct 14 23:07:44 khanh-pham go-librespot[2045914]: time="2026-10-14T23:07:44+07:00" level=debug msg="completed keyexchange" Oct 14 23:07:44 khanh-pham go-librespot[2045914]: time="2026-10-14T23:07:44+07:00" level=debug msg="completed challenge" Oct 14 23:07:44 khanh-pham go-librespot[2045914]: time="2026-10-14T23:07:44+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:07:44 khanh-pham go-librespot[2045914]: time="2026-10-14T23:07:44+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:07:44 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:07:44 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:07:46 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:07:46 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:07:48 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70368. Oct 14 23:07:48 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:48 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:48 khanh-pham go-librespot[2045945]: go-librespot daemon starting... Oct 14 23:07:48 khanh-pham go-librespot[2045946]: time="2026-10-14T23:07:48+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:07:48 khanh-pham go-librespot[2045946]: time="2026-10-14T23:07:48+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:07:48 khanh-pham go-librespot[2045946]: time="2026-10-14T23:07:48+07:00" level=debug msg="app state loaded" Oct 14 23:07:48 khanh-pham go-librespot[2045946]: time="2026-10-14T23:07:48+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 14 23:07:48 khanh-pham go-librespot[2045946]: time="2026-10-14T23:07:48+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 14 23:07:48 khanh-pham go-librespot[2045946]: time="2026-10-14T23:07:48+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 14 23:07:48 khanh-pham go-librespot[2045946]: time="2026-10-14T23:07:48+07:00" level=info msg="zeroconf server listening on port 37807" Oct 14 23:07:48 khanh-pham go-librespot[2045946]: time="2026-10-14T23:07:48+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:07:48 khanh-pham go-librespot[2045946]: time="2026-10-14T23:07:48+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:07:48 khanh-pham go-librespot[2045946]: time="2026-10-14T23:07:48+07:00" level=debug msg="obtained new client token: AAGQbBG+mll+h2lgY+0USpQ9LhjQo8CQI7PFg46AxuwWQyDQXJXYpwLQjrhmVlIcH65/j34kZQSYVc+pJ1Tsh/aTlqDVMlQObedR/a/OAH+78nfHiiZIr+rhTi75I9wI0bveTf3RYPRlk4F5H/lvMCK2pRi1TLlNEUkZj1B/+IcdqO6+lHBZSzljpnQGU0PsnaF5m6h6VKMgs3ZzZkk30l3Eg9ir3/DW2bGC59mxWTLwWZK9+73TA57stfg=" Oct 14 23:07:48 khanh-pham go-librespot[2045946]: time="2026-10-14T23:07:48+07:00" level=warning msg="failed to connect to AP ap-gae2.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.241.202:4070: connect: connection refused" Oct 14 23:07:48 khanh-pham go-librespot[2045946]: time="2026-10-14T23:07:48+07:00" level=debug msg="connected to ap-gae2.spotify.com:443" Oct 14 23:07:48 khanh-pham go-librespot[2045946]: time="2026-10-14T23:07:48+07:00" level=debug msg="completed keyexchange" Oct 14 23:07:48 khanh-pham go-librespot[2045946]: time="2026-10-14T23:07:48+07:00" level=debug msg="completed challenge" Oct 14 23:07:48 khanh-pham go-librespot[2045946]: time="2026-10-14T23:07:48+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:07:49 khanh-pham go-librespot[2045946]: time="2026-10-14T23:07:49+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:07:49 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:07:49 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:07:49 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:07:49 khanh-pham volumio[1392]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 14 23:07:52 khanh-pham systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 70369. Oct 14 23:07:52 khanh-pham systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:52 khanh-pham systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 14 23:07:52 khanh-pham go-librespot[2045964]: go-librespot daemon starting... Oct 14 23:07:52 khanh-pham go-librespot[2045965]: time="2026-10-14T23:07:52+07:00" level=info msg="running go-librespot 0.9.1" Oct 14 23:07:52 khanh-pham go-librespot[2045965]: time="2026-10-14T23:07:52+07:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 14 23:07:52 khanh-pham go-librespot[2045965]: time="2026-10-14T23:07:52+07:00" level=debug msg="app state loaded" Oct 14 23:07:52 khanh-pham go-librespot[2045965]: time="2026-10-14T23:07:52+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 14 23:07:52 khanh-pham go-librespot[2045965]: time="2026-10-14T23:07:52+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 14 23:07:52 khanh-pham go-librespot[2045965]: time="2026-10-14T23:07:52+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 14 23:07:52 khanh-pham go-librespot[2045965]: time="2026-10-14T23:07:52+07:00" level=info msg="zeroconf server listening on port 36591" Oct 14 23:07:52 khanh-pham go-librespot[2045965]: time="2026-10-14T23:07:52+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 14 23:07:52 khanh-pham go-librespot[2045965]: time="2026-10-14T23:07:52+07:00" level=info msg="loading previously persisted zeroconf credentials" username="04*********************sh" Oct 14 23:07:52 khanh-pham go-librespot[2045965]: time="2026-10-14T23:07:52+07:00" level=debug msg="obtained new client token: AAG+VMZTary66EHs89m28rXqMBfE+cIwEDlafPgU+OTtWikLJTu0nFEnXYsi9KZ6Njko0X+oLgbSXpljXP7yZLRwPUBLXJnh8hVGKiBIrRcfR3InSoGARCkTQgdhazfSprUFK9jA9n4yl2Nyvcn9vxTaJQItE0oz5mxWrP+rY1JJrWVqxej+bUEpQruyHWFczRdDzKLWxf/VgOpl89+y+v7pPXXZYtGzbRqrFKqWsJZVl6ob4Jld7x72VT0=" Oct 14 23:07:52 khanh-pham go-librespot[2045965]: time="2026-10-14T23:07:52+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Oct 14 23:07:52 khanh-pham go-librespot[2045965]: time="2026-10-14T23:07:52+07:00" level=debug msg="completed keyexchange" Oct 14 23:07:52 khanh-pham go-librespot[2045965]: time="2026-10-14T23:07:52+07:00" level=debug msg="completed challenge" Oct 14 23:07:52 khanh-pham volumio[1392]: info: Initializing connection to go-librespot Websocket Oct 14 23:07:52 khanh-pham volumio[1392]: info: Connection to go-librespot Websocket established Oct 14 23:07:52 khanh-pham go-librespot[2045965]: time="2026-10-14T23:07:52+07:00" level=debug msg="new websocket client" Oct 14 23:07:52 khanh-pham go-librespot[2045965]: time="2026-10-14T23:07:52+07:00" level=info msg="authenticated AP" username="04*********************sh" Oct 14 23:07:52 khanh-pham volumio[1392]: info: [ytmusic] Refresh session PO token Oct 14 23:07:52 khanh-pham volumio[1392]: info: [ytmusic] Obtained session PO token using visitorData (expires in 43102 seconds) Oct 14 23:07:52 khanh-pham volumio[1392]: info: [ytmusic] Going to refresh session PO token in 43002 seconds Oct 14 23:07:52 khanh-pham volumio[1392]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 23:07:52 khanh-pham volumio[1392]: TypeError: Chaining cycle detected for promise # Oct 14 23:07:52 khanh-pham volumio[1392]: at #doGetSessionPoToken (/data/plugins/music_service/ytmusic/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:128:21) Oct 14 23:07:52 khanh-pham volumio[1392]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Oct 14 23:07:52 khanh-pham volumio[1392]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 23:07:52 khanh-pham go-librespot[2045965]: time="2026-10-14T23:07:52+07:00" level=fatal msg="daemon exited with error" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 14 23:07:52 khanh-pham systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 14 23:07:52 khanh-pham systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 14 23:07:53 khanh-pham sudo[2045991]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-14 23:06' Oct 14 23:07:53 khanh-pham sudo[2045991]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"