-- Logs begin at Sun 2025-12-07 07:25:37 UTC, end at Sun 2025-12-07 08:05:53 UTC. --
Dec 07 08:04:15 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Dec 07 08:04:15 volumio volumio[4739]: info: CURURI: music-library/USB/EA86-55F0/LOVE SONG
Dec 07 08:04:27 volumio volumio[4739]: info: CoreCommandRouter::volumioPlay
Dec 07 08:04:27 volumio volumio[4739]: UNSET VOLATILE
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::play index 3
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::stop
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 07 08:04:27 volumio volumio[4739]: UNSET VOLATILE
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::stPlaybackTimer
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::updateTrackBlock
Dec 07 08:04:27 volumio volumio[4739]: info: CorePlayQueue::getTrackBlock
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:27 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:27 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:27 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::serviceStop
Dec 07 08:04:27 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:27 volumio volumio[4739]: info: CoreCommandRouter::serviceStop
Dec 07 08:04:27 volumio volumio[4739]: info: ControllerMpd::stop
Dec 07 08:04:27 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand stop
Dec 07 08:04:27 volumio volumio[4739]: info:
Dec 07 08:04:27 volumio volumio[4739]: ---------------------------- MPD announces state update: player
Dec 07 08:04:27 volumio volumio[4739]: info: ControllerMpd::getState
Dec 07 08:04:27 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand status
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::play index undefined
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 07 08:04:27 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::startPlaybackTimer
Dec 07 08:04:27 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:27 volumio volumio[4739]: verbose: ControllerMpd::clearAddPlayTracks USB/EA86-55F0/LOVE SONG/All This Time - Tiffany.mp3
Dec 07 08:04:27 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand stop
Dec 07 08:04:27 volumio volumio[4739]: verbose: ControllerMpd::parseState
Dec 07 08:04:27 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 07 08:04:27 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand clear
Dec 07 08:04:27 volumio volumio[4739]: info:
Dec 07 08:04:27 volumio volumio[4739]: ---------------------------- MPD announces system playlist update
Dec 07 08:04:27 volumio volumio[4739]: info: Ignoring MPD Status Update
Dec 07 08:04:27 volumio volumio[4739]: verbose: ControllerMpd::parseTrackInfo
Dec 07 08:04:27 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand add "USB/EA86-55F0/LOVE SONG/All This Time - Tiffany.mp3"
Dec 07 08:04:27 volumio volumio[4739]: info: ControllerMpd::pushState
Dec 07 08:04:27 volumio volumio[4739]: info: CoreCommandRouter::servicePushState
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:27 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:27 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:27 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:27 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:27 volumio volumio[4739]: 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":"All This Time","artist":"Tiffany","album":null,"uri":"USB/EA86-55F0/LOVE SONG/All This Time - Tiffany.mp3","trackType":"mp3"}
Dec 07 08:04:27 volumio volumio[4739]: verbose: CURRENT POSITION 3
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::syncState stateService stop
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::syncState currentStatus stop
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:27 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:27 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:27 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:27 volumio volumio[4739]: info: No code
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:27 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:27 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:27 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:27 volumio volumio[4739]: info: ------------------------------ 63ms
Dec 07 08:04:27 volumio volumio[4739]: error: updateQueue error: null
Dec 07 08:04:27 volumio volumio[4739]: info:
Dec 07 08:04:27 volumio volumio[4739]: ---------------------------- MPD announces system playlist update
Dec 07 08:04:27 volumio volumio[4739]: info: Ignoring MPD Status Update
Dec 07 08:04:27 volumio volumio[4739]: info: ------------------------------ 43ms
Dec 07 08:04:27 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand play
Dec 07 08:04:27 volumio volumio[4739]: info:
Dec 07 08:04:27 volumio volumio[4739]: ---------------------------- MPD announces state update: player
Dec 07 08:04:27 volumio volumio[4739]: info: ------------------------------ 19ms
Dec 07 08:04:27 volumio volumio[4739]: info: ControllerMpd::getState
Dec 07 08:04:27 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand status
Dec 07 08:04:27 volumio volumio[4739]: info:
Dec 07 08:04:27 volumio volumio[4739]: ---------------------------- MPD announces state update: player
Dec 07 08:04:27 volumio volumio[4739]: info: ControllerMpd::getState
Dec 07 08:04:27 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand status
Dec 07 08:04:27 volumio volumio[4739]: verbose: ControllerMpd::parseState
Dec 07 08:04:27 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 07 08:04:27 volumio volumio[4739]: verbose: ControllerMpd::parseState
Dec 07 08:04:27 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 07 08:04:27 volumio volumio[4739]: verbose: ControllerMpd::parseTrackInfo
Dec 07 08:04:27 volumio volumio[4739]: info: ControllerMpd::pushState
Dec 07 08:04:27 volumio volumio[4739]: info: CoreCommandRouter::servicePushState
Dec 07 08:04:27 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:27 volumio volumio[4739]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":261,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"All This Time","artist":"Tiffany","album":null,"uri":"USB/EA86-55F0/LOVE SONG/All This Time - Tiffany.mp3","trackType":"mp3"}
Dec 07 08:04:27 volumio volumio[4739]: verbose: CURRENT POSITION 3
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::syncState stateService play
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::syncState currentStatus stop
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:27 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:27 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:27 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:27 volumio volumio[4739]: info: ------------------------------ 26ms
Dec 07 08:04:27 volumio volumio[4739]: verbose: ControllerMpd::parseTrackInfo
Dec 07 08:04:27 volumio volumio[4739]: info: ControllerMpd::pushState
Dec 07 08:04:27 volumio volumio[4739]: info: CoreCommandRouter::servicePushState
Dec 07 08:04:27 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:27 volumio volumio[4739]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":261,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"All This Time","artist":"Tiffany","album":null,"uri":"USB/EA86-55F0/LOVE SONG/All This Time - Tiffany.mp3","trackType":"mp3"}
Dec 07 08:04:27 volumio volumio[4739]: verbose: CURRENT POSITION 3
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::syncState stateService play
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::syncState currentStatus play
Dec 07 08:04:27 volumio volumio[4739]: info: Received an update from plugin. extracting info from payload
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:27 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:27 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:27 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:27 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:27 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:27 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:27 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:27 volumio volumio[4739]: info: ------------------------------ 44ms
Dec 07 08:04:31 volumio volumio[4739]: info: CoreCommandRouter::volumioPlay
Dec 07 08:04:31 volumio volumio[4739]: UNSET VOLATILE
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::play index 3
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::stop
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 07 08:04:31 volumio volumio[4739]: UNSET VOLATILE
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::stPlaybackTimer
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::updateTrackBlock
Dec 07 08:04:31 volumio volumio[4739]: info: CorePlayQueue::getTrackBlock
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:31 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:31 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:31 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::serviceStop
Dec 07 08:04:31 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:31 volumio volumio[4739]: info: CoreCommandRouter::serviceStop
Dec 07 08:04:31 volumio volumio[4739]: info: ControllerMpd::stop
Dec 07 08:04:31 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand stop
Dec 07 08:04:31 volumio volumio[4739]: info:
Dec 07 08:04:31 volumio volumio[4739]: ---------------------------- MPD announces state update: player
Dec 07 08:04:31 volumio volumio[4739]: info: ControllerMpd::getState
Dec 07 08:04:31 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand status
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::play index undefined
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 07 08:04:31 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::startPlaybackTimer
Dec 07 08:04:31 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:31 volumio volumio[4739]: verbose: ControllerMpd::clearAddPlayTracks USB/EA86-55F0/LOVE SONG/All This Time - Tiffany.mp3
Dec 07 08:04:31 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand stop
Dec 07 08:04:31 volumio volumio[4739]: verbose: ControllerMpd::parseState
Dec 07 08:04:31 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 07 08:04:31 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand clear
Dec 07 08:04:31 volumio volumio[4739]: info:
Dec 07 08:04:31 volumio volumio[4739]: ---------------------------- MPD announces system playlist update
Dec 07 08:04:31 volumio volumio[4739]: info: Ignoring MPD Status Update
Dec 07 08:04:31 volumio volumio[4739]: verbose: ControllerMpd::parseTrackInfo
Dec 07 08:04:31 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand add "USB/EA86-55F0/LOVE SONG/All This Time - Tiffany.mp3"
Dec 07 08:04:31 volumio volumio[4739]: info: ControllerMpd::pushState
Dec 07 08:04:31 volumio volumio[4739]: info: CoreCommandRouter::servicePushState
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:31 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:31 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:31 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:31 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:31 volumio volumio[4739]: 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":"All This Time","artist":"Tiffany","album":null,"uri":"USB/EA86-55F0/LOVE SONG/All This Time - Tiffany.mp3","trackType":"mp3"}
Dec 07 08:04:31 volumio volumio[4739]: verbose: CURRENT POSITION 3
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::syncState stateService stop
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::syncState currentStatus stop
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:31 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:31 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:31 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:31 volumio volumio[4739]: info: No code
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:31 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:31 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:31 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:31 volumio volumio[4739]: info: ------------------------------ 47ms
Dec 07 08:04:31 volumio volumio[4739]: error: updateQueue error: null
Dec 07 08:04:31 volumio volumio[4739]: info:
Dec 07 08:04:31 volumio volumio[4739]: ---------------------------- MPD announces system playlist update
Dec 07 08:04:31 volumio volumio[4739]: info: Ignoring MPD Status Update
Dec 07 08:04:31 volumio volumio[4739]: info: ------------------------------ 34ms
Dec 07 08:04:31 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand play
Dec 07 08:04:31 volumio volumio[4739]: info:
Dec 07 08:04:31 volumio volumio[4739]: ---------------------------- MPD announces state update: player
Dec 07 08:04:31 volumio volumio[4739]: info: ------------------------------ 19ms
Dec 07 08:04:31 volumio volumio[4739]: info: ControllerMpd::getState
Dec 07 08:04:31 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand status
Dec 07 08:04:31 volumio volumio[4739]: info:
Dec 07 08:04:31 volumio volumio[4739]: ---------------------------- MPD announces state update: player
Dec 07 08:04:31 volumio volumio[4739]: info: ControllerMpd::getState
Dec 07 08:04:31 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand status
Dec 07 08:04:31 volumio volumio[4739]: verbose: ControllerMpd::parseState
Dec 07 08:04:31 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 07 08:04:31 volumio volumio[4739]: verbose: ControllerMpd::parseState
Dec 07 08:04:31 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 07 08:04:31 volumio volumio[4739]: verbose: ControllerMpd::parseTrackInfo
Dec 07 08:04:31 volumio volumio[4739]: info: ControllerMpd::pushState
Dec 07 08:04:31 volumio volumio[4739]: info: CoreCommandRouter::servicePushState
Dec 07 08:04:31 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:31 volumio volumio[4739]: verbose: STATE SERVICE {"status":"play","position":0,"seek":181,"duration":261,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"All This Time","artist":"Tiffany","album":null,"uri":"USB/EA86-55F0/LOVE SONG/All This Time - Tiffany.mp3","trackType":"mp3"}
Dec 07 08:04:31 volumio volumio[4739]: verbose: CURRENT POSITION 3
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::syncState stateService play
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::syncState currentStatus stop
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:31 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:31 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:31 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:31 volumio volumio[4739]: info: ------------------------------ 28ms
Dec 07 08:04:31 volumio volumio[4739]: verbose: ControllerMpd::parseTrackInfo
Dec 07 08:04:31 volumio volumio[4739]: info: ControllerMpd::pushState
Dec 07 08:04:31 volumio volumio[4739]: info: CoreCommandRouter::servicePushState
Dec 07 08:04:31 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:31 volumio volumio[4739]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":261,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"All This Time","artist":"Tiffany","album":null,"uri":"USB/EA86-55F0/LOVE SONG/All This Time - Tiffany.mp3","trackType":"mp3"}
Dec 07 08:04:31 volumio volumio[4739]: verbose: CURRENT POSITION 3
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::syncState stateService play
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::syncState currentStatus play
Dec 07 08:04:31 volumio volumio[4739]: info: Received an update from plugin. extracting info from payload
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:31 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:31 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:31 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:31 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:31 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:31 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:31 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:31 volumio volumio[4739]: info: ------------------------------ 46ms
Dec 07 08:04:48 volumio volumio[4739]: info: CoreCommandRouter::volumioNext
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::next
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::stop
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 07 08:04:48 volumio volumio[4739]: UNSET VOLATILE
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::stPlaybackTimer
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::updateTrackBlock
Dec 07 08:04:48 volumio volumio[4739]: info: CorePlayQueue::getTrackBlock
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:48 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:48 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:48 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::serviceStop
Dec 07 08:04:48 volumio volumio[4739]: info: CorePlayQueue::getTrack 3
Dec 07 08:04:48 volumio volumio[4739]: info: CoreCommandRouter::serviceStop
Dec 07 08:04:48 volumio volumio[4739]: info: ControllerMpd::stop
Dec 07 08:04:48 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand stop
Dec 07 08:04:48 volumio volumio[4739]: info:
Dec 07 08:04:48 volumio volumio[4739]: ---------------------------- MPD announces state update: player
Dec 07 08:04:48 volumio volumio[4739]: info: ControllerMpd::getState
Dec 07 08:04:48 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand status
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::play index undefined
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 07 08:04:48 volumio volumio[4739]: info: CorePlayQueue::getTrack 4
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::startPlaybackTimer
Dec 07 08:04:48 volumio volumio[4739]: info: CorePlayQueue::getTrack 4
Dec 07 08:04:48 volumio volumio[4739]: verbose: ControllerMpd::clearAddPlayTracks USB/EA86-55F0/LOVE SONG/arthur time - christopher cross.mp3
Dec 07 08:04:48 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand stop
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::updateTrackBlock
Dec 07 08:04:48 volumio volumio[4739]: info: CorePlayQueue::getTrackBlock
Dec 07 08:04:48 volumio volumio[4739]: verbose: ControllerMpd::parseState
Dec 07 08:04:48 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 07 08:04:48 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand clear
Dec 07 08:04:48 volumio volumio[4739]: info:
Dec 07 08:04:48 volumio volumio[4739]: ---------------------------- MPD announces system playlist update
Dec 07 08:04:48 volumio volumio[4739]: info: Ignoring MPD Status Update
Dec 07 08:04:48 volumio volumio[4739]: verbose: ControllerMpd::parseTrackInfo
Dec 07 08:04:48 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand add "USB/EA86-55F0/LOVE SONG/arthur time - christopher cross.mp3"
Dec 07 08:04:48 volumio volumio[4739]: info: ControllerMpd::pushState
Dec 07 08:04:48 volumio volumio[4739]: info: CoreCommandRouter::servicePushState
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:48 volumio volumio[4739]: info: CorePlayQueue::getTrack 4
Dec 07 08:04:48 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:48 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:48 volumio volumio[4739]: info: CorePlayQueue::getTrack 4
Dec 07 08:04:48 volumio volumio[4739]: 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":"All This Time","artist":"Tiffany","album":null,"uri":"USB/EA86-55F0/LOVE SONG/All This Time - Tiffany.mp3","trackType":"mp3"}
Dec 07 08:04:48 volumio volumio[4739]: verbose: CURRENT POSITION 4
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::syncState stateService stop
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::syncState currentStatus stop
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:48 volumio volumio[4739]: info: CorePlayQueue::getTrack 4
Dec 07 08:04:48 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:48 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:48 volumio volumio[4739]: info: No code
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:48 volumio volumio[4739]: info: CorePlayQueue::getTrack 4
Dec 07 08:04:48 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:48 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:48 volumio volumio[4739]: info: ------------------------------ 55ms
Dec 07 08:04:48 volumio volumio[4739]: error: updateQueue error: null
Dec 07 08:04:48 volumio volumio[4739]: info:
Dec 07 08:04:48 volumio volumio[4739]: ---------------------------- MPD announces system playlist update
Dec 07 08:04:48 volumio volumio[4739]: info: Ignoring MPD Status Update
Dec 07 08:04:48 volumio volumio[4739]: info: ------------------------------ 41ms
Dec 07 08:04:48 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand play
Dec 07 08:04:48 volumio volumio[4739]: info:
Dec 07 08:04:48 volumio volumio[4739]: ---------------------------- MPD announces state update: player
Dec 07 08:04:48 volumio volumio[4739]: info: ------------------------------ 18ms
Dec 07 08:04:48 volumio volumio[4739]: info: ControllerMpd::getState
Dec 07 08:04:48 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand status
Dec 07 08:04:48 volumio volumio[4739]: info:
Dec 07 08:04:48 volumio volumio[4739]: ---------------------------- MPD announces state update: player
Dec 07 08:04:48 volumio volumio[4739]: info: ControllerMpd::getState
Dec 07 08:04:48 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand status
Dec 07 08:04:48 volumio volumio[4739]: verbose: ControllerMpd::parseState
Dec 07 08:04:48 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 07 08:04:48 volumio volumio[4739]: verbose: ControllerMpd::parseState
Dec 07 08:04:48 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 07 08:04:48 volumio volumio[4739]: verbose: ControllerMpd::parseTrackInfo
Dec 07 08:04:48 volumio volumio[4739]: info: ControllerMpd::pushState
Dec 07 08:04:48 volumio volumio[4739]: info: CoreCommandRouter::servicePushState
Dec 07 08:04:48 volumio volumio[4739]: info: CorePlayQueue::getTrack 4
Dec 07 08:04:48 volumio volumio[4739]: verbose: STATE SERVICE {"status":"play","position":0,"seek":383,"duration":235,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"arthur time - christopher cross.mp3","artist":null,"album":null,"uri":"USB/EA86-55F0/LOVE SONG/arthur time - christopher cross.mp3","trackType":"mp3"}
Dec 07 08:04:48 volumio volumio[4739]: verbose: CURRENT POSITION 4
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::syncState stateService play
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::syncState currentStatus stop
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:48 volumio volumio[4739]: info: CorePlayQueue::getTrack 4
Dec 07 08:04:48 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:48 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:48 volumio volumio[4739]: info: ------------------------------ 24ms
Dec 07 08:04:48 volumio volumio[4739]: verbose: ControllerMpd::parseTrackInfo
Dec 07 08:04:48 volumio volumio[4739]: info: ControllerMpd::pushState
Dec 07 08:04:48 volumio volumio[4739]: info: CoreCommandRouter::servicePushState
Dec 07 08:04:48 volumio volumio[4739]: info: CorePlayQueue::getTrack 4
Dec 07 08:04:48 volumio volumio[4739]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":235,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"arthur time - christopher cross.mp3","artist":null,"album":null,"uri":"USB/EA86-55F0/LOVE SONG/arthur time - christopher cross.mp3","trackType":"mp3"}
Dec 07 08:04:48 volumio volumio[4739]: verbose: CURRENT POSITION 4
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::syncState stateService play
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::syncState currentStatus play
Dec 07 08:04:48 volumio volumio[4739]: info: Received an update from plugin. extracting info from payload
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:48 volumio volumio[4739]: info: CorePlayQueue::getTrack 4
Dec 07 08:04:48 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:48 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:48 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:48 volumio volumio[4739]: info: CorePlayQueue::getTrack 4
Dec 07 08:04:48 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:48 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:48 volumio volumio[4739]: info: ------------------------------ 45ms
Dec 07 08:04:53 volumio volumio[4739]: info: CoreCommandRouter::volumioNext
Dec 07 08:04:53 volumio volumio[4739]: info: CoreStateMachine::next
Dec 07 08:04:53 volumio volumio[4739]: info: CoreStateMachine::stop
Dec 07 08:04:53 volumio volumio[4739]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 07 08:04:53 volumio volumio[4739]: UNSET VOLATILE
Dec 07 08:04:53 volumio volumio[4739]: info: CoreStateMachine::stPlaybackTimer
Dec 07 08:04:53 volumio volumio[4739]: info: CoreStateMachine::updateTrackBlock
Dec 07 08:04:53 volumio volumio[4739]: info: CorePlayQueue::getTrackBlock
Dec 07 08:04:53 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:53 volumio volumio[4739]: info: CorePlayQueue::getTrack 4
Dec 07 08:04:53 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:53 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:53 volumio volumio[4739]: info: CoreStateMachine::serviceStop
Dec 07 08:04:53 volumio volumio[4739]: info: CorePlayQueue::getTrack 4
Dec 07 08:04:53 volumio volumio[4739]: info: CoreCommandRouter::serviceStop
Dec 07 08:04:53 volumio volumio[4739]: info: ControllerMpd::stop
Dec 07 08:04:53 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand stop
Dec 07 08:04:53 volumio volumio[4739]: info: CoreStateMachine::play index undefined
Dec 07 08:04:53 volumio volumio[4739]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 07 08:04:53 volumio volumio[4739]: info: CorePlayQueue::getTrack 5
Dec 07 08:04:53 volumio volumio[4739]: info: CoreStateMachine::startPlaybackTimer
Dec 07 08:04:53 volumio volumio[4739]: info: CorePlayQueue::getTrack 5
Dec 07 08:04:53 volumio volumio[4739]: verbose: ControllerMpd::clearAddPlayTracks USB/EA86-55F0/LOVE SONG/Belladonna - UFO.mp3
Dec 07 08:04:53 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand stop
Dec 07 08:04:53 volumio volumio[4739]: info: CoreStateMachine::updateTrackBlock
Dec 07 08:04:53 volumio volumio[4739]: info: CorePlayQueue::getTrackBlock
Dec 07 08:04:53 volumio volumio[4739]: info:
Dec 07 08:04:53 volumio volumio[4739]: ---------------------------- MPD announces state update: player
Dec 07 08:04:53 volumio volumio[4739]: info: ControllerMpd::getState
Dec 07 08:04:53 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand status
Dec 07 08:04:53 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand clear
Dec 07 08:04:53 volumio volumio[4739]: info:
Dec 07 08:04:53 volumio volumio[4739]: ---------------------------- MPD announces system playlist update
Dec 07 08:04:53 volumio volumio[4739]: info: Ignoring MPD Status Update
Dec 07 08:04:53 volumio volumio[4739]: verbose: ControllerMpd::parseState
Dec 07 08:04:53 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 07 08:04:53 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand add "USB/EA86-55F0/LOVE SONG/Belladonna - UFO.mp3"
Dec 07 08:04:53 volumio volumio[4739]: error: updateQueue error: null
Dec 07 08:04:53 volumio volumio[4739]: info:
Dec 07 08:04:53 volumio volumio[4739]: ---------------------------- MPD announces system playlist update
Dec 07 08:04:53 volumio volumio[4739]: info: Ignoring MPD Status Update
Dec 07 08:04:53 volumio volumio[4739]: info: ------------------------------ 6ms
Dec 07 08:04:53 volumio volumio[4739]: verbose: ControllerMpd::parseTrackInfo
Dec 07 08:04:53 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand play
Dec 07 08:04:53 volumio volumio[4739]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Dec 07 08:04:53 volumio volumio[4739]: info: ------------------------------ 15ms
Dec 07 08:04:53 volumio volumio[4739]: info: ------------------------------ 7ms
Dec 07 08:04:53 volumio volumio[4739]: info:
Dec 07 08:04:53 volumio volumio[4739]: ---------------------------- MPD announces state update: player
Dec 07 08:04:53 volumio volumio[4739]: info: ControllerMpd::getState
Dec 07 08:04:53 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand status
Dec 07 08:04:53 volumio volumio[4739]: verbose: ControllerMpd::parseState
Dec 07 08:04:53 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 07 08:04:53 volumio volumio[4739]: info:
Dec 07 08:04:53 volumio volumio[4739]: ---------------------------- MPD announces state update: player
Dec 07 08:04:53 volumio volumio[4739]: info: ControllerMpd::getState
Dec 07 08:04:53 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand status
Dec 07 08:04:53 volumio volumio[4739]: verbose: ControllerMpd::parseTrackInfo
Dec 07 08:04:53 volumio volumio[4739]: info: ControllerMpd::pushState
Dec 07 08:04:53 volumio volumio[4739]: info: CoreCommandRouter::servicePushState
Dec 07 08:04:53 volumio volumio[4739]: info: CorePlayQueue::getTrack 5
Dec 07 08:04:53 volumio volumio[4739]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":261,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Belladonna","artist":"UFO","album":null,"uri":"USB/EA86-55F0/LOVE SONG/Belladonna - UFO.mp3","trackType":"mp3"}
Dec 07 08:04:53 volumio volumio[4739]: verbose: CURRENT POSITION 5
Dec 07 08:04:53 volumio volumio[4739]: info: CoreStateMachine::syncState stateService play
Dec 07 08:04:53 volumio volumio[4739]: info: CoreStateMachine::syncState currentStatus stop
Dec 07 08:04:53 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:53 volumio volumio[4739]: info: CorePlayQueue::getTrack 5
Dec 07 08:04:53 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:53 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:53 volumio volumio[4739]: info: ------------------------------ 24ms
Dec 07 08:04:53 volumio volumio[4739]: verbose: ControllerMpd::parseState
Dec 07 08:04:53 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 07 08:04:53 volumio volumio[4739]: verbose: ControllerMpd::parseTrackInfo
Dec 07 08:04:53 volumio volumio[4739]: info: ControllerMpd::pushState
Dec 07 08:04:53 volumio volumio[4739]: info: CoreCommandRouter::servicePushState
Dec 07 08:04:53 volumio volumio[4739]: info: CorePlayQueue::getTrack 5
Dec 07 08:04:53 volumio volumio[4739]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":261,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Belladonna","artist":"UFO","album":null,"uri":"USB/EA86-55F0/LOVE SONG/Belladonna - UFO.mp3","trackType":"mp3"}
Dec 07 08:04:53 volumio volumio[4739]: verbose: CURRENT POSITION 5
Dec 07 08:04:53 volumio volumio[4739]: info: CoreStateMachine::syncState stateService play
Dec 07 08:04:53 volumio volumio[4739]: info: CoreStateMachine::syncState currentStatus play
Dec 07 08:04:53 volumio volumio[4739]: info: Received an update from plugin. extracting info from payload
Dec 07 08:04:53 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:53 volumio volumio[4739]: info: CorePlayQueue::getTrack 5
Dec 07 08:04:53 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:53 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:53 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:04:53 volumio volumio[4739]: info: CorePlayQueue::getTrack 5
Dec 07 08:04:53 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:04:53 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:04:53 volumio volumio[4739]: info: ------------------------------ 47ms
Dec 07 08:05:08 volumio volumio[4739]: info: CoreCommandRouter::volumioPlay
Dec 07 08:05:08 volumio volumio[4739]: UNSET VOLATILE
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::play index 27
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::stop
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 07 08:05:08 volumio volumio[4739]: UNSET VOLATILE
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::stPlaybackTimer
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::updateTrackBlock
Dec 07 08:05:08 volumio volumio[4739]: info: CorePlayQueue::getTrackBlock
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:05:08 volumio volumio[4739]: info: CorePlayQueue::getTrack 5
Dec 07 08:05:08 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:05:08 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::serviceStop
Dec 07 08:05:08 volumio volumio[4739]: info: CorePlayQueue::getTrack 5
Dec 07 08:05:08 volumio volumio[4739]: info: CoreCommandRouter::serviceStop
Dec 07 08:05:08 volumio volumio[4739]: info: ControllerMpd::stop
Dec 07 08:05:08 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand stop
Dec 07 08:05:08 volumio volumio[4739]: info:
Dec 07 08:05:08 volumio volumio[4739]: ---------------------------- MPD announces state update: player
Dec 07 08:05:08 volumio volumio[4739]: info: ControllerMpd::getState
Dec 07 08:05:08 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand status
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::play index undefined
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 07 08:05:08 volumio volumio[4739]: info: CorePlayQueue::getTrack 27
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::startPlaybackTimer
Dec 07 08:05:08 volumio volumio[4739]: info: CorePlayQueue::getTrack 27
Dec 07 08:05:08 volumio volumio[4739]: verbose: ControllerMpd::clearAddPlayTracks USB/EA86-55F0/LOVE SONG/Mariah Carey - Hero.mp3
Dec 07 08:05:08 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand stop
Dec 07 08:05:08 volumio volumio[4739]: verbose: ControllerMpd::parseState
Dec 07 08:05:08 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 07 08:05:08 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand clear
Dec 07 08:05:08 volumio volumio[4739]: info:
Dec 07 08:05:08 volumio volumio[4739]: ---------------------------- MPD announces system playlist update
Dec 07 08:05:08 volumio volumio[4739]: info: Ignoring MPD Status Update
Dec 07 08:05:08 volumio volumio[4739]: verbose: ControllerMpd::parseTrackInfo
Dec 07 08:05:08 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand add "USB/EA86-55F0/LOVE SONG/Mariah Carey - Hero.mp3"
Dec 07 08:05:08 volumio volumio[4739]: info: ControllerMpd::pushState
Dec 07 08:05:08 volumio volumio[4739]: info: CoreCommandRouter::servicePushState
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:05:08 volumio volumio[4739]: info: CorePlayQueue::getTrack 27
Dec 07 08:05:08 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:05:08 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:05:08 volumio volumio[4739]: info: CorePlayQueue::getTrack 27
Dec 07 08:05:08 volumio volumio[4739]: 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":"Belladonna","artist":"UFO","album":null,"uri":"USB/EA86-55F0/LOVE SONG/Belladonna - UFO.mp3","trackType":"mp3"}
Dec 07 08:05:08 volumio volumio[4739]: verbose: CURRENT POSITION 27
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::syncState stateService stop
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::syncState currentStatus stop
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:05:08 volumio volumio[4739]: info: CorePlayQueue::getTrack 27
Dec 07 08:05:08 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:05:08 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:05:08 volumio volumio[4739]: info: No code
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:05:08 volumio volumio[4739]: info: CorePlayQueue::getTrack 27
Dec 07 08:05:08 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:05:08 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:05:08 volumio volumio[4739]: info: ------------------------------ 45ms
Dec 07 08:05:08 volumio volumio[4739]: error: updateQueue error: null
Dec 07 08:05:08 volumio volumio[4739]: info:
Dec 07 08:05:08 volumio volumio[4739]: ---------------------------- MPD announces system playlist update
Dec 07 08:05:08 volumio volumio[4739]: info: Ignoring MPD Status Update
Dec 07 08:05:08 volumio volumio[4739]: info: ------------------------------ 32ms
Dec 07 08:05:08 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand play
Dec 07 08:05:08 volumio volumio[4739]: info:
Dec 07 08:05:08 volumio volumio[4739]: ---------------------------- MPD announces state update: player
Dec 07 08:05:08 volumio volumio[4739]: info: ------------------------------ 20ms
Dec 07 08:05:08 volumio volumio[4739]: info: ControllerMpd::getState
Dec 07 08:05:08 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand status
Dec 07 08:05:08 volumio volumio[4739]: info:
Dec 07 08:05:08 volumio volumio[4739]: ---------------------------- MPD announces state update: player
Dec 07 08:05:08 volumio volumio[4739]: info: ControllerMpd::getState
Dec 07 08:05:08 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand status
Dec 07 08:05:08 volumio volumio[4739]: verbose: ControllerMpd::parseState
Dec 07 08:05:08 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 07 08:05:08 volumio volumio[4739]: verbose: ControllerMpd::parseState
Dec 07 08:05:08 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 07 08:05:08 volumio volumio[4739]: verbose: ControllerMpd::parseTrackInfo
Dec 07 08:05:08 volumio volumio[4739]: info: ControllerMpd::pushState
Dec 07 08:05:08 volumio volumio[4739]: info: CoreCommandRouter::servicePushState
Dec 07 08:05:08 volumio volumio[4739]: info: CorePlayQueue::getTrack 27
Dec 07 08:05:08 volumio volumio[4739]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":264,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Hero","artist":"Mariah Carey","album":null,"uri":"USB/EA86-55F0/LOVE SONG/Mariah Carey - Hero.mp3","trackType":"mp3"}
Dec 07 08:05:08 volumio volumio[4739]: verbose: CURRENT POSITION 27
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::syncState stateService play
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::syncState currentStatus stop
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:05:08 volumio volumio[4739]: info: CorePlayQueue::getTrack 27
Dec 07 08:05:08 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:05:08 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:05:08 volumio volumio[4739]: info: ------------------------------ 25ms
Dec 07 08:05:08 volumio volumio[4739]: verbose: ControllerMpd::parseTrackInfo
Dec 07 08:05:08 volumio volumio[4739]: info: ControllerMpd::pushState
Dec 07 08:05:08 volumio volumio[4739]: info: CoreCommandRouter::servicePushState
Dec 07 08:05:08 volumio volumio[4739]: info: CorePlayQueue::getTrack 27
Dec 07 08:05:08 volumio volumio[4739]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":264,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Hero","artist":"Mariah Carey","album":null,"uri":"USB/EA86-55F0/LOVE SONG/Mariah Carey - Hero.mp3","trackType":"mp3"}
Dec 07 08:05:08 volumio volumio[4739]: verbose: CURRENT POSITION 27
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::syncState stateService play
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::syncState currentStatus play
Dec 07 08:05:08 volumio volumio[4739]: info: Received an update from plugin. extracting info from payload
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:05:08 volumio volumio[4739]: info: CorePlayQueue::getTrack 27
Dec 07 08:05:08 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:05:08 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:05:08 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:05:08 volumio volumio[4739]: info: CorePlayQueue::getTrack 27
Dec 07 08:05:08 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:05:08 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:05:08 volumio volumio[4739]: info: ------------------------------ 46ms
Dec 07 08:05:28 volumio volumio[4739]: info: CoreCommandRouter::volumioPlay
Dec 07 08:05:28 volumio volumio[4739]: UNSET VOLATILE
Dec 07 08:05:28 volumio volumio[4739]: info: CoreStateMachine::play index 10
Dec 07 08:05:28 volumio volumio[4739]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 07 08:05:28 volumio volumio[4739]: info: CoreStateMachine::stop
Dec 07 08:05:28 volumio volumio[4739]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 07 08:05:28 volumio volumio[4739]: UNSET VOLATILE
Dec 07 08:05:28 volumio volumio[4739]: info: CoreStateMachine::stPlaybackTimer
Dec 07 08:05:28 volumio volumio[4739]: info: CoreStateMachine::updateTrackBlock
Dec 07 08:05:28 volumio volumio[4739]: info: CorePlayQueue::getTrackBlock
Dec 07 08:05:28 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:05:28 volumio volumio[4739]: info: CorePlayQueue::getTrack 27
Dec 07 08:05:28 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:05:28 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:05:28 volumio volumio[4739]: info: CoreStateMachine::serviceStop
Dec 07 08:05:28 volumio volumio[4739]: info: CorePlayQueue::getTrack 27
Dec 07 08:05:28 volumio volumio[4739]: info: CoreCommandRouter::serviceStop
Dec 07 08:05:28 volumio volumio[4739]: info: ControllerMpd::stop
Dec 07 08:05:28 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand stop
Dec 07 08:05:28 volumio volumio[4739]: info: CoreStateMachine::play index undefined
Dec 07 08:05:28 volumio volumio[4739]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 07 08:05:28 volumio volumio[4739]: info: CorePlayQueue::getTrack 10
Dec 07 08:05:28 volumio volumio[4739]: info: CoreStateMachine::startPlaybackTimer
Dec 07 08:05:28 volumio volumio[4739]: info: CorePlayQueue::getTrack 10
Dec 07 08:05:28 volumio volumio[4739]: verbose: ControllerMpd::clearAddPlayTracks USB/EA86-55F0/LOVE SONG/Dionne Warwick - HEARTBREAKER.mp3
Dec 07 08:05:28 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand stop
Dec 07 08:05:28 volumio volumio[4739]: info:
Dec 07 08:05:28 volumio volumio[4739]: ---------------------------- MPD announces state update: player
Dec 07 08:05:28 volumio volumio[4739]: info: ControllerMpd::getState
Dec 07 08:05:28 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand status
Dec 07 08:05:28 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand clear
Dec 07 08:05:28 volumio volumio[4739]: info:
Dec 07 08:05:28 volumio volumio[4739]: ---------------------------- MPD announces system playlist update
Dec 07 08:05:28 volumio volumio[4739]: info: Ignoring MPD Status Update
Dec 07 08:05:28 volumio volumio[4739]: verbose: ControllerMpd::parseState
Dec 07 08:05:28 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 07 08:05:28 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand add "USB/EA86-55F0/LOVE SONG/Dionne Warwick - HEARTBREAKER.mp3"
Dec 07 08:05:28 volumio volumio[4739]: error: updateQueue error: null
Dec 07 08:05:28 volumio volumio[4739]: info:
Dec 07 08:05:28 volumio volumio[4739]: ---------------------------- MPD announces system playlist update
Dec 07 08:05:28 volumio volumio[4739]: info: Ignoring MPD Status Update
Dec 07 08:05:28 volumio volumio[4739]: info: ------------------------------ 6ms
Dec 07 08:05:28 volumio volumio[4739]: verbose: ControllerMpd::parseTrackInfo
Dec 07 08:05:28 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand play
Dec 07 08:05:28 volumio volumio[4739]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Dec 07 08:05:28 volumio volumio[4739]: info: ------------------------------ 14ms
Dec 07 08:05:28 volumio volumio[4739]: info: ------------------------------ 6ms
Dec 07 08:05:28 volumio volumio[4739]: info:
Dec 07 08:05:28 volumio volumio[4739]: ---------------------------- MPD announces state update: player
Dec 07 08:05:28 volumio volumio[4739]: info: ControllerMpd::getState
Dec 07 08:05:28 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand status
Dec 07 08:05:28 volumio volumio[4739]: info:
Dec 07 08:05:28 volumio volumio[4739]: ---------------------------- MPD announces state update: player
Dec 07 08:05:28 volumio volumio[4739]: info: ControllerMpd::getState
Dec 07 08:05:28 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand status
Dec 07 08:05:28 volumio volumio[4739]: verbose: ControllerMpd::parseState
Dec 07 08:05:28 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 07 08:05:28 volumio volumio[4739]: verbose: ControllerMpd::parseState
Dec 07 08:05:28 volumio volumio[4739]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 07 08:05:28 volumio volumio[4739]: verbose: ControllerMpd::parseTrackInfo
Dec 07 08:05:28 volumio volumio[4739]: info: ControllerMpd::pushState
Dec 07 08:05:28 volumio volumio[4739]: info: CoreCommandRouter::servicePushState
Dec 07 08:05:28 volumio volumio[4739]: info: CorePlayQueue::getTrack 10
Dec 07 08:05:28 volumio volumio[4739]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":259,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"HEARTBREAKER","artist":"Dionne Warwick","album":null,"uri":"USB/EA86-55F0/LOVE SONG/Dionne Warwick - HEARTBREAKER.mp3","trackType":"mp3"}
Dec 07 08:05:28 volumio volumio[4739]: verbose: CURRENT POSITION 10
Dec 07 08:05:28 volumio volumio[4739]: info: CoreStateMachine::syncState stateService play
Dec 07 08:05:28 volumio volumio[4739]: info: CoreStateMachine::syncState currentStatus stop
Dec 07 08:05:28 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:05:28 volumio volumio[4739]: info: CorePlayQueue::getTrack 10
Dec 07 08:05:28 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:05:28 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:05:28 volumio volumio[4739]: info: ------------------------------ 37ms
Dec 07 08:05:28 volumio volumio[4739]: verbose: ControllerMpd::parseTrackInfo
Dec 07 08:05:28 volumio volumio[4739]: info: ControllerMpd::pushState
Dec 07 08:05:28 volumio volumio[4739]: info: CoreCommandRouter::servicePushState
Dec 07 08:05:28 volumio volumio[4739]: info: CorePlayQueue::getTrack 10
Dec 07 08:05:28 volumio volumio[4739]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":259,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"HEARTBREAKER","artist":"Dionne Warwick","album":null,"uri":"USB/EA86-55F0/LOVE SONG/Dionne Warwick - HEARTBREAKER.mp3","trackType":"mp3"}
Dec 07 08:05:28 volumio volumio[4739]: verbose: CURRENT POSITION 10
Dec 07 08:05:28 volumio volumio[4739]: info: CoreStateMachine::syncState stateService play
Dec 07 08:05:28 volumio volumio[4739]: info: CoreStateMachine::syncState currentStatus play
Dec 07 08:05:28 volumio volumio[4739]: info: Received an update from plugin. extracting info from payload
Dec 07 08:05:28 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:05:28 volumio volumio[4739]: info: CorePlayQueue::getTrack 10
Dec 07 08:05:28 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:05:28 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:05:28 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:05:28 volumio volumio[4739]: info: CorePlayQueue::getTrack 10
Dec 07 08:05:28 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:05:28 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:05:28 volumio volumio[4739]: info: ------------------------------ 61ms
Dec 07 08:05:40 volumio volumio[4739]: info: VolumeController::SetAlsaVolume30
Dec 07 08:05:40 volumio volumio[4739]: info: CoreStateMachine::pushState
Dec 07 08:05:40 volumio volumio[4739]: info: CorePlayQueue::getTrack 10
Dec 07 08:05:40 volumio volumio[4739]: info: CoreCommandRouter::volumioPushState
Dec 07 08:05:40 volumio volumio[4739]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 08:05:52 volumio volumio[4739]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 07 08:05:52 volumio volumio[4739]: { Error: read ECONNRESET
Dec 07 08:05:52 volumio volumio[4739]: at _errnoException (util.js:1022:11)
Dec 07 08:05:53 volumio volumio[4739]: at TLSWrap.onread (net.js:628:25) code: 'ECONNRESET', errno: 'ECONNRESET', syscall: 'read' }
Dec 07 08:05:53 volumio volumio[4739]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 07 08:05:53 volumio sudo[5440]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-07 08:04
Dec 07 08:05:53 volumio sudo[5440]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 8 (jessie)"
NAME="Debian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
ID=debian
HOME_URL="http://www.debian.org/"
SUPPORT_URL="http://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="493b3f2063c664b52681092d76718ef5fb070910"
VOLUMIO_FE_VERSION="4917998f86709e30d6499627aa39df0350cb55f8"
VOLUMIO_BE_VERSION="d9435b7a968fdb32f8774ce87d86f5f44a90fb66"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sun Aug 2 23:36:23 CEST 2020"
VOLUMIO_VERSION="2.806"
VOLUMIO_HARDWARE="aml9xxxarmv7"
VOLUMIO_HASH="721ce12033fe994c37bd358dd68cf9f9"