Dec 05 20:13:00 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 05 20:13:00 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 05 20:13:00 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Dec 05 20:13:01 gbvpi-bedroom volumio-remote-updater[11354]: Test mode enabled
Dec 05 20:13:01 gbvpi-bedroom volumio-remote-updater[11354]: Alpha mode disabled
Dec 05 20:13:01 gbvpi-bedroom volumio-remote-updater[11354]: Alpha legacy test mode disabled
Dec 05 20:13:01 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Dec 05 20:13:01 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 05 20:13:01 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 05 20:13:01 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Dec 05 20:13:01 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Dec 05 20:13:01 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Dec 05 20:13:01 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 05 20:13:01 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 05 20:13:01 gbvpi-bedroom volumio[28500]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"ANNOUNCEMENT
\n\n- Production line
\n
\nFIX
\n\n- Nodejs 20.5.1 version pinning with static package fallback
\n
\n","title":"Update v4.073","updateavailable":true}
Dec 05 20:13:01 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Dec 05 20:13:01 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:01 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:13:01 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 8.
Dec 05 20:13:01 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:01 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:01 gbvpi-bedroom go-librespot[29117]: go-librespot daemon starting...
Dec 05 20:13:01 gbvpi-bedroom go-librespot[29118]: time="2025-12-05T20:13:01-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:13:01 gbvpi-bedroom go-librespot[29118]: time="2025-12-05T20:13:01-05:00" level=debug msg="app state loaded"
Dec 05 20:13:01 gbvpi-bedroom go-librespot[29118]: time="2025-12-05T20:13:01-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:13:01 gbvpi-bedroom go-librespot[29118]: time="2025-12-05T20:13:01-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 20:13:01 gbvpi-bedroom go-librespot[29118]: time="2025-12-05T20:13:01-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 20:13:01 gbvpi-bedroom go-librespot[29118]: time="2025-12-05T20:13:01-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 20:13:01 gbvpi-bedroom go-librespot[29118]: time="2025-12-05T20:13:01-05:00" level=info msg="zeroconf server listening on port 34683"
Dec 05 20:13:01 gbvpi-bedroom go-librespot[29118]: time="2025-12-05T20:13:01-05:00" level=debug msg="obtained new client token: AAB8bdCjU5i05bLsw5UdsTjwci2FauekkL9pOWLWbuV0IahOoPASQufQt/yT76n8PG/Otc5rJu377rv0u5/Aw0LPJLp7TjsMHkCsbqMlDhfYaMGc3FOtmW03SBK87DTqVjrmbbUT99zy/uUb0isQfuO7PaOjchPsQf1NcTdF5p0X0KSXTlflC5TXmg/SAN6M2SwXTGu9KwxJIz28jycrcawXxDcTKd63PKcBk7uZA4BayTSywzakp5JSCg=="
Dec 05 20:13:01 gbvpi-bedroom go-librespot[29118]: time="2025-12-05T20:13:01-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 20:13:01 gbvpi-bedroom go-librespot[29118]: time="2025-12-05T20:13:01-05:00" level=debug msg="completed keyexchange"
Dec 05 20:13:01 gbvpi-bedroom go-librespot[29118]: time="2025-12-05T20:13:01-05:00" level=debug msg="completed challenge"
Dec 05 20:13:01 gbvpi-bedroom go-librespot[29118]: time="2025-12-05T20:13:01-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 20:13:01 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:13:01 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:13:02 gbvpi-bedroom volumio[28500]: info: BOOT COMPLETED
Dec 05 20:13:04 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:04 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:13:05 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 9.
Dec 05 20:13:05 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:05 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:05 gbvpi-bedroom go-librespot[29126]: go-librespot daemon starting...
Dec 05 20:13:05 gbvpi-bedroom go-librespot[29127]: time="2025-12-05T20:13:05-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:13:05 gbvpi-bedroom go-librespot[29127]: time="2025-12-05T20:13:05-05:00" level=debug msg="app state loaded"
Dec 05 20:13:05 gbvpi-bedroom go-librespot[29127]: time="2025-12-05T20:13:05-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:13:05 gbvpi-bedroom go-librespot[29127]: time="2025-12-05T20:13:05-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 20:13:05 gbvpi-bedroom go-librespot[29127]: time="2025-12-05T20:13:05-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 20:13:05 gbvpi-bedroom go-librespot[29127]: time="2025-12-05T20:13:05-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 20:13:05 gbvpi-bedroom go-librespot[29127]: time="2025-12-05T20:13:05-05:00" level=info msg="zeroconf server listening on port 38487"
Dec 05 20:13:05 gbvpi-bedroom go-librespot[29127]: time="2025-12-05T20:13:05-05:00" level=debug msg="obtained new client token: AAD43t62XLil0lTbuCj7Eb4Mt/rZKZb/HSt1jFR6XdZfem8xaV+1Io4QdFuCC6EhmS0T8mwiSNf6F7kpYZS/qQLkSobf08RCm0Ou5uRqIcZ64S4Iu8L69qUIxtr/AC4hs3h62cP9pp2n0DOShXRKTzjSnU74OwATl6JHsXJdp2SkhyC9jmdjDV9UWNRT6ps/kTW80OxykHz3smN6L1ulyPruImussREgXeMalmsEkTirSJp8uKpkFImVOg=="
Dec 05 20:13:05 gbvpi-bedroom go-librespot[29127]: time="2025-12-05T20:13:05-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 20:13:05 gbvpi-bedroom go-librespot[29127]: time="2025-12-05T20:13:05-05:00" level=debug msg="completed keyexchange"
Dec 05 20:13:05 gbvpi-bedroom go-librespot[29127]: time="2025-12-05T20:13:05-05:00" level=debug msg="completed challenge"
Dec 05 20:13:05 gbvpi-bedroom go-librespot[29127]: time="2025-12-05T20:13:05-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 20:13:05 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:13:05 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:13:07 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:07 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:13:07 gbvpi-bedroom volumio[28500]: info: Discovery: Disconnected from remote: 192.168.1.28
Dec 05 20:13:07 gbvpi-bedroom volumio[28500]: info: MRS: Cleaning up device: 357de02c-99c5-4ddd-be16-8ae369ed89c3
Dec 05 20:13:07 gbvpi-bedroom volumio[28500]: info: Removing audio output:
Dec 05 20:13:07 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::volumioGetState
Dec 05 20:13:07 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::volumioGetState
Dec 05 20:13:08 gbvpi-bedroom volumio[28500]: info: Discovery: A device disappeared from network
Dec 05 20:13:08 gbvpi-bedroom volumio[28500]: info: Discovery: Device northpi-soundstation disappeared from network
Dec 05 20:13:08 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10.
Dec 05 20:13:08 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:08 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:08 gbvpi-bedroom go-librespot[29148]: go-librespot daemon starting...
Dec 05 20:13:08 gbvpi-bedroom go-librespot[29149]: time="2025-12-05T20:13:08-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:13:08 gbvpi-bedroom go-librespot[29149]: time="2025-12-05T20:13:08-05:00" level=debug msg="app state loaded"
Dec 05 20:13:08 gbvpi-bedroom go-librespot[29149]: time="2025-12-05T20:13:08-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:13:09 gbvpi-bedroom go-librespot[29149]: time="2025-12-05T20:13:09-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 20:13:09 gbvpi-bedroom go-librespot[29149]: time="2025-12-05T20:13:09-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 20:13:09 gbvpi-bedroom go-librespot[29149]: time="2025-12-05T20:13:09-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 20:13:09 gbvpi-bedroom go-librespot[29149]: time="2025-12-05T20:13:09-05:00" level=info msg="zeroconf server listening on port 44615"
Dec 05 20:13:09 gbvpi-bedroom go-librespot[29149]: time="2025-12-05T20:13:09-05:00" level=debug msg="obtained new client token: AAAlOpgl4go4eZOfodVv3WpUH+AIxJQA+uWKUhCz00OKfMW1EKdntx7gwEIDjD9+fRGyZ6DbLNXtyL9J51ljX+/8sp9Icg/JGXtQK4rQrxKmJFEGr7VI4glkfjOX/+V/weVOuONWmZfF70V7ntoF1zVs95xTGYFQS1PdkG/h3xwpPrtUjurbrlQW+JwLn6Se8eyyQGDKX3fnNP3XYHKH2n7+YFmQuJQxo1wp2N0DWR0c2NRX685w23I="
Dec 05 20:13:09 gbvpi-bedroom go-librespot[29149]: time="2025-12-05T20:13:09-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 20:13:09 gbvpi-bedroom go-librespot[29149]: time="2025-12-05T20:13:09-05:00" level=debug msg="completed keyexchange"
Dec 05 20:13:09 gbvpi-bedroom go-librespot[29149]: time="2025-12-05T20:13:09-05:00" level=debug msg="completed challenge"
Dec 05 20:13:09 gbvpi-bedroom go-librespot[29149]: time="2025-12-05T20:13:09-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 20:13:09 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:13:09 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:13:10 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:10 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:13:11 gbvpi-bedroom volumio[28500]: info: Discovery: adding 357de02c-99c5-4ddd-be16-8ae369ed89c3
Dec 05 20:13:11 gbvpi-bedroom volumio[28500]: info: Discovery: Found device NorthPi-Soundstation
Dec 05 20:13:11 gbvpi-bedroom volumio[28500]: info: Discovery: Connecting to remote: 192.168.1.28
Dec 05 20:13:12 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11.
Dec 05 20:13:12 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:12 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:12 gbvpi-bedroom go-librespot[29160]: go-librespot daemon starting...
Dec 05 20:13:12 gbvpi-bedroom go-librespot[29161]: time="2025-12-05T20:13:12-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:13:12 gbvpi-bedroom go-librespot[29161]: time="2025-12-05T20:13:12-05:00" level=debug msg="app state loaded"
Dec 05 20:13:12 gbvpi-bedroom go-librespot[29161]: time="2025-12-05T20:13:12-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:13:12 gbvpi-bedroom volumio[28500]: info: MRS: Pushing audio output on request
Dec 05 20:13:12 gbvpi-bedroom volumio[28500]: info: MRS: Pushing multiroomSync output
Dec 05 20:13:12 gbvpi-bedroom volumio[28500]: info: Discovery: Connected to remote: 192.168.1.28
Dec 05 20:13:12 gbvpi-bedroom go-librespot[29161]: time="2025-12-05T20:13:12-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 20:13:12 gbvpi-bedroom go-librespot[29161]: time="2025-12-05T20:13:12-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 20:13:12 gbvpi-bedroom go-librespot[29161]: time="2025-12-05T20:13:12-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 20:13:12 gbvpi-bedroom go-librespot[29161]: time="2025-12-05T20:13:12-05:00" level=info msg="zeroconf server listening on port 42625"
Dec 05 20:13:13 gbvpi-bedroom go-librespot[29161]: time="2025-12-05T20:13:13-05:00" level=debug msg="obtained new client token: AACwDEVLlWNuhRq2yjKt+hC8STXycOcVMSUu33wQyzJBeUyzx2YLqhvduKKGBs7J3/v0jfwqTgrwHGboyTVZWVrwZOucd4IlsI/lIhgu1Og7j/zYPIGWeZhv06X+YE7zaHgl2pxNOJbOOsRfG3g94N6Bvh2xWsDevRvMw8jErbHLDF+MmfptVIYqNXsj6bcKxA4IU0RsKqbosTd7QuJNwy+wrJ9RkmLUxWhRCtWFJISNIk/nbAtsBAAlmg=="
Dec 05 20:13:13 gbvpi-bedroom go-librespot[29161]: time="2025-12-05T20:13:13-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 20:13:13 gbvpi-bedroom go-librespot[29161]: time="2025-12-05T20:13:13-05:00" level=debug msg="completed keyexchange"
Dec 05 20:13:13 gbvpi-bedroom go-librespot[29161]: time="2025-12-05T20:13:13-05:00" level=debug msg="completed challenge"
Dec 05 20:13:13 gbvpi-bedroom go-librespot[29161]: time="2025-12-05T20:13:13-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 20:13:13 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:13:13 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:13:13 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:13 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:13:16 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:16 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:13:16 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 12.
Dec 05 20:13:16 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:16 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:16 gbvpi-bedroom go-librespot[29169]: go-librespot daemon starting...
Dec 05 20:13:16 gbvpi-bedroom go-librespot[29170]: time="2025-12-05T20:13:16-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:13:16 gbvpi-bedroom go-librespot[29170]: time="2025-12-05T20:13:16-05:00" level=debug msg="app state loaded"
Dec 05 20:13:16 gbvpi-bedroom go-librespot[29170]: time="2025-12-05T20:13:16-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:13:16 gbvpi-bedroom go-librespot[29170]: time="2025-12-05T20:13:16-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 20:13:16 gbvpi-bedroom go-librespot[29170]: time="2025-12-05T20:13:16-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 20:13:16 gbvpi-bedroom go-librespot[29170]: time="2025-12-05T20:13:16-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 20:13:16 gbvpi-bedroom go-librespot[29170]: time="2025-12-05T20:13:16-05:00" level=info msg="zeroconf server listening on port 42543"
Dec 05 20:13:16 gbvpi-bedroom go-librespot[29170]: time="2025-12-05T20:13:16-05:00" level=debug msg="obtained new client token: AAB+xdmZUHNZTeYK03fnh0/rVKKQlFvguQ7CCvFHMBcOlVhkX4j64ro6R35UrRs9WHsC+JmHsYl2pCveSNjG7B/y2FigQBmmKoBOhSL3aOITOFESjnbMi0FxEwiY/ivWO11IDF0jL9uTMDZAEmwTTUEcs6G98OZ+uDpy65awywlnmCeAhdBVz8nmy61/9km2geC46+qsGi92JvbdaGLE7KuINdLKVoN6tlis5Wfu+6RfplhDSDk1m8eSqw=="
Dec 05 20:13:16 gbvpi-bedroom go-librespot[29170]: time="2025-12-05T20:13:16-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 20:13:16 gbvpi-bedroom go-librespot[29170]: time="2025-12-05T20:13:16-05:00" level=debug msg="completed keyexchange"
Dec 05 20:13:16 gbvpi-bedroom go-librespot[29170]: time="2025-12-05T20:13:16-05:00" level=debug msg="completed challenge"
Dec 05 20:13:16 gbvpi-bedroom go-librespot[29170]: time="2025-12-05T20:13:16-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 20:13:16 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:13:16 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:13:17 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::volumioGetState
Dec 05 20:13:17 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::volumioGetState
Dec 05 20:13:17 gbvpi-bedroom volumio[28500]: info: Listing playlists
Dec 05 20:13:17 gbvpi-bedroom volumio[28500]: info: Listing playlists
Dec 05 20:13:17 gbvpi-bedroom volumio[28500]: info: Listing playlists
Dec 05 20:13:17 gbvpi-bedroom volumio[28500]: info: Listing playlists
Dec 05 20:13:19 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:19 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:13:20 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 13.
Dec 05 20:13:20 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:20 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:20 gbvpi-bedroom go-librespot[29191]: go-librespot daemon starting...
Dec 05 20:13:20 gbvpi-bedroom go-librespot[29192]: time="2025-12-05T20:13:20-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:13:20 gbvpi-bedroom go-librespot[29192]: time="2025-12-05T20:13:20-05:00" level=debug msg="app state loaded"
Dec 05 20:13:20 gbvpi-bedroom go-librespot[29192]: time="2025-12-05T20:13:20-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:13:20 gbvpi-bedroom go-librespot[29192]: time="2025-12-05T20:13:20-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 20:13:20 gbvpi-bedroom go-librespot[29192]: time="2025-12-05T20:13:20-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 20:13:20 gbvpi-bedroom go-librespot[29192]: time="2025-12-05T20:13:20-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 20:13:20 gbvpi-bedroom go-librespot[29192]: time="2025-12-05T20:13:20-05:00" level=info msg="zeroconf server listening on port 38899"
Dec 05 20:13:20 gbvpi-bedroom go-librespot[29192]: time="2025-12-05T20:13:20-05:00" level=debug msg="obtained new client token: AADyzTgZVP6N+2R7iJV4hJ2uhNji3UtcnDb1yF3VLW/PhD/KRudyhcim4qyMj76QrX74wn4pox3bLSz+tzxc9BGX+SqunGgOODC120aSl7MK1ilwTMJ0DK6jGssLjb09SZtDev/JD3kBml8BKHXtCtCQG6OKoWlnYalJcq1ImA5uKHbMgUcInnzmnWi7naKjbWwvYq4J4CDO8s1VQF9PkSz1zpfVdtYvelk+WWMWHQ5q9SNH0TsNBX007g=="
Dec 05 20:13:20 gbvpi-bedroom go-librespot[29192]: time="2025-12-05T20:13:20-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 20:13:20 gbvpi-bedroom go-librespot[29192]: time="2025-12-05T20:13:20-05:00" level=debug msg="completed keyexchange"
Dec 05 20:13:20 gbvpi-bedroom go-librespot[29192]: time="2025-12-05T20:13:20-05:00" level=debug msg="completed challenge"
Dec 05 20:13:20 gbvpi-bedroom go-librespot[29192]: time="2025-12-05T20:13:20-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 20:13:20 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:13:20 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:13:22 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:22 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:13:23 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14.
Dec 05 20:13:23 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:23 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:23 gbvpi-bedroom go-librespot[29200]: go-librespot daemon starting...
Dec 05 20:13:23 gbvpi-bedroom go-librespot[29201]: time="2025-12-05T20:13:23-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:13:23 gbvpi-bedroom go-librespot[29201]: time="2025-12-05T20:13:23-05:00" level=debug msg="app state loaded"
Dec 05 20:13:23 gbvpi-bedroom go-librespot[29201]: time="2025-12-05T20:13:23-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:13:24 gbvpi-bedroom go-librespot[29201]: time="2025-12-05T20:13:24-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 20:13:24 gbvpi-bedroom go-librespot[29201]: time="2025-12-05T20:13:24-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 20:13:24 gbvpi-bedroom go-librespot[29201]: time="2025-12-05T20:13:24-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 20:13:24 gbvpi-bedroom go-librespot[29201]: time="2025-12-05T20:13:24-05:00" level=info msg="zeroconf server listening on port 40047"
Dec 05 20:13:24 gbvpi-bedroom go-librespot[29201]: time="2025-12-05T20:13:24-05:00" level=debug msg="obtained new client token: AABbzKiWUAUjnGnM2rodiix6icI0ANwtLc/CGsMk9nT3UgRqqbgzz7vDqg1Jj1IpYoLwCrA/bkJ4gGnTIC84OWtPTGb200SzaGEw6CCr0hNaX6TkPPmXZF368kNBGzqydN6M8Eojc2AyXVCAPHPP9NKvC7fYPa7v/x7bN3poXQo+4tDTMQ1ldxHxbz9raaGveMGD5qPbvH5husnfsZOe7/VC3On83N9gv7UagaSFuaoatkoLtnDEy4g="
Dec 05 20:13:24 gbvpi-bedroom go-librespot[29201]: time="2025-12-05T20:13:24-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 20:13:24 gbvpi-bedroom go-librespot[29201]: time="2025-12-05T20:13:24-05:00" level=debug msg="completed keyexchange"
Dec 05 20:13:24 gbvpi-bedroom go-librespot[29201]: time="2025-12-05T20:13:24-05:00" level=debug msg="completed challenge"
Dec 05 20:13:24 gbvpi-bedroom go-librespot[29201]: time="2025-12-05T20:13:24-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 20:13:24 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:13:24 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:13:25 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:25 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:13:26 gbvpi-bedroom volumio[28500]: info: MRS: Adding multiroomSync output
Dec 05 20:13:26 gbvpi-bedroom volumio[28500]: info: Adding audio output:
Dec 05 20:13:26 gbvpi-bedroom volumio[28500]: info: MRS: Pushing multiroomSync output
Dec 05 20:13:27 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 15.
Dec 05 20:13:27 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:27 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:27 gbvpi-bedroom go-librespot[29222]: go-librespot daemon starting...
Dec 05 20:13:27 gbvpi-bedroom go-librespot[29223]: time="2025-12-05T20:13:27-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:13:27 gbvpi-bedroom go-librespot[29223]: time="2025-12-05T20:13:27-05:00" level=debug msg="app state loaded"
Dec 05 20:13:27 gbvpi-bedroom go-librespot[29223]: time="2025-12-05T20:13:27-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:13:27 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::volumioGetState
Dec 05 20:13:27 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::volumioGetState
Dec 05 20:13:27 gbvpi-bedroom go-librespot[29223]: time="2025-12-05T20:13:27-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 20:13:27 gbvpi-bedroom go-librespot[29223]: time="2025-12-05T20:13:27-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 20:13:27 gbvpi-bedroom go-librespot[29223]: time="2025-12-05T20:13:27-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 20:13:27 gbvpi-bedroom go-librespot[29223]: time="2025-12-05T20:13:27-05:00" level=info msg="zeroconf server listening on port 46325"
Dec 05 20:13:27 gbvpi-bedroom go-librespot[29223]: time="2025-12-05T20:13:27-05:00" level=debug msg="obtained new client token: AADJN6k2KlsiETXiOgpkFhCibFXfYDUNiQPOcFySYimimZegcAF/hh/HhqqoxoFXp9Rf28p57qNziCFP/yZRNUwkx3myJJ/AvLP0IFKBT/ATRYbf3LzG/wtYQaVNFpuVLyM7jk6cuBISBa6pFr1JGzoEAc1RWQgQ2czJ0ikiszr53J6275u17dMcyZpLFhES0FNhzBvhLlhESkX1qcLIYw1hVq2K8XoWhRYamnjJ4D+xGfEsgBarzSPbEQ=="
Dec 05 20:13:28 gbvpi-bedroom go-librespot[29223]: time="2025-12-05T20:13:28-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 20:13:28 gbvpi-bedroom go-librespot[29223]: time="2025-12-05T20:13:28-05:00" level=debug msg="completed keyexchange"
Dec 05 20:13:28 gbvpi-bedroom go-librespot[29223]: time="2025-12-05T20:13:28-05:00" level=debug msg="completed challenge"
Dec 05 20:13:28 gbvpi-bedroom go-librespot[29223]: time="2025-12-05T20:13:28-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 20:13:28 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:13:28 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:13:28 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:28 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:13:31 gbvpi-bedroom volumio[28500]: info: UPDATER: Scheduling automatic update
Dec 05 20:13:31 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStartTime
Dec 05 20:13:31 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStopTime
Dec 05 20:13:31 gbvpi-bedroom volumio[28500]: info: UPDATER: Auto update will take place at: Sat Dec 06 2025 05:05:07 GMT-0500 (Eastern Standard Time)
Dec 05 20:13:31 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:31 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:13:31 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 16.
Dec 05 20:13:31 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:31 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:31 gbvpi-bedroom go-librespot[29230]: go-librespot daemon starting...
Dec 05 20:13:31 gbvpi-bedroom go-librespot[29231]: time="2025-12-05T20:13:31-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:13:31 gbvpi-bedroom go-librespot[29231]: time="2025-12-05T20:13:31-05:00" level=debug msg="app state loaded"
Dec 05 20:13:31 gbvpi-bedroom go-librespot[29231]: time="2025-12-05T20:13:31-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:13:31 gbvpi-bedroom go-librespot[29231]: time="2025-12-05T20:13:31-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 20:13:31 gbvpi-bedroom go-librespot[29231]: time="2025-12-05T20:13:31-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 20:13:31 gbvpi-bedroom go-librespot[29231]: time="2025-12-05T20:13:31-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 20:13:31 gbvpi-bedroom go-librespot[29231]: time="2025-12-05T20:13:31-05:00" level=info msg="zeroconf server listening on port 38669"
Dec 05 20:13:31 gbvpi-bedroom go-librespot[29231]: time="2025-12-05T20:13:31-05:00" level=debug msg="obtained new client token: AAA4hyzYh2Oiu9Ti+KQWfiYMNShDdKWcTheyTcbpmEwgELM9xHaZKpOnhfWIJGwGqg9EdIMQ2tR/MHNr44PZ10iPOasedQivPmc46HdygIrO4xxyrML1oFe8kszpSVw1xSWATLUe8ckbn1OUnelxstHbhbe5oJ1QQJlsixaHPDM+pWGfAgi6Ln/DqqUV54jVqUq2cTPZwtHO2aXpVPCNHJUwFuZUN7s9elE8qKV5JZ+0kb/NZekGrtCZEw=="
Dec 05 20:13:31 gbvpi-bedroom volumio[28500]: info: MRS: Pushing audio output on request
Dec 05 20:13:31 gbvpi-bedroom volumio[28500]: info: MRS: Pushing multiroomSync output
Dec 05 20:13:31 gbvpi-bedroom go-librespot[29231]: time="2025-12-05T20:13:31-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 20:13:31 gbvpi-bedroom go-librespot[29231]: time="2025-12-05T20:13:31-05:00" level=debug msg="completed keyexchange"
Dec 05 20:13:31 gbvpi-bedroom go-librespot[29231]: time="2025-12-05T20:13:31-05:00" level=debug msg="completed challenge"
Dec 05 20:13:31 gbvpi-bedroom go-librespot[29231]: time="2025-12-05T20:13:31-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 20:13:31 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:13:31 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:13:34 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:34 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:13:35 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 17.
Dec 05 20:13:35 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:35 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:35 gbvpi-bedroom go-librespot[29241]: go-librespot daemon starting...
Dec 05 20:13:35 gbvpi-bedroom go-librespot[29242]: time="2025-12-05T20:13:35-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:13:35 gbvpi-bedroom go-librespot[29242]: time="2025-12-05T20:13:35-05:00" level=debug msg="app state loaded"
Dec 05 20:13:35 gbvpi-bedroom go-librespot[29242]: time="2025-12-05T20:13:35-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:13:35 gbvpi-bedroom volumio[28500]: info: MRS: Updating multiroomSync output
Dec 05 20:13:35 gbvpi-bedroom volumio[28500]: info: MRS: Updating multiroomSync output
Dec 05 20:13:35 gbvpi-bedroom go-librespot[29242]: time="2025-12-05T20:13: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-gew4.spotify.com:80]"
Dec 05 20:13:35 gbvpi-bedroom go-librespot[29242]: time="2025-12-05T20:13:35-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 20:13:35 gbvpi-bedroom go-librespot[29242]: time="2025-12-05T20:13:35-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 20:13:35 gbvpi-bedroom go-librespot[29242]: time="2025-12-05T20:13:35-05:00" level=info msg="zeroconf server listening on port 43571"
Dec 05 20:13:35 gbvpi-bedroom go-librespot[29242]: time="2025-12-05T20:13:35-05:00" level=debug msg="obtained new client token: AADNVv1TAVyUwSyg2zlRJQg4hAOt/j2HQYINfiThyXPYGZa+vRPalHYvUUC8xaxXM18binzE+uwBYZe3oP3yhxUiidT+cqzQvYkNQLMmYlrVmSjzGVKCefifJzWt31FW/2ztaGFEoYre5PgCOdFA0iLaNiE2C9RhN2H/Thcf4JZoowo9pwa1RqVOjmaYFCXy8E8LePUczIjuqfrFoHF/EwSKgQnLb8OGZd3DFwwGyKkNxlYd6AEcwimkPw=="
Dec 05 20:13:35 gbvpi-bedroom go-librespot[29242]: time="2025-12-05T20:13:35-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 20:13:35 gbvpi-bedroom go-librespot[29242]: time="2025-12-05T20:13:35-05:00" level=debug msg="completed keyexchange"
Dec 05 20:13:35 gbvpi-bedroom go-librespot[29242]: time="2025-12-05T20:13:35-05:00" level=debug msg="completed challenge"
Dec 05 20:13:35 gbvpi-bedroom go-librespot[29242]: time="2025-12-05T20:13:35-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 20:13:35 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:13:35 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:13:37 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:37 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:13:37 gbvpi-bedroom volumio[28500]: info: [jellyfin-poller] Polled HTTPS://jellyfin.lukeaurio.net: online
Dec 05 20:13:37 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::volumioGetState
Dec 05 20:13:37 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::volumioGetState
Dec 05 20:13:37 gbvpi-bedroom volumio[28500]: info: Listing playlists
Dec 05 20:13:37 gbvpi-bedroom volumio[28500]: info: Listing playlists
Dec 05 20:13:37 gbvpi-bedroom volumio[28500]: info: Listing playlists
Dec 05 20:13:37 gbvpi-bedroom volumio[28500]: info: Listing playlists
Dec 05 20:13:38 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 18.
Dec 05 20:13:38 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:38 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:38 gbvpi-bedroom go-librespot[29263]: go-librespot daemon starting...
Dec 05 20:13:38 gbvpi-bedroom go-librespot[29264]: time="2025-12-05T20:13:38-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:13:38 gbvpi-bedroom go-librespot[29264]: time="2025-12-05T20:13:38-05:00" level=debug msg="app state loaded"
Dec 05 20:13:38 gbvpi-bedroom go-librespot[29264]: time="2025-12-05T20:13:38-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:13:39 gbvpi-bedroom go-librespot[29264]: time="2025-12-05T20:13: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-gew4.spotify.com:80]"
Dec 05 20:13:39 gbvpi-bedroom go-librespot[29264]: time="2025-12-05T20:13:39-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 20:13:39 gbvpi-bedroom go-librespot[29264]: time="2025-12-05T20:13:39-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 20:13:39 gbvpi-bedroom go-librespot[29264]: time="2025-12-05T20:13:39-05:00" level=info msg="zeroconf server listening on port 44697"
Dec 05 20:13:39 gbvpi-bedroom go-librespot[29264]: time="2025-12-05T20:13:39-05:00" level=debug msg="obtained new client token: AAD8i3R2q0L3o+CBfdYovl4xsfmTl4No8kzdzZhCqhsVlj/NlMeZg21Z5ZjPSCtQL2PmdlYun12VIEeU8S5mYyDsGhxH+X5pauaWTbElM+1PVx3kOCwTwos1+JdWSoXY7quF/iXqrffGU7E7zRDCKSGXAzACxCC5V6FiwafavrAuuX4Fs3aoJFqSGEy/G/UmVZCISeFFlZ4mcUtspcpGX0j6LsYpE/2WCSi70p2JfxEV4gSx5IZhViSijQ=="
Dec 05 20:13:39 gbvpi-bedroom go-librespot[29264]: time="2025-12-05T20:13:39-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 20:13:39 gbvpi-bedroom go-librespot[29264]: time="2025-12-05T20:13:39-05:00" level=debug msg="completed keyexchange"
Dec 05 20:13:39 gbvpi-bedroom go-librespot[29264]: time="2025-12-05T20:13:39-05:00" level=debug msg="completed challenge"
Dec 05 20:13:39 gbvpi-bedroom go-librespot[29264]: time="2025-12-05T20:13: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 20:13:39 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:13:39 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:13:40 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:40 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:13:42 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 19.
Dec 05 20:13:42 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:42 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:42 gbvpi-bedroom go-librespot[29272]: go-librespot daemon starting...
Dec 05 20:13:42 gbvpi-bedroom go-librespot[29273]: time="2025-12-05T20:13:42-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:13:42 gbvpi-bedroom go-librespot[29273]: time="2025-12-05T20:13:42-05:00" level=debug msg="app state loaded"
Dec 05 20:13:42 gbvpi-bedroom go-librespot[29273]: time="2025-12-05T20:13:42-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:13:42 gbvpi-bedroom go-librespot[29273]: time="2025-12-05T20:13: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 20:13:42 gbvpi-bedroom go-librespot[29273]: time="2025-12-05T20:13: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 20:13:42 gbvpi-bedroom go-librespot[29273]: time="2025-12-05T20:13: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 20:13:42 gbvpi-bedroom go-librespot[29273]: time="2025-12-05T20:13:42-05:00" level=info msg="zeroconf server listening on port 34569"
Dec 05 20:13:42 gbvpi-bedroom go-librespot[29273]: time="2025-12-05T20:13:42-05:00" level=debug msg="obtained new client token: AABsCcB4TkCA8rWOaJr94rkiu5nnz5o35qvtyNrwDh1ED4qzMzilWFbIbGEbCeXOI2xf5kiwEfaIKhF7/uOUspVmftOc7tOvL4Osx4k/8yWJ5DBg9dXfVvHS98GYzfxum5RAeIHxoDEkuWUflkaaXuPJ/c58ipBagoucci5jsxewKHr7xmeLqQnlHwIXejO6E5oEi/PQr15JjGEsEWgFIwEq7oyHlHVoW+/8veIRuhH/1vdMYOi+SCEFJA=="
Dec 05 20:13:42 gbvpi-bedroom go-librespot[29273]: time="2025-12-05T20:13:42-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 20:13:43 gbvpi-bedroom go-librespot[29273]: time="2025-12-05T20:13:43-05:00" level=debug msg="completed keyexchange"
Dec 05 20:13:43 gbvpi-bedroom go-librespot[29273]: time="2025-12-05T20:13:43-05:00" level=debug msg="completed challenge"
Dec 05 20:13:43 gbvpi-bedroom go-librespot[29273]: time="2025-12-05T20:13: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 20:13:43 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:13:43 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:13:43 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:43 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:13:44 gbvpi-bedroom volumio[28500]: info: Discovery: Disconnected from remote: 192.168.1.28
Dec 05 20:13:44 gbvpi-bedroom volumio[28500]: info: MRS: Cleaning up device: 357de02c-99c5-4ddd-be16-8ae369ed89c3
Dec 05 20:13:44 gbvpi-bedroom volumio[28500]: info: Removing audio output:
Dec 05 20:13:45 gbvpi-bedroom volumio[28500]: info: Discovery: A device disappeared from network
Dec 05 20:13:45 gbvpi-bedroom volumio[28500]: info: Discovery: Device northpi-soundstation disappeared from network
Dec 05 20:13:46 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:46 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:13:46 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20.
Dec 05 20:13:46 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:46 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:46 gbvpi-bedroom go-librespot[29280]: go-librespot daemon starting...
Dec 05 20:13:46 gbvpi-bedroom go-librespot[29281]: time="2025-12-05T20:13:46-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:13:46 gbvpi-bedroom go-librespot[29281]: time="2025-12-05T20:13:46-05:00" level=debug msg="app state loaded"
Dec 05 20:13:46 gbvpi-bedroom go-librespot[29281]: time="2025-12-05T20:13:46-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:13:46 gbvpi-bedroom go-librespot[29281]: time="2025-12-05T20:13: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-gae2.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 05 20:13:46 gbvpi-bedroom go-librespot[29281]: time="2025-12-05T20:13:46-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 20:13:46 gbvpi-bedroom go-librespot[29281]: time="2025-12-05T20:13:46-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 20:13:46 gbvpi-bedroom go-librespot[29281]: time="2025-12-05T20:13:46-05:00" level=info msg="zeroconf server listening on port 42325"
Dec 05 20:13:46 gbvpi-bedroom go-librespot[29281]: time="2025-12-05T20:13:46-05:00" level=debug msg="obtained new client token: AACnnOVjJLdEklD+HcEvHVcVsRSxX5kkfQnQcqy75/Ppe6ieO8GpQeLMQ2FOUNRrQqmUQ6xM9XBlUyQ+OaA11X+x98vJaPEdEfY73vsGQg50Vjrfye7E2jKoqVD4WrE0i4YVbih4sG8UIdT36/72Qw2Oqsg1D0BwZ/kcwTJl6AxmTP+y2wh91yq3DWETn8pGmKXn3/ee7jpSurvaybv5kAsvCt1iP9ffkJz7FL1Hd61HD2Fo29ovAWcHHw=="
Dec 05 20:13:46 gbvpi-bedroom go-librespot[29281]: time="2025-12-05T20:13:46-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 20:13:46 gbvpi-bedroom go-librespot[29281]: time="2025-12-05T20:13:46-05:00" level=debug msg="completed keyexchange"
Dec 05 20:13:46 gbvpi-bedroom go-librespot[29281]: time="2025-12-05T20:13:46-05:00" level=debug msg="completed challenge"
Dec 05 20:13:47 gbvpi-bedroom go-librespot[29281]: time="2025-12-05T20:13:47-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 20:13:47 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:13:47 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:13:47 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::volumioGetState
Dec 05 20:13:47 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::volumioGetState
Dec 05 20:13:48 gbvpi-bedroom volumio[28500]: info: Discovery: adding 357de02c-99c5-4ddd-be16-8ae369ed89c3
Dec 05 20:13:48 gbvpi-bedroom volumio[28500]: info: Discovery: Found device NorthPi-Soundstation
Dec 05 20:13:48 gbvpi-bedroom volumio[28500]: info: Discovery: Connecting to remote: 192.168.1.28
Dec 05 20:13:49 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:49 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:13:49 gbvpi-bedroom volumio[28500]: info: MRS: Pushing audio output on request
Dec 05 20:13:49 gbvpi-bedroom volumio[28500]: info: MRS: Pushing multiroomSync output
Dec 05 20:13:50 gbvpi-bedroom volumio[28500]: info: Discovery: Connected to remote: 192.168.1.28
Dec 05 20:13:50 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 21.
Dec 05 20:13:50 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:50 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:50 gbvpi-bedroom go-librespot[29303]: go-librespot daemon starting...
Dec 05 20:13:50 gbvpi-bedroom go-librespot[29304]: time="2025-12-05T20:13:50-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:13:50 gbvpi-bedroom go-librespot[29304]: time="2025-12-05T20:13:50-05:00" level=debug msg="app state loaded"
Dec 05 20:13:50 gbvpi-bedroom go-librespot[29304]: time="2025-12-05T20:13:50-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:13:50 gbvpi-bedroom go-librespot[29304]: time="2025-12-05T20:13:50-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 20:13:50 gbvpi-bedroom go-librespot[29304]: time="2025-12-05T20:13:50-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 20:13:50 gbvpi-bedroom go-librespot[29304]: time="2025-12-05T20:13:50-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 20:13:50 gbvpi-bedroom go-librespot[29304]: time="2025-12-05T20:13:50-05:00" level=info msg="zeroconf server listening on port 45263"
Dec 05 20:13:50 gbvpi-bedroom go-librespot[29304]: time="2025-12-05T20:13:50-05:00" level=debug msg="obtained new client token: AAAzMeJ5F54NR3l2b592qcSJtB3tnmY7qKyNTj1qwnuTM025m7wdOV1cWdgNMYFC1hxcKUqPW3TpNrdMkJ6pLlbWmzpibB9lCGOmSnxuWhLbGfzWM5hSdL2Hpg90c32168ReRhyM7R27LDMVDPqy3QrMc3wflWLhS32Oncf0ccI41EQEHOMAluYIqMx8q2jw/FtE35SKrBfgr12UEyVjjuExnrh0XOsssYM/OqwUlymIzlkuzx8a+n0mhQ=="
Dec 05 20:13:50 gbvpi-bedroom go-librespot[29304]: time="2025-12-05T20:13:50-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 20:13:50 gbvpi-bedroom go-librespot[29304]: time="2025-12-05T20:13:50-05:00" level=debug msg="completed keyexchange"
Dec 05 20:13:50 gbvpi-bedroom go-librespot[29304]: time="2025-12-05T20:13:50-05:00" level=debug msg="completed challenge"
Dec 05 20:13:50 gbvpi-bedroom go-librespot[29304]: time="2025-12-05T20:13: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 20:13:50 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:13:50 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:13:52 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:52 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:13:53 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 22.
Dec 05 20:13:53 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:53 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:53 gbvpi-bedroom go-librespot[29315]: go-librespot daemon starting...
Dec 05 20:13:53 gbvpi-bedroom go-librespot[29316]: time="2025-12-05T20:13:53-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:13:53 gbvpi-bedroom go-librespot[29316]: time="2025-12-05T20:13:53-05:00" level=debug msg="app state loaded"
Dec 05 20:13:53 gbvpi-bedroom go-librespot[29316]: time="2025-12-05T20:13:53-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:13:54 gbvpi-bedroom go-librespot[29316]: time="2025-12-05T20:13:54-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 20:13:54 gbvpi-bedroom go-librespot[29316]: time="2025-12-05T20:13:54-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 20:13:54 gbvpi-bedroom go-librespot[29316]: time="2025-12-05T20:13:54-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 20:13:54 gbvpi-bedroom go-librespot[29316]: time="2025-12-05T20:13:54-05:00" level=info msg="zeroconf server listening on port 46317"
Dec 05 20:13:54 gbvpi-bedroom go-librespot[29316]: time="2025-12-05T20:13:54-05:00" level=debug msg="obtained new client token: AAC9P/e6x7ae//Fp/bkGG0yGx42uiNBjqnmfCrSZIrfYVRESsbSnwJxcAA+wsCnfK6rYDNa/yRHU11uGaGAQzz0hAOTP6HL7zGxHdHa+hjY4Ca8cXYHfvR7pzaTKWOzwpz4oD+lRvjhuDxyvRSBxcuGIONh++/TAc4CtO6drJ/TJC9NrxMbCCzZoGg9uGNEctR1BoOOP9fZUTEQ34y/G5WkITpPclPDWJ1xSjOikHBaBp2fshqajOkI="
Dec 05 20:13:54 gbvpi-bedroom go-librespot[29316]: time="2025-12-05T20:13:54-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 20:13:54 gbvpi-bedroom go-librespot[29316]: time="2025-12-05T20:13:54-05:00" level=debug msg="completed keyexchange"
Dec 05 20:13:54 gbvpi-bedroom go-librespot[29316]: time="2025-12-05T20:13:54-05:00" level=debug msg="completed challenge"
Dec 05 20:13:54 gbvpi-bedroom go-librespot[29316]: time="2025-12-05T20:13:54-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 20:13:54 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:13:54 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:13:55 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:55 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:13:57 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 23.
Dec 05 20:13:57 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:57 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:13:57 gbvpi-bedroom go-librespot[29337]: go-librespot daemon starting...
Dec 05 20:13:57 gbvpi-bedroom go-librespot[29338]: time="2025-12-05T20:13:57-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:13:57 gbvpi-bedroom go-librespot[29338]: time="2025-12-05T20:13:57-05:00" level=debug msg="app state loaded"
Dec 05 20:13:57 gbvpi-bedroom go-librespot[29338]: time="2025-12-05T20:13:57-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:13:57 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::volumioGetState
Dec 05 20:13:57 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::volumioGetState
Dec 05 20:13:57 gbvpi-bedroom volumio[28500]: info: Listing playlists
Dec 05 20:13:57 gbvpi-bedroom volumio[28500]: info: Listing playlists
Dec 05 20:13:57 gbvpi-bedroom volumio[28500]: info: Listing playlists
Dec 05 20:13:57 gbvpi-bedroom volumio[28500]: info: Listing playlists
Dec 05 20:13:57 gbvpi-bedroom go-librespot[29338]: time="2025-12-05T20:13: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 20:13:57 gbvpi-bedroom go-librespot[29338]: time="2025-12-05T20:13: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 20:13:57 gbvpi-bedroom go-librespot[29338]: time="2025-12-05T20:13: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 20:13:57 gbvpi-bedroom go-librespot[29338]: time="2025-12-05T20:13:57-05:00" level=info msg="zeroconf server listening on port 42049"
Dec 05 20:13:58 gbvpi-bedroom go-librespot[29338]: time="2025-12-05T20:13:58-05:00" level=debug msg="obtained new client token: AADZTKT0ZA9Q43/sGvVJe14Qe4HLLDtN0G0Tl4kl4YBgMh/embSji3Cc2qVfW8zbmiP5LhdV/EI3N+T2zzMHPhPETD86Xb6SrmEVL1zWL2RrCE+vOK5rZ0RC/CHJ+YcPmwZrkowvjyRkApOk2fTB44Ee8727bcgXGtqkCn1u7OSr8mXsCE/joiF5hF5xRnv8EtboBlH0DmgjYPhbty+ImKovdoWg8SBHS543E1opv8VKq0mXn3pKhlZqhQ=="
Dec 05 20:13:58 gbvpi-bedroom go-librespot[29338]: time="2025-12-05T20:13:58-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 20:13:58 gbvpi-bedroom go-librespot[29338]: time="2025-12-05T20:13:58-05:00" level=debug msg="completed keyexchange"
Dec 05 20:13:58 gbvpi-bedroom go-librespot[29338]: time="2025-12-05T20:13:58-05:00" level=debug msg="completed challenge"
Dec 05 20:13:58 gbvpi-bedroom go-librespot[29338]: time="2025-12-05T20:13:58-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 20:13:58 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:13:58 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:13:58 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:13:58 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:14:01 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 24.
Dec 05 20:14:01 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:14:01 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:14:01 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:14:01 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:14:01 gbvpi-bedroom go-librespot[29349]: go-librespot daemon starting...
Dec 05 20:14:01 gbvpi-bedroom go-librespot[29350]: time="2025-12-05T20:14:01-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:14:01 gbvpi-bedroom go-librespot[29350]: time="2025-12-05T20:14:01-05:00" level=debug msg="app state loaded"
Dec 05 20:14:01 gbvpi-bedroom go-librespot[29350]: time="2025-12-05T20:14:01-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:14:01 gbvpi-bedroom go-librespot[29350]: time="2025-12-05T20:14:01-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 20:14:01 gbvpi-bedroom go-librespot[29350]: time="2025-12-05T20:14:01-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 20:14:01 gbvpi-bedroom go-librespot[29350]: time="2025-12-05T20:14:01-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 20:14:01 gbvpi-bedroom go-librespot[29350]: time="2025-12-05T20:14:01-05:00" level=info msg="zeroconf server listening on port 39181"
Dec 05 20:14:01 gbvpi-bedroom go-librespot[29350]: time="2025-12-05T20:14:01-05:00" level=debug msg="obtained new client token: AAC0bzkh+r0IDq/o9at21mPSah5lg1lpbsbbojG6OvI33+LcIeYscykCJtrYwIi89hhfbyk0YtJuD1eZHTXbrvjZTPyH247aycASsACE2gqRJBTI4/gFJSRRZ0VC4bGIuz2U95/CwLazh+gsWmMDbjVRcOlQNWmtVwUkRjR2GUKKDWUV4btuYYQJCirSPwuJNb6BW0EkTGJnOtqeGLhRyW404siWX+jPOh8E9gc04t9p+sbXcvPTc2e59Q=="
Dec 05 20:14:01 gbvpi-bedroom go-librespot[29350]: time="2025-12-05T20:14:01-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 20:14:01 gbvpi-bedroom go-librespot[29350]: time="2025-12-05T20:14:01-05:00" level=debug msg="completed keyexchange"
Dec 05 20:14:01 gbvpi-bedroom go-librespot[29350]: time="2025-12-05T20:14:01-05:00" level=debug msg="completed challenge"
Dec 05 20:14:01 gbvpi-bedroom go-librespot[29350]: time="2025-12-05T20:14:01-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 20:14:01 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:14:01 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:14:04 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:14:04 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:14:04 gbvpi-bedroom volumio[28500]: info: MRS: Adding multiroomSync output
Dec 05 20:14:04 gbvpi-bedroom volumio[28500]: info: Adding audio output:
Dec 05 20:14:04 gbvpi-bedroom volumio[28500]: info: MRS: Pushing multiroomSync output
Dec 05 20:14:05 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 25.
Dec 05 20:14:05 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:14:05 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:14:05 gbvpi-bedroom go-librespot[29357]: go-librespot daemon starting...
Dec 05 20:14:05 gbvpi-bedroom go-librespot[29358]: time="2025-12-05T20:14:05-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:14:05 gbvpi-bedroom go-librespot[29358]: time="2025-12-05T20:14:05-05:00" level=debug msg="app state loaded"
Dec 05 20:14:05 gbvpi-bedroom go-librespot[29358]: time="2025-12-05T20:14:05-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:14:05 gbvpi-bedroom go-librespot[29358]: time="2025-12-05T20:14:05-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 20:14:05 gbvpi-bedroom go-librespot[29358]: time="2025-12-05T20:14:05-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 20:14:05 gbvpi-bedroom go-librespot[29358]: time="2025-12-05T20:14:05-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 20:14:05 gbvpi-bedroom go-librespot[29358]: time="2025-12-05T20:14:05-05:00" level=info msg="zeroconf server listening on port 42073"
Dec 05 20:14:05 gbvpi-bedroom go-librespot[29358]: time="2025-12-05T20:14:05-05:00" level=debug msg="obtained new client token: AABHY1jbDOJ5Ug9L1AKPTHcTIlkqAnHFWHVbaL6/xtVzKt6E6Gpk6vAp0HJnNMKmYUDPJqJevKpJgPeEXP1jPc+u21gbHQB8AowscMf4JaBxjAim6+1OweM1BjEfupZMKTOHJm2j56xC18jvcXFz2YLujeaO727vw6Rv9vojC7XBO4QE3lRcyhNH6pAY5sxsUg4UQdX+OEpNMxRhBIM0IBXSX4xKJ0DeY8SZep04zHzJtb4B4wrp8Ofd9g=="
Dec 05 20:14:05 gbvpi-bedroom go-librespot[29358]: time="2025-12-05T20:14:05-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 20:14:05 gbvpi-bedroom go-librespot[29358]: time="2025-12-05T20:14:05-05:00" level=debug msg="completed keyexchange"
Dec 05 20:14:05 gbvpi-bedroom go-librespot[29358]: time="2025-12-05T20:14:05-05:00" level=debug msg="completed challenge"
Dec 05 20:14:05 gbvpi-bedroom go-librespot[29358]: time="2025-12-05T20:14:05-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 20:14:05 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:14:05 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:14:07 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:14:07 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:14:07 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::volumioGetState
Dec 05 20:14:07 gbvpi-bedroom volumio[28500]: info: CoreCommandRouter::volumioGetState
Dec 05 20:14:09 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 26.
Dec 05 20:14:09 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:14:09 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:14:09 gbvpi-bedroom go-librespot[29379]: go-librespot daemon starting...
Dec 05 20:14:09 gbvpi-bedroom go-librespot[29380]: time="2025-12-05T20:14:09-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:14:09 gbvpi-bedroom go-librespot[29380]: time="2025-12-05T20:14:09-05:00" level=debug msg="app state loaded"
Dec 05 20:14:09 gbvpi-bedroom go-librespot[29380]: time="2025-12-05T20:14:09-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:14:09 gbvpi-bedroom go-librespot[29380]: time="2025-12-05T20:14:09-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 20:14:09 gbvpi-bedroom go-librespot[29380]: time="2025-12-05T20:14:09-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 20:14:09 gbvpi-bedroom go-librespot[29380]: time="2025-12-05T20:14:09-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 20:14:09 gbvpi-bedroom go-librespot[29380]: time="2025-12-05T20:14:09-05:00" level=info msg="zeroconf server listening on port 44885"
Dec 05 20:14:09 gbvpi-bedroom go-librespot[29380]: time="2025-12-05T20:14:09-05:00" level=debug msg="obtained new client token: AADZqpbIYwuG5IDnoe3+gsqvJ0/iibR+r8hkHUGI1r4lwhgzoORtTQIPnJJi01cVAhvEOpjoUKpgCSxps2nCBD+2xc30RSI+rVa5222hT3JYN1mvnzPyob2Jn+beSPyrWQo5yQvzwJUHfLXDW4k84tm69eHaLDJ72SxHfdzyb0RitrxAk6V02nft9F70KnL+jVusUifTeZkuFNoxiMg4ZzJvub1ZXjI07RZYbzypd5FWi4p4AIOxXzYzZg=="
Dec 05 20:14:09 gbvpi-bedroom go-librespot[29380]: time="2025-12-05T20:14:09-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 20:14:09 gbvpi-bedroom go-librespot[29380]: time="2025-12-05T20:14:09-05:00" level=debug msg="connected to ap-gue1.spotify.com:443"
Dec 05 20:14:09 gbvpi-bedroom go-librespot[29380]: time="2025-12-05T20:14:09-05:00" level=debug msg="completed keyexchange"
Dec 05 20:14:09 gbvpi-bedroom go-librespot[29380]: time="2025-12-05T20:14:09-05:00" level=debug msg="completed challenge"
Dec 05 20:14:09 gbvpi-bedroom go-librespot[29380]: time="2025-12-05T20:14:09-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 20:14:09 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:14:09 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:14:09 gbvpi-bedroom volumio[28500]: info: MRS: Pushing audio output on request
Dec 05 20:14:09 gbvpi-bedroom volumio[28500]: info: MRS: Pushing multiroomSync output
Dec 05 20:14:10 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:14:10 gbvpi-bedroom volumio[28500]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:14:12 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 27.
Dec 05 20:14:12 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:14:12 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:14:12 gbvpi-bedroom go-librespot[29390]: go-librespot daemon starting...
Dec 05 20:14:12 gbvpi-bedroom go-librespot[29391]: time="2025-12-05T20:14:12-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:14:12 gbvpi-bedroom go-librespot[29391]: time="2025-12-05T20:14:12-05:00" level=debug msg="app state loaded"
Dec 05 20:14:12 gbvpi-bedroom go-librespot[29391]: time="2025-12-05T20:14:12-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:14:13 gbvpi-bedroom go-librespot[29391]: time="2025-12-05T20:14: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 20:14:13 gbvpi-bedroom go-librespot[29391]: time="2025-12-05T20:14: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 20:14:13 gbvpi-bedroom go-librespot[29391]: time="2025-12-05T20:14: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 20:14:13 gbvpi-bedroom go-librespot[29391]: time="2025-12-05T20:14:13-05:00" level=info msg="zeroconf server listening on port 39181"
Dec 05 20:14:13 gbvpi-bedroom go-librespot[29391]: time="2025-12-05T20:14:13-05:00" level=debug msg="obtained new client token: AADi91pbuYRwnF0kL/6thY2kyDFeasf9V53vssEbgbTfsgcDpkaHUDP0mpfNoEZ5KFNtjTKKNGPAhT6fLdxZlWAaCcQeDMhUEzJoJO5qqTfTZjFlpsTrPAWDeI6k5fPyXgAMY6QnqLaZ3cCX4paaKFgYc3DI0+PlzQtjf8HUEkKf/ovqLR5NnCvTWVkyMUAifsFlGXJk75MES6O0sdOnBiH0WWqgIxT9/EVnpvlu4dJeUByh/AqNbFQ="
Dec 05 20:14:13 gbvpi-bedroom go-librespot[29391]: time="2025-12-05T20:14:13-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 05 20:14:13 gbvpi-bedroom volumio[28500]: info: Initializing connection to go-librespot Websocket
Dec 05 20:14:13 gbvpi-bedroom go-librespot[29391]: time="2025-12-05T20:14:13-05:00" level=debug msg="new websocket client"
Dec 05 20:14:13 gbvpi-bedroom volumio[28500]: info: Connection to go-librespot Websocket established
Dec 05 20:14:13 gbvpi-bedroom go-librespot[29391]: time="2025-12-05T20:14:13-05:00" level=debug msg="completed keyexchange"
Dec 05 20:14:13 gbvpi-bedroom go-librespot[29391]: time="2025-12-05T20:14:13-05:00" level=debug msg="completed challenge"
Dec 05 20:14:13 gbvpi-bedroom go-librespot[29391]: time="2025-12-05T20:14:13-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 20:14:13 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 05 20:14:13 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 05 20:14:13 gbvpi-bedroom volumio[28500]: info: Connection to go-librespot Websocket closed
Dec 05 20:14:13 gbvpi-bedroom volumio[28500]: info: Discovery: Disconnected from remote: 192.168.1.28
Dec 05 20:14:13 gbvpi-bedroom volumio[28500]: info: MRS: Cleaning up device: 357de02c-99c5-4ddd-be16-8ae369ed89c3
Dec 05 20:14:13 gbvpi-bedroom volumio[28500]: info: Removing audio output:
Dec 05 20:14:14 gbvpi-bedroom volumio[28500]: info: Discovery: A device disappeared from network
Dec 05 20:14:14 gbvpi-bedroom volumio[28500]: info: Discovery: Device northpi-soundstation disappeared from network
Dec 05 20:14:16 gbvpi-bedroom volumio[28500]: info: Getting Spotify volume
Dec 05 20:14:16 gbvpi-bedroom volumio[28500]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 05 20:14:16 gbvpi-bedroom volumio[28500]: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 05 20:14:16 gbvpi-bedroom volumio[28500]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Dec 05 20:14:16 gbvpi-bedroom volumio[28500]: errno: -111,
Dec 05 20:14:16 gbvpi-bedroom volumio[28500]: code: 'ECONNREFUSED',
Dec 05 20:14:16 gbvpi-bedroom volumio[28500]: syscall: 'connect',
Dec 05 20:14:16 gbvpi-bedroom volumio[28500]: address: '127.0.0.1',
Dec 05 20:14:16 gbvpi-bedroom volumio[28500]: port: 9879,
Dec 05 20:14:16 gbvpi-bedroom volumio[28500]: response: undefined
Dec 05 20:14:16 gbvpi-bedroom volumio[28500]: }
Dec 05 20:14:16 gbvpi-bedroom volumio[28500]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 05 20:14:16 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 28.
Dec 05 20:14:16 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:14:16 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 05 20:14:16 gbvpi-bedroom go-librespot[29410]: go-librespot daemon starting...
Dec 05 20:14:16 gbvpi-bedroom go-librespot[29411]: time="2025-12-05T20:14:16-05:00" level=info msg="running go-librespot 0.4.0"
Dec 05 20:14:16 gbvpi-bedroom go-librespot[29411]: time="2025-12-05T20:14:16-05:00" level=debug msg="app state loaded"
Dec 05 20:14:16 gbvpi-bedroom go-librespot[29411]: time="2025-12-05T20:14:16-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 05 20:14:16 gbvpi-bedroom sudo[29420]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-05 20:13'
Dec 05 20:14:16 gbvpi-bedroom sudo[29420]: 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"