-- Logs begin at Mon 2026-08-24 18:23:40 MDT, end at Tue 2026-08-25 22:53:02 MDT. -- Aug 25 22:52:23 rivo volumio[32406]: info: Preload queue cleared Aug 25 22:52:23 rivo volumio[32406]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 25 22:52:23 rivo volumio[32406]: info: CoreStateMachine::ClearQueue Aug 25 22:52:23 rivo volumio[32406]: info: CoreStateMachine::stop Aug 25 22:52:23 rivo volumio[32406]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 25 22:52:23 rivo volumio[32406]: info: CoreStateMachine::stPlaybackTimer Aug 25 22:52:23 rivo volumio[32406]: info: CoreStateMachine::updateTrackBlock Aug 25 22:52:23 rivo volumio[32406]: info: CorePlayQueue::getTrackBlock Aug 25 22:52:23 rivo volumio[32406]: info: CoreStateMachine::pushState Aug 25 22:52:23 rivo volumio[32406]: info: CorePlayQueue::getTrack 0 Aug 25 22:52:23 rivo volumio[32406]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 22:52:23 rivo volumio[32406]: info: CoreCommandRouter::volumioPushState Aug 25 22:52:23 rivo volumio[32406]: info: CoreCommandRouter::volumioGetState Aug 25 22:52:23 rivo volumio[32406]: info: CorePlayQueue::getTrack 0 Aug 25 22:52:23 rivo volumio[32406]: info: MRS: Pushing multiroomSync output update for this device Aug 25 22:52:23 rivo volumio[32406]: info: MRS: Pushing multiroomSync output Aug 25 22:52:23 rivo volumio[32406]: info: CoreStateMachine::serviceStop Aug 25 22:52:23 rivo volumio[32406]: info: CorePlayQueue::getTrack 0 Aug 25 22:52:23 rivo volumio[32406]: info: CoreCommandRouter::serviceStop Aug 25 22:52:23 rivo volumio[32406]: info: ControllerMpd::stop Aug 25 22:52:23 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand stop Aug 25 22:52:23 rivo volumio[32406]: info: CorePlayQueue::clearPlayQueue Aug 25 22:52:23 rivo volumio[32406]: info: CorePlayQueue::saveQueue Aug 25 22:52:23 rivo volumio[32406]: info: CoreCommandRouter::volumioPushQueue Aug 25 22:52:23 rivo volumio[32406]: info: CoreStateMachine::addQueueItems Aug 25 22:52:23 rivo volumio[32406]: info: CorePlayQueue::addQueueItems Aug 25 22:52:23 rivo volumio[32406]: info: Preload queue cleared Aug 25 22:52:23 rivo volumio[32406]: info: Adding Item to queue: music-library/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/01 - Sonata No. 12 in A flat Major; I. Andante con Variazioni.flac Aug 25 22:52:23 rivo volumio[32406]: info: Using cached record of: music-library/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/01 - Sonata No. 12 in A flat Major; I. Andante con Variazioni.flac Aug 25 22:52:23 rivo volumio[32406]: info: Adding Item to queue: music-library/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/02 - Sonata No. 12 in A flat Major; II. Scherzo; Allergo molto.flac Aug 25 22:52:23 rivo volumio[32406]: info: Using cached record of: music-library/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/02 - Sonata No. 12 in A flat Major; II. Scherzo; Allergo molto.flac Aug 25 22:52:23 rivo volumio[32406]: info: Adding Item to queue: music-library/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/03 - Sonata No. 12 in A flat Major; III. Marcia funebre sulla morte d'un Eroe.flac Aug 25 22:52:23 rivo volumio[32406]: info: Using cached record of: music-library/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/03 - Sonata No. 12 in A flat Major; III. Marcia funebre sulla morte d'un Eroe.flac Aug 25 22:52:23 rivo volumio[32406]: info: Adding Item to queue: music-library/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/04 - Sonata No. 12 in A flat Major; IV. Allegro.flac Aug 25 22:52:23 rivo volumio[32406]: info: Using cached record of: music-library/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/04 - Sonata No. 12 in A flat Major; IV. Allegro.flac Aug 25 22:52:23 rivo volumio[32406]: info: Adding Item to queue: music-library/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac Aug 25 22:52:23 rivo volumio[32406]: info: Using cached record of: music-library/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac Aug 25 22:52:23 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:23.994-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" state=STATUS_STOPPED positionMs=0 volume=41 Aug 25 22:52:23 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:23.994-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" state=STATUS_STOPPED positionMs=0 volume=41 Aug 25 22:52:23 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:23.995-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/01 - Sonata No. 12 in A flat Major; I. Andante con Variazioni.flac" title="Sonata No. 12 in A flat Major: I. Andante con Variazioni" Aug 25 22:52:23 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:23.995-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/01 - Sonata No. 12 in A flat Major; I. Andante con Variazioni.flac" title="Sonata No. 12 in A flat Major: I. Andante con Variazioni" Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioPushQueue Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::saveQueue Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::updateTrackBlock Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrackBlock Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioPlay Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::play index 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::addQueueItems Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::addQueueItems Aug 25 22:52:24 rivo volumio[32406]: info: Preload queue cleared Aug 25 22:52:24 rivo volumio[32406]: info: Adding Item to queue: music-library/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/06 - Sonata No. 13 in E flat major; II. Allegro molto e vivace.flac Aug 25 22:52:24 rivo volumio[32406]: info: Using cached record of: music-library/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/06 - Sonata No. 13 in E flat major; II. Allegro molto e vivace.flac Aug 25 22:52:24 rivo volumio[32406]: info: Adding Item to queue: music-library/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/07 - Sonata No. 13 in E flat major; III. Adagio con espressione.flac Aug 25 22:52:24 rivo volumio[32406]: info: Using cached record of: music-library/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/07 - Sonata No. 13 in E flat major; III. Adagio con espressione.flac Aug 25 22:52:24 rivo volumio[32406]: info: Adding Item to queue: music-library/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/08 - Sonata No. 13 in E flat major; IV. Allegro vivace.flac Aug 25 22:52:24 rivo volumio[32406]: info: Using cached record of: music-library/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/08 - Sonata No. 13 in E flat major; IV. Allegro vivace.flac Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::stop Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioPushQueue Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::saveQueue Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::play index undefined Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::updateTrackBlock Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrackBlock Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::startPlaybackTimer Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::clearAddPlayTracks NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand stop Aug 25 22:52:24 rivo volumio[32406]: info: Updating RAAT Signal Path Aug 25 22:52:24 rivo volumio[32406]: info: Aug 25 22:52:24 rivo volumio[32406]: ---------------------------- MPD announces state update: player Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand stop took 90 milliseconds Aug 25 22:52:24 rivo volumio[32406]: info: ControllerMpd::getState Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand status Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand stop took 30 milliseconds Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand clear Aug 25 22:52:24 rivo volumio[32406]: info: Aug 25 22:52:24 rivo volumio[32406]: ---------------------------- MPD announces state update: player Aug 25 22:52:24 rivo volumio[32406]: info: ControllerMpd::getState Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand status Aug 25 22:52:24 rivo volumio[32406]: info: Aug 25 22:52:24 rivo volumio[32406]: ---------------------------- MPD announces state update: player Aug 25 22:52:24 rivo volumio[32406]: info: ControllerMpd::getState Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand status Aug 25 22:52:24 rivo volumio[32406]: info: Aug 25 22:52:24 rivo volumio[32406]: ---------------------------- MPD announces system playlist update Aug 25 22:52:24 rivo volumio[32406]: info: Ignoring MPD Status Update Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand status took 9 milliseconds Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand clear took 8 milliseconds Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand status took 7 milliseconds Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand status took 5 milliseconds Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::parseState Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand add "NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::parseState Aug 25 22:52:24 rivo volumio[32406]: info: ControllerMpd::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::servicePushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioPushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioGetState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output update for this device Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 25 22:52:24 rivo volumio[32406]: verbose: CURRENT POSITION 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::syncState stateService stop Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::syncState currentStatus stop Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioPushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioGetState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output update for this device Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output Aug 25 22:52:24 rivo volumio[32406]: info: No code Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioPushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioGetState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output update for this device Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output Aug 25 22:52:24 rivo volumio[32406]: info: ControllerMpd::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::servicePushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioPushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioGetState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output update for this device Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 25 22:52:24 rivo volumio[32406]: verbose: CURRENT POSITION 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::syncState stateService stop Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::syncState currentStatus stop Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioPushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioGetState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output update for this device Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output Aug 25 22:52:24 rivo volumio[32406]: info: No code Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioPushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioGetState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output update for this device Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.139-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" state=STATUS_STOPPED positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.140-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" state=STATUS_STOPPED positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.140-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.140-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" state=STATUS_STOPPED positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.140-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" state=STATUS_STOPPED positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.141-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.140-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.141-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" state=STATUS_STOPPED positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.141-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.142-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" state=STATUS_STOPPED positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.142-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.143-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.146-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" state=STATUS_STOPPED positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.146-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" state=STATUS_STOPPED positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.147-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.147-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" state=STATUS_STOPPED positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.147-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.147-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" state=STATUS_STOPPED positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.148-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.148-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.150-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" state=STATUS_STOPPED positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.158-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" state=STATUS_STOPPED positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.159-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.159-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio[32406]: info: ------------------------------ 101ms Aug 25 22:52:24 rivo volumio[32406]: info: ------------------------------ 101ms Aug 25 22:52:24 rivo volumio[32406]: info: Aug 25 22:52:24 rivo volumio[32406]: ---------------------------- MPD announces system playlist update Aug 25 22:52:24 rivo volumio[32406]: info: Ignoring MPD Status Update Aug 25 22:52:24 rivo volumio[32406]: info: Aug 25 22:52:24 rivo volumio[32406]: ---------------------------- MPD announces system playlist update Aug 25 22:52:24 rivo volumio[32406]: info: Ignoring MPD Status Update Aug 25 22:52:24 rivo volumio[32406]: error: updateQueue error: null Aug 25 22:52:24 rivo volumio[32406]: info: Aug 25 22:52:24 rivo volumio[32406]: ---------------------------- MPD announces system playlist update Aug 25 22:52:24 rivo volumio[32406]: info: Ignoring MPD Status Update Aug 25 22:52:24 rivo volumio[32406]: info: ------------------------------ 108ms Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand playlistinfo took 105 milliseconds Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand add "NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" took 105 milliseconds Aug 25 22:52:24 rivo volumio[32406]: info: ------------------------------ 10ms Aug 25 22:52:24 rivo volumio[32406]: info: ------------------------------ 8ms Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::parseTrackInfo Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand play Aug 25 22:52:24 rivo volumio[32406]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 25 22:52:24 rivo volumio[32406]: info: ------------------------------ 123ms Aug 25 22:52:24 rivo volumio[32406]: info: Aug 25 22:52:24 rivo volumio[32406]: ---------------------------- MPD announces system playlist update Aug 25 22:52:24 rivo volumio[32406]: info: Ignoring MPD Status Update Aug 25 22:52:24 rivo volumio[32406]: info: Aug 25 22:52:24 rivo volumio[32406]: ---------------------------- MPD announces system playlist update Aug 25 22:52:24 rivo volumio[32406]: info: Ignoring MPD Status Update Aug 25 22:52:24 rivo volumio[32406]: info: Updating RAAT Signal Path Aug 25 22:52:24 rivo volumio[32406]: info: Updating RAAT Signal Path Aug 25 22:52:24 rivo volumio[32406]: info: Updating RAAT Signal Path Aug 25 22:52:24 rivo volumio[32406]: info: Updating RAAT Signal Path Aug 25 22:52:24 rivo volumio[32406]: info: Updating RAAT Signal Path Aug 25 22:52:24 rivo volumio[32406]: info: ------------------------------ 75ms Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand play took 70 milliseconds Aug 25 22:52:24 rivo volumio[32406]: info: ------------------------------ 68ms Aug 25 22:52:24 rivo volumio[32406]: info: ------------------------------ 66ms Aug 25 22:52:24 rivo volumio[32406]: info: MCU Signalled Playback Inactive Aug 25 22:52:24 rivo volumio[32406]: info: Aug 25 22:52:24 rivo volumio[32406]: ---------------------------- MPD announces state update: player Aug 25 22:52:24 rivo volumio[32406]: info: ControllerMpd::getState Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand status Aug 25 22:52:24 rivo volumio[32406]: info: Aug 25 22:52:24 rivo volumio[32406]: ---------------------------- MPD announces state update: player Aug 25 22:52:24 rivo volumio[32406]: info: ControllerMpd::getState Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand status Aug 25 22:52:24 rivo volumio[32406]: info: Aug 25 22:52:24 rivo volumio[32406]: ---------------------------- MPD announces state update: player Aug 25 22:52:24 rivo volumio[32406]: info: ControllerMpd::getState Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand status Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand status took 34 milliseconds Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::parseState Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 25 22:52:24 rivo volumio[32406]: info: Aug 25 22:52:24 rivo volumio[32406]: ---------------------------- MPD announces state update: player Aug 25 22:52:24 rivo volumio[32406]: info: ControllerMpd::getState Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand status Aug 25 22:52:24 rivo volumio[32406]: info: Aug 25 22:52:24 rivo volumio[32406]: ---------------------------- MPD announces state update: player Aug 25 22:52:24 rivo volumio[32406]: info: ControllerMpd::getState Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand status Aug 25 22:52:24 rivo volumio[32406]: info: Aug 25 22:52:24 rivo volumio[32406]: ---------------------------- MPD announces state update: player Aug 25 22:52:24 rivo volumio[32406]: info: ControllerMpd::getState Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand status Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand status took 45 milliseconds Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand status took 42 milliseconds Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand playlistinfo took 13 milliseconds Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand status took 9 milliseconds Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand status took 7 milliseconds Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::parseState Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::parseState Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::parseTrackInfo Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::parseState Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::parseState Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 25 22:52:24 rivo volumio[32406]: info: ControllerMpd::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::servicePushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":472,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sonata No. 13 in E flat major: I. Andante","artist":"Glenn Gould","album":"GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]","uri":"NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac","trackType":"flac"} Aug 25 22:52:24 rivo volumio[32406]: verbose: CURRENT POSITION 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::syncState stateService play Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::syncState currentStatus stop Aug 25 22:52:24 rivo volumio[32406]: info: ------------------------------ 61ms Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand status took 15 milliseconds Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand playlistinfo took 10 milliseconds Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand playlistinfo took 11 milliseconds Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand playlistinfo took 10 milliseconds Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand playlistinfo took 12 milliseconds Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::parseState Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::parseTrackInfo Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::parseTrackInfo Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::parseTrackInfo Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::parseTrackInfo Aug 25 22:52:24 rivo volumio[32406]: info: ControllerMpd::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::servicePushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":472,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sonata No. 13 in E flat major: I. Andante","artist":"Glenn Gould","album":"GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]","uri":"NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac","trackType":"flac"} Aug 25 22:52:24 rivo volumio[32406]: verbose: CURRENT POSITION 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::syncState stateService play Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::syncState currentStatus play Aug 25 22:52:24 rivo volumio[32406]: info: Received an update from plugin. extracting info from payload Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioPushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioGetState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output update for this device Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioPushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioGetState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output update for this device Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output Aug 25 22:52:24 rivo volumio[32406]: info: ControllerMpd::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::servicePushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":472,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sonata No. 13 in E flat major: I. Andante","artist":"Glenn Gould","album":"GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]","uri":"NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac","trackType":"flac"} Aug 25 22:52:24 rivo volumio[32406]: verbose: CURRENT POSITION 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::syncState stateService play Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::syncState currentStatus play Aug 25 22:52:24 rivo volumio[32406]: info: Received an update from plugin. extracting info from payload Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioPushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioGetState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output update for this device Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioPushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioGetState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output update for this device Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output Aug 25 22:52:24 rivo volumio[32406]: info: ControllerMpd::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::servicePushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":472,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sonata No. 13 in E flat major: I. Andante","artist":"Glenn Gould","album":"GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]","uri":"NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac","trackType":"flac"} Aug 25 22:52:24 rivo volumio[32406]: verbose: CURRENT POSITION 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::syncState stateService play Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::syncState currentStatus play Aug 25 22:52:24 rivo volumio[32406]: info: Received an update from plugin. extracting info from payload Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioPushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioGetState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output update for this device Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioPushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioGetState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output update for this device Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output Aug 25 22:52:24 rivo volumio[32406]: info: ControllerMpd::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::servicePushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":472,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sonata No. 13 in E flat major: I. Andante","artist":"Glenn Gould","album":"GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]","uri":"NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac","trackType":"flac"} Aug 25 22:52:24 rivo volumio[32406]: verbose: CURRENT POSITION 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::syncState stateService play Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::syncState currentStatus play Aug 25 22:52:24 rivo volumio[32406]: info: Received an update from plugin. extracting info from payload Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioPushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioGetState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output update for this device Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioPushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioGetState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output update for this device Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.479-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.479-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.480-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.480-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.482-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.484-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.484-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.485-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.487-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.488-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.489-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.491-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.492-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.494-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.495-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.495-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.496-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.496-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.497-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.497-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.497-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.497-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.498-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.498-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.498-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.499-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.501-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.501-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.502-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.502-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.503-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio[32406]: info: ------------------------------ 262ms Aug 25 22:52:24 rivo volumio[32406]: info: ------------------------------ 261ms Aug 25 22:52:24 rivo volumio[32406]: info: ------------------------------ 229ms Aug 25 22:52:24 rivo volumio[32406]: info: ------------------------------ 228ms Aug 25 22:52:24 rivo volumio[32406]: info: sendMpdCommand playlistinfo took 212 milliseconds Aug 25 22:52:24 rivo volumio[32406]: verbose: ControllerMpd::parseTrackInfo Aug 25 22:52:24 rivo volumio[32406]: info: ControllerMpd::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::servicePushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":472,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sonata No. 13 in E flat major: I. Andante","artist":"Glenn Gould","album":"GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]","uri":"NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac","trackType":"flac"} Aug 25 22:52:24 rivo volumio[32406]: verbose: CURRENT POSITION 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::syncState stateService play Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::syncState currentStatus play Aug 25 22:52:24 rivo volumio[32406]: info: Received an update from plugin. extracting info from payload Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioPushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioGetState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output update for this device Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output Aug 25 22:52:24 rivo volumio[32406]: info: CoreStateMachine::pushState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioPushState Aug 25 22:52:24 rivo volumio[32406]: info: CoreCommandRouter::volumioGetState Aug 25 22:52:24 rivo volumio[32406]: info: CorePlayQueue::getTrack 4 Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output update for this device Aug 25 22:52:24 rivo volumio[32406]: info: MRS: Pushing multiroomSync output Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.626-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.626-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.627-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.627-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.629-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.629-06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" state=STATUS_PLAYING positionMs=0 volume=41 Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.629-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.183:53887,00:00:00:00:00:00%dd @ 0x1d14150" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio5-onboarding[3848]: time=2026-08-25T22:52:24.630-06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.6:58016 @ 0x1801c50" id="mnt/NAS/Multimedia/Music/A0_AIFF+FLAC/Scott/Scott_ForLouis_2017.12.13/Glenn Gould/GGR77 Beethoven - Sonata No 12, Op 26 & No 13, Op 27-1 [1983]/05 - Sonata No. 13 in E flat major; I. Andante.flac" title="Sonata No. 13 in E flat major: I. Andante" Aug 25 22:52:24 rivo volumio[32406]: info: ------------------------------ 288ms Aug 25 22:52:24 rivo volumio[32406]: info: Updating RAAT Signal Path Aug 25 22:52:24 rivo volumio[32406]: info: Updating RAAT Signal Path Aug 25 22:52:24 rivo volumio[32406]: info: Updating RAAT Signal Path Aug 25 22:52:24 rivo volumio[32406]: info: Updating RAAT Signal Path Aug 25 22:52:24 rivo volumio[32406]: info: Updating RAAT Signal Path Aug 25 22:52:24 rivo volumio[32406]: info: Updating RAAT Signal Path Aug 25 22:52:24 rivo volumio[32406]: info: Updating RAAT Signal Path Aug 25 22:52:24 rivo volumio[32406]: info: Updating RAAT Signal Path Aug 25 22:52:24 rivo volumio[32406]: info: Updating RAAT Signal Path Aug 25 22:52:24 rivo volumio[32406]: info: Updating RAAT Signal Path Aug 25 22:52:24 rivo volumio[32406]: info: Signalling Playback active due to playback status change Aug 25 22:52:24 rivo volumio[32406]: info: Signalling Playback active due to playback status change Aug 25 22:52:24 rivo volumio[32406]: info: Signalling Playback active due to playback status change Aug 25 22:52:24 rivo volumio[32406]: info: Signalling Playback active due to playback status change Aug 25 22:52:24 rivo volumio[32406]: info: Signalling Playback active due to playback status change Aug 25 22:52:24 rivo volumio[32406]: info: Signalling Playback active due to playback status change Aug 25 22:52:24 rivo volumio[32406]: info: Signalling Playback active due to playback status change Aug 25 22:52:24 rivo volumio[32406]: info: Signalling Playback active due to playback status change Aug 25 22:52:24 rivo volumio[32406]: info: Signalling Playback active due to playback status change Aug 25 22:52:24 rivo volumio[32406]: info: Signalling Playback active due to playback status change Aug 25 22:52:24 rivo volumio[32406]: info: MCU Signalled Playback Active Aug 25 22:52:53 rivo volumio[32406]: Searching plugin music_service/mpd Aug 25 22:52:53 rivo volumio[32406]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 25 22:52:54 rivo volumio[32406]: Searching plugin music_service/mpd Aug 25 22:52:54 rivo volumio[32406]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 25 22:52:54 rivo volumiologrotate[2846]: ls: cannot access '/var/log/samba/log.wb-RIVO': No such file or directory Aug 25 22:52:54 rivo volumiologrotate[2846]: ls: cannot access '+': No such file or directory Aug 25 22:52:55 rivo volumio[32406]: Searching plugin music_service/mpd Aug 25 22:52:55 rivo volumio[32406]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 25 22:52:56 rivo volumio[32406]: Searching plugin music_service/mpd Aug 25 22:52:56 rivo volumio[32406]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 25 22:52:56 rivo volumio[32406]: Searching plugin music_service/mpd Aug 25 22:52:56 rivo volumio[32406]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 25 22:52:57 rivo volumio[32406]: Searching plugin music_service/mpd Aug 25 22:52:57 rivo volumio[32406]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 25 22:52:59 rivo volumio[32406]: info: All search sources collected, pushing search results Aug 25 22:53:01 rivo volumio[32406]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 22:53:01 rivo volumio[32406]: Error: connect ECONNREFUSED 158.69.210.98:443 Aug 25 22:53:01 rivo volumio[32406]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Aug 25 22:53:01 rivo volumio[32406]: errno: -111, Aug 25 22:53:01 rivo volumio[32406]: code: 'ECONNREFUSED', Aug 25 22:53:01 rivo volumio[32406]: syscall: 'connect', Aug 25 22:53:01 rivo volumio[32406]: address: '158.69.210.98', Aug 25 22:53:01 rivo volumio[32406]: port: 443 Aug 25 22:53:01 rivo volumio[32406]: } Aug 25 22:53:01 rivo volumio[32406]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 22:53:02 rivo sudo[1931]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-25 22:52 Aug 25 22:53:02 rivo sudo[1931]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 11:19:27 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="a7285124ffc88c43265bb2db03526f6a"