-- Logs begin at Wed 2026-03-04 14:55:57 EET, end at Wed 2026-03-04 15:30:39 EET. -- Mar 04 15:29:02 displaystreamer volumio[1217]: info: CoreCommandRouter::volumioPlay Mar 04 15:29:02 displaystreamer volumio[1217]: info: CoreStateMachine::play index undefined Mar 04 15:29:02 displaystreamer volumio[1217]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 15:29:02 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:02 displaystreamer volumio[1217]: info: CoreStateMachine::startPlaybackTimer Mar 04 15:29:02 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:02 displaystreamer volumio[1217]: info: Spotify Resume Mar 04 15:29:02 displaystreamer volumio[1217]: info: Sending Spotify command to local API: /player/resume Mar 04 15:29:02 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:02+02:00" level=debug msg="vorbis: corrupt or missing data in bitstream" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:02 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:02+02:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:03 displaystreamer volumio[1217]: info: CoreCommandRouter::volumioPlay Mar 04 15:29:03 displaystreamer volumio[1217]: info: CoreStateMachine::play index undefined Mar 04 15:29:03 displaystreamer volumio[1217]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 15:29:03 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:03 displaystreamer volumio[1217]: info: CoreStateMachine::startPlaybackTimer Mar 04 15:29:03 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:03 displaystreamer volumio[1217]: info: Spotify Resume Mar 04 15:29:03 displaystreamer volumio[1217]: info: Sending Spotify command to local API: /player/resume Mar 04 15:29:03 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:03+02:00" level=debug msg="vorbis: corrupt or missing data in bitstream" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:03 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:03+02:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:04 displaystreamer volumio[1217]: info: CoreCommandRouter::volumioPlay Mar 04 15:29:04 displaystreamer volumio[1217]: info: CoreStateMachine::play index undefined Mar 04 15:29:04 displaystreamer volumio[1217]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 15:29:04 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:04 displaystreamer volumio[1217]: info: CoreStateMachine::startPlaybackTimer Mar 04 15:29:04 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:04 displaystreamer volumio[1217]: info: Spotify Resume Mar 04 15:29:04 displaystreamer volumio[1217]: info: Sending Spotify command to local API: /player/resume Mar 04 15:29:04 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:04+02:00" level=debug msg="vorbis: corrupt or missing data in bitstream" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:04 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:04+02:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:04 displaystreamer volumio[1217]: info: CoreCommandRouter::volumioPlay Mar 04 15:29:04 displaystreamer volumio[1217]: info: CoreStateMachine::play index undefined Mar 04 15:29:04 displaystreamer volumio[1217]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 15:29:04 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:04 displaystreamer volumio[1217]: info: CoreStateMachine::startPlaybackTimer Mar 04 15:29:04 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:04 displaystreamer volumio[1217]: info: Spotify Resume Mar 04 15:29:04 displaystreamer volumio[1217]: info: Sending Spotify command to local API: /player/resume Mar 04 15:29:04 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:04+02:00" level=debug msg="vorbis: corrupt or missing data in bitstream" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:04 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:04+02:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:04 displaystreamer volumio[1217]: info: CoreCommandRouter::volumioPlay Mar 04 15:29:04 displaystreamer volumio[1217]: info: CoreStateMachine::play index undefined Mar 04 15:29:04 displaystreamer volumio[1217]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 15:29:04 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:04 displaystreamer volumio[1217]: info: CoreStateMachine::startPlaybackTimer Mar 04 15:29:04 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:04 displaystreamer volumio[1217]: info: Spotify Resume Mar 04 15:29:04 displaystreamer volumio[1217]: info: Sending Spotify command to local API: /player/resume Mar 04 15:29:04 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:04+02:00" level=debug msg="vorbis: corrupt or missing data in bitstream" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:04 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:04+02:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:04 displaystreamer volumio[1217]: info: CoreCommandRouter::volumioPlay Mar 04 15:29:04 displaystreamer volumio[1217]: info: CoreStateMachine::play index undefined Mar 04 15:29:04 displaystreamer volumio[1217]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 15:29:04 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:04 displaystreamer volumio[1217]: info: CoreStateMachine::startPlaybackTimer Mar 04 15:29:04 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:04 displaystreamer volumio[1217]: info: Spotify Resume Mar 04 15:29:04 displaystreamer volumio[1217]: info: Sending Spotify command to local API: /player/resume Mar 04 15:29:04 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:04+02:00" level=debug msg="vorbis: corrupt or missing data in bitstream" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:04 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:04+02:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreCommandRouter::volumioPlay Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreStateMachine::play index undefined Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 15:29:05 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreStateMachine::startPlaybackTimer Mar 04 15:29:05 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:05 displaystreamer volumio[1217]: info: Spotify Resume Mar 04 15:29:05 displaystreamer volumio[1217]: info: Sending Spotify command to local API: /player/resume Mar 04 15:29:05 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:05+02:00" level=debug msg="vorbis: corrupt or missing data in bitstream" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:05 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:05+02:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreCommandRouter::volumioPlay Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreStateMachine::play index undefined Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 15:29:05 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreStateMachine::startPlaybackTimer Mar 04 15:29:05 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:05 displaystreamer volumio[1217]: info: Spotify Resume Mar 04 15:29:05 displaystreamer volumio[1217]: info: Sending Spotify command to local API: /player/resume Mar 04 15:29:05 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:05+02:00" level=debug msg="vorbis: corrupt or missing data in bitstream" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:05 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:05+02:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreCommandRouter::volumioPlay Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreStateMachine::play index undefined Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 15:29:05 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreStateMachine::startPlaybackTimer Mar 04 15:29:05 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:05 displaystreamer volumio[1217]: info: Spotify Resume Mar 04 15:29:05 displaystreamer volumio[1217]: info: Sending Spotify command to local API: /player/resume Mar 04 15:29:05 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:05+02:00" level=debug msg="vorbis: corrupt or missing data in bitstream" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:05 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:05+02:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreCommandRouter::volumioPlay Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreStateMachine::play index undefined Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 15:29:05 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreStateMachine::startPlaybackTimer Mar 04 15:29:05 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:05 displaystreamer volumio[1217]: info: Spotify Resume Mar 04 15:29:05 displaystreamer volumio[1217]: info: Sending Spotify command to local API: /player/resume Mar 04 15:29:05 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:05+02:00" level=debug msg="vorbis: corrupt or missing data in bitstream" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:05 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:05+02:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreCommandRouter::volumioPlay Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreStateMachine::play index undefined Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 15:29:05 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:05 displaystreamer volumio[1217]: info: CoreStateMachine::startPlaybackTimer Mar 04 15:29:05 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:05 displaystreamer volumio[1217]: info: Spotify Resume Mar 04 15:29:05 displaystreamer volumio[1217]: info: Sending Spotify command to local API: /player/resume Mar 04 15:29:05 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:05+02:00" level=debug msg="vorbis: corrupt or missing data in bitstream" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:05 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:05+02:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:06 displaystreamer volumio[1217]: info: CoreCommandRouter::volumioPlay Mar 04 15:29:06 displaystreamer volumio[1217]: info: CoreStateMachine::play index undefined Mar 04 15:29:06 displaystreamer volumio[1217]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 15:29:06 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:06 displaystreamer volumio[1217]: info: CoreStateMachine::startPlaybackTimer Mar 04 15:29:06 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:06 displaystreamer volumio[1217]: info: Spotify Resume Mar 04 15:29:06 displaystreamer volumio[1217]: info: Sending Spotify command to local API: /player/resume Mar 04 15:29:06 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:06+02:00" level=debug msg="vorbis: corrupt or missing data in bitstream" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:06 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:06+02:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:10 displaystreamer volumio[1217]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 15:29:10 displaystreamer volumio[1217]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 15:29:10 displaystreamer volumio[1217]: info: Retrieving Cloud Streaming UI Mar 04 15:29:10 displaystreamer volumio[1217]: info: Getting Tidal Cloud Configuration Mar 04 15:29:10 displaystreamer volumio[1217]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 15:29:10 displaystreamer volumio[1217]: info: Getting Qobuz Cloud Configuration Mar 04 15:29:10 displaystreamer volumio[1217]: info: Asking plugin for UI Config Mar 04 15:29:10 displaystreamer volumio[1217]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 15:29:10 displaystreamer volumio[1217]: info: Getting Spotify Cloud Configuration Mar 04 15:29:10 displaystreamer volumio[1217]: info: Asking plugin for UI Config Mar 04 15:29:10 displaystreamer volumio[1217]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 15:29:10 displaystreamer volumio[1217]: info: Saving Spotify Acccount Mar 04 15:29:10 displaystreamer volumio[1217]: info: Got it Mar 04 15:29:10 displaystreamer volumio[1217]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 04 15:29:10 displaystreamer volumio[1217]: info: Got Tidal Cloud Configuration Mar 04 15:29:10 displaystreamer volumio[1217]: info: Got it Mar 04 15:29:10 displaystreamer volumio[1217]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 15:29:10 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 04 15:29:10 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 04 15:29:10 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 04 15:29:10 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 04 15:29:10 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 04 15:29:10 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 04 15:29:10 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 04 15:29:10 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 04 15:29:10 displaystreamer volumio[1217]: info: CoreCommandRouter::volumioGetBrowseSources Mar 04 15:29:10 displaystreamer volumio[1217]: info: CoreCommandRouter::volumioGetBrowseSources Mar 04 15:29:10 displaystreamer volumio[1217]: info: CoreCommandRouter::volumioGetBrowseSources Mar 04 15:29:10 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:29:10 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 04 15:29:14 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:29:18 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:29:21 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:21+02:00" level=trace msg="sent dealer ping" Mar 04 15:29:22 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:22+02:00" level=trace msg="received dealer pong" Mar 04 15:29:22 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:29:24 displaystreamer volumio[1217]: info: Disabling MyMusic plugin multiroom Mar 04 15:29:24 displaystreamer volumio[1217]: info: [MyVolumio PluginManager] Disabling and stopping plugin audio_interface multiroom Mar 04 15:29:24 displaystreamer volumio[1217]: info: Disabling plugin multiroom Mar 04 15:29:24 displaystreamer volumio[1217]: info: Preparing to generate the ALSA configuration file Mar 04 15:29:24 displaystreamer volumio[1217]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Mar 04 15:29:24 displaystreamer volumio[1217]: info: Reading ALSA contributions from plugins. Mar 04 15:29:24 displaystreamer volumio[1217]: info: Asound.conf file written Mar 04 15:29:24 displaystreamer sudo[9102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 04 15:29:24 displaystreamer sudo[9102]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 15:29:24 displaystreamer sudo[9102]: pam_unix(sudo:session): session closed for user root Mar 04 15:29:24 displaystreamer volumio[1217]: info: Output device has changed, restarting MPD Mar 04 15:29:24 displaystreamer sudo[9109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 04 15:29:24 displaystreamer sudo[9109]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 15:29:24 displaystreamer sudo[9109]: pam_unix(sudo:session): session closed for user root Mar 04 15:29:24 displaystreamer volumio[1217]: info: Output device has changed, restarting Shairport Sync Mar 04 15:29:24 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 15:29:24 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 15:29:24 displaystreamer sudo[9112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 04 15:29:24 displaystreamer sudo[9112]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 15:29:24 displaystreamer systemd[1]: Stopping Music Player Daemon... Mar 04 15:29:24 displaystreamer volumio[1217]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 04 15:29:24 displaystreamer volumio[1217]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 04 15:29:24 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 15:29:24 displaystreamer systemd[1]: mpd.service: Succeeded. Mar 04 15:29:24 displaystreamer systemd[1]: Stopped Music Player Daemon. Mar 04 15:29:24 displaystreamer volumio[1217]: info: MPD Permissions set Mar 04 15:29:24 displaystreamer volumio[1217]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Mar 04 15:29:24 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 15:29:24 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 15:29:24 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 15:29:24 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 15:29:24 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 15:29:24 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 15:29:24 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 15:29:24 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 15:29:24 displaystreamer systemd[1]: Starting Music Player Daemon... Mar 04 15:29:24 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 15:29:24 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 15:29:24 displaystreamer volumio[1217]: info: Starting Shairport Sync Mar 04 15:29:24 displaystreamer volumio[1217]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Mar 04 15:29:24 displaystreamer volumio[1217]: info: CoreCommandRouter::volumioGetState Mar 04 15:29:24 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:24 displaystreamer volumio[1217]: info: mpdhttpout --- Volumio set on pause Mar 04 15:29:24 displaystreamer sudo[9125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 04 15:29:24 displaystreamer sudo[9125]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 15:29:24 displaystreamer sudo[9117]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 04 15:29:24 displaystreamer sudo[9117]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 15:29:24 displaystreamer sudo[9117]: pam_unix(sudo:session): session closed for user root Mar 04 15:29:24 displaystreamer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 04 15:29:24 displaystreamer systemd[1]: shairport-sync.service: Succeeded. Mar 04 15:29:24 displaystreamer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 04 15:29:24 displaystreamer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 04 15:29:24 displaystreamer sudo[9125]: pam_unix(sudo:session): session closed for user root Mar 04 15:29:24 displaystreamer volumio[1217]: info: Shairport-Sync Started Mar 04 15:29:24 displaystreamer mpd[9128]: Mar 04 15:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 04 15:29:24 displaystreamer systemd[1]: Started Music Player Daemon. Mar 04 15:29:24 displaystreamer sudo[9112]: pam_unix(sudo:session): session closed for user root Mar 04 15:29:24 displaystreamer volumio[1217]: error: updateQueue error: null Mar 04 15:29:26 displaystreamer kernel: hwmon hwmon3: Undervoltage detected! Mar 04 15:29:26 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:29:26 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Mar 04 15:29:26 displaystreamer sudo[9136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 04 15:29:26 displaystreamer sudo[9136]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 15:29:26 displaystreamer systemd[1]: Stopping Music Player Daemon... Mar 04 15:29:26 displaystreamer systemd[1]: mpd.service: Succeeded. Mar 04 15:29:26 displaystreamer systemd[1]: Stopped Music Player Daemon. Mar 04 15:29:26 displaystreamer systemd[1]: Starting Music Player Daemon... Mar 04 15:29:26 displaystreamer sudo[9138]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 04 15:29:26 displaystreamer sudo[9138]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 15:29:26 displaystreamer sudo[9138]: pam_unix(sudo:session): session closed for user root Mar 04 15:29:27 displaystreamer mpd[9140]: Mar 04 15:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 04 15:29:27 displaystreamer systemd[1]: Started Music Player Daemon. Mar 04 15:29:27 displaystreamer sudo[9136]: pam_unix(sudo:session): session closed for user root Mar 04 15:29:27 displaystreamer volumio[1217]: error: updateQueue error: null Mar 04 15:29:30 displaystreamer kernel: hwmon hwmon3: Voltage normalised Mar 04 15:29:30 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:29:34 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:29:38 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:29:41 displaystreamer volumio[1217]: info: Disabling MyMusic plugin smart_inputs Mar 04 15:29:41 displaystreamer volumio[1217]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service smart_inputs Mar 04 15:29:41 displaystreamer volumio[1217]: info: Removeing all smart Inputs Mar 04 15:29:41 displaystreamer volumio[1217]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSG Control Mic Mar 04 15:29:41 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 04 15:29:41 displaystreamer volumio[1217]: Cannot find translation for source YouTube2 Mar 04 15:29:41 displaystreamer volumio[1217]: Cannot find translation for source Randomizer Mar 04 15:29:41 displaystreamer volumio[1217]: info: Disabling plugin smart_inputs Mar 04 15:29:42 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:29:46 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:29:50 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:29:51 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:51+02:00" level=trace msg="received accesspoint ping" Mar 04 15:29:51 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:51+02:00" level=trace msg="received accesspoint pong ack" Mar 04 15:29:51 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:51+02:00" level=trace msg="sent dealer ping" Mar 04 15:29:52 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:52+02:00" level=trace msg="received dealer pong" Mar 04 15:29:54 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:29:55 displaystreamer volumio[1217]: info: CoreCommandRouter::volumioPlay Mar 04 15:29:55 displaystreamer volumio[1217]: info: CoreStateMachine::play index undefined Mar 04 15:29:55 displaystreamer volumio[1217]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 15:29:55 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:55 displaystreamer volumio[1217]: info: CoreStateMachine::startPlaybackTimer Mar 04 15:29:55 displaystreamer volumio[1217]: info: CorePlayQueue::getTrack 57 Mar 04 15:29:55 displaystreamer volumio[1217]: info: Spotify Resume Mar 04 15:29:55 displaystreamer volumio[1217]: info: Sending Spotify command to local API: /player/resume Mar 04 15:29:55 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:55+02:00" level=debug msg="vorbis: corrupt or missing data in bitstream" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:55 displaystreamer go-librespot[3093]: time="2026-03-04T15:29:55+02:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:6XfW9kVcAajJYUyGl4P7Ah" Mar 04 15:29:58 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:30:02 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:30:06 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:30:10 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:30:14 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:30:18 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:30:21 displaystreamer go-librespot[3093]: time="2026-03-04T15:30:21+02:00" level=trace msg="sent dealer ping" Mar 04 15:30:22 displaystreamer go-librespot[3093]: time="2026-03-04T15:30:22+02:00" level=trace msg="received dealer pong" Mar 04 15:30:22 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:30:26 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:30:30 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:30:34 displaystreamer volumiossh-tunnel[8971]: Connection to eu10.myvolumio.org closed by remote host. Mar 04 15:30:34 displaystreamer autossh[8972]: ssh exited with error status 255; restarting ssh Mar 04 15:30:34 displaystreamer autossh[8972]: starting ssh (count 2) Mar 04 15:30:34 displaystreamer autossh[8972]: ssh child pid is 9293 Mar 04 15:30:34 displaystreamer volumiossh-tunnel[8971]: ssh: connect to host eu10.myvolumio.org port 2222: Connection refused Mar 04 15:30:34 displaystreamer autossh[8972]: ssh exited with error status 255; restarting ssh Mar 04 15:30:34 displaystreamer autossh[8972]: starting ssh (count 3) Mar 04 15:30:34 displaystreamer autossh[8972]: ssh child pid is 9294 Mar 04 15:30:34 displaystreamer volumiossh-tunnel[8971]: ssh: connect to host eu10.myvolumio.org port 2222: Connection refused Mar 04 15:30:34 displaystreamer autossh[8972]: ssh exited with error status 255; restarting ssh Mar 04 15:30:34 displaystreamer autossh[8972]: starting ssh (count 4) Mar 04 15:30:34 displaystreamer autossh[8972]: ssh child pid is 9295 Mar 04 15:30:34 displaystreamer volumiossh-tunnel[8971]: ssh: connect to host eu10.myvolumio.org port 2222: Connection refused Mar 04 15:30:34 displaystreamer autossh[8972]: ssh exited with error status 255; restarting ssh Mar 04 15:30:34 displaystreamer autossh[8972]: starting ssh (count 5) Mar 04 15:30:34 displaystreamer autossh[8972]: ssh child pid is 9296 Mar 04 15:30:34 displaystreamer volumiossh-tunnel[8971]: ssh: connect to host eu10.myvolumio.org port 2222: Connection refused Mar 04 15:30:34 displaystreamer autossh[8972]: ssh exited with error status 255; restarting ssh Mar 04 15:30:34 displaystreamer autossh[8972]: starting ssh (count 6) Mar 04 15:30:34 displaystreamer autossh[8972]: ssh child pid is 9297 Mar 04 15:30:34 displaystreamer volumiossh-tunnel[8971]: ssh: connect to host eu10.myvolumio.org port 2222: Connection refused Mar 04 15:30:34 displaystreamer autossh[8972]: ssh exited with error status 255; restarting ssh Mar 04 15:30:34 displaystreamer autossh[8972]: starting ssh (count 7) Mar 04 15:30:34 displaystreamer autossh[8972]: ssh child pid is 9298 Mar 04 15:30:34 displaystreamer volumiossh-tunnel[8971]: ssh: connect to host eu10.myvolumio.org port 2222: Connection refused Mar 04 15:30:34 displaystreamer autossh[8972]: ssh exited with error status 255; restarting ssh Mar 04 15:30:34 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:30:36 displaystreamer autossh[8972]: starting ssh (count 8) Mar 04 15:30:36 displaystreamer autossh[8972]: ssh child pid is 9299 Mar 04 15:30:36 displaystreamer volumiossh-tunnel[8971]: ssh: connect to host eu10.myvolumio.org port 2222: Connection refused Mar 04 15:30:36 displaystreamer autossh[8972]: ssh exited with error status 255; restarting ssh Mar 04 15:30:36 displaystreamer volumio[1217]: info: Disabling MyMusic plugin upnp Mar 04 15:30:36 displaystreamer sudo[9301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Mar 04 15:30:36 displaystreamer sudo[9301]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 15:30:36 displaystreamer volumio[1217]: error: Upnp client error: Error: This socket has been ended by the other party Mar 04 15:30:36 displaystreamer systemd[1]: Stopping UPnP Renderer front-end to MPD... Mar 04 15:30:38 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 15:30:39 displaystreamer volumio[1217]: info: Enabling MyMusic plugin upnp Mar 04 15:30:39 displaystreamer volumio[1217]: info: Enabling plugin upnp Mar 04 15:30:39 displaystreamer volumio[1217]: info: Loading plugin "upnp"... Mar 04 15:30:39 displaystreamer volumio[1217]: info: [1772631039531] Starting Upmpd Daemon Mar 04 15:30:39 displaystreamer volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 04 15:30:39 displaystreamer volumio[1217]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 15:30:39 displaystreamer volumio[1217]: Error: listen EADDRINUSE: address already in use :::6599 Mar 04 15:30:39 displaystreamer volumio[1217]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Mar 04 15:30:39 displaystreamer volumio[1217]: at listenInCluster (net.js:1366:12) Mar 04 15:30:39 displaystreamer volumio[1217]: at Server.listen (net.js:1452:7) Mar 04 15:30:39 displaystreamer volumio[1217]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Mar 04 15:30:39 displaystreamer volumio[1217]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Mar 04 15:30:39 displaystreamer volumio[1217]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Mar 04 15:30:39 displaystreamer volumio[1217]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Mar 04 15:30:39 displaystreamer volumio[1217]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Mar 04 15:30:39 displaystreamer volumio[1217]: code: 'EADDRINUSE', Mar 04 15:30:39 displaystreamer volumio[1217]: errno: -98, Mar 04 15:30:39 displaystreamer volumio[1217]: syscall: 'listen', Mar 04 15:30:39 displaystreamer volumio[1217]: address: '::', Mar 04 15:30:39 displaystreamer volumio[1217]: port: 6599 Mar 04 15:30:39 displaystreamer volumio[1217]: } Mar 04 15:30:39 displaystreamer volumio[1217]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 15:30:39 displaystreamer sudo[9312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-04 15:29 Mar 04 15:30:39 displaystreamer sudo[9312]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Feb 2026 01:46:18 PM CET" VOLUMIO_VERSION="3.908" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3e9dbaf8f44792d26e97456a18f12823"