Apr 12 19:41:02 display volumio[1433]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Apr 12 19:41:02 display volumio[1433]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Apr 12 19:41:06 display volumio[1433]: error: camilladsp exceeded max consecutive respawns (10); stopping respawn. Plugin restart required. Apr 12 19:41:10 display volumio[1433]: info: [now-playing] Weather not configured: Weather is not set up: add Geographic Coordinates in Localization and an OpenWeatherMap API key in Weather Service. Apr 12 19:41:13 display volumio[1433]: info: camilladsp respawn in 10000 ms (attempt 8/10) Apr 12 19:41:14 display volumio[1433]: error: FusionDsp - Monitor WebSocket error: [object Object] Apr 12 19:41:14 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:14 display volumio[1433]: error: FusionDsp - Monitor WebSocket error: [object Object] Apr 12 19:41:14 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:20 display volumio[1433]: error: FusionDsp - Monitor WebSocket error: [object Object] Apr 12 19:41:20 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:22 display volumio[1433]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Apr 12 19:41:22 display volumio[1433]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor started Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor started Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor started Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor started Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor started Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor started Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor started Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor started Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor started Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor started Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor started Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor started Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:23 display volumio[1433]: info: camilladsp respawn in 10000 ms (attempt 9/10) Apr 12 19:41:23 display volumio[1433]: error: FusionDsp - Monitor WebSocket error: [object Object] Apr 12 19:41:23 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::volumioNext Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::next Apr 12 19:41:26 display volumio[1433]: info: [1776040886320] ControllerTidal::next Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::next Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::stop Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::stPlaybackTimer Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::updateTrackBlock Apr 12 19:41:26 display volumio[1433]: info: CorePlayQueue::getTrackBlock Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::pushState Apr 12 19:41:26 display volumio[1433]: info: CorePlayQueue::getTrack 5 Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::volumioPushState Apr 12 19:41:26 display volumio[1433]: info: MRS: Pushing multiroomSync output update for this device Apr 12 19:41:26 display volumio[1433]: info: MRS: Pushing multiroomSync output Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:41:26 display volumio[1433]: info: CorePlayQueue::getTrack 5 Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::serviceStop Apr 12 19:41:26 display volumio[1433]: info: CorePlayQueue::getTrack 5 Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::serviceStop Apr 12 19:41:26 display volumio[1433]: info: [1776040886326] ControllerTidal::stop Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 12 19:41:26 display volumio[1433]: info: ControllerMpd::stop Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand stop Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.329-05:00 level=INFO msg="emitting player state changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" state=STATUS_STOPPED positionMs=0 volume=100 Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.329-05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" state=STATUS_STOPPED positionMs=0 volume=100 Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.329-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" id=tidal://song/1290305 title="Send Her My Love (2024 Remaster)" Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.329-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" id=tidal://song/1290305 title="Send Her My Love (2024 Remaster)" Apr 12 19:41:26 display volumio[1433]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Volumio is not playing Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Clipped samples monitor stopped Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Volumio is not playing Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Clipped samples monitor stopped Apr 12 19:41:26 display sudo[23549]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 12 19:41:26 display sudo[23549]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:41:26 display volumio[1433]: info: Apr 12 19:41:26 display volumio[1433]: ---------------------------- MPD announces state update: player Apr 12 19:41:26 display volumio[1433]: info: sendMpdCommand stop took 23 milliseconds Apr 12 19:41:26 display volumio[1433]: info: ControllerMpd::getState Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand status Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::play index undefined Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 12 19:41:26 display volumio[1433]: info: CorePlayQueue::getTrack 6 Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::startPlaybackTimer Apr 12 19:41:26 display volumio[1433]: info: CorePlayQueue::getTrack 6 Apr 12 19:41:26 display volumio[1433]: info: [1776040886350] ControllerTidal::clearAddPlayTrack Apr 12 19:41:26 display volumio[1433]: info: Getting stream with soundQuality HI_RES Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::updateTrackBlock Apr 12 19:41:26 display volumio[1433]: info: CorePlayQueue::getTrackBlock Apr 12 19:41:26 display volumio[1433]: info: Apr 12 19:41:26 display volumio[1433]: ---------------------------- MPD announces state update: player Apr 12 19:41:26 display volumio[1433]: info: ControllerMpd::getState Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand status Apr 12 19:41:26 display volumio[1433]: info: sendMpdCommand status took 11 milliseconds Apr 12 19:41:26 display volumio[1433]: info: sendMpdCommand status took 8 milliseconds Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::parseState Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::parseState Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 12 19:41:26 display volumio[1433]: info: touch_display: Setting screensaver timeout to 240 seconds. Apr 12 19:41:26 display volumio[1433]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 12 19:41:26 display volumio[1433]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::parseTrackInfo Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::parseTrackInfo Apr 12 19:41:26 display volumio[1433]: info: ControllerMpd::pushState Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::servicePushState Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::pushState Apr 12 19:41:26 display volumio[1433]: info: CorePlayQueue::getTrack 6 Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::volumioPushState Apr 12 19:41:26 display systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Apr 12 19:41:26 display volumio[1433]: info: MRS: Pushing multiroomSync output update for this device Apr 12 19:41:26 display volumio[1433]: info: MRS: Pushing multiroomSync output Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:41:26 display volumio[1433]: info: CorePlayQueue::getTrack 6 Apr 12 19:41:26 display volumio[1433]: info: CorePlayQueue::getTrack 6 Apr 12 19:41:26 display volumio[1433]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Apr 12 19:41:26 display volumio[1433]: info: ControllerMpd::pushState Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::servicePushState Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::pushState Apr 12 19:41:26 display volumio[1433]: info: CorePlayQueue::getTrack 6 Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::volumioPushState Apr 12 19:41:26 display volumio[1433]: info: MRS: Pushing multiroomSync output update for this device Apr 12 19:41:26 display volumio[1433]: info: MRS: Pushing multiroomSync output Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:41:26 display volumio[1433]: info: CorePlayQueue::getTrack 6 Apr 12 19:41:26 display volumio[1433]: info: CorePlayQueue::getTrack 6 Apr 12 19:41:26 display volumio[1433]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.369-05:00 level=INFO msg="emitting player state changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" state=STATUS_STOPPED positionMs=0 volume=100 Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.369-05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" state=STATUS_STOPPED positionMs=0 volume=100 Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.369-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" id=tidal://song/100577989 title=Sara Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.369-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" id=tidal://song/100577989 title=Sara Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.371-05:00 level=INFO msg="emitting player state changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" state=STATUS_STOPPED positionMs=0 volume=100 Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.371-05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" state=STATUS_STOPPED positionMs=0 volume=100 Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.371-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" id=tidal://song/100577989 title=Sara Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.371-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" id=tidal://song/100577989 title=Sara Apr 12 19:41:26 display volumio[1433]: info: ------------------------------ 26ms Apr 12 19:41:26 display volumio[1433]: info: ------------------------------ 23ms Apr 12 19:41:26 display volumio[1433]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 12 19:41:26 display volumio[1433]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 12 19:41:26 display sudo[23554]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 12 19:41:26 display sudo[23554]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Volumio is not playing Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Clipped samples monitor stopped Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Volumio is not playing Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Clipped samples monitor stopped Apr 12 19:41:26 display sudo[23556]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 12 19:41:26 display sudo[23556]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Volumio is not playing Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Clipped samples monitor stopped Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Volumio is not playing Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Clipped samples monitor stopped Apr 12 19:41:26 display systemd[1]: peppymeterbasic.service: Deactivated successfully. Apr 12 19:41:26 display systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Apr 12 19:41:26 display systemd[1]: peppymeterbasic.service: Consumed 15.853s CPU time. Apr 12 19:41:26 display sudo[23556]: pam_unix(sudo:session): session closed for user root Apr 12 19:41:26 display sudo[23549]: pam_unix(sudo:session): session closed for user root Apr 12 19:41:26 display volumio[1433]: info: peppymeterbasic Daemon Stop Apr 12 19:41:26 display volumio[1433]: info: peppymeterbasic Daemon Stop Apr 12 19:41:26 display sudo[23554]: pam_unix(sudo:session): session closed for user root Apr 12 19:41:26 display volumio[1433]: info: peppymeterbasic Daemon Stop Apr 12 19:41:26 display volumio[1433]: info: getStreamUrl took 282 milliseconds Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand stop Apr 12 19:41:26 display volumio[1433]: info: sendMpdCommand stop took 1 milliseconds Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand clear Apr 12 19:41:26 display volumio[1433]: info: Apr 12 19:41:26 display volumio[1433]: ---------------------------- MPD announces system playlist update Apr 12 19:41:26 display volumio[1433]: info: Ignoring MPD Status Update Apr 12 19:41:26 display volumio[1433]: info: sendMpdCommand clear took 0 milliseconds Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand add "http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic3NTNlMDM4YWVhOTNhMGQ5YTBjMmRlMGJlN2MwNzVmY182MS5tcDQ/0.flac?token=1776044486~MzEyOTZlNTZhZTMyYzNiZWVmOWI1NDFiYzk5MGM4YmRkMGYyMGY5YQ==" Apr 12 19:41:26 display volumio[1433]: info: Apr 12 19:41:26 display volumio[1433]: ---------------------------- MPD announces system playlist update Apr 12 19:41:26 display volumio[1433]: info: Ignoring MPD Status Update Apr 12 19:41:26 display volumio[1433]: error: updateQueue error: null Apr 12 19:41:26 display volumio[1433]: info: Apr 12 19:41:26 display volumio[1433]: ---------------------------- MPD announces system playlist update Apr 12 19:41:26 display volumio[1433]: info: Ignoring MPD Status Update Apr 12 19:41:26 display volumio[1433]: info: ------------------------------ 1ms Apr 12 19:41:26 display volumio[1433]: info: sendMpdCommand add "http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic3NTNlMDM4YWVhOTNhMGQ5YTBjMmRlMGJlN2MwNzVmY182MS5tcDQ/0.flac?token=1776044486~MzEyOTZlNTZhZTMyYzNiZWVmOWI1NDFiYzk5MGM4YmRkMGYyMGY5YQ==" took 1 milliseconds Apr 12 19:41:26 display volumio[1433]: info: ------------------------------ 1ms Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand play Apr 12 19:41:26 display volumio[1433]: info: Apr 12 19:41:26 display volumio[1433]: ---------------------------- MPD announces system playlist update Apr 12 19:41:26 display volumio[1433]: info: Ignoring MPD Status Update Apr 12 19:41:26 display volumio[1433]: info: ------------------------------ 0ms Apr 12 19:41:26 display volumio[1433]: info: sendMpdCommand play took 1 milliseconds Apr 12 19:41:26 display volumio[1433]: info: ------------------------------ 1ms Apr 12 19:41:26 display volumio[1433]: info: Apr 12 19:41:26 display volumio[1433]: ---------------------------- MPD announces state update: player Apr 12 19:41:26 display volumio[1433]: info: ControllerMpd::getState Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand status Apr 12 19:41:26 display volumio[1433]: info: Apr 12 19:41:26 display volumio[1433]: ---------------------------- MPD announces state update: player Apr 12 19:41:26 display volumio[1433]: info: ControllerMpd::getState Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand status Apr 12 19:41:26 display volumio[1433]: info: sendMpdCommand status took 2 milliseconds Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::parseState Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 12 19:41:26 display volumio[1433]: info: Apr 12 19:41:26 display volumio[1433]: ---------------------------- MPD announces state update: player Apr 12 19:41:26 display volumio[1433]: info: ControllerMpd::getState Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand status Apr 12 19:41:26 display volumio[1433]: info: Apr 12 19:41:26 display volumio[1433]: ---------------------------- MPD announces state update: player Apr 12 19:41:26 display volumio[1433]: info: ControllerMpd::getState Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand status Apr 12 19:41:26 display volumio[1433]: info: sendMpdCommand status took 3 milliseconds Apr 12 19:41:26 display volumio[1433]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 12 19:41:26 display volumio[1433]: info: sendMpdCommand status took 0 milliseconds Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::parseState Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::parseTrackInfo Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::parseState Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 12 19:41:26 display volumio[1433]: info: ControllerMpd::pushState Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::servicePushState Apr 12 19:41:26 display volumio[1433]: info: CorePlayQueue::getTrack 6 Apr 12 19:41:26 display volumio[1433]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0.flac?token=1776044486~MzEyOTZlNTZhZTMyYzNiZWVmOWI1NDFiYzk5MGM4YmRkMGYyMGY5YQ==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic3NTNlMDM4YWVhOTNhMGQ5YTBjMmRlMGJlN2MwNzVmY182MS5tcDQ/0.flac?token=1776044486~MzEyOTZlNTZhZTMyYzNiZWVmOWI1NDFiYzk5MGM4YmRkMGYyMGY5YQ==","trackType":"tidal"} Apr 12 19:41:26 display volumio[1433]: verbose: CURRENT POSITION 6 Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::syncState stateService play Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::syncState currentStatus stop Apr 12 19:41:26 display volumio[1433]: info: ------------------------------ 4ms Apr 12 19:41:26 display volumio[1433]: info: sendMpdCommand status took 1 milliseconds Apr 12 19:41:26 display volumio[1433]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 12 19:41:26 display volumio[1433]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::parseState Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::parseTrackInfo Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::parseTrackInfo Apr 12 19:41:26 display volumio[1433]: info: ControllerMpd::pushState Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::servicePushState Apr 12 19:41:26 display volumio[1433]: info: CorePlayQueue::getTrack 6 Apr 12 19:41:26 display volumio[1433]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0.flac?token=1776044486~MzEyOTZlNTZhZTMyYzNiZWVmOWI1NDFiYzk5MGM4YmRkMGYyMGY5YQ==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic3NTNlMDM4YWVhOTNhMGQ5YTBjMmRlMGJlN2MwNzVmY182MS5tcDQ/0.flac?token=1776044486~MzEyOTZlNTZhZTMyYzNiZWVmOWI1NDFiYzk5MGM4YmRkMGYyMGY5YQ==","trackType":"tidal"} Apr 12 19:41:26 display volumio[1433]: verbose: CURRENT POSITION 6 Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::syncState stateService play Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::syncState currentStatus play Apr 12 19:41:26 display volumio[1433]: info: Received an update from plugin. extracting info from payload Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::pushState Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::volumioPushState Apr 12 19:41:26 display volumio[1433]: info: MRS: Pushing multiroomSync output update for this device Apr 12 19:41:26 display volumio[1433]: info: MRS: Pushing multiroomSync output Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::pushState Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::volumioPushState Apr 12 19:41:26 display volumio[1433]: info: MRS: Pushing multiroomSync output update for this device Apr 12 19:41:26 display volumio[1433]: info: MRS: Pushing multiroomSync output Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:41:26 display volumio[1433]: info: ControllerMpd::pushState Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::servicePushState Apr 12 19:41:26 display volumio[1433]: info: CorePlayQueue::getTrack 6 Apr 12 19:41:26 display volumio[1433]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0.flac?token=1776044486~MzEyOTZlNTZhZTMyYzNiZWVmOWI1NDFiYzk5MGM4YmRkMGYyMGY5YQ==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic3NTNlMDM4YWVhOTNhMGQ5YTBjMmRlMGJlN2MwNzVmY182MS5tcDQ/0.flac?token=1776044486~MzEyOTZlNTZhZTMyYzNiZWVmOWI1NDFiYzk5MGM4YmRkMGYyMGY5YQ==","trackType":"tidal"} Apr 12 19:41:26 display volumio[1433]: verbose: CURRENT POSITION 6 Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::syncState stateService play Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::syncState currentStatus play Apr 12 19:41:26 display volumio[1433]: info: Received an update from plugin. extracting info from payload Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::pushState Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::volumioPushState Apr 12 19:41:26 display volumio[1433]: info: MRS: Pushing multiroomSync output update for this device Apr 12 19:41:26 display volumio[1433]: info: MRS: Pushing multiroomSync output Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::pushState Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::volumioPushState Apr 12 19:41:26 display volumio[1433]: info: MRS: Pushing multiroomSync output update for this device Apr 12 19:41:26 display volumio[1433]: info: MRS: Pushing multiroomSync output Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.709-05:00 level=INFO msg="emitting player state changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" state=STATUS_PLAYING positionMs=0 volume=100 Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.710-05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" state=STATUS_PLAYING positionMs=0 volume=100 Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.710-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" id=tidal://song/100577989 title=Sara Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.710-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" id=tidal://song/100577989 title=Sara Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.712-05:00 level=INFO msg="emitting player state changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" state=STATUS_PLAYING positionMs=0 volume=100 Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.712-05:00 level=INFO msg="emitting player state changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" state=STATUS_PLAYING positionMs=0 volume=100 Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.713-05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" state=STATUS_PLAYING positionMs=0 volume=100 Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.713-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" id=tidal://song/100577989 title=Sara Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.713-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" id=tidal://song/100577989 title=Sara Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.713-05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" state=STATUS_PLAYING positionMs=0 volume=100 Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.713-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" id=tidal://song/100577989 title=Sara Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.714-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" id=tidal://song/100577989 title=Sara Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.714-05:00 level=INFO msg="emitting player state changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" state=STATUS_PLAYING positionMs=0 volume=100 Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.715-05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" state=STATUS_PLAYING positionMs=0 volume=100 Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.715-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" id=tidal://song/100577989 title=Sara Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.715-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" id=tidal://song/100577989 title=Sara Apr 12 19:41:26 display volumio[1433]: info: ------------------------------ 21ms Apr 12 19:41:26 display volumio[1433]: info: ------------------------------ 19ms Apr 12 19:41:26 display volumio[1433]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 12 19:41:26 display volumio[1433]: verbose: ControllerMpd::parseTrackInfo Apr 12 19:41:26 display volumio[1433]: info: ControllerMpd::pushState Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::servicePushState Apr 12 19:41:26 display volumio[1433]: info: CorePlayQueue::getTrack 6 Apr 12 19:41:26 display volumio[1433]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0.flac?token=1776044486~MzEyOTZlNTZhZTMyYzNiZWVmOWI1NDFiYzk5MGM4YmRkMGYyMGY5YQ==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic3NTNlMDM4YWVhOTNhMGQ5YTBjMmRlMGJlN2MwNzVmY182MS5tcDQ/0.flac?token=1776044486~MzEyOTZlNTZhZTMyYzNiZWVmOWI1NDFiYzk5MGM4YmRkMGYyMGY5YQ==","trackType":"tidal"} Apr 12 19:41:26 display volumio[1433]: verbose: CURRENT POSITION 6 Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::syncState stateService play Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::syncState currentStatus play Apr 12 19:41:26 display volumio[1433]: info: Received an update from plugin. extracting info from payload Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::pushState Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::volumioPushState Apr 12 19:41:26 display volumio[1433]: info: MRS: Pushing multiroomSync output update for this device Apr 12 19:41:26 display volumio[1433]: info: MRS: Pushing multiroomSync output Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:41:26 display volumio[1433]: info: CoreStateMachine::pushState Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::volumioPushState Apr 12 19:41:26 display volumio[1433]: info: MRS: Pushing multiroomSync output update for this device Apr 12 19:41:26 display volumio[1433]: info: MRS: Pushing multiroomSync output Apr 12 19:41:26 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.723-05:00 level=INFO msg="emitting player state changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" state=STATUS_PLAYING positionMs=0 volume=100 Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.723-05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" state=STATUS_PLAYING positionMs=0 volume=100 Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.723-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" id=tidal://song/100577989 title=Sara Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.723-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" id=tidal://song/100577989 title=Sara Apr 12 19:41:26 display volumio[1433]: info: ------------------------------ 26ms Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.725-05:00 level=INFO msg="emitting player state changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" state=STATUS_PLAYING positionMs=0 volume=100 Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.725-05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" state=STATUS_PLAYING positionMs=0 volume=100 Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.725-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" id=tidal://song/100577989 title=Sara Apr 12 19:41:26 display volumio5-onboarding[2495]: time=2026-04-12T19:41:26.726-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" id=tidal://song/100577989 title=Sara Apr 12 19:41:26 display volumio[1433]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 12 19:41:26 display volumio[1433]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 12 19:41:26 display volumio[1433]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 12 19:41:26 display volumio[1433]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 12 19:41:26 display sudo[23567]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 12 19:41:26 display sudo[23565]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 12 19:41:26 display sudo[23567]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:41:26 display sudo[23565]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:41:26 display volumio[1433]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 12 19:41:26 display volumio[1433]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 12 19:41:26 display sudo[23573]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 12 19:41:26 display sudo[23573]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:41:26 display sudo[23572]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 12 19:41:26 display sudo[23572]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:41:26 display sudo[23578]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 12 19:41:26 display sudo[23578]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:41:26 display sudo[23575]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 12 19:41:26 display sudo[23575]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Volumio is playing Apr 12 19:41:26 display volumio[1433]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Volumio is playing Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Volumio is playing Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Volumio is playing Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Volumio is playing Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Volumio is playing Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Volumio is playing Apr 12 19:41:26 display volumio[1433]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Volumio is playing Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Volumio is playing Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Volumio is playing Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Volumio is playing Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Volumio is playing Apr 12 19:41:26 display volumio[1433]: error: FusionDsp - Monitor WebSocket error: [object Object] Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:26 display volumio[1433]: error: FusionDsp - Monitor WebSocket error: [object Object] Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:26 display volumio[1433]: error: FusionDsp - Monitor WebSocket error: [object Object] Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:26 display volumio[1433]: error: FusionDsp - Monitor WebSocket error: [object Object] Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:26 display volumio[1433]: error: FusionDsp - Monitor WebSocket error: [object Object] Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:26 display volumio[1433]: error: FusionDsp - Monitor WebSocket error: [object Object] Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:26 display volumio[1433]: error: FusionDsp - Monitor WebSocket error: [object Object] Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:26 display volumio[1433]: error: FusionDsp - Monitor WebSocket error: [object Object] Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:26 display volumio[1433]: error: FusionDsp - Monitor WebSocket error: [object Object] Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:26 display volumio[1433]: error: FusionDsp - Monitor WebSocket error: [object Object] Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:26 display volumio[1433]: error: FusionDsp - Monitor WebSocket error: [object Object] Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:26 display volumio[1433]: error: FusionDsp - Monitor WebSocket error: [object Object] Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:41:26 display systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Apr 12 19:41:26 display volumio[1433]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 12 19:41:26 display sudo[23567]: pam_unix(sudo:session): session closed for user root Apr 12 19:41:26 display volumio[1433]: info: peppymeterbasic Daemon Started Apr 12 19:41:26 display sudo[23565]: pam_unix(sudo:session): session closed for user root Apr 12 19:41:26 display sudo[23573]: pam_unix(sudo:session): session closed for user root Apr 12 19:41:26 display sudo[23572]: pam_unix(sudo:session): session closed for user root Apr 12 19:41:26 display volumio[1433]: info: peppymeterbasic Daemon Started Apr 12 19:41:26 display sudo[23575]: pam_unix(sudo:session): session closed for user root Apr 12 19:41:26 display sudo[23578]: pam_unix(sudo:session): session closed for user root Apr 12 19:41:26 display volumio[1433]: info: peppymeterbasic Daemon Started Apr 12 19:41:26 display volumio[1433]: info: peppymeterbasic Daemon Started Apr 12 19:41:26 display volumio[1433]: info: peppymeterbasic Daemon Started Apr 12 19:41:26 display volumio[1433]: info: peppymeterbasic Daemon Started Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 12 19:41:26 display volumio[1433]: info: camilladsp service terminated, instance 1 Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 12 19:41:26 display volumio[1433]: info: camilladsp service started and running in background, instance 1 Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 12 19:41:26 display volumio[1433]: info: camilladsp service terminated, instance 2 Apr 12 19:41:26 display volumio[1433]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 12 19:41:26 display volumio[1433]: info: camilladsp service started and running in background, instance 2 Apr 12 19:41:26 display volumio[1433]: info: camilladsp respawn in 100 ms (attempt 1/10) Apr 12 19:41:27 display volumio[1433]: info: camilladsp respawn in 200 ms (attempt 2/10) Apr 12 19:41:27 display volumio[1433]: info: camilladsp respawn in 400 ms (attempt 3/10) Apr 12 19:41:27 display volumio[1433]: info: camilladsp respawn in 800 ms (attempt 4/10) Apr 12 19:41:28 display volumio[1433]: info: camilladsp respawn in 1600 ms (attempt 5/10) Apr 12 19:41:28 display volumio[1433]: info: camilladsp respawn in 100 ms (attempt 1/10) Apr 12 19:41:30 display volumio[1433]: info: camilladsp respawn in 3200 ms (attempt 6/10) Apr 12 19:41:32 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 12 19:41:32 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 12 19:41:32 display volumio[1433]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 19:41:33 display volumio[1433]: info: camilladsp respawn in 6400 ms (attempt 7/10) Apr 12 19:41:33 display volumio[1433]: info: camilladsp respawn in 10000 ms (attempt 8/10) Apr 12 19:41:35 display volumio[1433]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 19:41:39 display volumio[1433]: info: camilladsp respawn in 10000 ms (attempt 9/10) Apr 12 19:41:40 display volumio[1433]: info: camilladsp respawn in 200 ms (attempt 2/10) Apr 12 19:41:41 display volumio[1433]: info: camilladsp respawn in 400 ms (attempt 3/10) Apr 12 19:41:43 display volumio[1433]: info: camilladsp respawn in 10000 ms (attempt 10/10) Apr 12 19:41:44 display volumio[1433]: info: FusionDsp - Clipping Monitor started Apr 12 19:41:44 display volumio[1433]: info: FusionDsp - Clipping Monitor started Apr 12 19:41:49 display volumio[1433]: info: CALLMETHOD: audio_interface fusiondsp disableeffect Apr 12 19:41:49 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , disableeffect Apr 12 19:41:49 display volumio[1433]: error: camilladsp exceeded max consecutive respawns (10); stopping respawn. Plugin restart required. Apr 12 19:41:50 display volumio[1433]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 12 19:41:50 display volumio[1433]: info: FusionDsp - Effects disabled Apr 12 19:41:50 display volumio[1433]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 19:41:50 display volumio[1433]: info: CoreCommandRouter::Close All Modals sent Apr 12 19:41:50 display volumio[1433]: info: CALLMETHOD: audio_interface fusiondsp disableeffect Apr 12 19:41:50 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , disableeffect Apr 12 19:41:51 display volumio[1433]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 12 19:41:51 display volumio[1433]: info: FusionDsp - Effects disabled Apr 12 19:41:51 display volumio[1433]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 19:41:51 display volumio[1433]: info: CoreCommandRouter::Close All Modals sent Apr 12 19:41:53 display volumio[1433]: info: CALLMETHOD: audio_interface fusiondsp saveparameq [object Object] Apr 12 19:41:53 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , saveparameq Apr 12 19:41:53 display volumio[1433]: warn: camilladsp respawn stopped due to repeated failures; not respawning Apr 12 19:41:54 display volumio[1433]: info: FusionDsp - Sent ResetClippedSamples command Apr 12 19:41:54 display volumio[1433]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 12 19:41:54 display volumio[1433]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 19:41:54 display volumio[1433]: info: CoreCommandRouter::Close All Modals sent Apr 12 19:42:07 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:42:07 display volumio[1433]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Apr 12 19:42:07 display volumio[1433]: info: camilladsp respawn in 800 ms (attempt 4/10) Apr 12 19:42:09 display volumio[1433]: info: camilladsp respawn in 1600 ms (attempt 5/10) Apr 12 19:42:15 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 12 19:42:15 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 12 19:42:15 display volumio[1433]: info: camilladsp respawn in 3200 ms (attempt 6/10) Apr 12 19:42:20 display volumio[1433]: info: FusionDsp - Stopping clipped samples monitor Apr 12 19:42:20 display volumio[1433]: info: FusionDsp - Clipped samples monitor stopped Apr 12 19:42:20 display volumio[1433]: info: FusionDsp - Stopping FusionDsp service Apr 12 19:42:20 display volumio[1433]: info: camilladsp service terminated, instance 2 Apr 12 19:42:20 display volumio[1433]: info: FusionDsp - PEQ graph server stopped Apr 12 19:42:20 display volumio[1433]: info: Disabling plugin fusiondsp Apr 12 19:42:20 display volumio[1433]: info: Preparing to generate the ALSA configuration file Apr 12 19:42:20 display sudo[23850]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Apr 12 19:42:20 display sudo[23850]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::volumioPause Apr 12 19:42:20 display volumio[1433]: info: CoreStateMachine::pause Apr 12 19:42:20 display volumio[1433]: info: CoreStateMachine::stPlaybackTimer Apr 12 19:42:20 display volumio[1433]: info: CoreStateMachine::servicePause Apr 12 19:42:20 display volumio[1433]: info: CorePlayQueue::getTrack 6 Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::servicePause Apr 12 19:42:20 display volumio[1433]: info: [1776040940034] ControllerTidal::pause Apr 12 19:42:20 display volumio[1433]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 12 19:42:20 display volumio[1433]: info: ControllerMpd::pause Apr 12 19:42:20 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand pause Apr 12 19:42:20 display volumio[1433]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 12 19:42:20 display volumio[1433]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 12 19:42:20 display volumio[1433]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Apr 12 19:42:20 display volumio[1433]: info: Reading ALSA contributions from plugins. Apr 12 19:42:20 display volumio[1433]: info: Apr 12 19:42:20 display volumio[1433]: ---------------------------- MPD announces state update: player Apr 12 19:42:20 display volumio[1433]: info: sendMpdCommand pause took 2 milliseconds Apr 12 19:42:20 display volumio[1433]: info: ControllerMpd::getState Apr 12 19:42:20 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand status Apr 12 19:42:20 display volumio[1433]: info: Apr 12 19:42:20 display volumio[1433]: ---------------------------- MPD announces state update: player Apr 12 19:42:20 display volumio[1433]: info: ControllerMpd::getState Apr 12 19:42:20 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand status Apr 12 19:42:20 display volumio[1433]: info: sendMpdCommand status took 0 milliseconds Apr 12 19:42:20 display volumio[1433]: info: sendMpdCommand status took 0 milliseconds Apr 12 19:42:20 display volumio[1433]: verbose: ControllerMpd::parseState Apr 12 19:42:20 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 12 19:42:20 display volumio[1433]: verbose: ControllerMpd::parseState Apr 12 19:42:20 display volumio[1433]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 12 19:42:20 display volumio[1433]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 12 19:42:20 display volumio[1433]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 12 19:42:20 display volumio[1433]: verbose: ControllerMpd::parseTrackInfo Apr 12 19:42:20 display volumio[1433]: verbose: ControllerMpd::parseTrackInfo Apr 12 19:42:20 display volumio[1433]: info: ControllerMpd::pushState Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::servicePushState Apr 12 19:42:20 display volumio[1433]: info: CorePlayQueue::getTrack 6 Apr 12 19:42:20 display volumio[1433]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":53576,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1031 Kbps","isStreaming":false,"title":"0.flac?token=1776044486~MzEyOTZlNTZhZTMyYzNiZWVmOWI1NDFiYzk5MGM4YmRkMGYyMGY5YQ==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic3NTNlMDM4YWVhOTNhMGQ5YTBjMmRlMGJlN2MwNzVmY182MS5tcDQ/0.flac?token=1776044486~MzEyOTZlNTZhZTMyYzNiZWVmOWI1NDFiYzk5MGM4YmRkMGYyMGY5YQ==","trackType":"tidal"} Apr 12 19:42:20 display volumio[1433]: verbose: CURRENT POSITION 6 Apr 12 19:42:20 display volumio[1433]: info: CoreStateMachine::syncState stateService pause Apr 12 19:42:20 display volumio[1433]: info: CoreStateMachine::syncState currentStatus pause Apr 12 19:42:20 display volumio[1433]: info: CoreStateMachine::pushState Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::volumioPushState Apr 12 19:42:20 display volumio[1433]: info: MRS: Pushing multiroomSync output update for this device Apr 12 19:42:20 display volumio[1433]: info: MRS: Pushing multiroomSync output Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:42:20 display volumio[1433]: info: CoreStateMachine::stPlaybackTimer Apr 12 19:42:20 display volumio[1433]: info: ControllerMpd::pushState Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::servicePushState Apr 12 19:42:20 display volumio[1433]: info: CorePlayQueue::getTrack 6 Apr 12 19:42:20 display systemd[1]: Stopping fusiondsp.service - FusionDsp Daemon... Apr 12 19:42:20 display volumio[1433]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":53576,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1031 Kbps","isStreaming":false,"title":"0.flac?token=1776044486~MzEyOTZlNTZhZTMyYzNiZWVmOWI1NDFiYzk5MGM4YmRkMGYyMGY5YQ==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEic3NTNlMDM4YWVhOTNhMGQ5YTBjMmRlMGJlN2MwNzVmY182MS5tcDQ/0.flac?token=1776044486~MzEyOTZlNTZhZTMyYzNiZWVmOWI1NDFiYzk5MGM4YmRkMGYyMGY5YQ==","trackType":"tidal"} Apr 12 19:42:20 display volumio[1433]: verbose: CURRENT POSITION 6 Apr 12 19:42:20 display volumio[1433]: info: CoreStateMachine::syncState stateService pause Apr 12 19:42:20 display volumio[1433]: info: CoreStateMachine::syncState currentStatus pause Apr 12 19:42:20 display volumio[1433]: info: CoreStateMachine::pushState Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::volumioPushState Apr 12 19:42:20 display volumio[1433]: info: MRS: Pushing multiroomSync output update for this device Apr 12 19:42:20 display volumio[1433]: info: MRS: Pushing multiroomSync output Apr 12 19:42:20 display volumio[23130]: ======== Running on http://0.0.0.0:5011 ======== Apr 12 19:42:20 display volumio[23130]: (Press CTRL+C to quit) Apr 12 19:42:20 display systemd[1]: fusiondsp.service: Deactivated successfully. Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:42:20 display volumio[1433]: info: CoreStateMachine::stPlaybackTimer Apr 12 19:42:20 display systemd[1]: Stopped fusiondsp.service - FusionDsp Daemon. Apr 12 19:42:20 display volumio5-onboarding[2495]: time=2026-04-12T19:42:20.054-05:00 level=INFO msg="emitting player state changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" state=STATUS_PAUSED positionMs=53429 volume=100 Apr 12 19:42:20 display volumio5-onboarding[2495]: time=2026-04-12T19:42:20.054-05:00 level=INFO msg="emitting player state changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" state=STATUS_PAUSED positionMs=53429 volume=100 Apr 12 19:42:20 display volumio5-onboarding[2495]: time=2026-04-12T19:42:20.055-05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" state=STATUS_PAUSED positionMs=53429 volume=100 Apr 12 19:42:20 display volumio5-onboarding[2495]: time=2026-04-12T19:42:20.055-05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" state=STATUS_PAUSED positionMs=53429 volume=100 Apr 12 19:42:20 display volumio5-onboarding[2495]: time=2026-04-12T19:42:20.055-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" id=tidal://song/100577989 title=Sara Apr 12 19:42:20 display volumio5-onboarding[2495]: time=2026-04-12T19:42:20.055-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" id=tidal://song/100577989 title=Sara Apr 12 19:42:20 display volumio5-onboarding[2495]: time=2026-04-12T19:42:20.055-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" id=tidal://song/100577989 title=Sara Apr 12 19:42:20 display volumio5-onboarding[2495]: time=2026-04-12T19:42:20.055-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" id=tidal://song/100577989 title=Sara Apr 12 19:42:20 display volumio[1433]: info: ------------------------------ 25ms Apr 12 19:42:20 display sudo[23850]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:20 display volumio[1433]: info: ------------------------------ 24ms Apr 12 19:42:20 display volumio[1433]: info: PeppyMeterBasic ---peppymeterbasic status pause Apr 12 19:42:20 display volumio[1433]: info: PeppyMeterBasic ---peppymeterbasic status pause Apr 12 19:42:20 display sudo[23853]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 12 19:42:20 display sudo[23853]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:20 display volumio[1433]: info: FusionDsp - Volumio is not playing Apr 12 19:42:20 display volumio[1433]: info: FusionDsp - Clipped samples monitor stopped Apr 12 19:42:20 display volumio[1433]: info: FusionDsp - Volumio is not playing Apr 12 19:42:20 display sudo[23855]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 12 19:42:20 display sudo[23855]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:20 display volumio[1433]: info: FusionDsp - Clipped samples monitor stopped Apr 12 19:42:20 display volumio[1433]: info: FusionDsp - Reporting Fusion DSP Disabled Apr 12 19:42:20 display volumio[1433]: info: Removing fusiondspeq DSP Signal Path Element Apr 12 19:42:20 display systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Apr 12 19:42:20 display volumio[1433]: info: Asound.conf file written Apr 12 19:42:20 display sudo[23862]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 12 19:42:20 display sudo[23862]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:20 display sudo[23862]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:20 display volumio[1433]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Apr 12 19:42:20 display volumio[1433]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Apr 12 19:42:20 display volumio[1433]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Apr 12 19:42:20 display volumio[1433]: No state is present for card sndrpihifiberry Apr 12 19:42:20 display volumio[1433]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Apr 12 19:42:20 display volumio[1433]: Found hardware: "RPi-simple" "" "" "" "" Apr 12 19:42:20 display volumio[1433]: Hardware is initialized using a generic method Apr 12 19:42:20 display volumio[1433]: No state is present for card sndrpihifiberry Apr 12 19:42:20 display volumio[1433]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:7 use case configuration -2 Apr 12 19:42:20 display volumio[1433]: info: Output device has changed, restarting MPD Apr 12 19:42:20 display volumio[1433]: info: Output device has changed, restarting Shairport Sync Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 19:42:20 display sudo[23869]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 12 19:42:20 display sudo[23869]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:20 display sudo[23871]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 12 19:42:20 display sudo[23871]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:20 display sudo[23869]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:20 display volumio[1433]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 12 19:42:20 display systemd[1]: Stopping mpd.service - Music Player Daemon... Apr 12 19:42:20 display volumio[1433]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: QobuzConnect: setDeactiveState invoked Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:42:20 display vtcs[23154]: [2026-04-12 19:42:20.166] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Apr 12 19:42:20 display vtcs[23154]: [2026-04-12 19:42:20.166] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Apr 12 19:42:20 display systemd[1]: mpd.service: Deactivated successfully. Apr 12 19:42:20 display systemd[1]: Stopped mpd.service - Music Player Daemon. Apr 12 19:42:20 display systemd[1]: mpd.service: Consumed 2.047s CPU time. Apr 12 19:42:20 display systemd[1]: mpd.socket: Deactivated successfully. Apr 12 19:42:20 display systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Apr 12 19:42:20 display systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Apr 12 19:42:20 display volumio[1433]: info: Done. Apr 12 19:42:20 display sudo[23881]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 12 19:42:20 display systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Apr 12 19:42:20 display sudo[23881]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:20 display sudo[23885]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 12 19:42:20 display systemd[1]: Starting mpd.service - Music Player Daemon... Apr 12 19:42:20 display sudo[23885]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:20 display sudo[23893]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Apr 12 19:42:20 display sudo[23893]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:20 display systemd[1]: peppymeterbasic.service: Deactivated successfully. Apr 12 19:42:20 display systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Apr 12 19:42:20 display systemd[1]: peppymeterbasic.service: Consumed 18.571s CPU time. Apr 12 19:42:20 display volumio[1433]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Apr 12 19:42:20 display volumio[1433]: info: MPD Permissions set Apr 12 19:42:20 display volumio[1433]: info: touch_display: Setting screensaver timeout to 240 seconds. Apr 12 19:42:20 display sudo[23855]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:20 display sudo[23889]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 12 19:42:20 display volumio[1433]: info: peppymeterbasic Daemon Stop Apr 12 19:42:20 display sudo[23889]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 12 19:42:20 display sudo[23853]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display sudo[23889]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:20 display sudo[23893]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:20 display sudo[23898]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Apr 12 19:42:20 display sudo[23898]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: peppymeterbasic Daemon Stop Apr 12 19:42:20 display volumio[1433]: info: Starting Shairport Sync Apr 12 19:42:20 display volumio[1433]: info: Preparing to generate the ALSA configuration file Apr 12 19:42:20 display sudo[23906]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 12 19:42:20 display sudo[23906]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:20 display systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Apr 12 19:42:20 display volumio[1433]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 12 19:42:20 display volumio[1433]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 12 19:42:20 display systemd[1]: vtcs.service: Deactivated successfully. Apr 12 19:42:20 display volumio[1433]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Apr 12 19:42:20 display volumio[1433]: info: Reading ALSA contributions from plugins. Apr 12 19:42:20 display systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Apr 12 19:42:20 display volumio[1433]: info: Asound.conf file unchanged, so no further update is needed Apr 12 19:42:20 display volumio[1433]: info: Output device has changed, restarting MPD Apr 12 19:42:20 display sudo[23909]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 12 19:42:20 display sudo[23909]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:20 display volumio[1433]: info: Output device has changed, restarting Shairport Sync Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 19:42:20 display sudo[23885]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:20 display sudo[23909]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:20 display sudo[23911]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 12 19:42:20 display sudo[23911]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:20 display systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Apr 12 19:42:20 display volumio[1433]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 12 19:42:20 display volumio[1433]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display sudo[23881]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:20 display systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Apr 12 19:42:20 display systemd[1]: shairport-sync.service: Deactivated successfully. Apr 12 19:42:20 display systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 12 19:42:20 display qobuz-connect[23107]: 20260412 19:42:20.366 [23107.23107] INFO SampleApp: Stopping Local configuration server Apr 12 19:42:20 display systemd[1]: shairport-sync.service: Consumed 1.707s CPU time. Apr 12 19:42:20 display volumio[1433]: info: QobuzConnect: setDeactiveState invoked Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:42:20 display systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 12 19:42:20 display sudo[23906]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:20 display sudo[23929]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 12 19:42:20 display sudo[23929]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:20 display systemd[1]: mpd.service: Deactivated successfully. Apr 12 19:42:20 display systemd[1]: Stopped mpd.service - Music Player Daemon. Apr 12 19:42:20 display systemd[1]: mpd.socket: Deactivated successfully. Apr 12 19:42:20 display sudo[23924]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 12 19:42:20 display sudo[23924]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:20 display systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Apr 12 19:42:20 display systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Apr 12 19:42:20 display systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Apr 12 19:42:20 display systemd[1]: Starting mpd.service - Music Player Daemon... Apr 12 19:42:20 display sudo[23950]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Apr 12 19:42:20 display sudo[23950]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:20 display volumio[1433]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Apr 12 19:42:20 display volumio[1433]: info: MPD Permissions set Apr 12 19:42:20 display volumio[1433]: info: Shairport-Sync Started Apr 12 19:42:20 display sudo[23950]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:20 display sudo[23948]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 12 19:42:20 display sudo[23948]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display sudo[23948]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display qobuz-connect[23107]: 20260412 19:42:20.491 [23107.23107] INFO SampleApp: shat down connection on UNIX socket Apr 12 19:42:20 display sudo[23953]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Apr 12 19:42:20 display sudo[23953]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:20 display volumio[1433]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Apr 12 19:42:20 display volumio[1433]: info: QobuzConnect: setDeactiveState invoked Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:42:20 display systemd[1]: qobuz-connect.service: Deactivated successfully. Apr 12 19:42:20 display systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Apr 12 19:42:20 display volumio[1433]: info: Starting Shairport Sync Apr 12 19:42:20 display sudo[23929]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:20 display sudo[23924]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:20 display systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Apr 12 19:42:20 display sudo[23963]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 12 19:42:20 display sudo[23963]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:20 display sudo[23898]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:20 display sudo[23953]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:20 display volumio[1433]: info: Executing endpoint qc_getconfig Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Apr 12 19:42:20 display systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Apr 12 19:42:20 display systemd[1]: shairport-sync.service: Deactivated successfully. Apr 12 19:42:20 display systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 12 19:42:20 display qobuz-connect[23965]: 20260412 19:42:20.597 [23965.23965] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Apr 12 19:42:20 display qobuz-connect[23965]: 20260412 19:42:20.598 [23965.23965] INFO VolumeManager: [0x1e772b8]: Setting new playback volume: 75 Apr 12 19:42:20 display qobuz-connect[23965]: 20260412 19:42:20.598 [23965.23965] INFO VolumeManager: [0x1e772b8]: Setting new mute state: 0 Apr 12 19:42:20 display qobuz-connect[23965]: 20260412 19:42:20.598 [23965.23965] INFO AudioStreamManager: [0x1e77010]: Setting new audio download buffer size: 1048576 Apr 12 19:42:20 display qobuz-connect[23965]: 20260412 19:42:20.598 [23965.23965] INFO QobuzConnect: [0x1e77b80]: Client initialized! Apr 12 19:42:20 display qobuz-connect[23965]: 20260412 19:42:20.598 [23965.23965] INFO SampleApp: Starting Avahi advertising, name: Display, service name: _qobuz-connect._tcp Apr 12 19:42:20 display volumio[1433]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Apr 12 19:42:20 display volumio[1433]: info: QobuzConnect: QOBUZ Connect daemon connected Apr 12 19:42:20 display qobuz-connect[23965]: 20260412 19:42:20.607 [23965.23965] INFO LocalConfigManager: [0x1e76d38]: Starting Local Configuration server Apr 12 19:42:20 display qobuz-connect[23965]: 20260412 19:42:20.607 [23965.23965] INFO SampleApp: Starting Local configuration server Apr 12 19:42:20 display qobuz-connect[23965]: 20260412 19:42:20.607 [23965.23965] INFO SampleApp: Connected to UNIX socket client 0x1e61818 Apr 12 19:42:20 display systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 12 19:42:20 display sudo[23963]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:20 display volumio[1433]: info: Shairport-Sync Started Apr 12 19:42:20 display volumio[1433]: (node:1433) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Apr 12 19:42:20 display volumio[1433]: (Use `node --trace-warnings ...` to show where the warning was created) Apr 12 19:42:20 display volumio[1433]: (node:1433) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Apr 12 19:42:20 display volumio[1433]: (node:1433) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Apr 12 19:42:20 display volumio[1433]: (node:1433) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Apr 12 19:42:20 display volumio[1433]: (node:1433) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Apr 12 19:42:20 display qobuz-connect[23965]: 20260412 19:42:20.747 [23965.23965] INFO SampleApp: Playback volume changed: 75 Apr 12 19:42:20 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:42:20 display volumio[1433]: info: camilladsp respawn in 6400 ms (attempt 7/10) Apr 12 19:42:21 display mpd[23961]: 2026-04-12T19:42:21 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 12 19:42:21 display systemd[1]: Started mpd.service - Music Player Daemon. Apr 12 19:42:21 display sudo[23911]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:21 display sudo[23871]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:21 display volumio[1433]: error: MPD error: The expression evaluated to a falsy value: Apr 12 19:42:21 display volumio[1433]: assert.ok(self.idling) Apr 12 19:42:21 display volumio[1433]: error: The expression evaluated to a falsy value: Apr 12 19:42:21 display volumio[1433]: assert.ok(self.idling) Apr 12 19:42:21 display volumio[1433]: error: updateQueue error: null Apr 12 19:42:23 display volumio[1433]: info: TidalConnect service stoped! Apr 12 19:42:23 display volumio[1433]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 12 19:42:23 display volumio[1433]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 12 19:42:23 display volumio[1433]: info: TidalConnect service stoped! Apr 12 19:42:23 display sudo[24001]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 12 19:42:23 display sudo[24001]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:23 display systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Apr 12 19:42:23 display sudo[24001]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:23 display volumio[1433]: info: Executing endpoint tc_getconfig Apr 12 19:42:23 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 12 19:42:23 display vtcs[24004]: STARTING TidalConnect services, version: 1.6.1 Apr 12 19:42:23 display vtcs[24004]: STARTED TidalConnect services. Apr 12 19:42:23 display volumio[1433]: info: Executing endpoint tc_connect Apr 12 19:42:23 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 12 19:42:23 display volumio[1433]: info: Connecting to TidalConnect Apr 12 19:42:23 display volumio[1433]: info: CoreCommandRouter::servicePushState Apr 12 19:42:23 display volumio[1433]: info: CoreStateMachine::pushState Apr 12 19:42:23 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 19:42:23 display volumio[1433]: info: CoreCommandRouter::volumioPushState Apr 12 19:42:23 display volumio[1433]: info: MRS: Pushing multiroomSync output update for this device Apr 12 19:42:23 display volumio[1433]: info: MRS: Pushing multiroomSync output Apr 12 19:42:23 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:42:23 display volumio[1433]: info: CorePlayQueue::getTrack 6 Apr 12 19:42:23 display volumio[1433]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Apr 12 19:42:23 display volumio[1433]: info: CoreCommandRouter::servicePushState Apr 12 19:42:23 display volumio[1433]: info: CoreStateMachine::pushState Apr 12 19:42:23 display volumio[1433]: info: CoreCommandRouter::volumioPushState Apr 12 19:42:23 display volumio[1433]: info: MRS: Pushing multiroomSync output update for this device Apr 12 19:42:23 display volumio[1433]: info: MRS: Pushing multiroomSync output Apr 12 19:42:23 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:42:23 display volumio[1433]: info: CorePlayQueue::getTrack 6 Apr 12 19:42:23 display volumio[1433]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect Apr 12 19:42:23 display volumio5-onboarding[2495]: time=2026-04-12T19:42:23.504-05:00 level=INFO msg="emitting player state changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" state=STATUS_PAUSED positionMs=56561 volume=100 Apr 12 19:42:23 display volumio5-onboarding[2495]: time=2026-04-12T19:42:23.504-05:00 level=INFO msg="emitting player state changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" state=STATUS_PAUSED positionMs=56561 volume=100 Apr 12 19:42:23 display volumio5-onboarding[2495]: time=2026-04-12T19:42:23.504-05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" state=STATUS_PAUSED positionMs=56561 volume=100 Apr 12 19:42:23 display volumio5-onboarding[2495]: time=2026-04-12T19:42:23.504-05:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" state=STATUS_PAUSED positionMs=56561 volume=100 Apr 12 19:42:23 display volumio5-onboarding[2495]: time=2026-04-12T19:42:23.504-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" id=tidal://song/100577989 title=Sara Apr 12 19:42:23 display volumio5-onboarding[2495]: time=2026-04-12T19:42:23.504-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.205:54298 @ 0x327a300" id=tidal://song/100577989 title=Sara Apr 12 19:42:23 display volumio5-onboarding[2495]: time=2026-04-12T19:42:23.504-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" id=tidal://song/100577989 title=Sara Apr 12 19:42:23 display volumio5-onboarding[2495]: time=2026-04-12T19:42:23.504-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%04,10.0.0.205:54298 @ 0x318f440" id=tidal://song/100577989 title=Sara Apr 12 19:42:23 display volumio[1433]: info: PeppyMeterBasic ---peppymeterbasic status pause Apr 12 19:42:23 display volumio[1433]: info: PeppyMeterBasic ---peppymeterbasic status pause Apr 12 19:42:23 display sudo[24020]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 12 19:42:23 display sudo[24020]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:23 display sudo[24024]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 12 19:42:23 display sudo[24024]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:23 display volumio[1433]: info: FusionDsp - Volumio is not playing Apr 12 19:42:23 display volumio[1433]: info: FusionDsp - Clipped samples monitor stopped Apr 12 19:42:23 display volumio[1433]: info: FusionDsp - Volumio is not playing Apr 12 19:42:23 display volumio[1433]: info: FusionDsp - Clipped samples monitor stopped Apr 12 19:42:23 display sudo[24020]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:23 display volumio[1433]: info: peppymeterbasic Daemon Stop Apr 12 19:42:23 display volumio[1433]: info: TidalConnect service stoped! Apr 12 19:42:23 display sudo[24024]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:23 display volumio[1433]: info: peppymeterbasic Daemon Stop Apr 12 19:42:23 display volumio[1433]: info: TidalConnect service stoped! Apr 12 19:42:23 display volumio[1433]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 12 19:42:23 display volumio[1433]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 12 19:42:23 display sudo[24035]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 12 19:42:23 display sudo[24035]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:23 display sudo[24035]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:24 display volumio[1433]: info: Starting Uninstall of plugin audio_interface - fusiondsp Apr 12 19:42:24 display volumio[1433]: info: Uninstalling plugin fusiondsp Apr 12 19:42:24 display volumio5-onboarding[2495]: time=2026-04-12T19:42:24.696-05:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 19:42:24 display volumio[1433]: info: Disabling plugin fusiondsp Apr 12 19:42:24 display volumio[1433]: info: Preparing to generate the ALSA configuration file Apr 12 19:42:24 display volumio[1433]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 12 19:42:24 display volumio[1433]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 12 19:42:24 display volumio[1433]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Apr 12 19:42:24 display volumio[1433]: info: Reading ALSA contributions from plugins. Apr 12 19:42:24 display volumio[1433]: info: Asound.conf file unchanged, so no further update is needed Apr 12 19:42:24 display volumio[1433]: info: Output device has changed, restarting MPD Apr 12 19:42:24 display volumio[1433]: info: Output device has changed, restarting Shairport Sync Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 19:42:24 display sudo[24039]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 12 19:42:24 display sudo[24039]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:24 display sudo[24039]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:24 display sudo[24041]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 12 19:42:24 display sudo[24041]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:24 display volumio[1433]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 12 19:42:24 display volumio[1433]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display systemd[1]: Stopping mpd.service - Music Player Daemon... Apr 12 19:42:24 display volumio[1433]: info: QobuzConnect: setDeactiveState invoked Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:42:24 display vtcs[24004]: [2026-04-12 19:42:24.740] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Apr 12 19:42:24 display vtcs[24004]: [2026-04-12 19:42:24.740] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Apr 12 19:42:24 display volumio5-onboarding[2495]: time=2026-04-12T19:42:24.747-05:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 19:42:24 display volumio[1433]: info: Checking if uninstall.sh is present Apr 12 19:42:24 display systemd[1]: mpd.service: Deactivated successfully. Apr 12 19:42:24 display systemd[1]: Stopped mpd.service - Music Player Daemon. Apr 12 19:42:24 display systemd[1]: mpd.socket: Deactivated successfully. Apr 12 19:42:24 display systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Apr 12 19:42:24 display sudo[24051]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 12 19:42:24 display systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Apr 12 19:42:24 display sudo[24051]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:24 display sudo[24056]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 12 19:42:24 display sudo[24056]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:24 display systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Apr 12 19:42:24 display systemd[1]: Starting mpd.service - Music Player Daemon... Apr 12 19:42:24 display volumio[1433]: info: Executing uninstall.sh Apr 12 19:42:24 display systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Apr 12 19:42:24 display systemd[1]: vtcs.service: Deactivated successfully. Apr 12 19:42:24 display systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Apr 12 19:42:24 display sudo[24056]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:24 display sudo[24065]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Apr 12 19:42:24 display sudo[24065]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:24 display sudo[24051]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:24 display volumio[1433]: info: MPD Permissions set Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display sudo[24067]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/audio_interface/fusiondsp/uninstall.sh Apr 12 19:42:24 display sudo[24067]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:24 display sudo[24061]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 12 19:42:24 display sudo[24061]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 12 19:42:24 display sudo[24065]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:24 display sudo[24061]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display sudo[24079]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Apr 12 19:42:24 display sudo[24079]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:24 display volumio[1433]: info: Starting Shairport Sync Apr 12 19:42:24 display volumio[1433]: info: Preparing to generate the ALSA configuration file Apr 12 19:42:24 display sudo[24084]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 12 19:42:24 display sudo[24084]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:24 display volumio[1433]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 12 19:42:24 display volumio[1433]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 12 19:42:24 display volumio[1433]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Apr 12 19:42:24 display volumio[1433]: info: Reading ALSA contributions from plugins. Apr 12 19:42:24 display volumio[1433]: info: Asound.conf file unchanged, so no further update is needed Apr 12 19:42:24 display volumio[1433]: info: Output device has changed, restarting MPD Apr 12 19:42:24 display volumio[1433]: info: Output device has changed, restarting Shairport Sync Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 19:42:24 display sudo[24087]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 12 19:42:24 display sudo[24087]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:24 display sudo[24087]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:24 display sudo[24089]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 12 19:42:24 display sudo[24089]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:24 display volumio[1433]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 12 19:42:24 display volumio[1433]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: QobuzConnect: setDeactiveState invoked Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:42:24 display systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Apr 12 19:42:24 display systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Apr 12 19:42:24 display sudo[24099]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 12 19:42:24 display sudo[24099]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:24 display qobuz-connect[23965]: 20260412 19:42:24.870 [23965.23965] INFO SampleApp: Stopping Local configuration server Apr 12 19:42:24 display sudo[24101]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 12 19:42:24 display systemd[1]: mpd.service: Deactivated successfully. Apr 12 19:42:24 display systemd[1]: Stopped mpd.service - Music Player Daemon. Apr 12 19:42:24 display systemd[1]: shairport-sync.service: Deactivated successfully. Apr 12 19:42:24 display systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 12 19:42:24 display systemd[1]: shairport-sync.service: Consumed 1.491s CPU time. Apr 12 19:42:24 display sudo[24101]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:24 display sudo[24105]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm /etc/systemd/system/fusiondsp.service Apr 12 19:42:24 display sudo[24105]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 12 19:42:24 display sudo[24105]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:24 display volumio[1433]: info: MPD Permissions set Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display sudo[24111]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Apr 12 19:42:24 display sudo[24114]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl daemon-reload Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 19:42:24 display volumio[1433]: info: Starting Shairport Sync Apr 12 19:42:24 display sudo[24111]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:24 display sudo[24114]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 12 19:42:24 display systemd[1]: mpd.socket: Deactivated successfully. Apr 12 19:42:24 display systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Apr 12 19:42:24 display systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Apr 12 19:42:24 display sudo[24122]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 12 19:42:24 display sudo[24122]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:24 display systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Apr 12 19:42:24 display systemd[1]: Starting mpd.service - Music Player Daemon... Apr 12 19:42:24 display systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 12 19:42:24 display sudo[24084]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:24 display volumio[1433]: info: Shairport-Sync Started Apr 12 19:42:24 display systemd[1]: Reloading. Apr 12 19:42:24 display sudo[24111]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:24 display sudo[24099]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:24 display sudo[24142]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Apr 12 19:42:24 display sudo[24142]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 19:42:24 display sudo[24126]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 12 19:42:24 display sudo[24126]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 12 19:42:25 display sudo[24126]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:25 display systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 12 19:42:25 display systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 12 19:42:25 display sudo[24114]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:25 display sudo[24067]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:25 display volumio[1433]: info: Uninstall script completed Apr 12 19:42:25 display volumio[1433]: info: Removing plugin fusiondsp from configuration Apr 12 19:42:25 display volumio5-onboarding[2495]: time=2026-04-12T19:42:25.342-05:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 19:42:25 display systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Apr 12 19:42:25 display systemd[1]: shairport-sync.service: Deactivated successfully. Apr 12 19:42:25 display systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 12 19:42:25 display sudo[24101]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:25 display systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 12 19:42:25 display sudo[24122]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:25 display volumio[1433]: info: Successfully removed fusiondsp configuration files Apr 12 19:42:25 display volumio[1433]: info: Plugin folders cleanup Apr 12 19:42:25 display volumio[1433]: info: Scanning into folder /volumio/app/plugins/ Apr 12 19:42:25 display volumio[1433]: info: Scanning category audio_interface Apr 12 19:42:25 display volumio[1433]: info: Scanning category miscellanea Apr 12 19:42:25 display volumio5-onboarding[2495]: time=2026-04-12T19:42:25.439-05:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 19:42:25 display volumio[1433]: info: Scanning category music_service Apr 12 19:42:25 display volumio[1433]: info: Scanning category plugins.json Apr 12 19:42:25 display volumio[1433]: info: Scanning category system_controller Apr 12 19:42:25 display volumio[1433]: info: Scanning category user_interface Apr 12 19:42:25 display volumio[1433]: info: Scanning into folder /data/plugins/ Apr 12 19:42:25 display volumio[1433]: info: Scanning category audio_interface Apr 12 19:42:25 display volumio[1433]: info: Cleaning folder for fusiondsp Apr 12 19:42:25 display mpd[24163]: 2026-04-12T19:42:25 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 12 19:42:25 display systemd[1]: Started mpd.service - Music Player Daemon. Apr 12 19:42:25 display sudo[24089]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:25 display sudo[24041]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:25 display volumio[1433]: info: Scanning category user_interface Apr 12 19:42:25 display volumio[1433]: info: Plugin folders cleanup completed Apr 12 19:42:25 display volumio5-onboarding[2495]: time=2026-04-12T19:42:25.881-05:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 19:42:25 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 12 19:42:25 display volumio[1433]: info: [{"prettyName":"Now Playing","name":"now_playing","category":"user_interface","version":"1.0.6","icon":"fa-play-circle","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Peppy-meter-Basic","name":"peppymeterbasic","category":"user_interface","version":"1.0.9","icon":"fa-bar-chart","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Touch Display","name":"touch_display","category":"user_interface","version":"3.6.0","icon":"fa-hand-pointer-o","isManuallyInstalled":false,"enabled":true,"active":true}] Apr 12 19:42:25 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 12 19:42:25 display volumio[1433]: info: Shairport-Sync Started Apr 12 19:42:25 display volumio[1433]: error: MPD error: The expression evaluated to a falsy value: Apr 12 19:42:25 display volumio[1433]: assert.ok(self.idling) Apr 12 19:42:25 display volumio[1433]: error: The expression evaluated to a falsy value: Apr 12 19:42:25 display volumio[1433]: assert.ok(self.idling) Apr 12 19:42:25 display volumio[1433]: error: updateQueue error: null Apr 12 19:42:26 display volumio[1433]: info: TidalConnect service started! Apr 12 19:42:26 display volumio[1433]: info: TidalConnect service started! Apr 12 19:42:26 display qobuz-connect[23965]: 20260412 19:42:26.621 [23965.23965] INFO SampleApp: shat down connection on UNIX socket Apr 12 19:42:26 display volumio[1433]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Apr 12 19:42:26 display volumio[1433]: info: QobuzConnect: setDeactiveState invoked Apr 12 19:42:26 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:42:26 display systemd[1]: qobuz-connect.service: Deactivated successfully. Apr 12 19:42:26 display systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Apr 12 19:42:26 display systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Apr 12 19:42:26 display sudo[24142]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:26 display sudo[24079]: pam_unix(sudo:session): session closed for user root Apr 12 19:42:26 display volumio[1433]: info: Executing endpoint qc_getconfig Apr 12 19:42:26 display volumio[1433]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Apr 12 19:42:26 display qobuz-connect[24189]: 20260412 19:42:26.687 [24189.24189] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Apr 12 19:42:26 display volumio[1433]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Apr 12 19:42:26 display volumio[1433]: info: QobuzConnect: QOBUZ Connect daemon connected Apr 12 19:42:26 display qobuz-connect[24189]: 20260412 19:42:26.689 [24189.24189] INFO VolumeManager: [0x88b2b8]: Setting new playback volume: 75 Apr 12 19:42:26 display qobuz-connect[24189]: 20260412 19:42:26.689 [24189.24189] INFO VolumeManager: [0x88b2b8]: Setting new mute state: 0 Apr 12 19:42:26 display qobuz-connect[24189]: 20260412 19:42:26.689 [24189.24189] INFO AudioStreamManager: [0x88b010]: Setting new audio download buffer size: 1048576 Apr 12 19:42:26 display qobuz-connect[24189]: 20260412 19:42:26.689 [24189.24189] INFO QobuzConnect: [0x88bb80]: Client initialized! Apr 12 19:42:26 display qobuz-connect[24189]: 20260412 19:42:26.689 [24189.24189] INFO SampleApp: Starting Avahi advertising, name: Display, service name: _qobuz-connect._tcp Apr 12 19:42:26 display qobuz-connect[24189]: 20260412 19:42:26.702 [24189.24189] INFO LocalConfigManager: [0x88ad38]: Starting Local Configuration server Apr 12 19:42:26 display qobuz-connect[24189]: 20260412 19:42:26.702 [24189.24189] INFO SampleApp: Starting Local configuration server Apr 12 19:42:26 display qobuz-connect[24189]: 20260412 19:42:26.702 [24189.24189] INFO SampleApp: Connected to UNIX socket client 0x875818 Apr 12 19:42:26 display qobuz-connect[24189]: 20260412 19:42:26.836 [24189.24189] INFO SampleApp: Playback volume changed: 75 Apr 12 19:42:26 display volumio[1433]: info: CoreCommandRouter::volumioGetState Apr 12 19:42:27 display volumio[1433]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 12 19:42:27 display volumio[1433]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Apr 12 19:42:27 display volumio[1433]: at ChildProcess._handle.onexit (node:internal/child_process:286:19) Apr 12 19:42:27 display volumio[1433]: at onErrorNT (node:internal/child_process:484:16) Apr 12 19:42:27 display volumio[1433]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Apr 12 19:42:27 display volumio[1433]: errno: -2, Apr 12 19:42:27 display volumio[1433]: code: 'ENOENT', Apr 12 19:42:27 display volumio[1433]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Apr 12 19:42:27 display volumio[1433]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Apr 12 19:42:27 display volumio[1433]: spawnargs: [ Apr 12 19:42:27 display volumio[1433]: '-p', Apr 12 19:42:27 display volumio[1433]: 9876, Apr 12 19:42:27 display volumio[1433]: '-o', Apr 12 19:42:27 display volumio[1433]: '/tmp/camilladsp.log', Apr 12 19:42:27 display volumio[1433]: '-l', Apr 12 19:42:27 display volumio[1433]: 'warn', Apr 12 19:42:27 display volumio[1433]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Apr 12 19:42:27 display volumio[1433]: ] Apr 12 19:42:27 display volumio[1433]: } Apr 12 19:42:27 display volumio[1433]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 12 19:42:27 display sudo[24224]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-12 19:41' Apr 12 19:42:27 display sudo[24224]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"