-- Logs begin at Fri 2025-06-27 13:50:23 +07, end at Fri 2025-06-27 15:00:34 +07. --
Jun 27 14:59:15 rivoplus volumio[3416]: info:
Jun 27 14:59:15 rivoplus volumio[3416]: ---------------------------- MPD announces state update: player
Jun 27 14:59:15 rivoplus volumio[3416]: info: ControllerMpd::getState
Jun 27 14:59:15 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand status
Jun 27 14:59:15 rivoplus volumio[3416]: info:
Jun 27 14:59:15 rivoplus volumio[3416]: ---------------------------- MPD announces state update: player
Jun 27 14:59:15 rivoplus volumio[3416]: info: ControllerMpd::getState
Jun 27 14:59:15 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand status
Jun 27 14:59:15 rivoplus volumio[3416]: info:
Jun 27 14:59:15 rivoplus volumio[3416]: ---------------------------- MPD announces state update: player
Jun 27 14:59:15 rivoplus volumio[3416]: info: ControllerMpd::getState
Jun 27 14:59:15 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand status
Jun 27 14:59:15 rivoplus volumio[3416]: info: sendMpdCommand status took 8 milliseconds
Jun 27 14:59:15 rivoplus volumio[3416]: info: sendMpdCommand status took 7 milliseconds
Jun 27 14:59:15 rivoplus volumio[3416]: info: sendMpdCommand status took 2 milliseconds
Jun 27 14:59:15 rivoplus volumio[3416]: verbose: ControllerMpd::parseState
Jun 27 14:59:15 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 27 14:59:15 rivoplus volumio[3416]: verbose: ControllerMpd::parseState
Jun 27 14:59:15 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 27 14:59:15 rivoplus volumio[3416]: verbose: ControllerMpd::parseState
Jun 27 14:59:15 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 27 14:59:15 rivoplus volumio[3416]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jun 27 14:59:15 rivoplus volumio[3416]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jun 27 14:59:15 rivoplus volumio[3416]: verbose: ControllerMpd::parseTrackInfo
Jun 27 14:59:15 rivoplus volumio[3416]: verbose: ControllerMpd::parseTrackInfo
Jun 27 14:59:15 rivoplus volumio[3416]: verbose: ControllerMpd::parseTrackInfo
Jun 27 14:59:15 rivoplus volumio[3416]: info: ControllerMpd::pushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::servicePushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:15 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:15 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:15 rivoplus volumio[3416]: info: CorePlayQueue::getTrack 0
Jun 27 14:59:15 rivoplus volumio[3416]: 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":"13. My BASS","artist":"Brian Bromberg","album":"Brian Bromberg","uri":"http://192.168.3.13:50002/m/NDLNA/9494.wav","trackType":"wav"}
Jun 27 14:59:15 rivoplus volumio[3416]: verbose: CURRENT POSITION 0
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreStateMachine::syncState stateService stop
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreStateMachine::syncState currentStatus play
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:15 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:15 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreStateMachine::stPlaybackTimer
Jun 27 14:59:15 rivoplus volumio[3416]: info: ControllerMpd::pushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::servicePushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:15 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:15 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:15 rivoplus volumio[3416]: info: CorePlayQueue::getTrack 0
Jun 27 14:59:15 rivoplus volumio[3416]: 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":"13. My BASS","artist":"Brian Bromberg","album":"Brian Bromberg","uri":"http://192.168.3.13:50002/m/NDLNA/9494.wav","trackType":"wav"}
Jun 27 14:59:15 rivoplus volumio[3416]: verbose: CURRENT POSITION 0
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreStateMachine::syncState stateService stop
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreStateMachine::syncState currentStatus stop
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:15 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:15 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:15 rivoplus volumio[3416]: info: No code
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:15 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:15 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:15 rivoplus volumio[3416]: info: ControllerMpd::pushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::servicePushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:15 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:15 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:15 rivoplus volumio[3416]: info: CorePlayQueue::getTrack 0
Jun 27 14:59:15 rivoplus volumio[3416]: 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":"13. My BASS","artist":"Brian Bromberg","album":"Brian Bromberg","uri":"http://192.168.3.13:50002/m/NDLNA/9494.wav","trackType":"wav"}
Jun 27 14:59:15 rivoplus volumio[3416]: verbose: CURRENT POSITION 0
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreStateMachine::syncState stateService stop
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreStateMachine::syncState currentStatus stop
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:15 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:15 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:15 rivoplus volumio[3416]: info: No code
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:15 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:15 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:15 rivoplus volumio[3416]: info: ------------------------------ 90ms
Jun 27 14:59:15 rivoplus volumio[3416]: info: ------------------------------ 89ms
Jun 27 14:59:15 rivoplus volumio[3416]: info: ------------------------------ 90ms
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetQueue
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreStateMachine::getQueue
Jun 27 14:59:15 rivoplus volumio[3416]: info: CorePlayQueue::getQueue
Jun 27 14:59:15 rivoplus volumio[3416]: info: MCU Signalled Playback Inactive
Jun 27 14:59:15 rivoplus volumio[3416]: info: Clearing queue after UPNP request
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreStateMachine::ClearQueue
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreStateMachine::stop
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 27 14:59:15 rivoplus volumio[3416]: info: CorePlayQueue::clearPlayQueue
Jun 27 14:59:15 rivoplus volumio[3416]: info: CorePlayQueue::saveQueue
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CorePlayQueue::getTrack 0
Jun 27 14:59:15 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:15 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushQueue
Jun 27 14:59:15 rivoplus volumio[3416]: info:
Jun 27 14:59:15 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:15 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:15 rivoplus volumio[3416]: info:
Jun 27 14:59:15 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:15 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:15 rivoplus volumio[3416]: info:
Jun 27 14:59:15 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:15 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:15 rivoplus volumio[3416]: error: updateQueue error: null
Jun 27 14:59:15 rivoplus volumio[3416]: error: updateQueue error: null
Jun 27 14:59:15 rivoplus volumio[3416]: error: updateQueue error: null
Jun 27 14:59:15 rivoplus volumio[3416]: info: ------------------------------ 7ms
Jun 27 14:59:15 rivoplus volumio[3416]: info: ------------------------------ 5ms
Jun 27 14:59:15 rivoplus volumio[3416]: info: ------------------------------ 5ms
Jun 27 14:59:15 rivoplus volumio[3416]: info: Starting UPNP Playback
Jun 27 14:59:15 rivoplus volumio[3416]: info: Preparing playback through UPNP
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:15 rivoplus volumio[3416]: info: CorePlayQueue::getTrack 0
Jun 27 14:59:15 rivoplus volumio[3416]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 8ms
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 7ms
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 6ms
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 5ms
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 4ms
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 2ms
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 3ms
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 2ms
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 3ms
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 2ms
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 5ms
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 4ms
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 3ms
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 5ms
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 4ms
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 2ms
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces state update: player
Jun 27 14:59:16 rivoplus volumio[3416]: info: ControllerMpd::getState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand status
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces state update: player
Jun 27 14:59:16 rivoplus volumio[3416]: info: ControllerMpd::getState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand status
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces state update: player
Jun 27 14:59:16 rivoplus volumio[3416]: info: ControllerMpd::getState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand status
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces state update: player
Jun 27 14:59:16 rivoplus volumio[3416]: info: sendMpdCommand status took 8 milliseconds
Jun 27 14:59:16 rivoplus volumio[3416]: info: ControllerMpd::getState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand status
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::parseState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 27 14:59:16 rivoplus volumio[3416]: info: sendMpdCommand status took 10 milliseconds
Jun 27 14:59:16 rivoplus volumio[3416]: info: sendMpdCommand status took 8 milliseconds
Jun 27 14:59:16 rivoplus volumio[3416]: info: sendMpdCommand status took 4 milliseconds
Jun 27 14:59:16 rivoplus volumio[3416]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::parseState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::parseState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::parseState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::parseTrackInfo
Jun 27 14:59:16 rivoplus volumio[3416]: info: ControllerMpd::pushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::servicePushState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: In UPNP mode
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":409,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Milestones","artist":"Various Artists","album":"Dynamik - Advanced High Resolution Sound Vol.1","uri":"http://192.168.3.13:50002/m/NDLNA/9493.flac","trackType":"flac"}
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: CURRENT POSITION 0
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::syncState stateService play
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::syncState currentStatus stop
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 20ms
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces state update: player
Jun 27 14:59:16 rivoplus volumio[3416]: info: ControllerMpd::getState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand status
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces state update: player
Jun 27 14:59:16 rivoplus volumio[3416]: info: ControllerMpd::getState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand status
Jun 27 14:59:16 rivoplus volumio[3416]: info: sendMpdCommand playlistinfo took 11 milliseconds
Jun 27 14:59:16 rivoplus volumio[3416]: info: sendMpdCommand status took 6 milliseconds
Jun 27 14:59:16 rivoplus volumio[3416]: info: sendMpdCommand status took 4 milliseconds
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::parseTrackInfo
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::parseState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::parseState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 27 14:59:16 rivoplus volumio[3416]: info: ControllerMpd::pushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::servicePushState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: In UPNP mode
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":409,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Milestones","artist":"Various Artists","album":"Dynamik - Advanced High Resolution Sound Vol.1","uri":"http://192.168.3.13:50002/m/NDLNA/9493.flac","trackType":"flac"}
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: CURRENT POSITION 0
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::syncState stateService play
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::syncState currentStatus play
Jun 27 14:59:16 rivoplus volumio[3416]: info: Received an update from plugin. extracting info from payload
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:16 rivoplus volumio[3416]: info: ControllerMpd::pushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::servicePushState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: In UPNP mode
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":409,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Milestones","artist":"Various Artists","album":"Dynamik - Advanced High Resolution Sound Vol.1","uri":"http://192.168.3.13:50002/m/NDLNA/9493.flac","trackType":"flac"}
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: CURRENT POSITION 0
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::syncState stateService play
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::syncState currentStatus play
Jun 27 14:59:16 rivoplus volumio[3416]: info: Received an update from plugin. extracting info from payload
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:16 rivoplus volumio[3416]: info: ControllerMpd::pushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::servicePushState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: In UPNP mode
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":409,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Milestones","artist":"Various Artists","album":"Dynamik - Advanced High Resolution Sound Vol.1","uri":"http://192.168.3.13:50002/m/NDLNA/9493.flac","trackType":"flac"}
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: CURRENT POSITION 0
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::syncState stateService play
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::syncState currentStatus play
Jun 27 14:59:16 rivoplus volumio[3416]: info: Received an update from plugin. extracting info from payload
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 121ms
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 121ms
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 119ms
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces state update: player
Jun 27 14:59:16 rivoplus volumio[3416]: info: ControllerMpd::getState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand status
Jun 27 14:59:16 rivoplus volumio[3416]: info: sendMpdCommand playlistinfo took 109 milliseconds
Jun 27 14:59:16 rivoplus volumio[3416]: info: sendMpdCommand playlistinfo took 109 milliseconds
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::parseTrackInfo
Jun 27 14:59:16 rivoplus volumio[3416]: info: ControllerMpd::pushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::servicePushState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: In UPNP mode
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":409,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Milestones","artist":"Various Artists","album":" Dynamik - Advanced High Resolution Sound Vol.1","uri":"http://192.168.3.13:50002/m/NDLNA/9493.flac","trackType":"flac"}
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: CURRENT POSITION 0
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::syncState stateService play
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::syncState currentStatus play
Jun 27 14:59:16 rivoplus volumio[3416]: info: Received an update from plugin. extracting info from payload
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:16 rivoplus volumio[3416]: info: ControllerMpd::pushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::servicePushState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: In UPNP mode
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":409,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Milestones","artist":"Various Artists","album":" Dynamik - Advanced High Resolution Sound Vol.1","uri":"http://192.168.3.13:50002/m/NDLNA/9493.flac","trackType":"flac"}
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: CURRENT POSITION 0
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::syncState stateService play
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::syncState currentStatus play
Jun 27 14:59:16 rivoplus volumio[3416]: info: Received an update from plugin. extracting info from payload
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 229ms
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 234ms
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CorePlayQueue::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CorePlayQueue::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CorePlayQueue::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CorePlayQueue::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CorePlayQueue::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CorePlayQueue::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CorePlayQueue::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CorePlayQueue::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CorePlayQueue::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: CorePlayQueue::getQueue
Jun 27 14:59:16 rivoplus volumio[3416]: info: Signalling Playback active due to playback status change
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces state update: player
Jun 27 14:59:16 rivoplus volumio[3416]: info: ControllerMpd::getState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand status
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces system playlist update
Jun 27 14:59:16 rivoplus volumio[3416]: info: Ignoring MPD Status Update
Jun 27 14:59:16 rivoplus volumio[3416]: info:
Jun 27 14:59:16 rivoplus volumio[3416]: ---------------------------- MPD announces state update: player
Jun 27 14:59:16 rivoplus volumio[3416]: info: ControllerMpd::getState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand status
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 280ms
Jun 27 14:59:16 rivoplus volumio[3416]: info: sendMpdCommand status took 278 milliseconds
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 14ms
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::parseState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 27 14:59:16 rivoplus volumio[3416]: info: sendMpdCommand status took 33 milliseconds
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 32ms
Jun 27 14:59:16 rivoplus volumio[3416]: info: sendMpdCommand status took 31 milliseconds
Jun 27 14:59:16 rivoplus volumio[3416]: info: sendMpdCommand playlistinfo took 27 milliseconds
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::parseState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::parseState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: ControllerMpd::parseTrackInfo
Jun 27 14:59:16 rivoplus volumio[3416]: info: ControllerMpd::pushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::servicePushState
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: In UPNP mode
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1359,"duration":409,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1252 Kbps","isStreaming":false,"title":"Milestones","artist":"Various Artists","album":" Dynamik - Advanced High Resolution Sound Vol.1","uri":"http://192.168.3.13:50002/m/NDLNA/9493.flac","trackType":"flac"}
Jun 27 14:59:16 rivoplus volumio[3416]: verbose: CURRENT POSITION 0
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::syncState stateService play
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::syncState currentStatus play
Jun 27 14:59:16 rivoplus volumio[3416]: info: Received an update from plugin. extracting info from payload
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:16 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:16 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:16 rivoplus volumio[3416]: info: ------------------------------ 362ms
Jun 27 14:59:17 rivoplus volumio[3416]: info: sendMpdCommand playlistinfo took 62 milliseconds
Jun 27 14:59:17 rivoplus volumio[3416]: info: sendMpdCommand playlistinfo took 61 milliseconds
Jun 27 14:59:17 rivoplus volumio[3416]: verbose: ControllerMpd::parseTrackInfo
Jun 27 14:59:17 rivoplus volumio[3416]: info: ControllerMpd::pushState
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreCommandRouter::servicePushState
Jun 27 14:59:17 rivoplus volumio[3416]: verbose: In UPNP mode
Jun 27 14:59:17 rivoplus volumio[3416]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1737,"duration":409,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1459 Kbps","isStreaming":false,"title":"Milestones","artist":"Various Artists","album":" Dynamik - Advanced High Resolution Sound Vol.1","uri":"http://192.168.3.13:50002/m/NDLNA/9493.flac","trackType":"flac"}
Jun 27 14:59:17 rivoplus volumio[3416]: verbose: CURRENT POSITION 0
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreStateMachine::syncState stateService play
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreStateMachine::syncState currentStatus play
Jun 27 14:59:17 rivoplus volumio[3416]: info: Received an update from plugin. extracting info from payload
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:17 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:17 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:17 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:17 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:17 rivoplus volumio[3416]: info: ControllerMpd::pushState
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreCommandRouter::servicePushState
Jun 27 14:59:17 rivoplus volumio[3416]: verbose: In UPNP mode
Jun 27 14:59:17 rivoplus volumio[3416]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1737,"duration":409,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1459 Kbps","isStreaming":false,"title":"Milestones","artist":"Various Artists","album":" Dynamik - Advanced High Resolution Sound Vol.1","uri":"http://192.168.3.13:50002/m/NDLNA/9493.flac","trackType":"flac"}
Jun 27 14:59:17 rivoplus volumio[3416]: verbose: CURRENT POSITION 0
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreStateMachine::syncState stateService play
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreStateMachine::syncState currentStatus play
Jun 27 14:59:17 rivoplus volumio[3416]: info: Received an update from plugin. extracting info from payload
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:17 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:17 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreStateMachine::pushState
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreCommandRouter::volumioPushState
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetState
Jun 27 14:59:17 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output update for this device
Jun 27 14:59:17 rivoplus volumio[3416]: info: MRS: Pushing multiroomSync output
Jun 27 14:59:17 rivoplus volumio[3416]: info: ------------------------------ 241ms
Jun 27 14:59:17 rivoplus volumio[3416]: info: ------------------------------ 235ms
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetQueue
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreStateMachine::getQueue
Jun 27 14:59:17 rivoplus volumio[3416]: info: CorePlayQueue::getQueue
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetQueue
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreStateMachine::getQueue
Jun 27 14:59:17 rivoplus volumio[3416]: info: CorePlayQueue::getQueue
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetQueue
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreStateMachine::getQueue
Jun 27 14:59:17 rivoplus volumio[3416]: info: CorePlayQueue::getQueue
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetQueue
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreStateMachine::getQueue
Jun 27 14:59:17 rivoplus volumio[3416]: info: CorePlayQueue::getQueue
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetQueue
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreStateMachine::getQueue
Jun 27 14:59:17 rivoplus volumio[3416]: info: CorePlayQueue::getQueue
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreCommandRouter::volumioGetQueue
Jun 27 14:59:17 rivoplus volumio[3416]: info: CoreStateMachine::getQueue
Jun 27 14:59:17 rivoplus volumio[3416]: info: CorePlayQueue::getQueue
Jun 27 14:59:17 rivoplus volumio[3416]: info: MCU Signalled Playback Active
Jun 27 14:59:19 rivoplus volumio[3416]: info: Executing endpoint metavolumio
Jun 27 14:59:19 rivoplus volumio[3416]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 27 14:59:19 rivoplus volumio[3416]: info: Executing endpoint metavolumio
Jun 27 14:59:19 rivoplus volumio[3416]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 27 14:59:19 rivoplus volumio[3416]: info: Executing endpoint metavolumio
Jun 27 14:59:19 rivoplus volumio[3416]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 27 14:59:20 rivoplus ntpd[24518]: Soliciting pool server 103.184.124.254
Jun 27 14:59:22 rivoplus ntpd[24518]: Soliciting pool server 115.165.161.155
Jun 27 14:59:30 rivoplus ntpd[24518]: Soliciting pool server 115.165.161.155
Jun 27 14:59:30 rivoplus ntpd[24518]: Soliciting pool server 103.199.19.135
Jun 27 15:00:24 rivoplus ntpd[24518]: Soliciting pool server 103.188.82.179
Jun 27 15:00:26 rivoplus ntpd[24518]: Soliciting pool server 27.71.27.209
Jun 27 15:00:33 rivoplus volumio[3416]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 27 15:00:33 rivoplus volumio[3416]: Error: connect ETIMEDOUT 151.101.130.79:443
Jun 27 15:00:33 rivoplus volumio[3416]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Jun 27 15:00:33 rivoplus volumio[3416]: errno: -110,
Jun 27 15:00:33 rivoplus volumio[3416]: code: 'ETIMEDOUT',
Jun 27 15:00:33 rivoplus volumio[3416]: syscall: 'connect',
Jun 27 15:00:33 rivoplus volumio[3416]: address: '151.101.130.79',
Jun 27 15:00:33 rivoplus volumio[3416]: port: 443
Jun 27 15:00:33 rivoplus volumio[3416]: }
Jun 27 15:00:33 rivoplus volumio[3416]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 27 15:00:34 rivoplus sudo[27788]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-27 14:59
Jun 27 15:00:34 rivoplus sudo[27788]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="rivoplus"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:41:30 PM CEST"
VOLUMIO_VERSION="3.816"
VOLUMIO_HARDWARE="mp1"
VOLUMIO_DEVICENAME="Volumio MP1"
VOLUMIO_VENDOR_MODEL="Volumio Rivo"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Rivo"
VOLUMIO_HASH="e2256d79dd6d0ae59eb47f10e57a5e95"