Dec 05 07:43:00 northpi-soundstation go-librespot[14631]: time="2025-12-05T07:43:00-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 07:43:00 northpi-soundstation go-librespot[14631]: time="2025-12-05T07:43:00-05:00" level=debug msg="completed keyexchange"
Dec 05 07:43:00 northpi-soundstation go-librespot[14631]: time="2025-12-05T07:43:00-05:00" level=debug msg="completed challenge"
Dec 05 07:43:00 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:00 northpi-soundstation go-librespot[14631]: time="2025-12-05T07:43:00-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 05 07:43:00 northpi-soundstation volumio[14030]: info: Error connecting to go-librespot Websocket: Error: read ECONNRESET
Dec 05 07:43:00 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 07:43:00 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 07:43:00 northpi-soundstation volumio[14030]: info: CoreCommandRouter::volumioGetState
Dec 05 07:43:00 northpi-soundstation volumio[14030]: info: Listing playlists
Dec 05 07:43:00 northpi-soundstation volumio[14030]: info: Listing playlists
Dec 05 07:43:01 northpi-soundstation volumio[14030]: info: MRS: Adding multiroomSync output
Dec 05 07:43:01 northpi-soundstation volumio[14030]: info: Adding audio output:
Dec 05 07:43:01 northpi-soundstation volumio[14030]: info: MRS: Pushing multiroomSync output
Dec 05 07:43:02 northpi-soundstation kernel: xhci_hcd 0000:01:00.0: ERROR Transfer event for disabled endpoint slot 2 ep 13
Dec 05 07:43:02 northpi-soundstation kernel: xhci_hcd 0000:01:00.0: @0000000428d204d0 00000000 00000000 0e000000 020e8001
Dec 05 07:43:02 northpi-soundstation volumio[14030]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 05 07:43:02 northpi-soundstation volumio[14030]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 05 07:43:02 northpi-soundstation volumio[14030]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Dec 05 07:43:02 northpi-soundstation volumio-remote-updater[818]: Test mode enabled
Dec 05 07:43:02 northpi-soundstation volumio-remote-updater[818]: Alpha mode disabled
Dec 05 07:43:02 northpi-soundstation volumio-remote-updater[818]: Alpha legacy test mode disabled
Dec 05 07:43:02 northpi-soundstation volumio[14030]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Dec 05 07:43:02 northpi-soundstation volumio[14030]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 05 07:43:02 northpi-soundstation volumio[14030]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 05 07:43:02 northpi-soundstation volumio[14030]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Dec 05 07:43:02 northpi-soundstation volumio[14030]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Dec 05 07:43:02 northpi-soundstation volumio[14030]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Dec 05 07:43:02 northpi-soundstation volumio[14030]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 05 07:43:02 northpi-soundstation volumio[14030]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 05 07:43:02 northpi-soundstation volumio[14030]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Dec 05 07:43:02 northpi-soundstation volumio[14030]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Dec 05 07:43:03 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:03 northpi-soundstation volumio[14030]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 07:43:03 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 8.
Dec 05 07:43:03 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:03 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:03 northpi-soundstation go-librespot[14643]: go-librespot daemon starting...
Dec 05 07:43:03 northpi-soundstation go-librespot[14644]: time="2025-12-05T07:43:03-05:00" level=info msg="running go-librespot 0.3.2"
Dec 05 07:43:03 northpi-soundstation go-librespot[14644]: time="2025-12-05T07:43:03-05:00" level=debug msg="app state loaded"
Dec 05 07:43:03 northpi-soundstation go-librespot[14644]: time="2025-12-05T07:43:03-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 07:43:03 northpi-soundstation go-librespot[14644]: time="2025-12-05T07:43:03-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]"
Dec 05 07:43:03 northpi-soundstation go-librespot[14644]: time="2025-12-05T07:43:03-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443]"
Dec 05 07:43:03 northpi-soundstation go-librespot[14644]: time="2025-12-05T07:43:03-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443]"
Dec 05 07:43:03 northpi-soundstation go-librespot[14644]: time="2025-12-05T07:43:03-05:00" level=info msg="zeroconf server listening on port 43287"
Dec 05 07:43:03 northpi-soundstation go-librespot[14644]: time="2025-12-05T07:43:03-05:00" level=debug msg="obtained new client token: AAAElD+kuCz2dRF5c4PP/WWg1VB3YzU02HGUvxdk1wFBncnnOrXvT2pc7LHVufp5nXn5t+L26bJJ5nyRgjSlX6/zulHjPaYdHbK/WbV0zfbDakmZ1BFEquNpbJYwIFqb//fCFEvXtr/SsHaxZ21gOy3vPGvI+124+qM1twOkiHKvBD9Ihdyfb+dyUJTanmEcO4icoZg7a5HuHjGwkLHBtoiTxJUr4xz4s98Q6fh8TFu90Zb8ys62gAqH7g=="
Dec 05 07:43:03 northpi-soundstation go-librespot[14644]: time="2025-12-05T07:43:03-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 07:43:03 northpi-soundstation go-librespot[14644]: time="2025-12-05T07:43:03-05:00" level=debug msg="completed keyexchange"
Dec 05 07:43:03 northpi-soundstation go-librespot[14644]: time="2025-12-05T07:43:03-05:00" level=debug msg="completed challenge"
Dec 05 07:43:03 northpi-soundstation go-librespot[14644]: time="2025-12-05T07:43:03-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 05 07:43:03 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 07:43:03 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 07:43:04 northpi-soundstation volumio[14030]: info: BOOT COMPLETED
Dec 05 07:43:06 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:06 northpi-soundstation volumio[14030]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 07:43:06 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 9.
Dec 05 07:43:06 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:06 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:06 northpi-soundstation go-librespot[14652]: go-librespot daemon starting...
Dec 05 07:43:06 northpi-soundstation go-librespot[14653]: time="2025-12-05T07:43:06-05:00" level=info msg="running go-librespot 0.3.2"
Dec 05 07:43:06 northpi-soundstation go-librespot[14653]: time="2025-12-05T07:43:06-05:00" level=debug msg="app state loaded"
Dec 05 07:43:06 northpi-soundstation go-librespot[14653]: time="2025-12-05T07:43:06-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 07:43:06 northpi-soundstation go-librespot[14653]: time="2025-12-05T07:43:06-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]"
Dec 05 07:43:06 northpi-soundstation go-librespot[14653]: time="2025-12-05T07:43:06-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443]"
Dec 05 07:43:06 northpi-soundstation go-librespot[14653]: time="2025-12-05T07:43:06-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443]"
Dec 05 07:43:06 northpi-soundstation go-librespot[14653]: time="2025-12-05T07:43:06-05:00" level=info msg="zeroconf server listening on port 46377"
Dec 05 07:43:07 northpi-soundstation go-librespot[14653]: time="2025-12-05T07:43:07-05:00" level=debug msg="obtained new client token: AACan300cAgu3gfx1kCeFrsAUyXhCwOqfK52ZbFgKnbIj5iJNdzOpK0i0fM8zQf9L3dZ2MoZhwsnFvRKjzqjta/ofDkibmInsN0LeIKoE0d5PBpRScMK/4qWL30i9Z6Zh/vyJy+xQebQ/MSQelD8IVEfrdpmAMpPcAYkKGbjNHrKL6VzprlRb0bVY8E3yp2wWNh4mtDUJF6rR2tsfH6ZObQ5FvORDM9RGc79OycZEHBA8aR1u4c+mw1CDA=="
Dec 05 07:43:07 northpi-soundstation go-librespot[14653]: time="2025-12-05T07:43:07-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 07:43:07 northpi-soundstation go-librespot[14653]: time="2025-12-05T07:43:07-05:00" level=debug msg="completed keyexchange"
Dec 05 07:43:07 northpi-soundstation go-librespot[14653]: time="2025-12-05T07:43:07-05:00" level=debug msg="completed challenge"
Dec 05 07:43:07 northpi-soundstation go-librespot[14653]: time="2025-12-05T07:43:07-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 05 07:43:07 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 07:43:07 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 07:43:07 northpi-soundstation volumio[14030]: info: MRS: Pushing audio output on request
Dec 05 07:43:07 northpi-soundstation volumio[14030]: info: MRS: Pushing multiroomSync output
Dec 05 07:43:09 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:09 northpi-soundstation volumio[14030]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 07:43:10 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10.
Dec 05 07:43:10 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:10 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:10 northpi-soundstation go-librespot[14674]: go-librespot daemon starting...
Dec 05 07:43:10 northpi-soundstation go-librespot[14675]: time="2025-12-05T07:43:10-05:00" level=info msg="running go-librespot 0.3.2"
Dec 05 07:43:10 northpi-soundstation go-librespot[14675]: time="2025-12-05T07:43:10-05:00" level=debug msg="app state loaded"
Dec 05 07:43:10 northpi-soundstation go-librespot[14675]: time="2025-12-05T07:43:10-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 07:43:10 northpi-soundstation volumio[14030]: info: CoreCommandRouter::volumioGetState
Dec 05 07:43:10 northpi-soundstation go-librespot[14675]: time="2025-12-05T07:43:10-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 05 07:43:10 northpi-soundstation go-librespot[14675]: time="2025-12-05T07:43:10-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Dec 05 07:43:10 northpi-soundstation go-librespot[14675]: time="2025-12-05T07:43:10-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Dec 05 07:43:10 northpi-soundstation go-librespot[14675]: time="2025-12-05T07:43:10-05:00" level=info msg="zeroconf server listening on port 45567"
Dec 05 07:43:10 northpi-soundstation go-librespot[14675]: time="2025-12-05T07:43:10-05:00" level=debug msg="obtained new client token: AAB2ieklw+BHg1eFSNz3YQeCuSKLm4eheSgoCvJTdabvPxKqXvulHsFkI6PAUxgakzdBS4ZXy/KmoV/DwM+QlATm2x6Ek06E+32ltHR7v9fSEIe5BYrXmQOclLSi391vkCu60VmdsYvZwfFH2BlrLQTM2I2WGbLYWmMZEj6dTdGjmKWlowakGPvZl/8rp8G17bML0zChU+gLNxhPepznwv/++XBHNIUgFvnWfd64+M9qXzd67g4cFg76lQ=="
Dec 05 07:43:10 northpi-soundstation go-librespot[14675]: time="2025-12-05T07:43:10-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 07:43:10 northpi-soundstation go-librespot[14675]: time="2025-12-05T07:43:10-05:00" level=debug msg="completed keyexchange"
Dec 05 07:43:10 northpi-soundstation go-librespot[14675]: time="2025-12-05T07:43:10-05:00" level=debug msg="completed challenge"
Dec 05 07:43:10 northpi-soundstation go-librespot[14675]: time="2025-12-05T07:43:10-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 05 07:43:10 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 07:43:10 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 07:43:10 northpi-soundstation volumio[14030]: info: Discovery: Disconnected from remote: 192.168.1.97
Dec 05 07:43:10 northpi-soundstation volumio[14030]: info: MRS: Cleaning up device: 74ce6260-2045-48bb-acbd-0b75ccb5d93e
Dec 05 07:43:10 northpi-soundstation volumio[14030]: info: Removing audio output:
Dec 05 07:43:11 northpi-soundstation volumio[14030]: info: Discovery: Remote connection error: 192.168.1.97
Dec 05 07:43:11 northpi-soundstation volumio[14030]: info: Discovery: A device disappeared from network
Dec 05 07:43:11 northpi-soundstation volumio[14030]: info: Discovery: Device gbvpi-bedroom disappeared from network
Dec 05 07:43:12 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:12 northpi-soundstation volumio[14030]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 07:43:13 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11.
Dec 05 07:43:13 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:13 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:13 northpi-soundstation go-librespot[14683]: go-librespot daemon starting...
Dec 05 07:43:13 northpi-soundstation go-librespot[14684]: time="2025-12-05T07:43:13-05:00" level=info msg="running go-librespot 0.3.2"
Dec 05 07:43:13 northpi-soundstation go-librespot[14684]: time="2025-12-05T07:43:13-05:00" level=debug msg="app state loaded"
Dec 05 07:43:13 northpi-soundstation go-librespot[14684]: time="2025-12-05T07:43:13-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 07:43:13 northpi-soundstation go-librespot[14684]: time="2025-12-05T07:43:13-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 05 07:43:13 northpi-soundstation go-librespot[14684]: time="2025-12-05T07:43:13-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Dec 05 07:43:13 northpi-soundstation go-librespot[14684]: time="2025-12-05T07:43:13-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Dec 05 07:43:13 northpi-soundstation go-librespot[14684]: time="2025-12-05T07:43:13-05:00" level=info msg="zeroconf server listening on port 36955"
Dec 05 07:43:14 northpi-soundstation go-librespot[14684]: time="2025-12-05T07:43:14-05:00" level=debug msg="obtained new client token: AAD04DOoT9sNaFZqUi0JcbLZVOcvNgIGZgQD6oqRz7Zh+pXU9jCP0DiKDpLP7FQIRE2nMPSeOqayNzV6EwWSUSiSIijyr2cnoL40lXaDRBohOp7dJT14VFJew1x4Kr1L2csQ4KFUpGf4JDG9QiCf9TnQJUc4Z5vrleFk+PE8Shib6klwGQy2rChn+0ZbvEDUi9p4mWyA2lmB7qMttb+MU9PBaOkmopNe9OctmY6FxHLvANxV7d7TbCI="
Dec 05 07:43:14 northpi-soundstation go-librespot[14684]: time="2025-12-05T07:43:14-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 07:43:14 northpi-soundstation go-librespot[14684]: time="2025-12-05T07:43:14-05:00" level=debug msg="completed keyexchange"
Dec 05 07:43:14 northpi-soundstation go-librespot[14684]: time="2025-12-05T07:43:14-05:00" level=debug msg="completed challenge"
Dec 05 07:43:14 northpi-soundstation go-librespot[14684]: time="2025-12-05T07:43:14-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 05 07:43:14 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 07:43:14 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 07:43:15 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:15 northpi-soundstation volumio[14030]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 07:43:15 northpi-soundstation volumio[14030]: info: Discovery: adding 74ce6260-2045-48bb-acbd-0b75ccb5d93e
Dec 05 07:43:15 northpi-soundstation volumio[14030]: info: Discovery: Found device GBVPi-Bedroom
Dec 05 07:43:15 northpi-soundstation volumio[14030]: info: Discovery: Connecting to remote: 192.168.1.97
Dec 05 07:43:16 northpi-soundstation volumio[14030]: info: MRS: Pushing audio output on request
Dec 05 07:43:16 northpi-soundstation volumio[14030]: info: MRS: Pushing multiroomSync output
Dec 05 07:43:16 northpi-soundstation volumio[14030]: info: Discovery: Connected to remote: 192.168.1.97
Dec 05 07:43:17 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 12.
Dec 05 07:43:17 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:17 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:17 northpi-soundstation go-librespot[14696]: go-librespot daemon starting...
Dec 05 07:43:17 northpi-soundstation go-librespot[14697]: time="2025-12-05T07:43:17-05:00" level=info msg="running go-librespot 0.3.2"
Dec 05 07:43:17 northpi-soundstation go-librespot[14697]: time="2025-12-05T07:43:17-05:00" level=debug msg="app state loaded"
Dec 05 07:43:17 northpi-soundstation go-librespot[14697]: time="2025-12-05T07:43:17-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 07:43:17 northpi-soundstation volumio[14030]: verbose: New Socket.io Connection to 192.168.1.28:3000 from 192.168.1.97 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Dec 05 07:43:17 northpi-soundstation go-librespot[14697]: time="2025-12-05T07:43:17-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 05 07:43:17 northpi-soundstation go-librespot[14697]: time="2025-12-05T07:43:17-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Dec 05 07:43:17 northpi-soundstation go-librespot[14697]: time="2025-12-05T07:43:17-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Dec 05 07:43:17 northpi-soundstation go-librespot[14697]: time="2025-12-05T07:43:17-05:00" level=info msg="zeroconf server listening on port 33171"
Dec 05 07:43:17 northpi-soundstation go-librespot[14697]: time="2025-12-05T07:43:17-05:00" level=debug msg="obtained new client token: AADPaGyKlx2TTq/C9lDISqXAKmhovplOt9WxO63B0JLrr+fFbkcB3e4LAULQJM+zPNiNT6U2PddOjx9Sdb6OXUWhEt9rMUuprzqy2AY99rLAV9TEAQgUEm02pk0Wm3EcUjk20naM1Gt39qdsTZVZR0QkXsm1YpuSVsoyRrsQie+Erhx6BOl8IOU1keVUYnMqlbqsfx0bRt+maaw46r4XzaPv3xq5zb3510E7yeSiA4VNoB4XDsSvHe141w=="
Dec 05 07:43:17 northpi-soundstation go-librespot[14697]: time="2025-12-05T07:43:17-05:00" level=warning msg="failed to connect to AP ap-gue1.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.255.62:4070: connect: connection refused"
Dec 05 07:43:17 northpi-soundstation go-librespot[14697]: time="2025-12-05T07:43:17-05:00" level=debug msg="connected to ap-gue1.spotify.com:443"
Dec 05 07:43:17 northpi-soundstation go-librespot[14697]: time="2025-12-05T07:43:17-05:00" level=debug msg="completed keyexchange"
Dec 05 07:43:17 northpi-soundstation go-librespot[14697]: time="2025-12-05T07:43:17-05:00" level=debug msg="completed challenge"
Dec 05 07:43:17 northpi-soundstation go-librespot[14697]: time="2025-12-05T07:43:17-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 05 07:43:17 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 07:43:17 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 07:43:18 northpi-soundstation volumio[14030]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Dec 05 07:43:18 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:18 northpi-soundstation volumio[14030]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 07:43:18 northpi-soundstation volumio[14030]: info: CoreCommandRouter::volumioGetState
Dec 05 07:43:20 northpi-soundstation volumio[14030]: info: CoreCommandRouter::volumioGetState
Dec 05 07:43:20 northpi-soundstation volumio[14030]: info: Listing playlists
Dec 05 07:43:20 northpi-soundstation volumio[14030]: info: Listing playlists
Dec 05 07:43:21 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:21 northpi-soundstation volumio[14030]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 07:43:21 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 13.
Dec 05 07:43:21 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:21 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:21 northpi-soundstation go-librespot[14718]: go-librespot daemon starting...
Dec 05 07:43:21 northpi-soundstation go-librespot[14719]: time="2025-12-05T07:43:21-05:00" level=info msg="running go-librespot 0.3.2"
Dec 05 07:43:21 northpi-soundstation go-librespot[14719]: time="2025-12-05T07:43:21-05:00" level=debug msg="app state loaded"
Dec 05 07:43:21 northpi-soundstation go-librespot[14719]: time="2025-12-05T07:43:21-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 07:43:21 northpi-soundstation go-librespot[14719]: time="2025-12-05T07:43:21-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 05 07:43:21 northpi-soundstation go-librespot[14719]: time="2025-12-05T07:43:21-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Dec 05 07:43:21 northpi-soundstation go-librespot[14719]: time="2025-12-05T07:43:21-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Dec 05 07:43:21 northpi-soundstation go-librespot[14719]: time="2025-12-05T07:43:21-05:00" level=info msg="zeroconf server listening on port 37095"
Dec 05 07:43:21 northpi-soundstation go-librespot[14719]: time="2025-12-05T07:43:21-05:00" level=debug msg="obtained new client token: AAD+XDPL4xgBVl9EFaYSaR9b0l2YJXJ3fwQ7qhBwvWS8gqMUyGT33YBhLdrHh10FX/pX0GMEs0oIjkfsN4B2d47ns8hnHyOEA/hkKKw9r2hvlkXRhn3Zee1UVAUCys4p2piR0AhINPXEkIxlJHjoAB2XFZ7NSlW7bJqsh4JeHs2s2D7DkurB6sIqicVs73w1gzg09F23sM/ZBcoTdCeSh/tkeCp93x+pEtiT2o8DpTZACAZ9MYtfDy5C5w=="
Dec 05 07:43:21 northpi-soundstation go-librespot[14719]: time="2025-12-05T07:43:21-05:00" level=warning msg="failed to connect to AP ap-gue1.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.255.62:4070: connect: connection refused"
Dec 05 07:43:21 northpi-soundstation go-librespot[14719]: time="2025-12-05T07:43:21-05:00" level=debug msg="connected to ap-gue1.spotify.com:443"
Dec 05 07:43:21 northpi-soundstation go-librespot[14719]: time="2025-12-05T07:43:21-05:00" level=debug msg="completed keyexchange"
Dec 05 07:43:21 northpi-soundstation go-librespot[14719]: time="2025-12-05T07:43:21-05:00" level=debug msg="completed challenge"
Dec 05 07:43:21 northpi-soundstation go-librespot[14719]: time="2025-12-05T07:43:21-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 05 07:43:21 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 07:43:21 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 07:43:24 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:24 northpi-soundstation volumio[14030]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 07:43:24 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14.
Dec 05 07:43:24 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:24 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:24 northpi-soundstation go-librespot[14726]: go-librespot daemon starting...
Dec 05 07:43:24 northpi-soundstation go-librespot[14727]: time="2025-12-05T07:43:24-05:00" level=info msg="running go-librespot 0.3.2"
Dec 05 07:43:24 northpi-soundstation go-librespot[14727]: time="2025-12-05T07:43:24-05:00" level=debug msg="app state loaded"
Dec 05 07:43:24 northpi-soundstation go-librespot[14727]: time="2025-12-05T07:43:24-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 07:43:25 northpi-soundstation go-librespot[14727]: time="2025-12-05T07:43:25-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 05 07:43:25 northpi-soundstation go-librespot[14727]: time="2025-12-05T07:43:25-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Dec 05 07:43:25 northpi-soundstation go-librespot[14727]: time="2025-12-05T07:43:25-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Dec 05 07:43:25 northpi-soundstation go-librespot[14727]: time="2025-12-05T07:43:25-05:00" level=info msg="zeroconf server listening on port 43719"
Dec 05 07:43:25 northpi-soundstation go-librespot[14727]: time="2025-12-05T07:43:25-05:00" level=debug msg="obtained new client token: AAAnA9wcOhDXJGoxf3RFB7FbyXogfIt1wZtO5zq648/LWjY0UkZTNF8W3MesEfXtFBaJB/9vUEWGckztF1uyd1k0S13NY1zDLaOV1tpzEoPIjq01Pu3pfl0QcsfL2QUDfU8WM0sERaszxadyLghnyLPPBCLub1A/aaFIWdFeFG1RjcXtslcn55HkqAgYIvC9FxhR4x9Q+dGVngqcdoH/QiGjPfPdwSjpW/7vnd090VSfLDl3/Skef13eJA=="
Dec 05 07:43:25 northpi-soundstation go-librespot[14727]: time="2025-12-05T07:43:25-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 07:43:25 northpi-soundstation go-librespot[14727]: time="2025-12-05T07:43:25-05:00" level=debug msg="completed keyexchange"
Dec 05 07:43:25 northpi-soundstation go-librespot[14727]: time="2025-12-05T07:43:25-05:00" level=debug msg="completed challenge"
Dec 05 07:43:25 northpi-soundstation go-librespot[14727]: time="2025-12-05T07:43:25-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 05 07:43:25 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 07:43:25 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 07:43:27 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:27 northpi-soundstation volumio[14030]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 07:43:28 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 15.
Dec 05 07:43:28 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:28 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:28 northpi-soundstation go-librespot[14735]: go-librespot daemon starting...
Dec 05 07:43:28 northpi-soundstation go-librespot[14736]: time="2025-12-05T07:43:28-05:00" level=info msg="running go-librespot 0.3.2"
Dec 05 07:43:28 northpi-soundstation go-librespot[14736]: time="2025-12-05T07:43:28-05:00" level=debug msg="app state loaded"
Dec 05 07:43:28 northpi-soundstation go-librespot[14736]: time="2025-12-05T07:43:28-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 07:43:28 northpi-soundstation go-librespot[14736]: time="2025-12-05T07:43:28-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 05 07:43:28 northpi-soundstation go-librespot[14736]: time="2025-12-05T07:43:28-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Dec 05 07:43:28 northpi-soundstation go-librespot[14736]: time="2025-12-05T07:43:28-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Dec 05 07:43:28 northpi-soundstation go-librespot[14736]: time="2025-12-05T07:43:28-05:00" level=info msg="zeroconf server listening on port 34665"
Dec 05 07:43:29 northpi-soundstation go-librespot[14736]: time="2025-12-05T07:43:29-05:00" level=debug msg="obtained new client token: AAB5gb2D+OhVAhgw8+6IgYyuq5nZHcybtMYCjpFPqMOY+/GiOewwPd0TySPSmw53hjJ/knrXvsuq2N66vDC298HbrbgxdQgj1jQc3OijHbbV425yOCn9aSczMZBvIx0PB4iBPIKG/kgPKrT6BtBt+3+N3OWmnIOojIlMBnh6BYuJMogHweEYsNdGACzAm/dpsBP03SEmS06LW9TPDpnYpCU8KZjWpFCR9qnVJKtDE0CEZ3MtQNK+iUN8cg=="
Dec 05 07:43:29 northpi-soundstation go-librespot[14736]: time="2025-12-05T07:43:29-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 07:43:29 northpi-soundstation go-librespot[14736]: time="2025-12-05T07:43:29-05:00" level=debug msg="completed keyexchange"
Dec 05 07:43:29 northpi-soundstation go-librespot[14736]: time="2025-12-05T07:43:29-05:00" level=debug msg="completed challenge"
Dec 05 07:43:29 northpi-soundstation go-librespot[14736]: time="2025-12-05T07:43:29-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 05 07:43:29 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 07:43:29 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 07:43:30 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:30 northpi-soundstation volumio[14030]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 07:43:30 northpi-soundstation volumio[14030]: info: CoreCommandRouter::volumioGetState
Dec 05 07:43:30 northpi-soundstation volumio[14030]: info: MRS: Adding multiroomSync output
Dec 05 07:43:30 northpi-soundstation volumio[14030]: info: Adding audio output:
Dec 05 07:43:30 northpi-soundstation volumio[14030]: info: MRS: Pushing multiroomSync output
Dec 05 07:43:32 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 16.
Dec 05 07:43:32 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:32 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:32 northpi-soundstation go-librespot[14757]: go-librespot daemon starting...
Dec 05 07:43:32 northpi-soundstation go-librespot[14758]: time="2025-12-05T07:43:32-05:00" level=info msg="running go-librespot 0.3.2"
Dec 05 07:43:32 northpi-soundstation go-librespot[14758]: time="2025-12-05T07:43:32-05:00" level=debug msg="app state loaded"
Dec 05 07:43:32 northpi-soundstation go-librespot[14758]: time="2025-12-05T07:43:32-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 07:43:32 northpi-soundstation go-librespot[14758]: time="2025-12-05T07:43:32-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 05 07:43:32 northpi-soundstation go-librespot[14758]: time="2025-12-05T07:43:32-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Dec 05 07:43:32 northpi-soundstation go-librespot[14758]: time="2025-12-05T07:43:32-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Dec 05 07:43:32 northpi-soundstation go-librespot[14758]: time="2025-12-05T07:43:32-05:00" level=info msg="zeroconf server listening on port 39223"
Dec 05 07:43:32 northpi-soundstation go-librespot[14758]: time="2025-12-05T07:43:32-05:00" level=debug msg="obtained new client token: AACrO1gGTMxUWdI3FbzHLQJARZUkri/SY/vy+rvimQ5GM14n7ucg4P/oDZp+bl3qXHUgJUi3cT3BRwBbaD353otf7ZH9ZDpxNQ+PRSWTsibi3+YsTaiB/EKCvkc4E7XUOj/6vdmWbKNkYsik+6Y5N6ifS2IVQ2KAe4fcFCSbKt0p9hP8lPkMdKIk1xeD5WAmggs3sVjG3nZOyPFQrsxJWK1o4UGZjy1FoG72Mp8oG/XEr1Jvskx2oM2dZw=="
Dec 05 07:43:32 northpi-soundstation go-librespot[14758]: time="2025-12-05T07:43:32-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 07:43:32 northpi-soundstation go-librespot[14758]: time="2025-12-05T07:43:32-05:00" level=debug msg="completed keyexchange"
Dec 05 07:43:32 northpi-soundstation go-librespot[14758]: time="2025-12-05T07:43:32-05:00" level=debug msg="completed challenge"
Dec 05 07:43:32 northpi-soundstation go-librespot[14758]: time="2025-12-05T07:43:32-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 05 07:43:32 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 07:43:32 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 07:43:33 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:33 northpi-soundstation volumio[14030]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 07:43:35 northpi-soundstation volumio[14030]: info: MRS: Pushing audio output on request
Dec 05 07:43:35 northpi-soundstation volumio[14030]: info: MRS: Pushing multiroomSync output
Dec 05 07:43:35 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 17.
Dec 05 07:43:35 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:35 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:35 northpi-soundstation go-librespot[14768]: go-librespot daemon starting...
Dec 05 07:43:35 northpi-soundstation go-librespot[14769]: time="2025-12-05T07:43:35-05:00" level=info msg="running go-librespot 0.3.2"
Dec 05 07:43:35 northpi-soundstation go-librespot[14769]: time="2025-12-05T07:43:35-05:00" level=debug msg="app state loaded"
Dec 05 07:43:35 northpi-soundstation go-librespot[14769]: time="2025-12-05T07:43:35-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 07:43:35 northpi-soundstation go-librespot[14769]: time="2025-12-05T07:43:35-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]"
Dec 05 07:43:35 northpi-soundstation go-librespot[14769]: time="2025-12-05T07:43:35-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443]"
Dec 05 07:43:35 northpi-soundstation go-librespot[14769]: time="2025-12-05T07:43:35-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443]"
Dec 05 07:43:35 northpi-soundstation go-librespot[14769]: time="2025-12-05T07:43:35-05:00" level=info msg="zeroconf server listening on port 34919"
Dec 05 07:43:35 northpi-soundstation go-librespot[14769]: time="2025-12-05T07:43:35-05:00" level=debug msg="obtained new client token: AACMLEuHWFG+duUPZfcpaab+4M6Jhq7TgWLr0OwQBunUfIZKPDd0nDq1VWwRoslYwHzL+cb+aYb8ziwmpQ1kic4J3ELXAz5xMvxxdB22E+w4K5BLkjiiJpbv+WFXSmYOhrN2BqWksDWGYRoRIUxOt5YdIBUoaU5b0sd4HOJn/kGn9wJwguKyMAFRaOdKzN49PCmqL9S8ITcMVE558bVOhAy/1TCxt3dYUINZApTuCIBpM7ZGgojx/2wwqg=="
Dec 05 07:43:36 northpi-soundstation go-librespot[14769]: time="2025-12-05T07:43:36-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 07:43:36 northpi-soundstation go-librespot[14769]: time="2025-12-05T07:43:36-05:00" level=debug msg="completed keyexchange"
Dec 05 07:43:36 northpi-soundstation go-librespot[14769]: time="2025-12-05T07:43:36-05:00" level=debug msg="completed challenge"
Dec 05 07:43:36 northpi-soundstation go-librespot[14769]: time="2025-12-05T07:43:36-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 05 07:43:36 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 07:43:36 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 07:43:36 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:36 northpi-soundstation volumio[14030]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 07:43:38 northpi-soundstation volumio[14030]: info: MRS: Updating multiroomSync output
Dec 05 07:43:39 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 18.
Dec 05 07:43:39 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:39 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:39 northpi-soundstation volumio[14030]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 07:43:39 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:39 northpi-soundstation go-librespot[14791]: go-librespot daemon starting...
Dec 05 07:43:39 northpi-soundstation go-librespot[14792]: time="2025-12-05T07:43:39-05:00" level=info msg="running go-librespot 0.3.2"
Dec 05 07:43:39 northpi-soundstation go-librespot[14792]: time="2025-12-05T07:43:39-05:00" level=debug msg="app state loaded"
Dec 05 07:43:39 northpi-soundstation go-librespot[14792]: time="2025-12-05T07:43:39-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 07:43:39 northpi-soundstation go-librespot[14792]: time="2025-12-05T07:43:39-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]"
Dec 05 07:43:39 northpi-soundstation go-librespot[14792]: time="2025-12-05T07:43:39-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443]"
Dec 05 07:43:39 northpi-soundstation go-librespot[14792]: time="2025-12-05T07:43:39-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443]"
Dec 05 07:43:39 northpi-soundstation go-librespot[14792]: time="2025-12-05T07:43:39-05:00" level=info msg="zeroconf server listening on port 39717"
Dec 05 07:43:39 northpi-soundstation go-librespot[14792]: time="2025-12-05T07:43:39-05:00" level=debug msg="obtained new client token: AAAnJWzlv9wYw9C/+K6UFqi3hxNXfU47MvSh3tyuCYPu5c31Piug5bagDiuSksWgInUlrjRUdZeRTal6L0Php9NVNpGmD6xeegf1YHqminWQndJZba5F7WXouzTgh6o8UfW6+azaPD5naoVlGzMcxnm0oT8a55xJeKXQd4jfTIJyN2dyv1oIspJJlkGrwu4skxRkneZ/vMYBR6Og91fPYnq2y5dgPg6P7nu7DIZzVJFL7OCauqgEHk1vZQ=="
Dec 05 07:43:39 northpi-soundstation go-librespot[14792]: time="2025-12-05T07:43:39-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 07:43:39 northpi-soundstation go-librespot[14792]: time="2025-12-05T07:43:39-05:00" level=debug msg="completed keyexchange"
Dec 05 07:43:39 northpi-soundstation go-librespot[14792]: time="2025-12-05T07:43:39-05:00" level=debug msg="completed challenge"
Dec 05 07:43:39 northpi-soundstation go-librespot[14792]: time="2025-12-05T07:43:39-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 05 07:43:39 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 07:43:39 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 07:43:40 northpi-soundstation volumio[14030]: info: CoreCommandRouter::volumioGetState
Dec 05 07:43:40 northpi-soundstation volumio[14030]: info: Listing playlists
Dec 05 07:43:40 northpi-soundstation volumio[14030]: info: Listing playlists
Dec 05 07:43:42 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:42 northpi-soundstation volumio[14030]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 07:43:42 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 19.
Dec 05 07:43:42 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:42 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:42 northpi-soundstation go-librespot[14799]: go-librespot daemon starting...
Dec 05 07:43:42 northpi-soundstation go-librespot[14800]: time="2025-12-05T07:43:42-05:00" level=info msg="running go-librespot 0.3.2"
Dec 05 07:43:42 northpi-soundstation go-librespot[14800]: time="2025-12-05T07:43:42-05:00" level=debug msg="app state loaded"
Dec 05 07:43:42 northpi-soundstation go-librespot[14800]: time="2025-12-05T07:43:42-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 07:43:42 northpi-soundstation go-librespot[14800]: time="2025-12-05T07:43:42-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 05 07:43:42 northpi-soundstation go-librespot[14800]: time="2025-12-05T07:43:42-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Dec 05 07:43:42 northpi-soundstation go-librespot[14800]: time="2025-12-05T07:43:42-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Dec 05 07:43:42 northpi-soundstation go-librespot[14800]: time="2025-12-05T07:43:42-05:00" level=info msg="zeroconf server listening on port 35913"
Dec 05 07:43:42 northpi-soundstation go-librespot[14800]: time="2025-12-05T07:43:42-05:00" level=debug msg="obtained new client token: AAAfkDNtemF2Okx+o6TrLdOCon+3POWtier5ln9JzqgzWk1wdL7D9LCaOcNeE36o5dzxN62OwnPMT9tcokABD1nJ7IorI2xXrPK4Omw7Pr9HtqUfGqEvFStCtIXdWWTutGFJki4ITVBP7rVtEMXVjs5lAX8sefUIZnYdVvG2oBvCV02QbhL1B1zsz6dtaAj75VKjsiXb6XKYYip5Yqel085dkUEGQz5SVCn3UFkhNTh6568AsyYWucy5EA=="
Dec 05 07:43:43 northpi-soundstation go-librespot[14800]: time="2025-12-05T07:43:43-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 07:43:43 northpi-soundstation go-librespot[14800]: time="2025-12-05T07:43:43-05:00" level=debug msg="completed keyexchange"
Dec 05 07:43:43 northpi-soundstation go-librespot[14800]: time="2025-12-05T07:43:43-05:00" level=debug msg="completed challenge"
Dec 05 07:43:43 northpi-soundstation go-librespot[14800]: time="2025-12-05T07:43:43-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 05 07:43:43 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 07:43:43 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 07:43:45 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:45 northpi-soundstation volumio[14030]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 07:43:46 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20.
Dec 05 07:43:46 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:46 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:46 northpi-soundstation go-librespot[14807]: go-librespot daemon starting...
Dec 05 07:43:46 northpi-soundstation go-librespot[14808]: time="2025-12-05T07:43:46-05:00" level=info msg="running go-librespot 0.3.2"
Dec 05 07:43:46 northpi-soundstation go-librespot[14808]: time="2025-12-05T07:43:46-05:00" level=debug msg="app state loaded"
Dec 05 07:43:46 northpi-soundstation go-librespot[14808]: time="2025-12-05T07:43:46-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 07:43:46 northpi-soundstation go-librespot[14808]: time="2025-12-05T07:43:46-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 05 07:43:46 northpi-soundstation go-librespot[14808]: time="2025-12-05T07:43:46-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Dec 05 07:43:46 northpi-soundstation go-librespot[14808]: time="2025-12-05T07:43:46-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Dec 05 07:43:46 northpi-soundstation go-librespot[14808]: time="2025-12-05T07:43:46-05:00" level=info msg="zeroconf server listening on port 46595"
Dec 05 07:43:46 northpi-soundstation go-librespot[14808]: time="2025-12-05T07:43:46-05:00" level=debug msg="obtained new client token: AADDsRGdc34WFmSnnRasq+7SAKYL3XqKf+OY7K2DRIb38PVbHTT6nwDQ8SDocmMYA3tZ1B7TmXkeaTZLGC2dzQIa+qhauMh6r6w35oQoldO/umK9aFVukS+MO5SovlPdFpqXEPEZDcU4gRFpgFwSnj7bzhQ+wGndCqfEAovq7bfarYXGsvhDE6PDYH3tLENVDVzNC4r3cmQ79099eOxiq4dDdT2UlbSXSpuFDrfhgAmGkp8rEpTdNBF/NQ=="
Dec 05 07:43:46 northpi-soundstation go-librespot[14808]: time="2025-12-05T07:43:46-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 07:43:46 northpi-soundstation go-librespot[14808]: time="2025-12-05T07:43:46-05:00" level=debug msg="completed keyexchange"
Dec 05 07:43:46 northpi-soundstation go-librespot[14808]: time="2025-12-05T07:43:46-05:00" level=debug msg="completed challenge"
Dec 05 07:43:46 northpi-soundstation go-librespot[14808]: time="2025-12-05T07:43:46-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 05 07:43:46 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 07:43:46 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 07:43:48 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:48 northpi-soundstation volumio[14030]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 07:43:49 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 21.
Dec 05 07:43:49 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:49 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:49 northpi-soundstation go-librespot[14830]: go-librespot daemon starting...
Dec 05 07:43:49 northpi-soundstation go-librespot[14831]: time="2025-12-05T07:43:49-05:00" level=info msg="running go-librespot 0.3.2"
Dec 05 07:43:49 northpi-soundstation go-librespot[14831]: time="2025-12-05T07:43:49-05:00" level=debug msg="app state loaded"
Dec 05 07:43:49 northpi-soundstation go-librespot[14831]: time="2025-12-05T07:43:49-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 07:43:49 northpi-soundstation go-librespot[14831]: time="2025-12-05T07:43:49-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 05 07:43:49 northpi-soundstation go-librespot[14831]: time="2025-12-05T07:43:49-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Dec 05 07:43:49 northpi-soundstation go-librespot[14831]: time="2025-12-05T07:43:49-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Dec 05 07:43:49 northpi-soundstation go-librespot[14831]: time="2025-12-05T07:43:49-05:00" level=info msg="zeroconf server listening on port 34159"
Dec 05 07:43:50 northpi-soundstation go-librespot[14831]: time="2025-12-05T07:43:50-05:00" level=debug msg="obtained new client token: AAAdLAC+khgcM4HuSQcy0IUe/wHWyJ8Ga14toX+cvuZBwlSWSAkCxFaANWHtbZjxAW+rvUrzh/Zbhmm6HvHCAA99ZYReFNdqCOvCNCilbwT7Hz5HMLKVV+ko2hJHDgi9AGEuuMJBKeYBVu9ods//j9gqFT0cI1ZlXbT32FsqnJ1nPUegkzZO88UMO4ZHK1+U1hiWvaTt/M5AlXxnX2qPYfcDUu/zzHccr4zcUM4efBxf7H1jMyNNlWI="
Dec 05 07:43:50 northpi-soundstation go-librespot[14831]: time="2025-12-05T07:43:50-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 07:43:50 northpi-soundstation go-librespot[14831]: time="2025-12-05T07:43:50-05:00" level=debug msg="completed keyexchange"
Dec 05 07:43:50 northpi-soundstation go-librespot[14831]: time="2025-12-05T07:43:50-05:00" level=debug msg="completed challenge"
Dec 05 07:43:50 northpi-soundstation go-librespot[14831]: time="2025-12-05T07:43:50-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 05 07:43:50 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 07:43:50 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 07:43:50 northpi-soundstation volumio[14030]: info: CoreCommandRouter::volumioGetState
Dec 05 07:43:51 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:51 northpi-soundstation volumio[14030]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 07:43:53 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 22.
Dec 05 07:43:53 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:53 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:53 northpi-soundstation go-librespot[14838]: go-librespot daemon starting...
Dec 05 07:43:53 northpi-soundstation go-librespot[14839]: time="2025-12-05T07:43:53-05:00" level=info msg="running go-librespot 0.3.2"
Dec 05 07:43:53 northpi-soundstation go-librespot[14839]: time="2025-12-05T07:43:53-05:00" level=debug msg="app state loaded"
Dec 05 07:43:53 northpi-soundstation go-librespot[14839]: time="2025-12-05T07:43:53-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 07:43:53 northpi-soundstation go-librespot[14839]: time="2025-12-05T07:43:53-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 05 07:43:53 northpi-soundstation go-librespot[14839]: time="2025-12-05T07:43:53-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Dec 05 07:43:53 northpi-soundstation go-librespot[14839]: time="2025-12-05T07:43:53-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Dec 05 07:43:53 northpi-soundstation go-librespot[14839]: time="2025-12-05T07:43:53-05:00" level=info msg="zeroconf server listening on port 42907"
Dec 05 07:43:53 northpi-soundstation go-librespot[14839]: time="2025-12-05T07:43:53-05:00" level=debug msg="obtained new client token: AAA4KoypSOnxx5Ps/DLpwetzqbfvXOuDJENYbzRlej7DB+ENpLVJngIQTxaBUjpmmRu5KhJLXpdTcC334vniAKkCES0B8MBu0yNzDaGsj/V5ijfyz03H0hccBJ85IIPbWJY3anBRhOcGrbF9G6bmi43ZeHTeVuUpy3nOXek3A34G+wY8gNfIN9w83sYLzCn4QB/jFXJJAii/OK6BQhvLN3pudt95HL3kfFISKW+tmWmIVXaaAgrw2s3bcw=="
Dec 05 07:43:53 northpi-soundstation go-librespot[14839]: time="2025-12-05T07:43:53-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 07:43:53 northpi-soundstation go-librespot[14839]: time="2025-12-05T07:43:53-05:00" level=debug msg="completed keyexchange"
Dec 05 07:43:53 northpi-soundstation go-librespot[14839]: time="2025-12-05T07:43:53-05:00" level=debug msg="completed challenge"
Dec 05 07:43:53 northpi-soundstation go-librespot[14839]: time="2025-12-05T07:43:53-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 05 07:43:53 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 07:43:53 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 07:43:54 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:54 northpi-soundstation volumio[14030]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 07:43:54 northpi-soundstation volumio[14030]: info: Discovery: Disconnected from remote: 192.168.1.97
Dec 05 07:43:54 northpi-soundstation volumio[14030]: info: MRS: Cleaning up device: 74ce6260-2045-48bb-acbd-0b75ccb5d93e
Dec 05 07:43:54 northpi-soundstation volumio[14030]: info: Removing audio output:
Dec 05 07:43:55 northpi-soundstation volumio[14030]: info: Discovery: A device disappeared from network
Dec 05 07:43:55 northpi-soundstation volumio[14030]: info: Discovery: Device gbvpi-bedroom disappeared from network
Dec 05 07:43:56 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 23.
Dec 05 07:43:56 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:56 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:43:56 northpi-soundstation go-librespot[14849]: go-librespot daemon starting...
Dec 05 07:43:56 northpi-soundstation go-librespot[14850]: time="2025-12-05T07:43:56-05:00" level=info msg="running go-librespot 0.3.2"
Dec 05 07:43:56 northpi-soundstation go-librespot[14850]: time="2025-12-05T07:43:56-05:00" level=debug msg="app state loaded"
Dec 05 07:43:56 northpi-soundstation go-librespot[14850]: time="2025-12-05T07:43:56-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 07:43:57 northpi-soundstation go-librespot[14850]: time="2025-12-05T07:43:57-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 05 07:43:57 northpi-soundstation go-librespot[14850]: time="2025-12-05T07:43:57-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Dec 05 07:43:57 northpi-soundstation go-librespot[14850]: time="2025-12-05T07:43:57-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Dec 05 07:43:57 northpi-soundstation go-librespot[14850]: time="2025-12-05T07:43:57-05:00" level=info msg="zeroconf server listening on port 36845"
Dec 05 07:43:57 northpi-soundstation volumio[14030]: info: Initializing connection to go-librespot Websocket
Dec 05 07:43:57 northpi-soundstation go-librespot[14850]: time="2025-12-05T07:43:57-05:00" level=debug msg="new websocket client"
Dec 05 07:43:57 northpi-soundstation volumio[14030]: info: Connection to go-librespot Websocket established
Dec 05 07:43:57 northpi-soundstation go-librespot[14850]: time="2025-12-05T07:43:57-05:00" level=debug msg="obtained new client token: AAC3Ukwgr9cOu+n+RI6HqbZN4WLUeo0O0y9DCYmiNlyAxffDH7BYT/5K8jvUfDa5A5109AzDS/6xPyurbUbtPZ1KRKrNcqIgtMdYeUV8yKsl+2AUQ+tXJL7hD68R/MCvKuKytuLuAPWZ6f63iYliEMtVuGms55m9QHY4/wx8ZkxL46VOvv5uA1sqWEI17Id/TPQ1YnvSQxOJ5yA8WwYh/TkmLzyPeXEFnp63IFSRe6l95q/UbxW0Z/w="
Dec 05 07:43:57 northpi-soundstation go-librespot[14850]: time="2025-12-05T07:43:57-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 07:43:57 northpi-soundstation go-librespot[14850]: time="2025-12-05T07:43:57-05:00" level=debug msg="completed keyexchange"
Dec 05 07:43:57 northpi-soundstation go-librespot[14850]: time="2025-12-05T07:43:57-05:00" level=debug msg="completed challenge"
Dec 05 07:43:57 northpi-soundstation go-librespot[14850]: time="2025-12-05T07:43:57-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 05 07:43:57 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 07:43:57 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 07:43:57 northpi-soundstation volumio[14030]: info: Connection to go-librespot Websocket closed
Dec 05 07:43:58 northpi-soundstation volumio[14030]: info: Discovery: adding 74ce6260-2045-48bb-acbd-0b75ccb5d93e
Dec 05 07:43:58 northpi-soundstation volumio[14030]: info: Discovery: Found device GBVPi-Bedroom
Dec 05 07:43:58 northpi-soundstation volumio[14030]: info: Discovery: Connecting to remote: 192.168.1.97
Dec 05 07:43:59 northpi-soundstation volumio[14030]: info: MRS: Pushing audio output on request
Dec 05 07:43:59 northpi-soundstation volumio[14030]: info: MRS: Pushing multiroomSync output
Dec 05 07:43:59 northpi-soundstation volumio[14030]: info: Discovery: Connected to remote: 192.168.1.97
Dec 05 07:44:00 northpi-soundstation volumio[14030]: info: Getting Spotify volume
Dec 05 07:44:00 northpi-soundstation volumio[14030]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 05 07:44:00 northpi-soundstation volumio[14030]: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 07:44:00 northpi-soundstation volumio[14030]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Dec 05 07:44:00 northpi-soundstation volumio[14030]: errno: -111,
Dec 05 07:44:00 northpi-soundstation volumio[14030]: code: 'ECONNREFUSED',
Dec 05 07:44:00 northpi-soundstation volumio[14030]: syscall: 'connect',
Dec 05 07:44:00 northpi-soundstation volumio[14030]: address: '127.0.0.1',
Dec 05 07:44:00 northpi-soundstation volumio[14030]: port: 9879,
Dec 05 07:44:00 northpi-soundstation volumio[14030]: response: undefined
Dec 05 07:44:00 northpi-soundstation volumio[14030]: }
Dec 05 07:44:00 northpi-soundstation volumio[14030]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 05 07:44:00 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 24.
Dec 05 07:44:00 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:44:00 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 07:44:00 northpi-soundstation go-librespot[14884]: go-librespot daemon starting...
Dec 05 07:44:00 northpi-soundstation go-librespot[14885]: time="2025-12-05T07:44:00-05:00" level=info msg="running go-librespot 0.3.2"
Dec 05 07:44:00 northpi-soundstation go-librespot[14885]: time="2025-12-05T07:44:00-05:00" level=debug msg="app state loaded"
Dec 05 07:44:00 northpi-soundstation go-librespot[14885]: time="2025-12-05T07:44:00-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 07:44:00 northpi-soundstation sudo[14894]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-05 07:43'
Dec 05 07:44:00 northpi-soundstation sudo[14894]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="3a3cfe435f8bb2bc94a920662e91a4ef35bc8e7c"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Dec 2 11:51:19 UTC 2025"
VOLUMIO_VERSION="4.072"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="e5001581b220b096097cf8f46a54d4f1"