-- Logs begin at Tue 2024-05-07 12:47:25 UTC, end at Tue 2024-05-07 13:01:20 UTC. --
May 07 13:00:01 volumio volumio[826]: info: CoreCommandRouter::volumioSeek
May 07 13:00:01 volumio volumio[826]: info: CoreStateMachine::seek
May 07 13:00:01 volumio volumio[826]: info: CorePlayQueue::getTrack 5
May 07 13:00:01 volumio volumio[826]: info: TRACKBLOCK {"uri":"music-library/USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(06) [Hadouk Trio] Friday the 13th.wv","service":"mpd","name":"Friday the 13th","artist":"Hadouk Trio","album":"Air Hadouk","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=142&web=Hadouk%20Trio/Air%20Hadouk/extralarge&path=%2Fmnt%2FUSB%2F2E3CD90E3CD8D247%2F%D0%9C%D0%A3%D0%97%D0%AB%D0%9A%D0%90%2F%D0%94%D0%96%D0%90%D0%97%2F2010%20-%20Air%20Hadouk&metadata=false","duration":318,"trackType":"wv","samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2}
May 07 13:00:01 volumio volumio[826]: info: CoreStateMachine::startPlaybackTimer
May 07 13:00:01 volumio volumio[826]: info: CorePlayQueue::getTrack 5
May 07 13:00:01 volumio volumio[826]: info: ControllerMpd::seek
May 07 13:00:01 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:01 volumio volumio[826]: info: CorePlayQueue::getTrack 5
May 07 13:00:01 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:00:01 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:01 volumio volumio[826]: error: null
May 07 13:00:01 volumio volumio[826]: info:
May 07 13:00:01 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:01 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:01 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:01 volumio volumio[826]: info:
May 07 13:00:01 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:01 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:01 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:01 volumio volumio[826]: info:
May 07 13:00:01 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:01 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:01 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:01 volumio volumio[826]: info: sendMpdCommand status took 3 milliseconds
May 07 13:00:01 volumio volumio[826]: info: sendMpdCommand status took 2 milliseconds
May 07 13:00:01 volumio volumio[826]: info: sendMpdCommand status took 1 milliseconds
May 07 13:00:01 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:01 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:01 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:01 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:01 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:01 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:01 volumio volumio[826]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 07 13:00:01 volumio volumio[826]: info: sendMpdCommand playlistinfo took 5 milliseconds
May 07 13:00:01 volumio volumio[826]: info: sendMpdCommand playlistinfo took 11 milliseconds
May 07 13:00:01 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:01 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:01 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:01 volumio volumio[826]: info: CorePlayQueue::getTrack 5
May 07 13:00:01 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":57000,"duration":318,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1040 Kbps","isStreaming":false,"title":"Friday the 13th","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(06) [Hadouk Trio] Friday the 13th.wv","trackType":"wv"}
May 07 13:00:01 volumio volumio[826]: verbose: CURRENT POSITION 5
May 07 13:00:01 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:01 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:01 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:01 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:01 volumio volumio[826]: info: CorePlayQueue::getTrack 5
May 07 13:00:01 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:01 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:01 volumio volumio[826]: info: CorePlayQueue::getTrack 5
May 07 13:00:01 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:01 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:01 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:01 volumio volumio[826]: info: CorePlayQueue::getTrack 5
May 07 13:00:01 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":57000,"duration":318,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1040 Kbps","isStreaming":false,"title":"Friday the 13th","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(06) [Hadouk Trio] Friday the 13th.wv","trackType":"wv"}
May 07 13:00:01 volumio volumio[826]: verbose: CURRENT POSITION 5
May 07 13:00:01 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:01 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:01 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:01 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:01 volumio volumio[826]: info: CorePlayQueue::getTrack 5
May 07 13:00:01 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:01 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:01 volumio volumio[826]: info: CorePlayQueue::getTrack 5
May 07 13:00:01 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:01 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:01 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:01 volumio volumio[826]: info: CorePlayQueue::getTrack 5
May 07 13:00:01 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":57000,"duration":318,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1040 Kbps","isStreaming":false,"title":"Friday the 13th","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(06) [Hadouk Trio] Friday the 13th.wv","trackType":"wv"}
May 07 13:00:01 volumio volumio[826]: verbose: CURRENT POSITION 5
May 07 13:00:01 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:01 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:01 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:01 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:01 volumio volumio[826]: info: CorePlayQueue::getTrack 5
May 07 13:00:01 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:01 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:01 volumio volumio[826]: info: CorePlayQueue::getTrack 5
May 07 13:00:01 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:01 volumio volumio[826]: info: ------------------------------ 82ms
May 07 13:00:01 volumio volumio[826]: info: ------------------------------ 87ms
May 07 13:00:01 volumio volumio[826]: info: ------------------------------ 87ms
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::volumioNext
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::next
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::stop
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::stPlaybackTimer
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::updateTrackBlock
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrackBlock
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 5
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::serviceStop
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 5
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::serviceStop
May 07 13:00:02 volumio volumio[826]: info: ControllerMpd::stop
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand stop
May 07 13:00:02 volumio volumio[826]: info:
May 07 13:00:02 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand stop took 48 milliseconds
May 07 13:00:02 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::play index undefined
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::startPlaybackTimer
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::clearAddPlayTracks USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(07) [Hadouk Trio] Hang around me.wv
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand stop
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::updateTrackBlock
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrackBlock
May 07 13:00:02 volumio volumio[826]: info:
May 07 13:00:02 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:02 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:02 volumio volumio[826]: info:
May 07 13:00:02 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:02 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand status took 5 milliseconds
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand stop took 4 milliseconds
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand status took 1 milliseconds
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand clear
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:02 volumio volumio[826]: info:
May 07 13:00:02 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:02 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand status took 2 milliseconds
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand clear took 1 milliseconds
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand add "USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(07) [Hadouk Trio] Hang around me.wv"
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:02 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: 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":"Friday the 13th","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(06) [Hadouk Trio] Friday the 13th.wv","trackType":"wv"}
May 07 13:00:02 volumio volumio[826]: verbose: CURRENT POSITION 6
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::syncState stateService stop
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus stop
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:02 volumio volumio[826]: info: No code
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:02 volumio volumio[826]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 07 13:00:02 volumio volumio[826]: info: ------------------------------ 27ms
May 07 13:00:02 volumio volumio[826]: info: ------------------------------ 23ms
May 07 13:00:02 volumio volumio[826]: info:
May 07 13:00:02 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:02 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:02 volumio volumio[826]: info:
May 07 13:00:02 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:02 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:02 volumio volumio[826]: error: updateQueue error: null
May 07 13:00:02 volumio volumio[826]: info:
May 07 13:00:02 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:02 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:02 volumio volumio[826]: info: ------------------------------ 21ms
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand playlistinfo took 20 milliseconds
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand add "USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(07) [Hadouk Trio] Hang around me.wv" took 19 milliseconds
May 07 13:00:02 volumio volumio[826]: info: ------------------------------ 9ms
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand play
May 07 13:00:02 volumio volumio[826]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 07 13:00:02 volumio volumio[826]: info: ------------------------------ 32ms
May 07 13:00:02 volumio volumio[826]: info:
May 07 13:00:02 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:02 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:02 volumio volumio[826]: info: ------------------------------ 18ms
May 07 13:00:02 volumio volumio[826]: info: ------------------------------ 17ms
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand play took 10 milliseconds
May 07 13:00:02 volumio volumio[826]: info: ------------------------------ 7ms
May 07 13:00:02 volumio volumio[826]: info:
May 07 13:00:02 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:02 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:02 volumio volumio[826]: info: ------------------------------ 0ms
May 07 13:00:02 volumio volumio[826]: info:
May 07 13:00:02 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:02 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:02 volumio volumio[826]: info:
May 07 13:00:02 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:02 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:02 volumio volumio[826]: info:
May 07 13:00:02 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:02 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand status took 4 milliseconds
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:02 volumio volumio[826]: info:
May 07 13:00:02 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:02 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:02 volumio volumio[826]: info:
May 07 13:00:02 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:02 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:02 volumio volumio[826]: info:
May 07 13:00:02 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:02 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand status took 5 milliseconds
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand status took 6 milliseconds
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand playlistinfo took 5 milliseconds
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand status took 6 milliseconds
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand status took 5 milliseconds
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:02 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hang around me","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(07) [Hadouk Trio] Hang around me.wv","trackType":"wv"}
May 07 13:00:02 volumio volumio[826]: verbose: CURRENT POSITION 6
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus stop
May 07 13:00:02 volumio volumio[826]: info: ------------------------------ 14ms
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand playlistinfo took 5 milliseconds
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:02 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hang around me","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(07) [Hadouk Trio] Hang around me.wv","trackType":"wv"}
May 07 13:00:02 volumio volumio[826]: verbose: CURRENT POSITION 6
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:02 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:02 volumio volumio[826]: info: ------------------------------ 30ms
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand playlistinfo took 20 milliseconds
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand playlistinfo took 20 milliseconds
May 07 13:00:02 volumio volumio[826]: info: sendMpdCommand playlistinfo took 21 milliseconds
May 07 13:00:02 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:02 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hang around me","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(07) [Hadouk Trio] Hang around me.wv","trackType":"wv"}
May 07 13:00:02 volumio volumio[826]: verbose: CURRENT POSITION 6
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:02 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:02 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hang around me","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(07) [Hadouk Trio] Hang around me.wv","trackType":"wv"}
May 07 13:00:02 volumio volumio[826]: verbose: CURRENT POSITION 6
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:02 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:02 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hang around me","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(07) [Hadouk Trio] Hang around me.wv","trackType":"wv"}
May 07 13:00:02 volumio volumio[826]: verbose: CURRENT POSITION 6
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:02 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:02 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hang around me","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(07) [Hadouk Trio] Hang around me.wv","trackType":"wv"}
May 07 13:00:02 volumio volumio[826]: verbose: CURRENT POSITION 6
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:02 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:02 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:02 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:02 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:03 volumio volumio[826]: info: ------------------------------ 122ms
May 07 13:00:03 volumio volumio[826]: info: ------------------------------ 119ms
May 07 13:00:05 volumio volumio[826]: info: CoreCommandRouter::volumioSeek
May 07 13:00:05 volumio volumio[826]: info: CoreStateMachine::seek
May 07 13:00:05 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:05 volumio volumio[826]: info: TRACKBLOCK {"uri":"music-library/USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(07) [Hadouk Trio] Hang around me.wv","service":"mpd","name":"Hang around me","artist":"Hadouk Trio","album":"Air Hadouk","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=142&web=Hadouk%20Trio/Air%20Hadouk/extralarge&path=%2Fmnt%2FUSB%2F2E3CD90E3CD8D247%2F%D0%9C%D0%A3%D0%97%D0%AB%D0%9A%D0%90%2F%D0%94%D0%96%D0%90%D0%97%2F2010%20-%20Air%20Hadouk&metadata=false","duration":139,"trackType":"wv","samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2}
May 07 13:00:05 volumio volumio[826]: info: CoreStateMachine::startPlaybackTimer
May 07 13:00:05 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:05 volumio volumio[826]: info: ControllerMpd::seek
May 07 13:00:05 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:05 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:05 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:00:05 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:05 volumio volumio[826]: error: null
May 07 13:00:05 volumio volumio[826]: info:
May 07 13:00:05 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:05 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:05 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:05 volumio volumio[826]: info:
May 07 13:00:05 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:05 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:05 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:05 volumio volumio[826]: info:
May 07 13:00:05 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:05 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:05 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:05 volumio volumio[826]: info: sendMpdCommand status took 5 milliseconds
May 07 13:00:05 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:05 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:05 volumio volumio[826]: info: sendMpdCommand status took 10 milliseconds
May 07 13:00:05 volumio volumio[826]: info: sendMpdCommand playlistinfo took 9 milliseconds
May 07 13:00:05 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:05 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:05 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:05 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:05 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:05 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:05 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:05 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:05 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":24000,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"427 Kbps","isStreaming":false,"title":"Hang around me","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(07) [Hadouk Trio] Hang around me.wv","trackType":"wv"}
May 07 13:00:05 volumio volumio[826]: verbose: CURRENT POSITION 6
May 07 13:00:05 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:05 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:05 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:05 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:05 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:05 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:05 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:05 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:05 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:05 volumio volumio[826]: info: ------------------------------ 37ms
May 07 13:00:05 volumio volumio[826]: info: sendMpdCommand playlistinfo took 23 milliseconds
May 07 13:00:05 volumio volumio[826]: info: sendMpdCommand playlistinfo took 24 milliseconds
May 07 13:00:05 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:05 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:05 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:05 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:05 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":24000,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"427 Kbps","isStreaming":false,"title":"Hang around me","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(07) [Hadouk Trio] Hang around me.wv","trackType":"wv"}
May 07 13:00:05 volumio volumio[826]: verbose: CURRENT POSITION 6
May 07 13:00:05 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:05 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:05 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:05 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:05 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:05 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:05 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:05 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:05 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:05 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:05 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:05 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:05 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":24000,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"427 Kbps","isStreaming":false,"title":"Hang around me","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(07) [Hadouk Trio] Hang around me.wv","trackType":"wv"}
May 07 13:00:05 volumio volumio[826]: verbose: CURRENT POSITION 6
May 07 13:00:05 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:05 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:05 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:05 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:05 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:05 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:05 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:05 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:05 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:05 volumio volumio[826]: info: ------------------------------ 102ms
May 07 13:00:05 volumio volumio[826]: info: ------------------------------ 104ms
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::volumioSeek
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::seek
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:15 volumio volumio[826]: info: TRACKBLOCK {"uri":"music-library/USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(07) [Hadouk Trio] Hang around me.wv","service":"mpd","name":"Hang around me","artist":"Hadouk Trio","album":"Air Hadouk","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=142&web=Hadouk%20Trio/Air%20Hadouk/extralarge&path=%2Fmnt%2FUSB%2F2E3CD90E3CD8D247%2F%D0%9C%D0%A3%D0%97%D0%AB%D0%9A%D0%90%2F%D0%94%D0%96%D0%90%D0%97%2F2010%20-%20Air%20Hadouk&metadata=false","duration":139,"trackType":"wv","samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2}
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::startPlaybackTimer
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:15 volumio volumio[826]: info: ControllerMpd::seek
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:15 volumio volumio[826]: error: null
May 07 13:00:15 volumio volumio[826]: info:
May 07 13:00:15 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:15 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:15 volumio volumio[826]: info:
May 07 13:00:15 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:15 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:15 volumio volumio[826]: info:
May 07 13:00:15 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:15 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:15 volumio volumio[826]: info: sendMpdCommand status took 2 milliseconds
May 07 13:00:15 volumio volumio[826]: info: sendMpdCommand status took 1 milliseconds
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:15 volumio volumio[826]: info: sendMpdCommand status took 1 milliseconds
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:15 volumio volumio[826]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 07 13:00:15 volumio volumio[826]: info: sendMpdCommand playlistinfo took 0 milliseconds
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:15 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:15 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":52455,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"576 Kbps","isStreaming":false,"title":"Hang around me","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(07) [Hadouk Trio] Hang around me.wv","trackType":"wv"}
May 07 13:00:15 volumio volumio[826]: verbose: CURRENT POSITION 6
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:15 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:15 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:15 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":52455,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"559 Kbps","isStreaming":false,"title":"Hang around me","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(07) [Hadouk Trio] Hang around me.wv","trackType":"wv"}
May 07 13:00:15 volumio volumio[826]: verbose: CURRENT POSITION 6
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:15 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:15 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:15 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":52455,"duration":139,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"559 Kbps","isStreaming":false,"title":"Hang around me","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(07) [Hadouk Trio] Hang around me.wv","trackType":"wv"}
May 07 13:00:15 volumio volumio[826]: verbose: CURRENT POSITION 6
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:15 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:15 volumio volumio[826]: info: ------------------------------ 36ms
May 07 13:00:15 volumio volumio[826]: info: ------------------------------ 35ms
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::volumioNext
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::next
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::stop
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::stPlaybackTimer
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::updateTrackBlock
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrackBlock
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::serviceStop
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 6
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::serviceStop
May 07 13:00:15 volumio volumio[826]: info: ControllerMpd::stop
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand stop
May 07 13:00:15 volumio volumio[826]: info:
May 07 13:00:15 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:15 volumio volumio[826]: info: sendMpdCommand stop took 45 milliseconds
May 07 13:00:15 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::play index undefined
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::startPlaybackTimer
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::clearAddPlayTracks USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(08) [Hadouk Trio] Hang2hang.wv
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand stop
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::updateTrackBlock
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrackBlock
May 07 13:00:15 volumio volumio[826]: info:
May 07 13:00:15 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:15 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:15 volumio volumio[826]: info:
May 07 13:00:15 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:15 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:15 volumio volumio[826]: info: sendMpdCommand status took 6 milliseconds
May 07 13:00:15 volumio volumio[826]: info: sendMpdCommand stop took 5 milliseconds
May 07 13:00:15 volumio volumio[826]: info: sendMpdCommand status took 2 milliseconds
May 07 13:00:15 volumio volumio[826]: info: sendMpdCommand status took 1 milliseconds
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand clear
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:15 volumio volumio[826]: info:
May 07 13:00:15 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:15 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:15 volumio volumio[826]: info: sendMpdCommand playlistinfo took 7 milliseconds
May 07 13:00:15 volumio volumio[826]: info: sendMpdCommand clear took 7 milliseconds
May 07 13:00:15 volumio volumio[826]: info: sendMpdCommand playlistinfo took 7 milliseconds
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand add "USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(08) [Hadouk Trio] Hang2hang.wv"
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:15 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:15 volumio volumio[826]: 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":"Hang around me","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(07) [Hadouk Trio] Hang around me.wv","trackType":"wv"}
May 07 13:00:15 volumio volumio[826]: verbose: CURRENT POSITION 7
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::syncState stateService stop
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus stop
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:15 volumio volumio[826]: info: No code
May 07 13:00:15 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:15 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:15 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:15 volumio volumio[826]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 07 13:00:15 volumio volumio[826]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 07 13:00:15 volumio volumio[826]: info: ------------------------------ 38ms
May 07 13:00:15 volumio volumio[826]: info: ------------------------------ 34ms
May 07 13:00:15 volumio volumio[826]: info: ------------------------------ 33ms
May 07 13:00:15 volumio volumio[826]: info:
May 07 13:00:15 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:15 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:15 volumio volumio[826]: info:
May 07 13:00:15 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:15 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:15 volumio volumio[826]: error: updateQueue error: null
May 07 13:00:15 volumio volumio[826]: info:
May 07 13:00:15 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:15 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:15 volumio volumio[826]: info: ------------------------------ 25ms
May 07 13:00:15 volumio volumio[826]: info: sendMpdCommand add "USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(08) [Hadouk Trio] Hang2hang.wv" took 24 milliseconds
May 07 13:00:15 volumio volumio[826]: info: ------------------------------ 3ms
May 07 13:00:15 volumio volumio[826]: info: ------------------------------ 2ms
May 07 13:00:15 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand play
May 07 13:00:15 volumio volumio[826]: info:
May 07 13:00:15 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:15 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:15 volumio volumio[826]: info:
May 07 13:00:15 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:15 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:15 volumio volumio[826]: info: ------------------------------ 9ms
May 07 13:00:15 volumio volumio[826]: info: sendMpdCommand play took 8 milliseconds
May 07 13:00:15 volumio volumio[826]: info: ------------------------------ 7ms
May 07 13:00:16 volumio volumio[826]: info:
May 07 13:00:16 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:16 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:16 volumio volumio[826]: info:
May 07 13:00:16 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:16 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:16 volumio volumio[826]: info:
May 07 13:00:16 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:16 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:16 volumio volumio[826]: info:
May 07 13:00:16 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:16 volumio volumio[826]: info: sendMpdCommand status took 4 milliseconds
May 07 13:00:16 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:16 volumio volumio[826]: info: sendMpdCommand status took 2 milliseconds
May 07 13:00:16 volumio volumio[826]: info: sendMpdCommand status took 3 milliseconds
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:16 volumio volumio[826]: info:
May 07 13:00:16 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:16 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:16 volumio volumio[826]: info:
May 07 13:00:16 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:16 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:16 volumio volumio[826]: info: sendMpdCommand status took 3 milliseconds
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:16 volumio volumio[826]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 07 13:00:16 volumio volumio[826]: info: sendMpdCommand playlistinfo took 4 milliseconds
May 07 13:00:16 volumio volumio[826]: info: sendMpdCommand status took 3 milliseconds
May 07 13:00:16 volumio volumio[826]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:16 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:16 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:16 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:16 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hang2hang","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(08) [Hadouk Trio] Hang2hang.wv","trackType":"wv"}
May 07 13:00:16 volumio volumio[826]: verbose: CURRENT POSITION 7
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus stop
May 07 13:00:16 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:16 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:16 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:16 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hang2hang","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(08) [Hadouk Trio] Hang2hang.wv","trackType":"wv"}
May 07 13:00:16 volumio volumio[826]: verbose: CURRENT POSITION 7
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:16 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:16 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:16 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:00:16 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:16 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:16 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:16 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:16 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:16 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:16 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hang2hang","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(08) [Hadouk Trio] Hang2hang.wv","trackType":"wv"}
May 07 13:00:16 volumio volumio[826]: verbose: CURRENT POSITION 7
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:16 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:16 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:16 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:16 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:16 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:16 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:16 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:16 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:16 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hang2hang","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(08) [Hadouk Trio] Hang2hang.wv","trackType":"wv"}
May 07 13:00:16 volumio volumio[826]: verbose: CURRENT POSITION 7
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:16 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:16 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:16 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:16 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:16 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:16 volumio volumio[826]: info: ------------------------------ 25ms
May 07 13:00:16 volumio volumio[826]: info: ------------------------------ 72ms
May 07 13:00:16 volumio volumio[826]: info: ------------------------------ 72ms
May 07 13:00:16 volumio volumio[826]: info: ------------------------------ 74ms
May 07 13:00:16 volumio volumio[826]: info: sendMpdCommand playlistinfo took 70 milliseconds
May 07 13:00:16 volumio volumio[826]: info: sendMpdCommand playlistinfo took 70 milliseconds
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:16 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:16 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:16 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:16 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:16 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hang2hang","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(08) [Hadouk Trio] Hang2hang.wv","trackType":"wv"}
May 07 13:00:16 volumio volumio[826]: verbose: CURRENT POSITION 7
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:16 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:16 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:16 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:16 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:16 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:16 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:16 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:16 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:16 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hang2hang","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(08) [Hadouk Trio] Hang2hang.wv","trackType":"wv"}
May 07 13:00:16 volumio volumio[826]: verbose: CURRENT POSITION 7
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:16 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:16 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:16 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:16 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:16 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:16 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:16 volumio volumio[826]: info: ------------------------------ 141ms
May 07 13:00:16 volumio volumio[826]: info: ------------------------------ 142ms
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::volumioNext
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::next
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::stop
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::stPlaybackTimer
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::updateTrackBlock
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrackBlock
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::serviceStop
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 7
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::serviceStop
May 07 13:00:22 volumio volumio[826]: info: ControllerMpd::stop
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand stop
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand stop took 45 milliseconds
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::play index undefined
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::startPlaybackTimer
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::clearAddPlayTracks USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(09) [Hadouk Trio] Nambaraп Gate.wv
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand stop
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::updateTrackBlock
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrackBlock
May 07 13:00:22 volumio volumio[826]: info:
May 07 13:00:22 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:22 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:22 volumio volumio[826]: info:
May 07 13:00:22 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:22 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:22 volumio volumio[826]: info:
May 07 13:00:22 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:22 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand stop took 7 milliseconds
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand status took 5 milliseconds
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand status took 1 milliseconds
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand clear
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:22 volumio volumio[826]: info:
May 07 13:00:22 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:22 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand status took 1 milliseconds
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand clear took 2 milliseconds
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand add "USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(09) [Hadouk Trio] Nambaraп Gate.wv"
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:22 volumio volumio[826]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 07 13:00:22 volumio volumio[826]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 07 13:00:22 volumio volumio[826]: info: ------------------------------ 9ms
May 07 13:00:22 volumio volumio[826]: info: ------------------------------ 5ms
May 07 13:00:22 volumio volumio[826]: info:
May 07 13:00:22 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:22 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:22 volumio volumio[826]: info:
May 07 13:00:22 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:22 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:22 volumio volumio[826]: error: updateQueue error: null
May 07 13:00:22 volumio volumio[826]: info:
May 07 13:00:22 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:22 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:22 volumio volumio[826]: info: ------------------------------ 3ms
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand add "USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(09) [Hadouk Trio] Nambaraп Gate.wv" took 3 milliseconds
May 07 13:00:22 volumio volumio[826]: info: ------------------------------ 2ms
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand play
May 07 13:00:22 volumio volumio[826]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 07 13:00:22 volumio volumio[826]: info: ------------------------------ 6ms
May 07 13:00:22 volumio volumio[826]: info:
May 07 13:00:22 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:22 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:22 volumio volumio[826]: info:
May 07 13:00:22 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:22 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:22 volumio volumio[826]: info: ------------------------------ 3ms
May 07 13:00:22 volumio volumio[826]: info: ------------------------------ 4ms
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand play took 3 milliseconds
May 07 13:00:22 volumio volumio[826]: info: ------------------------------ 2ms
May 07 13:00:22 volumio volumio[826]: info:
May 07 13:00:22 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:22 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:22 volumio volumio[826]: info:
May 07 13:00:22 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:22 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:22 volumio volumio[826]: info:
May 07 13:00:22 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:22 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:22 volumio volumio[826]: info:
May 07 13:00:22 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:22 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand status took 3 milliseconds
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand status took 2 milliseconds
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:22 volumio volumio[826]: info:
May 07 13:00:22 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:22 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:22 volumio volumio[826]: info:
May 07 13:00:22 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:22 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand status took 3 milliseconds
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand status took 1 milliseconds
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:22 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:22 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":61,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nambaraп Gate","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(09) [Hadouk Trio] Nambaraп Gate.wv","trackType":"wv"}
May 07 13:00:22 volumio volumio[826]: verbose: CURRENT POSITION 8
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus stop
May 07 13:00:22 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:22 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":61,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nambaraп Gate","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(09) [Hadouk Trio] Nambaraп Gate.wv","trackType":"wv"}
May 07 13:00:22 volumio volumio[826]: verbose: CURRENT POSITION 8
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:22 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:22 volumio volumio[826]: info: ------------------------------ 15ms
May 07 13:00:22 volumio volumio[826]: info: ------------------------------ 34ms
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand playlistinfo took 30 milliseconds
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand playlistinfo took 29 milliseconds
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand playlistinfo took 29 milliseconds
May 07 13:00:22 volumio volumio[826]: info: sendMpdCommand playlistinfo took 29 milliseconds
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:22 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:22 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:22 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":61,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nambaraп Gate","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(09) [Hadouk Trio] Nambaraп Gate.wv","trackType":"wv"}
May 07 13:00:22 volumio volumio[826]: verbose: CURRENT POSITION 8
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:22 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:22 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:22 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":61,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nambaraп Gate","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(09) [Hadouk Trio] Nambaraп Gate.wv","trackType":"wv"}
May 07 13:00:22 volumio volumio[826]: verbose: CURRENT POSITION 8
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:22 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:22 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:22 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":61,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nambaraп Gate","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(09) [Hadouk Trio] Nambaraп Gate.wv","trackType":"wv"}
May 07 13:00:22 volumio volumio[826]: verbose: CURRENT POSITION 8
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:22 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:22 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:22 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":61,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nambaraп Gate","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(09) [Hadouk Trio] Nambaraп Gate.wv","trackType":"wv"}
May 07 13:00:22 volumio volumio[826]: verbose: CURRENT POSITION 8
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:22 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:22 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:22 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:22 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:22 volumio volumio[826]: info: ------------------------------ 176ms
May 07 13:00:22 volumio volumio[826]: info: ------------------------------ 175ms
May 07 13:00:22 volumio volumio[826]: info: ------------------------------ 174ms
May 07 13:00:25 volumio volumio[826]: info: CoreCommandRouter::volumioNext
May 07 13:00:25 volumio volumio[826]: info: CoreStateMachine::next
May 07 13:00:25 volumio volumio[826]: info: CoreStateMachine::stop
May 07 13:00:25 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined
May 07 13:00:25 volumio volumio[826]: info: CoreStateMachine::stPlaybackTimer
May 07 13:00:25 volumio volumio[826]: info: CoreStateMachine::updateTrackBlock
May 07 13:00:25 volumio volumio[826]: info: CorePlayQueue::getTrackBlock
May 07 13:00:25 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:25 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:25 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:00:25 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:25 volumio volumio[826]: info: CoreStateMachine::serviceStop
May 07 13:00:25 volumio volumio[826]: info: CorePlayQueue::getTrack 8
May 07 13:00:25 volumio volumio[826]: info: CoreCommandRouter::serviceStop
May 07 13:00:25 volumio volumio[826]: info: ControllerMpd::stop
May 07 13:00:25 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand stop
May 07 13:00:25 volumio volumio[826]: info:
May 07 13:00:25 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:25 volumio volumio[826]: info: sendMpdCommand stop took 46 milliseconds
May 07 13:00:25 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:25 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:25 volumio volumio[826]: info: CoreStateMachine::play index undefined
May 07 13:00:25 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined
May 07 13:00:25 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:25 volumio volumio[826]: info: CoreStateMachine::startPlaybackTimer
May 07 13:00:25 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:25 volumio volumio[826]: verbose: ControllerMpd::clearAddPlayTracks USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(10) [Hadouk Trio] Nambaraп.wv
May 07 13:00:25 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand stop
May 07 13:00:25 volumio volumio[826]: info: CoreStateMachine::updateTrackBlock
May 07 13:00:25 volumio volumio[826]: info: CorePlayQueue::getTrackBlock
May 07 13:00:25 volumio volumio[826]: info:
May 07 13:00:25 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:25 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:25 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:25 volumio volumio[826]: info:
May 07 13:00:25 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:25 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:25 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:25 volumio volumio[826]: info: sendMpdCommand status took 6 milliseconds
May 07 13:00:25 volumio volumio[826]: info: sendMpdCommand stop took 6 milliseconds
May 07 13:00:25 volumio volumio[826]: info: sendMpdCommand status took 3 milliseconds
May 07 13:00:25 volumio volumio[826]: info: sendMpdCommand status took 2 milliseconds
May 07 13:00:25 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:25 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:25 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand clear
May 07 13:00:25 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:25 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:25 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:25 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:25 volumio volumio[826]: info:
May 07 13:00:25 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:25 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:25 volumio volumio[826]: info: sendMpdCommand playlistinfo took 4 milliseconds
May 07 13:00:25 volumio volumio[826]: info: sendMpdCommand clear took 6 milliseconds
May 07 13:00:25 volumio volumio[826]: info: sendMpdCommand playlistinfo took 7 milliseconds
May 07 13:00:25 volumio volumio[826]: info: sendMpdCommand playlistinfo took 7 milliseconds
May 07 13:00:25 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:25 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand add "USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(10) [Hadouk Trio] Nambaraп.wv"
May 07 13:00:25 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:25 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:25 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:25 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:25 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:25 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:25 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:00:25 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:25 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:25 volumio volumio[826]: 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":"Nambaraп Gate","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(09) [Hadouk Trio] Nambaraп Gate.wv","trackType":"wv"}
May 07 13:00:25 volumio volumio[826]: verbose: CURRENT POSITION 9
May 07 13:00:25 volumio volumio[826]: info: CoreStateMachine::syncState stateService stop
May 07 13:00:25 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus stop
May 07 13:00:25 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:25 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:25 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:25 volumio volumio[826]: info: No code
May 07 13:00:25 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:25 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:25 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:25 volumio volumio[826]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 07 13:00:25 volumio volumio[826]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 07 13:00:25 volumio volumio[826]: info: ------------------------------ 31ms
May 07 13:00:25 volumio volumio[826]: info: ------------------------------ 27ms
May 07 13:00:25 volumio volumio[826]: info: ------------------------------ 26ms
May 07 13:00:25 volumio volumio[826]: info:
May 07 13:00:25 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:25 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:25 volumio volumio[826]: info:
May 07 13:00:25 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:25 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:25 volumio volumio[826]: error: updateQueue error: null
May 07 13:00:25 volumio volumio[826]: info:
May 07 13:00:25 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:25 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:25 volumio volumio[826]: info: ------------------------------ 25ms
May 07 13:00:25 volumio volumio[826]: info: sendMpdCommand add "USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(10) [Hadouk Trio] Nambaraп.wv" took 19 milliseconds
May 07 13:00:25 volumio volumio[826]: info: ------------------------------ 2ms
May 07 13:00:25 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand play
May 07 13:00:25 volumio volumio[826]: info:
May 07 13:00:25 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:25 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:25 volumio volumio[826]: info: ------------------------------ 12ms
May 07 13:00:25 volumio volumio[826]: info: ------------------------------ 10ms
May 07 13:00:25 volumio volumio[826]: info: sendMpdCommand play took 9 milliseconds
May 07 13:00:25 volumio volumio[826]: info: ------------------------------ 9ms
May 07 13:00:25 volumio volumio[826]: info:
May 07 13:00:25 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:25 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:25 volumio volumio[826]: info: ------------------------------ 1ms
May 07 13:00:26 volumio volumio[826]: info:
May 07 13:00:26 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:26 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:26 volumio volumio[826]: info:
May 07 13:00:26 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:26 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:26 volumio volumio[826]: info:
May 07 13:00:26 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:26 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:26 volumio volumio[826]: info:
May 07 13:00:26 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:26 volumio volumio[826]: info: sendMpdCommand status took 4 milliseconds
May 07 13:00:26 volumio volumio[826]: info: sendMpdCommand status took 3 milliseconds
May 07 13:00:26 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:26 volumio volumio[826]: info:
May 07 13:00:26 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:26 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:26 volumio volumio[826]: info:
May 07 13:00:26 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:26 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:26 volumio volumio[826]: info: sendMpdCommand status took 4 milliseconds
May 07 13:00:26 volumio volumio[826]: info: sendMpdCommand status took 4 milliseconds
May 07 13:00:26 volumio volumio[826]: info: sendMpdCommand playlistinfo took 4 milliseconds
May 07 13:00:26 volumio volumio[826]: info: sendMpdCommand playlistinfo took 4 milliseconds
May 07 13:00:26 volumio volumio[826]: info: sendMpdCommand status took 3 milliseconds
May 07 13:00:26 volumio volumio[826]: info: sendMpdCommand status took 1 milliseconds
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:26 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:26 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:26 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:26 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nambaraп","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(10) [Hadouk Trio] Nambaraп.wv","trackType":"wv"}
May 07 13:00:26 volumio volumio[826]: verbose: CURRENT POSITION 9
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus stop
May 07 13:00:26 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:26 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:26 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:26 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nambaraп","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(10) [Hadouk Trio] Nambaraп.wv","trackType":"wv"}
May 07 13:00:26 volumio volumio[826]: verbose: CURRENT POSITION 9
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:26 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:26 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:26 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:00:26 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:26 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:26 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:26 volumio volumio[826]: info: ------------------------------ 20ms
May 07 13:00:26 volumio volumio[826]: info: ------------------------------ 35ms
May 07 13:00:26 volumio volumio[826]: info: sendMpdCommand playlistinfo took 28 milliseconds
May 07 13:00:26 volumio volumio[826]: info: sendMpdCommand playlistinfo took 29 milliseconds
May 07 13:00:26 volumio volumio[826]: info: sendMpdCommand playlistinfo took 28 milliseconds
May 07 13:00:26 volumio volumio[826]: info: sendMpdCommand playlistinfo took 29 milliseconds
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:26 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:26 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:26 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:26 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:26 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nambaraп","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(10) [Hadouk Trio] Nambaraп.wv","trackType":"wv"}
May 07 13:00:26 volumio volumio[826]: verbose: CURRENT POSITION 9
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:26 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:26 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:26 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:26 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:26 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:26 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:26 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:26 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:26 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nambaraп","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(10) [Hadouk Trio] Nambaraп.wv","trackType":"wv"}
May 07 13:00:26 volumio volumio[826]: verbose: CURRENT POSITION 9
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:26 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:26 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:26 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:26 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:26 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:26 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:26 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:26 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:26 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nambaraп","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(10) [Hadouk Trio] Nambaraп.wv","trackType":"wv"}
May 07 13:00:26 volumio volumio[826]: verbose: CURRENT POSITION 9
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:26 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:26 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:26 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:26 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:26 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:26 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:26 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:26 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:26 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nambaraп","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(10) [Hadouk Trio] Nambaraп.wv","trackType":"wv"}
May 07 13:00:26 volumio volumio[826]: verbose: CURRENT POSITION 9
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:26 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:26 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:26 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:26 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:26 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:26 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:26 volumio volumio[826]: info: ------------------------------ 112ms
May 07 13:00:26 volumio volumio[826]: info: ------------------------------ 110ms
May 07 13:00:26 volumio volumio[826]: info: ------------------------------ 108ms
May 07 13:00:27 volumio volumio[826]: info: CoreCommandRouter::volumioGetQueue
May 07 13:00:27 volumio volumio[826]: info: CoreStateMachine::getQueue
May 07 13:00:27 volumio volumio[826]: info: CorePlayQueue::getQueue
May 07 13:00:33 volumio volumio[826]: info: CoreCommandRouter::volumioClearQueue
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::ClearQueue
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::stop
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::stPlaybackTimer
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::updateTrackBlock
May 07 13:00:33 volumio volumio[826]: info: CorePlayQueue::getTrackBlock
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:33 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:33 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:00:33 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::serviceStop
May 07 13:00:33 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:33 volumio volumio[826]: info: CoreCommandRouter::serviceStop
May 07 13:00:33 volumio volumio[826]: info: ControllerMpd::stop
May 07 13:00:33 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand stop
May 07 13:00:33 volumio volumio[826]: info: CorePlayQueue::clearPlayQueue
May 07 13:00:33 volumio volumio[826]: info: CorePlayQueue::saveQueue
May 07 13:00:33 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:33 volumio volumio[826]: info: CoreCommandRouter::volumioPushQueue
May 07 13:00:33 volumio volumio[826]: info:
May 07 13:00:33 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:33 volumio volumio[826]: info: sendMpdCommand stop took 61 milliseconds
May 07 13:00:33 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:33 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:33 volumio volumio[826]: info:
May 07 13:00:33 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:33 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:33 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:33 volumio volumio[826]: info:
May 07 13:00:33 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:33 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:33 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:33 volumio volumio[826]: info: sendMpdCommand status took 3 milliseconds
May 07 13:00:33 volumio volumio[826]: info: sendMpdCommand status took 2 milliseconds
May 07 13:00:33 volumio volumio[826]: info: sendMpdCommand status took 3 milliseconds
May 07 13:00:33 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:33 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:33 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:33 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:33 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:33 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:33 volumio volumio[826]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 07 13:00:33 volumio volumio[826]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 07 13:00:33 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:33 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:33 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:33 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:33 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:33 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:33 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:00:33 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:33 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:33 volumio volumio[826]: 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":"Nambaraп","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(10) [Hadouk Trio] Nambaraп.wv","trackType":"wv"}
May 07 13:00:33 volumio volumio[826]: verbose: CURRENT POSITION 9
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::syncState stateService stop
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus stop
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:33 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:33 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:33 volumio volumio[826]: info: No code
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:33 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:33 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:33 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:33 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:33 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:33 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:33 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:33 volumio volumio[826]: 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":"Nambaraп","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(10) [Hadouk Trio] Nambaraп.wv","trackType":"wv"}
May 07 13:00:33 volumio volumio[826]: verbose: CURRENT POSITION 9
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::syncState stateService stop
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus stop
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:33 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:33 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:33 volumio volumio[826]: info: No code
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:33 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:33 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:33 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:33 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:33 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:33 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:33 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:33 volumio volumio[826]: 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":"Nambaraп","artist":"Hadouk Trio","album":"Air Hadouk","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/ДЖАЗ/2010 - Air Hadouk/(10) [Hadouk Trio] Nambaraп.wv","trackType":"wv"}
May 07 13:00:33 volumio volumio[826]: verbose: CURRENT POSITION 9
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::syncState stateService stop
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus stop
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:33 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:33 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:33 volumio volumio[826]: info: No code
May 07 13:00:33 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:33 volumio volumio[826]: info: CorePlayQueue::getTrack 9
May 07 13:00:33 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:33 volumio volumio[826]: info: ------------------------------ 48ms
May 07 13:00:33 volumio volumio[826]: info: ------------------------------ 47ms
May 07 13:00:33 volumio volumio[826]: info: ------------------------------ 46ms
May 07 13:00:49 volumio volumio[826]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
May 07 13:00:52 volumio volumio[826]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
May 07 13:00:53 volumio volumio[826]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
May 07 13:00:54 volumio volumio[826]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
May 07 13:00:58 volumio volumio[826]: info: Preload queue cleared
May 07 13:00:58 volumio volumio[826]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::ClearQueue
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::stop
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined
May 07 13:00:58 volumio volumio[826]: info: CorePlayQueue::clearPlayQueue
May 07 13:00:58 volumio volumio[826]: info: CorePlayQueue::saveQueue
May 07 13:00:58 volumio volumio[826]: info: CoreCommandRouter::volumioPushQueue
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::addQueueItems
May 07 13:00:58 volumio volumio[826]: info: CorePlayQueue::addQueueItems
May 07 13:00:58 volumio volumio[826]: info: Preload queue cleared
May 07 13:00:58 volumio volumio[826]: info: Adding Item to queue: artists://Cliff%20Richard%20%26%20The%20Shadows
May 07 13:00:58 volumio volumio[826]: info: Exploding uri artists://Cliff%20Richard%20%26%20The%20Shadows in service mpd
May 07 13:00:58 volumio volumio[826]: info: CoreCommandRouter::volumioPushQueue
May 07 13:00:58 volumio volumio[826]: info: CorePlayQueue::saveQueue
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::updateTrackBlock
May 07 13:00:58 volumio volumio[826]: info: CorePlayQueue::getTrackBlock
May 07 13:00:58 volumio volumio[826]: info: CoreCommandRouter::volumioPlay
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::play index 0
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::stop
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::play index undefined
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined
May 07 13:00:58 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::startPlaybackTimer
May 07 13:00:58 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::clearAddPlayTracks USB/2E3CD90E3CD8D247/МУЗЫКА/POPSA!!!/VA - 100 Greatest Breakfast Songs (2019) FLAC/078 - Cliff Richard & The Shadows - The Young Ones.flac
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand stop
May 07 13:00:58 volumio volumio[826]: info: sendMpdCommand stop took 1 milliseconds
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand clear
May 07 13:00:58 volumio volumio[826]: info:
May 07 13:00:58 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:58 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:58 volumio volumio[826]: info: sendMpdCommand clear took 1 milliseconds
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand add "USB/2E3CD90E3CD8D247/МУЗЫКА/POPSA!!!/VA - 100 Greatest Breakfast Songs (2019) FLAC/078 - Cliff Richard & The Shadows - The Young Ones.flac"
May 07 13:00:58 volumio volumio[826]: info:
May 07 13:00:58 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:58 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:58 volumio volumio[826]: info:
May 07 13:00:58 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:58 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:58 volumio volumio[826]: error: updateQueue error: null
May 07 13:00:58 volumio volumio[826]: info:
May 07 13:00:58 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:58 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:58 volumio volumio[826]: info: ------------------------------ 5ms
May 07 13:00:58 volumio volumio[826]: info: sendMpdCommand add "USB/2E3CD90E3CD8D247/МУЗЫКА/POPSA!!!/VA - 100 Greatest Breakfast Songs (2019) FLAC/078 - Cliff Richard & The Shadows - The Young Ones.flac" took 5 milliseconds
May 07 13:00:58 volumio volumio[826]: info: ------------------------------ 5ms
May 07 13:00:58 volumio volumio[826]: info: ------------------------------ 5ms
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand play
May 07 13:00:58 volumio volumio[826]: info:
May 07 13:00:58 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:58 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:58 volumio volumio[826]: info:
May 07 13:00:58 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:00:58 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:00:58 volumio volumio[826]: info: ------------------------------ 6ms
May 07 13:00:58 volumio volumio[826]: info: sendMpdCommand play took 5 milliseconds
May 07 13:00:58 volumio volumio[826]: info: ------------------------------ 4ms
May 07 13:00:58 volumio volumio[826]: info: ------------------------------ 3ms
May 07 13:00:58 volumio volumio[826]: info:
May 07 13:00:58 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:58 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:58 volumio volumio[826]: info:
May 07 13:00:58 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:58 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:58 volumio volumio[826]: info:
May 07 13:00:58 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:58 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:58 volumio volumio[826]: info:
May 07 13:00:58 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:58 volumio volumio[826]: info: sendMpdCommand status took 3 milliseconds
May 07 13:00:58 volumio volumio[826]: info: sendMpdCommand status took 3 milliseconds
May 07 13:00:58 volumio volumio[826]: info: sendMpdCommand status took 2 milliseconds
May 07 13:00:58 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:58 volumio volumio[826]: info:
May 07 13:00:58 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:58 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:58 volumio volumio[826]: info:
May 07 13:00:58 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:00:58 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:00:58 volumio volumio[826]: info: sendMpdCommand status took 2 milliseconds
May 07 13:00:58 volumio volumio[826]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 07 13:00:58 volumio volumio[826]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 07 13:00:58 volumio volumio[826]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 07 13:00:58 volumio volumio[826]: info: sendMpdCommand status took 1 milliseconds
May 07 13:00:58 volumio volumio[826]: info: sendMpdCommand status took 3 milliseconds
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:00:58 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:58 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:58 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:00:58 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":191,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Young Ones","artist":"Cliff Richard & The Shadows","album":"100 Greatest Breakfast Songs","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/POPSA!!!/VA - 100 Greatest Breakfast Songs (2019) FLAC/078 - Cliff Richard & The Shadows - The Young Ones.flac","trackType":"flac"}
May 07 13:00:58 volumio volumio[826]: verbose: CURRENT POSITION 0
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus stop
May 07 13:00:58 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:58 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:58 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:00:58 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":191,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Young Ones","artist":"Cliff Richard & The Shadows","album":"100 Greatest Breakfast Songs","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/POPSA!!!/VA - 100 Greatest Breakfast Songs (2019) FLAC/078 - Cliff Richard & The Shadows - The Young Ones.flac","trackType":"flac"}
May 07 13:00:58 volumio volumio[826]: verbose: CURRENT POSITION 0
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:58 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:58 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:00:58 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:00:58 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:58 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:00:58 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:58 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:58 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:58 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:00:58 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":191,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Young Ones","artist":"Cliff Richard & The Shadows","album":"100 Greatest Breakfast Songs","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/POPSA!!!/VA - 100 Greatest Breakfast Songs (2019) FLAC/078 - Cliff Richard & The Shadows - The Young Ones.flac","trackType":"flac"}
May 07 13:00:58 volumio volumio[826]: verbose: CURRENT POSITION 0
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:58 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:58 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:00:58 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:58 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:00:58 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:58 volumio volumio[826]: info: ------------------------------ 16ms
May 07 13:00:58 volumio volumio[826]: info: ------------------------------ 36ms
May 07 13:00:58 volumio volumio[826]: info: sendMpdCommand playlistinfo took 29 milliseconds
May 07 13:00:58 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:00:58 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:58 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:58 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:00:58 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":191,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Young Ones","artist":"Cliff Richard & The Shadows","album":"100 Greatest Breakfast Songs","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/POPSA!!!/VA - 100 Greatest Breakfast Songs (2019) FLAC/078 - Cliff Richard & The Shadows - The Young Ones.flac","trackType":"flac"}
May 07 13:00:58 volumio volumio[826]: verbose: CURRENT POSITION 0
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:58 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:58 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:58 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:00:58 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:59 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:59 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:00:59 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:59 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:59 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:59 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:00:59 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":191,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Young Ones","artist":"Cliff Richard & The Shadows","album":"100 Greatest Breakfast Songs","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/POPSA!!!/VA - 100 Greatest Breakfast Songs (2019) FLAC/078 - Cliff Richard & The Shadows - The Young Ones.flac","trackType":"flac"}
May 07 13:00:59 volumio volumio[826]: verbose: CURRENT POSITION 0
May 07 13:00:59 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:59 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:59 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:59 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:59 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:00:59 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:59 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:59 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:00:59 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:59 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:00:59 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:00:59 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:00:59 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":191,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Young Ones","artist":"Cliff Richard & The Shadows","album":"100 Greatest Breakfast Songs","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/POPSA!!!/VA - 100 Greatest Breakfast Songs (2019) FLAC/078 - Cliff Richard & The Shadows - The Young Ones.flac","trackType":"flac"}
May 07 13:00:59 volumio volumio[826]: verbose: CURRENT POSITION 0
May 07 13:00:59 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:00:59 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:00:59 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:00:59 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:59 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:00:59 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:59 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:00:59 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:00:59 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:00:59 volumio volumio[826]: info: ------------------------------ 99ms
May 07 13:00:59 volumio volumio[826]: info: ------------------------------ 97ms
May 07 13:00:59 volumio volumio[826]: info: ------------------------------ 98ms
May 07 13:01:08 volumio volumio[826]: info: Preload queue cleared
May 07 13:01:08 volumio volumio[826]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::ClearQueue
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::stop
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::stPlaybackTimer
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::updateTrackBlock
May 07 13:01:08 volumio volumio[826]: info: CorePlayQueue::getTrackBlock
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:01:08 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:08 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:01:08 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::serviceStop
May 07 13:01:08 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:08 volumio volumio[826]: info: CoreCommandRouter::serviceStop
May 07 13:01:08 volumio volumio[826]: info: ControllerMpd::stop
May 07 13:01:08 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand stop
May 07 13:01:08 volumio volumio[826]: info: CorePlayQueue::clearPlayQueue
May 07 13:01:08 volumio volumio[826]: info: CorePlayQueue::saveQueue
May 07 13:01:08 volumio volumio[826]: info: CoreCommandRouter::volumioPushQueue
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::addQueueItems
May 07 13:01:08 volumio volumio[826]: info: CorePlayQueue::addQueueItems
May 07 13:01:08 volumio volumio[826]: info: Preload queue cleared
May 07 13:01:08 volumio volumio[826]: info: Adding Item to queue: albums://Paul%20McCartney/Kisses%20On%20the%20Bottom%20%E2%80%93%20Complete%20Kisses
May 07 13:01:08 volumio volumio[826]: info: Exploding uri albums://Paul%20McCartney/Kisses%20On%20the%20Bottom%20%E2%80%93%20Complete%20Kisses in service mpd
May 07 13:01:08 volumio volumio[826]: info: CoreCommandRouter::volumioPushQueue
May 07 13:01:08 volumio volumio[826]: info: CorePlayQueue::saveQueue
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::updateTrackBlock
May 07 13:01:08 volumio volumio[826]: info: CorePlayQueue::getTrackBlock
May 07 13:01:08 volumio volumio[826]: info: CoreCommandRouter::volumioPlay
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::play index 0
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::stop
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::play index undefined
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined
May 07 13:01:08 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::startPlaybackTimer
May 07 13:01:08 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:08 volumio volumio[826]: verbose: ControllerMpd::clearAddPlayTracks USB/2E3CD90E3CD8D247/МУЗЫКА/BLUESROCK/2012 - Kisses On the Bottom – Complete Kisses/01 I'm Gonna Sit Right Down and Writ.flac
May 07 13:01:08 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand stop
May 07 13:01:08 volumio volumio[826]: info: sendMpdCommand stop took 46 milliseconds
May 07 13:01:08 volumio volumio[826]: info:
May 07 13:01:08 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:01:08 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:01:08 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:01:08 volumio volumio[826]: info: sendMpdCommand stop took 7 milliseconds
May 07 13:01:08 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand clear
May 07 13:01:08 volumio volumio[826]: info:
May 07 13:01:08 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:01:08 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:01:08 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:01:08 volumio volumio[826]: info:
May 07 13:01:08 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:01:08 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:01:08 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:01:08 volumio volumio[826]: info:
May 07 13:01:08 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:01:08 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:01:08 volumio volumio[826]: info: sendMpdCommand status took 2 milliseconds
May 07 13:01:08 volumio volumio[826]: info: sendMpdCommand clear took 2 milliseconds
May 07 13:01:08 volumio volumio[826]: info: sendMpdCommand status took 1 milliseconds
May 07 13:01:08 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:01:08 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:01:08 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand add "USB/2E3CD90E3CD8D247/МУЗЫКА/BLUESROCK/2012 - Kisses On the Bottom – Complete Kisses/01 I'm Gonna Sit Right Down and Writ.flac"
May 07 13:01:08 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:01:08 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:01:08 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:01:08 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:08 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:01:08 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:01:08 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:08 volumio volumio[826]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
May 07 13:01:08 volumio volumio[826]: verbose: CURRENT POSITION 0
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::syncState stateService stop
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus stop
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:01:08 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:08 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:01:08 volumio volumio[826]: info: No code
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:01:08 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:08 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:01:08 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:01:08 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:01:08 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:08 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:01:08 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:08 volumio volumio[826]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
May 07 13:01:08 volumio volumio[826]: verbose: CURRENT POSITION 0
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::syncState stateService stop
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus stop
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:01:08 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:08 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:01:08 volumio volumio[826]: info: No code
May 07 13:01:08 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:01:08 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:08 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:01:08 volumio volumio[826]: info: ------------------------------ 37ms
May 07 13:01:08 volumio volumio[826]: info: ------------------------------ 37ms
May 07 13:01:08 volumio volumio[826]: info:
May 07 13:01:08 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:01:08 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:01:08 volumio volumio[826]: info:
May 07 13:01:08 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:01:08 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:01:08 volumio volumio[826]: error: updateQueue error: null
May 07 13:01:08 volumio volumio[826]: info:
May 07 13:01:08 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:01:08 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:01:08 volumio volumio[826]: info: ------------------------------ 40ms
May 07 13:01:08 volumio volumio[826]: info: sendMpdCommand playlistinfo took 39 milliseconds
May 07 13:01:08 volumio volumio[826]: info: sendMpdCommand add "USB/2E3CD90E3CD8D247/МУЗЫКА/BLUESROCK/2012 - Kisses On the Bottom – Complete Kisses/01 I'm Gonna Sit Right Down and Writ.flac" took 39 milliseconds
May 07 13:01:08 volumio volumio[826]: info: ------------------------------ 3ms
May 07 13:01:08 volumio volumio[826]: info: ------------------------------ 2ms
May 07 13:01:08 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:01:08 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand play
May 07 13:01:08 volumio volumio[826]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 07 13:01:08 volumio volumio[826]: info: ------------------------------ 43ms
May 07 13:01:08 volumio volumio[826]: info:
May 07 13:01:08 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:01:08 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:01:08 volumio volumio[826]: info:
May 07 13:01:08 volumio volumio[826]: ---------------------------- MPD announces system playlist update
May 07 13:01:08 volumio volumio[826]: info: Ignoring MPD Status Update
May 07 13:01:08 volumio volumio[826]: info: ------------------------------ 14ms
May 07 13:01:08 volumio volumio[826]: info: sendMpdCommand play took 13 milliseconds
May 07 13:01:08 volumio volumio[826]: info: ------------------------------ 12ms
May 07 13:01:08 volumio volumio[826]: info: ------------------------------ 20ms
May 07 13:01:09 volumio volumio[826]: info:
May 07 13:01:09 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:01:09 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:01:09 volumio volumio[826]: info:
May 07 13:01:09 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:01:09 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:01:09 volumio volumio[826]: info:
May 07 13:01:09 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:01:09 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:01:09 volumio volumio[826]: info:
May 07 13:01:09 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:01:09 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:01:09 volumio volumio[826]: info: sendMpdCommand status took 8 milliseconds
May 07 13:01:09 volumio volumio[826]: info: sendMpdCommand status took 6 milliseconds
May 07 13:01:09 volumio volumio[826]: info: sendMpdCommand status took 5 milliseconds
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:01:09 volumio volumio[826]: info:
May 07 13:01:09 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:01:09 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:01:09 volumio volumio[826]: info:
May 07 13:01:09 volumio volumio[826]: ---------------------------- MPD announces state update: player
May 07 13:01:09 volumio volumio[826]: info: ControllerMpd::getState
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand status
May 07 13:01:09 volumio volumio[826]: info: sendMpdCommand status took 6 milliseconds
May 07 13:01:09 volumio volumio[826]: info: sendMpdCommand playlistinfo took 6 milliseconds
May 07 13:01:09 volumio volumio[826]: info: sendMpdCommand playlistinfo took 6 milliseconds
May 07 13:01:09 volumio volumio[826]: info: sendMpdCommand playlistinfo took 6 milliseconds
May 07 13:01:09 volumio volumio[826]: info: sendMpdCommand status took 4 milliseconds
May 07 13:01:09 volumio volumio[826]: info: sendMpdCommand status took 4 milliseconds
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::parseState
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 07 13:01:09 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:01:09 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:01:09 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:09 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":155,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1414 Kbps","isStreaming":false,"title":"I'm Gonna Sit Right Down and Write Myself a Letter","artist":"Paul McCartney","album":"Kisses On the Bottom – Complete Kisses","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/BLUESROCK/2012 - Kisses On the Bottom – Complete Kisses/01 I'm Gonna Sit Right Down and Writ.flac","trackType":"flac"}
May 07 13:01:09 volumio volumio[826]: verbose: CURRENT POSITION 0
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus stop
May 07 13:01:09 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:01:09 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:01:09 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:09 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":155,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1414 Kbps","isStreaming":false,"title":"I'm Gonna Sit Right Down and Write Myself a Letter","artist":"Paul McCartney","album":"Kisses On the Bottom – Complete Kisses","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/BLUESROCK/2012 - Kisses On the Bottom – Complete Kisses/01 I'm Gonna Sit Right Down and Writ.flac","trackType":"flac"}
May 07 13:01:09 volumio volumio[826]: verbose: CURRENT POSITION 0
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:01:09 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:01:09 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:09 volumio volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 13:01:09 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:01:09 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:09 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:01:09 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:01:09 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:01:09 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:09 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":155,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1414 Kbps","isStreaming":false,"title":"I'm Gonna Sit Right Down and Write Myself a Letter","artist":"Paul McCartney","album":"Kisses On the Bottom – Complete Kisses","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/BLUESROCK/2012 - Kisses On the Bottom – Complete Kisses/01 I'm Gonna Sit Right Down and Writ.flac","trackType":"flac"}
May 07 13:01:09 volumio volumio[826]: verbose: CURRENT POSITION 0
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:01:09 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:01:09 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:09 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:01:09 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:09 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:01:09 volumio volumio[826]: info: ------------------------------ 38ms
May 07 13:01:09 volumio volumio[826]: info: ------------------------------ 59ms
May 07 13:01:09 volumio volumio[826]: info: ------------------------------ 57ms
May 07 13:01:09 volumio volumio[826]: info: sendMpdCommand playlistinfo took 52 milliseconds
May 07 13:01:09 volumio volumio[826]: info: sendMpdCommand playlistinfo took 51 milliseconds
May 07 13:01:09 volumio volumio[826]: info: sendMpdCommand playlistinfo took 50 milliseconds
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:01:09 volumio volumio[826]: verbose: ControllerMpd::parseTrackInfo
May 07 13:01:09 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:01:09 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:01:09 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:09 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":155,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1414 Kbps","isStreaming":false,"title":"I'm Gonna Sit Right Down and Write Myself a Letter","artist":"Paul McCartney","album":"Kisses On the Bottom – Complete Kisses","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/BLUESROCK/2012 - Kisses On the Bottom – Complete Kisses/01 I'm Gonna Sit Right Down and Writ.flac","trackType":"flac"}
May 07 13:01:09 volumio volumio[826]: verbose: CURRENT POSITION 0
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:01:09 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:01:09 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:09 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:01:09 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:09 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:01:09 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:01:09 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:01:09 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:09 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":155,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1414 Kbps","isStreaming":false,"title":"I'm Gonna Sit Right Down and Write Myself a Letter","artist":"Paul McCartney","album":"Kisses On the Bottom – Complete Kisses","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/BLUESROCK/2012 - Kisses On the Bottom – Complete Kisses/01 I'm Gonna Sit Right Down and Writ.flac","trackType":"flac"}
May 07 13:01:09 volumio volumio[826]: verbose: CURRENT POSITION 0
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:01:09 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:01:09 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:09 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:01:09 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:09 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:01:09 volumio volumio[826]: info: ControllerMpd::pushState
May 07 13:01:09 volumio volumio[826]: info: CoreCommandRouter::servicePushState
May 07 13:01:09 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:09 volumio volumio[826]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":155,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1414 Kbps","isStreaming":false,"title":"I'm Gonna Sit Right Down and Write Myself a Letter","artist":"Paul McCartney","album":"Kisses On the Bottom – Complete Kisses","uri":"USB/2E3CD90E3CD8D247/МУЗЫКА/BLUESROCK/2012 - Kisses On the Bottom – Complete Kisses/01 I'm Gonna Sit Right Down and Writ.flac","trackType":"flac"}
May 07 13:01:09 volumio volumio[826]: verbose: CURRENT POSITION 0
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::syncState stateService play
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::syncState currentStatus play
May 07 13:01:09 volumio volumio[826]: info: Received an update from plugin. extracting info from payload
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:01:09 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:09 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:01:09 volumio volumio[826]: info: CoreStateMachine::pushState
May 07 13:01:09 volumio volumio[826]: info: CorePlayQueue::getTrack 0
May 07 13:01:09 volumio volumio[826]: info: CoreCommandRouter::volumioPushState
May 07 13:01:09 volumio volumio[826]: info: ------------------------------ 129ms
May 07 13:01:09 volumio volumio[826]: info: ------------------------------ 127ms
May 07 13:01:09 volumio volumio[826]: info: ------------------------------ 126ms
May 07 13:01:20 volumio volumio[826]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 07 13:01:20 volumio volumio[826]: Error: connect ETIMEDOUT 151.101.86.79:80
May 07 13:01:20 volumio volumio[826]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
May 07 13:01:20 volumio volumio[826]: errno: -110,
May 07 13:01:20 volumio volumio[826]: code: 'ETIMEDOUT',
May 07 13:01:20 volumio volumio[826]: syscall: 'connect',
May 07 13:01:20 volumio volumio[826]: address: '151.101.86.79',
May 07 13:01:20 volumio volumio[826]: port: 80
May 07 13:01:20 volumio volumio[826]: }
May 07 13:01:20 volumio volumio[826]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 07 13:01:20 volumio sudo[3556]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-07 13:00
May 07 13:01:20 volumio sudo[3556]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="e7445fab547cd22e23d9bef72406cfb610bc1d7d"
VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee"
VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623"
VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:42:03 PM CEST"
VOLUMIO_VERSION="3.661"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="c434411fe8754b648dc7feb1d8f43761"