Dec 14 23:18:00 gbvpi-bedroom go-librespot[17462]: time="2025-12-14T23:18:00-05:00" level=debug msg="obtained new client token: AAANWGnd9x0XVpPyFb8TfsB37PQU50xONDUEyF6yArmrzoYXBucsvdanMKF/Mv2BQ4su9gjSOyJbS8HBdcymrbkXabo+aG71UkvIExjmKC2lffsOGkOfwYHivbI2/Y6JE9WJxSkLUauoEwNFSwPMPBxCkHONGROb4Z1GlNbMMVOpfBJG2el+zjcwLZwN/Ey1apIZo1wrgsKAuEyh42i4cxEs01jmD5bVis+JnmOyyJw7tM9hCQOXQEs="
Dec 14 23:18:00 gbvpi-bedroom go-librespot[17462]: time="2025-12-14T23:18:00-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:18:00 gbvpi-bedroom go-librespot[17462]: time="2025-12-14T23:18:00-05:00" level=debug msg="completed keyexchange"
Dec 14 23:18:00 gbvpi-bedroom go-librespot[17462]: time="2025-12-14T23:18:00-05:00" level=debug msg="completed challenge"
Dec 14 23:18:00 gbvpi-bedroom go-librespot[17462]: time="2025-12-14T23:18: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 14 23:18:00 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:18:00 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:18:01 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:01 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:03 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 14 23:18:03 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 14 23:18:03 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Dec 14 23:18:03 gbvpi-bedroom volumio-remote-updater[775]: Test mode enabled
Dec 14 23:18:03 gbvpi-bedroom volumio-remote-updater[775]: Alpha mode disabled
Dec 14 23:18:03 gbvpi-bedroom volumio-remote-updater[775]: Alpha legacy test mode disabled
Dec 14 23:18:03 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Dec 14 23:18:03 gbvpi-bedroom volumio[16887]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"CAUTION
\n\n- This build may break your network
\n
\nFIX
\n\n- Wireless and network handling
\n
\n","title":"Update v4.080","updateavailable":true}
Dec 14 23:18:03 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Dec 14 23:18:03 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 26.
Dec 14 23:18:03 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:03 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:03 gbvpi-bedroom go-librespot[17479]: go-librespot daemon starting...
Dec 14 23:18:03 gbvpi-bedroom go-librespot[17480]: time="2025-12-14T23:18:03-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:18:03 gbvpi-bedroom go-librespot[17480]: time="2025-12-14T23:18:03-05:00" level=debug msg="app state loaded"
Dec 14 23:18:03 gbvpi-bedroom go-librespot[17480]: time="2025-12-14T23:18:03-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:18:03 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 14 23:18:03 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 14 23:18:03 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Dec 14 23:18:03 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Dec 14 23:18:03 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Dec 14 23:18:03 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 14 23:18:03 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 14 23:18:03 gbvpi-bedroom go-librespot[17480]: time="2025-12-14T23:18: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-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 14 23:18:03 gbvpi-bedroom go-librespot[17480]: time="2025-12-14T23:18:03-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 14 23:18:03 gbvpi-bedroom go-librespot[17480]: time="2025-12-14T23:18:03-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 14 23:18:03 gbvpi-bedroom go-librespot[17480]: time="2025-12-14T23:18:03-05:00" level=info msg="zeroconf server listening on port 44095"
Dec 14 23:18:03 gbvpi-bedroom go-librespot[17480]: time="2025-12-14T23:18:03-05:00" level=debug msg="obtained new client token: AACrBDlZ2KHl0AxifdJJSs3PzX7iaqfFSNowbqAxxKZ+niP/jsHq1ur3hiJ6zWeRa0UmZl8t7jR4b9qYxcPf8urPxw5+DeMU8zl2WuBTiEpe5U2DHfge5PvAPQFgjTIy6hVRCPMOnYyCI7GDERHmYU+qIqHAD48iE1UliTgqXmhGRnpNs56WDToj4VixS2tObLDQ7OPD4V8gId5vSuq6yBdkOwH5pEUKpj3aUtAOQViZYlfIRx8wHQBq9g=="
Dec 14 23:18:03 gbvpi-bedroom go-librespot[17480]: time="2025-12-14T23:18:03-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:18:03 gbvpi-bedroom go-librespot[17480]: time="2025-12-14T23:18:03-05:00" level=debug msg="completed keyexchange"
Dec 14 23:18:03 gbvpi-bedroom go-librespot[17480]: time="2025-12-14T23:18:03-05:00" level=debug msg="completed challenge"
Dec 14 23:18:03 gbvpi-bedroom go-librespot[17480]: time="2025-12-14T23:18: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 14 23:18:04 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:18:04 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:18:04 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:04 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:05 gbvpi-bedroom volumio[16887]: info: BOOT COMPLETED
Dec 14 23:18:05 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::volumioGetState
Dec 14 23:18:05 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::volumioGetState
Dec 14 23:18:05 gbvpi-bedroom volumio[16887]: info: Listing playlists
Dec 14 23:18:05 gbvpi-bedroom volumio[16887]: info: Listing playlists
Dec 14 23:18:05 gbvpi-bedroom volumio[16887]: info: Listing playlists
Dec 14 23:18:05 gbvpi-bedroom volumio[16887]: info: Listing playlists
Dec 14 23:18:07 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:07 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:07 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 27.
Dec 14 23:18:07 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:07 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:07 gbvpi-bedroom go-librespot[17487]: go-librespot daemon starting...
Dec 14 23:18:07 gbvpi-bedroom go-librespot[17488]: time="2025-12-14T23:18:07-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:18:07 gbvpi-bedroom go-librespot[17488]: time="2025-12-14T23:18:07-05:00" level=debug msg="app state loaded"
Dec 14 23:18:07 gbvpi-bedroom go-librespot[17488]: time="2025-12-14T23:18:07-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:18:07 gbvpi-bedroom go-librespot[17488]: time="2025-12-14T23:18:07-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 14 23:18:07 gbvpi-bedroom go-librespot[17488]: time="2025-12-14T23:18:07-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 14 23:18:07 gbvpi-bedroom go-librespot[17488]: time="2025-12-14T23:18:07-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 14 23:18:07 gbvpi-bedroom go-librespot[17488]: time="2025-12-14T23:18:07-05:00" level=info msg="zeroconf server listening on port 44549"
Dec 14 23:18:07 gbvpi-bedroom go-librespot[17488]: time="2025-12-14T23:18:07-05:00" level=debug msg="obtained new client token: AABOor+RVQhGqWNGq4s9TCOwxQ2sWmZ9GFjj2g0YTM8C6phfUn3t3ROubvNKcuNCEA72Fs2RSHW1SYxHR/WFe0hycrKLuSpfCWy3v8SWOes0L0aDMEJmR8LrKpgf6Xx2sFizmqgJACQ+pWmAY1ey0jJ7U5IKfyROBpFZxOscMXrVAnj1efis9ZrsHWM80n8abVbieU0yDVTJHYeBWUSdRydo4syaZysQ8S8iE1uSLf45T8aEqhljATz3gA=="
Dec 14 23:18:07 gbvpi-bedroom go-librespot[17488]: time="2025-12-14T23:18:07-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:18:07 gbvpi-bedroom go-librespot[17488]: time="2025-12-14T23:18:07-05:00" level=debug msg="completed keyexchange"
Dec 14 23:18:07 gbvpi-bedroom go-librespot[17488]: time="2025-12-14T23:18:07-05:00" level=debug msg="completed challenge"
Dec 14 23:18:07 gbvpi-bedroom go-librespot[17488]: time="2025-12-14T23:18: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 14 23:18:07 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:18:07 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:18:10 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:10 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:10 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 28.
Dec 14 23:18:10 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:11 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:11 gbvpi-bedroom go-librespot[17509]: go-librespot daemon starting...
Dec 14 23:18:11 gbvpi-bedroom go-librespot[17510]: time="2025-12-14T23:18:11-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:18:11 gbvpi-bedroom go-librespot[17510]: time="2025-12-14T23:18:11-05:00" level=debug msg="app state loaded"
Dec 14 23:18:11 gbvpi-bedroom go-librespot[17510]: time="2025-12-14T23:18:11-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:18:11 gbvpi-bedroom go-librespot[17510]: time="2025-12-14T23:18:11-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 14 23:18:11 gbvpi-bedroom go-librespot[17510]: time="2025-12-14T23:18:11-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 14 23:18:11 gbvpi-bedroom go-librespot[17510]: time="2025-12-14T23:18:11-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 14 23:18:11 gbvpi-bedroom go-librespot[17510]: time="2025-12-14T23:18:11-05:00" level=info msg="zeroconf server listening on port 38263"
Dec 14 23:18:11 gbvpi-bedroom go-librespot[17510]: time="2025-12-14T23:18:11-05:00" level=debug msg="obtained new client token: AABsYqHIewliKCRJmmMwxJLD1v3XEzYBcEomvhQFRjVe7tOqkJK3cjkxsfS1Hyd2YHqdL2j7MHQwqr3+qc+ceQ/vqq6JYdsO5scyrPZSYeh/GTZ5Z9+FsDHUdskAFWcwpEj5X7jPtsUgp5ccXau0anvJRF3bT19T1vKTgnSMqg/5bTZ+2N3uRghmWpkGsW8F8/COzFRWaAZw9dXpR96b26rzzsbdFwCky+y1FWnaMsgbHeDhTji09pPk1Q=="
Dec 14 23:18:11 gbvpi-bedroom go-librespot[17510]: time="2025-12-14T23:18:11-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:18:11 gbvpi-bedroom go-librespot[17510]: time="2025-12-14T23:18:11-05:00" level=debug msg="completed keyexchange"
Dec 14 23:18:11 gbvpi-bedroom go-librespot[17510]: time="2025-12-14T23:18:11-05:00" level=debug msg="completed challenge"
Dec 14 23:18:11 gbvpi-bedroom go-librespot[17510]: time="2025-12-14T23:18:11-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 14 23:18:11 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:18:11 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:18:13 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:13 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:14 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 29.
Dec 14 23:18:14 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:14 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:14 gbvpi-bedroom go-librespot[17519]: go-librespot daemon starting...
Dec 14 23:18:14 gbvpi-bedroom go-librespot[17520]: time="2025-12-14T23:18:14-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:18:14 gbvpi-bedroom go-librespot[17520]: time="2025-12-14T23:18:14-05:00" level=debug msg="app state loaded"
Dec 14 23:18:14 gbvpi-bedroom go-librespot[17520]: time="2025-12-14T23:18:14-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:18:15 gbvpi-bedroom go-librespot[17520]: time="2025-12-14T23:18:15-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 14 23:18:15 gbvpi-bedroom go-librespot[17520]: time="2025-12-14T23:18:15-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 14 23:18:15 gbvpi-bedroom go-librespot[17520]: time="2025-12-14T23:18:15-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 14 23:18:15 gbvpi-bedroom go-librespot[17520]: time="2025-12-14T23:18:15-05:00" level=info msg="zeroconf server listening on port 41441"
Dec 14 23:18:15 gbvpi-bedroom go-librespot[17520]: time="2025-12-14T23:18:15-05:00" level=debug msg="obtained new client token: AAAmrq20daNcHeMZYn/CqBikZg2hrZYzV/2tIVUUSJpVgJ/KW17mMqOLaacQ6QzZZeytptU82+uUbPsq7chByNG5R4IvU2bT2D6hyP+8XKnJZi2ihWjVtEwOlsI8xGXiC1pY8+wP5UsJ9DCOPGcv82QOHySAKE49uIbXw9UPXz17lDdvEkaYSH7wxokD6KGcUQVydqSW+p1CGIZAPXGobCF+yQ6KyJuVr6GGuN++vJohkt86tl0OmDY="
Dec 14 23:18:15 gbvpi-bedroom go-librespot[17520]: time="2025-12-14T23:18:15-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:18:15 gbvpi-bedroom go-librespot[17520]: time="2025-12-14T23:18:15-05:00" level=debug msg="completed keyexchange"
Dec 14 23:18:15 gbvpi-bedroom go-librespot[17520]: time="2025-12-14T23:18:15-05:00" level=debug msg="completed challenge"
Dec 14 23:18:15 gbvpi-bedroom go-librespot[17520]: time="2025-12-14T23:18:15-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 14 23:18:15 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:18:15 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:18:15 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::volumioGetState
Dec 14 23:18:15 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::volumioGetState
Dec 14 23:18:16 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:16 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:18 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 30.
Dec 14 23:18:18 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:18 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:18 gbvpi-bedroom go-librespot[17530]: go-librespot daemon starting...
Dec 14 23:18:18 gbvpi-bedroom go-librespot[17531]: time="2025-12-14T23:18:18-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:18:18 gbvpi-bedroom go-librespot[17531]: time="2025-12-14T23:18:18-05:00" level=debug msg="app state loaded"
Dec 14 23:18:18 gbvpi-bedroom go-librespot[17531]: time="2025-12-14T23:18:18-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:18:18 gbvpi-bedroom go-librespot[17531]: time="2025-12-14T23:18:18-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 14 23:18:18 gbvpi-bedroom go-librespot[17531]: time="2025-12-14T23:18:18-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 14 23:18:18 gbvpi-bedroom go-librespot[17531]: time="2025-12-14T23:18:18-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 14 23:18:18 gbvpi-bedroom go-librespot[17531]: time="2025-12-14T23:18:18-05:00" level=info msg="zeroconf server listening on port 37831"
Dec 14 23:18:18 gbvpi-bedroom go-librespot[17531]: time="2025-12-14T23:18:18-05:00" level=debug msg="obtained new client token: AACNp3eN1EKN//MmNLjQq6/mSqsrWBjjMbLr5FOkjgHoljpyi/Q2JtRXh6PUlPFyPxvaSL1mQ8DQbZFNImKAvUG8d1hcgDx2b9bAyF6e0s4eYf6nI8fxjuz6x/rkA90J8yafbHLXKWNGXGVwMRhTK9QpvkDDnU6vIav8EAO8u1vFnpIhPd5mJ1w98OgBWo3WqPF3A0Djg6l2TdHJIXOFq11dASOt9jNRAF3IJc5vppqwNX+4yrCH12xi7A=="
Dec 14 23:18:18 gbvpi-bedroom go-librespot[17531]: time="2025-12-14T23:18:18-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:18:18 gbvpi-bedroom go-librespot[17531]: time="2025-12-14T23:18:18-05:00" level=debug msg="completed keyexchange"
Dec 14 23:18:18 gbvpi-bedroom go-librespot[17531]: time="2025-12-14T23:18:18-05:00" level=debug msg="completed challenge"
Dec 14 23:18:19 gbvpi-bedroom go-librespot[17531]: time="2025-12-14T23:18:19-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 14 23:18:19 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:18:19 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:18:19 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:19 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:22 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:22 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:22 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 31.
Dec 14 23:18:22 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:22 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:22 gbvpi-bedroom go-librespot[17552]: go-librespot daemon starting...
Dec 14 23:18:22 gbvpi-bedroom go-librespot[17553]: time="2025-12-14T23:18:22-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:18:22 gbvpi-bedroom go-librespot[17553]: time="2025-12-14T23:18:22-05:00" level=debug msg="app state loaded"
Dec 14 23:18:22 gbvpi-bedroom go-librespot[17553]: time="2025-12-14T23:18:22-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:18:22 gbvpi-bedroom go-librespot[17553]: time="2025-12-14T23:18:22-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 14 23:18:22 gbvpi-bedroom go-librespot[17553]: time="2025-12-14T23:18:22-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 14 23:18:22 gbvpi-bedroom go-librespot[17553]: time="2025-12-14T23:18:22-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 14 23:18:22 gbvpi-bedroom go-librespot[17553]: time="2025-12-14T23:18:22-05:00" level=info msg="zeroconf server listening on port 40049"
Dec 14 23:18:22 gbvpi-bedroom go-librespot[17553]: time="2025-12-14T23:18:22-05:00" level=debug msg="obtained new client token: AADqo2vO2Q+y5fD2DhrPsp+N6xkMtD2jXwTP86/F2S05Ub96qlalBWh04XjFQDAFoRQfI7ls7RdnzNSuoZQJDQzPtZitmnr0P6yGRqVjf96WTqgKk/eTGBYO+idSNNxCDFe3DFXQ7mk+7Od/gUC5YhiHXaUKuBqhCETDvNz+Bl9m3idu1u46bs1XBWJ/eT56jNjTiy11QmEPExnseOFNcy+GqsMsNlgGvjLeoJB7KwNFPrCjlH3pN5jnng=="
Dec 14 23:18:22 gbvpi-bedroom go-librespot[17553]: time="2025-12-14T23:18:22-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:18:22 gbvpi-bedroom go-librespot[17553]: time="2025-12-14T23:18:22-05:00" level=debug msg="completed keyexchange"
Dec 14 23:18:22 gbvpi-bedroom go-librespot[17553]: time="2025-12-14T23:18:22-05:00" level=debug msg="completed challenge"
Dec 14 23:18:22 gbvpi-bedroom go-librespot[17553]: time="2025-12-14T23:18:22-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 14 23:18:22 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:18:22 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:18:25 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:25 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:25 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::volumioGetState
Dec 14 23:18:25 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::volumioGetState
Dec 14 23:18:25 gbvpi-bedroom volumio[16887]: info: Listing playlists
Dec 14 23:18:25 gbvpi-bedroom volumio[16887]: info: Listing playlists
Dec 14 23:18:25 gbvpi-bedroom volumio[16887]: info: Listing playlists
Dec 14 23:18:25 gbvpi-bedroom volumio[16887]: info: Listing playlists
Dec 14 23:18:25 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 32.
Dec 14 23:18:25 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:26 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:26 gbvpi-bedroom go-librespot[17560]: go-librespot daemon starting...
Dec 14 23:18:26 gbvpi-bedroom go-librespot[17561]: time="2025-12-14T23:18:26-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:18:26 gbvpi-bedroom go-librespot[17561]: time="2025-12-14T23:18:26-05:00" level=debug msg="app state loaded"
Dec 14 23:18:26 gbvpi-bedroom go-librespot[17561]: time="2025-12-14T23:18:26-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:18:26 gbvpi-bedroom go-librespot[17561]: time="2025-12-14T23:18:26-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 14 23:18:26 gbvpi-bedroom go-librespot[17561]: time="2025-12-14T23:18:26-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 14 23:18:26 gbvpi-bedroom go-librespot[17561]: time="2025-12-14T23:18:26-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 14 23:18:26 gbvpi-bedroom go-librespot[17561]: time="2025-12-14T23:18:26-05:00" level=info msg="zeroconf server listening on port 36495"
Dec 14 23:18:26 gbvpi-bedroom go-librespot[17561]: time="2025-12-14T23:18:26-05:00" level=debug msg="obtained new client token: AAB4iQj1R1BS78PY4eU9gW/eKIqDfegIY/hpSz5sEPtqTTJJ5ZkObwrKgc4U6hErA0Bd4XmVMKyav+nH1aqUYmX2zdsGw4civDW5vdQLkKjdArhDhfnR7PhAkO0ZHlpyj8J7qW9lSwrwDnuSz+3AyDBjmlbW6QFpxtzwN8e4OYSs7LV0skS12qJ89KUEhuYyhspjWP459j72eQcH5lQeIm8m/TOMJ+el2Exfrx3hvTwBfZUHx01d0YGt1Q=="
Dec 14 23:18:26 gbvpi-bedroom go-librespot[17561]: time="2025-12-14T23:18:26-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:18:26 gbvpi-bedroom go-librespot[17561]: time="2025-12-14T23:18:26-05:00" level=debug msg="completed keyexchange"
Dec 14 23:18:26 gbvpi-bedroom go-librespot[17561]: time="2025-12-14T23:18:26-05:00" level=debug msg="completed challenge"
Dec 14 23:18:26 gbvpi-bedroom go-librespot[17561]: time="2025-12-14T23:18:26-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 14 23:18:26 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:18:26 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:18:28 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:28 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:29 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 33.
Dec 14 23:18:29 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:29 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:29 gbvpi-bedroom go-librespot[17568]: go-librespot daemon starting...
Dec 14 23:18:29 gbvpi-bedroom go-librespot[17569]: time="2025-12-14T23:18:29-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:18:29 gbvpi-bedroom go-librespot[17569]: time="2025-12-14T23:18:29-05:00" level=debug msg="app state loaded"
Dec 14 23:18:29 gbvpi-bedroom go-librespot[17569]: time="2025-12-14T23:18:29-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:18:29 gbvpi-bedroom go-librespot[17569]: time="2025-12-14T23:18:29-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 14 23:18:29 gbvpi-bedroom go-librespot[17569]: time="2025-12-14T23:18:29-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 14 23:18:29 gbvpi-bedroom go-librespot[17569]: time="2025-12-14T23:18:29-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 14 23:18:29 gbvpi-bedroom go-librespot[17569]: time="2025-12-14T23:18:29-05:00" level=info msg="zeroconf server listening on port 46077"
Dec 14 23:18:30 gbvpi-bedroom go-librespot[17569]: time="2025-12-14T23:18:30-05:00" level=debug msg="obtained new client token: AACbbUGJ0NpRRQx7ksvOIov+FCekOujOTQl5KxmviJR5QUoA2TVs6qy2A3wC4LqZd0WXlVnlNVOebGFuc66SPzQD8Fx1G9jgSU+nmjoXPFdDAMpczE00N5lCPc7iNY2HNl1SjBL2FLBRdmffMOrfXSL2I1pE0c8UMKqwrrhlDOx419Wq9zz/Jy0Qz9j10Io8TfPQRe2NqgsSk0RzIfPq67VFhdevIKNEAa2EH30kRlOPv0PMvj/kT4M="
Dec 14 23:18:30 gbvpi-bedroom go-librespot[17569]: time="2025-12-14T23:18:30-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:18:30 gbvpi-bedroom go-librespot[17569]: time="2025-12-14T23:18:30-05:00" level=debug msg="completed keyexchange"
Dec 14 23:18:30 gbvpi-bedroom go-librespot[17569]: time="2025-12-14T23:18:30-05:00" level=debug msg="completed challenge"
Dec 14 23:18:30 gbvpi-bedroom go-librespot[17569]: time="2025-12-14T23:18:30-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 14 23:18:30 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:18:30 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:18:31 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:31 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:33 gbvpi-bedroom volumio[16887]: info: UPDATER: Scheduling automatic update
Dec 14 23:18:33 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStartTime
Dec 14 23:18:33 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStopTime
Dec 14 23:18:33 gbvpi-bedroom volumio[16887]: info: UPDATER: Auto update will take place at: Mon Dec 15 2025 04:50:44 GMT-0500 (Eastern Standard Time)
Dec 14 23:18:33 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 34.
Dec 14 23:18:33 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:33 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:33 gbvpi-bedroom go-librespot[17591]: go-librespot daemon starting...
Dec 14 23:18:33 gbvpi-bedroom go-librespot[17592]: time="2025-12-14T23:18:33-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:18:33 gbvpi-bedroom go-librespot[17592]: time="2025-12-14T23:18:33-05:00" level=debug msg="app state loaded"
Dec 14 23:18:33 gbvpi-bedroom go-librespot[17592]: time="2025-12-14T23:18:33-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:18:33 gbvpi-bedroom go-librespot[17592]: time="2025-12-14T23:18:33-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 14 23:18:33 gbvpi-bedroom go-librespot[17592]: time="2025-12-14T23:18:33-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 14 23:18:33 gbvpi-bedroom go-librespot[17592]: time="2025-12-14T23:18:33-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 14 23:18:33 gbvpi-bedroom go-librespot[17592]: time="2025-12-14T23:18:33-05:00" level=info msg="zeroconf server listening on port 36507"
Dec 14 23:18:33 gbvpi-bedroom go-librespot[17592]: time="2025-12-14T23:18:33-05:00" level=debug msg="obtained new client token: AADOVDWYARTEPjkOotT/jkIHp+dLvL/oTNjGouwamUgQW7qUU1eOTHtkKfXMIH86G4NYr60Z6i6Y5LnI3CP1RC9WftJ3c3c3ARfSXDAVOpkuYkQTET8AZuV5g43eY3W7N6tsraKbRtehAbCltJNUz0RRlLiRQtw6L90uUaYDwCYa/llK8SunJSXAzZpu+bV95PyKGRWs8kjlhGDrMyEWxENOq865VDTqW29+lg7IFPGPujuEY+yErSoBhg=="
Dec 14 23:18:33 gbvpi-bedroom go-librespot[17592]: time="2025-12-14T23:18:33-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:18:34 gbvpi-bedroom go-librespot[17592]: time="2025-12-14T23:18:34-05:00" level=debug msg="completed keyexchange"
Dec 14 23:18:34 gbvpi-bedroom go-librespot[17592]: time="2025-12-14T23:18:34-05:00" level=debug msg="completed challenge"
Dec 14 23:18:34 gbvpi-bedroom go-librespot[17592]: time="2025-12-14T23:18:34-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 14 23:18:34 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:18:34 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:18:34 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:34 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:35 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::volumioGetState
Dec 14 23:18:35 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::volumioGetState
Dec 14 23:18:37 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:37 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:37 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 35.
Dec 14 23:18:37 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:37 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:37 gbvpi-bedroom go-librespot[17602]: go-librespot daemon starting...
Dec 14 23:18:37 gbvpi-bedroom go-librespot[17603]: time="2025-12-14T23:18:37-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:18:37 gbvpi-bedroom go-librespot[17603]: time="2025-12-14T23:18:37-05:00" level=debug msg="app state loaded"
Dec 14 23:18:37 gbvpi-bedroom go-librespot[17603]: time="2025-12-14T23:18:37-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:18:37 gbvpi-bedroom go-librespot[17603]: time="2025-12-14T23:18:37-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 14 23:18:37 gbvpi-bedroom go-librespot[17603]: time="2025-12-14T23:18:37-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 14 23:18:37 gbvpi-bedroom go-librespot[17603]: time="2025-12-14T23:18:37-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 14 23:18:37 gbvpi-bedroom go-librespot[17603]: time="2025-12-14T23:18:37-05:00" level=info msg="zeroconf server listening on port 32791"
Dec 14 23:18:37 gbvpi-bedroom go-librespot[17603]: time="2025-12-14T23:18:37-05:00" level=debug msg="obtained new client token: AACQIg8JTaoAdXP2hGI0cEavENU+oG2z//WJm3H2RTaX1v6qwc1A7h6iRIOYSg3caVfDZjDF9F6GH18cnR4Tjw4ZUpdIDDJ5eQ/RWNWa2tuomBWcVz/9zQJBhhRRNkb2GJPwP0iEkFvftc79beMYOtANxHQeZa2QSVEiQVp+0PaZ72DQppSoER3yUygZ/cJ80ChYsC5+adg2pUNo81jdReHppprKwSFmxQuV4E0U8H0oGG20rt/ymqNOXQ=="
Dec 14 23:18:37 gbvpi-bedroom go-librespot[17603]: time="2025-12-14T23:18:37-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:18:37 gbvpi-bedroom go-librespot[17603]: time="2025-12-14T23:18:37-05:00" level=debug msg="completed keyexchange"
Dec 14 23:18:37 gbvpi-bedroom go-librespot[17603]: time="2025-12-14T23:18:37-05:00" level=debug msg="completed challenge"
Dec 14 23:18:37 gbvpi-bedroom go-librespot[17603]: time="2025-12-14T23:18:37-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 14 23:18:37 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:18:37 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:18:40 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:40 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:40 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 36.
Dec 14 23:18:40 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:41 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:41 gbvpi-bedroom go-librespot[17624]: go-librespot daemon starting...
Dec 14 23:18:41 gbvpi-bedroom go-librespot[17625]: time="2025-12-14T23:18:41-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:18:41 gbvpi-bedroom go-librespot[17625]: time="2025-12-14T23:18:41-05:00" level=debug msg="app state loaded"
Dec 14 23:18:41 gbvpi-bedroom go-librespot[17625]: time="2025-12-14T23:18:41-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:18:41 gbvpi-bedroom go-librespot[17625]: time="2025-12-14T23:18:41-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 14 23:18:41 gbvpi-bedroom go-librespot[17625]: time="2025-12-14T23:18:41-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 14 23:18:41 gbvpi-bedroom go-librespot[17625]: time="2025-12-14T23:18:41-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 14 23:18:41 gbvpi-bedroom go-librespot[17625]: time="2025-12-14T23:18:41-05:00" level=info msg="zeroconf server listening on port 43251"
Dec 14 23:18:41 gbvpi-bedroom go-librespot[17625]: time="2025-12-14T23:18:41-05:00" level=debug msg="obtained new client token: AADziq1eaRtYHsMvWmTmQSouMXKHSRLFJ2rLt7RJLHp/jPctm8TzXahv4yhzUfPhfIAupW7Z9At1ug8SNCB3HfSB2feoV/N9EtHbUSf9eqfMAo7a5uU/msk9yR98WLpyecbJxQJ5DhNTU8wc1zgalooB5KQO0AHGiJc247swnNmepZvn1DEfwur+ft+wNZnCnxvEZgZ5EHGh7SxbblAxc6SKUzo0ha2M2oynD4wsK31Fmnkfw4Djp6mSiQ=="
Dec 14 23:18:41 gbvpi-bedroom go-librespot[17625]: time="2025-12-14T23:18:41-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:18:41 gbvpi-bedroom go-librespot[17625]: time="2025-12-14T23:18:41-05:00" level=debug msg="completed keyexchange"
Dec 14 23:18:41 gbvpi-bedroom go-librespot[17625]: time="2025-12-14T23:18:41-05:00" level=debug msg="completed challenge"
Dec 14 23:18:41 gbvpi-bedroom go-librespot[17625]: time="2025-12-14T23:18:41-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 14 23:18:41 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:18:41 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:18:43 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:43 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:44 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 37.
Dec 14 23:18:44 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:44 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:44 gbvpi-bedroom go-librespot[17632]: go-librespot daemon starting...
Dec 14 23:18:44 gbvpi-bedroom go-librespot[17633]: time="2025-12-14T23:18:44-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:18:44 gbvpi-bedroom go-librespot[17633]: time="2025-12-14T23:18:44-05:00" level=debug msg="app state loaded"
Dec 14 23:18:44 gbvpi-bedroom go-librespot[17633]: time="2025-12-14T23:18:44-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:18:45 gbvpi-bedroom go-librespot[17633]: time="2025-12-14T23:18:45-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 14 23:18:45 gbvpi-bedroom go-librespot[17633]: time="2025-12-14T23:18:45-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 14 23:18:45 gbvpi-bedroom go-librespot[17633]: time="2025-12-14T23:18:45-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 14 23:18:45 gbvpi-bedroom go-librespot[17633]: time="2025-12-14T23:18:45-05:00" level=info msg="zeroconf server listening on port 37591"
Dec 14 23:18:45 gbvpi-bedroom go-librespot[17633]: time="2025-12-14T23:18:45-05:00" level=debug msg="obtained new client token: AABzwKK/sSXswdQnABAZGTlzVmzMHwnWPFdYeNwU2bl8P7KBekT/jjDS54ra8jQx6yftCf0vDYms9hlatNJ8kehRYOpKRqFUi0vHZAsYtxB1XYOvDjF2CLmMkntFTenjKWFLDZpFh3LfhKy13qfH0Bx3jGjXqUnUl/PpI3KMlT4H0NeM/gQjHdOQeOmHE3QDLL8gLwhFXyIjzZLsQB3iO0CKZYk5oReN7McIUhw/r5MLC+Sb+DDVW+8="
Dec 14 23:18:45 gbvpi-bedroom go-librespot[17633]: time="2025-12-14T23:18:45-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:18:45 gbvpi-bedroom go-librespot[17633]: time="2025-12-14T23:18:45-05:00" level=debug msg="completed keyexchange"
Dec 14 23:18:45 gbvpi-bedroom go-librespot[17633]: time="2025-12-14T23:18:45-05:00" level=debug msg="completed challenge"
Dec 14 23:18:45 gbvpi-bedroom go-librespot[17633]: time="2025-12-14T23:18:45-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 14 23:18:45 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:18:45 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:18:45 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::volumioGetState
Dec 14 23:18:45 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::volumioGetState
Dec 14 23:18:45 gbvpi-bedroom volumio[16887]: info: Listing playlists
Dec 14 23:18:45 gbvpi-bedroom volumio[16887]: info: Listing playlists
Dec 14 23:18:45 gbvpi-bedroom volumio[16887]: info: Listing playlists
Dec 14 23:18:45 gbvpi-bedroom volumio[16887]: info: Listing playlists
Dec 14 23:18:46 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:46 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:48 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 38.
Dec 14 23:18:48 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:48 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:48 gbvpi-bedroom go-librespot[17640]: go-librespot daemon starting...
Dec 14 23:18:48 gbvpi-bedroom go-librespot[17641]: time="2025-12-14T23:18:48-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:18:48 gbvpi-bedroom go-librespot[17641]: time="2025-12-14T23:18:48-05:00" level=debug msg="app state loaded"
Dec 14 23:18:48 gbvpi-bedroom go-librespot[17641]: time="2025-12-14T23:18:48-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:18:48 gbvpi-bedroom go-librespot[17641]: time="2025-12-14T23:18:48-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 14 23:18:48 gbvpi-bedroom go-librespot[17641]: time="2025-12-14T23:18:48-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 14 23:18:48 gbvpi-bedroom go-librespot[17641]: time="2025-12-14T23:18:48-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 14 23:18:48 gbvpi-bedroom go-librespot[17641]: time="2025-12-14T23:18:48-05:00" level=info msg="zeroconf server listening on port 33121"
Dec 14 23:18:48 gbvpi-bedroom go-librespot[17641]: time="2025-12-14T23:18:48-05:00" level=debug msg="obtained new client token: AAAPTxUs7OzNEc500BpG+pBqpdq0Jiy6oN6/Gdj25+VVED5xohbRHPQpVFvlme7aqHBlG9uglF4Vh7hDeonN/XZ9rguL4izN4Lr/C0aIYIWMPY5sNzBfPSxSsoRiG6vMlYpN2pUmmEBvz82M1Ve0Kjk226VBZINDDW5lhXkvJijyBCOcnjmwdbLn8PsQE7orwxgvgNVVKdV9R4od5A62WEjEjxcHqvmhopqm+dm70KZvTcyryPwDIS4+Fg=="
Dec 14 23:18:48 gbvpi-bedroom go-librespot[17641]: time="2025-12-14T23:18:48-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:18:48 gbvpi-bedroom go-librespot[17641]: time="2025-12-14T23:18:48-05:00" level=debug msg="completed keyexchange"
Dec 14 23:18:48 gbvpi-bedroom go-librespot[17641]: time="2025-12-14T23:18:48-05:00" level=debug msg="completed challenge"
Dec 14 23:18:49 gbvpi-bedroom go-librespot[17641]: time="2025-12-14T23:18:49-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 14 23:18:49 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:18:49 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:18:49 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:49 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:52 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:52 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:52 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 39.
Dec 14 23:18:52 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:52 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:52 gbvpi-bedroom go-librespot[17662]: go-librespot daemon starting...
Dec 14 23:18:52 gbvpi-bedroom go-librespot[17663]: time="2025-12-14T23:18:52-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:18:52 gbvpi-bedroom go-librespot[17663]: time="2025-12-14T23:18:52-05:00" level=debug msg="app state loaded"
Dec 14 23:18:52 gbvpi-bedroom go-librespot[17663]: time="2025-12-14T23:18:52-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:18:52 gbvpi-bedroom go-librespot[17663]: time="2025-12-14T23:18:52-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 14 23:18:52 gbvpi-bedroom go-librespot[17663]: time="2025-12-14T23:18:52-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 14 23:18:52 gbvpi-bedroom go-librespot[17663]: time="2025-12-14T23:18:52-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 14 23:18:52 gbvpi-bedroom go-librespot[17663]: time="2025-12-14T23:18:52-05:00" level=info msg="zeroconf server listening on port 35333"
Dec 14 23:18:52 gbvpi-bedroom go-librespot[17663]: time="2025-12-14T23:18:52-05:00" level=debug msg="obtained new client token: AAA0r9GPOWrTTsFDqXVRQXDFxYdk2nOojNkywwYirymedgooEyi5WKdEj528tSQHZplvtLcgG0p+vqBn7YGmHBfXWiG5Gy0EU78PXdn6KgSCpcHQi5TYHz259VmWerb0xQk1uJ+4gb8itlN5fjtrdFp/zxG+k0wXlDoHBqF4+8L0/wNkCFXGdz0IYr5n0caEK6/Poj9x7Et3a71fOlfnEY4pwD95Nf1cRizgluEcBbIgPgwMAjeTlITRRA=="
Dec 14 23:18:52 gbvpi-bedroom go-librespot[17663]: time="2025-12-14T23:18:52-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:18:52 gbvpi-bedroom go-librespot[17663]: time="2025-12-14T23:18:52-05:00" level=debug msg="completed keyexchange"
Dec 14 23:18:52 gbvpi-bedroom go-librespot[17663]: time="2025-12-14T23:18:52-05:00" level=debug msg="completed challenge"
Dec 14 23:18:52 gbvpi-bedroom go-librespot[17663]: time="2025-12-14T23:18:52-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 14 23:18:52 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:18:52 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:18:55 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:55 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:55 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::volumioGetState
Dec 14 23:18:55 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::volumioGetState
Dec 14 23:18:55 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 40.
Dec 14 23:18:55 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:56 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:56 gbvpi-bedroom go-librespot[17674]: go-librespot daemon starting...
Dec 14 23:18:56 gbvpi-bedroom go-librespot[17675]: time="2025-12-14T23:18:56-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:18:56 gbvpi-bedroom go-librespot[17675]: time="2025-12-14T23:18:56-05:00" level=debug msg="app state loaded"
Dec 14 23:18:56 gbvpi-bedroom go-librespot[17675]: time="2025-12-14T23:18:56-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:18:56 gbvpi-bedroom go-librespot[17675]: time="2025-12-14T23:18:56-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 14 23:18:56 gbvpi-bedroom go-librespot[17675]: time="2025-12-14T23:18:56-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 14 23:18:56 gbvpi-bedroom go-librespot[17675]: time="2025-12-14T23:18:56-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 14 23:18:56 gbvpi-bedroom go-librespot[17675]: time="2025-12-14T23:18:56-05:00" level=info msg="zeroconf server listening on port 35095"
Dec 14 23:18:56 gbvpi-bedroom go-librespot[17675]: time="2025-12-14T23:18:56-05:00" level=debug msg="obtained new client token: AADacy92YY0gyNY8KONVSdSf3iNXPfhZD5TShZlOt6jrYKkLMqmTo84Akr2CiYV+Sls1t0hd8Hn3DkrvO9HBkSlL9xOXtoaqu/Tj560UTJaZPa7PDK9AWDgQXIXLvAtzmnSZ8T3Z6U5svMqUg33vIir2COYUFopHKe9vyT8BXToG8jv+CNWm5Z/I9zs3BXYYtEpdsAtdpuSN1b9PNSZYxj/JGe4mB2FpnE95XA9NPgYPVmD95kQl7u0IYg=="
Dec 14 23:18:56 gbvpi-bedroom go-librespot[17675]: time="2025-12-14T23:18:56-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:18:56 gbvpi-bedroom go-librespot[17675]: time="2025-12-14T23:18:56-05:00" level=debug msg="completed keyexchange"
Dec 14 23:18:56 gbvpi-bedroom go-librespot[17675]: time="2025-12-14T23:18:56-05:00" level=debug msg="completed challenge"
Dec 14 23:18:56 gbvpi-bedroom go-librespot[17675]: time="2025-12-14T23:18:56-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 14 23:18:56 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:18:56 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:18:58 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:18:58 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:18:59 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 41.
Dec 14 23:18:59 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:59 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:18:59 gbvpi-bedroom go-librespot[17682]: go-librespot daemon starting...
Dec 14 23:18:59 gbvpi-bedroom go-librespot[17683]: time="2025-12-14T23:18:59-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:18:59 gbvpi-bedroom go-librespot[17683]: time="2025-12-14T23:18:59-05:00" level=debug msg="app state loaded"
Dec 14 23:18:59 gbvpi-bedroom go-librespot[17683]: time="2025-12-14T23:18:59-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:18:59 gbvpi-bedroom go-librespot[17683]: time="2025-12-14T23:18:59-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 14 23:18:59 gbvpi-bedroom go-librespot[17683]: time="2025-12-14T23:18:59-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 14 23:18:59 gbvpi-bedroom go-librespot[17683]: time="2025-12-14T23:18:59-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 14 23:18:59 gbvpi-bedroom go-librespot[17683]: time="2025-12-14T23:18:59-05:00" level=info msg="zeroconf server listening on port 42341"
Dec 14 23:19:00 gbvpi-bedroom go-librespot[17683]: time="2025-12-14T23:19:00-05:00" level=debug msg="obtained new client token: AAB+L3mrIUYuS3C91LiiTxCn6xf7AJf3vAfUSqwwMQ04DupwrIrPCcQO2BiM2zONqy7c0Zh1yM+3ztG6aTJEs/Ub4KRg3WXmWzp2jVYqW2RfzP4pQlLFPJKdNrWb2XqkvIMlilnb9b5v1jDiF9s0xNDmP8bK9MjMjAGHdq90rfTWLVgnlxs9Y6EjVNn6VXCUtDdGz7iWQ1o3UqEnB1wZfUwuAfdNI3kHPnbYc6RIq9VOeegVef9UpZ8="
Dec 14 23:19:00 gbvpi-bedroom go-librespot[17683]: time="2025-12-14T23:19:00-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:19:00 gbvpi-bedroom go-librespot[17683]: time="2025-12-14T23:19:00-05:00" level=debug msg="completed keyexchange"
Dec 14 23:19:00 gbvpi-bedroom go-librespot[17683]: time="2025-12-14T23:19:00-05:00" level=debug msg="completed challenge"
Dec 14 23:19:00 gbvpi-bedroom go-librespot[17683]: time="2025-12-14T23:19: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 14 23:19:00 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:19:00 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:19:01 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:19:01 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:19:03 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 42.
Dec 14 23:19:03 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:19:03 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:19:03 gbvpi-bedroom go-librespot[17704]: go-librespot daemon starting...
Dec 14 23:19:03 gbvpi-bedroom go-librespot[17705]: time="2025-12-14T23:19:03-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:19:03 gbvpi-bedroom go-librespot[17705]: time="2025-12-14T23:19:03-05:00" level=debug msg="app state loaded"
Dec 14 23:19:03 gbvpi-bedroom go-librespot[17705]: time="2025-12-14T23:19:03-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:19:03 gbvpi-bedroom go-librespot[17705]: time="2025-12-14T23:19: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-gew4.spotify.com:80]"
Dec 14 23:19:03 gbvpi-bedroom go-librespot[17705]: time="2025-12-14T23:19:03-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 14 23:19:03 gbvpi-bedroom go-librespot[17705]: time="2025-12-14T23:19:03-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 14 23:19:03 gbvpi-bedroom go-librespot[17705]: time="2025-12-14T23:19:03-05:00" level=info msg="zeroconf server listening on port 38553"
Dec 14 23:19:03 gbvpi-bedroom go-librespot[17705]: time="2025-12-14T23:19:03-05:00" level=debug msg="obtained new client token: AACjjkyrfe+0k6zz546tFjyNs+8v7GLYnCndGnTt6JMVyG7/oyene3F8oOlE8s3E6biN2tJ2DsKhdln7QPqXSu8K/yXHlg47obQ4blJiSKvlfyqZW0IX67cdKqRThJ2nuBv2+CL9IcPzrnid6CSzsIMkMgZXJj2CFpyoEVUe2dZh08mQj34Xv4nEneXpJydVhS5sUL11QBv8dTBIWh6pqYNfl7XKbN5uCdyBnpW493mAc74KnDsBe5xfww=="
Dec 14 23:19:03 gbvpi-bedroom go-librespot[17705]: time="2025-12-14T23:19:03-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:19:03 gbvpi-bedroom go-librespot[17705]: time="2025-12-14T23:19:03-05:00" level=debug msg="completed keyexchange"
Dec 14 23:19:03 gbvpi-bedroom go-librespot[17705]: time="2025-12-14T23:19:03-05:00" level=debug msg="completed challenge"
Dec 14 23:19:03 gbvpi-bedroom go-librespot[17705]: time="2025-12-14T23:19: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 14 23:19:03 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:19:03 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:19:04 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:19:04 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:19:05 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::volumioGetState
Dec 14 23:19:05 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::volumioGetState
Dec 14 23:19:05 gbvpi-bedroom volumio[16887]: info: Listing playlists
Dec 14 23:19:05 gbvpi-bedroom volumio[16887]: info: Listing playlists
Dec 14 23:19:05 gbvpi-bedroom volumio[16887]: info: Listing playlists
Dec 14 23:19:05 gbvpi-bedroom volumio[16887]: info: Listing playlists
Dec 14 23:19:07 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:19:07 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:19:07 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 43.
Dec 14 23:19:07 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:19:07 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:19:07 gbvpi-bedroom go-librespot[17712]: go-librespot daemon starting...
Dec 14 23:19:07 gbvpi-bedroom go-librespot[17713]: time="2025-12-14T23:19:07-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:19:07 gbvpi-bedroom go-librespot[17713]: time="2025-12-14T23:19:07-05:00" level=debug msg="app state loaded"
Dec 14 23:19:07 gbvpi-bedroom go-librespot[17713]: time="2025-12-14T23:19:07-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:19:07 gbvpi-bedroom go-librespot[17713]: time="2025-12-14T23:19:07-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 14 23:19:07 gbvpi-bedroom go-librespot[17713]: time="2025-12-14T23:19:07-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 14 23:19:07 gbvpi-bedroom go-librespot[17713]: time="2025-12-14T23:19:07-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 14 23:19:07 gbvpi-bedroom go-librespot[17713]: time="2025-12-14T23:19:07-05:00" level=info msg="zeroconf server listening on port 42659"
Dec 14 23:19:07 gbvpi-bedroom go-librespot[17713]: time="2025-12-14T23:19:07-05:00" level=debug msg="obtained new client token: AAB8KieFZNHkFa1RSaDvue2nedLWPgqVr6SJ8DII5Ws0JRSQmlKDbTkYH4M0QI9BJxwj1tLHh6qD+b3ZwDzvENPYwrfySRDuOryXEgSgm25E5yGLGzyfU7N2rjG+QP6XJZjF0EQPDVNEHc6mb8cocAaaGPWOIG7QkO9nLnKhOb7ye1jOTqJNFt9tMNblnR8rQ3T7hiVUWzqyiFBkD69MGga9F861ti3vsSmxxdi7SMGc6IE9yFbnthq8Uw=="
Dec 14 23:19:07 gbvpi-bedroom go-librespot[17713]: time="2025-12-14T23:19:07-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:19:07 gbvpi-bedroom go-librespot[17713]: time="2025-12-14T23:19:07-05:00" level=debug msg="completed keyexchange"
Dec 14 23:19:07 gbvpi-bedroom go-librespot[17713]: time="2025-12-14T23:19:07-05:00" level=debug msg="completed challenge"
Dec 14 23:19:07 gbvpi-bedroom go-librespot[17713]: time="2025-12-14T23:19: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 14 23:19:07 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:19:07 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:19:10 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:19:10 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:19:10 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 44.
Dec 14 23:19:10 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:19:10 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:19:10 gbvpi-bedroom go-librespot[17734]: go-librespot daemon starting...
Dec 14 23:19:10 gbvpi-bedroom go-librespot[17735]: time="2025-12-14T23:19:10-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:19:10 gbvpi-bedroom go-librespot[17735]: time="2025-12-14T23:19:10-05:00" level=debug msg="app state loaded"
Dec 14 23:19:10 gbvpi-bedroom go-librespot[17735]: time="2025-12-14T23:19:10-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:19:10 gbvpi-bedroom go-librespot[17735]: time="2025-12-14T23:19: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 14 23:19:10 gbvpi-bedroom go-librespot[17735]: time="2025-12-14T23:19: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 14 23:19:10 gbvpi-bedroom go-librespot[17735]: time="2025-12-14T23:19: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 14 23:19:10 gbvpi-bedroom go-librespot[17735]: time="2025-12-14T23:19:10-05:00" level=info msg="zeroconf server listening on port 45361"
Dec 14 23:19:11 gbvpi-bedroom go-librespot[17735]: time="2025-12-14T23:19:11-05:00" level=debug msg="obtained new client token: AADsD9H1eDbugefMJUz6Lov7huOHl7UkumWXRM2rJLM8D1es3OT23dS5cpGxRX1c79NDoq2KiqnQcBmWtzgTgfUFbIW5z50TAoGeP8R7Jabu8attaHOzHPe2wMp04Em6BSddr/LDFn9pWgUqK/3fkUX/zLcVYa7pSF+I1LpEgGgBqD5qSxDaU7i4P5F6m/cRfNoDloGCAmZwRXs1lPb5Hwi9kzj/EH23jOi6+OdRZn8otLsa8Xyd9QY="
Dec 14 23:19:11 gbvpi-bedroom go-librespot[17735]: time="2025-12-14T23:19:11-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:19:11 gbvpi-bedroom go-librespot[17735]: time="2025-12-14T23:19:11-05:00" level=debug msg="completed keyexchange"
Dec 14 23:19:11 gbvpi-bedroom go-librespot[17735]: time="2025-12-14T23:19:11-05:00" level=debug msg="completed challenge"
Dec 14 23:19:11 gbvpi-bedroom go-librespot[17735]: time="2025-12-14T23:19:11-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 14 23:19:11 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:19:11 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:19:13 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:19:13 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:19:14 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 45.
Dec 14 23:19:14 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:19:14 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:19:14 gbvpi-bedroom go-librespot[17743]: go-librespot daemon starting...
Dec 14 23:19:14 gbvpi-bedroom go-librespot[17744]: time="2025-12-14T23:19:14-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:19:14 gbvpi-bedroom go-librespot[17744]: time="2025-12-14T23:19:14-05:00" level=debug msg="app state loaded"
Dec 14 23:19:14 gbvpi-bedroom go-librespot[17744]: time="2025-12-14T23:19:14-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:19:14 gbvpi-bedroom go-librespot[17744]: time="2025-12-14T23:19:14-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 14 23:19:14 gbvpi-bedroom go-librespot[17744]: time="2025-12-14T23:19:14-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 14 23:19:14 gbvpi-bedroom go-librespot[17744]: time="2025-12-14T23:19:14-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 14 23:19:14 gbvpi-bedroom go-librespot[17744]: time="2025-12-14T23:19:14-05:00" level=info msg="zeroconf server listening on port 46563"
Dec 14 23:19:14 gbvpi-bedroom go-librespot[17744]: time="2025-12-14T23:19:14-05:00" level=debug msg="obtained new client token: AADpwCAneA6bK2mBwghbuCCsLmpu2sTtgvIbkexvV4029j17jrKJTLLqPIHesmTOGX1YkFozP/z4jI79Orp/FMvZCoedVEnChhCkHa4FNWdLehzFW9bfoxzWXGth6OTL22whUEBJbyF/d7ufon0wycoH+QJnQhzxTp90dbWCDETuALcBaq+fhjKfhT8c7EducE2zlUppdQcf7XG0AzHp0rluBTplWMEmmVUt91I2+PAjBZZf5fZ9a4HYvA=="
Dec 14 23:19:14 gbvpi-bedroom go-librespot[17744]: time="2025-12-14T23:19:14-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:19:14 gbvpi-bedroom go-librespot[17744]: time="2025-12-14T23:19:14-05:00" level=debug msg="completed keyexchange"
Dec 14 23:19:14 gbvpi-bedroom go-librespot[17744]: time="2025-12-14T23:19:14-05:00" level=debug msg="completed challenge"
Dec 14 23:19:14 gbvpi-bedroom go-librespot[17744]: time="2025-12-14T23:19: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 14 23:19:14 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:19:14 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:19:15 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::volumioGetState
Dec 14 23:19:15 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::volumioGetState
Dec 14 23:19:16 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:19:16 gbvpi-bedroom volumio[16887]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 14 23:19:17 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 46.
Dec 14 23:19:17 gbvpi-bedroom systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:19:18 gbvpi-bedroom systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 14 23:19:18 gbvpi-bedroom go-librespot[17754]: go-librespot daemon starting...
Dec 14 23:19:18 gbvpi-bedroom go-librespot[17755]: time="2025-12-14T23:19:18-05:00" level=info msg="running go-librespot 0.4.0"
Dec 14 23:19:18 gbvpi-bedroom go-librespot[17755]: time="2025-12-14T23:19:18-05:00" level=debug msg="app state loaded"
Dec 14 23:19:18 gbvpi-bedroom go-librespot[17755]: time="2025-12-14T23:19:18-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 14 23:19:18 gbvpi-bedroom go-librespot[17755]: time="2025-12-14T23:19:18-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 14 23:19:18 gbvpi-bedroom go-librespot[17755]: time="2025-12-14T23:19:18-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 14 23:19:18 gbvpi-bedroom go-librespot[17755]: time="2025-12-14T23:19:18-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 14 23:19:18 gbvpi-bedroom go-librespot[17755]: time="2025-12-14T23:19:18-05:00" level=info msg="zeroconf server listening on port 37255"
Dec 14 23:19:18 gbvpi-bedroom go-librespot[17755]: time="2025-12-14T23:19:18-05:00" level=debug msg="obtained new client token: AADufroU3oE4P5bcd/0V5CLr67pTwqwM3kwLGyJiIOMdVcJFyu570gKFvf8vRQNftcuo4KuTYoGD98FkPXnjQGU7gI6Rz71wAhMukjHEu1WdDA0HD7XN4FoUhIBIKiEgXx17HRzWkhJnKsLG+LAVdjkeaJ2YqsTnT0x4RI7e96zapb+lEmsQQ3VCsCHzcxMU8C3DQJjGyRJ13wtNgGKGBEm86FYkqnwQrGYZZx6eoVmcSQGWTt5qUH7sVg=="
Dec 14 23:19:19 gbvpi-bedroom volumio[16887]: info: Initializing connection to go-librespot Websocket
Dec 14 23:19:19 gbvpi-bedroom go-librespot[17755]: time="2025-12-14T23:19:19-05:00" level=debug msg="new websocket client"
Dec 14 23:19:19 gbvpi-bedroom volumio[16887]: info: Connection to go-librespot Websocket established
Dec 14 23:19:22 gbvpi-bedroom volumio[16887]: info: Getting Spotify volume
Dec 14 23:19:22 gbvpi-bedroom volumio[16887]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Dec 14 23:19:22 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::volumioGetState
Dec 14 23:19:22 gbvpi-bedroom volumio[16887]: SPOTIFY: RECEIVED VOLUMIO VOLUME 91
Dec 14 23:19:22 gbvpi-bedroom volumio[16887]: SPOTIFY: SPOTIFY VOLUME undefined
Dec 14 23:19:22 gbvpi-bedroom volumio[16887]: SPOTIFY: VOLUMIO VOLUME 91
Dec 14 23:19:22 gbvpi-bedroom volumio[16887]: info: Aligning Spotify Volume to Volumio Volume
Dec 14 23:19:22 gbvpi-bedroom volumio[16887]: info: CoreCommandRouter::volumioGetState
Dec 14 23:19:22 gbvpi-bedroom volumio[16887]: info: Setting Spotify Volume from Volumio: 91
Dec 14 23:19:23 gbvpi-bedroom go-librespot[17755]: time="2025-12-14T23:19:23-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 14 23:19:23 gbvpi-bedroom go-librespot[17755]: time="2025-12-14T23:19:23-05:00" level=debug msg="completed keyexchange"
Dec 14 23:19:23 gbvpi-bedroom go-librespot[17755]: time="2025-12-14T23:19:23-05:00" level=debug msg="completed challenge"
Dec 14 23:19:23 gbvpi-bedroom go-librespot[17755]: time="2025-12-14T23:19:23-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 14 23:19:23 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 14 23:19:23 gbvpi-bedroom systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 14 23:19:23 gbvpi-bedroom volumio[16887]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 14 23:19:23 gbvpi-bedroom volumio[16887]: Error: socket hang up
Dec 14 23:19:23 gbvpi-bedroom volumio[16887]: at connResetException (node:internal/errors:720:14)
Dec 14 23:19:23 gbvpi-bedroom volumio[16887]: at Socket.socketOnEnd (node:_http_client:519:23)
Dec 14 23:19:23 gbvpi-bedroom volumio[16887]: at Socket.emit (node:events:526:35)
Dec 14 23:19:23 gbvpi-bedroom volumio[16887]: at endReadableNT (node:internal/streams/readable:1376:12)
Dec 14 23:19:23 gbvpi-bedroom volumio[16887]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) {
Dec 14 23:19:23 gbvpi-bedroom volumio[16887]: code: 'ECONNRESET',
Dec 14 23:19:23 gbvpi-bedroom volumio[16887]: response: undefined
Dec 14 23:19:23 gbvpi-bedroom volumio[16887]: }
Dec 14 23:19:23 gbvpi-bedroom volumio[16887]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 14 23:19:23 gbvpi-bedroom sudo[17790]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-14 23:18'
Dec 14 23:19:23 gbvpi-bedroom sudo[17790]: 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="6a0bffa825dc2af90b21170949f5219ba5ab5701"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed Dec 10 09:27:23 UTC 2025"
VOLUMIO_VERSION="4.075"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="4bd01f93a654c7068f4553fbd69478e2"