Feb 11 18:42:00 lounge volumio[1291]: verbose: New Socket.io Connection to 192.168.129.88 from 192.168.129.42 UA: Mozilla/5.0 (Linux; Android 14; 21081111RG Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.132 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Feb 11 18:42:00 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 11 18:42:00 lounge volumio[1291]: info: CoreCommandRouter::volumioGetVisibleSources Feb 11 18:42:00 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 11 18:42:00 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:00 lounge volumio[1291]: info: CorePlayQueue::getTrack 1 Feb 11 18:42:00 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 11 18:42:00 lounge volumio[1291]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 11 18:42:00 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 11 18:42:00 lounge volumio[1291]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 11 18:42:00 lounge volumio[1291]: info: Received Get System Info Feb 11 18:42:00 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 18:42:00 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 18:42:00 lounge volumio[1291]: info: Discovery: Getting this device information Feb 11 18:42:00 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:00 lounge volumio[1291]: info: CorePlayQueue::getTrack 1 Feb 11 18:42:00 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 18:42:00 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:00 lounge volumio[1291]: info: CorePlayQueue::getTrack 1 Feb 11 18:42:00 lounge volumio[1291]: info: Listing playlists Feb 11 18:42:00 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 11 18:42:00 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 11 18:42:00 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 11 18:42:00 lounge volumio[1291]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 11 18:42:02 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 11 18:42:02 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 11 18:42:02 lounge volumio[1291]: info: Received Get System Info Feb 11 18:42:02 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 18:42:02 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 18:42:02 lounge volumio[1291]: info: Discovery: Getting this device information Feb 11 18:42:02 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:02 lounge volumio[1291]: info: CorePlayQueue::getTrack 1 Feb 11 18:42:02 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 18:42:02 lounge volumio[1291]: error: FusionDsp - Monitor WebSocket error: [object Object] Feb 11 18:42:02 lounge volumio[1291]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Feb 11 18:42:02 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 11 18:42:02 lounge volumio[1291]: info: Received Get System Info Feb 11 18:42:02 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 18:42:02 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 18:42:02 lounge volumio[1291]: info: Discovery: Getting this device information Feb 11 18:42:02 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:02 lounge volumio[1291]: info: CorePlayQueue::getTrack 1 Feb 11 18:42:02 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 18:42:03 lounge volumio[1291]: info: CoreCommandRouter::volumioPause Feb 11 18:42:03 lounge volumio[1291]: info: CoreStateMachine::pause Feb 11 18:42:03 lounge volumio[1291]: info: CoreStateMachine::stPlaybackTimer Feb 11 18:42:03 lounge volumio[1291]: info: CoreStateMachine::servicePause Feb 11 18:42:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 1 Feb 11 18:42:03 lounge volumio[1291]: info: CoreCommandRouter::servicePause Feb 11 18:42:03 lounge volumio[1291]: info: ControllerMpd::pause Feb 11 18:42:03 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand pause Feb 11 18:42:03 lounge volumio[1291]: info: Feb 11 18:42:03 lounge volumio[1291]: ---------------------------- MPD announces state update: player Feb 11 18:42:03 lounge volumio[1291]: info: sendMpdCommand pause took 0 milliseconds Feb 11 18:42:03 lounge volumio[1291]: info: ControllerMpd::getState Feb 11 18:42:03 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Feb 11 18:42:03 lounge volumio[1291]: info: sendMpdCommand status took 0 milliseconds Feb 11 18:42:03 lounge volumio[1291]: verbose: ControllerMpd::parseState Feb 11 18:42:03 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 18:42:03 lounge volumio[1291]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 11 18:42:03 lounge volumio[1291]: verbose: ControllerMpd::parseTrackInfo Feb 11 18:42:03 lounge volumio[1291]: info: ControllerMpd::pushState Feb 11 18:42:03 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:42:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 1 Feb 11 18:42:03 lounge volumio[1291]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":128451,"duration":380,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"806 Kbps","isStreaming":false,"title":"In the Heat of the Jungle","artist":"Chris Isaak","album":"Heart Shaped World","uri":"USB/Flac_Volumio/Music/Chris_Isaak/1989-Heart_Shaped_World/10-In_the_Heat_of_the_Jungle.flac","trackType":"flac"} Feb 11 18:42:03 lounge volumio[1291]: verbose: CURRENT POSITION 1 Feb 11 18:42:03 lounge volumio[1291]: info: CoreStateMachine::syncState stateService pause Feb 11 18:42:03 lounge volumio[1291]: info: CoreStateMachine::syncState currentStatus pause Feb 11 18:42:03 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:42:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 1 Feb 11 18:42:03 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:42:03 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:42:03 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:42:03 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:42:03 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 1 Feb 11 18:42:03 lounge volumio[1291]: info: CoreStateMachine::stPlaybackTimer Feb 11 18:42:03 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:03.048Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_PAUSED positionMs=146533 volume=100 Feb 11 18:42:03 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:03.048Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id=mnt/USB/Flac_Volumio/Music/Chris_Isaak/1989-Heart_Shaped_World/10-In_the_Heat_of_the_Jungle.flac title="In the Heat of the Jungle" Feb 11 18:42:03 lounge volumio[1291]: info: ------------------------------ 5ms Feb 11 18:42:03 lounge volumio[1291]: info: FusionDsp - Volumio is not playing Feb 11 18:42:03 lounge volumio[1291]: info: FusionDsp - Clipped samples monitor stopped Feb 11 18:42:05 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:05 lounge volumio[1291]: info: CorePlayQueue::getTrack 1 Feb 11 18:42:05 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 11 18:42:05 lounge volumio[1291]: info: CoreCommandRouter::volumioPlay Feb 11 18:42:05 lounge volumio[1291]: info: CoreStateMachine::play index undefined Feb 11 18:42:05 lounge volumio[1291]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 18:42:05 lounge volumio[1291]: info: CorePlayQueue::getTrack 1 Feb 11 18:42:05 lounge volumio[1291]: info: CoreStateMachine::startPlaybackTimer Feb 11 18:42:05 lounge volumio[1291]: info: CorePlayQueue::getTrack 1 Feb 11 18:42:05 lounge volumio[1291]: info: ControllerMpd::resume Feb 11 18:42:05 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand play Feb 11 18:42:05 lounge volumio[1291]: info: Feb 11 18:42:05 lounge volumio[1291]: ---------------------------- MPD announces state update: player Feb 11 18:42:05 lounge volumio[1291]: info: sendMpdCommand play took 2 milliseconds Feb 11 18:42:05 lounge volumio[1291]: info: ControllerMpd::getState Feb 11 18:42:05 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Feb 11 18:42:05 lounge volumio[1291]: info: sendMpdCommand status took 0 milliseconds Feb 11 18:42:05 lounge volumio[1291]: verbose: ControllerMpd::parseState Feb 11 18:42:05 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 18:42:05 lounge volumio[1291]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 11 18:42:05 lounge volumio[1291]: verbose: ControllerMpd::parseTrackInfo Feb 11 18:42:05 lounge volumio[1291]: info: ControllerMpd::pushState Feb 11 18:42:05 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:42:05 lounge volumio[1291]: info: CorePlayQueue::getTrack 1 Feb 11 18:42:05 lounge volumio[1291]: verbose: STATE SERVICE {"status":"play","position":0,"seek":129683,"duration":380,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"715 Kbps","isStreaming":false,"title":"In the Heat of the Jungle","artist":"Chris Isaak","album":"Heart Shaped World","uri":"USB/Flac_Volumio/Music/Chris_Isaak/1989-Heart_Shaped_World/10-In_the_Heat_of_the_Jungle.flac","trackType":"flac"} Feb 11 18:42:05 lounge volumio[1291]: verbose: CURRENT POSITION 1 Feb 11 18:42:05 lounge volumio[1291]: info: CoreStateMachine::syncState stateService play Feb 11 18:42:05 lounge volumio[1291]: info: CoreStateMachine::syncState currentStatus pause Feb 11 18:42:05 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:42:05 lounge volumio[1291]: info: CorePlayQueue::getTrack 1 Feb 11 18:42:05 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:42:05 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:42:05 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:42:05 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:42:05 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:05 lounge volumio[1291]: info: CorePlayQueue::getTrack 1 Feb 11 18:42:05 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:05.751Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_PLAYING positionMs=147486 volume=100 Feb 11 18:42:05 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:05.751Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id=mnt/USB/Flac_Volumio/Music/Chris_Isaak/1989-Heart_Shaped_World/10-In_the_Heat_of_the_Jungle.flac title="In the Heat of the Jungle" Feb 11 18:42:05 lounge volumio[1291]: info: ------------------------------ 4ms Feb 11 18:42:05 lounge volumio[1291]: info: FusionDsp - Volumio is playing Feb 11 18:42:05 lounge volumio[1291]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Feb 11 18:42:05 lounge volumio[1291]: error: FusionDsp - Monitor WebSocket error: [object Object] Feb 11 18:42:05 lounge volumio[1291]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Feb 11 18:42:05 lounge volumio[1291]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Feb 11 18:42:05 lounge volumio[1291]: info: FusionDsp - ---- read samplerate from file: 44100 Feb 11 18:42:06 lounge volumio[1291]: info: FusionDsp - If filter freq >samplerate/2 then disable it Feb 11 18:42:06 lounge volumio[1291]: error: FusionDsp - Reload WebSocket error: [object Object] Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::volumioNext Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::next Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::stop Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::stPlaybackTimer Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::updateTrackBlock Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrackBlock Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrack 1 Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:42:07 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:42:07 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrack 1 Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::serviceStop Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrack 1 Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::serviceStop Feb 11 18:42:07 lounge volumio[1291]: info: ControllerMpd::stop Feb 11 18:42:07 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 18:42:07 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:07.759Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_STOPPED positionMs=0 volume=100 Feb 11 18:42:07 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:07.760Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id=mnt/USB/Flac_Volumio/Music/Chris_Isaak/1989-Heart_Shaped_World/10-In_the_Heat_of_the_Jungle.flac title="In the Heat of the Jungle" Feb 11 18:42:07 lounge volumio[1291]: info: FusionDsp - Volumio is not playing Feb 11 18:42:07 lounge volumio[1291]: info: FusionDsp - Clipped samples monitor stopped Feb 11 18:42:07 lounge volumio[1291]: info: Feb 11 18:42:07 lounge volumio[1291]: ---------------------------- MPD announces state update: player Feb 11 18:42:07 lounge volumio[1291]: info: sendMpdCommand stop took 3 milliseconds Feb 11 18:42:07 lounge volumio[1291]: info: ControllerMpd::getState Feb 11 18:42:07 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::play index undefined Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::startPlaybackTimer Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:07 lounge volumio[1291]: verbose: ControllerMpd::clearAddPlayTracks USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac Feb 11 18:42:07 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::updateTrackBlock Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrackBlock Feb 11 18:42:07 lounge volumio[1291]: info: sendMpdCommand status took 0 milliseconds Feb 11 18:42:07 lounge volumio[1291]: info: sendMpdCommand stop took 0 milliseconds Feb 11 18:42:07 lounge volumio[1291]: verbose: ControllerMpd::parseState Feb 11 18:42:07 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 18:42:07 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand clear Feb 11 18:42:07 lounge volumio[1291]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 11 18:42:07 lounge volumio[1291]: verbose: ControllerMpd::parseTrackInfo Feb 11 18:42:07 lounge volumio[1291]: info: ControllerMpd::pushState Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:42:07 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:42:07 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:07 lounge volumio[1291]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"In the Heat of the Jungle","artist":"Chris Isaak","album":"Heart Shaped World","uri":"USB/Flac_Volumio/Music/Chris_Isaak/1989-Heart_Shaped_World/10-In_the_Heat_of_the_Jungle.flac","trackType":"flac"} Feb 11 18:42:07 lounge volumio[1291]: verbose: CURRENT POSITION 2 Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::syncState stateService stop Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::syncState currentStatus stop Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:42:07 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:42:07 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:07 lounge volumio[1291]: info: No code Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:42:07 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:42:07 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:07 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:07.768Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_STOPPED positionMs=0 volume=100 Feb 11 18:42:07 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:07.768Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_STOPPED positionMs=0 volume=100 Feb 11 18:42:07 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:07.768Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac" title="Solamente una vez" Feb 11 18:42:07 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:07.768Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_STOPPED positionMs=0 volume=100 Feb 11 18:42:07 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:07.768Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac" title="Solamente una vez" Feb 11 18:42:07 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:07.769Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac" title="Solamente una vez" Feb 11 18:42:07 lounge volumio[1291]: info: ------------------------------ 8ms Feb 11 18:42:07 lounge volumio[1291]: info: Feb 11 18:42:07 lounge volumio[1291]: ---------------------------- MPD announces system playlist update Feb 11 18:42:07 lounge volumio[1291]: info: Ignoring MPD Status Update Feb 11 18:42:07 lounge volumio[1291]: info: sendMpdCommand clear took 6 milliseconds Feb 11 18:42:07 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand add "USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac" Feb 11 18:42:07 lounge volumio[1291]: info: FusionDsp - Volumio is not playing Feb 11 18:42:07 lounge volumio[1291]: info: FusionDsp - Clipped samples monitor stopped Feb 11 18:42:07 lounge volumio[1291]: info: FusionDsp - Volumio is not playing Feb 11 18:42:07 lounge volumio[1291]: info: FusionDsp - Clipped samples monitor stopped Feb 11 18:42:07 lounge volumio[1291]: info: FusionDsp - Volumio is not playing Feb 11 18:42:07 lounge volumio[1291]: info: FusionDsp - Clipped samples monitor stopped Feb 11 18:42:07 lounge volumio[1291]: error: updateQueue error: null Feb 11 18:42:07 lounge volumio[1291]: info: Feb 11 18:42:07 lounge volumio[1291]: ---------------------------- MPD announces system playlist update Feb 11 18:42:07 lounge volumio[1291]: info: Ignoring MPD Status Update Feb 11 18:42:07 lounge volumio[1291]: info: ------------------------------ 5ms Feb 11 18:42:07 lounge volumio[1291]: info: sendMpdCommand add "USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac" took 4 milliseconds Feb 11 18:42:07 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand play Feb 11 18:42:07 lounge volumio[1291]: info: ------------------------------ 1ms Feb 11 18:42:07 lounge volumio[1291]: info: sendMpdCommand play took 0 milliseconds Feb 11 18:42:07 lounge volumio[1291]: info: Feb 11 18:42:07 lounge volumio[1291]: ---------------------------- MPD announces state update: player Feb 11 18:42:07 lounge volumio[1291]: info: ControllerMpd::getState Feb 11 18:42:07 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Feb 11 18:42:07 lounge volumio[1291]: info: Feb 11 18:42:07 lounge volumio[1291]: ---------------------------- MPD announces state update: player Feb 11 18:42:07 lounge volumio[1291]: info: sendMpdCommand status took 2 milliseconds Feb 11 18:42:07 lounge volumio[1291]: info: ControllerMpd::getState Feb 11 18:42:07 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Feb 11 18:42:07 lounge volumio[1291]: verbose: ControllerMpd::parseState Feb 11 18:42:07 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 18:42:07 lounge volumio[1291]: info: sendMpdCommand status took 0 milliseconds Feb 11 18:42:07 lounge volumio[1291]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 11 18:42:07 lounge volumio[1291]: verbose: ControllerMpd::parseState Feb 11 18:42:07 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 18:42:07 lounge volumio[1291]: verbose: ControllerMpd::parseTrackInfo Feb 11 18:42:07 lounge volumio[1291]: info: ControllerMpd::pushState Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:07 lounge volumio[1291]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":131,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"709 Kbps","isStreaming":false,"title":"Solamente una vez","artist":"The 3 Tenors","album":"The 3 Tenors in Paris 1998","uri":"USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac","trackType":"flac"} Feb 11 18:42:07 lounge volumio[1291]: verbose: CURRENT POSITION 2 Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::syncState stateService play Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::syncState currentStatus stop Feb 11 18:42:07 lounge volumio[1291]: info: ------------------------------ 4ms Feb 11 18:42:07 lounge volumio[1291]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 11 18:42:07 lounge volumio[1291]: verbose: ControllerMpd::parseTrackInfo Feb 11 18:42:07 lounge volumio[1291]: info: ControllerMpd::pushState Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:07 lounge volumio[1291]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1209,"duration":131,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"726 Kbps","isStreaming":false,"title":"Solamente una vez","artist":"The 3 Tenors","album":"The 3 Tenors in Paris 1998","uri":"USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac","trackType":"flac"} Feb 11 18:42:07 lounge volumio[1291]: verbose: CURRENT POSITION 2 Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::syncState stateService play Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::syncState currentStatus play Feb 11 18:42:07 lounge volumio[1291]: info: Received an update from plugin. extracting info from payload Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:42:07 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:42:07 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:07 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:42:07 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:42:07 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:42:07 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:07 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:07 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:07.787Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_PLAYING positionMs=1209 volume=100 Feb 11 18:42:07 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:07.787Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_PLAYING positionMs=1209 volume=100 Feb 11 18:42:07 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:07.787Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac" title="Solamente una vez" Feb 11 18:42:07 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:07.787Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac" title="Solamente una vez" Feb 11 18:42:07 lounge volumio[1291]: info: ------------------------------ 8ms Feb 11 18:42:07 lounge volumio[1291]: info: FusionDsp - Volumio is playing Feb 11 18:42:07 lounge volumio[1291]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Feb 11 18:42:07 lounge volumio[1291]: info: FusionDsp - Volumio is playing Feb 11 18:42:07 lounge volumio[1291]: error: FusionDsp - Monitor WebSocket error: [object Object] Feb 11 18:42:07 lounge volumio[1291]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Feb 11 18:42:07 lounge volumio[1291]: error: FusionDsp - Monitor WebSocket error: [object Object] Feb 11 18:42:07 lounge volumio[1291]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Feb 11 18:42:07 lounge volumio[1291]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Feb 11 18:42:07 lounge volumio[1291]: info: FusionDsp - ---- read samplerate from file: 44100 Feb 11 18:42:08 lounge volumio[1291]: info: FusionDsp - If filter freq >samplerate/2 then disable it Feb 11 18:42:08 lounge volumio[1291]: error: FusionDsp - Reload WebSocket error: [object Object] Feb 11 18:42:08 lounge volumio[1291]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Feb 11 18:42:08 lounge volumio[1291]: 2+0 records in Feb 11 18:42:08 lounge volumio[1291]: 2+0 records out Feb 11 18:42:08 lounge volumio[1291]: 65536 bytes (66 kB, 64 KiB) copied, 0.000124369 s, 527 MB/s Feb 11 18:42:08 lounge volumio[1291]: info: camilladsp respawn in 10000 ms (attempt 6/10) Feb 11 18:42:10 lounge volumio[1291]: info: CoreCommandRouter::volumioPause Feb 11 18:42:10 lounge volumio[1291]: info: CoreStateMachine::pause Feb 11 18:42:10 lounge volumio[1291]: info: CoreStateMachine::stPlaybackTimer Feb 11 18:42:10 lounge volumio[1291]: info: CoreStateMachine::servicePause Feb 11 18:42:10 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:10 lounge volumio[1291]: info: CoreCommandRouter::servicePause Feb 11 18:42:10 lounge volumio[1291]: info: ControllerMpd::pause Feb 11 18:42:10 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand pause Feb 11 18:42:10 lounge volumio[1291]: info: sendMpdCommand pause took 0 milliseconds Feb 11 18:42:10 lounge volumio[1291]: info: Feb 11 18:42:10 lounge volumio[1291]: ---------------------------- MPD announces state update: player Feb 11 18:42:10 lounge volumio[1291]: info: ControllerMpd::getState Feb 11 18:42:10 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Feb 11 18:42:10 lounge volumio[1291]: info: sendMpdCommand status took 1 milliseconds Feb 11 18:42:10 lounge volumio[1291]: verbose: ControllerMpd::parseState Feb 11 18:42:10 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 18:42:10 lounge volumio[1291]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 11 18:42:10 lounge volumio[1291]: verbose: ControllerMpd::parseTrackInfo Feb 11 18:42:10 lounge volumio[1291]: info: ControllerMpd::pushState Feb 11 18:42:10 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:42:10 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:10 lounge volumio[1291]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":1847,"duration":131,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"786 Kbps","isStreaming":false,"title":"Solamente una vez","artist":"The 3 Tenors","album":"The 3 Tenors in Paris 1998","uri":"USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac","trackType":"flac"} Feb 11 18:42:10 lounge volumio[1291]: verbose: CURRENT POSITION 2 Feb 11 18:42:10 lounge volumio[1291]: info: CoreStateMachine::syncState stateService pause Feb 11 18:42:10 lounge volumio[1291]: info: CoreStateMachine::syncState currentStatus pause Feb 11 18:42:10 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:42:10 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:10 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:42:10 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:42:10 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:42:10 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:42:10 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:10 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:10 lounge volumio[1291]: info: CoreStateMachine::stPlaybackTimer Feb 11 18:42:10 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:10.059Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_PAUSED positionMs=3460 volume=100 Feb 11 18:42:10 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:10.059Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac" title="Solamente una vez" Feb 11 18:42:10 lounge volumio[1291]: info: ------------------------------ 5ms Feb 11 18:42:10 lounge volumio[1291]: info: FusionDsp - Volumio is not playing Feb 11 18:42:10 lounge volumio[1291]: info: FusionDsp - Clipped samples monitor stopped Feb 11 18:42:10 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 11 18:42:13 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:13 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:13 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 11 18:42:13 lounge volumio[1291]: info: CoreCommandRouter::volumioPlay Feb 11 18:42:13 lounge volumio[1291]: info: CoreStateMachine::play index undefined Feb 11 18:42:13 lounge volumio[1291]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 18:42:13 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:13 lounge volumio[1291]: info: CoreStateMachine::startPlaybackTimer Feb 11 18:42:13 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:13 lounge volumio[1291]: info: ControllerMpd::resume Feb 11 18:42:13 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand play Feb 11 18:42:13 lounge volumio[1291]: info: Feb 11 18:42:13 lounge volumio[1291]: ---------------------------- MPD announces state update: player Feb 11 18:42:13 lounge volumio[1291]: info: sendMpdCommand play took 2 milliseconds Feb 11 18:42:13 lounge volumio[1291]: info: ControllerMpd::getState Feb 11 18:42:13 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Feb 11 18:42:13 lounge volumio[1291]: info: sendMpdCommand status took 0 milliseconds Feb 11 18:42:13 lounge volumio[1291]: verbose: ControllerMpd::parseState Feb 11 18:42:13 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 18:42:13 lounge volumio[1291]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 11 18:42:13 lounge volumio[1291]: verbose: ControllerMpd::parseTrackInfo Feb 11 18:42:13 lounge volumio[1291]: info: ControllerMpd::pushState Feb 11 18:42:13 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:42:13 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:13 lounge volumio[1291]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3033,"duration":131,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"763 Kbps","isStreaming":false,"title":"Solamente una vez","artist":"The 3 Tenors","album":"The 3 Tenors in Paris 1998","uri":"USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac","trackType":"flac"} Feb 11 18:42:13 lounge volumio[1291]: verbose: CURRENT POSITION 2 Feb 11 18:42:13 lounge volumio[1291]: info: CoreStateMachine::syncState stateService play Feb 11 18:42:13 lounge volumio[1291]: info: CoreStateMachine::syncState currentStatus pause Feb 11 18:42:13 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:42:13 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:13 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:42:13 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:42:13 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:42:13 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:42:13 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:13 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:13 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:13.936Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_PLAYING positionMs=3947 volume=100 Feb 11 18:42:13 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:13.936Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac" title="Solamente una vez" Feb 11 18:42:13 lounge volumio[1291]: info: ------------------------------ 4ms Feb 11 18:42:13 lounge volumio[1291]: info: FusionDsp - Volumio is playing Feb 11 18:42:13 lounge volumio[1291]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Feb 11 18:42:13 lounge volumio[1291]: error: FusionDsp - Monitor WebSocket error: [object Object] Feb 11 18:42:13 lounge volumio[1291]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Feb 11 18:42:14 lounge volumio[1291]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Feb 11 18:42:14 lounge volumio[1291]: info: FusionDsp - ---- read samplerate from file: 44100 Feb 11 18:42:14 lounge volumio[1291]: info: FusionDsp - If filter freq >samplerate/2 then disable it Feb 11 18:42:14 lounge volumio[1291]: error: FusionDsp - Reload WebSocket error: [object Object] Feb 11 18:42:18 lounge volumio[1291]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Feb 11 18:42:18 lounge volumio[1291]: 2+0 records in Feb 11 18:42:18 lounge volumio[1291]: 2+0 records out Feb 11 18:42:18 lounge volumio[1291]: 65536 bytes (66 kB, 64 KiB) copied, 9.0815e-05 s, 722 MB/s Feb 11 18:42:18 lounge volumio[1291]: info: camilladsp respawn in 10000 ms (attempt 7/10) Feb 11 18:42:18 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 11 18:42:18 lounge volumio[1291]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 11 18:42:18 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 11 18:42:18 lounge volumio[1291]: info: Received Get System Version Feb 11 18:42:18 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 11 18:42:18 lounge volumio[1291]: info: Received Get System Info Feb 11 18:42:18 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 18:42:18 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 18:42:18 lounge volumio[1291]: info: Discovery: Getting this device information Feb 11 18:42:18 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:18 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:18 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 18:42:20 lounge volumio[1291]: error: FusionDsp - Monitor WebSocket error: [object Object] Feb 11 18:42:20 lounge volumio[1291]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Feb 11 18:42:22 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 11 18:42:22 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 11 18:42:22 lounge volumio[1291]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 11 18:42:24 lounge volumio[1291]: error: FusionDsp - Monitor WebSocket error: [object Object] Feb 11 18:42:24 lounge volumio[1291]: info: FusionDsp - Clipping Monitor reconnecting in 30000ms Feb 11 18:42:28 lounge volumio[1291]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Feb 11 18:42:28 lounge volumio[1291]: 2+0 records in Feb 11 18:42:28 lounge volumio[1291]: 2+0 records out Feb 11 18:42:28 lounge volumio[1291]: 65536 bytes (66 kB, 64 KiB) copied, 0.000125795 s, 521 MB/s Feb 11 18:42:28 lounge volumio[1291]: info: camilladsp respawn in 10000 ms (attempt 8/10) Feb 11 18:42:31 lounge volumio[1291]: info: FusionDsp - Stopping clipped samples monitor Feb 11 18:42:31 lounge volumio[1291]: info: FusionDsp - Clipped samples monitor stopped Feb 11 18:42:31 lounge volumio[1291]: info: FusionDsp - Stopping FusionDsp service Feb 11 18:42:31 lounge volumio[1291]: info: camilladsp service terminated, instance 1 Feb 11 18:42:31 lounge volumio[1291]: info: Disabling plugin fusiondsp Feb 11 18:42:31 lounge volumio[1291]: info: Preparing to generate the ALSA configuration file Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::volumioPause Feb 11 18:42:31 lounge volumio[1291]: info: CoreStateMachine::pause Feb 11 18:42:31 lounge volumio[1291]: info: CoreStateMachine::stPlaybackTimer Feb 11 18:42:31 lounge volumio[1291]: info: CoreStateMachine::servicePause Feb 11 18:42:31 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::servicePause Feb 11 18:42:31 lounge volumio[1291]: info: ControllerMpd::pause Feb 11 18:42:31 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand pause Feb 11 18:42:31 lounge sudo[9950]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Feb 11 18:42:31 lounge sudo[9950]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 18:42:31 lounge volumio[1291]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 11 18:42:31 lounge volumio[1291]: info: Reading ALSA contributions from plugins. Feb 11 18:42:31 lounge volumio[1291]: info: Feb 11 18:42:31 lounge volumio[1291]: ---------------------------- MPD announces state update: player Feb 11 18:42:31 lounge volumio[1291]: info: sendMpdCommand pause took 1 milliseconds Feb 11 18:42:31 lounge volumio[1291]: info: ControllerMpd::getState Feb 11 18:42:31 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Feb 11 18:42:31 lounge volumio[1291]: info: sendMpdCommand status took 0 milliseconds Feb 11 18:42:31 lounge volumio[1291]: verbose: ControllerMpd::parseState Feb 11 18:42:31 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 18:42:31 lounge volumio[1291]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 11 18:42:31 lounge volumio[1291]: verbose: ControllerMpd::parseTrackInfo Feb 11 18:42:31 lounge volumio[1291]: info: ControllerMpd::pushState Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:42:31 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:31 lounge volumio[1291]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":3969,"duration":131,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"778 Kbps","isStreaming":false,"title":"Solamente una vez","artist":"The 3 Tenors","album":"The 3 Tenors in Paris 1998","uri":"USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac","trackType":"flac"} Feb 11 18:42:31 lounge volumio[1291]: verbose: CURRENT POSITION 2 Feb 11 18:42:31 lounge volumio[1291]: info: CoreStateMachine::syncState stateService pause Feb 11 18:42:31 lounge volumio[1291]: info: CoreStateMachine::syncState currentStatus pause Feb 11 18:42:31 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:42:31 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:42:31 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:42:31 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:31 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:31 lounge volumio[1291]: info: CoreStateMachine::stPlaybackTimer Feb 11 18:42:31 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:31.257Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_PAUSED positionMs=21212 volume=100 Feb 11 18:42:31 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:31.257Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac" title="Solamente una vez" Feb 11 18:42:31 lounge volumio[1291]: info: ------------------------------ 4ms Feb 11 18:42:31 lounge systemd[1]: Stopping fusiondsp.service - FusionDsp Daemon... Feb 11 18:42:31 lounge volumio[7955]: ======== Running on http://0.0.0.0:5011 ======== Feb 11 18:42:31 lounge volumio[7955]: (Press CTRL+C to quit) Feb 11 18:42:31 lounge volumio[1291]: info: Asound.conf file written Feb 11 18:42:31 lounge sudo[9954]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 11 18:42:31 lounge sudo[9954]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 18:42:31 lounge sudo[9954]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:31 lounge volumio[1291]: info: Output device has changed, restarting MPD Feb 11 18:42:31 lounge sudo[9962]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 11 18:42:31 lounge sudo[9962]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 18:42:31 lounge sudo[9962]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:31 lounge volumio[1291]: info: Output device has changed, restarting Shairport Sync Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 11 18:42:31 lounge sudo[9965]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 11 18:42:31 lounge sudo[9965]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 18:42:31 lounge volumio[1291]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 11 18:42:31 lounge volumio[1291]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:31 lounge volumio[1291]: info: QobuzConnect: setDeactiveState invoked Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:31 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:31 lounge vtcs[7885]: [2026-02-11 18:42:31.327] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Feb 11 18:42:31 lounge vtcs[7885]: [2026-02-11 18:42:31.327] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Feb 11 18:42:31 lounge systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 11 18:42:31 lounge volumio[1291]: info: Done. Feb 11 18:42:31 lounge sudo[9974]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 11 18:42:31 lounge sudo[9974]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 11 18:42:31 lounge systemd[1]: mpd.service: Deactivated successfully. Feb 11 18:42:31 lounge systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 11 18:42:31 lounge systemd[1]: mpd.service: Consumed 3.003s CPU time. Feb 11 18:42:31 lounge systemd[1]: mpd.socket: Deactivated successfully. Feb 11 18:42:31 lounge sudo[9978]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 11 18:42:31 lounge systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 11 18:42:31 lounge systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 11 18:42:31 lounge sudo[9978]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 18:42:31 lounge volumio[1291]: info: MPD Permissions set Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:31 lounge sudo[9985]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 11 18:42:31 lounge sudo[9985]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 11 18:42:31 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:31 lounge volumio[1291]: info: Starting Shairport Sync Feb 11 18:42:31 lounge systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 11 18:42:31 lounge systemd[1]: Starting mpd.service - Music Player Daemon... Feb 11 18:42:31 lounge systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Feb 11 18:42:31 lounge systemd[1]: vtcs.service: Killing process 7892 (vtcs) with signal SIGKILL. Feb 11 18:42:31 lounge systemd[1]: fusiondsp.service: Deactivated successfully. Feb 11 18:42:31 lounge systemd[1]: Stopped fusiondsp.service - FusionDsp Daemon. Feb 11 18:42:31 lounge systemd[1]: fusiondsp.service: Consumed 2.116s CPU time. Feb 11 18:42:31 lounge systemd[1]: vtcs.service: Deactivated successfully. Feb 11 18:42:31 lounge systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Feb 11 18:42:31 lounge sudo[9998]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 11 18:42:31 lounge sudo[9998]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 18:42:31 lounge sudo[9974]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:31 lounge sudo[9950]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:31 lounge sudo[9985]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:31 lounge volumio[1291]: info: FusionDsp - Reporting Fusion DSP Disabled Feb 11 18:42:31 lounge volumio[1291]: info: Removing fusiondspeq DSP Signal Path Element Feb 11 18:42:31 lounge systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 11 18:42:31 lounge systemd[1]: shairport-sync.service: Deactivated successfully. Feb 11 18:42:31 lounge systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 11 18:42:31 lounge systemd[1]: shairport-sync.service: Consumed 4.321s CPU time. Feb 11 18:42:31 lounge sudo[10001]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 11 18:42:31 lounge sudo[10001]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 18:42:31 lounge sudo[9978]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:31 lounge sudo[9997]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 11 18:42:31 lounge sudo[9997]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 18:42:31 lounge sudo[9997]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:31 lounge systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 11 18:42:31 lounge sudo[9998]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:31 lounge volumio[1291]: info: Shairport-Sync Started Feb 11 18:42:31 lounge systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Feb 11 18:42:31 lounge qobuz-connect[7856]: 20260211 18:42:31.462 [7856.7856] INFO SampleApp: Stopping Local configuration server Feb 11 18:42:31 lounge mpd[10007]: 2026-02-11T18:42:31 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 11 18:42:31 lounge systemd[1]: Started mpd.service - Music Player Daemon. Feb 11 18:42:31 lounge sudo[9965]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:31 lounge volumio[1291]: error: updateQueue error: null Feb 11 18:42:32 lounge qobuz-connect[7856]: 20260211 18:42:32.913 [7856.7856] INFO SampleApp: shat down connection on UNIX socket Feb 11 18:42:32 lounge volumio[1291]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 11 18:42:32 lounge volumio[1291]: info: QobuzConnect: setDeactiveState invoked Feb 11 18:42:32 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:32 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:32 lounge systemd[1]: qobuz-connect.service: Deactivated successfully. Feb 11 18:42:32 lounge systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Feb 11 18:42:32 lounge systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Feb 11 18:42:32 lounge sudo[10001]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:32 lounge volumio[1291]: info: Executing endpoint qc_getconfig Feb 11 18:42:32 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 11 18:42:32 lounge qobuz-connect[10027]: 20260211 18:42:32.965 [10027.10027] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 11 18:42:32 lounge volumio[1291]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 11 18:42:32 lounge volumio[1291]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 11 18:42:32 lounge qobuz-connect[10027]: 20260211 18:42:32.966 [10027.10027] INFO VolumeManager: [0x559ba528b2e0]: Setting new playback volume: 75 Feb 11 18:42:32 lounge qobuz-connect[10027]: 20260211 18:42:32.966 [10027.10027] INFO VolumeManager: [0x559ba528b2e0]: Setting new mute state: 0 Feb 11 18:42:32 lounge qobuz-connect[10027]: 20260211 18:42:32.966 [10027.10027] INFO QobuzConnect: [0x559ba528c500]: Client initialized! Feb 11 18:42:32 lounge qobuz-connect[10027]: 20260211 18:42:32.966 [10027.10027] INFO SampleApp: Starting Avahi advertising, name: Lounge, service name: _qobuz-connect._tcp Feb 11 18:42:32 lounge qobuz-connect[10027]: 20260211 18:42:32.969 [10027.10027] INFO LocalConfigManager: [0x559ba528a5d0]: Starting Local Configuration server Feb 11 18:42:32 lounge qobuz-connect[10027]: 20260211 18:42:32.969 [10027.10027] INFO SampleApp: Starting Local configuration server Feb 11 18:42:32 lounge qobuz-connect[10027]: 20260211 18:42:32.970 [10027.10027] INFO SampleApp: Connected to UNIX socket client 0x559ba5260bb0 Feb 11 18:42:33 lounge qobuz-connect[10027]: 20260211 18:42:33.114 [10027.10027] INFO SampleApp: Playback volume changed: 75 Feb 11 18:42:33 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:33 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:34 lounge volumio[1291]: info: TidalConnect service stoped! Feb 11 18:42:34 lounge volumio[1291]: info: TidalConnect service stoped! Feb 11 18:42:34 lounge volumio[1291]: info: Starting Uninstall of plugin audio_interface - fusiondsp Feb 11 18:42:34 lounge volumio[1291]: info: Uninstalling plugin fusiondsp Feb 11 18:42:34 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:34.441Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 11 18:42:34 lounge volumio[1291]: info: Disabling plugin fusiondsp Feb 11 18:42:34 lounge volumio[1291]: info: Preparing to generate the ALSA configuration file Feb 11 18:42:34 lounge volumio[1291]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 11 18:42:34 lounge volumio[1291]: info: Reading ALSA contributions from plugins. Feb 11 18:42:34 lounge volumio[1291]: info: Asound.conf file unchanged, so no further update is needed Feb 11 18:42:34 lounge volumio[1291]: info: Output device has changed, restarting MPD Feb 11 18:42:34 lounge volumio[1291]: info: Output device has changed, restarting Shairport Sync Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 11 18:42:34 lounge sudo[10044]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 11 18:42:34 lounge sudo[10044]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 18:42:34 lounge sudo[10044]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:34 lounge sudo[10046]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 11 18:42:34 lounge sudo[10046]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 18:42:34 lounge volumio[1291]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 11 18:42:34 lounge volumio[1291]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:34 lounge volumio[1291]: info: QobuzConnect: setDeactiveState invoked Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:34 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:34 lounge systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 11 18:42:34 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:34.482Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 11 18:42:34 lounge volumio[1291]: info: Checking if uninstall.sh is present Feb 11 18:42:34 lounge sudo[10056]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 11 18:42:34 lounge sudo[10056]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 18:42:34 lounge systemd[1]: mpd.service: Deactivated successfully. Feb 11 18:42:34 lounge systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 11 18:42:34 lounge systemd[1]: mpd.socket: Deactivated successfully. Feb 11 18:42:34 lounge sudo[10059]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 11 18:42:34 lounge systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 11 18:42:34 lounge sudo[10059]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 18:42:34 lounge systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 11 18:42:34 lounge volumio[1291]: info: Executing uninstall.sh Feb 11 18:42:34 lounge sudo[10067]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 11 18:42:34 lounge sudo[10067]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 18:42:34 lounge volumio[1291]: info: MPD Permissions set Feb 11 18:42:34 lounge volumio[1291]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 11 18:42:34 lounge volumio[1291]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:34 lounge systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 11 18:42:34 lounge systemd[1]: Starting mpd.service - Music Player Daemon... Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 18:42:34 lounge sudo[10070]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/audio_interface/fusiondsp/uninstall.sh Feb 11 18:42:34 lounge sudo[10070]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 18:42:34 lounge volumio[1291]: info: Starting Shairport Sync Feb 11 18:42:34 lounge sudo[10067]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:34 lounge sudo[10084]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 11 18:42:34 lounge sudo[10084]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 18:42:34 lounge sudo[10088]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 11 18:42:34 lounge sudo[10088]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 18:42:34 lounge sudo[10056]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:34 lounge sudo[10059]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:34 lounge sudo[10089]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 11 18:42:34 lounge sudo[10089]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 18:42:34 lounge sudo[10077]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 11 18:42:34 lounge sudo[10077]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 18:42:34 lounge sudo[10077]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:34 lounge qobuz-connect[10027]: 20260211 18:42:34.613 [10027.10027] INFO SampleApp: Stopping Local configuration server Feb 11 18:42:34 lounge systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Feb 11 18:42:34 lounge systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 11 18:42:34 lounge systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Feb 11 18:42:34 lounge sudo[10084]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:34 lounge systemd[1]: shairport-sync.service: Deactivated successfully. Feb 11 18:42:34 lounge systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 11 18:42:34 lounge systemd[1]: shairport-sync.service: Consumed 1.534s CPU time. Feb 11 18:42:34 lounge systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 11 18:42:34 lounge sudo[10088]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:34 lounge sudo[10100]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm /etc/systemd/system/fusiondsp.service Feb 11 18:42:34 lounge sudo[10100]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 18:42:34 lounge volumio[1291]: info: Shairport-Sync Started Feb 11 18:42:34 lounge sudo[10100]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:34 lounge sudo[10103]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl daemon-reload Feb 11 18:42:34 lounge sudo[10103]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 18:42:34 lounge systemd[1]: Reloading. Feb 11 18:42:34 lounge volumio[1291]: info: Executing endpoint tc_getconfig Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 11 18:42:34 lounge vtcs[10098]: STARTING TidalConnect services, version: 1.6.1 Feb 11 18:42:34 lounge vtcs[10098]: STARTED TidalConnect services. Feb 11 18:42:34 lounge volumio[1291]: info: Executing endpoint tc_connect Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 11 18:42:34 lounge volumio[1291]: info: Connecting to TidalConnect Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:42:34 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:42:34 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:42:34 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:42:34 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:34 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:34 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:34 lounge volumio[1291]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:42:34 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:42:34 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:42:34 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:42:34 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:34 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:34 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:34 lounge volumio[1291]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Feb 11 18:42:34 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:34.714Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_PAUSED positionMs=21462 volume=100 Feb 11 18:42:34 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:34.715Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac" title="Solamente una vez" Feb 11 18:42:34 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:34.715Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_PAUSED positionMs=21462 volume=100 Feb 11 18:42:34 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:34.716Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac" title="Solamente una vez" Feb 11 18:42:34 lounge systemd-gpt-auto-generator[10141]: EFI loader partition unknown, exiting. Feb 11 18:42:34 lounge systemd-gpt-auto-generator[10141]: (The boot loader did not set EFI variable LoaderDevicePartUUID.) Feb 11 18:42:34 lounge volumio[1291]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 11 18:42:34 lounge volumio[1291]: info: QobuzConnect: setDeactiveState invoked Feb 11 18:42:34 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:34 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:34 lounge qobuz-connect[10027]: 20260211 18:42:34.983 [10027.10027] INFO SampleApp: shat down connection on UNIX socket Feb 11 18:42:34 lounge mpd[10096]: 2026-02-11T18:42:34 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 11 18:42:35 lounge 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. Feb 11 18:42:35 lounge 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. Feb 11 18:42:35 lounge sudo[10103]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:35 lounge systemd[1]: Started mpd.service - Music Player Daemon. Feb 11 18:42:35 lounge sudo[10070]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:35 lounge systemd[1]: qobuz-connect.service: Deactivated successfully. Feb 11 18:42:35 lounge systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Feb 11 18:42:35 lounge volumio[1291]: info: Uninstall script completed Feb 11 18:42:35 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:35.062Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 11 18:42:35 lounge sudo[10046]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:35 lounge volumio[1291]: info: Removing plugin fusiondsp from configuration Feb 11 18:42:35 lounge volumio[1291]: info: Successfully removed fusiondsp configuration files Feb 11 18:42:35 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:35.080Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 11 18:42:35 lounge volumio[1291]: info: Plugin folders cleanup Feb 11 18:42:35 lounge volumio[1291]: info: Scanning into folder /volumio/app/plugins/ Feb 11 18:42:35 lounge volumio[1291]: info: Scanning category audio_interface Feb 11 18:42:35 lounge volumio[1291]: info: Scanning category miscellanea Feb 11 18:42:35 lounge volumio[1291]: info: Scanning category music_service Feb 11 18:42:35 lounge volumio[1291]: info: Scanning category plugins.json Feb 11 18:42:35 lounge volumio[1291]: info: Scanning category system_controller Feb 11 18:42:35 lounge volumio[1291]: info: Scanning category user_interface Feb 11 18:42:35 lounge volumio[1291]: info: Scanning into folder /data/plugins/ Feb 11 18:42:35 lounge volumio[1291]: info: Scanning category audio_interface Feb 11 18:42:35 lounge volumio[1291]: info: Cleaning folder for fusiondsp Feb 11 18:42:35 lounge systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Feb 11 18:42:35 lounge sudo[10089]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:35 lounge volumio[1291]: info: Scanning category music_service Feb 11 18:42:35 lounge volumio[1291]: info: Scanning category user_interface Feb 11 18:42:35 lounge volumio[1291]: info: Plugin folders cleanup completed Feb 11 18:42:35 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:35.500Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 11 18:42:35 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 11 18:42:35 lounge volumio[1291]: info: [{"prettyName":"Mother Earth Radio","name":"motherearthradio","category":"music_service","version":"1.5.0","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Radio Paradise","name":"radio_paradise","category":"music_service","version":"2.0.16","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Randomizer","name":"randomizer","category":"user_interface","version":"4.1.2","icon":"fa-random","isManuallyInstalled":false,"enabled":true,"active":true}] Feb 11 18:42:35 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 11 18:42:35 lounge volumio[1291]: info: Executing endpoint qc_getconfig Feb 11 18:42:35 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 11 18:42:35 lounge qobuz-connect[10153]: 20260211 18:42:35.531 [10153.10153] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 11 18:42:35 lounge qobuz-connect[10153]: 20260211 18:42:35.533 [10153.10153] INFO VolumeManager: [0x564eea4242e0]: Setting new playback volume: 75 Feb 11 18:42:35 lounge qobuz-connect[10153]: 20260211 18:42:35.533 [10153.10153] INFO VolumeManager: [0x564eea4242e0]: Setting new mute state: 0 Feb 11 18:42:35 lounge qobuz-connect[10153]: 20260211 18:42:35.533 [10153.10153] INFO QobuzConnect: [0x564eea425500]: Client initialized! Feb 11 18:42:35 lounge qobuz-connect[10153]: 20260211 18:42:35.533 [10153.10153] INFO SampleApp: Starting Avahi advertising, name: Lounge, service name: _qobuz-connect._tcp Feb 11 18:42:35 lounge volumio[1291]: error: updateQueue error: null Feb 11 18:42:35 lounge volumio[1291]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 11 18:42:35 lounge volumio[1291]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 11 18:42:35 lounge qobuz-connect[10153]: 20260211 18:42:35.542 [10153.10153] INFO LocalConfigManager: [0x564eea4235d0]: Starting Local Configuration server Feb 11 18:42:35 lounge qobuz-connect[10153]: 20260211 18:42:35.543 [10153.10153] INFO SampleApp: Starting Local configuration server Feb 11 18:42:35 lounge qobuz-connect[10153]: 20260211 18:42:35.543 [10153.10153] INFO SampleApp: Connected to UNIX socket client 0x564eea3f9bb0 Feb 11 18:42:35 lounge qobuz-connect[10153]: 20260211 18:42:35.681 [10153.10153] INFO SampleApp: Playback volume changed: 75 Feb 11 18:42:35 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:35 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:37 lounge volumio[1291]: info: TidalConnect service stoped! Feb 11 18:42:37 lounge volumio[1291]: info: TidalConnect service stoped! Feb 11 18:42:37 lounge volumio[1291]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 11 18:42:37 lounge volumio[1291]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 11 18:42:37 lounge sudo[10175]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 11 18:42:37 lounge sudo[10175]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 18:42:37 lounge sudo[10175]: pam_unix(sudo:session): session closed for user root Feb 11 18:42:37 lounge volumio[1291]: info: TidalConnect service started! Feb 11 18:42:38 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:38 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:38 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 11 18:42:38 lounge volumio[1291]: info: CoreCommandRouter::volumioPlay Feb 11 18:42:38 lounge volumio[1291]: info: CoreStateMachine::play index undefined Feb 11 18:42:38 lounge volumio[1291]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 18:42:38 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:38 lounge volumio[1291]: info: CoreStateMachine::startPlaybackTimer Feb 11 18:42:38 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:38 lounge volumio[1291]: info: ControllerMpd::resume Feb 11 18:42:38 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand play Feb 11 18:42:38 lounge volumio[1291]: info: sendMpdCommand play took 1 milliseconds Feb 11 18:42:40 lounge volumio[1291]: info: TidalConnect service started! Feb 11 18:42:41 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:41 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:41 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 11 18:42:41 lounge volumio[1291]: info: CoreCommandRouter::volumioPlay Feb 11 18:42:41 lounge volumio[1291]: info: CoreStateMachine::play index undefined Feb 11 18:42:41 lounge volumio[1291]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 18:42:41 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:41 lounge volumio[1291]: info: CoreStateMachine::startPlaybackTimer Feb 11 18:42:41 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:41 lounge volumio[1291]: info: ControllerMpd::resume Feb 11 18:42:41 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand play Feb 11 18:42:41 lounge volumio[1291]: info: sendMpdCommand play took 0 milliseconds Feb 11 18:42:43 lounge volumio[1291]: info: CoreCommandRouter::volumioNext Feb 11 18:42:43 lounge volumio[1291]: info: CoreStateMachine::next Feb 11 18:42:43 lounge volumio[1291]: info: CoreStateMachine::stop Feb 11 18:42:43 lounge volumio[1291]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 18:42:43 lounge volumio[1291]: info: CoreStateMachine::updateTrackBlock Feb 11 18:42:43 lounge volumio[1291]: info: CorePlayQueue::getTrackBlock Feb 11 18:42:43 lounge volumio[1291]: info: CoreStateMachine::stPlaybackTimer Feb 11 18:42:43 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:42:43 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:43 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:42:43 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:42:43 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:42:43 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:42:43 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:43 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:43 lounge volumio[1291]: info: CoreStateMachine::serviceStop Feb 11 18:42:43 lounge volumio[1291]: info: CorePlayQueue::getTrack 2 Feb 11 18:42:43 lounge volumio[1291]: info: CoreCommandRouter::serviceStop Feb 11 18:42:43 lounge volumio[1291]: info: ControllerMpd::stop Feb 11 18:42:43 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 18:42:43 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:43.579Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_STOPPED positionMs=0 volume=100 Feb 11 18:42:43 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:43.579Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac" title="Solamente una vez" Feb 11 18:42:43 lounge volumio[1291]: info: sendMpdCommand stop took 4 milliseconds Feb 11 18:42:43 lounge volumio[1291]: info: CoreStateMachine::play index undefined Feb 11 18:42:43 lounge volumio[1291]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 18:42:43 lounge volumio[1291]: info: CorePlayQueue::getTrack 3 Feb 11 18:42:43 lounge volumio[1291]: info: CoreStateMachine::startPlaybackTimer Feb 11 18:42:43 lounge volumio[1291]: info: CorePlayQueue::getTrack 3 Feb 11 18:42:43 lounge volumio[1291]: verbose: ControllerMpd::clearAddPlayTracks USB/Flac_Volumio/Music/Jacques_Brel/1988-Quinze_ans_d_amour/11-Jef.flac Feb 11 18:42:43 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 18:42:43 lounge volumio[1291]: info: CoreStateMachine::updateTrackBlock Feb 11 18:42:43 lounge volumio[1291]: info: CorePlayQueue::getTrackBlock Feb 11 18:42:43 lounge volumio[1291]: info: sendMpdCommand stop took 1 milliseconds Feb 11 18:42:43 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand clear Feb 11 18:42:43 lounge volumio[1291]: info: Feb 11 18:42:43 lounge volumio[1291]: ---------------------------- MPD announces system playlist update Feb 11 18:42:43 lounge volumio[1291]: info: Ignoring MPD Status Update Feb 11 18:42:43 lounge volumio[1291]: info: sendMpdCommand clear took 0 milliseconds Feb 11 18:42:43 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand add "USB/Flac_Volumio/Music/Jacques_Brel/1988-Quinze_ans_d_amour/11-Jef.flac" Feb 11 18:42:43 lounge volumio[1291]: error: updateQueue error: null Feb 11 18:42:43 lounge volumio[1291]: info: ------------------------------ 0ms Feb 11 18:42:43 lounge volumio[1291]: info: Feb 11 18:42:43 lounge volumio[1291]: ---------------------------- MPD announces system playlist update Feb 11 18:42:43 lounge volumio[1291]: info: Ignoring MPD Status Update Feb 11 18:42:43 lounge volumio[1291]: info: sendMpdCommand add "USB/Flac_Volumio/Music/Jacques_Brel/1988-Quinze_ans_d_amour/11-Jef.flac" took 1 milliseconds Feb 11 18:42:43 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand play Feb 11 18:42:43 lounge volumio[1291]: info: ------------------------------ 1ms Feb 11 18:42:43 lounge volumio[1291]: info: sendMpdCommand play took 0 milliseconds Feb 11 18:42:43 lounge volumio[1291]: info: Feb 11 18:42:43 lounge volumio[1291]: ---------------------------- MPD announces state update: player Feb 11 18:42:43 lounge volumio[1291]: info: ControllerMpd::getState Feb 11 18:42:43 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Feb 11 18:42:43 lounge volumio[1291]: info: Feb 11 18:42:43 lounge volumio[1291]: ---------------------------- MPD announces state update: player Feb 11 18:42:43 lounge volumio[1291]: info: sendMpdCommand status took 17 milliseconds Feb 11 18:42:43 lounge volumio[1291]: info: ControllerMpd::getState Feb 11 18:42:43 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Feb 11 18:42:43 lounge volumio[1291]: verbose: ControllerMpd::parseState Feb 11 18:42:43 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 18:42:43 lounge volumio[1291]: info: sendMpdCommand status took 2 milliseconds Feb 11 18:42:43 lounge volumio[1291]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 11 18:42:43 lounge volumio[1291]: verbose: ControllerMpd::parseState Feb 11 18:42:43 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 18:42:43 lounge volumio[1291]: verbose: ControllerMpd::parseTrackInfo Feb 11 18:42:43 lounge volumio[1291]: info: ControllerMpd::pushState Feb 11 18:42:43 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:42:43 lounge volumio[1291]: info: CorePlayQueue::getTrack 3 Feb 11 18:42:43 lounge volumio[1291]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":218,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"582 Kbps","isStreaming":false,"title":"Jef","artist":"Jacques Brel","album":"Quinze ans d’amour","uri":"USB/Flac_Volumio/Music/Jacques_Brel/1988-Quinze_ans_d_amour/11-Jef.flac","trackType":"flac"} Feb 11 18:42:43 lounge volumio[1291]: verbose: CURRENT POSITION 3 Feb 11 18:42:43 lounge volumio[1291]: info: CoreStateMachine::syncState stateService play Feb 11 18:42:43 lounge volumio[1291]: info: CoreStateMachine::syncState currentStatus stop Feb 11 18:42:43 lounge volumio[1291]: info: ------------------------------ 20ms Feb 11 18:42:43 lounge volumio[1291]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 11 18:42:43 lounge volumio[1291]: verbose: ControllerMpd::parseTrackInfo Feb 11 18:42:43 lounge volumio[1291]: info: ControllerMpd::pushState Feb 11 18:42:43 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:42:43 lounge volumio[1291]: info: CorePlayQueue::getTrack 3 Feb 11 18:42:43 lounge volumio[1291]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1209,"duration":218,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"608 Kbps","isStreaming":false,"title":"Jef","artist":"Jacques Brel","album":"Quinze ans d’amour","uri":"USB/Flac_Volumio/Music/Jacques_Brel/1988-Quinze_ans_d_amour/11-Jef.flac","trackType":"flac"} Feb 11 18:42:43 lounge volumio[1291]: verbose: CURRENT POSITION 3 Feb 11 18:42:43 lounge volumio[1291]: info: CoreStateMachine::syncState stateService play Feb 11 18:42:43 lounge volumio[1291]: info: CoreStateMachine::syncState currentStatus play Feb 11 18:42:43 lounge volumio[1291]: info: Received an update from plugin. extracting info from payload Feb 11 18:42:43 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:42:43 lounge volumio[1291]: info: CorePlayQueue::getTrack 3 Feb 11 18:42:43 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:42:43 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:42:43 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:42:43 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:42:43 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:43 lounge volumio[1291]: info: CorePlayQueue::getTrack 3 Feb 11 18:42:43 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:42:43 lounge volumio[1291]: info: CorePlayQueue::getTrack 3 Feb 11 18:42:43 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:42:43 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:42:43 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:42:43 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:42:43 lounge volumio[1291]: info: CorePlayQueue::getTrack 3 Feb 11 18:42:43 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:43.613Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_PLAYING positionMs=1209 volume=100 Feb 11 18:42:43 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:43.613Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id=mnt/USB/Flac_Volumio/Music/Jacques_Brel/1988-Quinze_ans_d_amour/11-Jef.flac title=Jef Feb 11 18:42:43 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:43.613Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_PLAYING positionMs=1209 volume=100 Feb 11 18:42:43 lounge volumio5-onboarding[1869]: time=2026-02-11T17:42:43.613Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id=mnt/USB/Flac_Volumio/Music/Jacques_Brel/1988-Quinze_ans_d_amour/11-Jef.flac title=Jef Feb 11 18:42:43 lounge volumio[1291]: info: ------------------------------ 8ms Feb 11 18:42:55 lounge volumio[1291]: info: CoreCommandRouter::volumioGetQueue Feb 11 18:42:55 lounge volumio[1291]: info: CoreStateMachine::getQueue Feb 11 18:42:55 lounge volumio[1291]: info: CorePlayQueue::getQueue Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::volumioNext Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::next Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::stop Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::stPlaybackTimer Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::updateTrackBlock Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrackBlock Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrack 3 Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:43:01 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:43:01 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrack 3 Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::serviceStop Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrack 3 Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::serviceStop Feb 11 18:43:01 lounge volumio[1291]: info: ControllerMpd::stop Feb 11 18:43:01 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 18:43:01 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:01.784Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_STOPPED positionMs=0 volume=100 Feb 11 18:43:01 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:01.784Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id=mnt/USB/Flac_Volumio/Music/Jacques_Brel/1988-Quinze_ans_d_amour/11-Jef.flac title=Jef Feb 11 18:43:01 lounge volumio[1291]: info: Feb 11 18:43:01 lounge volumio[1291]: ---------------------------- MPD announces state update: player Feb 11 18:43:01 lounge volumio[1291]: info: sendMpdCommand stop took 4 milliseconds Feb 11 18:43:01 lounge volumio[1291]: info: ControllerMpd::getState Feb 11 18:43:01 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::play index undefined Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrack 4 Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::startPlaybackTimer Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrack 4 Feb 11 18:43:01 lounge volumio[1291]: verbose: ControllerMpd::clearAddPlayTracks USB/Flac_Volumio/Music/Patricia_Kaas/2016-Patricia_Kaas/Disc_1/03-Madame_Tout_Le_Monde.flac Feb 11 18:43:01 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::updateTrackBlock Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrackBlock Feb 11 18:43:01 lounge volumio[1291]: info: sendMpdCommand status took 1 milliseconds Feb 11 18:43:01 lounge volumio[1291]: info: sendMpdCommand stop took 1 milliseconds Feb 11 18:43:01 lounge volumio[1291]: verbose: ControllerMpd::parseState Feb 11 18:43:01 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 18:43:01 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand clear Feb 11 18:43:01 lounge volumio[1291]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 11 18:43:01 lounge volumio[1291]: verbose: ControllerMpd::parseTrackInfo Feb 11 18:43:01 lounge volumio[1291]: info: ControllerMpd::pushState Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrack 4 Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:43:01 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:43:01 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrack 4 Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrack 4 Feb 11 18:43:01 lounge volumio[1291]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Jef","artist":"Jacques Brel","album":"Quinze ans d’amour","uri":"USB/Flac_Volumio/Music/Jacques_Brel/1988-Quinze_ans_d_amour/11-Jef.flac","trackType":"flac"} Feb 11 18:43:01 lounge volumio[1291]: verbose: CURRENT POSITION 4 Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::syncState stateService stop Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::syncState currentStatus stop Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrack 4 Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:43:01 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:43:01 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrack 4 Feb 11 18:43:01 lounge volumio[1291]: info: No code Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrack 4 Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:43:01 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:43:01 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrack 4 Feb 11 18:43:01 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:01.792Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_STOPPED positionMs=0 volume=100 Feb 11 18:43:01 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:01.792Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id=mnt/USB/Flac_Volumio/Music/Patricia_Kaas/2016-Patricia_Kaas/Disc_1/03-Madame_Tout_Le_Monde.flac title="Madame Tout Le Monde" Feb 11 18:43:01 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:01.793Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_STOPPED positionMs=0 volume=100 Feb 11 18:43:01 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:01.793Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_STOPPED positionMs=0 volume=100 Feb 11 18:43:01 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:01.793Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id=mnt/USB/Flac_Volumio/Music/Patricia_Kaas/2016-Patricia_Kaas/Disc_1/03-Madame_Tout_Le_Monde.flac title="Madame Tout Le Monde" Feb 11 18:43:01 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:01.793Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id=mnt/USB/Flac_Volumio/Music/Patricia_Kaas/2016-Patricia_Kaas/Disc_1/03-Madame_Tout_Le_Monde.flac title="Madame Tout Le Monde" Feb 11 18:43:01 lounge volumio[1291]: info: ------------------------------ 9ms Feb 11 18:43:01 lounge volumio[1291]: info: Feb 11 18:43:01 lounge volumio[1291]: ---------------------------- MPD announces system playlist update Feb 11 18:43:01 lounge volumio[1291]: info: Ignoring MPD Status Update Feb 11 18:43:01 lounge volumio[1291]: info: sendMpdCommand clear took 7 milliseconds Feb 11 18:43:01 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand add "USB/Flac_Volumio/Music/Patricia_Kaas/2016-Patricia_Kaas/Disc_1/03-Madame_Tout_Le_Monde.flac" Feb 11 18:43:01 lounge volumio[1291]: error: updateQueue error: null Feb 11 18:43:01 lounge volumio[1291]: info: Feb 11 18:43:01 lounge volumio[1291]: ---------------------------- MPD announces system playlist update Feb 11 18:43:01 lounge volumio[1291]: info: Ignoring MPD Status Update Feb 11 18:43:01 lounge volumio[1291]: info: ------------------------------ 5ms Feb 11 18:43:01 lounge volumio[1291]: info: sendMpdCommand add "USB/Flac_Volumio/Music/Patricia_Kaas/2016-Patricia_Kaas/Disc_1/03-Madame_Tout_Le_Monde.flac" took 5 milliseconds Feb 11 18:43:01 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand play Feb 11 18:43:01 lounge volumio[1291]: info: ------------------------------ 0ms Feb 11 18:43:01 lounge volumio[1291]: info: sendMpdCommand play took 1 milliseconds Feb 11 18:43:01 lounge volumio[1291]: info: Feb 11 18:43:01 lounge volumio[1291]: ---------------------------- MPD announces state update: player Feb 11 18:43:01 lounge volumio[1291]: info: ControllerMpd::getState Feb 11 18:43:01 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Feb 11 18:43:01 lounge volumio[1291]: info: Feb 11 18:43:01 lounge volumio[1291]: ---------------------------- MPD announces state update: player Feb 11 18:43:01 lounge volumio[1291]: info: sendMpdCommand status took 2 milliseconds Feb 11 18:43:01 lounge volumio[1291]: info: ControllerMpd::getState Feb 11 18:43:01 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Feb 11 18:43:01 lounge volumio[1291]: verbose: ControllerMpd::parseState Feb 11 18:43:01 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 18:43:01 lounge volumio[1291]: info: sendMpdCommand status took 2 milliseconds Feb 11 18:43:01 lounge volumio[1291]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 11 18:43:01 lounge volumio[1291]: verbose: ControllerMpd::parseState Feb 11 18:43:01 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 18:43:01 lounge volumio[1291]: verbose: ControllerMpd::parseTrackInfo Feb 11 18:43:01 lounge volumio[1291]: info: ControllerMpd::pushState Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrack 4 Feb 11 18:43:01 lounge volumio[1291]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":168,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"761 Kbps","isStreaming":false,"title":"Madame Tout Le Monde","artist":"Patricia Kaas","album":"Patricia Kaas","uri":"USB/Flac_Volumio/Music/Patricia_Kaas/2016-Patricia_Kaas/Disc_1/03-Madame_Tout_Le_Monde.flac","trackType":"flac"} Feb 11 18:43:01 lounge volumio[1291]: verbose: CURRENT POSITION 4 Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::syncState stateService play Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::syncState currentStatus stop Feb 11 18:43:01 lounge volumio[1291]: info: ------------------------------ 4ms Feb 11 18:43:01 lounge volumio[1291]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 11 18:43:01 lounge volumio[1291]: verbose: ControllerMpd::parseTrackInfo Feb 11 18:43:01 lounge volumio[1291]: info: ControllerMpd::pushState Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrack 4 Feb 11 18:43:01 lounge volumio[1291]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1140,"duration":168,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"768 Kbps","isStreaming":false,"title":"Madame Tout Le Monde","artist":"Patricia Kaas","album":"Patricia Kaas","uri":"USB/Flac_Volumio/Music/Patricia_Kaas/2016-Patricia_Kaas/Disc_1/03-Madame_Tout_Le_Monde.flac","trackType":"flac"} Feb 11 18:43:01 lounge volumio[1291]: verbose: CURRENT POSITION 4 Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::syncState stateService play Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::syncState currentStatus play Feb 11 18:43:01 lounge volumio[1291]: info: Received an update from plugin. extracting info from payload Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrack 4 Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:43:01 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:43:01 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrack 4 Feb 11 18:43:01 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrack 4 Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:43:01 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:43:01 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:43:01 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:43:01 lounge volumio[1291]: info: CorePlayQueue::getTrack 4 Feb 11 18:43:01 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:01.812Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_PLAYING positionMs=1140 volume=100 Feb 11 18:43:01 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:01.812Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_PLAYING positionMs=1140 volume=100 Feb 11 18:43:01 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:01.812Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id=mnt/USB/Flac_Volumio/Music/Patricia_Kaas/2016-Patricia_Kaas/Disc_1/03-Madame_Tout_Le_Monde.flac title="Madame Tout Le Monde" Feb 11 18:43:01 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:01.812Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id=mnt/USB/Flac_Volumio/Music/Patricia_Kaas/2016-Patricia_Kaas/Disc_1/03-Madame_Tout_Le_Monde.flac title="Madame Tout Le Monde" Feb 11 18:43:01 lounge volumio[1291]: info: ------------------------------ 7ms Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::volumioNext Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::next Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::stop Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::stPlaybackTimer Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::updateTrackBlock Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrackBlock Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 4 Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:43:03 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:43:03 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 4 Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::serviceStop Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 4 Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::serviceStop Feb 11 18:43:03 lounge volumio[1291]: info: ControllerMpd::stop Feb 11 18:43:03 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 18:43:03 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:03.238Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_STOPPED positionMs=0 volume=100 Feb 11 18:43:03 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:03.238Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id=mnt/USB/Flac_Volumio/Music/Patricia_Kaas/2016-Patricia_Kaas/Disc_1/03-Madame_Tout_Le_Monde.flac title="Madame Tout Le Monde" Feb 11 18:43:03 lounge volumio[1291]: info: Feb 11 18:43:03 lounge volumio[1291]: ---------------------------- MPD announces state update: player Feb 11 18:43:03 lounge volumio[1291]: info: sendMpdCommand stop took 3 milliseconds Feb 11 18:43:03 lounge volumio[1291]: info: ControllerMpd::getState Feb 11 18:43:03 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::play index undefined Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 5 Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::startPlaybackTimer Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 5 Feb 11 18:43:03 lounge volumio[1291]: verbose: ControllerMpd::clearAddPlayTracks USB/Flac_Volumio/Classic/Jean-Jacques Milteau/Pacific Blue/06 At Last On Time.flac Feb 11 18:43:03 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::updateTrackBlock Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrackBlock Feb 11 18:43:03 lounge volumio[1291]: info: sendMpdCommand status took 1 milliseconds Feb 11 18:43:03 lounge volumio[1291]: info: sendMpdCommand stop took 0 milliseconds Feb 11 18:43:03 lounge volumio[1291]: verbose: ControllerMpd::parseState Feb 11 18:43:03 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 18:43:03 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand clear Feb 11 18:43:03 lounge volumio[1291]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 11 18:43:03 lounge volumio[1291]: verbose: ControllerMpd::parseTrackInfo Feb 11 18:43:03 lounge volumio[1291]: info: ControllerMpd::pushState Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 5 Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:43:03 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:43:03 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 5 Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 5 Feb 11 18:43:03 lounge volumio[1291]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Madame Tout Le Monde","artist":"Patricia Kaas","album":"Patricia Kaas","uri":"USB/Flac_Volumio/Music/Patricia_Kaas/2016-Patricia_Kaas/Disc_1/03-Madame_Tout_Le_Monde.flac","trackType":"flac"} Feb 11 18:43:03 lounge volumio[1291]: verbose: CURRENT POSITION 5 Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::syncState stateService stop Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::syncState currentStatus stop Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 5 Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:43:03 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:43:03 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 5 Feb 11 18:43:03 lounge volumio[1291]: info: No code Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 5 Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:43:03 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:43:03 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 5 Feb 11 18:43:03 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:03.246Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_STOPPED positionMs=0 volume=100 Feb 11 18:43:03 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:03.246Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_STOPPED positionMs=0 volume=100 Feb 11 18:43:03 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:03.246Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_STOPPED positionMs=0 volume=100 Feb 11 18:43:03 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:03.246Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Classic/Jean-Jacques Milteau/Pacific Blue/06 At Last On Time.flac" title="At Last On Time" Feb 11 18:43:03 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:03.247Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Classic/Jean-Jacques Milteau/Pacific Blue/06 At Last On Time.flac" title="At Last On Time" Feb 11 18:43:03 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:03.247Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Classic/Jean-Jacques Milteau/Pacific Blue/06 At Last On Time.flac" title="At Last On Time" Feb 11 18:43:03 lounge volumio[1291]: info: ------------------------------ 7ms Feb 11 18:43:03 lounge volumio[1291]: info: Feb 11 18:43:03 lounge volumio[1291]: ---------------------------- MPD announces system playlist update Feb 11 18:43:03 lounge volumio[1291]: info: Ignoring MPD Status Update Feb 11 18:43:03 lounge volumio[1291]: info: sendMpdCommand clear took 7 milliseconds Feb 11 18:43:03 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand add "USB/Flac_Volumio/Classic/Jean-Jacques Milteau/Pacific Blue/06 At Last On Time.flac" Feb 11 18:43:03 lounge volumio[1291]: error: updateQueue error: null Feb 11 18:43:03 lounge volumio[1291]: info: Feb 11 18:43:03 lounge volumio[1291]: ---------------------------- MPD announces system playlist update Feb 11 18:43:03 lounge volumio[1291]: info: Ignoring MPD Status Update Feb 11 18:43:03 lounge volumio[1291]: info: ------------------------------ 6ms Feb 11 18:43:03 lounge volumio[1291]: info: sendMpdCommand add "USB/Flac_Volumio/Classic/Jean-Jacques Milteau/Pacific Blue/06 At Last On Time.flac" took 6 milliseconds Feb 11 18:43:03 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand play Feb 11 18:43:03 lounge volumio[1291]: info: ------------------------------ 0ms Feb 11 18:43:03 lounge volumio[1291]: info: sendMpdCommand play took 0 milliseconds Feb 11 18:43:03 lounge volumio[1291]: info: Feb 11 18:43:03 lounge volumio[1291]: ---------------------------- MPD announces state update: player Feb 11 18:43:03 lounge volumio[1291]: info: ControllerMpd::getState Feb 11 18:43:03 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Feb 11 18:43:03 lounge volumio[1291]: info: Feb 11 18:43:03 lounge volumio[1291]: ---------------------------- MPD announces state update: player Feb 11 18:43:03 lounge volumio[1291]: info: sendMpdCommand status took 1 milliseconds Feb 11 18:43:03 lounge volumio[1291]: info: ControllerMpd::getState Feb 11 18:43:03 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Feb 11 18:43:03 lounge volumio[1291]: verbose: ControllerMpd::parseState Feb 11 18:43:03 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 18:43:03 lounge volumio[1291]: info: sendMpdCommand status took 1 milliseconds Feb 11 18:43:03 lounge volumio[1291]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 11 18:43:03 lounge volumio[1291]: verbose: ControllerMpd::parseState Feb 11 18:43:03 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 18:43:03 lounge volumio[1291]: verbose: ControllerMpd::parseTrackInfo Feb 11 18:43:03 lounge volumio[1291]: info: ControllerMpd::pushState Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 5 Feb 11 18:43:03 lounge volumio[1291]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":348,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"At Last On Time","artist":"Jean-Jacques Milteau","album":"Pacific Blue","uri":"USB/Flac_Volumio/Classic/Jean-Jacques Milteau/Pacific Blue/06 At Last On Time.flac","trackType":"flac"} Feb 11 18:43:03 lounge volumio[1291]: verbose: CURRENT POSITION 5 Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::syncState stateService play Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::syncState currentStatus stop Feb 11 18:43:03 lounge volumio[1291]: info: ------------------------------ 2ms Feb 11 18:43:03 lounge volumio[1291]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 11 18:43:03 lounge volumio[1291]: verbose: ControllerMpd::parseTrackInfo Feb 11 18:43:03 lounge volumio[1291]: info: ControllerMpd::pushState Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 5 Feb 11 18:43:03 lounge volumio[1291]: verbose: STATE SERVICE {"status":"play","position":0,"seek":296,"duration":348,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"558 Kbps","isStreaming":false,"title":"At Last On Time","artist":"Jean-Jacques Milteau","album":"Pacific Blue","uri":"USB/Flac_Volumio/Classic/Jean-Jacques Milteau/Pacific Blue/06 At Last On Time.flac","trackType":"flac"} Feb 11 18:43:03 lounge volumio[1291]: verbose: CURRENT POSITION 5 Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::syncState stateService play Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::syncState currentStatus play Feb 11 18:43:03 lounge volumio[1291]: info: Received an update from plugin. extracting info from payload Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 5 Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:43:03 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:43:03 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 5 Feb 11 18:43:03 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 5 Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:43:03 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:43:03 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:43:03 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:43:03 lounge volumio[1291]: info: CorePlayQueue::getTrack 5 Feb 11 18:43:03 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:03.267Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_PLAYING positionMs=296 volume=100 Feb 11 18:43:03 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:03.268Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_PLAYING positionMs=296 volume=100 Feb 11 18:43:03 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:03.268Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Classic/Jean-Jacques Milteau/Pacific Blue/06 At Last On Time.flac" title="At Last On Time" Feb 11 18:43:03 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:03.268Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Classic/Jean-Jacques Milteau/Pacific Blue/06 At Last On Time.flac" title="At Last On Time" Feb 11 18:43:03 lounge volumio[1291]: info: ------------------------------ 6ms Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::volumioNext Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::next Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::stop Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::stPlaybackTimer Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::updateTrackBlock Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrackBlock Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrack 5 Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:43:09 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:43:09 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrack 5 Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::serviceStop Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrack 5 Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::serviceStop Feb 11 18:43:09 lounge volumio[1291]: info: ControllerMpd::stop Feb 11 18:43:09 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 18:43:09 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:09.370Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_STOPPED positionMs=0 volume=100 Feb 11 18:43:09 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:09.370Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Classic/Jean-Jacques Milteau/Pacific Blue/06 At Last On Time.flac" title="At Last On Time" Feb 11 18:43:09 lounge volumio[1291]: info: Feb 11 18:43:09 lounge volumio[1291]: ---------------------------- MPD announces state update: player Feb 11 18:43:09 lounge volumio[1291]: info: sendMpdCommand stop took 3 milliseconds Feb 11 18:43:09 lounge volumio[1291]: info: ControllerMpd::getState Feb 11 18:43:09 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::play index undefined Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrack 6 Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::startPlaybackTimer Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrack 6 Feb 11 18:43:09 lounge volumio[1291]: verbose: ControllerMpd::clearAddPlayTracks USB/Flac_Volumio/Music/Best Audiophiles/the-best-jazz-audiophile-recommended-collection-vol.1-5/06. Besame Mucho.flac Feb 11 18:43:09 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::updateTrackBlock Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrackBlock Feb 11 18:43:09 lounge volumio[1291]: info: sendMpdCommand status took 1 milliseconds Feb 11 18:43:09 lounge volumio[1291]: info: sendMpdCommand stop took 0 milliseconds Feb 11 18:43:09 lounge volumio[1291]: verbose: ControllerMpd::parseState Feb 11 18:43:09 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 18:43:09 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand clear Feb 11 18:43:09 lounge volumio[1291]: info: Feb 11 18:43:09 lounge volumio[1291]: ---------------------------- MPD announces system playlist update Feb 11 18:43:09 lounge volumio[1291]: info: Ignoring MPD Status Update Feb 11 18:43:09 lounge volumio[1291]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 11 18:43:09 lounge volumio[1291]: info: sendMpdCommand clear took 0 milliseconds Feb 11 18:43:09 lounge volumio[1291]: verbose: ControllerMpd::parseTrackInfo Feb 11 18:43:09 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand add "USB/Flac_Volumio/Music/Best Audiophiles/the-best-jazz-audiophile-recommended-collection-vol.1-5/06. Besame Mucho.flac" Feb 11 18:43:09 lounge volumio[1291]: info: ControllerMpd::pushState Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrack 6 Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:43:09 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:43:09 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrack 6 Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrack 6 Feb 11 18:43:09 lounge volumio[1291]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"At Last On Time","artist":"Jean-Jacques Milteau","album":"Pacific Blue","uri":"USB/Flac_Volumio/Classic/Jean-Jacques Milteau/Pacific Blue/06 At Last On Time.flac","trackType":"flac"} Feb 11 18:43:09 lounge volumio[1291]: verbose: CURRENT POSITION 6 Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::syncState stateService stop Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::syncState currentStatus stop Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrack 6 Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:43:09 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:43:09 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrack 6 Feb 11 18:43:09 lounge volumio[1291]: info: No code Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrack 6 Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:43:09 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:43:09 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrack 6 Feb 11 18:43:09 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:09.378Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_STOPPED positionMs=0 volume=100 Feb 11 18:43:09 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:09.378Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Music/Best Audiophiles/the-best-jazz-audiophile-recommended-collection-vol.1-5/06. Besame Mucho.flac" title="Besame Mucho" Feb 11 18:43:09 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:09.379Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_STOPPED positionMs=0 volume=100 Feb 11 18:43:09 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:09.379Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Music/Best Audiophiles/the-best-jazz-audiophile-recommended-collection-vol.1-5/06. Besame Mucho.flac" title="Besame Mucho" Feb 11 18:43:09 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:09.379Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_STOPPED positionMs=0 volume=100 Feb 11 18:43:09 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:09.379Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Music/Best Audiophiles/the-best-jazz-audiophile-recommended-collection-vol.1-5/06. Besame Mucho.flac" title="Besame Mucho" Feb 11 18:43:09 lounge volumio[1291]: info: ------------------------------ 7ms Feb 11 18:43:09 lounge volumio[1291]: error: updateQueue error: null Feb 11 18:43:09 lounge volumio[1291]: info: Feb 11 18:43:09 lounge volumio[1291]: ---------------------------- MPD announces system playlist update Feb 11 18:43:09 lounge volumio[1291]: info: Ignoring MPD Status Update Feb 11 18:43:09 lounge volumio[1291]: info: ------------------------------ 6ms Feb 11 18:43:09 lounge volumio[1291]: info: sendMpdCommand add "USB/Flac_Volumio/Music/Best Audiophiles/the-best-jazz-audiophile-recommended-collection-vol.1-5/06. Besame Mucho.flac" took 6 milliseconds Feb 11 18:43:09 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand play Feb 11 18:43:09 lounge volumio[1291]: info: Feb 11 18:43:09 lounge volumio[1291]: ---------------------------- MPD announces state update: player Feb 11 18:43:09 lounge volumio[1291]: info: ------------------------------ 6ms Feb 11 18:43:09 lounge volumio[1291]: info: sendMpdCommand play took 6 milliseconds Feb 11 18:43:09 lounge volumio[1291]: info: ControllerMpd::getState Feb 11 18:43:09 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Feb 11 18:43:09 lounge volumio[1291]: info: Feb 11 18:43:09 lounge volumio[1291]: ---------------------------- MPD announces state update: player Feb 11 18:43:09 lounge volumio[1291]: info: ControllerMpd::getState Feb 11 18:43:09 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Feb 11 18:43:09 lounge volumio[1291]: info: sendMpdCommand status took 0 milliseconds Feb 11 18:43:09 lounge volumio[1291]: verbose: ControllerMpd::parseState Feb 11 18:43:09 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 18:43:09 lounge volumio[1291]: info: sendMpdCommand status took 0 milliseconds Feb 11 18:43:09 lounge volumio[1291]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 11 18:43:09 lounge volumio[1291]: verbose: ControllerMpd::parseState Feb 11 18:43:09 lounge volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 18:43:09 lounge volumio[1291]: verbose: ControllerMpd::parseTrackInfo Feb 11 18:43:09 lounge volumio[1291]: info: ControllerMpd::pushState Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrack 6 Feb 11 18:43:09 lounge volumio[1291]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1186,"duration":334,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"497 Kbps","isStreaming":false,"title":"Besame Mucho","artist":"Eline Gemert","album":"The Best Jazz Audiophile Recommended Vol. 01","uri":"USB/Flac_Volumio/Music/Best Audiophiles/the-best-jazz-audiophile-recommended-collection-vol.1-5/06. Besame Mucho.flac","trackType":"flac"} Feb 11 18:43:09 lounge volumio[1291]: verbose: CURRENT POSITION 6 Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::syncState stateService play Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::syncState currentStatus stop Feb 11 18:43:09 lounge volumio[1291]: info: ------------------------------ 2ms Feb 11 18:43:09 lounge volumio[1291]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 11 18:43:09 lounge volumio[1291]: verbose: ControllerMpd::parseTrackInfo Feb 11 18:43:09 lounge volumio[1291]: info: ControllerMpd::pushState Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::servicePushState Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrack 6 Feb 11 18:43:09 lounge volumio[1291]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1186,"duration":334,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"576 Kbps","isStreaming":false,"title":"Besame Mucho","artist":"Eline Gemert","album":"The Best Jazz Audiophile Recommended Vol. 01","uri":"USB/Flac_Volumio/Music/Best Audiophiles/the-best-jazz-audiophile-recommended-collection-vol.1-5/06. Besame Mucho.flac","trackType":"flac"} Feb 11 18:43:09 lounge volumio[1291]: verbose: CURRENT POSITION 6 Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::syncState stateService play Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::syncState currentStatus play Feb 11 18:43:09 lounge volumio[1291]: info: Received an update from plugin. extracting info from payload Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrack 6 Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:43:09 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:43:09 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrack 6 Feb 11 18:43:09 lounge volumio[1291]: info: CoreStateMachine::pushState Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrack 6 Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::volumioPushState Feb 11 18:43:09 lounge volumio[1291]: info: MRS: Pushing multiroomSync output update for this device Feb 11 18:43:09 lounge volumio[1291]: info: MRS: Pushing multiroomSync output Feb 11 18:43:09 lounge volumio[1291]: info: CoreCommandRouter::volumioGetState Feb 11 18:43:09 lounge volumio[1291]: info: CorePlayQueue::getTrack 6 Feb 11 18:43:09 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:09.390Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_PLAYING positionMs=1186 volume=100 Feb 11 18:43:09 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:09.390Z level=INFO msg="emitting player state changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" state=STATUS_PLAYING positionMs=1186 volume=100 Feb 11 18:43:09 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:09.391Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Music/Best Audiophiles/the-best-jazz-audiophile-recommended-collection-vol.1-5/06. Besame Mucho.flac" title="Besame Mucho" Feb 11 18:43:09 lounge volumio5-onboarding[1869]: time=2026-02-11T17:43:09.390Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.129.42:37856 @ 0xc00034a120" id="mnt/USB/Flac_Volumio/Music/Best Audiophiles/the-best-jazz-audiophile-recommended-collection-vol.1-5/06. Besame Mucho.flac" title="Besame Mucho" Feb 11 18:43:09 lounge volumio[1291]: info: ------------------------------ 5ms Feb 11 18:43:39 lounge volumio[1291]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri Feb 11 18:43:39 lounge volumio[1291]: info: Preload queue cleared Feb 11 18:43:39 lounge volumio[1291]: info: Preloading song: mnt/USB/Flac_Volumio/Music/Best Audiophiles/the-best-jazz-audiophile-recommended-collection-vol.1-5/06. Besame Mucho.flac Feb 11 18:43:39 lounge volumio[1291]: info: Preloading song: mnt/USB/Flac_Volumio/Classic/Jean-Jacques Milteau/Pacific Blue/06 At Last On Time.flac Feb 11 18:43:39 lounge volumio[1291]: info: Preloading song: mnt/USB/Flac_Volumio/Music/Patricia_Kaas/2016-Patricia_Kaas/Disc_1/03-Madame_Tout_Le_Monde.flac Feb 11 18:43:39 lounge volumio[1291]: info: Preloading song: mnt/USB/Flac_Volumio/Music/Jacques_Brel/1988-Quinze_ans_d_amour/11-Jef.flac Feb 11 18:43:39 lounge volumio[1291]: info: Preloading song: mnt/USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac Feb 11 18:43:39 lounge volumio[1291]: info: Preloading song: mnt/USB/Flac_Volumio/Music/Chris_Isaak/1989-Heart_Shaped_World/10-In_the_Heat_of_the_Jungle.flac Feb 11 18:43:39 lounge volumio[1291]: info: Preloading song: mnt/USB/Flac_Volumio/Music/June & Lula/2010-Sixteen Times/03-Feeling You're Falling.flac Feb 11 18:43:39 lounge volumio[1291]: info: Preloading song: https://stream.radioparadise.com/mellow-flacm Feb 11 18:43:39 lounge volumio[1291]: info: Preloading song: mnt/USB/Flac_Volumio/Music/Alain_Bashung/2010-Osez/Disc_1-Les_Classiques/01-La_nuit_je_mens.flac Feb 11 18:43:39 lounge volumio[1291]: info: Preloading song: mnt/USB/Flac_Volumio/Music/Alain_Bashung/2010-Osez/Disc_1-Les_Classiques/12-Osez_Josephine.flac Feb 11 18:43:39 lounge volumio[1291]: info: Exploding uri mnt/USB/Flac_Volumio/Music/Best Audiophiles/the-best-jazz-audiophile-recommended-collection-vol.1-5/06. Besame Mucho.flac in service mpd Feb 11 18:43:39 lounge volumio[1291]: info: ALBUMART /albumart?cacheid=382&web=Eline%20Gemert/The%20Best%20Jazz%20Audiophile%20Recommended%20Vol.%2001/extralarge&path=%2Fmnt%2FUSB%2FFlac_Volumio%2FMusic%2FBest%20Audiophiles%2Fthe-best-jazz-audiophile-recommended-collection-vol.1-5%2F06.%20Besame%20Mucho.flac&metadata=false Feb 11 18:43:39 lounge volumio[1291]: info: URI /mnt/USB/Flac_Volumio/Music/Best Audiophiles/the-best-jazz-audiophile-recommended-collection-vol.1-5/06. Besame Mucho.flac Feb 11 18:43:39 lounge volumio[1291]: info: Exploding uri mnt/USB/Flac_Volumio/Classic/Jean-Jacques Milteau/Pacific Blue/06 At Last On Time.flac in service mpd Feb 11 18:43:39 lounge volumio[1291]: info: ALBUMART /albumart?cacheid=382&web=Jean-Jacques%20Milteau/Pacific%20Blue/extralarge&path=%2Fmnt%2FUSB%2FFlac_Volumio%2FClassic%2FJean-Jacques%20Milteau%2FPacific%20Blue%2F06%20At%20Last%20On%20Time.flac&metadata=false Feb 11 18:43:39 lounge volumio[1291]: info: URI /mnt/USB/Flac_Volumio/Classic/Jean-Jacques Milteau/Pacific Blue/06 At Last On Time.flac Feb 11 18:43:39 lounge volumio[1291]: info: Exploding uri mnt/USB/Flac_Volumio/Music/Patricia_Kaas/2016-Patricia_Kaas/Disc_1/03-Madame_Tout_Le_Monde.flac in service mpd Feb 11 18:43:39 lounge volumio[1291]: info: ALBUMART /albumart?cacheid=382&web=Patricia%20Kaas/Patricia%20Kaas/extralarge&path=%2Fmnt%2FUSB%2FFlac_Volumio%2FMusic%2FPatricia_Kaas%2F2016-Patricia_Kaas%2FDisc_1%2F03-Madame_Tout_Le_Monde.flac&metadata=false Feb 11 18:43:39 lounge volumio[1291]: info: URI /mnt/USB/Flac_Volumio/Music/Patricia_Kaas/2016-Patricia_Kaas/Disc_1/03-Madame_Tout_Le_Monde.flac Feb 11 18:43:39 lounge volumio[1291]: info: Exploding uri mnt/USB/Flac_Volumio/Music/Jacques_Brel/1988-Quinze_ans_d_amour/11-Jef.flac in service mpd Feb 11 18:43:39 lounge volumio[1291]: info: ALBUMART /albumart?cacheid=382&web=Jacques%20Brel/Quinze%20ans%20d%E2%80%99amour/extralarge&path=%2Fmnt%2FUSB%2FFlac_Volumio%2FMusic%2FJacques_Brel%2F1988-Quinze_ans_d_amour%2F11-Jef.flac&metadata=false Feb 11 18:43:39 lounge volumio[1291]: info: URI /mnt/USB/Flac_Volumio/Music/Jacques_Brel/1988-Quinze_ans_d_amour/11-Jef.flac Feb 11 18:43:39 lounge volumio[1291]: info: Exploding uri mnt/USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac in service mpd Feb 11 18:43:39 lounge volumio[1291]: info: ALBUMART /albumart?cacheid=382&web=The%203%20Tenors/The%203%20Tenors%20in%20Paris%201998/extralarge&path=%2Fmnt%2FUSB%2FFlac_Volumio%2FClassic%2FThe%203%20Tenors%20-%20The%203%20Tenors%20in%20Paris%201998%2F08%20-%20The%203%20Tenors%20-%20Solamente%20una%20vez.flac&metadata=false Feb 11 18:43:39 lounge volumio[1291]: info: URI /mnt/USB/Flac_Volumio/Classic/The 3 Tenors - The 3 Tenors in Paris 1998/08 - The 3 Tenors - Solamente una vez.flac Feb 11 18:43:39 lounge volumio[1291]: info: Exploding uri mnt/USB/Flac_Volumio/Music/Chris_Isaak/1989-Heart_Shaped_World/10-In_the_Heat_of_the_Jungle.flac in service mpd Feb 11 18:43:39 lounge volumio[1291]: info: ALBUMART /albumart?cacheid=382&web=Chris%20Isaak/Heart%20Shaped%20World/extralarge&path=%2Fmnt%2FUSB%2FFlac_Volumio%2FMusic%2FChris_Isaak%2F1989-Heart_Shaped_World%2F10-In_the_Heat_of_the_Jungle.flac&metadata=false Feb 11 18:43:39 lounge volumio[1291]: info: URI /mnt/USB/Flac_Volumio/Music/Chris_Isaak/1989-Heart_Shaped_World/10-In_the_Heat_of_the_Jungle.flac Feb 11 18:43:39 lounge volumio[1291]: info: Exploding uri mnt/USB/Flac_Volumio/Music/June & Lula/2010-Sixteen Times/03-Feeling You're Falling.flac in service mpd Feb 11 18:43:39 lounge volumio[1291]: info: ALBUMART /albumart?cacheid=382&web=June%20%26%20Lula/Sixteen%20Times/extralarge&path=%2Fmnt%2FUSB%2FFlac_Volumio%2FMusic%2FJune%20%26%20Lula%2F2010-Sixteen%20Times%2F03-Feeling%20You're%20Falling.flac&metadata=false Feb 11 18:43:39 lounge volumio[1291]: info: URI /mnt/USB/Flac_Volumio/Music/June & Lula/2010-Sixteen Times/03-Feeling You're Falling.flac Feb 11 18:43:40 lounge volumio[1291]: info: Exploding uri https://stream.radioparadise.com/mellow-flacm in service radio_paradise Feb 11 18:43:40 lounge volumio[1291]: error: [RadioParadise] explodeUri: No station found for uri "https://stream.radioparadise.com/mellow-flacm" Feb 11 18:43:40 lounge volumio[1291]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 11 18:43:40 lounge volumio[1291]: TypeError: Cannot read properties of undefined (reading 'then') Feb 11 18:43:40 lounge volumio[1291]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1384:31) Feb 11 18:43:40 lounge volumio[1291]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Feb 11 18:43:40 lounge volumio[1291]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Feb 11 18:43:40 lounge volumio[1291]: at Timeout._onTimeout (/volumio/app/playqueue.js:146:100) Feb 11 18:43:40 lounge volumio[1291]: at listOnTimeout (node:internal/timers:573:17) Feb 11 18:43:40 lounge volumio[1291]: at process.processTimers (node:internal/timers:514:7) Feb 11 18:43:40 lounge volumio[1291]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 11 18:43:40 lounge sudo[10366]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-11 18:42' Feb 11 18:43:40 lounge sudo[10366]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:31:57 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6759e875c98b942866984e844891d6c1"