-- Logs begin at Mon 2026-10-12 01:17:00 CEST, end at Mon 2026-10-12 01:38:11 CEST. -- Oct 12 01:37:01 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::volumioGetState Oct 12 01:37:01 schlafzimmer-jonas volumio[971]: info: CorePlayQueue::getTrack 6 Oct 12 01:37:04 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 12 01:37:04 schlafzimmer-jonas volumio[971]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 12 01:37:04 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 12 01:37:04 schlafzimmer-jonas volumio[971]: info: Received Get System Version Oct 12 01:37:04 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 01:37:04 schlafzimmer-jonas volumio[971]: info: Received Get System Info Oct 12 01:37:04 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 01:37:04 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 01:37:04 schlafzimmer-jonas volumio[971]: info: Discovery: Getting this device information Oct 12 01:37:04 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::volumioGetState Oct 12 01:37:04 schlafzimmer-jonas volumio[971]: info: CorePlayQueue::getTrack 6 Oct 12 01:37:04 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 01:37:06 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 01:37:06 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 12 01:37:07 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 12 01:37:07 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 12 01:37:07 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Oct 12 01:37:07 schlafzimmer-jonas volumio[971]: info: Received Get System Version Oct 12 01:37:07 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 01:37:11 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::volumioGetState Oct 12 01:37:11 schlafzimmer-jonas volumio[971]: info: CorePlayQueue::getTrack 6 Oct 12 01:37:11 schlafzimmer-jonas volumio[971]: info: Listing playlists Oct 12 01:37:11 schlafzimmer-jonas volumio[971]: info: Listing playlists Oct 12 01:37:12 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 01:37:12 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 12 01:37:18 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 01:37:21 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::volumioGetState Oct 12 01:37:21 schlafzimmer-jonas volumio[971]: info: CorePlayQueue::getTrack 6 Oct 12 01:37:31 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::volumioGetState Oct 12 01:37:31 schlafzimmer-jonas volumio[971]: info: CorePlayQueue::getTrack 6 Oct 12 01:37:31 schlafzimmer-jonas volumio[971]: info: Listing playlists Oct 12 01:37:31 schlafzimmer-jonas volumio[971]: info: Listing playlists Oct 12 01:37:32 schlafzimmer-jonas volumiologrotate[591]: ls: cannot access '/var/log/samba/log.wb-SCHLAFZIMMER': No such file or directory Oct 12 01:37:32 schlafzimmer-jonas volumiologrotate[591]: ls: cannot access 'JONAS': No such file or directory Oct 12 01:37:41 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::volumioGetState Oct 12 01:37:41 schlafzimmer-jonas volumio[971]: info: CorePlayQueue::getTrack 6 Oct 12 01:37:49 schlafzimmer-jonas volumio[971]: info: CALLMETHOD: music_service spop saveGoLibrespotSettings [object Object] Oct 12 01:37:49 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: spop , saveGoLibrespotSettings Oct 12 01:37:49 schlafzimmer-jonas volumio[971]: info: Creating Spotify config file Oct 12 01:37:49 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 01:37:49 schlafzimmer-jonas volumio[971]: info: Spotify config file written Oct 12 01:37:50 schlafzimmer-jonas sudo[26554]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Oct 12 01:37:50 schlafzimmer-jonas sudo[26554]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 01:37:50 schlafzimmer-jonas systemd[1]: Stopping go-librespot Daemon... Oct 12 01:37:50 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Oct 12 01:37:50 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Succeeded. Oct 12 01:37:50 schlafzimmer-jonas systemd[1]: Stopped go-librespot Daemon. Oct 12 01:37:50 schlafzimmer-jonas volumio[971]: error: Failed to send command to Spotify local API: /player/add_to_queue: Error: socket hang up Oct 12 01:37:50 schlafzimmer-jonas volumio[971]: (node:971) UnhandledPromiseRejectionWarning: Error: socket hang up Oct 12 01:37:50 schlafzimmer-jonas volumio[971]: at connResetException (internal/errors.js:607:14) Oct 12 01:37:50 schlafzimmer-jonas volumio[971]: at Socket.socketOnEnd (_http_client.js:493:23) Oct 12 01:37:50 schlafzimmer-jonas volumio[971]: at Socket.emit (events.js:327:22) Oct 12 01:37:50 schlafzimmer-jonas volumio[971]: at endReadableNT (internal/streams/readable.js:1327:12) Oct 12 01:37:50 schlafzimmer-jonas volumio[971]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Oct 12 01:37:50 schlafzimmer-jonas volumio[971]: (node:971) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 18848) Oct 12 01:37:50 schlafzimmer-jonas volumio[971]: info: Connection to go-librespot Websocket closed Oct 12 01:37:50 schlafzimmer-jonas systemd[1]: Started go-librespot Daemon. Oct 12 01:37:50 schlafzimmer-jonas go-librespot[26556]: go-librespot daemon starting... Oct 12 01:37:50 schlafzimmer-jonas sudo[26554]: pam_unix(sudo:session): session closed for user root Oct 12 01:37:50 schlafzimmer-jonas go-librespot[26556]: time="2026-10-12T01:37:50+02:00" level=info msg="running go-librespot 0.7.1" Oct 12 01:37:50 schlafzimmer-jonas go-librespot[26556]: time="2026-10-12T01:37:50+02:00" level=debug msg="app state loaded" Oct 12 01:37:50 schlafzimmer-jonas go-librespot[26556]: time="2026-10-12T01:37:50+02:00" level=debug msg="stored credentials not found" Oct 12 01:37:50 schlafzimmer-jonas go-librespot[26556]: time="2026-10-12T01:37:50+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 01:37:50 schlafzimmer-jonas go-librespot[26556]: time="2026-10-12T01:37:50+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 12 01:37:50 schlafzimmer-jonas go-librespot[26556]: time="2026-10-12T01:37:50+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 12 01:37:50 schlafzimmer-jonas go-librespot[26556]: time="2026-10-12T01:37:50+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 12 01:37:50 schlafzimmer-jonas go-librespot[26556]: time="2026-10-12T01:37:50+02:00" level=info msg="zeroconf server listening on port 44363" Oct 12 01:37:50 schlafzimmer-jonas go-librespot[26556]: time="2026-10-12T01:37:50+02:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Oct 12 01:37:50 schlafzimmer-jonas go-librespot[26556]: time="2026-10-12T01:37:50+02:00" level=debug msg="obtained new client token: AAECOjJOUMxPDapCNgbPLva4XAsXNmVg55+hB/Hcvom8y6zsm4Murrzu4L/xV3PzgYUeAAxM9iE8mPB+nhnPwGVSq7utSGIWb+9fE+iRdelZQ9cx5OPyd2AZ8PuVgWcnhz6Q3e68CdeLnha/gPFdnvc1+PR1rCFBeLTBpv1xIWYJwKzsy9nY+fOkF55mKnTEWAicSKXZqH5PFgMqS3nCPPjVWoK73HuosDNy5xXHfxadcyksmmMkdeY=" Oct 12 01:37:50 schlafzimmer-jonas go-librespot[26556]: time="2026-10-12T01:37:50+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 01:37:50 schlafzimmer-jonas go-librespot[26556]: time="2026-10-12T01:37:50+02:00" level=debug msg="completed keyexchange" Oct 12 01:37:50 schlafzimmer-jonas go-librespot[26556]: time="2026-10-12T01:37:50+02:00" level=debug msg="completed challenge" Oct 12 01:37:50 schlafzimmer-jonas go-librespot[26556]: time="2026-10-12T01:37:50+02:00" level=info msg="authenticated AP" username="31************************3e" Oct 12 01:37:50 schlafzimmer-jonas go-librespot[26556]: time="2026-10-12T01:37:50+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 01:37:50 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 01:37:50 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 01:37:51 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::volumioGetState Oct 12 01:37:51 schlafzimmer-jonas volumio[971]: info: CorePlayQueue::getTrack 6 Oct 12 01:37:51 schlafzimmer-jonas volumio[971]: info: Listing playlists Oct 12 01:37:51 schlafzimmer-jonas volumio[971]: info: Listing playlists Oct 12 01:37:52 schlafzimmer-jonas volumio[971]: info: CALLMETHOD: music_service spop saveGoLibrespotSettings [object Object] Oct 12 01:37:52 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: spop , saveGoLibrespotSettings Oct 12 01:37:52 schlafzimmer-jonas volumio[971]: info: Creating Spotify config file Oct 12 01:37:52 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 01:37:52 schlafzimmer-jonas volumio[971]: info: Spotify config file written Oct 12 01:37:52 schlafzimmer-jonas sudo[26567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Oct 12 01:37:52 schlafzimmer-jonas sudo[26567]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 01:37:52 schlafzimmer-jonas systemd[1]: Stopped go-librespot Daemon. Oct 12 01:37:52 schlafzimmer-jonas systemd[1]: Started go-librespot Daemon. Oct 12 01:37:52 schlafzimmer-jonas go-librespot[26569]: go-librespot daemon starting... Oct 12 01:37:52 schlafzimmer-jonas sudo[26567]: pam_unix(sudo:session): session closed for user root Oct 12 01:37:52 schlafzimmer-jonas go-librespot[26569]: time="2026-10-12T01:37:52+02:00" level=info msg="running go-librespot 0.7.1" Oct 12 01:37:52 schlafzimmer-jonas go-librespot[26569]: time="2026-10-12T01:37:52+02:00" level=debug msg="app state loaded" Oct 12 01:37:52 schlafzimmer-jonas go-librespot[26569]: time="2026-10-12T01:37:52+02:00" level=debug msg="stored credentials not found" Oct 12 01:37:52 schlafzimmer-jonas go-librespot[26569]: time="2026-10-12T01:37:52+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 01:37:52 schlafzimmer-jonas go-librespot[26569]: time="2026-10-12T01:37:52+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 12 01:37:52 schlafzimmer-jonas go-librespot[26569]: time="2026-10-12T01:37:52+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 12 01:37:52 schlafzimmer-jonas go-librespot[26569]: time="2026-10-12T01:37:52+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 12 01:37:52 schlafzimmer-jonas go-librespot[26569]: time="2026-10-12T01:37:52+02:00" level=info msg="zeroconf server listening on port 38261" Oct 12 01:37:52 schlafzimmer-jonas go-librespot[26569]: time="2026-10-12T01:37:52+02:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Oct 12 01:37:52 schlafzimmer-jonas go-librespot[26569]: time="2026-10-12T01:37:52+02:00" level=debug msg="obtained new client token: AAEVZhmhzykrHqq+Pyf1mLO+bInKIt9L8FByQ6v54eMRd4GNXIEhWt5W8NCflYVsJcsbdr5VK5733UAZrcSqARq+Y8YbifeNB5VvNNLy5x0hRf39IKox3kIxDSY0X2Z2+ZwUXrZ+CSdrnSghVjFjlryrHDJoGIQTNZqg115GSmUcWBg/vjI51QEi5dGbbm06+KDmtmXO0BvGfBa+RdIvveq9y3bfh6HRJzEMhXF7T/GhZwlXmiq59RA=" Oct 12 01:37:52 schlafzimmer-jonas go-librespot[26569]: time="2026-10-12T01:37:52+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 01:37:52 schlafzimmer-jonas go-librespot[26569]: time="2026-10-12T01:37:52+02:00" level=debug msg="completed keyexchange" Oct 12 01:37:52 schlafzimmer-jonas go-librespot[26569]: time="2026-10-12T01:37:52+02:00" level=debug msg="completed challenge" Oct 12 01:37:52 schlafzimmer-jonas go-librespot[26569]: time="2026-10-12T01:37:52+02:00" level=info msg="authenticated AP" username="31************************3e" Oct 12 01:37:52 schlafzimmer-jonas go-librespot[26569]: time="2026-10-12T01:37:52+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 01:37:52 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 01:37:52 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 01:37:53 schlafzimmer-jonas volumio[971]: info: Initializing connection to go-librespot Websocket Oct 12 01:37:53 schlafzimmer-jonas volumio[971]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 01:37:53 schlafzimmer-jonas volumio[971]: info: go-librespot daemon successfully initialized Oct 12 01:37:53 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 01:37:53 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 12 01:37:55 schlafzimmer-jonas volumio[971]: info: go-librespot daemon successfully initialized Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: info: Initializing connection to go-librespot Websocket Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 01:37:56 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 12 01:37:56 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Oct 12 01:37:56 schlafzimmer-jonas systemd[1]: Stopped go-librespot Daemon. Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: info: Initializing connection to go-librespot Websocket Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 01:37:56 schlafzimmer-jonas systemd[1]: Started go-librespot Daemon. Oct 12 01:37:56 schlafzimmer-jonas go-librespot[26579]: go-librespot daemon starting... Oct 12 01:37:56 schlafzimmer-jonas go-librespot[26579]: time="2026-10-12T01:37:56+02:00" level=info msg="running go-librespot 0.7.1" Oct 12 01:37:56 schlafzimmer-jonas go-librespot[26579]: time="2026-10-12T01:37:56+02:00" level=debug msg="app state loaded" Oct 12 01:37:56 schlafzimmer-jonas go-librespot[26579]: time="2026-10-12T01:37:56+02:00" level=debug msg="stored credentials not found" Oct 12 01:37:56 schlafzimmer-jonas go-librespot[26579]: time="2026-10-12T01:37:56+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 01:37:56 schlafzimmer-jonas go-librespot[26579]: time="2026-10-12T01:37:56+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 12 01:37:56 schlafzimmer-jonas go-librespot[26579]: time="2026-10-12T01:37:56+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 12 01:37:56 schlafzimmer-jonas go-librespot[26579]: time="2026-10-12T01:37:56+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 12 01:37:56 schlafzimmer-jonas go-librespot[26579]: time="2026-10-12T01:37:56+02:00" level=info msg="zeroconf server listening on port 41545" Oct 12 01:37:56 schlafzimmer-jonas go-librespot[26579]: time="2026-10-12T01:37:56+02:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Oct 12 01:37:56 schlafzimmer-jonas go-librespot[26579]: time="2026-10-12T01:37:56+02:00" level=debug msg="obtained new client token: AAHCXA/QKGwGCKsBl6PcdR7Buat3uO9kPH/ajkwX0CJJwtqLNsw83+oU4qMNVF3nis8FD1+j7N+NBk3OS3e9SDY+cNmBc5FTLDcZKZf0ntvtvwon8KuYFolk0w4bovpZolLiqkTp/drGBDFd0+J+gsJljBu+YcuMCCIpOC3OJWv5azzPzYfllJ87AYx3mbDzKjSUiTrY1b3wVFOLw3vZbFdip8K7YgIZ0uSbIQI7M6OkPuZM8yjY1d0=" Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: info: Enabling plugin spop Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: info: Loading plugin "spop"... Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: info: PLUGIN START: spop Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: info: Creating Spotify config file Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: info: Done. Oct 12 01:37:56 schlafzimmer-jonas go-librespot[26579]: time="2026-10-12T01:37:56+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: info: No need to fix Spotify hosts Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: info: Spotify config file written Oct 12 01:37:56 schlafzimmer-jonas go-librespot[26579]: time="2026-10-12T01:37:56+02:00" level=debug msg="completed keyexchange" Oct 12 01:37:56 schlafzimmer-jonas go-librespot[26579]: time="2026-10-12T01:37:56+02:00" level=debug msg="completed challenge" Oct 12 01:37:56 schlafzimmer-jonas sudo[26590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Oct 12 01:37:56 schlafzimmer-jonas sudo[26590]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 01:37:56 schlafzimmer-jonas systemd[1]: Stopping go-librespot Daemon... Oct 12 01:37:56 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Oct 12 01:37:56 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Succeeded. Oct 12 01:37:56 schlafzimmer-jonas systemd[1]: Stopped go-librespot Daemon. Oct 12 01:37:56 schlafzimmer-jonas systemd[1]: Started go-librespot Daemon. Oct 12 01:37:56 schlafzimmer-jonas go-librespot[26592]: go-librespot daemon starting... Oct 12 01:37:56 schlafzimmer-jonas sudo[26590]: pam_unix(sudo:session): session closed for user root Oct 12 01:37:56 schlafzimmer-jonas go-librespot[26592]: time="2026-10-12T01:37:56+02:00" level=info msg="running go-librespot 0.7.1" Oct 12 01:37:56 schlafzimmer-jonas go-librespot[26592]: time="2026-10-12T01:37:56+02:00" level=debug msg="app state loaded" Oct 12 01:37:56 schlafzimmer-jonas go-librespot[26592]: time="2026-10-12T01:37:56+02:00" level=debug msg="stored credentials not found" Oct 12 01:37:56 schlafzimmer-jonas go-librespot[26592]: time="2026-10-12T01:37:56+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: info: New Spotify access tokenBQAd3DJpgh... Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: info: Spotify credentials grant success - running version from March 24, 2019 Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: SPOTIFY: User informations: {"account_id":"j13c8GcUgv","country":"DE","display_name":"Indianer Jonas","email":"jonas.wurzschmitt@outlook.de","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/31yuebmmwgcg56oyg7buotgzqb3e"},"followers":{"href":null,"total":1},"href":"https://api.spotify.com/v1/users/31yuebmmwgcg56oyg7buotgzqb3e","id":"31yuebmmwgcg56oyg7buotgzqb3e","images":[{"height":300,"url":"https://i.scdn.co/image/ab6775700000ee85409ac42c5b039ae0187588e2","width":300},{"height":64,"url":"https://i.scdn.co/image/ab67757000003b82409ac42c5b039ae0187588e2","width":64}],"product":"premium","type":"user","uri":"spotify:user:31yuebmmwgcg56oyg7buotgzqb3e"} Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: info: Spotify Successfully logged in Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: info: [1791761876967] CoreMusicLibrary::Adding element Spotify Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 01:37:56 schlafzimmer-jonas volumio[971]: Cannot find translation for source Spotify Oct 12 01:37:57 schlafzimmer-jonas go-librespot[26592]: time="2026-10-12T01:37:57+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 01:37:57 schlafzimmer-jonas go-librespot[26592]: time="2026-10-12T01:37:57+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 01:37:57 schlafzimmer-jonas go-librespot[26592]: time="2026-10-12T01:37:57+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 01:37:57 schlafzimmer-jonas go-librespot[26592]: time="2026-10-12T01:37:57+02:00" level=info msg="zeroconf server listening on port 46201" Oct 12 01:37:57 schlafzimmer-jonas go-librespot[26592]: time="2026-10-12T01:37:57+02:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Oct 12 01:37:57 schlafzimmer-jonas go-librespot[26592]: time="2026-10-12T01:37:57+02:00" level=debug msg="obtained new client token: AAG+zX1nucfIF0mZFZG3XLfIH39xk6Pk//pOvg9od29ws9dilzuv5iExZ/9oIqRXsmB6PamQ4fvgTOx6puDyAH+VE3Wrm2Wa4OTTB0/q0HOF2VOq2iEPYyBdIgzH6gsjTmZFbRsgIycRJvF4UYjthNms9yBYtMxGKYuCsbOeIVYq52EKP3of++hRsP9C2kKCApzonbJXLGTF8zBS+mJ6HnYqUznMd3XnYycMOxI/atw9LczsJgxUK2I=" Oct 12 01:37:57 schlafzimmer-jonas go-librespot[26592]: time="2026-10-12T01:37:57+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 01:37:57 schlafzimmer-jonas go-librespot[26592]: time="2026-10-12T01:37:57+02:00" level=debug msg="completed keyexchange" Oct 12 01:37:57 schlafzimmer-jonas go-librespot[26592]: time="2026-10-12T01:37:57+02:00" level=debug msg="completed challenge" Oct 12 01:37:57 schlafzimmer-jonas go-librespot[26592]: time="2026-10-12T01:37:57+02:00" level=info msg="authenticated AP" username="31************************3e" Oct 12 01:37:57 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Oct 12 01:37:57 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 01:37:57 schlafzimmer-jonas volumio[971]: info: Disabling plugin spop Oct 12 01:37:57 schlafzimmer-jonas volumio[971]: info: Done. Oct 12 01:37:57 schlafzimmer-jonas sudo[26603]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop go-librespot-daemon.service Oct 12 01:37:57 schlafzimmer-jonas sudo[26603]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 01:37:57 schlafzimmer-jonas systemd[1]: Stopping go-librespot Daemon... Oct 12 01:37:57 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Oct 12 01:37:57 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Succeeded. Oct 12 01:37:57 schlafzimmer-jonas systemd[1]: Stopped go-librespot Daemon. Oct 12 01:37:57 schlafzimmer-jonas sudo[26603]: pam_unix(sudo:session): session closed for user root Oct 12 01:37:58 schlafzimmer-jonas volumio[971]: info: Initializing connection to go-librespot Websocket Oct 12 01:37:58 schlafzimmer-jonas volumio[971]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 01:37:59 schlafzimmer-jonas volumio[971]: info: Enabling plugin spop Oct 12 01:37:59 schlafzimmer-jonas volumio[971]: info: Loading plugin "spop"... Oct 12 01:37:59 schlafzimmer-jonas volumio[971]: info: PLUGIN START: spop Oct 12 01:37:59 schlafzimmer-jonas volumio[971]: info: Creating Spotify config file Oct 12 01:37:59 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 01:37:59 schlafzimmer-jonas volumio[971]: info: Done. Oct 12 01:37:59 schlafzimmer-jonas volumio[971]: info: Spotify config file written Oct 12 01:37:59 schlafzimmer-jonas volumio[971]: info: No need to fix Spotify hosts Oct 12 01:37:59 schlafzimmer-jonas sudo[26620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Oct 12 01:37:59 schlafzimmer-jonas sudo[26620]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 01:37:59 schlafzimmer-jonas systemd[1]: Started go-librespot Daemon. Oct 12 01:37:59 schlafzimmer-jonas go-librespot[26622]: go-librespot daemon starting... Oct 12 01:37:59 schlafzimmer-jonas sudo[26620]: pam_unix(sudo:session): session closed for user root Oct 12 01:37:59 schlafzimmer-jonas go-librespot[26622]: time="2026-10-12T01:37:59+02:00" level=info msg="running go-librespot 0.7.1" Oct 12 01:37:59 schlafzimmer-jonas go-librespot[26622]: time="2026-10-12T01:37:59+02:00" level=debug msg="app state loaded" Oct 12 01:37:59 schlafzimmer-jonas go-librespot[26622]: time="2026-10-12T01:37:59+02:00" level=debug msg="stored credentials not found" Oct 12 01:37:59 schlafzimmer-jonas go-librespot[26622]: time="2026-10-12T01:37:59+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 01:37:59 schlafzimmer-jonas volumio[971]: info: New Spotify access tokenBQDp2G_cj9... Oct 12 01:37:59 schlafzimmer-jonas volumio[971]: info: Spotify credentials grant success - running version from March 24, 2019 Oct 12 01:37:59 schlafzimmer-jonas volumio[971]: SPOTIFY: User informations: {"account_id":"j13c8GcUgv","country":"DE","display_name":"Indianer Jonas","email":"jonas.wurzschmitt@outlook.de","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/31yuebmmwgcg56oyg7buotgzqb3e"},"followers":{"href":null,"total":1},"href":"https://api.spotify.com/v1/users/31yuebmmwgcg56oyg7buotgzqb3e","id":"31yuebmmwgcg56oyg7buotgzqb3e","images":[{"height":300,"url":"https://i.scdn.co/image/ab6775700000ee85409ac42c5b039ae0187588e2","width":300},{"height":64,"url":"https://i.scdn.co/image/ab67757000003b82409ac42c5b039ae0187588e2","width":64}],"product":"premium","type":"user","uri":"spotify:user:31yuebmmwgcg56oyg7buotgzqb3e"} Oct 12 01:37:59 schlafzimmer-jonas volumio[971]: info: Spotify Successfully logged in Oct 12 01:37:59 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 12 01:37:59 schlafzimmer-jonas volumio[971]: info: [1791761879436] CoreMusicLibrary::Adding element Spotify Oct 12 01:37:59 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 01:37:59 schlafzimmer-jonas volumio[971]: Cannot find translation for source Spotify Oct 12 01:37:59 schlafzimmer-jonas go-librespot[26622]: time="2026-10-12T01:37:59+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Oct 12 01:37:59 schlafzimmer-jonas go-librespot[26622]: time="2026-10-12T01:37:59+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 12 01:37:59 schlafzimmer-jonas go-librespot[26622]: time="2026-10-12T01:37:59+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 12 01:37:59 schlafzimmer-jonas go-librespot[26622]: time="2026-10-12T01:37:59+02:00" level=info msg="zeroconf server listening on port 42173" Oct 12 01:37:59 schlafzimmer-jonas go-librespot[26622]: time="2026-10-12T01:37:59+02:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Oct 12 01:37:59 schlafzimmer-jonas go-librespot[26622]: time="2026-10-12T01:37:59+02:00" level=debug msg="obtained new client token: AAG4WUWy+AzAIB6WGBbqR9kxuVD3NdeV1hOvUjAHf6OFkO1+heIOREq8LEsWem2aWs/jSLhK77UQKgn+HScs3w/PS/FqOD9bPYir17CqD82++iGYMzExh2yaqh9uI3G3Go5bdLjKm/aKH8JSvOhJOclJ+U6YHEEirgn6bvuI+TRg1SmmH2KwFwKCP7I4mWqN682GjR44gEM5tBEjwlHgDEBefFGksp09lienlgMicNRAumMFRXGKpOI=" Oct 12 01:37:59 schlafzimmer-jonas go-librespot[26622]: time="2026-10-12T01:37:59+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 01:37:59 schlafzimmer-jonas go-librespot[26622]: time="2026-10-12T01:37:59+02:00" level=debug msg="completed keyexchange" Oct 12 01:37:59 schlafzimmer-jonas go-librespot[26622]: time="2026-10-12T01:37:59+02:00" level=debug msg="completed challenge" Oct 12 01:37:59 schlafzimmer-jonas go-librespot[26622]: time="2026-10-12T01:37:59+02:00" level=info msg="authenticated AP" username="31************************3e" Oct 12 01:37:59 schlafzimmer-jonas volumio[971]: info: go-librespot daemon successfully initialized Oct 12 01:37:59 schlafzimmer-jonas go-librespot[26622]: time="2026-10-12T01:37:59+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 01:37:59 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 01:37:59 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 01:38:01 schlafzimmer-jonas volumio[971]: info: Initializing connection to go-librespot Websocket Oct 12 01:38:01 schlafzimmer-jonas volumio[971]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 01:38:01 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::volumioGetState Oct 12 01:38:01 schlafzimmer-jonas volumio[971]: info: CorePlayQueue::getTrack 6 Oct 12 01:38:01 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 01:38:01 schlafzimmer-jonas volumio[971]: info: [ASDebug] Setting UI defaults Oct 12 01:38:01 schlafzimmer-jonas volumio[971]: info: [ASDebug] Port: 24 Oct 12 01:38:01 schlafzimmer-jonas volumio[971]: info: [ASDebug] Inverted: false Oct 12 01:38:01 schlafzimmer-jonas volumio[971]: info: [ASDebug] Latched: false Oct 12 01:38:01 schlafzimmer-jonas volumio[971]: info: [ASDebug] On pulse width: 500 Oct 12 01:38:01 schlafzimmer-jonas volumio[971]: info: [ASDebug] Off pulse width: 500 Oct 12 01:38:02 schlafzimmer-jonas volumio[971]: info: go-librespot daemon successfully initialized Oct 12 01:38:02 schlafzimmer-jonas volumio[971]: info: Initializing connection to go-librespot Websocket Oct 12 01:38:02 schlafzimmer-jonas volumio[971]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 01:38:03 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 12 01:38:03 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Oct 12 01:38:03 schlafzimmer-jonas systemd[1]: Stopped go-librespot Daemon. Oct 12 01:38:03 schlafzimmer-jonas systemd[1]: Started go-librespot Daemon. Oct 12 01:38:03 schlafzimmer-jonas go-librespot[26633]: go-librespot daemon starting... Oct 12 01:38:03 schlafzimmer-jonas go-librespot[26633]: time="2026-10-12T01:38:03+02:00" level=info msg="running go-librespot 0.7.1" Oct 12 01:38:03 schlafzimmer-jonas go-librespot[26633]: time="2026-10-12T01:38:03+02:00" level=debug msg="app state loaded" Oct 12 01:38:03 schlafzimmer-jonas go-librespot[26633]: time="2026-10-12T01:38:03+02:00" level=debug msg="stored credentials not found" Oct 12 01:38:03 schlafzimmer-jonas go-librespot[26633]: time="2026-10-12T01:38:03+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 01:38:03 schlafzimmer-jonas go-librespot[26633]: time="2026-10-12T01:38:03+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 01:38:03 schlafzimmer-jonas go-librespot[26633]: time="2026-10-12T01:38:03+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 01:38:03 schlafzimmer-jonas go-librespot[26633]: time="2026-10-12T01:38:03+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 01:38:03 schlafzimmer-jonas go-librespot[26633]: time="2026-10-12T01:38:03+02:00" level=info msg="zeroconf server listening on port 45917" Oct 12 01:38:03 schlafzimmer-jonas go-librespot[26633]: time="2026-10-12T01:38:03+02:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Oct 12 01:38:03 schlafzimmer-jonas go-librespot[26633]: time="2026-10-12T01:38:03+02:00" level=debug msg="obtained new client token: AAFNYgsP4Ym4pv0PtboU5KSRLE+6LqPIWN1B7Ip5knttlxHDsuYNSwLKWZO4OCv8Nlwia+dRR6aFJsZpXrJneqW5d1Fu/tCUieJ9PbdclZWp40GV4UwA99bvzmsPLEYXJ+0ugFTFmpzgigL8A4NzQaN4CGMF8TsmbsobzPDcb5oHCPeQ6SmiIg4btTIJlJLcK2V3VnNMv1c5rz9fNilo6S5IEnmt1Nl2zB6I8wahfG+tX94Y7KUsYB0=" Oct 12 01:38:03 schlafzimmer-jonas go-librespot[26633]: time="2026-10-12T01:38:03+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 12 01:38:03 schlafzimmer-jonas go-librespot[26633]: time="2026-10-12T01:38:03+02:00" level=debug msg="completed keyexchange" Oct 12 01:38:03 schlafzimmer-jonas go-librespot[26633]: time="2026-10-12T01:38:03+02:00" level=debug msg="completed challenge" Oct 12 01:38:03 schlafzimmer-jonas go-librespot[26633]: time="2026-10-12T01:38:03+02:00" level=info msg="authenticated AP" username="31************************3e" Oct 12 01:38:03 schlafzimmer-jonas go-librespot[26633]: time="2026-10-12T01:38:03+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 01:38:03 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 01:38:03 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 01:38:05 schlafzimmer-jonas volumio[971]: info: Initializing connection to go-librespot Websocket Oct 12 01:38:05 schlafzimmer-jonas volumio[971]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 01:38:06 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 01:38:06 schlafzimmer-jonas volumio[971]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 12 01:38:07 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 12 01:38:07 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Oct 12 01:38:07 schlafzimmer-jonas systemd[1]: Stopped go-librespot Daemon. Oct 12 01:38:07 schlafzimmer-jonas systemd[1]: Started go-librespot Daemon. Oct 12 01:38:07 schlafzimmer-jonas go-librespot[26643]: go-librespot daemon starting... Oct 12 01:38:07 schlafzimmer-jonas go-librespot[26643]: time="2026-10-12T01:38:07+02:00" level=info msg="running go-librespot 0.7.1" Oct 12 01:38:07 schlafzimmer-jonas go-librespot[26643]: time="2026-10-12T01:38:07+02:00" level=debug msg="app state loaded" Oct 12 01:38:07 schlafzimmer-jonas go-librespot[26643]: time="2026-10-12T01:38:07+02:00" level=debug msg="stored credentials not found" Oct 12 01:38:07 schlafzimmer-jonas go-librespot[26643]: time="2026-10-12T01:38:07+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 01:38:07 schlafzimmer-jonas go-librespot[26643]: time="2026-10-12T01:38:07+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 12 01:38:07 schlafzimmer-jonas go-librespot[26643]: time="2026-10-12T01:38:07+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 12 01:38:07 schlafzimmer-jonas go-librespot[26643]: time="2026-10-12T01:38:07+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 12 01:38:07 schlafzimmer-jonas go-librespot[26643]: time="2026-10-12T01:38:07+02:00" level=info msg="zeroconf server listening on port 36151" Oct 12 01:38:07 schlafzimmer-jonas go-librespot[26643]: time="2026-10-12T01:38:07+02:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Oct 12 01:38:07 schlafzimmer-jonas go-librespot[26643]: time="2026-10-12T01:38:07+02:00" level=debug msg="obtained new client token: AAEQJtSTy69OSZoszVHfuZAizpA30+4oOV9rqIoIaFr7LmJ8yf7etn+/SCHDMkbruo04ovhB22m4N5ITAcTuzUflSXswtcdbPCJXBzWdeM8JDYOBCqRTSIxBSurBKPffMeq03bhSe0F5JfyNKSaskgz5k7U0j/+4UFfCRYiLLEL7Sgsz9e3SCY8HuRALmkEczkqf7ChCCPx/fDNuEJvSnA8bvKfUJVdXW+KMXlaT5YPtiKMw9PGgCaw=" Oct 12 01:38:07 schlafzimmer-jonas go-librespot[26643]: time="2026-10-12T01:38:07+02:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.1.133:4070: connect: connection refused" Oct 12 01:38:07 schlafzimmer-jonas go-librespot[26643]: time="2026-10-12T01:38:07+02:00" level=debug msg="connected to ap-gew4.spotify.com:443" Oct 12 01:38:07 schlafzimmer-jonas go-librespot[26643]: time="2026-10-12T01:38:07+02:00" level=debug msg="completed keyexchange" Oct 12 01:38:07 schlafzimmer-jonas go-librespot[26643]: time="2026-10-12T01:38:07+02:00" level=debug msg="completed challenge" Oct 12 01:38:07 schlafzimmer-jonas go-librespot[26643]: time="2026-10-12T01:38:07+02:00" level=info msg="authenticated AP" username="31************************3e" Oct 12 01:38:07 schlafzimmer-jonas go-librespot[26643]: time="2026-10-12T01:38:07+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 12 01:38:07 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 12 01:38:07 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 12 01:38:08 schlafzimmer-jonas volumio[971]: info: Initializing connection to go-librespot Websocket Oct 12 01:38:08 schlafzimmer-jonas volumio[971]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 12 01:38:08 schlafzimmer-jonas volumio[971]: info: [ASDebug] Port: 24 Oct 12 01:38:08 schlafzimmer-jonas volumio[971]: info: [ASDebug] Inverted: false Oct 12 01:38:08 schlafzimmer-jonas volumio[971]: info: [ASDebug] Delay: 720 Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: info: [ASDebug] Port: 24 Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: info: [ASDebug] Inverted: false Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: info: [ASDebug] Delay: 720 Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: Error: EBADF: bad file descriptor, close Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: at Object.closeSync (fs.js:439:3) Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: at Object.closeSync (/volumio/node_modules/graceful-fs/graceful-fs.js:74:20) Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: at Object.closeSync (/data/plugins/system_controller/ampswitch/node_modules/graceful-fs/graceful-fs.js:51:27) Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: at Gpio.unexport (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:307:8) Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: at AmpSwitchController.freeGPIO (/data/plugins/system_controller/ampswitch/index.js:242:19) Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: at AmpSwitchController.onStop (/data/plugins/system_controller/ampswitch/index.js:90:10) Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29) Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1412:47) Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: at Socket.emit (events.js:315:20) Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: errno: -9, Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: syscall: 'close', Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: code: 'EBADF' Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: } Oct 12 01:38:10 schlafzimmer-jonas volumio[971]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 01:38:11 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 12 01:38:11 schlafzimmer-jonas systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3. Oct 12 01:38:11 schlafzimmer-jonas systemd[1]: Stopped go-librespot Daemon. Oct 12 01:38:11 schlafzimmer-jonas systemd[1]: Started go-librespot Daemon. Oct 12 01:38:11 schlafzimmer-jonas go-librespot[26676]: go-librespot daemon starting... Oct 12 01:38:11 schlafzimmer-jonas go-librespot[26676]: time="2026-10-12T01:38:11+02:00" level=info msg="running go-librespot 0.7.1" Oct 12 01:38:11 schlafzimmer-jonas go-librespot[26676]: time="2026-10-12T01:38:11+02:00" level=debug msg="app state loaded" Oct 12 01:38:11 schlafzimmer-jonas go-librespot[26676]: time="2026-10-12T01:38:11+02:00" level=debug msg="stored credentials not found" Oct 12 01:38:11 schlafzimmer-jonas go-librespot[26676]: time="2026-10-12T01:38:11+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 01:38:11 schlafzimmer-jonas sudo[26687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-12 01:37 Oct 12 01:38:11 schlafzimmer-jonas sudo[26687]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"