-- Logs begin at Sat 2025-12-20 04:27:12 CET, end at Mon 2026-10-12 20:36:46 CEST. --
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: Starting Streaming Service Transparent Proxy
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: Streaming services startup
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: Starting Streaming Daemon
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Oct 12 20:35:01 volumio-schlafzimmer sudo[1513]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Oct 12 20:35:01 volumio-schlafzimmer sudo[1513]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 12 20:35:01 volumio-schlafzimmer sudo[1513]: pam_unix(sudo:session): session closed for user root
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: AutoStart - Plugin is starting
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioGetQueue
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::getQueue
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getQueue
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: AutoStart - start playing
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: AutoStart - start playing with no specific position
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPlay
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::play index 0
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::stop
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::play index undefined
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::startPlaybackTimer
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: [1791830101818] ControllerSpotify::clearAddPlayTrack
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: Sending Spotify command with payload to local API: /player/play
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: Received Get System Version
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: Received Get System Info
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: Discovery: Getting this device information
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioGetState
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: error: Failed to send command to Spotify local API: /player/play: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: error: Cannot start Volumio Streaming Daemon
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Oct 12 20:35:01 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:02 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:35:02 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 5.
Oct 12 20:35:02 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:35:02 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:35:02 volumio-schlafzimmer go-librespot[1520]: go-librespot daemon starting...
Oct 12 20:35:02 volumio-schlafzimmer volumio[671]: error: MyVolumio Custom Token format not valid, refreshing it
Oct 12 20:35:02 volumio-schlafzimmer go-librespot[1520]: time="2026-10-12T20:35:02+02:00" level=info msg="running go-librespot 0.4.0"
Oct 12 20:35:02 volumio-schlafzimmer go-librespot[1520]: time="2026-10-12T20:35:02+02:00" level=debug msg="app state loaded"
Oct 12 20:35:02 volumio-schlafzimmer go-librespot[1520]: time="2026-10-12T20:35:02+02:00" level=info msg="api server listening on 127.0.0.1:9879"
Oct 12 20:35:03 volumio-schlafzimmer go-librespot[1520]: time="2026-10-12T20:35: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-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Oct 12 20:35:03 volumio-schlafzimmer go-librespot[1520]: time="2026-10-12T20:35:03+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 20:35:03 volumio-schlafzimmer go-librespot[1520]: time="2026-10-12T20:35:03+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 20:35:03 volumio-schlafzimmer go-librespot[1520]: time="2026-10-12T20:35:03+02:00" level=info msg="zeroconf server listening on port 39771"
Oct 12 20:35:03 volumio-schlafzimmer go-librespot[1520]: time="2026-10-12T20:35:03+02:00" level=debug msg="obtained new client token: AAFO6CUUnjGgChnQ+c4y/Hof4ypOPsQecwjP8j8NwK5Ker5VOGU7lMHefDnfC92tW3zLXNANV0ghkggjQ2YkHtkfs4zaKzOgIChmWYh/SumvmL/kvoRS4ShGc+xMDrfhjtObSX24ka5o36lJUWvjBuvD89jbtd+BHeuKdAKcF3878KL2x+1ik8hxJTU0DCB+etBb841bJtYxRwYHN565nQ8AEi+mFJM4eYV55QD/5c65YajS5787k4U="
Oct 12 20:35:03 volumio-schlafzimmer go-librespot[1520]: time="2026-10-12T20:35:03+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070"
Oct 12 20:35:03 volumio-schlafzimmer go-librespot[1520]: time="2026-10-12T20:35:03+02:00" level=debug msg="completed keyexchange"
Oct 12 20:35:03 volumio-schlafzimmer go-librespot[1520]: time="2026-10-12T20:35:03+02:00" level=debug msg="completed challenge"
Oct 12 20:35:03 volumio-schlafzimmer go-librespot[1520]: time="2026-10-12T20:35:03+02:00" level=info msg="authenticated AP" username="de***********er"
Oct 12 20:35:03 volumio-schlafzimmer volumio[671]: info: MyVolumio login type: Token
Oct 12 20:35:03 volumio-schlafzimmer go-librespot[1520]: time="2026-10-12T20:35: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 20:35:03 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:35:03 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:35:04 volumio-schlafzimmer volumio[671]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Oct 12 20:35:04 volumio-schlafzimmer volumio[671]: info: MyVolumio token set successfully
Oct 12 20:35:04 volumio-schlafzimmer volumio[671]: info: MYVOLUMIO: Adding device
Oct 12 20:35:04 volumio-schlafzimmer volumio[671]: info: MYVOLUMIO: Evaluating Server
Oct 12 20:35:04 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:35:04 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:05 volumio-schlafzimmer volumio[671]: STREAMING PROXY: Starting server on port 3245
Oct 12 20:35:05 volumio-schlafzimmer volumio[671]: Node JS runtime: 14
Oct 12 20:35:05 volumio-schlafzimmer volumio[671]: info: MyVolumio status changed
Oct 12 20:35:05 volumio-schlafzimmer volumio[671]: info: Streaming services startup
Oct 12 20:35:05 volumio-schlafzimmer volumio[671]: info: Starting Streaming Daemon
Oct 12 20:35:05 volumio-schlafzimmer volumio[671]: info: Removing browser output: myVolumio user plan is not superstar
Oct 12 20:35:05 volumio-schlafzimmer volumio[671]: info: Removing audio output:
Oct 12 20:35:05 volumio-schlafzimmer volumio[671]: info: Stoppping Tunnel 1
Oct 12 20:35:05 volumio-schlafzimmer sudo[1564]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Oct 12 20:35:06 volumio-schlafzimmer sudo[1564]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 12 20:35:06 volumio-schlafzimmer sudo[1567]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Oct 12 20:35:06 volumio-schlafzimmer sudo[1564]: pam_unix(sudo:session): session closed for user root
Oct 12 20:35:06 volumio-schlafzimmer sudo[1567]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 12 20:35:06 volumio-schlafzimmer volumio[671]: info: Setting Geolocation for MyVolumio to eu4
Oct 12 20:35:06 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 12 20:35:06 volumio-schlafzimmer sudo[1567]: pam_unix(sudo:session): session closed for user root
Oct 12 20:35:06 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 12 20:35:06 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 12 20:35:06 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 12 20:35:06 volumio-schlafzimmer volumio[671]: error: Cannot start Volumio Streaming Daemon
Oct 12 20:35:06 volumio-schlafzimmer volumio[671]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Oct 12 20:35:06 volumio-schlafzimmer volumio[671]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Oct 12 20:35:06 volumio-schlafzimmer volumio[671]: info: Remote SSH Stopped
Oct 12 20:35:06 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Oct 12 20:35:06 volumio-schlafzimmer volumio-remote-updater[459]: No test mode
Oct 12 20:35:06 volumio-schlafzimmer volumio-remote-updater[459]: No alpha test mode
Oct 12 20:35:06 volumio-schlafzimmer volumio[671]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\nFix for BLE notification issues
\nFix for mDNS/BCT
\n
\nNEW ADDITIONS
\n\nUpdate Tidal SDK
\nUpdate Qobuz Connect SDK
\n\n","title":"Update v3.912","updateavailable":true}
Oct 12 20:35:06 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Oct 12 20:35:06 volumio-schlafzimmer volumio[671]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Oct 12 20:35:06 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:35:06 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 6.
Oct 12 20:35:06 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:35:07 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:35:07 volumio-schlafzimmer go-librespot[1572]: go-librespot daemon starting...
Oct 12 20:35:07 volumio-schlafzimmer go-librespot[1572]: time="2026-10-12T20:35:07+02:00" level=info msg="running go-librespot 0.4.0"
Oct 12 20:35:07 volumio-schlafzimmer go-librespot[1572]: time="2026-10-12T20:35:07+02:00" level=debug msg="app state loaded"
Oct 12 20:35:07 volumio-schlafzimmer go-librespot[1572]: time="2026-10-12T20:35:07+02:00" level=info msg="api server listening on 127.0.0.1:9879"
Oct 12 20:35:07 volumio-schlafzimmer ntpd[642]: Soliciting pool server 195.201.139.229
Oct 12 20:35:07 volumio-schlafzimmer ntpd[642]: Soliciting pool server 185.232.69.65
Oct 12 20:35:07 volumio-schlafzimmer volumio[671]: info: Updating MyVolumio device info
Oct 12 20:35:07 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 12 20:35:07 volumio-schlafzimmer go-librespot[1572]: time="2026-10-12T20:35: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 12 20:35:07 volumio-schlafzimmer go-librespot[1572]: time="2026-10-12T20:35:07+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 20:35:07 volumio-schlafzimmer go-librespot[1572]: time="2026-10-12T20:35:07+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 20:35:07 volumio-schlafzimmer go-librespot[1572]: time="2026-10-12T20:35:07+02:00" level=info msg="zeroconf server listening on port 36347"
Oct 12 20:35:07 volumio-schlafzimmer go-librespot[1572]: time="2026-10-12T20:35:07+02:00" level=debug msg="obtained new client token: AAGCBVnHWxTsiMHfCH22vPEDFfmM4SIjck8gofL9MFk3gMa12pw2Gfdls2lW8OfTWlfNJ7vwWyx/4U0uulVbwy5sKu3ESKoSiBnb1RYebuJHVzgYztBvMArihhC/dnEB6731aKWNlyvXpMmni6kpAE30PhqNbtQfNQd3nxxLgxIAFsbGN6AbZrvbKc8z/PsOtr9Dlovxi2R810GHA/T34WY6r9hU3XcZ9+iLqp2XueodRHOqBBcpc6hykQ=="
Oct 12 20:35:07 volumio-schlafzimmer go-librespot[1572]: time="2026-10-12T20:35: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 20:35:07 volumio-schlafzimmer go-librespot[1572]: time="2026-10-12T20:35:07+02:00" level=debug msg="connected to ap-gew4.spotify.com:443"
Oct 12 20:35:07 volumio-schlafzimmer go-librespot[1572]: time="2026-10-12T20:35:07+02:00" level=debug msg="completed keyexchange"
Oct 12 20:35:07 volumio-schlafzimmer go-librespot[1572]: time="2026-10-12T20:35:07+02:00" level=debug msg="completed challenge"
Oct 12 20:35:07 volumio-schlafzimmer go-librespot[1572]: time="2026-10-12T20:35:07+02:00" level=info msg="authenticated AP" username="de***********er"
Oct 12 20:35:07 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:35:07 volumio-schlafzimmer go-librespot[1572]: time="2026-10-12T20:35:07+02:00" level=debug msg="new websocket client"
Oct 12 20:35:07 volumio-schlafzimmer volumio[671]: info: Connection to go-librespot Websocket established
Oct 12 20:35:08 volumio-schlafzimmer go-librespot[1572]: time="2026-10-12T20:35:08+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 20:35:08 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:35:08 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:35:08 volumio-schlafzimmer volumio[671]: info: Connection to go-librespot Websocket closed
Oct 12 20:35:08 volumio-schlafzimmer ntpd[642]: Soliciting pool server 144.76.76.107
Oct 12 20:35:08 volumio-schlafzimmer ntpd[642]: Soliciting pool server 131.188.3.221
Oct 12 20:35:08 volumio-schlafzimmer volumio[671]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Oct 12 20:35:08 volumio-schlafzimmer ntpd[642]: Soliciting pool server 162.159.200.1
Oct 12 20:35:09 volumio-schlafzimmer ntpd[642]: Soliciting pool server 45.138.55.60
Oct 12 20:35:09 volumio-schlafzimmer ntpd[642]: Soliciting pool server 62.225.132.250
Oct 12 20:35:09 volumio-schlafzimmer ntpd[642]: Soliciting pool server 134.60.1.30
Oct 12 20:35:09 volumio-schlafzimmer ntpd[642]: Soliciting pool server 217.144.138.234
Oct 12 20:35:09 volumio-schlafzimmer volumio[671]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Oct 12 20:35:10 volumio-schlafzimmer ntpd[642]: Soliciting pool server 129.250.35.251
Oct 12 20:35:10 volumio-schlafzimmer ntpd[642]: Soliciting pool server 49.12.35.6
Oct 12 20:35:10 volumio-schlafzimmer ntpd[642]: Soliciting pool server 45.138.55.61
Oct 12 20:35:10 volumio-schlafzimmer ntpd[642]: Soliciting pool server 130.162.251.109
Oct 12 20:35:10 volumio-schlafzimmer volumio[671]: info: MYVOLUMIO: Adding device
Oct 12 20:35:10 volumio-schlafzimmer volumio[671]: info: MYVOLUMIO: Evaluating Server
Oct 12 20:35:11 volumio-schlafzimmer ntpd[642]: Soliciting pool server 85.220.190.246
Oct 12 20:35:11 volumio-schlafzimmer ntpd[642]: Soliciting pool server 78.47.168.188
Oct 12 20:35:11 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:35:11 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 7.
Oct 12 20:35:11 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:35:11 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:35:11 volumio-schlafzimmer go-librespot[1588]: go-librespot daemon starting...
Oct 12 20:35:11 volumio-schlafzimmer go-librespot[1588]: time="2026-10-12T20:35:11+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:35:11 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:35:11 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:35:11 volumio-schlafzimmer volumio[671]: info: Getting Spotify volume
Oct 12 20:35:11 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:35:11 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 12 20:35:11 volumio-schlafzimmer volumio[671]: (node:671) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:11 volumio-schlafzimmer volumio[671]:     at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16)
Oct 12 20:35:11 volumio-schlafzimmer volumio[671]: (node:671) 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: 2)
Oct 12 20:35:11 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:11 volumio-schlafzimmer volumio[671]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8
Oct 12 20:35:11 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 12 20:35:11 volumio-schlafzimmer volumio[671]: info: Setting Geolocation for MyVolumio to eu4
Oct 12 20:35:11 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 12 20:35:11 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 12 20:35:11 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 12 20:35:12 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioGetState
Oct 12 20:35:12 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:35:12 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:35:12 volumio-schlafzimmer ntpd[642]: Soliciting pool server 94.130.184.193
Oct 12 20:35:12 volumio-schlafzimmer ntpd[642]: Soliciting pool server 2a01:4f8:191:946a::2
Oct 12 20:35:12 volumio-schlafzimmer volumio[671]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Oct 12 20:35:12 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 12 20:35:12 volumio-schlafzimmer volumio[671]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8
Oct 12 20:35:12 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioGetState
Oct 12 20:35:12 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:35:12 volumio-schlafzimmer volumio[671]: info: Updating MyVolumio device info
Oct 12 20:35:12 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 12 20:35:13 volumio-schlafzimmer volumio[671]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Oct 12 20:35:14 volumio-schlafzimmer ntpd[642]: receive: Unexpected origin timestamp 0xee77a6e2.0f8b5937 does not match aorg 0000000000.00000000 from server@85.220.190.246 xmt 0xee77a6e2.d187cc1a
Oct 12 20:35:14 volumio-schlafzimmer ntpd[642]: receive: Unexpected origin timestamp 0xee77a6e2.0fcf7e2a does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xee77a6e2.d2262a80
Oct 12 20:35:14 volumio-schlafzimmer ntpd[642]: receive: Unexpected origin timestamp 0xee77a6e2.0fdaa981 does not match aorg 0000000000.00000000 from server@144.76.76.107 xmt 0xee77a6e2.d1bf4d65
Oct 12 20:35:14 volumio-schlafzimmer ntpd[642]: receive: Unexpected origin timestamp 0xee77a6e2.0fc1ac5a does not match aorg 0000000000.00000000 from server@134.60.1.30 xmt 0xee77a6e2.d251e15c
Oct 12 20:35:14 volumio-schlafzimmer ntpd[642]: receive: Unexpected origin timestamp 0xee77a6e2.0fcb3014 does not match aorg 0000000000.00000000 from server@62.225.132.250 xmt 0xee77a6e2.d3085931
Oct 12 20:35:14 volumio-schlafzimmer ntpd[642]: receive: Unexpected origin timestamp 0xee77a6e2.0fdffb11 does not match aorg 0000000000.00000000 from server@185.232.69.65 xmt 0xee77a6e2.d22e7234
Oct 12 20:35:14 volumio-schlafzimmer ntpd[642]: receive: Unexpected origin timestamp 0xee77a6e2.0fb3e44c does not match aorg 0000000000.00000000 from server@217.144.138.234 xmt 0xee77a6e2.d34f83c6
Oct 12 20:35:14 volumio-schlafzimmer ntpd[642]: receive: Unexpected origin timestamp 0xee77a6e2.0fa60dce does not match aorg 0000000000.00000000 from server@45.138.55.61 xmt 0xee77a6e2.d3524bfc
Oct 12 20:35:14 volumio-schlafzimmer ntpd[642]: receive: Unexpected origin timestamp 0xee77a6e2.0fb9db13 does not match aorg 0000000000.00000000 from server@45.138.55.60 xmt 0xee77a6e2.d36588f1
Oct 12 20:35:14 volumio-schlafzimmer ntpd[642]: receive: Unexpected origin timestamp 0xee77a6e2.0fd52e7d does not match aorg 0000000000.00000000 from server@131.188.3.221 xmt 0xee77a6e2.d3c4d78d
Oct 12 20:35:14 volumio-schlafzimmer volumio[671]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Oct 12 20:35:15 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:35:15 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 8.
Oct 12 20:35:15 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:35:15 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:35:15 volumio-schlafzimmer go-librespot[1609]: go-librespot daemon starting...
Oct 12 20:35:15 volumio-schlafzimmer go-librespot[1609]: time="2026-10-12T20:35:15+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:35:15 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:35:15 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:35:15 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 12 20:35:15 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:35:15 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:15 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioGetState
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: Received Get System Info
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: Discovery: Getting this device information
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioGetState
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioGetState
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: Listing playlists
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: Received Get System Info
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: Discovery: Getting this device information
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioGetState
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:35:16 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 12 20:35:18 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:35:18 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 9.
Oct 12 20:35:18 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:35:18 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 12 20:35:18 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 12 20:35:18 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Oct 12 20:35:18 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 12 20:35:18 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Oct 12 20:35:18 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioGetBrowseSources
Oct 12 20:35:18 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 12 20:35:18 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:35:18 volumio-schlafzimmer go-librespot[1630]: go-librespot daemon starting...
Oct 12 20:35:18 volumio-schlafzimmer go-librespot[1630]: time="2026-10-12T20:35:18+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:35:18 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:35:18 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:35:18 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:35:18 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 12 20:35:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 12 20:35:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 12 20:35:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Oct 12 20:35:20 volumio-schlafzimmer volumio[671]: info: FusionDsp -
Oct 12 20:35:21 volumio-schlafzimmer volumio[671]: info: FusionDsp - undefined
Oct 12 20:35:21 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:35:21 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10.
Oct 12 20:35:21 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:35:21 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:35:21 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:21 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:35:21 volumio-schlafzimmer go-librespot[1637]: go-librespot daemon starting...
Oct 12 20:35:21 volumio-schlafzimmer go-librespot[1637]: time="2026-10-12T20:35:21+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:35:21 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:35:21 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:35:22 volumio-schlafzimmer volumio[671]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Oct 12 20:35:22 volumio-schlafzimmer volumio[671]: info: Completed starting MyVolumio Plugin
Oct 12 20:35:22 volumio-schlafzimmer volumio[671]:  [Metrics]  CommandRouter:  73s 329.60ms 
Oct 12 20:35:22 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumiosetStartupVolume
Oct 12 20:35:22 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 12 20:35:22 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 12 20:35:22 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::Close All Modals sent
Oct 12 20:35:22 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::Close All Modals sent
Oct 12 20:35:22 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Oct 12 20:35:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 12 20:35:23 volumio-schlafzimmer volumio[671]: info: Received Get System Info
Oct 12 20:35:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 12 20:35:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 12 20:35:23 volumio-schlafzimmer volumio[671]: info: Discovery: Getting this device information
Oct 12 20:35:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioGetState
Oct 12 20:35:23 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:35:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 12 20:35:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Oct 12 20:35:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 12 20:35:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Oct 12 20:35:24 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 12 20:35:24 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:35:24 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:24 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:35:24 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11.
Oct 12 20:35:24 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:35:24 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:35:24 volumio-schlafzimmer go-librespot[1645]: go-librespot daemon starting...
Oct 12 20:35:24 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 12 20:35:24 volumio-schlafzimmer volumio[671]: info: Received Get System Info
Oct 12 20:35:24 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 12 20:35:24 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 12 20:35:24 volumio-schlafzimmer volumio[671]: info: Discovery: Getting this device information
Oct 12 20:35:24 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioGetState
Oct 12 20:35:24 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:35:24 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 12 20:35:25 volumio-schlafzimmer go-librespot[1645]: time="2026-10-12T20:35:25+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:35:25 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:35:25 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:35:25 volumio-schlafzimmer kernel: EXT4-fs warning (device mmcblk0p3): ext4_dirblock_csum_verify:406: inode #1052201: comm ThreadPoolForeg: No space for directory leaf checksum. Please run e2fsck -D.
Oct 12 20:35:25 volumio-schlafzimmer kernel: EXT4-fs error (device mmcblk0p3): htree_dirblock_to_tree:1083: inode #1052201: comm ThreadPoolForeg: Directory block failed checksum
Oct 12 20:35:25 volumio-schlafzimmer kernel: EXT4-fs warning (device mmcblk0p3): ext4_dirblock_csum_verify:406: inode #1052201: comm ThreadPoolForeg: No space for directory leaf checksum. Please run e2fsck -D.
Oct 12 20:35:25 volumio-schlafzimmer kernel: EXT4-fs error (device mmcblk0p3): ext4_empty_dir:3139: inode #1052201: comm ThreadPoolForeg: Directory block failed checksum
Oct 12 20:35:27 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:35:27 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:28 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:35:28 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 12.
Oct 12 20:35:28 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:35:28 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:35:28 volumio-schlafzimmer go-librespot[1849]: go-librespot daemon starting...
Oct 12 20:35:28 volumio-schlafzimmer go-librespot[1849]: time="2026-10-12T20:35:28+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:35:28 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:35:28 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:35:29 volumio-schlafzimmer volumio[671]: info: BOOT COMPLETED
Oct 12 20:35:30 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:35:30 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:31 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:35:31 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 13.
Oct 12 20:35:31 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:35:31 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:35:31 volumio-schlafzimmer go-librespot[1859]: go-librespot daemon starting...
Oct 12 20:35:31 volumio-schlafzimmer go-librespot[1859]: time="2026-10-12T20:35:31+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:35:31 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:35:31 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:35:31 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 12 20:35:31 volumio-schlafzimmer volumio[671]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Oct 12 20:35:31 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Oct 12 20:35:32 volumio-schlafzimmer volumio[671]: info: Received Get System Version
Oct 12 20:35:32 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 12 20:35:32 volumio-schlafzimmer volumio[671]: info: Received Get System Info
Oct 12 20:35:32 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 12 20:35:32 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 12 20:35:32 volumio-schlafzimmer volumio[671]: info: Discovery: Getting this device information
Oct 12 20:35:32 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioGetState
Oct 12 20:35:32 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:35:32 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 12 20:35:33 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:35:33 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:34 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:35:34 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14.
Oct 12 20:35:34 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:35:34 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:35:34 volumio-schlafzimmer go-librespot[1867]: go-librespot daemon starting...
Oct 12 20:35:34 volumio-schlafzimmer go-librespot[1867]: time="2026-10-12T20:35:34+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:35:34 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:35:34 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:35:35 volumio-schlafzimmer kernel: EXT4-fs error (device mmcblk0p3): ext4_validate_block_bitmap:421: comm kworker/u10:4: bg 483: bad block bitmap checksum
Oct 12 20:35:35 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 12 20:35:36 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 12 20:35:36 volumio-schlafzimmer kernel: EXT4-fs error (device mmcblk0p3): ext4_validate_block_bitmap:421: comm kworker/u10:4: bg 522: bad block bitmap checksum
Oct 12 20:35:36 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 12 20:35:36 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 12 20:35:36 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs
Oct 12 20:35:36 volumio-schlafzimmer volumio[671]: info: Received Get System Version
Oct 12 20:35:36 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 12 20:35:36 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:35:36 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:37 volumio-schlafzimmer volumio[671]: info: UPDATER: Scheduling automatic update
Oct 12 20:35:37 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStartTime
Oct 12 20:35:37 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStopTime
Oct 12 20:35:37 volumio-schlafzimmer volumio[671]: info: UPDATER: Auto update will take place at: Tue Oct 13 2026 04:10:03 GMT+0200 (Central European Summer Time)
Oct 12 20:35:37 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:35:37 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 15.
Oct 12 20:35:37 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:35:37 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:35:37 volumio-schlafzimmer go-librespot[1902]: go-librespot daemon starting...
Oct 12 20:35:38 volumio-schlafzimmer go-librespot[1902]: time="2026-10-12T20:35:38+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:35:38 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:35:38 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:35:39 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:35:39 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:41 volumio-schlafzimmer kernel: EXT4-fs error (device mmcblk0p3): ext4_validate_block_bitmap:421: comm kworker/u10:4: bg 498: bad block bitmap checksum
Oct 12 20:35:41 volumio-schlafzimmer kernel: EXT4-fs error (device mmcblk0p3): ext4_validate_block_bitmap:421: comm kworker/u10:4: bg 1342: bad block bitmap checksum
Oct 12 20:35:41 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:35:41 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 16.
Oct 12 20:35:41 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:35:41 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:35:41 volumio-schlafzimmer go-librespot[1914]: go-librespot daemon starting...
Oct 12 20:35:41 volumio-schlafzimmer go-librespot[1914]: time="2026-10-12T20:35:41+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:35:41 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:35:41 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:35:42 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:35:42 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:44 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:35:44 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 17.
Oct 12 20:35:44 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:35:44 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:35:44 volumio-schlafzimmer go-librespot[1921]: go-librespot daemon starting...
Oct 12 20:35:44 volumio-schlafzimmer go-librespot[1921]: time="2026-10-12T20:35:44+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:35:44 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:35:44 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:35:44 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioGetState
Oct 12 20:35:44 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:35:45 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPlay
Oct 12 20:35:45 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::play index undefined
Oct 12 20:35:45 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 20:35:45 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:35:45 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::startPlaybackTimer
Oct 12 20:35:45 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:35:45 volumio-schlafzimmer volumio[671]: info: [1791830145566] ControllerSpotify::clearAddPlayTrack
Oct 12 20:35:45 volumio-schlafzimmer volumio[671]: info: Sending Spotify command with payload to local API: /player/play
Oct 12 20:35:45 volumio-schlafzimmer volumio[671]: error: Failed to send command to Spotify local API: /player/play: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:45 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:35:45 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:47 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:35:47 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 18.
Oct 12 20:35:47 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:35:47 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:35:47 volumio-schlafzimmer go-librespot[1943]: go-librespot daemon starting...
Oct 12 20:35:47 volumio-schlafzimmer go-librespot[1943]: time="2026-10-12T20:35:47+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:35:47 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:35:47 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:35:48 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:35:48 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:50 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:35:50 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 19.
Oct 12 20:35:50 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:35:50 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:35:50 volumio-schlafzimmer go-librespot[1953]: go-librespot daemon starting...
Oct 12 20:35:50 volumio-schlafzimmer go-librespot[1953]: time="2026-10-12T20:35:50+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:35:50 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:35:50 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:35:51 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:35:51 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:52 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioGetQueue
Oct 12 20:35:52 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::getQueue
Oct 12 20:35:52 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getQueue
Oct 12 20:35:54 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:35:54 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20.
Oct 12 20:35:54 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:35:54 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:35:54 volumio-schlafzimmer go-librespot[1960]: go-librespot daemon starting...
Oct 12 20:35:54 volumio-schlafzimmer go-librespot[1960]: time="2026-10-12T20:35:54+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:35:54 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:35:54 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:35:54 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:35:54 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:35:57 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Oct 12 20:35:57 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:35:57 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 21.
Oct 12 20:35:57 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:35:57 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:35:57 volumio-schlafzimmer volumio[671]: info: Preload queue cleared
Oct 12 20:35:57 volumio-schlafzimmer go-librespot[1981]: go-librespot daemon starting...
Oct 12 20:35:57 volumio-schlafzimmer go-librespot[1981]: time="2026-10-12T20:35:57+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:35:57 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:35:57 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:35:57 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:35:57 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:36:00 volumio-schlafzimmer volumiologrotate[476]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory
Oct 12 20:36:00 volumio-schlafzimmer volumiologrotate[476]: ls: cannot access 'SCHLAFZIMMER': No such file or directory
Oct 12 20:36:00 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:36:00 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 22.
Oct 12 20:36:00 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Oct 12 20:36:00 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:36:00 volumio-schlafzimmer volumio[671]: info: Preload queue cleared
Oct 12 20:36:00 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:36:00 volumio-schlafzimmer go-librespot[2056]: go-librespot daemon starting...
Oct 12 20:36:00 volumio-schlafzimmer go-librespot[2056]: time="2026-10-12T20:36:00+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:36:00 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:36:00 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:36:00 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:36:00 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:36:03 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:36:03 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:36:03 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:36:03 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 23.
Oct 12 20:36:03 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:36:03 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:36:03 volumio-schlafzimmer go-librespot[2070]: go-librespot daemon starting...
Oct 12 20:36:03 volumio-schlafzimmer go-librespot[2070]: time="2026-10-12T20:36:03+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:36:03 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:36:03 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:36:04 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Oct 12 20:36:04 volumio-schlafzimmer volumio[671]: info: Preload queue cleared
Oct 12 20:36:06 volumio-schlafzimmer kernel: EXT4-fs error (device mmcblk0p3): ext4_validate_block_bitmap:421: comm kworker/u11:0: bg 104: bad block bitmap checksum
Oct 12 20:36:06 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:36:06 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:36:06 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Oct 12 20:36:07 volumio-schlafzimmer volumio[671]: info: Preload queue cleared
Oct 12 20:36:07 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:36:07 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 24.
Oct 12 20:36:07 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:36:07 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:36:07 volumio-schlafzimmer go-librespot[2092]: go-librespot daemon starting...
Oct 12 20:36:07 volumio-schlafzimmer go-librespot[2092]: time="2026-10-12T20:36:07+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:36:07 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:36:07 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:36:09 volumio-schlafzimmer volumio[671]: info: Preload queue cleared
Oct 12 20:36:09 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioReplaceandPlayItems
Oct 12 20:36:09 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::ClearQueue
Oct 12 20:36:09 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::stop
Oct 12 20:36:09 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 20:36:09 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::clearPlayQueue
Oct 12 20:36:09 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::saveQueue
Oct 12 20:36:09 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushQueue
Oct 12 20:36:09 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::addQueueItems
Oct 12 20:36:09 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::addQueueItems
Oct 12 20:36:09 volumio-schlafzimmer volumio[671]: info: Preload queue cleared
Oct 12 20:36:09 volumio-schlafzimmer volumio[671]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s96182
Oct 12 20:36:09 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Oct 12 20:36:09 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:36:09 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:36:09 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushQueue
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::saveQueue
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::updateTrackBlock
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrackBlock
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPlay
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::play index 0
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::stop
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::play index undefined
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::startPlaybackTimer
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: [1791830170021] ControllerWebradio::clearAddPlayTrack
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand stop
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: sendMpdCommand stop took 13 milliseconds
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand clear
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: sendMpdCommand clear took 7 milliseconds
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand load "https://streams.egofm.de/egoFM-hq"
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: error: updateQueue error: null
Oct 12 20:36:10 volumio-schlafzimmer volumio[671]: info: ------------------------------ 23ms
Oct 12 20:36:10 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:36:10 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 25.
Oct 12 20:36:10 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:36:10 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:36:10 volumio-schlafzimmer go-librespot[2103]: go-librespot daemon starting...
Oct 12 20:36:10 volumio-schlafzimmer go-librespot[2103]: time="2026-10-12T20:36:10+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:36:10 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:36:10 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: Preload queue cleared
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioReplaceandPlayItems
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::ClearQueue
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::stop
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::clearPlayQueue
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::saveQueue
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushQueue
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::addQueueItems
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::addQueueItems
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: Preload queue cleared
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s96182
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushQueue
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::saveQueue
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::updateTrackBlock
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrackBlock
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPlay
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::play index 0
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::stop
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::play index undefined
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::startPlaybackTimer
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: info: [1791830171205] ControllerWebradio::clearAddPlayTrack
Oct 12 20:36:11 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand stop
Oct 12 20:36:12 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:36:12 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:36:13 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:36:13 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 26.
Oct 12 20:36:13 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:36:13 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:36:13 volumio-schlafzimmer go-librespot[2111]: go-librespot daemon starting...
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: Preload queue cleared
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioReplaceandPlayItems
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::ClearQueue
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::stop
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::clearPlayQueue
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::saveQueue
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushQueue
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::addQueueItems
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::addQueueItems
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: Preload queue cleared
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s96182
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Oct 12 20:36:13 volumio-schlafzimmer go-librespot[2111]: time="2026-10-12T20:36:13+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushQueue
Oct 12 20:36:13 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:36:13 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::saveQueue
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::updateTrackBlock
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrackBlock
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPlay
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::play index 0
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::stop
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::play index undefined
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::startPlaybackTimer
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: info: [1791830173783] ControllerWebradio::clearAddPlayTrack
Oct 12 20:36:13 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand stop
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand add "https://streams.egofm.de/egoFM-hq"
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: error: updateQueue error: null
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: error: updateQueue error: null
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: error: updateQueue error: null
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info: ------------------------------ 4016ms
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info: ------------------------------ 4014ms
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info: ------------------------------ 4011ms
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info: sendMpdCommand stop took 2861 milliseconds
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info: sendMpdCommand stop took 285 milliseconds
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand clear
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand clear
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info: sendMpdCommand add "https://streams.egofm.de/egoFM-hq" took 18 milliseconds
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info: sendMpdCommand clear took 11 milliseconds
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info: sendMpdCommand clear took 18 milliseconds
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand play
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand load "https://streams.egofm.de/egoFM-hq"
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand load "https://streams.egofm.de/egoFM-hq"
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: error: updateQueue error: null
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: error: updateQueue error: null
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: error: updateQueue error: null
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info: ------------------------------ 41ms
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info: ------------------------------ 40ms
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info: ------------------------------ 39ms
Oct 12 20:36:14 volumio-schlafzimmer volumio[671]: info: sendMpdCommand play took 23 milliseconds
Oct 12 20:36:15 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:36:15 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:36:16 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand add "https://streams.egofm.de/egoFM-hq"
Oct 12 20:36:16 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:36:16 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 27.
Oct 12 20:36:16 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:36:16 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:36:16 volumio-schlafzimmer go-librespot[2132]: go-librespot daemon starting...
Oct 12 20:36:17 volumio-schlafzimmer go-librespot[2132]: time="2026-10-12T20:36:17+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:36:17 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:36:17 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:36:17 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:17 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: error: updateQueue error: null
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: error: updateQueue error: null
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: error: updateQueue error: null
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand add "https://streams.egofm.de/egoFM-hq"
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: ------------------------------ 3917ms
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: ------------------------------ 3914ms
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: ------------------------------ 3912ms
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: sendMpdCommand add "https://streams.egofm.de/egoFM-hq" took 1848 milliseconds
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: ------------------------------ 24ms
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: ------------------------------ 20ms
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: ------------------------------ 18ms
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand play
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: sendMpdCommand add "https://streams.egofm.de/egoFM-hq" took 25 milliseconds
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: ------------------------------ 33ms
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: sendMpdCommand play took 19 milliseconds
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: ------------------------------ 18ms
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: ------------------------------ 14ms
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: ------------------------------ 12ms
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand play
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: ------------------------------ 25ms
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: sendMpdCommand play took 16 milliseconds
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: ------------------------------ 14ms
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: ------------------------------ 12ms
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: ------------------------------ 9ms
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:36:18 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: FusionDsp -  ---- read samplerate, raw: 44100,S32_LE,2,32
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: FusionDsp -  ---- read samplerate from file: 44100
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: camilladsp stopping service pid 1090...
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: camilladsp service terminated, instance 1
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: FusionDsp -  If filter freq >samplerate/2 then disable it
Oct 12 20:36:20 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:36:20 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 28.
Oct 12 20:36:20 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: camilladsp service started and running in background, instance 1
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 149 milliseconds
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 147 milliseconds
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 144 milliseconds
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 137 milliseconds
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:20 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:20 volumio-schlafzimmer go-librespot[2145]: go-librespot daemon starting...
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ------------------------------ 69ms
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 61 milliseconds
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 56 milliseconds
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 53 milliseconds
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 52 milliseconds
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 52 milliseconds
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ------------------------------ 50ms
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 45 milliseconds
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ------------------------------ 43ms
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 38 milliseconds
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ------------------------------ 36ms
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 35 milliseconds
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:20 volumio-schlafzimmer go-librespot[2145]: time="2026-10-12T20:36:20+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:20 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:36:20 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"egoFM-hq","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus stop
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":674,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"egoFM-hq","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus play
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: Received an update from plugin. extracting info from payload
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"egoFM-hq","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus play
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: Received an update from plugin. extracting info from payload
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"egoFM-hq","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus play
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: Received an update from plugin. extracting info from payload
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ------------------------------ 359ms
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ------------------------------ 515ms
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ------------------------------ 513ms
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ------------------------------ 510ms
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 342 milliseconds
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 332 milliseconds
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 331 milliseconds
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 330 milliseconds
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"egoFM-hq","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus play
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: Received an update from plugin. extracting info from payload
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"egoFM-hq","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus play
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: Received an update from plugin. extracting info from payload
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"egoFM-hq","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus play
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: Received an update from plugin. extracting info from payload
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"egoFM-hq","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus play
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: Received an update from plugin. extracting info from payload
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:20 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:21 volumio-schlafzimmer volumio[671]: info: ------------------------------ 901ms
Oct 12 20:36:21 volumio-schlafzimmer volumio[671]: info: ------------------------------ 878ms
Oct 12 20:36:21 volumio-schlafzimmer volumio[671]: info: ------------------------------ 871ms
Oct 12 20:36:21 volumio-schlafzimmer volumio[671]: info: ------------------------------ 866ms
Oct 12 20:36:21 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:21 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:21 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:21 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:21 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:21 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:21 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:21 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:21 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:21 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:21 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:21 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:21 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:21 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:36:21 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioStop
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::stop
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::stPlaybackTimer
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::updateTrackBlock
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrackBlock
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:23 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:36:23 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 29.
Oct 12 20:36:23 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::serviceStop
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::serviceStop
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: [1791830183429] ControllerWebradio::stop
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand stop
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:23 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:36:23 volumio-schlafzimmer go-librespot[2159]: go-librespot daemon starting...
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: sendMpdCommand stop took 115 milliseconds
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 28 milliseconds
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 23 milliseconds
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 17 milliseconds
Oct 12 20:36:23 volumio-schlafzimmer go-librespot[2159]: time="2026-10-12T20:36:23+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 12 milliseconds
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:23 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:36:23 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: touch_display: Setting screensaver timeout to 120 seconds.
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 19 milliseconds
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 19 milliseconds
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 18 milliseconds
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: ------------------------------ 240ms
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: ------------------------------ 225ms
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: ------------------------------ 219ms
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: ------------------------------ 212ms
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Oct 12 20:36:23 volumio-schlafzimmer volumio[671]: info: touch_display: Setting screensaver timeout to 120 seconds.
Oct 12 20:36:24 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:36:24 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPlay
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::play index undefined
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::startPlaybackTimer
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: info: [1791830185450] ControllerWebradio::clearAddPlayTrack
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand stop
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: info: sendMpdCommand stop took 2 milliseconds
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand clear
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: info: sendMpdCommand clear took 3 milliseconds
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand load "https://streams.egofm.de/egoFM-hq"
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: error: updateQueue error: null
Oct 12 20:36:25 volumio-schlafzimmer volumio[671]: info: ------------------------------ 16ms
Oct 12 20:36:26 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:36:26 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 30.
Oct 12 20:36:26 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:36:26 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:36:26 volumio-schlafzimmer go-librespot[2179]: go-librespot daemon starting...
Oct 12 20:36:26 volumio-schlafzimmer go-librespot[2179]: time="2026-10-12T20:36:26+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:36:26 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:36:26 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:36:27 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:36:27 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:36:27 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand add "https://streams.egofm.de/egoFM-hq"
Oct 12 20:36:27 volumio-schlafzimmer volumio[671]: error: updateQueue error: null
Oct 12 20:36:27 volumio-schlafzimmer volumio[671]: error: updateQueue error: null
Oct 12 20:36:27 volumio-schlafzimmer volumio[671]: error: updateQueue error: null
Oct 12 20:36:27 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:27 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:27 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:27 volumio-schlafzimmer volumio[671]: info: ------------------------------ 2537ms
Oct 12 20:36:27 volumio-schlafzimmer volumio[671]: info: ------------------------------ 2534ms
Oct 12 20:36:27 volumio-schlafzimmer volumio[671]: info: ------------------------------ 2532ms
Oct 12 20:36:28 volumio-schlafzimmer volumio[671]: info: sendMpdCommand add "https://streams.egofm.de/egoFM-hq" took 6 milliseconds
Oct 12 20:36:28 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 12 20:36:28 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand play
Oct 12 20:36:28 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:28 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:28 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:28 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:28 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:28 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:28 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:28 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:28 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:28 volumio-schlafzimmer volumio[671]: info: ------------------------------ 17ms
Oct 12 20:36:28 volumio-schlafzimmer volumio[671]: info: sendMpdCommand play took 13 milliseconds
Oct 12 20:36:28 volumio-schlafzimmer volumio[671]: info: ------------------------------ 11ms
Oct 12 20:36:28 volumio-schlafzimmer volumio[671]: info: ------------------------------ 9ms
Oct 12 20:36:28 volumio-schlafzimmer volumio[671]: info: ------------------------------ 6ms
Oct 12 20:36:28 volumio-schlafzimmer kernel: EXT4-fs error (device mmcblk0p3): ext4_validate_inode_bitmap:105: comm nmbd: Corrupt inode bitmap - block_group = 481, inode_bitmap = 3932178
Oct 12 20:36:28 volumio-schlafzimmer kernel: EXT4-fs error (device mmcblk0p3): ext4_validate_inode_bitmap:105: comm nmbd: Corrupt inode bitmap - block_group = 480, inode_bitmap = 3932177
Oct 12 20:36:28 volumio-schlafzimmer kernel: EXT4-fs error (device mmcblk0p3) in ext4_free_inode:362: Filesystem failed CRC
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:29 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:36:29 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 31.
Oct 12 20:36:29 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info: FusionDsp -  ---- read samplerate, raw: 44100,S32_LE,2,32
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info: FusionDsp -  ---- read samplerate from file: 44100
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info: FusionDsp -  If filter freq >samplerate/2 then disable it
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 76 milliseconds
Oct 12 20:36:29 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 74 milliseconds
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 71 milliseconds
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 66 milliseconds
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:29 volumio-schlafzimmer go-librespot[2205]: go-librespot daemon starting...
Oct 12 20:36:29 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 58 milliseconds
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ------------------------------ 65ms
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 54 milliseconds
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 54 milliseconds
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 51 milliseconds
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 39 milliseconds
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 39 milliseconds
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 33 milliseconds
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 24 milliseconds
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 21 milliseconds
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Senseless Optimism - Heat","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:30 volumio-schlafzimmer go-librespot[2205]: time="2026-10-12T20:36:30+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus stop
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:30 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Senseless Optimism - Heat","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus play
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: Received an update from plugin. extracting info from payload
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:30 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Senseless Optimism - Heat","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus play
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: Received an update from plugin. extracting info from payload
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Senseless Optimism - Heat","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus play
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: Received an update from plugin. extracting info from payload
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ------------------------------ 238ms
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ------------------------------ 366ms
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ------------------------------ 362ms
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ------------------------------ 361ms
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces system playlist update
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: Ignoring MPD Status Update
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 254 milliseconds
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 250 milliseconds
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 248 milliseconds
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ------------------------------ 33ms
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 29 milliseconds
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1737,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Senseless Optimism - Heat","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus play
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: Received an update from plugin. extracting info from payload
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1862,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Senseless Optimism - Heat","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus play
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: Received an update from plugin. extracting info from payload
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1862,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Senseless Optimism - Heat","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus play
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: Received an update from plugin. extracting info from payload
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1862,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Senseless Optimism - Heat","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus play
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: Received an update from plugin. extracting info from payload
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1862,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Senseless Optimism - Heat","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus play
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: Received an update from plugin. extracting info from payload
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ------------------------------ 825ms
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ------------------------------ 824ms
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ------------------------------ 792ms
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ------------------------------ 782ms
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ------------------------------ 781ms
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ------------------------------ 693ms
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 689 milliseconds
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ------------------------------ 687ms
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 682 milliseconds
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 653 milliseconds
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2102,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Senseless Optimism - Heat","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus play
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: Received an update from plugin. extracting info from payload
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 12 20:36:30 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: ------------------------------ 768ms
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 85 milliseconds
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 85 milliseconds
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2102,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Senseless Optimism - Heat","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus play
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: Received an update from plugin. extracting info from payload
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2102,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Senseless Optimism - Heat","artist":"egofm","album":null,"uri":"https://streams.egofm.de/egoFM-hq","trackType":""}
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: verbose: CURRENT POSITION 0
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   stateService play
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::syncState   currentStatus play
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: Received an update from plugin. extracting info from payload
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: ------------------------------ 935ms
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: ------------------------------ 929ms
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:31 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:36:33 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:36:33 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 32.
Oct 12 20:36:33 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:36:33 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:36:33 volumio-schlafzimmer go-librespot[2214]: go-librespot daemon starting...
Oct 12 20:36:33 volumio-schlafzimmer go-librespot[2214]: time="2026-10-12T20:36:33+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:36:33 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:36:33 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:36:34 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:36:34 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioStop
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::stop
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::stPlaybackTimer
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::updateTrackBlock
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrackBlock
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::serviceStop
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::serviceStop
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: [1791830196133] ControllerWebradio::stop
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand stop
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: sendMpdCommand stop took 81 milliseconds
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 3 milliseconds
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info:
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: ---------------------------- MPD announces state update: player
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: ControllerMpd::getState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand status
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 24 milliseconds
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 20 milliseconds
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 15 milliseconds
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: sendMpdCommand status took 10 milliseconds
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: ------------------------------ 100ms
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: touch_display: Setting screensaver timeout to 120 seconds.
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 86 milliseconds
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 85 milliseconds
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: sendMpdCommand playlistinfo took 85 milliseconds
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: verbose: ControllerMpd::parseTrackInfo
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: ControllerMpd::pushState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::servicePushState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreStateMachine::pushState
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioPushState
Oct 12 20:36:36 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:36:36 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 33.
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Oct 12 20:36:36 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: ------------------------------ 237ms
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: ------------------------------ 233ms
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: info: ------------------------------ 229ms
Oct 12 20:36:36 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:36:36 volumio-schlafzimmer go-librespot[2223]: go-librespot daemon starting...
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:36 volumio-schlafzimmer volumio[671]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Oct 12 20:36:36 volumio-schlafzimmer go-librespot[2223]: time="2026-10-12T20:36:36+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:36:36 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:36:36 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:36:37 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:36:37 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:36:39 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::volumioGetState
Oct 12 20:36:39 volumio-schlafzimmer volumio[671]: info: CorePlayQueue::getTrack 0
Oct 12 20:36:39 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:36:39 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 34.
Oct 12 20:36:39 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:36:39 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:36:39 volumio-schlafzimmer go-librespot[2250]: go-librespot daemon starting...
Oct 12 20:36:39 volumio-schlafzimmer go-librespot[2250]: time="2026-10-12T20:36:39+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:36:39 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:36:39 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:36:40 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:36:40 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:36:42 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 12 20:36:42 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 12 20:36:42 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 12 20:36:42 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 12 20:36:42 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs
Oct 12 20:36:42 volumio-schlafzimmer volumio[671]: info: Received Get System Version
Oct 12 20:36:42 volumio-schlafzimmer volumio[671]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 12 20:36:42 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:36:42 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 35.
Oct 12 20:36:42 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:36:42 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:36:42 volumio-schlafzimmer go-librespot[2272]: go-librespot daemon starting...
Oct 12 20:36:42 volumio-schlafzimmer go-librespot[2272]: time="2026-10-12T20:36:42+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:36:42 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:36:42 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:36:43 volumio-schlafzimmer volumio[671]: info: Initializing connection to go-librespot Websocket
Oct 12 20:36:43 volumio-schlafzimmer volumio[671]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 12 20:36:45 volumio-schlafzimmer volumio-remote-updater[459]: No test mode
Oct 12 20:36:45 volumio-schlafzimmer volumio-remote-updater[459]: No alpha test mode
Oct 12 20:36:45 volumio-schlafzimmer volumio[671]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\nFix for BLE notification issues
\nFix for mDNS/BCT
\n
\nNEW ADDITIONS
\n\nUpdate Tidal SDK
\nUpdate Qobuz Connect SDK
\n\n","title":"Update v3.912","updateavailable":true}
Oct 12 20:36:45 volumio-schlafzimmer volumio[671]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 12 20:36:45 volumio-schlafzimmer volumio[671]: SyntaxError: /data/configuration/plugins.json: Unexpected token g in JSON at position 0
Oct 12 20:36:45 volumio-schlafzimmer volumio[671]:     at JSON.parse ()
Oct 12 20:36:45 volumio-schlafzimmer volumio[671]:     at Object.readFileSync (/volumio/node_modules/jsonfile/index.js:69:17)
Oct 12 20:36:45 volumio-schlafzimmer volumio[671]:     at PluginManager.getAllPlugNames (/volumio/app/pluginmanager.js:568:21)
Oct 12 20:36:45 volumio-schlafzimmer volumio[671]:     at PluginManager.getPluginsMatrix (/volumio/app/pluginmanager.js:592:26)
Oct 12 20:36:45 volumio-schlafzimmer volumio[671]:     at PluginManager.listPluginsBrokenByNewVersion (/volumio/app/pluginmanager.js:1224:22)
Oct 12 20:36:45 volumio-schlafzimmer volumio[671]:     at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:978:60)
Oct 12 20:36:45 volumio-schlafzimmer volumio[671]:     at Socket.emit (events.js:315:20)
Oct 12 20:36:45 volumio-schlafzimmer volumio[671]:     at /volumio/node_modules/socket.io/lib/socket.js:528:12
Oct 12 20:36:45 volumio-schlafzimmer volumio[671]:     at processTicksAndRejections (internal/process/task_queues.js:75:11)
Oct 12 20:36:45 volumio-schlafzimmer volumio[671]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 12 20:36:46 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Oct 12 20:36:46 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 36.
Oct 12 20:36:46 volumio-schlafzimmer systemd[1]: Stopped go-librespot Daemon.
Oct 12 20:36:46 volumio-schlafzimmer systemd[1]: Started go-librespot Daemon.
Oct 12 20:36:46 volumio-schlafzimmer go-librespot[2288]: go-librespot daemon starting...
Oct 12 20:36:46 volumio-schlafzimmer go-librespot[2288]: time="2026-10-12T20:36:46+02:00" level=fatal msg="failed loading config" error="failed reading configuration file: yaml: control characters are not allowed"
Oct 12 20:36:46 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 12 20:36:46 volumio-schlafzimmer systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 12 20:36:46 volumio-schlafzimmer sudo[2297]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-12 20:35
Oct 12 20:36:46 volumio-schlafzimmer sudo[2297]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET"
VOLUMIO_VERSION="3.886"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"