Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: MPD Permissions set
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: MPD Permissions set
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: Volumio called home
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: Spotify config file written
Dec 09 00:12:00 northpi-soundstation volumio[10289]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:00 northpi-soundstation sudo[10507]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:00 northpi-soundstation sudo[10507]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:00 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: No need to fix Spotify hosts
Dec 09 00:12:00 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:00 northpi-soundstation go-librespot[10514]: go-librespot daemon starting...
Dec 09 00:12:00 northpi-soundstation sudo[10507]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:00 northpi-soundstation go-librespot[10520]: time="2025-12-09T00:12:00-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:12:00 northpi-soundstation go-librespot[10520]: time="2025-12-09T00:12:00-05:00" level=debug msg="app state loaded"
Dec 09 00:12:00 northpi-soundstation go-librespot[10520]: time="2025-12-09T00:12:00-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: Starting Shairport Sync
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: Starting Shairport Sync
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: Starting Shairport Sync
Dec 09 00:12:00 northpi-soundstation sudo[10527]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Dec 09 00:12:00 northpi-soundstation sudo[10527]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:00 northpi-soundstation sudo[10532]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Dec 09 00:12:00 northpi-soundstation sudo[10532]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:00 northpi-soundstation systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Dec 09 00:12:00 northpi-soundstation systemd[1]: shairport-sync.service: Deactivated successfully.
Dec 09 00:12:00 northpi-soundstation systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Dec 09 00:12:00 northpi-soundstation systemd[1]: shairport-sync.service: Consumed 1.620s CPU time.
Dec 09 00:12:00 northpi-soundstation sudo[10529]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Dec 09 00:12:00 northpi-soundstation sudo[10529]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:00 northpi-soundstation systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Dec 09 00:12:00 northpi-soundstation sudo[10527]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:00 northpi-soundstation go-librespot[10520]: time="2025-12-09T00:12:00-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 09 00:12:00 northpi-soundstation volumio[10289]: info: Shairport-Sync Started
Dec 09 00:12:00 northpi-soundstation go-librespot[10520]: time="2025-12-09T00:12:00-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 09 00:12:00 northpi-soundstation go-librespot[10520]: time="2025-12-09T00:12:00-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 09 00:12:00 northpi-soundstation volumio[10289]: Error adding Membership: Error: addMembership EINVAL
Dec 09 00:12:00 northpi-soundstation systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: An error occurred while refreshing Spotify Token Error: Bad Request
Dec 09 00:12:00 northpi-soundstation go-librespot[10520]: time="2025-12-09T00:12:00-05:00" level=info msg="zeroconf server listening on port 40739"
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetState
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: CorePlayQueue::getTrack 0
Dec 09 00:12:00 northpi-soundstation systemd[1]: shairport-sync.service: Deactivated successfully.
Dec 09 00:12:00 northpi-soundstation systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Dec 09 00:12:00 northpi-soundstation systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Dec 09 00:12:00 northpi-soundstation sudo[10529]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:00 northpi-soundstation sudo[10532]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: Shairport-Sync Started
Dec 09 00:12:00 northpi-soundstation volumio[10289]: info: Shairport-Sync Started
Dec 09 00:12:00 northpi-soundstation go-librespot[10520]: time="2025-12-09T00:12:00-05:00" level=debug msg="obtained new client token: AADc8mGy4O1q9cpUbR32GqT8EJZ1ueLBZ/66nRgpfxw2XADUoOv7UraLRQ/8+YGcVH48dq7VGBgG/STYeQadmpG3iyoZ8IGXnP7hhLDWrPlF+3/K9BDmLRg5wZNwu3SzTX92VCOZwrupU78q29tMTRnqW36Rpxa5KjPILf/mcKkKm+pFObc+5bQ6CwuXuvpfmrO/QM8Bai17Un5s5ghXharhmF11BI0CyJ73dv4mBQdyBkzF6FjtGOTqIQ=="
Dec 09 00:12:00 northpi-soundstation go-librespot[10520]: time="2025-12-09T00:12:00-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:12:00 northpi-soundstation go-librespot[10520]: time="2025-12-09T00:12:00-05:00" level=debug msg="completed keyexchange"
Dec 09 00:12:00 northpi-soundstation go-librespot[10520]: time="2025-12-09T00:12:00-05:00" level=debug msg="completed challenge"
Dec 09 00:12:00 northpi-soundstation go-librespot[10520]: time="2025-12-09T00:12: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 09 00:12:00 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:12:00 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:12:01 northpi-soundstation mpd[10484]: 2025-12-09T00:12:01 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Dec 09 00:12:01 northpi-soundstation systemd[1]: Started mpd.service - Music Player Daemon.
Dec 09 00:12:01 northpi-soundstation sudo[10445]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:01 northpi-soundstation sudo[10455]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:01 northpi-soundstation volumio[10289]: info: Completed starting Core Plugins
Dec 09 00:12:01 northpi-soundstation volumio[10289]: info: -------------------------------------------
Dec 09 00:12:01 northpi-soundstation volumio[10289]: info: -----    MyVolumio plugins startup     ----
Dec 09 00:12:01 northpi-soundstation volumio[10289]: info: -------------------------------------------
Dec 09 00:12:01 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Fetching plans data....
Dec 09 00:12:01 northpi-soundstation volumio[10289]: error: MPD error: The expression evaluated to a falsy value:
Dec 09 00:12:01 northpi-soundstation volumio[10289]:   assert.ok(self.idling)
Dec 09 00:12:01 northpi-soundstation volumio[10289]: error: The expression evaluated to a falsy value:
Dec 09 00:12:01 northpi-soundstation volumio[10289]:   assert.ok(self.idling)
Dec 09 00:12:01 northpi-soundstation volumio[10289]: info: MPD running with PID10484
Dec 09 00:12:01 northpi-soundstation volumio[10289]:  ,establishing connection
Dec 09 00:12:01 northpi-soundstation volumio[10289]: error: updateQueue error: null
Dec 09 00:12:01 northpi-soundstation volumio[10289]: error: updateQueue error: null
Dec 09 00:12:02 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetState
Dec 09 00:12:02 northpi-soundstation volumio[10289]: info: CorePlayQueue::getTrack 0
Dec 09 00:12:02 northpi-soundstation volumio[10289]: info: Listing playlists
Dec 09 00:12:02 northpi-soundstation volumio[10289]: info: Listing playlists
Dec 09 00:12:03 northpi-soundstation volumio[10289]: info: [jellyfin-poller] Polled https://jellyfin.lukeaurio.net: online
Dec 09 00:12:03 northpi-soundstation volumio[10289]: info: go-librespot daemon successfully initialized
Dec 09 00:12:04 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 108.
Dec 09 00:12:04 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:04 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:04 northpi-soundstation go-librespot[10573]: go-librespot daemon starting...
Dec 09 00:12:04 northpi-soundstation go-librespot[10574]: time="2025-12-09T00:12:04-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:12:04 northpi-soundstation go-librespot[10574]: time="2025-12-09T00:12:04-05:00" level=debug msg="app state loaded"
Dec 09 00:12:04 northpi-soundstation go-librespot[10574]: time="2025-12-09T00:12:04-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:12:04 northpi-soundstation sudo[10581]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Dec 09 00:12:04 northpi-soundstation sudo[10581]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:04 northpi-soundstation sudo[10584]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Dec 09 00:12:04 northpi-soundstation sudo[10584]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:04 northpi-soundstation systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service...
Dec 09 00:12:04 northpi-soundstation systemd[1]: mpd_monitor.service: Deactivated successfully.
Dec 09 00:12:04 northpi-soundstation systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service.
Dec 09 00:12:04 northpi-soundstation systemd[1]: Started mpd_monitor.service - MPD Monitor Service.
Dec 09 00:12:04 northpi-soundstation sudo[10581]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:04 northpi-soundstation mpd_monitor.sh[10587]: MPD Monitor Service: Starting MPD Monitor Service
Dec 09 00:12:04 northpi-soundstation volumio[10289]: info: Successfully started MPD Monitor
Dec 09 00:12:04 northpi-soundstation systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service...
Dec 09 00:12:04 northpi-soundstation systemd[1]: mpd_monitor.service: Deactivated successfully.
Dec 09 00:12:04 northpi-soundstation systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service.
Dec 09 00:12:04 northpi-soundstation systemd[1]: Started mpd_monitor.service - MPD Monitor Service.
Dec 09 00:12:04 northpi-soundstation sudo[10584]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:04 northpi-soundstation mpd_monitor.sh[10589]: MPD Monitor Service: Starting MPD Monitor Service
Dec 09 00:12:04 northpi-soundstation volumio[10289]: info: Successfully started MPD Monitor
Dec 09 00:12:04 northpi-soundstation go-librespot[10574]: time="2025-12-09T00:12:04-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 09 00:12:04 northpi-soundstation go-librespot[10574]: time="2025-12-09T00:12:04-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 09 00:12:04 northpi-soundstation go-librespot[10574]: time="2025-12-09T00:12:04-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 09 00:12:04 northpi-soundstation go-librespot[10574]: time="2025-12-09T00:12:04-05:00" level=info msg="zeroconf server listening on port 45537"
Dec 09 00:12:04 northpi-soundstation go-librespot[10574]: time="2025-12-09T00:12:04-05:00" level=debug msg="obtained new client token: AAAUSLwUGX8CObWfwRe0MKKmlvutAakWiAWEq2vK6z55jIPNMbpSczL1aoJw2dg7ah5N5h4P8jcfr7J6bSUHO8I/Zomu9+M0jA2hmqaET68/JSvKjRSFWJsZKwWAHEk8iXAEsBJhdxo8aam1PxfaXwlsoce7q0VqdbHNkbHr2Hi728bOgEGFo0Odq1GWpmSj2zFUGTfrtxaNXOybcfp4LrFBcPQmZ8xGxIiWVX9cy6kbd+PpLslo0ZlJgA=="
Dec 09 00:12:04 northpi-soundstation go-librespot[10574]: time="2025-12-09T00:12:04-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:12:04 northpi-soundstation go-librespot[10574]: time="2025-12-09T00:12:04-05:00" level=debug msg="completed keyexchange"
Dec 09 00:12:04 northpi-soundstation go-librespot[10574]: time="2025-12-09T00:12:04-05:00" level=debug msg="completed challenge"
Dec 09 00:12:04 northpi-soundstation go-librespot[10574]: time="2025-12-09T00:12:04-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 09 00:12:04 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:12:04 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:12:05 northpi-soundstation sudo[10608]:  volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 09 00:12:05 northpi-soundstation sudo[10610]:  volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 09 00:12:05 northpi-soundstation sudo[10610]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:05 northpi-soundstation sudo[10608]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:05 northpi-soundstation sudo[10610]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:05 northpi-soundstation sudo[10608]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:05 northpi-soundstation sudo[10614]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Dec 09 00:12:05 northpi-soundstation sudo[10614]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:05 northpi-soundstation sudo[10614]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:05 northpi-soundstation volumio[10289]: info: Upmpdcli Daemon Started
Dec 09 00:12:06 northpi-soundstation volumio[10289]: error: Failed LSINFO: Error:  [50@0] {lsinfo} No such directory
Dec 09 00:12:06 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:12:06 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:12:07 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 109.
Dec 09 00:12:07 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:07 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:07 northpi-soundstation go-librespot[10616]: go-librespot daemon starting...
Dec 09 00:12:07 northpi-soundstation go-librespot[10617]: time="2025-12-09T00:12:07-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:12:07 northpi-soundstation go-librespot[10617]: time="2025-12-09T00:12:07-05:00" level=debug msg="app state loaded"
Dec 09 00:12:07 northpi-soundstation go-librespot[10617]: time="2025-12-09T00:12:07-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:12:07 northpi-soundstation go-librespot[10617]: time="2025-12-09T00:12: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-gew4.spotify.com:80]"
Dec 09 00:12:07 northpi-soundstation go-librespot[10617]: time="2025-12-09T00:12:07-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 09 00:12:07 northpi-soundstation go-librespot[10617]: time="2025-12-09T00:12:07-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 09 00:12:07 northpi-soundstation go-librespot[10617]: time="2025-12-09T00:12:07-05:00" level=info msg="zeroconf server listening on port 43835"
Dec 09 00:12:08 northpi-soundstation go-librespot[10617]: time="2025-12-09T00:12:08-05:00" level=debug msg="obtained new client token: AAB5zWWq90Jx9rJEs3B6tjdSLH0fTy3ytLVQ5WK3j1tAZNF4SBVmEzlP8bPhaS9YC6VPw4naynRFONhOQZ+yCT44gb7MqSHLxsR64Ut95YzjdTWLkSbR2G5XJrNuKAvO8IPjCuQxN4EIZwTuSPk9CP+Wnu9zrqQ/gZ2UWdNURuoSXxy8xvxUPIidGuWbQeYd28om91csNk7P1u1OkaW9qISRBvUDRnd+ko/dFFOVjwR2XlgjecpIL7ZG+w=="
Dec 09 00:12:08 northpi-soundstation go-librespot[10617]: time="2025-12-09T00:12:08-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 09 00:12:08 northpi-soundstation go-librespot[10617]: time="2025-12-09T00:12:08-05:00" level=debug msg="connected to ap-gue1.spotify.com:443"
Dec 09 00:12:08 northpi-soundstation go-librespot[10617]: time="2025-12-09T00:12:08-05:00" level=debug msg="completed keyexchange"
Dec 09 00:12:08 northpi-soundstation go-librespot[10617]: time="2025-12-09T00:12:08-05:00" level=debug msg="completed challenge"
Dec 09 00:12:08 northpi-soundstation go-librespot[10617]: time="2025-12-09T00:12:08-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 09 00:12:08 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:12:08 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: Adding plugin bluetooth to MyMusic Plugins
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: Adding plugin multiroom to MyMusic Plugins
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: Adding plugin metavolumio to MyMusic Plugins
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: Adding plugin cd_controller to MyMusic Plugins
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: Adding plugin qobuzconnect to MyMusic Plugins
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: Adding plugin smart_inputs to MyMusic Plugins
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: Adding plugin tidalconnect to MyMusic Plugins
Dec 09 00:12:09 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Dec 09 00:12:10 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Dec 09 00:12:10 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Dec 09 00:12:10 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:10 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:10 northpi-soundstation volumio[10289]: info: Starting MyVolumio Remote Streaming Endpoints
Dec 09 00:12:10 northpi-soundstation volumio[10289]: info: MyVolumio login type: Token
Dec 09 00:12:10 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Dec 09 00:12:10 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Dec 09 00:12:10 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Dec 09 00:12:10 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Dec 09 00:12:10 northpi-soundstation volumio[10289]: info: Streaming services startup
Dec 09 00:12:10 northpi-soundstation volumio[10289]: info: Starting Streaming Daemon
Dec 09 00:12:10 northpi-soundstation sudo[10625]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Dec 09 00:12:10 northpi-soundstation sudo[10625]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:10 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Dec 09 00:12:10 northpi-soundstation sudo[10625]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:10 northpi-soundstation volumio[10289]: error: Cannot start Volumio Streaming Daemon
Dec 09 00:12:10 northpi-soundstation volumio[10289]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Dec 09 00:12:10 northpi-soundstation volumio[10289]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Dec 09 00:12:10 northpi-soundstation volumio[10289]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: MyVolumio token set successfully
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: MYVOLUMIO: Adding device
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: MYVOLUMIO: Evaluating Server
Dec 09 00:12:11 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 110.
Dec 09 00:12:11 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: MyVolumio Plan changed: premium
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Subscribed plan changed to premium
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: Removing browser output: myVolumio user plan is not superstar
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: Removing audio output:
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: MYVOLUMIO: Adding device
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: MYVOLUMIO: Evaluating Server
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: Remote config written successfully
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: Starting Tunnel 1
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: Starting Tunnel Connection Checker
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: Completed starting MyVolumio Plugin
Dec 09 00:12:11 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:11 northpi-soundstation go-librespot[10647]: go-librespot daemon starting...
Dec 09 00:12:11 northpi-soundstation go-librespot[10656]: time="2025-12-09T00:12:11-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:12:11 northpi-soundstation go-librespot[10656]: time="2025-12-09T00:12:11-05:00" level=debug msg="app state loaded"
Dec 09 00:12:11 northpi-soundstation go-librespot[10656]: time="2025-12-09T00:12:11-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: MYVolumio Device enabled
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: MyVolumio status changed
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: Streaming services startup
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: Starting Streaming Daemon
Dec 09 00:12:11 northpi-soundstation sudo[10679]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Dec 09 00:12:11 northpi-soundstation sudo[10679]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: Setting Geolocation for MyVolumio to us4
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"...
Dec 09 00:12:11 northpi-soundstation sudo[10679]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:11 northpi-soundstation go-librespot[10656]: time="2025-12-09T00:12: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-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 09 00:12:11 northpi-soundstation go-librespot[10656]: time="2025-12-09T00:12:11-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 09 00:12:11 northpi-soundstation go-librespot[10656]: time="2025-12-09T00:12:11-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 09 00:12:11 northpi-soundstation go-librespot[10656]: time="2025-12-09T00:12:11-05:00" level=info msg="zeroconf server listening on port 35375"
Dec 09 00:12:11 northpi-soundstation volumio[10289]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart
Dec 09 00:12:11 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Loading plugin "multiroom"...
Dec 09 00:12:11 northpi-soundstation go-librespot[10656]: time="2025-12-09T00:12:11-05:00" level=debug msg="obtained new client token: AABgmO/2nqeJ8595iWKVKvJUdpH+TkQR8Qdh2yaZOCt2A2rTi21xhJhV4Aa7Q15sSd8pJQx5660qErulo6FCOPUkTSCnOeUZ+2tkoPJa0OExRhQRZXt2NLKDgTjMMwojscztZW5pa9kOBxRNaWM35os4frhs/aZHzqEGnqTVpFMNn6acnfe7kBxDBng423oSEBF0VmB9iC/A/t2Rbk4Ft60Y+QIIBZNV2lyZQO7nYPINSTAIXrbU/Hq6Qg=="
Dec 09 00:12:11 northpi-soundstation go-librespot[10656]: time="2025-12-09T00:12:11-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 09 00:12:11 northpi-soundstation go-librespot[10656]: time="2025-12-09T00:12:11-05:00" level=debug msg="connected to ap-gue1.spotify.com:443"
Dec 09 00:12:12 northpi-soundstation go-librespot[10656]: time="2025-12-09T00:12:12-05:00" level=debug msg="completed keyexchange"
Dec 09 00:12:12 northpi-soundstation go-librespot[10656]: time="2025-12-09T00:12:12-05:00" level=debug msg="completed challenge"
Dec 09 00:12:12 northpi-soundstation go-librespot[10656]: time="2025-12-09T00:12:12-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 09 00:12:12 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:12:12 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom
Dec 09 00:12:12 northpi-soundstation sudo[10683]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom
Dec 09 00:12:12 northpi-soundstation sudo[10683]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:12 northpi-soundstation sudo[10683]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:12 northpi-soundstation volumio[10289]: /usr/bin/mkdir: cannot create directory ‘/tmp/hls’: File exists
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: MRS: MultiRoom plugin initialized
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: MRS: STOPPING SNAPCLIENT
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: MRS: Snap server stop
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: MRS: STOPPING volumioStreaming
Dec 09 00:12:12 northpi-soundstation sudo[10700]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient
Dec 09 00:12:12 northpi-soundstation sudo[10700]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:12 northpi-soundstation sudo[10704]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming
Dec 09 00:12:12 northpi-soundstation sudo[10704]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:12 northpi-soundstation sudo[10702]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"...
Dec 09 00:12:12 northpi-soundstation sudo[10702]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Loading plugin "manifestui"...
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"...
Dec 09 00:12:12 northpi-soundstation sudo[10709]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Dec 09 00:12:12 northpi-soundstation sudo[10709]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"...
Dec 09 00:12:12 northpi-soundstation sudo[10700]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:12 northpi-soundstation sudo[10709]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"...
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Loading plugin "tidal"...
Dec 09 00:12:12 northpi-soundstation sudo[10704]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Loading plugin "qobuz"...
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"...
Dec 09 00:12:12 northpi-soundstation sudo[10702]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"...
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: Preparing to generate the ALSA configuration file
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: Updating MyVolumio device info
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: Reading ALSA contributions from plugins.
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: Setting Geolocation for MyVolumio to us4
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: Successfully Added MyVolumio device
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: MRS: Removed streaming files
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: MRS: volumioStreaming STOPPED
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: MRS: SNAPSERVER STOPPED
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: MRS: SNAPCLIENT STOPPED
Dec 09 00:12:12 northpi-soundstation volumio[10289]: error: Cannot start Volumio Streaming Daemon
Dec 09 00:12:12 northpi-soundstation volumio[10289]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Dec 09 00:12:12 northpi-soundstation volumio[10289]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetState
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: CorePlayQueue::getTrack 0
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: Asound.conf file written
Dec 09 00:12:12 northpi-soundstation sudo[10713]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Dec 09 00:12:12 northpi-soundstation sudo[10713]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:12 northpi-soundstation sudo[10713]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:12 northpi-soundstation volumio[10289]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2
Dec 09 00:12:12 northpi-soundstation volumio[10289]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: Output device has changed, restarting MPD
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: Output device has changed, restarting Shairport Sync
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:12 northpi-soundstation sudo[10719]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 09 00:12:12 northpi-soundstation sudo[10719]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:12 northpi-soundstation sudo[10719]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth
Dec 09 00:12:12 northpi-soundstation volumio[10289]: ------------------------------------ BT MESSAGE: [FUNC] onStart
Dec 09 00:12:12 northpi-soundstation volumio[10289]: ------------------------------------ BT MESSAGE: Starting Volumio Bluetooth Service
Dec 09 00:12:12 northpi-soundstation sudo[10723]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 09 00:12:12 northpi-soundstation sudo[10723]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:12 northpi-soundstation volumio[10289]: ------------------------------------ BT MESSAGE: Boot config /etc/bluetooth/volumio.conf: cache mode = tmp
Dec 09 00:12:12 northpi-soundstation volumio[10289]: ------------------------------------ BT MESSAGE: [metaCache] Directory exists and is ready.
Dec 09 00:12:12 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: MRS: Pushing multiroomSync output for this device
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: MRS: Pushing multiroomSync output
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: Adding audio output:
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: Adding audio output:
Dec 09 00:12:13 northpi-soundstation systemd[1]: Stopping mpd.service - Music Player Daemon...
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: Adding METAVOLUMIO REST API Endpoints
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: Preparing CD Folders
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: Adding CD REST API Endpoints
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: Starting UDEV Watcher for CD
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: Detecting CD presence with UDEV
Dec 09 00:12:13 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices
Dec 09 00:12:13 northpi-soundstation bluetoothd[806]: Path / reserved for Adv Monitor app :1.63838
Dec 09 00:12:13 northpi-soundstation systemd[1]: mpd.service: Deactivated successfully.
Dec 09 00:12:13 northpi-soundstation systemd[1]: Stopped mpd.service - Music Player Daemon.
Dec 09 00:12:13 northpi-soundstation systemd[1]: mpd.service: Consumed 1.716s CPU time.
Dec 09 00:12:13 northpi-soundstation systemd[1]: mpd.socket: Deactivated successfully.
Dec 09 00:12:13 northpi-soundstation systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Dec 09 00:12:13 northpi-soundstation systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Dec 09 00:12:13 northpi-soundstation bluetoothd[806]: Adv Monitor app :1.63838 disconnected from D-Bus
Dec 09 00:12:13 northpi-soundstation systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Dec 09 00:12:13 northpi-soundstation systemd[1]: Starting mpd.service - Music Player Daemon...
Dec 09 00:12:13 northpi-soundstation sudo[10739]:     root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 09 00:12:13 northpi-soundstation sudo[10739]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Dec 09 00:12:13 northpi-soundstation sudo[10739]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:14 northpi-soundstation mpd[10741]: 2025-12-09T00:12:14 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Dec 09 00:12:14 northpi-soundstation systemd[1]: Started mpd.service - Music Player Daemon.
Dec 09 00:12:14 northpi-soundstation sudo[10723]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:15 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 111.
Dec 09 00:12:15 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:15 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:15 northpi-soundstation go-librespot[10744]: go-librespot daemon starting...
Dec 09 00:12:15 northpi-soundstation go-librespot[10745]: time="2025-12-09T00:12:15-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:12:15 northpi-soundstation go-librespot[10745]: time="2025-12-09T00:12:15-05:00" level=debug msg="app state loaded"
Dec 09 00:12:15 northpi-soundstation go-librespot[10745]: time="2025-12-09T00:12:15-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:12:15 northpi-soundstation go-librespot[10745]: time="2025-12-09T00:12: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-gae2.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 09 00:12:15 northpi-soundstation go-librespot[10745]: time="2025-12-09T00:12:15-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 09 00:12:15 northpi-soundstation go-librespot[10745]: time="2025-12-09T00:12:15-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 09 00:12:15 northpi-soundstation go-librespot[10745]: time="2025-12-09T00:12:15-05:00" level=info msg="zeroconf server listening on port 43745"
Dec 09 00:12:15 northpi-soundstation go-librespot[10745]: time="2025-12-09T00:12:15-05:00" level=debug msg="obtained new client token: AACQ8p7xVbrfZeSM7NW8HXDstX65YaeYDX9DbLmqLHxWYd+6Fn077IobTBEhZK4iqHW3DeQngzmK57syyAf6aDrnP1HXg9oh4Euh/tzGF8bfITQBsFZ6WiqdCUHkwNIzO4fj6CsUYpxl07KABuhMO+WokkvfbfTgXOCVQ1faegghvg6B5S82jIS43OEkv7bHkmRuMqIcWTpHY0d8pP6ng6RWdzmw0bsbfn1OFimIFfFwK9uiasZdkXqn/w=="
Dec 09 00:12:15 northpi-soundstation go-librespot[10745]: time="2025-12-09T00:12:15-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:12:15 northpi-soundstation go-librespot[10745]: time="2025-12-09T00:12:15-05:00" level=debug msg="completed keyexchange"
Dec 09 00:12:15 northpi-soundstation go-librespot[10745]: time="2025-12-09T00:12:15-05:00" level=debug msg="completed challenge"
Dec 09 00:12:15 northpi-soundstation go-librespot[10745]: time="2025-12-09T00:12: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 09 00:12:15 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:12:15 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:12:18 northpi-soundstation volumio[10289]: warn: [cd-plugin] cdspeedctl: device or media not ready
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Adding inputs REST Endpoints
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Scanning Audio Inputs
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Checking against Known Cards name
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Adding Server instance for streaming
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio
Dec 09 00:12:18 northpi-soundstation volumio[10289]: error: Hi Res Audio Failed Login: Missing Login Data
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Adding HIGHRESAUDIO REST API Endpoints
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect
Dec 09 00:12:18 northpi-soundstation sudo[10772]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Dec 09 00:12:18 northpi-soundstation sudo[10772]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: QobuzConnect: Starting Qobuz Connect socket and service
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections
Dec 09 00:12:18 northpi-soundstation sudo[10779]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Dec 09 00:12:18 northpi-soundstation sudo[10779]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:18 northpi-soundstation systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service...
Dec 09 00:12:18 northpi-soundstation systemd[1]: vtcs.service: Killing process 10194 (vtcs) with signal SIGKILL.
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Adding TIDAL REST API Endpoints
Dec 09 00:12:18 northpi-soundstation systemd[1]: vtcs.service: Deactivated successfully.
Dec 09 00:12:18 northpi-soundstation systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service.
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Stopping AccessToken refresher cron for QOBUZ
Dec 09 00:12:18 northpi-soundstation sudo[10772]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: AccessToken refresher cron started for QOBUZ
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Adding QOBUZ REST API Endpoints
Dec 09 00:12:18 northpi-soundstation sudo[10779]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Updating MyVolumio device info
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: MRS: Getting audio outputs on start
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: MRS: Requesting all other devices output
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:12:18 northpi-soundstation sudo[10782]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Dec 09 00:12:18 northpi-soundstation sudo[10782]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:18 northpi-soundstation systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service...
Dec 09 00:12:18 northpi-soundstation qobuz-connect[10110]: 20251209 00:12:18.252 [10110.10110] INFO SampleApp: Stopping Local configuration server
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Successfully Updated MyVolumio device
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Successfully Added MyVolumio device
Dec 09 00:12:18 northpi-soundstation volumio[10289]: ------------------------------------ BT MESSAGE: Bluetooth adapter powered on
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: MPD Permissions set
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:12:18 northpi-soundstation sudo[10785]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service
Dec 09 00:12:18 northpi-soundstation volumio[10289]: error: updateQueue error: null
Dec 09 00:12:18 northpi-soundstation sudo[10785]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:18 northpi-soundstation sudo[10785]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:18 northpi-soundstation volumio[10289]: ------------------------------------ BT MESSAGE: volumiobt.service started successfully
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioStop
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: CoreStateMachine::stop
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 09 00:12:18 northpi-soundstation volumio[10289]: ------------------------------------ BT MESSAGE: [FUNC] dbusStart
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Starting Shairport Sync
Dec 09 00:12:18 northpi-soundstation sudo[10800]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Dec 09 00:12:18 northpi-soundstation sudo[10800]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:18 northpi-soundstation sudo[10802]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Dec 09 00:12:18 northpi-soundstation sudo[10802]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:18 northpi-soundstation systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Dec 09 00:12:18 northpi-soundstation autossh[10137]: received signal to exit (15)
Dec 09 00:12:18 northpi-soundstation systemd[1]: Stopping sshtunnel.service - MyVolumio SSH Tunnel...
Dec 09 00:12:18 northpi-soundstation systemd[1]: sshtunnel.service: Deactivated successfully.
Dec 09 00:12:18 northpi-soundstation systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel.
Dec 09 00:12:18 northpi-soundstation systemd[1]: shairport-sync.service: Deactivated successfully.
Dec 09 00:12:18 northpi-soundstation systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Dec 09 00:12:18 northpi-soundstation systemd[1]: shairport-sync.service: Consumed 1.589s CPU time.
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Successfully Updated MyVolumio device
Dec 09 00:12:18 northpi-soundstation systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Dec 09 00:12:18 northpi-soundstation sudo[10800]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:18 northpi-soundstation systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel.
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Shairport-Sync Started
Dec 09 00:12:18 northpi-soundstation autossh[10807]: port set to 0, monitoring disabled
Dec 09 00:12:18 northpi-soundstation autossh[10807]: starting ssh (count 1)
Dec 09 00:12:18 northpi-soundstation autossh[10807]: ssh child pid is 10810
Dec 09 00:12:18 northpi-soundstation sudo[10802]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: Remote SSH Started
Dec 09 00:12:18 northpi-soundstation volumiossh-tunnel[10810]: Warning: Permanently added '[us4.myvolumio.org]:2222' (ED25519) to the list of known hosts.
Dec 09 00:12:18 northpi-soundstation volumio[10289]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3
Dec 09 00:12:18 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetState
Dec 09 00:12:18 northpi-soundstation volumio[10289]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.KgLfU6XUUlR7svHZAvNpgZIq9af1.0b008618efe21bea1cc98e8c917fa0a8.state.status'
Dec 09 00:12:18 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 112.
Dec 09 00:12:18 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:18 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:18 northpi-soundstation go-librespot[10825]: go-librespot daemon starting...
Dec 09 00:12:18 northpi-soundstation go-librespot[10826]: time="2025-12-09T00:12:18-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:12:18 northpi-soundstation go-librespot[10826]: time="2025-12-09T00:12:18-05:00" level=debug msg="app state loaded"
Dec 09 00:12:18 northpi-soundstation go-librespot[10826]: time="2025-12-09T00:12:18-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:12:19 northpi-soundstation go-librespot[10826]: time="2025-12-09T00:12:19-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 09 00:12:19 northpi-soundstation go-librespot[10826]: time="2025-12-09T00:12:19-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 09 00:12:19 northpi-soundstation go-librespot[10826]: time="2025-12-09T00:12:19-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 09 00:12:19 northpi-soundstation go-librespot[10826]: time="2025-12-09T00:12:19-05:00" level=info msg="zeroconf server listening on port 43487"
Dec 09 00:12:19 northpi-soundstation go-librespot[10826]: time="2025-12-09T00:12:19-05:00" level=debug msg="obtained new client token: AABC1cflcQcndAdVsQW2+nwuExCv9ECs3BvlmloBrMg/0BpcEI6dlnS4AMgbXX3RXs8w7N+B50QkYPicXehbf26uZaRU/iuZ/Lhc/Ig67FzNbBCiER8nyPcHatpYtbFy+86JTjuFWxmJjNQ6Pw9MEKb54Px6QRiXYLptu0KhDQosG8LHttOXOLOOn+weZm73XnUtTXcbeCP4+NH/rAt+kH+PkUW7+vPIyKuiEdS18jGRH0C8LmgV2Aw="
Dec 09 00:12:19 northpi-soundstation go-librespot[10826]: time="2025-12-09T00:12:19-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:12:19 northpi-soundstation go-librespot[10826]: time="2025-12-09T00:12:19-05:00" level=debug msg="completed keyexchange"
Dec 09 00:12:19 northpi-soundstation go-librespot[10826]: time="2025-12-09T00:12:19-05:00" level=debug msg="completed challenge"
Dec 09 00:12:19 northpi-soundstation go-librespot[10826]: time="2025-12-09T00:12: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 09 00:12:19 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:12:19 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:12:19 northpi-soundstation systemd[1]: qobuz-connect.service: Deactivated successfully.
Dec 09 00:12:19 northpi-soundstation systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service.
Dec 09 00:12:20 northpi-soundstation systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service.
Dec 09 00:12:20 northpi-soundstation sudo[10782]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:20 northpi-soundstation volumio[10289]: info: Executing endpoint qc_getconfig
Dec 09 00:12:20 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Dec 09 00:12:20 northpi-soundstation qobuz-connect[10833]: 20251209 00:12:20.103 [10833.10833] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Dec 09 00:12:20 northpi-soundstation volumio[10289]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Dec 09 00:12:20 northpi-soundstation volumio[10289]: info: QobuzConnect: QOBUZ Connect daemon connected
Dec 09 00:12:20 northpi-soundstation qobuz-connect[10833]: 20251209 00:12:20.107 [10833.10833] INFO VolumeManager: [0x1130598]: Setting new playback volume: 75
Dec 09 00:12:20 northpi-soundstation qobuz-connect[10833]: 20251209 00:12:20.107 [10833.10833] INFO VolumeManager: [0x1130598]: Setting new mute state: 0
Dec 09 00:12:20 northpi-soundstation qobuz-connect[10833]: 20251209 00:12:20.107 [10833.10833] INFO QobuzConnect: [0x1130f68]: Client initialized!
Dec 09 00:12:20 northpi-soundstation qobuz-connect[10833]: 20251209 00:12:20.107 [10833.10833] INFO SampleApp: Starting Avahi advertising, name: NorthPi-Soundstation, service name: _qobuz-connect._tcp
Dec 09 00:12:20 northpi-soundstation qobuz-connect[10833]: 20251209 00:12:20.116 [10833.10833] INFO LocalConfigManager: [0x112fe78]: Starting Local Configuration server
Dec 09 00:12:20 northpi-soundstation qobuz-connect[10833]: 20251209 00:12:20.116 [10833.10833] INFO SampleApp: Starting Local configuration server
Dec 09 00:12:20 northpi-soundstation qobuz-connect[10833]: 20251209 00:12:20.116 [10833.10833] INFO SampleApp: Connected to UNIX socket client 0x111a818
Dec 09 00:12:20 northpi-soundstation qobuz-connect[10833]: 20251209 00:12:20.254 [10833.10833] INFO SampleApp: Playback volume changed: 75
Dec 09 00:12:20 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: TidalConnect service stoped!
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect
Dec 09 00:12:21 northpi-soundstation sudo[10848]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Dec 09 00:12:21 northpi-soundstation sudo[10848]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:12:21 northpi-soundstation sudo[10851]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service
Dec 09 00:12:21 northpi-soundstation sudo[10851]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 09 00:12:21 northpi-soundstation systemd[1]: Started vtcs.service - Volumio Tidal Connect Service.
Dec 09 00:12:21 northpi-soundstation sudo[10848]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:21 northpi-soundstation systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service...
Dec 09 00:12:21 northpi-soundstation systemd[1]: mpd_monitor.service: Deactivated successfully.
Dec 09 00:12:21 northpi-soundstation systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service.
Dec 09 00:12:21 northpi-soundstation systemd[1]: Started mpd_monitor.service - MPD Monitor Service.
Dec 09 00:12:21 northpi-soundstation mpd_monitor.sh[10856]: MPD Monitor Service: Starting MPD Monitor Service
Dec 09 00:12:21 northpi-soundstation sudo[10851]: pam_unix(sudo:session): session closed for user root
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: Successfully started MPD Monitor
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: Executing endpoint tc_getconfig
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Dec 09 00:12:21 northpi-soundstation vtcs[10854]: STARTING TidalConnect services, version: 1.5.2.56
Dec 09 00:12:21 northpi-soundstation vtcs[10854]: STARTED TidalConnect services.
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: Executing endpoint tc_connect
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: Connecting to TidalConnect
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::servicePushState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreStateMachine::pushState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioPushState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: MRS: Pushing multiroomSync output update for this device
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: MRS: Pushing multiroomSync output
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CorePlayQueue::getTrack 0
Dec 09 00:12:21 northpi-soundstation volumio[10289]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false}
Dec 09 00:12:21 northpi-soundstation volumio[10289]: verbose: CURRENT POSITION 0
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreStateMachine::syncState   stateService stop
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreStateMachine::syncState   currentStatus stop
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreStateMachine::pushState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioPushState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: MRS: Pushing multiroomSync output update for this device
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: MRS: Pushing multiroomSync output
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: No code
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreStateMachine::pushState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioPushState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: MRS: Pushing multiroomSync output update for this device
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: MRS: Pushing multiroomSync output
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::servicePushState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreStateMachine::pushState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioPushState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: MRS: Pushing multiroomSync output update for this device
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: MRS: Pushing multiroomSync output
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CorePlayQueue::getTrack 0
Dec 09 00:12:21 northpi-soundstation volumio[10289]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false}
Dec 09 00:12:21 northpi-soundstation volumio[10289]: verbose: CURRENT POSITION 0
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreStateMachine::syncState   stateService stop
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreStateMachine::syncState   currentStatus stop
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreStateMachine::pushState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioPushState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: MRS: Pushing multiroomSync output update for this device
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: MRS: Pushing multiroomSync output
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: No code
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreStateMachine::pushState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioPushState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: MRS: Pushing multiroomSync output update for this device
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: MRS: Pushing multiroomSync output
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.KgLfU6XUUlR7svHZAvNpgZIq9af1.0b008618efe21bea1cc98e8c917fa0a8.state.status'
Dec 09 00:12:21 northpi-soundstation volumio[10289]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.KgLfU6XUUlR7svHZAvNpgZIq9af1.0b008618efe21bea1cc98e8c917fa0a8.state.status'
Dec 09 00:12:21 northpi-soundstation volumio[10289]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.KgLfU6XUUlR7svHZAvNpgZIq9af1.0b008618efe21bea1cc98e8c917fa0a8.state.status'
Dec 09 00:12:21 northpi-soundstation volumio[10289]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.KgLfU6XUUlR7svHZAvNpgZIq9af1.0b008618efe21bea1cc98e8c917fa0a8.state.status'
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetState
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: Listing playlists
Dec 09 00:12:21 northpi-soundstation volumio[10289]: info: Listing playlists
Dec 09 00:12:22 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 113.
Dec 09 00:12:22 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:22 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:22 northpi-soundstation go-librespot[10874]: go-librespot daemon starting...
Dec 09 00:12:22 northpi-soundstation go-librespot[10875]: time="2025-12-09T00:12:22-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:12:22 northpi-soundstation go-librespot[10875]: time="2025-12-09T00:12:22-05:00" level=debug msg="app state loaded"
Dec 09 00:12:22 northpi-soundstation go-librespot[10875]: time="2025-12-09T00:12:22-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:12:22 northpi-soundstation go-librespot[10875]: time="2025-12-09T00:12: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-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 09 00:12:22 northpi-soundstation go-librespot[10875]: time="2025-12-09T00:12:22-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 09 00:12:22 northpi-soundstation go-librespot[10875]: time="2025-12-09T00:12:22-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 09 00:12:22 northpi-soundstation go-librespot[10875]: time="2025-12-09T00:12:22-05:00" level=info msg="zeroconf server listening on port 40999"
Dec 09 00:12:22 northpi-soundstation go-librespot[10875]: time="2025-12-09T00:12:22-05:00" level=debug msg="obtained new client token: AADsCms8h4pRN5p7mXzEqiZYwtDRhBQRXeBu8lXnUr3IS0JzRXJ3bCDK/esQEgsYTtb72HOJbp6DjszMjBvhI5tBT28H1pNn6YFDlohlWXo8aMrJFkKx6jIDU2lQ1OgG4zJrzVuqplbqVph9B57fbfkrHv+Zsqk8Gk0FAsGTLQoE2L+L3uSHoxOrVMDl6CPfsf1GKwwv2ycwXbjLwVuSyy/KG2ojyAPWTPEOED9NuX/+GS/WUiL+Z3obzw=="
Dec 09 00:12:22 northpi-soundstation go-librespot[10875]: time="2025-12-09T00:12:22-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:12:22 northpi-soundstation go-librespot[10875]: time="2025-12-09T00:12:22-05:00" level=debug msg="completed keyexchange"
Dec 09 00:12:22 northpi-soundstation go-librespot[10875]: time="2025-12-09T00:12:22-05:00" level=debug msg="completed challenge"
Dec 09 00:12:22 northpi-soundstation go-librespot[10875]: time="2025-12-09T00:12: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 09 00:12:22 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:12:22 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:12:24 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:12:24 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:12:24 northpi-soundstation volumio[10289]: info: TidalConnect service started!
Dec 09 00:12:24 northpi-soundstation volumio[10289]:  [Metrics]  CommandRouter:  30s 125.57ms 
Dec 09 00:12:24 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumiosetStartupVolume
Dec 09 00:12:24 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:24 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:24 northpi-soundstation volumio[10289]: info: CoreCommandRouter::Close All Modals sent
Dec 09 00:12:24 northpi-soundstation volumio[10289]: info: CoreCommandRouter::Close All Modals sent
Dec 09 00:12:25 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 09 00:12:25 northpi-soundstation volumio[10289]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4
Dec 09 00:12:25 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetState
Dec 09 00:12:25 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Dec 09 00:12:25 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 09 00:12:25 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Dec 09 00:12:25 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 114.
Dec 09 00:12:25 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:26 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:26 northpi-soundstation go-librespot[10902]: go-librespot daemon starting...
Dec 09 00:12:26 northpi-soundstation go-librespot[10903]: time="2025-12-09T00:12:26-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:12:26 northpi-soundstation go-librespot[10903]: time="2025-12-09T00:12:26-05:00" level=debug msg="app state loaded"
Dec 09 00:12:26 northpi-soundstation go-librespot[10903]: time="2025-12-09T00:12:26-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:12:26 northpi-soundstation go-librespot[10903]: time="2025-12-09T00:12: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-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 09 00:12:26 northpi-soundstation go-librespot[10903]: time="2025-12-09T00:12:26-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 09 00:12:26 northpi-soundstation go-librespot[10903]: time="2025-12-09T00:12:26-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 09 00:12:26 northpi-soundstation go-librespot[10903]: time="2025-12-09T00:12:26-05:00" level=info msg="zeroconf server listening on port 33429"
Dec 09 00:12:26 northpi-soundstation go-librespot[10903]: time="2025-12-09T00:12:26-05:00" level=debug msg="obtained new client token: AABDDw2bP8oxcz5L5d6fNmRdPCh5wyeEEreXCEt83cVU+/hLCRaP5sRXHvCWZGlQPi/O8q1KgWMPJ170X5/P0+usKLvnUx6FQ3683yvDLZ1Z/msrt2pB5SaM5W/0RI0/XZXHC6X8n8sk6haJ6wypCnWaXONmQ83cHtikXbAYjlQjpBvfCmC7IZDcwgGFLpfmR57lBxAjE4ZuzRKLAh62SyWWpW1RbIo7/XqYHX5BdNLxA63JWp1uOt++tw=="
Dec 09 00:12:26 northpi-soundstation go-librespot[10903]: time="2025-12-09T00:12:26-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:12:26 northpi-soundstation go-librespot[10903]: time="2025-12-09T00:12:26-05:00" level=debug msg="completed keyexchange"
Dec 09 00:12:26 northpi-soundstation go-librespot[10903]: time="2025-12-09T00:12:26-05:00" level=debug msg="completed challenge"
Dec 09 00:12:26 northpi-soundstation go-librespot[10903]: time="2025-12-09T00:12: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 09 00:12:26 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:12:26 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:12:27 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:12:27 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:12:29 northpi-soundstation kernel: xhci_hcd 0000:01:00.0: ERROR Transfer event for disabled endpoint slot 2 ep 13
Dec 09 00:12:29 northpi-soundstation kernel: xhci_hcd 0000:01:00.0: @0000000428d18940 00000000 00000000 0e000000 020e8001
Dec 09 00:12:29 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 115.
Dec 09 00:12:29 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:29 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:29 northpi-soundstation go-librespot[10911]: go-librespot daemon starting...
Dec 09 00:12:29 northpi-soundstation go-librespot[10912]: time="2025-12-09T00:12:29-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:12:29 northpi-soundstation go-librespot[10912]: time="2025-12-09T00:12:29-05:00" level=debug msg="app state loaded"
Dec 09 00:12:29 northpi-soundstation go-librespot[10912]: time="2025-12-09T00:12:29-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:12:29 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 09 00:12:29 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 09 00:12:29 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Dec 09 00:12:29 northpi-soundstation volumio-remote-updater[5170]: Test mode enabled
Dec 09 00:12:29 northpi-soundstation volumio-remote-updater[5170]: Alpha mode disabled
Dec 09 00:12:29 northpi-soundstation volumio-remote-updater[5170]: Alpha legacy test mode disabled
Dec 09 00:12:29 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Dec 09 00:12:29 northpi-soundstation go-librespot[10912]: time="2025-12-09T00:12: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-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]"
Dec 09 00:12:29 northpi-soundstation go-librespot[10912]: time="2025-12-09T00:12:29-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 09 00:12:29 northpi-soundstation go-librespot[10912]: time="2025-12-09T00:12:29-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 09 00:12:29 northpi-soundstation go-librespot[10912]: time="2025-12-09T00:12:29-05:00" level=info msg="zeroconf server listening on port 46837"
Dec 09 00:12:30 northpi-soundstation go-librespot[10912]: time="2025-12-09T00:12:30-05:00" level=debug msg="obtained new client token: AADexewHUU8BqRmM3HoKphhxmjdbo8TyEUUdg5s9wfXdBUYKjMK2GXG9tCEL7kK8+Z9bPSVuyywkoZKJb5hj8poV+MHVhCczca5zA9mmzb+FB1BMml9wgpehJEXmgfQ31AN8xtfJX7maJCzPUiTiF98Yhs3EnPUIhJlzJsH8jejbVpoyaMUoxBq65ZN10gdJkrw8tFp9S49/umRgp/OePVUNppyf+tY9U8bS1xXeyCy4RldPI/Ox2Js="
Dec 09 00:12:30 northpi-soundstation volumio[10289]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"ANNOUNCEMENT
\n\nProduction line
\n
\nFIX
\n\nNodejs 20.5.1 version pinning with static package fallback
\n\n","title":"Update v4.073","updateavailable":true}
Dec 09 00:12:30 northpi-soundstation go-librespot[10912]: time="2025-12-09T00:12:30-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:12:30 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Dec 09 00:12:30 northpi-soundstation go-librespot[10912]: time="2025-12-09T00:12:30-05:00" level=debug msg="completed keyexchange"
Dec 09 00:12:30 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:30 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 09 00:12:30 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Dec 09 00:12:30 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Dec 09 00:12:30 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Dec 09 00:12:30 northpi-soundstation go-librespot[10912]: time="2025-12-09T00:12:30-05:00" level=debug msg="completed challenge"
Dec 09 00:12:30 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 09 00:12:30 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 09 00:12:30 northpi-soundstation go-librespot[10912]: time="2025-12-09T00:12: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 09 00:12:30 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:12:30 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:12:30 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:12:30 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:12:31 northpi-soundstation volumio[10289]: info: BOOT COMPLETED
Dec 09 00:12:31 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetState
Dec 09 00:12:33 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:12:33 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:12:33 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 116.
Dec 09 00:12:33 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:33 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:33 northpi-soundstation go-librespot[10923]: go-librespot daemon starting...
Dec 09 00:12:33 northpi-soundstation go-librespot[10924]: time="2025-12-09T00:12:33-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:12:33 northpi-soundstation go-librespot[10924]: time="2025-12-09T00:12:33-05:00" level=debug msg="app state loaded"
Dec 09 00:12:33 northpi-soundstation go-librespot[10924]: time="2025-12-09T00:12:33-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:12:33 northpi-soundstation go-librespot[10924]: time="2025-12-09T00:12: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 09 00:12:33 northpi-soundstation go-librespot[10924]: time="2025-12-09T00:12: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 09 00:12:33 northpi-soundstation go-librespot[10924]: time="2025-12-09T00:12: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 09 00:12:33 northpi-soundstation go-librespot[10924]: time="2025-12-09T00:12:33-05:00" level=info msg="zeroconf server listening on port 40945"
Dec 09 00:12:33 northpi-soundstation go-librespot[10924]: time="2025-12-09T00:12:33-05:00" level=debug msg="obtained new client token: AADFIEVTl1HaQpAfhC5y6Nt2GbUXYz70gPcVonLDCANs16GU26e3iwYo7Vp2yWC7p5B3p8Mk+R+1ZK7RMCf/0Zm12d1s2n/9XN7+A9dsXdwBuOYWlgFLbGavEYr4V0rfppzR+30b2ejrGbwQOqYDoqB81hjevZMMXLd5GRylU4Wd7cQzWFTcGyOegKOWk25SjYW3+VozomAVKyE+da5ba20AImEOZGhF6RWbVoTU91DY6H4MJyn6pZfNjQ=="
Dec 09 00:12:33 northpi-soundstation go-librespot[10924]: time="2025-12-09T00:12:33-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:12:33 northpi-soundstation go-librespot[10924]: time="2025-12-09T00:12:33-05:00" level=debug msg="completed keyexchange"
Dec 09 00:12:33 northpi-soundstation go-librespot[10924]: time="2025-12-09T00:12:33-05:00" level=debug msg="completed challenge"
Dec 09 00:12:33 northpi-soundstation go-librespot[10924]: time="2025-12-09T00:12:33-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 09 00:12:33 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:12:33 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:12:36 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:12:36 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:12:36 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 117.
Dec 09 00:12:36 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:36 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:36 northpi-soundstation go-librespot[10945]: go-librespot daemon starting...
Dec 09 00:12:36 northpi-soundstation go-librespot[10946]: time="2025-12-09T00:12:36-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:12:36 northpi-soundstation go-librespot[10946]: time="2025-12-09T00:12:36-05:00" level=debug msg="app state loaded"
Dec 09 00:12:36 northpi-soundstation go-librespot[10946]: time="2025-12-09T00:12:36-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:12:37 northpi-soundstation go-librespot[10946]: time="2025-12-09T00:12: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-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 09 00:12:37 northpi-soundstation go-librespot[10946]: time="2025-12-09T00:12:37-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 09 00:12:37 northpi-soundstation go-librespot[10946]: time="2025-12-09T00:12:37-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 09 00:12:37 northpi-soundstation go-librespot[10946]: time="2025-12-09T00:12:37-05:00" level=info msg="zeroconf server listening on port 37197"
Dec 09 00:12:37 northpi-soundstation go-librespot[10946]: time="2025-12-09T00:12:37-05:00" level=debug msg="obtained new client token: AAB1dj3ZU2RBkvXmmI2y6wo1Z4rKEbN63rLMNIxVgabq35CMgXigTdcouaiJRmUk4eR+54AfER2pFOr5t7Lu0MiFsxflVvY/nU3weM3JadWmFGqvhIvYYg+MOYcsdEYVk/jp1WzjO1MCcLsDr2GQFzJJ9LzyBS+OuN1PXcuz+pjguNOysJPdQZmVbziS5fPSG7ZQys0TdholrFxYptCPPEE5mNk6nCZfY7NpjcAF0OU8Q1OOjADsz/c="
Dec 09 00:12:37 northpi-soundstation go-librespot[10946]: time="2025-12-09T00:12:37-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:12:38 northpi-soundstation go-librespot[10946]: time="2025-12-09T00:12:38-05:00" level=debug msg="completed keyexchange"
Dec 09 00:12:38 northpi-soundstation go-librespot[10946]: time="2025-12-09T00:12:38-05:00" level=debug msg="completed challenge"
Dec 09 00:12:38 northpi-soundstation go-librespot[10946]: time="2025-12-09T00:12:38-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 09 00:12:38 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:12:38 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:12:39 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:12:39 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:12:41 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 118.
Dec 09 00:12:41 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:41 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:41 northpi-soundstation go-librespot[10957]: go-librespot daemon starting...
Dec 09 00:12:41 northpi-soundstation go-librespot[10958]: time="2025-12-09T00:12:41-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:12:41 northpi-soundstation go-librespot[10958]: time="2025-12-09T00:12:41-05:00" level=debug msg="app state loaded"
Dec 09 00:12:41 northpi-soundstation go-librespot[10958]: time="2025-12-09T00:12:41-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:12:41 northpi-soundstation go-librespot[10958]: time="2025-12-09T00:12: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 09 00:12:41 northpi-soundstation go-librespot[10958]: time="2025-12-09T00:12: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 09 00:12:41 northpi-soundstation go-librespot[10958]: time="2025-12-09T00:12: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 09 00:12:41 northpi-soundstation go-librespot[10958]: time="2025-12-09T00:12:41-05:00" level=info msg="zeroconf server listening on port 38651"
Dec 09 00:12:41 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetState
Dec 09 00:12:42 northpi-soundstation volumio[10289]: info: Listing playlists
Dec 09 00:12:42 northpi-soundstation volumio[10289]: info: Listing playlists
Dec 09 00:12:42 northpi-soundstation go-librespot[10958]: time="2025-12-09T00:12:42-05:00" level=debug msg="obtained new client token: AADKuUWYTzc/8X2r4VdyJOWl9yFk2walLLVtx41Afs0isiI78vjbznX4FTvuVhtww07+XvB4vv4Xt+O64p5yB3UhsYkqR0t4dfA0pmNv9zv08wu09giBm4EhCWDK5HOpwCc1USKTozvCqkK/uRFO3wFYMRicwp1jwFE2Fmpp7xMpkkpx6b0moBlFTyPouY7Hfzx/G90w750G7n3pepgcVDe5MHXC+o5BQh0zG14VJwGasaAQDzu4ONU="
Dec 09 00:12:42 northpi-soundstation go-librespot[10958]: time="2025-12-09T00:12:42-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:12:42 northpi-soundstation go-librespot[10958]: time="2025-12-09T00:12:42-05:00" level=debug msg="completed keyexchange"
Dec 09 00:12:42 northpi-soundstation go-librespot[10958]: time="2025-12-09T00:12:42-05:00" level=debug msg="completed challenge"
Dec 09 00:12:42 northpi-soundstation go-librespot[10958]: time="2025-12-09T00:12:42-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 09 00:12:42 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:12:42 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:12:42 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:12:42 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:12:45 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:12:45 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:12:45 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 119.
Dec 09 00:12:45 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:45 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:45 northpi-soundstation go-librespot[10965]: go-librespot daemon starting...
Dec 09 00:12:45 northpi-soundstation go-librespot[10966]: time="2025-12-09T00:12:45-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:12:45 northpi-soundstation go-librespot[10966]: time="2025-12-09T00:12:45-05:00" level=debug msg="app state loaded"
Dec 09 00:12:45 northpi-soundstation go-librespot[10966]: time="2025-12-09T00:12:45-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:12:45 northpi-soundstation go-librespot[10966]: time="2025-12-09T00:12: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-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 09 00:12:45 northpi-soundstation go-librespot[10966]: time="2025-12-09T00:12:45-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 09 00:12:45 northpi-soundstation go-librespot[10966]: time="2025-12-09T00:12:45-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 09 00:12:45 northpi-soundstation go-librespot[10966]: time="2025-12-09T00:12:45-05:00" level=info msg="zeroconf server listening on port 40399"
Dec 09 00:12:45 northpi-soundstation go-librespot[10966]: time="2025-12-09T00:12:45-05:00" level=debug msg="obtained new client token: AAD3JsttYbEKRPoYSA1M9ryacFzvX8lJVbEP2cUNoYg2sV5nH/XSlzlE0v0zXtAm9bpPOBDE5uv3TgHL0sS7dNlUmN0JYd7MgluvkgIMt/Iyv+MvVl0J/7DOjk2QaW1lqxScsMx1gVocDxasGqrc1lemI9agxl8DY0hBklVaiC0j89m/gk6lxX1A6dUnZJIreOasFK187lTZ1xW8bS75bIklivddttsxgmr62vpFAp1PS4bPxxDcQDgc2w=="
Dec 09 00:12:45 northpi-soundstation go-librespot[10966]: time="2025-12-09T00:12:45-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:12:45 northpi-soundstation go-librespot[10966]: time="2025-12-09T00:12:45-05:00" level=debug msg="completed keyexchange"
Dec 09 00:12:45 northpi-soundstation go-librespot[10966]: time="2025-12-09T00:12:45-05:00" level=debug msg="completed challenge"
Dec 09 00:12:45 northpi-soundstation go-librespot[10966]: time="2025-12-09T00:12: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 09 00:12:45 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:12:45 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:12:48 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:12:48 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:12:48 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 120.
Dec 09 00:12:48 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:48 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:48 northpi-soundstation go-librespot[10988]: go-librespot daemon starting...
Dec 09 00:12:48 northpi-soundstation go-librespot[10989]: time="2025-12-09T00:12:48-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:12:48 northpi-soundstation go-librespot[10989]: time="2025-12-09T00:12:48-05:00" level=debug msg="app state loaded"
Dec 09 00:12:48 northpi-soundstation go-librespot[10989]: time="2025-12-09T00:12:48-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:12:49 northpi-soundstation go-librespot[10989]: time="2025-12-09T00:12:49-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]"
Dec 09 00:12:49 northpi-soundstation go-librespot[10989]: time="2025-12-09T00:12:49-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 09 00:12:49 northpi-soundstation go-librespot[10989]: time="2025-12-09T00:12:49-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 09 00:12:49 northpi-soundstation go-librespot[10989]: time="2025-12-09T00:12:49-05:00" level=info msg="zeroconf server listening on port 42781"
Dec 09 00:12:49 northpi-soundstation go-librespot[10989]: time="2025-12-09T00:12:49-05:00" level=debug msg="obtained new client token: AAApcuAHVtdN49fBDsT/LtsQo2acn/br0W3W44+z9NIP7yPggDlrkuT+k0RNSPOIbfThM/rypoYcZ/fwpBLgBPwMcrJEgJu4I2GfR//HBN5jOri5qYyUxgle7fEjhy7/UDnTuNOdX81rdZDKpjF7zUw3qNRd6Yfkih0ewjL2t/FAHq/xhXKysCQO8rj9WmmiadkkMfPzUCea9p2Lt6qhenohg5LkF6fA1tAyPIzxM+pqhcWj5vbZ/1I="
Dec 09 00:12:49 northpi-soundstation go-librespot[10989]: time="2025-12-09T00:12:49-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:12:49 northpi-soundstation go-librespot[10989]: time="2025-12-09T00:12:49-05:00" level=debug msg="completed keyexchange"
Dec 09 00:12:49 northpi-soundstation go-librespot[10989]: time="2025-12-09T00:12:49-05:00" level=debug msg="completed challenge"
Dec 09 00:12:49 northpi-soundstation go-librespot[10989]: time="2025-12-09T00:12: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 09 00:12:49 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:12:49 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:12:51 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:12:51 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:12:52 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetState
Dec 09 00:12:52 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 121.
Dec 09 00:12:52 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:52 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:52 northpi-soundstation go-librespot[10997]: go-librespot daemon starting...
Dec 09 00:12:52 northpi-soundstation go-librespot[10998]: time="2025-12-09T00:12:52-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:12:52 northpi-soundstation go-librespot[10998]: time="2025-12-09T00:12:52-05:00" level=debug msg="app state loaded"
Dec 09 00:12:52 northpi-soundstation go-librespot[10998]: time="2025-12-09T00:12:52-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:12:52 northpi-soundstation go-librespot[10998]: time="2025-12-09T00:12: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-gew4.spotify.com:80]"
Dec 09 00:12:52 northpi-soundstation go-librespot[10998]: time="2025-12-09T00:12:52-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 09 00:12:52 northpi-soundstation go-librespot[10998]: time="2025-12-09T00:12:52-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 09 00:12:52 northpi-soundstation go-librespot[10998]: time="2025-12-09T00:12:52-05:00" level=info msg="zeroconf server listening on port 38789"
Dec 09 00:12:52 northpi-soundstation go-librespot[10998]: time="2025-12-09T00:12:52-05:00" level=debug msg="obtained new client token: AAAGDmUwW/n4fbXDri4e+voNuCQYcDguKkYy8BgwNM3Qc+PNduqtgJ2lWeQ4KRxAu3aBdexGfiUllH4pVlSY79jdZd4K2kE55xesHwhW2xVJYZEi3xTfBYxH/u+/huOP4NOh+XJ9lu4qGtaY7Og350JKvHGD8Cg7jN4l7RlPI3p2SbJEPF+eszrlaZzJ90+9V8tJQEb2YPCv9lgNHCy6vfO4cCUEV0f6FA8x6haeZoKmsJjFGX+Ox2QRaQ=="
Dec 09 00:12:53 northpi-soundstation go-librespot[10998]: time="2025-12-09T00:12:53-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:12:53 northpi-soundstation go-librespot[10998]: time="2025-12-09T00:12:53-05:00" level=debug msg="completed keyexchange"
Dec 09 00:12:53 northpi-soundstation go-librespot[10998]: time="2025-12-09T00:12:53-05:00" level=debug msg="completed challenge"
Dec 09 00:12:53 northpi-soundstation go-librespot[10998]: time="2025-12-09T00:12:53-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 09 00:12:53 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:12:53 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:12:54 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:12:54 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:12:56 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 122.
Dec 09 00:12:56 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:56 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:56 northpi-soundstation go-librespot[11019]: go-librespot daemon starting...
Dec 09 00:12:56 northpi-soundstation go-librespot[11020]: time="2025-12-09T00:12:56-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:12:56 northpi-soundstation go-librespot[11020]: time="2025-12-09T00:12:56-05:00" level=debug msg="app state loaded"
Dec 09 00:12:56 northpi-soundstation go-librespot[11020]: time="2025-12-09T00:12:56-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:12:56 northpi-soundstation go-librespot[11020]: time="2025-12-09T00:12: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-gae2.spotify.com:443 ap-gew1.spotify.com:80]"
Dec 09 00:12:56 northpi-soundstation go-librespot[11020]: time="2025-12-09T00:12:56-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 09 00:12:56 northpi-soundstation go-librespot[11020]: time="2025-12-09T00:12:56-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 09 00:12:56 northpi-soundstation go-librespot[11020]: time="2025-12-09T00:12:56-05:00" level=info msg="zeroconf server listening on port 38787"
Dec 09 00:12:56 northpi-soundstation go-librespot[11020]: time="2025-12-09T00:12:56-05:00" level=debug msg="obtained new client token: AACVQ0QO+TqVqVjz/IEe4fmx1pt6LCC3z5P0z7XipV41ptf2cvbCxbTZd3FkW3x/Tcwrf17b/jt6mnFgDl5z+0Yu8t8h1MVxn3RO3B4GBkYC4FBJVD7TyOKgdcPfy0exsNTu6ktPAksIwPUFyGi5wld05h8UU+KYnOXyH030x0GGMOrXX1FPpIR5+NWCKM/HnJRGQOt7hf1x81mWwyh+Uy/wBsRpGecHinAsE+WDBDw7CS6EvYO/X8bcTA=="
Dec 09 00:12:56 northpi-soundstation go-librespot[11020]: time="2025-12-09T00:12:56-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:12:56 northpi-soundstation go-librespot[11020]: time="2025-12-09T00:12:56-05:00" level=debug msg="completed keyexchange"
Dec 09 00:12:56 northpi-soundstation go-librespot[11020]: time="2025-12-09T00:12:56-05:00" level=debug msg="completed challenge"
Dec 09 00:12:56 northpi-soundstation go-librespot[11020]: time="2025-12-09T00:12: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 09 00:12:56 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:12:56 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:12:57 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:12:57 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:12:59 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 123.
Dec 09 00:12:59 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:59 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:12:59 northpi-soundstation go-librespot[11028]: go-librespot daemon starting...
Dec 09 00:12:59 northpi-soundstation go-librespot[11029]: time="2025-12-09T00:12:59-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:12:59 northpi-soundstation go-librespot[11029]: time="2025-12-09T00:12:59-05:00" level=debug msg="app state loaded"
Dec 09 00:12:59 northpi-soundstation go-librespot[11029]: time="2025-12-09T00:12:59-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:12:59 northpi-soundstation volumio[10289]: info: UPDATER: Scheduling automatic update
Dec 09 00:12:59 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStartTime
Dec 09 00:12:59 northpi-soundstation volumio[10289]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStopTime
Dec 09 00:12:59 northpi-soundstation volumio[10289]: info: UPDATER: Auto update will take place at: Wed Dec 10 2025 03:35:44 GMT-0500 (Eastern Standard Time)
Dec 09 00:12:59 northpi-soundstation go-librespot[11029]: time="2025-12-09T00:12: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-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 09 00:12:59 northpi-soundstation go-librespot[11029]: time="2025-12-09T00:12:59-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 09 00:12:59 northpi-soundstation go-librespot[11029]: time="2025-12-09T00:12:59-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 09 00:12:59 northpi-soundstation go-librespot[11029]: time="2025-12-09T00:12:59-05:00" level=info msg="zeroconf server listening on port 45077"
Dec 09 00:13:00 northpi-soundstation go-librespot[11029]: time="2025-12-09T00:13:00-05:00" level=debug msg="obtained new client token: AACumKzD7FwfCvdMTpRhhF86EixAl5r9oauizD5JCIYp01M9ZrP2pWqaczd6rraN9N10qR5b+0AmJAyqMR5R+3G2VZv/jWoFUWMtTS5TozvVOGzJVuFJxvFOlYHCCmohNfVXfpleRouSiVrBhaanDHydHidM0U4sgSar3HDWuP5xYIm53re7nkALVDDkGWJSWsCnWMI/cPXDwSWK0hRFOoQ1WWRkSIzP0PqTq5H0UrzmXTqgJJdqBnU="
Dec 09 00:13:00 northpi-soundstation go-librespot[11029]: time="2025-12-09T00:13:00-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:13:00 northpi-soundstation go-librespot[11029]: time="2025-12-09T00:13:00-05:00" level=debug msg="completed keyexchange"
Dec 09 00:13:00 northpi-soundstation go-librespot[11029]: time="2025-12-09T00:13:00-05:00" level=debug msg="completed challenge"
Dec 09 00:13:00 northpi-soundstation go-librespot[11029]: time="2025-12-09T00:13: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 09 00:13:00 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:13:00 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:13:00 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:13:00 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:13:01 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetState
Dec 09 00:13:02 northpi-soundstation volumio[10289]: info: Listing playlists
Dec 09 00:13:02 northpi-soundstation volumio[10289]: info: Listing playlists
Dec 09 00:13:03 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:13:03 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:13:03 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 124.
Dec 09 00:13:03 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:13:03 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:13:03 northpi-soundstation go-librespot[11040]: go-librespot daemon starting...
Dec 09 00:13:03 northpi-soundstation go-librespot[11041]: time="2025-12-09T00:13:03-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:13:03 northpi-soundstation go-librespot[11041]: time="2025-12-09T00:13:03-05:00" level=debug msg="app state loaded"
Dec 09 00:13:03 northpi-soundstation go-librespot[11041]: time="2025-12-09T00:13:03-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:13:03 northpi-soundstation go-librespot[11041]: time="2025-12-09T00:13: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 09 00:13:03 northpi-soundstation go-librespot[11041]: time="2025-12-09T00:13: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 09 00:13:03 northpi-soundstation go-librespot[11041]: time="2025-12-09T00:13: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 09 00:13:03 northpi-soundstation go-librespot[11041]: time="2025-12-09T00:13:03-05:00" level=info msg="zeroconf server listening on port 46309"
Dec 09 00:13:03 northpi-soundstation go-librespot[11041]: time="2025-12-09T00:13:03-05:00" level=debug msg="obtained new client token: AABeYgrZW5ignwgMkiEby6j3sg6iqfSK0lMm6Wre6WWtV4UYp8LIo0pou2k1UInCUsqHH/G3qKsrqvXE+gUjI989WELdqB0TYRKY9uicRLTHAUFZBnhsrPg4H/vAzL1L+JO5AfR5m9Zu3H47BrjeIRnC2iAXMBQfDoDPhUdfK4q+V7+RnR41G7DzyRm8gSKwWwOFDohNreh2REnKXNphIzgSld5C159rQSCcMqnuMLn1qGZnloOhkg5sig=="
Dec 09 00:13:03 northpi-soundstation go-librespot[11041]: time="2025-12-09T00:13:03-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:13:03 northpi-soundstation go-librespot[11041]: time="2025-12-09T00:13:03-05:00" level=debug msg="completed keyexchange"
Dec 09 00:13:03 northpi-soundstation go-librespot[11041]: time="2025-12-09T00:13:03-05:00" level=debug msg="completed challenge"
Dec 09 00:13:03 northpi-soundstation go-librespot[11041]: time="2025-12-09T00:13: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 09 00:13:03 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:13:03 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:13:06 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:13:06 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:13:06 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 125.
Dec 09 00:13:06 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:13:06 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:13:06 northpi-soundstation go-librespot[11062]: go-librespot daemon starting...
Dec 09 00:13:06 northpi-soundstation go-librespot[11063]: time="2025-12-09T00:13:06-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:13:06 northpi-soundstation go-librespot[11063]: time="2025-12-09T00:13:06-05:00" level=debug msg="app state loaded"
Dec 09 00:13:06 northpi-soundstation go-librespot[11063]: time="2025-12-09T00:13:06-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:13:07 northpi-soundstation go-librespot[11063]: time="2025-12-09T00:13: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-gew4.spotify.com:80]"
Dec 09 00:13:07 northpi-soundstation go-librespot[11063]: time="2025-12-09T00:13:07-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 09 00:13:07 northpi-soundstation go-librespot[11063]: time="2025-12-09T00:13:07-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 09 00:13:07 northpi-soundstation go-librespot[11063]: time="2025-12-09T00:13:07-05:00" level=info msg="zeroconf server listening on port 40549"
Dec 09 00:13:07 northpi-soundstation go-librespot[11063]: time="2025-12-09T00:13:07-05:00" level=debug msg="obtained new client token: AADIG+Yt6cx5oqIfAolQsAsa2SFd5FRxbCmCAF4wEnzdixUWkrtaFYsPTIcLXXTt3uR5SEzBXPZ1oz/zAMpjDjWYNK70Mh7opj6jdtUpquLliPHanicN76XwCN6FKGCS8pnokZa/gFAlAvnoYaQNXgCAzrJuplY0+voDOzbcg3k03K2gRoV/x7Xik43s/P9rxENnfOKZrfHTdUz2oW1pMib0xbWZVPehIqh0lOWuIRZuMFEcsuMIck4="
Dec 09 00:13:07 northpi-soundstation go-librespot[11063]: time="2025-12-09T00:13:07-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:13:07 northpi-soundstation go-librespot[11063]: time="2025-12-09T00:13:07-05:00" level=debug msg="completed keyexchange"
Dec 09 00:13:07 northpi-soundstation go-librespot[11063]: time="2025-12-09T00:13:07-05:00" level=debug msg="completed challenge"
Dec 09 00:13:07 northpi-soundstation go-librespot[11063]: time="2025-12-09T00:13: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 09 00:13:07 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:13:07 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:13:09 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:13:09 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:13:10 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 126.
Dec 09 00:13:10 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:13:10 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:13:10 northpi-soundstation go-librespot[11070]: go-librespot daemon starting...
Dec 09 00:13:10 northpi-soundstation go-librespot[11071]: time="2025-12-09T00:13:10-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:13:10 northpi-soundstation go-librespot[11071]: time="2025-12-09T00:13:10-05:00" level=debug msg="app state loaded"
Dec 09 00:13:10 northpi-soundstation go-librespot[11071]: time="2025-12-09T00:13:10-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:13:10 northpi-soundstation go-librespot[11071]: time="2025-12-09T00:13: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 09 00:13:10 northpi-soundstation go-librespot[11071]: time="2025-12-09T00:13: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 09 00:13:10 northpi-soundstation go-librespot[11071]: time="2025-12-09T00:13: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 09 00:13:10 northpi-soundstation go-librespot[11071]: time="2025-12-09T00:13:10-05:00" level=info msg="zeroconf server listening on port 43797"
Dec 09 00:13:10 northpi-soundstation go-librespot[11071]: time="2025-12-09T00:13:10-05:00" level=debug msg="obtained new client token: AADZsN3D3UURUKXB7dsZ3PboIkWNnv9/OPlKxSK5Z3O7QM1f1EyrIpBlxwNoRfavFQvUP+SZDJh0AStCRNW0iQfRpqKXy5mnmTr5AarCX00tob5kWcIyI0GkHfR5btsAYSmTQpbeF45k10sJztRwBmsEbRk7g9XXdmmvUvkpV4HJi1knrUKTeIUSdQW9kDKKjBe1jW+aU5y2q72Oj/4tsjl53ExrbzNlczllZ+tFNmeUO8bDG7277Q4n/g=="
Dec 09 00:13:10 northpi-soundstation go-librespot[11071]: time="2025-12-09T00:13:10-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:13:10 northpi-soundstation go-librespot[11071]: time="2025-12-09T00:13:10-05:00" level=debug msg="completed keyexchange"
Dec 09 00:13:10 northpi-soundstation go-librespot[11071]: time="2025-12-09T00:13:10-05:00" level=debug msg="completed challenge"
Dec 09 00:13:10 northpi-soundstation go-librespot[11071]: time="2025-12-09T00:13:10-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 09 00:13:10 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:13:10 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:13:11 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetState
Dec 09 00:13:12 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:13:12 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:13:14 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 127.
Dec 09 00:13:14 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:13:14 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:13:14 northpi-soundstation go-librespot[11078]: go-librespot daemon starting...
Dec 09 00:13:14 northpi-soundstation go-librespot[11079]: time="2025-12-09T00:13:14-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:13:14 northpi-soundstation go-librespot[11079]: time="2025-12-09T00:13:14-05:00" level=debug msg="app state loaded"
Dec 09 00:13:14 northpi-soundstation go-librespot[11079]: time="2025-12-09T00:13:14-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:13:14 northpi-soundstation go-librespot[11079]: time="2025-12-09T00:13: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 09 00:13:14 northpi-soundstation go-librespot[11079]: time="2025-12-09T00:13: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 09 00:13:14 northpi-soundstation go-librespot[11079]: time="2025-12-09T00:13: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 09 00:13:14 northpi-soundstation go-librespot[11079]: time="2025-12-09T00:13:14-05:00" level=info msg="zeroconf server listening on port 38047"
Dec 09 00:13:14 northpi-soundstation go-librespot[11079]: time="2025-12-09T00:13:14-05:00" level=debug msg="obtained new client token: AABQQCb/5AWOO/gFdbhyk1IBk+txi4aEhwa/dFJCu7bV6+UBcpHGWTrtEzzimdcam43D5rnTC3dPxM04F+Zeth9VVt98GiEYARqFu9y2fuZORmmhFH457BskU+Ogn/X/YLMD8bL+gXQLINTZK+TldkWXkQYT+ksshztq22y7nmRgdearHcsuob0D4LDZrJ6nFKssvdZJcyCGlOo2tSttjf8Is/7rSa5ZlGDlD1IafzteISowR+fdyX3a/g=="
Dec 09 00:13:14 northpi-soundstation go-librespot[11079]: time="2025-12-09T00:13:14-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:13:14 northpi-soundstation go-librespot[11079]: time="2025-12-09T00:13:14-05:00" level=debug msg="completed keyexchange"
Dec 09 00:13:14 northpi-soundstation go-librespot[11079]: time="2025-12-09T00:13:14-05:00" level=debug msg="completed challenge"
Dec 09 00:13:14 northpi-soundstation go-librespot[11079]: time="2025-12-09T00:13: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 09 00:13:14 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:13:14 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:13:15 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:13:15 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:13:17 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 128.
Dec 09 00:13:17 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:13:17 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:13:17 northpi-soundstation go-librespot[11100]: go-librespot daemon starting...
Dec 09 00:13:17 northpi-soundstation go-librespot[11101]: time="2025-12-09T00:13:17-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:13:17 northpi-soundstation go-librespot[11101]: time="2025-12-09T00:13:17-05:00" level=debug msg="app state loaded"
Dec 09 00:13:17 northpi-soundstation go-librespot[11101]: time="2025-12-09T00:13:17-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:13:17 northpi-soundstation go-librespot[11101]: time="2025-12-09T00:13:17-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 09 00:13:17 northpi-soundstation go-librespot[11101]: time="2025-12-09T00:13:17-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Dec 09 00:13:17 northpi-soundstation go-librespot[11101]: time="2025-12-09T00:13:17-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Dec 09 00:13:17 northpi-soundstation go-librespot[11101]: time="2025-12-09T00:13:17-05:00" level=info msg="zeroconf server listening on port 41923"
Dec 09 00:13:18 northpi-soundstation go-librespot[11101]: time="2025-12-09T00:13:18-05:00" level=debug msg="obtained new client token: AACWDPIqUfTo/FU0NUV5Ow1NUXZeAfCB6i1gjNe0JpHyQQR/lTImY9O/beR7WHy9odhYWRU559iOetqweaxC1ljpewuJGRHSZneCcBnNTDio26f4qWwNm0A2TKpnRt6vLrxn+OLTh9QMmxVex0JiMK9dZYyZ2PNBGlTfDqhzHOM997ZJYOM6R3oV9O9WMcquzlHfNfFe0Xctthv17LVuMfYvoEAEtI6dWkmg5O2L6LiU6rkZc61I6F+V9A=="
Dec 09 00:13:18 northpi-soundstation go-librespot[11101]: time="2025-12-09T00:13:18-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:13:18 northpi-soundstation go-librespot[11101]: time="2025-12-09T00:13:18-05:00" level=debug msg="completed keyexchange"
Dec 09 00:13:18 northpi-soundstation go-librespot[11101]: time="2025-12-09T00:13:18-05:00" level=debug msg="completed challenge"
Dec 09 00:13:18 northpi-soundstation go-librespot[11101]: time="2025-12-09T00:13:18-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 09 00:13:18 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:13:18 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:13:18 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:13:18 northpi-soundstation volumio[10289]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:13:21 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 129.
Dec 09 00:13:21 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:13:21 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:13:21 northpi-soundstation go-librespot[11109]: go-librespot daemon starting...
Dec 09 00:13:21 northpi-soundstation go-librespot[11110]: time="2025-12-09T00:13:21-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:13:21 northpi-soundstation go-librespot[11110]: time="2025-12-09T00:13:21-05:00" level=debug msg="app state loaded"
Dec 09 00:13:21 northpi-soundstation go-librespot[11110]: time="2025-12-09T00:13:21-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:13:21 northpi-soundstation volumio[10289]: info: Initializing connection to go-librespot Websocket
Dec 09 00:13:21 northpi-soundstation go-librespot[11110]: time="2025-12-09T00:13:21-05:00" level=debug msg="new websocket client"
Dec 09 00:13:21 northpi-soundstation volumio[10289]: info: Connection to go-librespot Websocket established
Dec 09 00:13:21 northpi-soundstation go-librespot[11110]: time="2025-12-09T00:13:21-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]"
Dec 09 00:13:21 northpi-soundstation go-librespot[11110]: time="2025-12-09T00:13:21-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Dec 09 00:13:21 northpi-soundstation go-librespot[11110]: time="2025-12-09T00:13:21-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Dec 09 00:13:21 northpi-soundstation go-librespot[11110]: time="2025-12-09T00:13:21-05:00" level=info msg="zeroconf server listening on port 40115"
Dec 09 00:13:21 northpi-soundstation go-librespot[11110]: time="2025-12-09T00:13:21-05:00" level=debug msg="obtained new client token: AAAGAfuD/8tmQbWDNTtA1aF9fLcVrsi9HDabyDyUvTXQICMgbihsvLHS6Hz9pAZXvWzydlFHWQU+DFEPpv4W82gZwmyBDAx9fSW9LhIXUlN2SuUT/tR1mh2V6g6+SLLON9R79Km6oLD47HQ6TXRT/qb0Ux9UazNjGcSBDDiYDqOnR2MPJ21y9Q5WAfwzVuuhBJue8J8nb/FXIlUrrX3GVLXGJj0ZJMrTbZyzPQkrubvZCsdHLlnImbbS2A=="
Dec 09 00:13:21 northpi-soundstation go-librespot[11110]: time="2025-12-09T00:13:21-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070"
Dec 09 00:13:21 northpi-soundstation go-librespot[11110]: time="2025-12-09T00:13:21-05:00" level=debug msg="completed keyexchange"
Dec 09 00:13:21 northpi-soundstation go-librespot[11110]: time="2025-12-09T00:13:21-05:00" level=debug msg="completed challenge"
Dec 09 00:13:21 northpi-soundstation go-librespot[11110]: time="2025-12-09T00:13:21-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: BadCredentials "
Dec 09 00:13:21 northpi-soundstation volumio[10289]: info: Connection to go-librespot Websocket closed
Dec 09 00:13:21 northpi-soundstation systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 09 00:13:21 northpi-soundstation systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 09 00:13:21 northpi-soundstation volumio[10289]: info: CoreCommandRouter::volumioGetState
Dec 09 00:13:22 northpi-soundstation volumio[10289]: info: Listing playlists
Dec 09 00:13:22 northpi-soundstation volumio[10289]: info: Listing playlists
Dec 09 00:13:24 northpi-soundstation volumio[10289]: info: Getting Spotify volume
Dec 09 00:13:24 northpi-soundstation volumio[10289]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 09 00:13:24 northpi-soundstation volumio[10289]: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 09 00:13:24 northpi-soundstation volumio[10289]:     at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Dec 09 00:13:24 northpi-soundstation volumio[10289]:   errno: -111,
Dec 09 00:13:24 northpi-soundstation volumio[10289]:   code: 'ECONNREFUSED',
Dec 09 00:13:24 northpi-soundstation volumio[10289]:   syscall: 'connect',
Dec 09 00:13:24 northpi-soundstation volumio[10289]:   address: '127.0.0.1',
Dec 09 00:13:24 northpi-soundstation volumio[10289]:   port: 9879,
Dec 09 00:13:24 northpi-soundstation volumio[10289]:   response: undefined
Dec 09 00:13:24 northpi-soundstation volumio[10289]: }
Dec 09 00:13:24 northpi-soundstation volumio[10289]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 09 00:13:24 northpi-soundstation systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 130.
Dec 09 00:13:24 northpi-soundstation systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:13:24 northpi-soundstation systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 09 00:13:24 northpi-soundstation go-librespot[11132]: go-librespot daemon starting...
Dec 09 00:13:24 northpi-soundstation go-librespot[11133]: time="2025-12-09T00:13:24-05:00" level=info msg="running go-librespot 0.3.2"
Dec 09 00:13:24 northpi-soundstation go-librespot[11133]: time="2025-12-09T00:13:24-05:00" level=debug msg="app state loaded"
Dec 09 00:13:24 northpi-soundstation go-librespot[11133]: time="2025-12-09T00:13:24-05:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 09 00:13:24 northpi-soundstation sudo[11141]:  volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-09 00:12'
Dec 09 00:13:24 northpi-soundstation sudo[11141]: 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"