Jun 20 21:45:43 primo volumio[1178]: info: Clearing queue after UPNP request
Jun 20 21:45:43 primo volumio[1178]: info: CoreStateMachine::ClearQueue
Jun 20 21:45:43 primo volumio[1178]: info: CoreStateMachine::stop
Jun 20 21:45:43 primo volumio[1178]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 20 21:45:43 primo volumio[1178]: info: CorePlayQueue::clearPlayQueue
Jun 20 21:45:43 primo volumio[1178]: info: CorePlayQueue::saveQueue
Jun 20 21:45:43 primo volumio[1178]: info: CoreCommandRouter::volumioPushState
Jun 20 21:45:43 primo volumio[1178]: info: CoreCommandRouter::volumioGetState
Jun 20 21:45:43 primo volumio[1178]: info: CorePlayQueue::getTrack 0
Jun 20 21:45:43 primo volumio[1178]: info: MRS: Pushing multiroomSync output update for this device
Jun 20 21:45:43 primo volumio[1178]: info: MRS: Pushing multiroomSync output
Jun 20 21:45:43 primo volumio[1178]: info: CoreCommandRouter::volumioPushQueue
Jun 20 21:45:43 primo volumio[1178]: info: Updating RAAT Signal Path
Jun 20 21:45:45 primo volumio[1178]: info: Starting UPNP Playback
Jun 20 21:45:45 primo volumio[1178]: info: Preparing playback through UPNP
Jun 20 21:45:45 primo volumio[1178]: info: CoreCommandRouter::volumioGetState
Jun 20 21:45:45 primo volumio[1178]: info: CorePlayQueue::getTrack 0
Jun 20 21:45:45 primo volumio[1178]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces system playlist update
Jun 20 21:45:46 primo volumio[1178]: info: Ignoring MPD Status Update
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces system playlist update
Jun 20 21:45:46 primo volumio[1178]: info: Ignoring MPD Status Update
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces system playlist update
Jun 20 21:45:46 primo volumio[1178]: info: Ignoring MPD Status Update
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 10ms
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 7ms
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 8ms
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces system playlist update
Jun 20 21:45:46 primo volumio[1178]: info: Ignoring MPD Status Update
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces system playlist update
Jun 20 21:45:46 primo volumio[1178]: info: Ignoring MPD Status Update
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces system playlist update
Jun 20 21:45:46 primo volumio[1178]: info: Ignoring MPD Status Update
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 8ms
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 6ms
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 5ms
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces system playlist update
Jun 20 21:45:46 primo volumio[1178]: info: Ignoring MPD Status Update
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces system playlist update
Jun 20 21:45:46 primo volumio[1178]: info: Ignoring MPD Status Update
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces system playlist update
Jun 20 21:45:46 primo volumio[1178]: info: Ignoring MPD Status Update
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 6ms
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 5ms
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 4ms
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces system playlist update
Jun 20 21:45:46 primo volumio[1178]: info: Ignoring MPD Status Update
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces system playlist update
Jun 20 21:45:46 primo volumio[1178]: info: Ignoring MPD Status Update
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces system playlist update
Jun 20 21:45:46 primo volumio[1178]: info: Ignoring MPD Status Update
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 6ms
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 4ms
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 3ms
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces system playlist update
Jun 20 21:45:46 primo volumio[1178]: info: Ignoring MPD Status Update
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces system playlist update
Jun 20 21:45:46 primo volumio[1178]: info: Ignoring MPD Status Update
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces system playlist update
Jun 20 21:45:46 primo volumio[1178]: info: Ignoring MPD Status Update
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 6ms
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 4ms
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 3ms
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces system playlist update
Jun 20 21:45:46 primo volumio[1178]: info: Ignoring MPD Status Update
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces system playlist update
Jun 20 21:45:46 primo volumio[1178]: info: Ignoring MPD Status Update
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces system playlist update
Jun 20 21:45:46 primo volumio[1178]: info: Ignoring MPD Status Update
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 3ms
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 3ms
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 2ms
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces state update: player
Jun 20 21:45:46 primo volumio[1178]: info: ControllerMpd::getState
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces state update: player
Jun 20 21:45:46 primo volumio[1178]: info: ControllerMpd::getState
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces state update: player
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces state update: player
Jun 20 21:45:46 primo volumio[1178]: info: ControllerMpd::getState
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 21:45:46 primo volumio[1178]: info: sendMpdCommand status took 10 milliseconds
Jun 20 21:45:46 primo volumio[1178]: info: ControllerMpd::getState
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::parseState
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces state update: player
Jun 20 21:45:46 primo volumio[1178]: info: ControllerMpd::getState
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 21:45:46 primo volumio[1178]: info:
Jun 20 21:45:46 primo volumio[1178]: ---------------------------- MPD announces state update: player
Jun 20 21:45:46 primo volumio[1178]: info: ControllerMpd::getState
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 21:45:46 primo volumio[1178]: info: sendMpdCommand status took 15 milliseconds
Jun 20 21:45:46 primo volumio[1178]: info: sendMpdCommand status took 12 milliseconds
Jun 20 21:45:46 primo volumio[1178]: info: sendMpdCommand status took 9 milliseconds
Jun 20 21:45:46 primo volumio[1178]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jun 20 21:45:46 primo volumio[1178]: info: sendMpdCommand status took 4 milliseconds
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::parseState
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::parseState
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::parseState
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::parseState
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 21:45:46 primo volumio[1178]: info: ControllerMpd::pushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::servicePushState
Jun 20 21:45:46 primo volumio[1178]: verbose: In UPNP mode
Jun 20 21:45:46 primo volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":217,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Housebroken","artist":"Aiyana-Lee","album":"Housebroken","uri":"http://192.168.50.109:13700/mconnect/tidal/497067167.flac","trackType":"tidal"}
Jun 20 21:45:46 primo volumio[1178]: verbose: CURRENT POSITION 0
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::syncState stateService play
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::syncState currentStatus stop
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 35ms
Jun 20 21:45:46 primo volumio[1178]: info: sendMpdCommand status took 17 milliseconds
Jun 20 21:45:46 primo volumio[1178]: info: sendMpdCommand playlistinfo took 13 milliseconds
Jun 20 21:45:46 primo volumio[1178]: info: sendMpdCommand playlistinfo took 13 milliseconds
Jun 20 21:45:46 primo volumio[1178]: info: sendMpdCommand playlistinfo took 12 milliseconds
Jun 20 21:45:46 primo volumio[1178]: info: sendMpdCommand playlistinfo took 10 milliseconds
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::parseState
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Jun 20 21:45:46 primo volumio[1178]: info: ControllerMpd::pushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::servicePushState
Jun 20 21:45:46 primo volumio[1178]: verbose: In UPNP mode
Jun 20 21:45:46 primo volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":217,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Housebroken","artist":"Aiyana-Lee","album":"Housebroken","uri":"http://192.168.50.109:13700/mconnect/tidal/497067167.flac","trackType":"tidal"}
Jun 20 21:45:46 primo volumio[1178]: verbose: CURRENT POSITION 0
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::syncState stateService play
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::syncState currentStatus play
Jun 20 21:45:46 primo volumio[1178]: info: Received an update from plugin. extracting info from payload
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::pushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioPushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetState
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output update for this device
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::pushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioPushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetState
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output update for this device
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output
Jun 20 21:45:46 primo volumio[1178]: info: ControllerMpd::pushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::servicePushState
Jun 20 21:45:46 primo volumio[1178]: verbose: In UPNP mode
Jun 20 21:45:46 primo volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":217,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Housebroken","artist":"Aiyana-Lee","album":"Housebroken","uri":"http://192.168.50.109:13700/mconnect/tidal/497067167.flac","trackType":"tidal"}
Jun 20 21:45:46 primo volumio[1178]: verbose: CURRENT POSITION 0
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::syncState stateService play
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::syncState currentStatus play
Jun 20 21:45:46 primo volumio[1178]: info: Received an update from plugin. extracting info from payload
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::pushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioPushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetState
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output update for this device
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::pushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioPushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetState
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output update for this device
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output
Jun 20 21:45:46 primo volumio[1178]: info: ControllerMpd::pushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::servicePushState
Jun 20 21:45:46 primo volumio[1178]: verbose: In UPNP mode
Jun 20 21:45:46 primo volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":217,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Housebroken","artist":"Aiyana-Lee","album":"Housebroken","uri":"http://192.168.50.109:13700/mconnect/tidal/497067167.flac","trackType":"tidal"}
Jun 20 21:45:46 primo volumio[1178]: verbose: CURRENT POSITION 0
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::syncState stateService play
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::syncState currentStatus play
Jun 20 21:45:46 primo volumio[1178]: info: Received an update from plugin. extracting info from payload
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::pushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioPushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetState
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output update for this device
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::pushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioPushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetState
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output update for this device
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output
Jun 20 21:45:46 primo volumio[1178]: info: ControllerMpd::pushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::servicePushState
Jun 20 21:45:46 primo volumio[1178]: verbose: In UPNP mode
Jun 20 21:45:46 primo volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":217,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Housebroken","artist":"Aiyana-Lee","album":"Housebroken","uri":"http://192.168.50.109:13700/mconnect/tidal/497067167.flac","trackType":"tidal"}
Jun 20 21:45:46 primo volumio[1178]: verbose: CURRENT POSITION 0
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::syncState stateService play
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::syncState currentStatus play
Jun 20 21:45:46 primo volumio[1178]: info: Received an update from plugin. extracting info from payload
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::pushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioPushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetState
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output update for this device
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::pushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioPushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetState
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output update for this device
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 133ms
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 130ms
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 131ms
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 126ms
Jun 20 21:45:46 primo volumio[1178]: info: sendMpdCommand playlistinfo took 105 milliseconds
Jun 20 21:45:46 primo volumio[1178]: verbose: ControllerMpd::parseTrackInfo
Jun 20 21:45:46 primo volumio[1178]: info: ControllerMpd::pushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::servicePushState
Jun 20 21:45:46 primo volumio[1178]: verbose: In UPNP mode
Jun 20 21:45:46 primo volumio[1178]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":217,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Housebroken","artist":"Aiyana-Lee","album":"Housebroken","uri":"http://192.168.50.109:13700/mconnect/tidal/497067167.flac","trackType":"tidal"}
Jun 20 21:45:46 primo volumio[1178]: verbose: CURRENT POSITION 0
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::syncState stateService play
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::syncState currentStatus play
Jun 20 21:45:46 primo volumio[1178]: info: Received an update from plugin. extracting info from payload
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::pushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioPushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetState
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output update for this device
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::pushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioPushState
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetState
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output update for this device
Jun 20 21:45:46 primo volumio[1178]: info: MRS: Pushing multiroomSync output
Jun 20 21:45:46 primo volumio[1178]: info: ------------------------------ 158ms
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetQueue
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: CorePlayQueue::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetQueue
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: CorePlayQueue::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetQueue
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: CorePlayQueue::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetQueue
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: CorePlayQueue::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetQueue
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: CorePlayQueue::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetQueue
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: CorePlayQueue::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetQueue
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: CorePlayQueue::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetQueue
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: CorePlayQueue::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetQueue
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: CorePlayQueue::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: CoreCommandRouter::volumioGetQueue
Jun 20 21:45:46 primo volumio[1178]: info: CoreStateMachine::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: CorePlayQueue::getQueue
Jun 20 21:45:46 primo volumio[1178]: info: Signalling Playback active due to playback status change
Jun 20 21:45:46 primo volumio[1178]: info: Signalling Playback active due to playback status change
Jun 20 21:45:46 primo volumio[1178]: info: Signalling Playback active due to playback status change
Jun 20 21:45:46 primo volumio[1178]: info: Signalling Playback active due to playback status change
Jun 20 21:45:46 primo volumio[1178]: info: Signalling Playback active due to playback status change
Jun 20 21:45:46 primo volumio[1178]: info: Signalling Playback active due to playback status change
Jun 20 21:45:46 primo volumio[1178]: info: Signalling Playback active due to playback status change
Jun 20 21:45:46 primo volumio[1178]: info: Signalling Playback active due to playback status change
Jun 20 21:45:46 primo volumio[1178]: info: Signalling Playback active due to playback status change
Jun 20 21:45:46 primo volumio[1178]: info: Signalling Playback active due to playback status change
Jun 20 21:45:46 primo volumio[1178]: info: Updating RAAT Signal Path
Jun 20 21:45:46 primo volumio[1178]: info: Updating RAAT Signal Path
Jun 20 21:45:46 primo volumio[1178]: info: Updating RAAT Signal Path
Jun 20 21:45:46 primo volumio[1178]: info: Updating RAAT Signal Path
Jun 20 21:45:46 primo volumio[1178]: info: Updating RAAT Signal Path
Jun 20 21:45:47 primo volumio[1178]: info: Updating RAAT Signal Path
Jun 20 21:45:47 primo volumio[1178]: info: Updating RAAT Signal Path
Jun 20 21:45:47 primo volumio[1178]: info: Updating RAAT Signal Path
Jun 20 21:45:47 primo volumio[1178]: info: Updating RAAT Signal Path
Jun 20 21:45:47 primo volumio[1178]: info: Updating RAAT Signal Path
Jun 20 21:45:47 primo volumio[1178]: info: MCU Signalled Playback Active
Jun 20 21:45:47 primo volumio[1178]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 20 21:45:47 primo volumio[1178]: Error: certificate is not yet valid
Jun 20 21:45:47 primo volumio[1178]: at TLSSocket.onConnectSecure (node:_tls_wrap:1627:34)
Jun 20 21:45:47 primo volumio[1178]: at TLSSocket.emit (node:events:514:28)
Jun 20 21:45:47 primo volumio[1178]: at TLSSocket._finishInit (node:_tls_wrap:1038:8)
Jun 20 21:45:47 primo volumio[1178]: at ssl.onhandshakedone (node:_tls_wrap:824:12) {
Jun 20 21:45:47 primo volumio[1178]: code: 'CERT_NOT_YET_VALID'
Jun 20 21:45:47 primo volumio[1178]: }
Jun 20 21:45:47 primo volumio[1178]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 20 21:45:48 primo sudo[2532]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-06-20 21:44'
Jun 20 21:45:48 primo sudo[2532]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="8cb312d06575d36d3ce97b351d77ec5842e888d3"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="9938d7179e3b7c4e41f3e2d60c255985cff08fee"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="primo3"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Jun 16 09:14:15 UTC 2026"
VOLUMIO_VERSION="4.168"
VOLUMIO_HARDWARE="cm4"
VOLUMIO_DEVICENAME="CM4"
VOLUMIO_VENDOR_MODEL="Volumio Primo v3"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Primo v3"
VOLUMIO_HASH="bb42cf540c8325b41ef2eab40f364732"