-- Logs begin at Mon 2025-05-12 14:17:01 UTC, end at Tue 2025-05-13 14:04:12 UTC. --
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::ClearQueue
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::stop
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::setConsumeUpdateService undefined
May 13 14:03:10 volumio volumio[1142]: verbose: UNSET VOLATILE
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::stPlaybackTimer
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::updateTrackBlock
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::getTrackBlock
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::serviceStop
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::serviceStop
May 13 14:03:10 volumio volumio[1142]: info: ControllerMpd::stop
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand stop
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::clearPlayQueue
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::saveQueue
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::volumioPushQueue
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::addQueueItems
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::addQueueItems
May 13 14:03:10 volumio volumio[1142]: info: Adding Item to queue: music-library/NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty
May 13 14:03:10 volumio volumio[1142]: info: Exploding uri music-library/NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty in service mpd
May 13 14:03:10 volumio volumio[1142]: info: touch_display: Setting screensaver timeout to 120 seconds.
May 13 14:03:10 volumio volumio[1142]: info: sendMpdCommand stop took 275 milliseconds
May 13 14:03:10 volumio volumio[1142]: info:
May 13 14:03:10 volumio volumio[1142]: ---------------------------- MPD announces state update: player
May 13 14:03:10 volumio volumio[1142]: info: ControllerMpd::getState
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status
May 13 14:03:10 volumio volumio[1142]: info:
May 13 14:03:10 volumio volumio[1142]: ---------------------------- MPD announces state update: player
May 13 14:03:10 volumio volumio[1142]: info: ControllerMpd::getState
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status
May 13 14:03:10 volumio volumio[1142]: info:
May 13 14:03:10 volumio volumio[1142]: ---------------------------- MPD announces state update: player
May 13 14:03:10 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=Daya/Sit%20Still%2C%20Look%20Pretty/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FDaya%20-%20Sit%20Still%2C%20Look%20Pretty%2FTracks%2F01.%20Dare.flac&metadata=false
May 13 14:03:10 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/01. Dare.flac
May 13 14:03:10 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=Daya/Sit%20Still%2C%20Look%20Pretty/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FDaya%20-%20Sit%20Still%2C%20Look%20Pretty%2FTracks%2F02.%20Legendary.flac&metadata=false
May 13 14:03:10 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/02. Legendary.flac
May 13 14:03:10 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=Daya/Sit%20Still%2C%20Look%20Pretty/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FDaya%20-%20Sit%20Still%2C%20Look%20Pretty%2FTracks%2F03.%20I.C.Y.M.I..flac&metadata=false
May 13 14:03:10 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/03. I.C.Y.M.I..flac
May 13 14:03:10 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=Daya/Sit%20Still%2C%20Look%20Pretty/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FDaya%20-%20Sit%20Still%2C%20Look%20Pretty%2FTracks%2F04.%20Thirsty.flac&metadata=false
May 13 14:03:10 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/04. Thirsty.flac
May 13 14:03:10 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=Daya/Sit%20Still%2C%20Look%20Pretty/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FDaya%20-%20Sit%20Still%2C%20Look%20Pretty%2FTracks%2F05.%20Love%20of%20My%20Life.flac&metadata=false
May 13 14:03:10 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/05. Love of My Life.flac
May 13 14:03:10 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=Daya/Sit%20Still%2C%20Look%20Pretty/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FDaya%20-%20Sit%20Still%2C%20Look%20Pretty%2FTracks%2F06.%20Hide%20Away.flac&metadata=false
May 13 14:03:10 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/06. Hide Away.flac
May 13 14:03:10 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=Daya/Sit%20Still%2C%20Look%20Pretty/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FDaya%20-%20Sit%20Still%2C%20Look%20Pretty%2FTracks%2F07.%20Cool.flac&metadata=false
May 13 14:03:10 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/07. Cool.flac
May 13 14:03:10 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=Daya/Sit%20Still%2C%20Look%20Pretty/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FDaya%20-%20Sit%20Still%2C%20Look%20Pretty%2FTracks%2F08.%20Sit%20Still%2C%20Look%20Pretty(1).flac&metadata=false
May 13 14:03:10 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/08. Sit Still, Look Pretty(1).flac
May 13 14:03:10 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=Daya/Sit%20Still%2C%20Look%20Pretty/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FDaya%20-%20Sit%20Still%2C%20Look%20Pretty%2FTracks%2F08.%20Sit%20Still%2C%20Look%20Pretty.flac&metadata=false
May 13 14:03:10 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/08. Sit Still, Look Pretty.flac
May 13 14:03:10 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=Daya/Sit%20Still%2C%20Look%20Pretty/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FDaya%20-%20Sit%20Still%2C%20Look%20Pretty%2FTracks%2F09.%20Talk.flac&metadata=false
May 13 14:03:10 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/09. Talk.flac
May 13 14:03:10 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=Daya/Sit%20Still%2C%20Look%20Pretty/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FDaya%20-%20Sit%20Still%2C%20Look%20Pretty%2FTracks%2F10.%20U12.flac&metadata=false
May 13 14:03:10 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/10. U12.flac
May 13 14:03:10 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=Daya/Sit%20Still%2C%20Look%20Pretty/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FDaya%20-%20Sit%20Still%2C%20Look%20Pretty%2FTracks%2F11.%20Words.flac&metadata=false
May 13 14:03:10 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/11. Words.flac
May 13 14:03:10 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=Daya/Sit%20Still%2C%20Look%20Pretty/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FDaya%20-%20Sit%20Still%2C%20Look%20Pretty%2FTracks%2F12.%20Back%20to%20Me.flac&metadata=false
May 13 14:03:10 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/12. Back to Me.flac
May 13 14:03:10 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=Daya/Sit%20Still%2C%20Look%20Pretty/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FDaya%20-%20Sit%20Still%2C%20Look%20Pretty%2FTracks%2F13.%20Got%20the%20Feeling.flac&metadata=false
May 13 14:03:10 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/13. Got the Feeling.flac
May 13 14:03:10 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=Daya/Sit%20Still%2C%20Look%20Pretty/large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FDaya%20-%20Sit%20Still%2C%20Look%20Pretty%2FTracks%2F14.%20We%20Are.flac&metadata=false
May 13 14:03:10 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/14. We Are.flac
May 13 14:03:10 volumio volumio[1142]: info: ControllerMpd::getState
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::saveQueue
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::volumioPushQueue
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::updateTrackBlock
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::getTrackBlock
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::volumioPlay
May 13 14:03:10 volumio volumio[1142]: verbose: UNSET VOLATILE
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::play index 0
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::setConsumeUpdateService undefined
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::stop
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::setConsumeUpdateService undefined
May 13 14:03:10 volumio volumio[1142]: verbose: UNSET VOLATILE
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::play index undefined
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::setConsumeUpdateService undefined
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::startPlaybackTimer
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::clearAddPlayTracks NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/01. Dare.flac
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand stop
May 13 14:03:10 volumio volumio[1142]: info: sendMpdCommand status took 31 milliseconds
May 13 14:03:10 volumio volumio[1142]: info: sendMpdCommand status took 31 milliseconds
May 13 14:03:10 volumio volumio[1142]: info: sendMpdCommand status took 10 milliseconds
May 13 14:03:10 volumio volumio[1142]: info: sendMpdCommand stop took 2 milliseconds
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::parseState
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::parseState
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::parseState
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand clear
May 13 14:03:10 volumio volumio[1142]: info:
May 13 14:03:10 volumio volumio[1142]: ---------------------------- MPD announces system playlist update
May 13 14:03:10 volumio volumio[1142]: info: Ignoring MPD Status Update
May 13 14:03:10 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 13 14:03:10 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 13 14:03:10 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 13 14:03:10 volumio volumio[1142]: info: sendMpdCommand clear took 3 milliseconds
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand add "NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/01. Dare.flac"
May 13 14:03:10 volumio volumio[1142]: info: ControllerMpd::pushState
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::servicePushState
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:10 volumio volumio[1142]: 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":"Eva.Cassidy.-.[Imagine].专辑.(Flac).flac","artist":null,"album":null,"uri":"NAS/MyNAS/PCM/Eva Cassidy - Imagine/Tracks/Eva.Cassidy.-.[Imagine].专辑.(Flac).flac","trackType":"flac"}
May 13 14:03:10 volumio volumio[1142]: verbose: CURRENT POSITION 0
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::syncState stateService stop
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus stop
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:10 volumio volumio[1142]: info: No code
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:10 volumio volumio[1142]: info: ControllerMpd::pushState
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::servicePushState
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:10 volumio volumio[1142]: 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":"Eva.Cassidy.-.[Imagine].专辑.(Flac).flac","artist":null,"album":null,"uri":"NAS/MyNAS/PCM/Eva Cassidy - Imagine/Tracks/Eva.Cassidy.-.[Imagine].专辑.(Flac).flac","trackType":"flac"}
May 13 14:03:10 volumio volumio[1142]: verbose: CURRENT POSITION 0
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::syncState stateService stop
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus stop
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:10 volumio volumio[1142]: info: No code
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:10 volumio volumio[1142]: info: ControllerMpd::pushState
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::servicePushState
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:10 volumio volumio[1142]: 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":"Eva.Cassidy.-.[Imagine].专辑.(Flac).flac","artist":null,"album":null,"uri":"NAS/MyNAS/PCM/Eva Cassidy - Imagine/Tracks/Eva.Cassidy.-.[Imagine].专辑.(Flac).flac","trackType":"flac"}
May 13 14:03:10 volumio volumio[1142]: verbose: CURRENT POSITION 0
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::syncState stateService stop
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus stop
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:10 volumio volumio[1142]: info: No code
May 13 14:03:10 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:10 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:10 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:10 volumio volumio[1142]: info: ------------------------------ 61ms
May 13 14:03:10 volumio volumio[1142]: info: ------------------------------ 61ms
May 13 14:03:10 volumio volumio[1142]: info: ------------------------------ 57ms
May 13 14:03:10 volumio volumio[1142]: info:
May 13 14:03:10 volumio volumio[1142]: ---------------------------- MPD announces system playlist update
May 13 14:03:10 volumio volumio[1142]: info: Ignoring MPD Status Update
May 13 14:03:10 volumio volumio[1142]: info:
May 13 14:03:10 volumio volumio[1142]: ---------------------------- MPD announces system playlist update
May 13 14:03:10 volumio volumio[1142]: info: Ignoring MPD Status Update
May 13 14:03:10 volumio volumio[1142]: error: updateQueue error: null
May 13 14:03:10 volumio volumio[1142]: info:
May 13 14:03:10 volumio volumio[1142]: ---------------------------- MPD announces system playlist update
May 13 14:03:10 volumio volumio[1142]: info: Ignoring MPD Status Update
May 13 14:03:10 volumio volumio[1142]: info: ------------------------------ 50ms
May 13 14:03:10 volumio volumio[1142]: info: sendMpdCommand add "NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/01. Dare.flac" took 48 milliseconds
May 13 14:03:10 volumio volumio[1142]: info: ------------------------------ 11ms
May 13 14:03:10 volumio volumio[1142]: info: ------------------------------ 10ms
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand play
May 13 14:03:10 volumio volumio[1142]: info:
May 13 14:03:10 volumio volumio[1142]: ---------------------------- MPD announces system playlist update
May 13 14:03:10 volumio volumio[1142]: info: Ignoring MPD Status Update
May 13 14:03:10 volumio volumio[1142]: info:
May 13 14:03:10 volumio volumio[1142]: ---------------------------- MPD announces system playlist update
May 13 14:03:10 volumio volumio[1142]: info: Ignoring MPD Status Update
May 13 14:03:10 volumio volumio[1142]: info: ------------------------------ 14ms
May 13 14:03:10 volumio volumio[1142]: info: sendMpdCommand play took 11 milliseconds
May 13 14:03:10 volumio volumio[1142]: info: ------------------------------ 9ms
May 13 14:03:10 volumio volumio[1142]: info: ------------------------------ 7ms
May 13 14:03:10 volumio volumio[1142]: info:
May 13 14:03:10 volumio volumio[1142]: ---------------------------- MPD announces state update: player
May 13 14:03:10 volumio volumio[1142]: info: ControllerMpd::getState
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status
May 13 14:03:10 volumio volumio[1142]: info:
May 13 14:03:10 volumio volumio[1142]: ---------------------------- MPD announces state update: player
May 13 14:03:10 volumio volumio[1142]: info: ControllerMpd::getState
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status
May 13 14:03:10 volumio volumio[1142]: info:
May 13 14:03:10 volumio volumio[1142]: ---------------------------- MPD announces state update: player
May 13 14:03:10 volumio volumio[1142]: info: ControllerMpd::getState
May 13 14:03:10 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status
May 13 14:03:11 volumio volumio[1142]: info:
May 13 14:03:11 volumio volumio[1142]: ---------------------------- MPD announces state update: player
May 13 14:03:11 volumio volumio[1142]: info: sendMpdCommand status took 503 milliseconds
May 13 14:03:11 volumio volumio[1142]: info: sendMpdCommand status took 502 milliseconds
May 13 14:03:11 volumio volumio[1142]: info: sendMpdCommand status took 501 milliseconds
May 13 14:03:11 volumio volumio[1142]: info: ControllerMpd::getState
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::parseState
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::parseState
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::parseState
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 13 14:03:11 volumio volumio[1142]: info:
May 13 14:03:11 volumio volumio[1142]: ---------------------------- MPD announces state update: player
May 13 14:03:11 volumio volumio[1142]: info: ControllerMpd::getState
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status
May 13 14:03:11 volumio volumio[1142]: info:
May 13 14:03:11 volumio volumio[1142]: ---------------------------- MPD announces state update: player
May 13 14:03:11 volumio volumio[1142]: info: ControllerMpd::getState
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status
May 13 14:03:11 volumio volumio[1142]: info: sendMpdCommand status took 6 milliseconds
May 13 14:03:11 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 6 milliseconds
May 13 14:03:11 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 6 milliseconds
May 13 14:03:11 volumio volumio[1142]: info: sendMpdCommand status took 5 milliseconds
May 13 14:03:11 volumio volumio[1142]: info: sendMpdCommand status took 3 milliseconds
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::parseState
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::parseState
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::parseState
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 13 14:03:11 volumio volumio[1142]: info: ControllerMpd::pushState
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::servicePushState
May 13 14:03:11 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:11 volumio volumio[1142]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":209,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dare","artist":"Daya","album":"Sit Still, Look Pretty","uri":"NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/01. Dare.flac","trackType":"flac"}
May 13 14:03:11 volumio volumio[1142]: verbose: CURRENT POSITION 0
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::syncState stateService play
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus stop
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:11 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:11 volumio volumio[1142]: info: ControllerMpd::pushState
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::servicePushState
May 13 14:03:11 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:11 volumio volumio[1142]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34,"duration":209,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"Dare","artist":"Daya","album":"Sit Still, Look Pretty","uri":"NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/01. Dare.flac","trackType":"flac"}
May 13 14:03:11 volumio volumio[1142]: verbose: CURRENT POSITION 0
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::syncState stateService play
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus play
May 13 14:03:11 volumio volumio[1142]: info: Received an update from plugin. extracting info from payload
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:11 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:11 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:11 volumio volumio[1142]: info: ControllerMpd::pushState
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::servicePushState
May 13 14:03:11 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:11 volumio volumio[1142]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":209,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"413 Kbps","isStreaming":false,"title":"Dare","artist":"Daya","album":"Sit Still, Look Pretty","uri":"NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/01. Dare.flac","trackType":"flac"}
May 13 14:03:11 volumio volumio[1142]: verbose: CURRENT POSITION 0
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::syncState stateService play
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus play
May 13 14:03:11 volumio volumio[1142]: info: Received an update from plugin. extracting info from payload
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:11 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:11 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:11 volumio volumio[1142]: info: ------------------------------ 560ms
May 13 14:03:11 volumio volumio[1142]: info: ------------------------------ 560ms
May 13 14:03:11 volumio volumio[1142]: info: ------------------------------ 560ms
May 13 14:03:11 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 58 milliseconds
May 13 14:03:11 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 59 milliseconds
May 13 14:03:11 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 60 milliseconds
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo
May 13 14:03:11 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo
May 13 14:03:11 volumio volumio[1142]: info: ControllerMpd::pushState
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::servicePushState
May 13 14:03:11 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:11 volumio volumio[1142]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1005,"duration":209,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1223 Kbps","isStreaming":false,"title":"Dare","artist":"Daya","album":"Sit Still, Look Pretty","uri":"NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/01. Dare.flac","trackType":"flac"}
May 13 14:03:11 volumio volumio[1142]: verbose: CURRENT POSITION 0
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::syncState stateService play
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus play
May 13 14:03:11 volumio volumio[1142]: info: Received an update from plugin. extracting info from payload
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:11 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:11 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:11 volumio volumio[1142]: info: ControllerMpd::pushState
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::servicePushState
May 13 14:03:11 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:11 volumio volumio[1142]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1005,"duration":209,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1208 Kbps","isStreaming":false,"title":"Dare","artist":"Daya","album":"Sit Still, Look Pretty","uri":"NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/01. Dare.flac","trackType":"flac"}
May 13 14:03:11 volumio volumio[1142]: verbose: CURRENT POSITION 0
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::syncState stateService play
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus play
May 13 14:03:11 volumio volumio[1142]: info: Received an update from plugin. extracting info from payload
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:11 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:11 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:11 volumio volumio[1142]: info: ControllerMpd::pushState
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::servicePushState
May 13 14:03:11 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:11 volumio volumio[1142]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1005,"duration":209,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1208 Kbps","isStreaming":false,"title":"Dare","artist":"Daya","album":"Sit Still, Look Pretty","uri":"NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/01. Dare.flac","trackType":"flac"}
May 13 14:03:11 volumio volumio[1142]: verbose: CURRENT POSITION 0
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::syncState stateService play
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus play
May 13 14:03:11 volumio volumio[1142]: info: Received an update from plugin. extracting info from payload
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:11 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:11 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:11 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:11 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:11 volumio volumio[1142]: info: ------------------------------ 138ms
May 13 14:03:11 volumio volumio[1142]: info: ------------------------------ 136ms
May 13 14:03:11 volumio volumio[1142]: info: ------------------------------ 135ms
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::ClearQueue
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::stop
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::setConsumeUpdateService undefined
May 13 14:03:22 volumio volumio[1142]: verbose: UNSET VOLATILE
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::stPlaybackTimer
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::updateTrackBlock
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrackBlock
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::serviceStop
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::serviceStop
May 13 14:03:22 volumio volumio[1142]: info: ControllerMpd::stop
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand stop
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::clearPlayQueue
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::saveQueue
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioPushQueue
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::addQueueItems
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::addQueueItems
May 13 14:03:22 volumio volumio[1142]: info: Adding Item to queue: music-library/NAS/MyNAS/PCM/Eva Cassidy - Songbird
May 13 14:03:22 volumio volumio[1142]: info: Exploding uri music-library/NAS/MyNAS/PCM/Eva Cassidy - Songbird in service mpd
May 13 14:03:22 volumio volumio[1142]: info:
May 13 14:03:22 volumio volumio[1142]: ---------------------------- MPD announces state update: player
May 13 14:03:22 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FEva%20Cassidy%20-%20Songbird%2FTracks%2F01%20Fields%20of%20Gold.flac&metadata=false
May 13 14:03:22 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Eva Cassidy - Songbird/Tracks/01 Fields of Gold.flac
May 13 14:03:22 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FEva%20Cassidy%20-%20Songbird%2FTracks%2F02%20Wade%20in%20the%20Water%20.flac&metadata=false
May 13 14:03:22 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Eva Cassidy - Songbird/Tracks/02 Wade in the Water .flac
May 13 14:03:22 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FEva%20Cassidy%20-%20Songbird%2FTracks%2F03%20Autumn%20Leaves.flac&metadata=false
May 13 14:03:22 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Eva Cassidy - Songbird/Tracks/03 Autumn Leaves.flac
May 13 14:03:22 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FEva%20Cassidy%20-%20Songbird%2FTracks%2F04%20Wayfaring%20Stranger.flac&metadata=false
May 13 14:03:22 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Eva Cassidy - Songbird/Tracks/04 Wayfaring Stranger.flac
May 13 14:03:22 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FEva%20Cassidy%20-%20Songbird%2FTracks%2F05%20Songbird.flac&metadata=false
May 13 14:03:22 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Eva Cassidy - Songbird/Tracks/05 Songbird.flac
May 13 14:03:22 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FEva%20Cassidy%20-%20Songbird%2FTracks%2F06%20Time%20Is%20A%20Healer.flac&metadata=false
May 13 14:03:22 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Eva Cassidy - Songbird/Tracks/06 Time Is A Healer.flac
May 13 14:03:22 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FEva%20Cassidy%20-%20Songbird%2FTracks%2F07%20I%20Know%20You%20By%20Heart.flac&metadata=false
May 13 14:03:22 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Eva Cassidy - Songbird/Tracks/07 I Know You By Heart.flac
May 13 14:03:22 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FEva%20Cassidy%20-%20Songbird%2FTracks%2F08%20People%20Get%20Ready.flac&metadata=false
May 13 14:03:22 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Eva Cassidy - Songbird/Tracks/08 People Get Ready.flac
May 13 14:03:22 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FEva%20Cassidy%20-%20Songbird%2FTracks%2F09%20Oh%2C%20Had%20I%20A%20Golden%20Thread.flac&metadata=false
May 13 14:03:22 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Eva Cassidy - Songbird/Tracks/09 Oh, Had I A Golden Thread.flac
May 13 14:03:22 volumio volumio[1142]: info: ALBUMART /albumart?cacheid=89&web=//large&path=%2Fmnt%2FNAS%2FMyNAS%2FPCM%2FEva%20Cassidy%20-%20Songbird%2FTracks%2F10%20Over%20the%20Rainbow.flac&metadata=false
May 13 14:03:22 volumio volumio[1142]: info: URI /mnt/NAS/MyNAS/PCM/Eva Cassidy - Songbird/Tracks/10 Over the Rainbow.flac
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand stop took 127 milliseconds
May 13 14:03:22 volumio volumio[1142]: info: ControllerMpd::getState
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::saveQueue
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioPushQueue
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::updateTrackBlock
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrackBlock
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioPlay
May 13 14:03:22 volumio volumio[1142]: verbose: UNSET VOLATILE
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::play index 0
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::setConsumeUpdateService undefined
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::stop
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::setConsumeUpdateService undefined
May 13 14:03:22 volumio volumio[1142]: verbose: UNSET VOLATILE
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::play index undefined
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::setConsumeUpdateService undefined
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::startPlaybackTimer
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::clearAddPlayTracks NAS/MyNAS/PCM/Eva Cassidy - Songbird/Tracks/01 Fields of Gold.flac
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand stop
May 13 14:03:22 volumio volumio[1142]: info:
May 13 14:03:22 volumio volumio[1142]: ---------------------------- MPD announces state update: player
May 13 14:03:22 volumio volumio[1142]: info: ControllerMpd::getState
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status
May 13 14:03:22 volumio volumio[1142]: info:
May 13 14:03:22 volumio volumio[1142]: ---------------------------- MPD announces state update: player
May 13 14:03:22 volumio volumio[1142]: info: ControllerMpd::getState
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand status took 19 milliseconds
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand stop took 8 milliseconds
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand status took 7 milliseconds
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::parseState
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand clear
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::parseState
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::parseState
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 13 14:03:22 volumio volumio[1142]: info: touch_display: Setting screensaver timeout to 120 seconds.
May 13 14:03:22 volumio volumio[1142]: info:
May 13 14:03:22 volumio volumio[1142]: ---------------------------- MPD announces system playlist update
May 13 14:03:22 volumio volumio[1142]: info: Ignoring MPD Status Update
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 11 milliseconds
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand clear took 11 milliseconds
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 11 milliseconds
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 10 milliseconds
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand add "NAS/MyNAS/PCM/Eva Cassidy - Songbird/Tracks/01 Fields of Gold.flac"
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo
May 13 14:03:22 volumio volumio[1142]: info: ControllerMpd::pushState
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::servicePushState
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: 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":"Dare","artist":"Daya","album":"Sit Still, Look Pretty","uri":"NAS/MyNAS/PCM/Daya - Sit Still, Look Pretty/Tracks/01. Dare.flac","trackType":"flac"}
May 13 14:03:22 volumio volumio[1142]: verbose: CURRENT POSITION 0
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::syncState stateService stop
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus stop
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:22 volumio volumio[1142]: info: No code
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:22 volumio volumio[1142]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 13 14:03:22 volumio volumio[1142]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 13 14:03:22 volumio volumio[1142]: info: ------------------------------ 66ms
May 13 14:03:22 volumio volumio[1142]: info: ------------------------------ 38ms
May 13 14:03:22 volumio volumio[1142]: info: ------------------------------ 37ms
May 13 14:03:22 volumio volumio[1142]: info:
May 13 14:03:22 volumio volumio[1142]: ---------------------------- MPD announces system playlist update
May 13 14:03:22 volumio volumio[1142]: info: Ignoring MPD Status Update
May 13 14:03:22 volumio volumio[1142]: info:
May 13 14:03:22 volumio volumio[1142]: ---------------------------- MPD announces system playlist update
May 13 14:03:22 volumio volumio[1142]: info: Ignoring MPD Status Update
May 13 14:03:22 volumio volumio[1142]: error: updateQueue error: null
May 13 14:03:22 volumio volumio[1142]: info:
May 13 14:03:22 volumio volumio[1142]: ---------------------------- MPD announces system playlist update
May 13 14:03:22 volumio volumio[1142]: info: Ignoring MPD Status Update
May 13 14:03:22 volumio volumio[1142]: info: ------------------------------ 26ms
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand add "NAS/MyNAS/PCM/Eva Cassidy - Songbird/Tracks/01 Fields of Gold.flac" took 24 milliseconds
May 13 14:03:22 volumio volumio[1142]: info: ------------------------------ 6ms
May 13 14:03:22 volumio volumio[1142]: info: ------------------------------ 4ms
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand play
May 13 14:03:22 volumio volumio[1142]: info:
May 13 14:03:22 volumio volumio[1142]: ---------------------------- MPD announces system playlist update
May 13 14:03:22 volumio volumio[1142]: info: Ignoring MPD Status Update
May 13 14:03:22 volumio volumio[1142]: info:
May 13 14:03:22 volumio volumio[1142]: ---------------------------- MPD announces system playlist update
May 13 14:03:22 volumio volumio[1142]: info: Ignoring MPD Status Update
May 13 14:03:22 volumio volumio[1142]: info:
May 13 14:03:22 volumio volumio[1142]: ---------------------------- MPD announces state update: player
May 13 14:03:22 volumio volumio[1142]: info: ------------------------------ 10ms
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand play took 8 milliseconds
May 13 14:03:22 volumio volumio[1142]: info: ControllerMpd::getState
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status
May 13 14:03:22 volumio volumio[1142]: info: ------------------------------ 8ms
May 13 14:03:22 volumio volumio[1142]: info: ------------------------------ 6ms
May 13 14:03:22 volumio volumio[1142]: info:
May 13 14:03:22 volumio volumio[1142]: ---------------------------- MPD announces state update: player
May 13 14:03:22 volumio volumio[1142]: info: ControllerMpd::getState
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status
May 13 14:03:22 volumio volumio[1142]: info:
May 13 14:03:22 volumio volumio[1142]: ---------------------------- MPD announces state update: player
May 13 14:03:22 volumio volumio[1142]: info: ControllerMpd::getState
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status
May 13 14:03:22 volumio volumio[1142]: info:
May 13 14:03:22 volumio volumio[1142]: ---------------------------- MPD announces state update: player
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand status took 435 milliseconds
May 13 14:03:22 volumio volumio[1142]: info: ControllerMpd::getState
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand status took 434 milliseconds
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand status took 433 milliseconds
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::parseState
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::parseState
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::parseState
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 13 14:03:22 volumio volumio[1142]: info:
May 13 14:03:22 volumio volumio[1142]: ---------------------------- MPD announces state update: player
May 13 14:03:22 volumio volumio[1142]: info: ControllerMpd::getState
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status
May 13 14:03:22 volumio volumio[1142]: info:
May 13 14:03:22 volumio volumio[1142]: ---------------------------- MPD announces state update: player
May 13 14:03:22 volumio volumio[1142]: info: ControllerMpd::getState
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand status
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand status took 5 milliseconds
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 4 milliseconds
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 4 milliseconds
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 4 milliseconds
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand status took 3 milliseconds
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand status took 2 milliseconds
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::parseState
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::parseState
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::parseState
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 13 14:03:22 volumio volumio[1142]: info: ControllerMpd::pushState
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::servicePushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":284,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 Fields of Gold.flac","artist":null,"album":null,"uri":"NAS/MyNAS/PCM/Eva Cassidy - Songbird/Tracks/01 Fields of Gold.flac","trackType":"flac"}
May 13 14:03:22 volumio volumio[1142]: verbose: CURRENT POSITION 0
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::syncState stateService play
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus stop
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:22 volumio volumio[1142]: info: ControllerMpd::pushState
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::servicePushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: verbose: STATE SERVICE {"status":"play","position":0,"seek":10,"duration":284,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 Fields of Gold.flac","artist":null,"album":null,"uri":"NAS/MyNAS/PCM/Eva Cassidy - Songbird/Tracks/01 Fields of Gold.flac","trackType":"flac"}
May 13 14:03:22 volumio volumio[1142]: verbose: CURRENT POSITION 0
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::syncState stateService play
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus play
May 13 14:03:22 volumio volumio[1142]: info: Received an update from plugin. extracting info from payload
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:22 volumio volumio[1142]: info: ControllerMpd::pushState
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::servicePushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: verbose: STATE SERVICE {"status":"play","position":0,"seek":10,"duration":284,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 Fields of Gold.flac","artist":null,"album":null,"uri":"NAS/MyNAS/PCM/Eva Cassidy - Songbird/Tracks/01 Fields of Gold.flac","trackType":"flac"}
May 13 14:03:22 volumio volumio[1142]: verbose: CURRENT POSITION 0
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::syncState stateService play
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus play
May 13 14:03:22 volumio volumio[1142]: info: Received an update from plugin. extracting info from payload
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:22 volumio volumio[1142]: info: ------------------------------ 474ms
May 13 14:03:22 volumio volumio[1142]: info: ------------------------------ 472ms
May 13 14:03:22 volumio volumio[1142]: info: ------------------------------ 473ms
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 37 milliseconds
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 36 milliseconds
May 13 14:03:22 volumio volumio[1142]: info: sendMpdCommand playlistinfo took 37 milliseconds
May 13 14:03:22 volumio volumio[1142]: verbose: ControllerMpd::parseTrackInfo
May 13 14:03:22 volumio volumio[1142]: info: ControllerMpd::pushState
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::servicePushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":284,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3 Kbps","isStreaming":false,"title":"01 Fields of Gold.flac","artist":null,"album":null,"uri":"NAS/MyNAS/PCM/Eva Cassidy - Songbird/Tracks/01 Fields of Gold.flac","trackType":"flac"}
May 13 14:03:22 volumio volumio[1142]: verbose: CURRENT POSITION 0
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::syncState stateService play
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus play
May 13 14:03:22 volumio volumio[1142]: info: Received an update from plugin. extracting info from payload
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:22 volumio volumio[1142]: info: ControllerMpd::pushState
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::servicePushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":284,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3 Kbps","isStreaming":false,"title":"01 Fields of Gold.flac","artist":null,"album":null,"uri":"NAS/MyNAS/PCM/Eva Cassidy - Songbird/Tracks/01 Fields of Gold.flac","trackType":"flac"}
May 13 14:03:22 volumio volumio[1142]: verbose: CURRENT POSITION 0
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::syncState stateService play
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus play
May 13 14:03:22 volumio volumio[1142]: info: Received an update from plugin. extracting info from payload
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:22 volumio volumio[1142]: info: ControllerMpd::pushState
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::servicePushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: verbose: STATE SERVICE {"status":"play","position":0,"seek":755,"duration":284,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3 Kbps","isStreaming":false,"title":"01 Fields of Gold.flac","artist":null,"album":null,"uri":"NAS/MyNAS/PCM/Eva Cassidy - Songbird/Tracks/01 Fields of Gold.flac","trackType":"flac"}
May 13 14:03:22 volumio volumio[1142]: verbose: CURRENT POSITION 0
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::syncState stateService play
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::syncState currentStatus play
May 13 14:03:22 volumio volumio[1142]: info: Received an update from plugin. extracting info from payload
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:22 volumio volumio[1142]: info: CoreStateMachine::pushState
May 13 14:03:22 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:03:22 volumio volumio[1142]: info: CoreCommandRouter::volumioPushState
May 13 14:03:22 volumio volumio[1142]: info: ------------------------------ 84ms
May 13 14:03:22 volumio volumio[1142]: info: ------------------------------ 81ms
May 13 14:03:22 volumio volumio[1142]: info: ------------------------------ 82ms
May 13 14:03:34 volumio volumio[1142]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 9
May 13 14:03:34 volumio volumio[1142]: info: CoreCommandRouter::volumioGetState
May 13 14:03:34 volumio volumio[1142]: info: CorePlayQueue::getTrack 0
May 13 14:04:12 volumio volumio[1142]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 13 14:04:12 volumio volumio[1142]: Error: Client network socket disconnected before secure TLS connection was established
May 13 14:04:12 volumio volumio[1142]: at connResetException (internal/errors.js:607:14)
May 13 14:04:12 volumio volumio[1142]: at TLSSocket.onConnectEnd (_tls_wrap.js:1544:19)
May 13 14:04:12 volumio volumio[1142]: at TLSSocket.emit (events.js:327:22)
May 13 14:04:12 volumio volumio[1142]: at endReadableNT (internal/streams/readable.js:1327:12)
May 13 14:04:12 volumio volumio[1142]: at processTicksAndRejections (internal/process/task_queues.js:80:21) {
May 13 14:04:12 volumio volumio[1142]: code: 'ECONNRESET',
May 13 14:04:12 volumio volumio[1142]: path: null,
May 13 14:04:12 volumio volumio[1142]: host: 'lastfm.freetls.fastly.net',
May 13 14:04:12 volumio volumio[1142]: port: 443,
May 13 14:04:12 volumio volumio[1142]: localAddress: undefined
May 13 14:04:12 volumio volumio[1142]: }
May 13 14:04:12 volumio volumio[1142]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 13 14:04:12 volumio sudo[2701]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-13 14:03
May 13 14:04:12 volumio sudo[2701]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
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="1c5fa5a8788b087ca429be9d10851b25c5cc4f5b"
VOLUMIO_FE_VERSION="e5ce74e254a237ac98580c4437c4ed223c7d5cd9"
VOLUMIO_FE3_VERSION="a86adf3c7ed2d6c50d9bca768f58ab2f56832dc1"
VOLUMIO_BE_VERSION="c8882d89d3d4e0a1571e0dc9701741128f5a1656"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 31 Mar 2022 02:51:41 PM CEST"
VOLUMIO_VERSION="3.251"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="e83cc5fcd68eb3ee4105ab0b8b3779ea"