-- Logs begin at Thu 2019-02-14 13:12:00 MSK, end at Fri 2024-04-19 02:19:50 MSK. --
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPlay
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreStateMachine::play index 16
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreStateMachine::stop
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreStateMachine::stPlaybackTimer
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreStateMachine::updateTrackBlock
Apr 19 02:18:23 volumio2ag volumio[856]: info: CorePlayQueue::getTrackBlock
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:23 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 7
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreStateMachine::serviceStop
Apr 19 02:18:23 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 7
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreCommandRouter::serviceStop
Apr 19 02:18:23 volumio2ag volumio[856]: info: [1713482303265] ControllerUPNPBrowser::stop
Apr 19 02:18:23 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand stop
Apr 19 02:18:23 volumio2ag volumio[856]: info:
Apr 19 02:18:23 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:18:23 volumio2ag volumio[856]: info: sendMpdCommand stop took 37 milliseconds
Apr 19 02:18:23 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:18:23 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreStateMachine::play index undefined
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:18:23 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 16
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreStateMachine::startPlaybackTimer
Apr 19 02:18:23 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 16
Apr 19 02:18:23 volumio2ag volumio[856]: info: [1713482303312] ControllerUPNPBrowser::clearAddPlayTrack
Apr 19 02:18:23 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand stop
Apr 19 02:18:23 volumio2ag volumio[856]: info:
Apr 19 02:18:23 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:18:23 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:18:23 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:18:23 volumio2ag volumio[856]: info:
Apr 19 02:18:23 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:18:23 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:18:23 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:18:23 volumio2ag volumio[856]: info: sendMpdCommand status took 30 milliseconds
Apr 19 02:18:23 volumio2ag volumio[856]: info: sendMpdCommand stop took 22 milliseconds
Apr 19 02:18:23 volumio2ag volumio[856]: info: sendMpdCommand status took 8 milliseconds
Apr 19 02:18:23 volumio2ag volumio[856]: info: sendMpdCommand status took 3 milliseconds
Apr 19 02:18:23 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:18:23 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:18:23 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand clear
Apr 19 02:18:23 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:18:23 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:18:23 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:18:23 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:18:23 volumio2ag volumio[856]: info: touch_display: Setting screensaver timeout to 360 seconds.
Apr 19 02:18:23 volumio2ag volumio[856]: info:
Apr 19 02:18:23 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:18:23 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:18:23 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 17 milliseconds
Apr 19 02:18:23 volumio2ag volumio[856]: info: sendMpdCommand clear took 16 milliseconds
Apr 19 02:18:23 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 15 milliseconds
Apr 19 02:18:23 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 14 milliseconds
Apr 19 02:18:23 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:18:23 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.0.103:45397/MediaServer/AudioItems/T-f2ba03f15d9301afe317c50c7778affb.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav"
Apr 19 02:18:23 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:18:23 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:18:23 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:23 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 16
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:23 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 16
Apr 19 02:18:23 volumio2ag volumio[856]: 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":"T-b43591bc5a98e23bc10a932f1389663b.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","artist":null,"album":null,"uri":"http://192.168.0.103:45397/MediaServer/AudioItems/T-b43591bc5a98e23bc10a932f1389663b.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","trackType":"wav"}
Apr 19 02:18:23 volumio2ag volumio[856]: verbose: CURRENT POSITION 16
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService stop
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:23 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 16
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:23 volumio2ag volumio[856]: info: No code
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:23 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 16
Apr 19 02:18:23 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:23 volumio2ag volumio[856]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 19 02:18:23 volumio2ag volumio[856]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 19 02:18:23 volumio2ag volumio[856]: info: ------------------------------ 96ms
Apr 19 02:18:23 volumio2ag volumio[856]: info: ------------------------------ 81ms
Apr 19 02:18:23 volumio2ag volumio[856]: info: ------------------------------ 68ms
Apr 19 02:18:23 volumio2ag volumio[856]: info:
Apr 19 02:18:23 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:18:23 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:18:23 volumio2ag volumio[856]: info:
Apr 19 02:18:23 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:18:23 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:18:23 volumio2ag volumio[856]: error: updateQueue error: null
Apr 19 02:18:23 volumio2ag volumio[856]: info: ------------------------------ 56ms
Apr 19 02:18:24 volumio2ag volumio[856]: error: updateQueue error: null
Apr 19 02:18:24 volumio2ag volumio[856]: error: updateQueue error: null
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.0.103:45397/MediaServer/AudioItems/T-f2ba03f15d9301afe317c50c7778affb.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav"
Apr 19 02:18:24 volumio2ag volumio[856]: info: ------------------------------ 1053ms
Apr 19 02:18:24 volumio2ag volumio[856]: info: ------------------------------ 1051ms
Apr 19 02:18:24 volumio2ag volumio[856]: info:
Apr 19 02:18:24 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:18:24 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:18:24 volumio2ag volumio[856]: info: sendMpdCommand add "http://192.168.0.103:45397/MediaServer/AudioItems/T-f2ba03f15d9301afe317c50c7778affb.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav" took 3 milliseconds
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand play
Apr 19 02:18:24 volumio2ag volumio[856]: info:
Apr 19 02:18:24 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:18:24 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:18:24 volumio2ag volumio[856]: info:
Apr 19 02:18:24 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:18:24 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:18:24 volumio2ag volumio[856]: info: ------------------------------ 7ms
Apr 19 02:18:24 volumio2ag volumio[856]: info: sendMpdCommand play took 7 milliseconds
Apr 19 02:18:24 volumio2ag volumio[856]: info: ------------------------------ 6ms
Apr 19 02:18:24 volumio2ag volumio[856]: info: ------------------------------ 6ms
Apr 19 02:18:24 volumio2ag volumio[856]: info:
Apr 19 02:18:24 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:18:24 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:18:24 volumio2ag volumio[856]: info:
Apr 19 02:18:24 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:18:24 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:18:24 volumio2ag volumio[856]: info:
Apr 19 02:18:24 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:18:24 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:18:24 volumio2ag volumio[856]: info:
Apr 19 02:18:24 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:18:24 volumio2ag volumio[856]: info: sendMpdCommand status took 4 milliseconds
Apr 19 02:18:24 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:18:24 volumio2ag volumio[856]: info: sendMpdCommand status took 4 milliseconds
Apr 19 02:18:24 volumio2ag volumio[856]: info: sendMpdCommand status took 2 milliseconds
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:18:24 volumio2ag volumio[856]: info:
Apr 19 02:18:24 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:18:24 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:18:24 volumio2ag volumio[856]: info:
Apr 19 02:18:24 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:18:24 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:18:24 volumio2ag volumio[856]: info: sendMpdCommand status took 6 milliseconds
Apr 19 02:18:24 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 19 02:18:24 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 19 02:18:24 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 19 02:18:24 volumio2ag volumio[856]: info: sendMpdCommand status took 4 milliseconds
Apr 19 02:18:24 volumio2ag volumio[856]: info: sendMpdCommand status took 2 milliseconds
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:18:24 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 16
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3054,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"T-f2ba03f15d9301afe317c50c7778affb.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","artist":null,"album":null,"uri":"http://192.168.0.103:45397/MediaServer/AudioItems/T-f2ba03f15d9301afe317c50c7778affb.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","trackType":"wav"}
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: CURRENT POSITION 16
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 02:18:24 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 16
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3054,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"T-f2ba03f15d9301afe317c50c7778affb.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","artist":null,"album":null,"uri":"http://192.168.0.103:45397/MediaServer/AudioItems/T-f2ba03f15d9301afe317c50c7778affb.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","trackType":"wav"}
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: CURRENT POSITION 16
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:18:24 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 16
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3054,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"T-f2ba03f15d9301afe317c50c7778affb.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","artist":null,"album":null,"uri":"http://192.168.0.103:45397/MediaServer/AudioItems/T-f2ba03f15d9301afe317c50c7778affb.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","trackType":"wav"}
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: CURRENT POSITION 16
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:18:24 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: ------------------------------ 28ms
Apr 19 02:18:24 volumio2ag volumio[856]: info: ------------------------------ 42ms
Apr 19 02:18:24 volumio2ag volumio[856]: info: ------------------------------ 41ms
Apr 19 02:18:24 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 32 milliseconds
Apr 19 02:18:24 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 32 milliseconds
Apr 19 02:18:24 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 32 milliseconds
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:18:24 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 16
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3054,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"T-f2ba03f15d9301afe317c50c7778affb.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","artist":null,"album":null,"uri":"http://192.168.0.103:45397/MediaServer/AudioItems/T-f2ba03f15d9301afe317c50c7778affb.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","trackType":"wav"}
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: CURRENT POSITION 16
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:18:24 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 16
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3054,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"T-f2ba03f15d9301afe317c50c7778affb.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","artist":null,"album":null,"uri":"http://192.168.0.103:45397/MediaServer/AudioItems/T-f2ba03f15d9301afe317c50c7778affb.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","trackType":"wav"}
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: CURRENT POSITION 16
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:18:24 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 16
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3054,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"T-f2ba03f15d9301afe317c50c7778affb.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","artist":null,"album":null,"uri":"http://192.168.0.103:45397/MediaServer/AudioItems/T-f2ba03f15d9301afe317c50c7778affb.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","trackType":"wav"}
Apr 19 02:18:24 volumio2ag volumio[856]: verbose: CURRENT POSITION 16
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:18:24 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:24 volumio2ag volumio[856]: info: ------------------------------ 84ms
Apr 19 02:18:24 volumio2ag volumio[856]: info: ------------------------------ 80ms
Apr 19 02:18:24 volumio2ag volumio[856]: info: ------------------------------ 80ms
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPlay
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::play index 19
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::stop
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::stPlaybackTimer
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::updateTrackBlock
Apr 19 02:18:32 volumio2ag volumio[856]: info: CorePlayQueue::getTrackBlock
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:32 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 16
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::serviceStop
Apr 19 02:18:32 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 16
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreCommandRouter::serviceStop
Apr 19 02:18:32 volumio2ag volumio[856]: info: [1713482312175] ControllerUPNPBrowser::stop
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand stop
Apr 19 02:18:32 volumio2ag volumio[856]: info:
Apr 19 02:18:32 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:18:32 volumio2ag volumio[856]: info: sendMpdCommand stop took 41 milliseconds
Apr 19 02:18:32 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::play index undefined
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:18:32 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 19
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::startPlaybackTimer
Apr 19 02:18:32 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 19
Apr 19 02:18:32 volumio2ag volumio[856]: info: [1713482312224] ControllerUPNPBrowser::clearAddPlayTrack
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand stop
Apr 19 02:18:32 volumio2ag volumio[856]: info:
Apr 19 02:18:32 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:18:32 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:18:32 volumio2ag volumio[856]: info:
Apr 19 02:18:32 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:18:32 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:18:32 volumio2ag volumio[856]: info: sendMpdCommand status took 15 milliseconds
Apr 19 02:18:32 volumio2ag volumio[856]: info: sendMpdCommand stop took 9 milliseconds
Apr 19 02:18:32 volumio2ag volumio[856]: info: sendMpdCommand status took 6 milliseconds
Apr 19 02:18:32 volumio2ag volumio[856]: info: sendMpdCommand status took 5 milliseconds
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand clear
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:18:32 volumio2ag volumio[856]: info:
Apr 19 02:18:32 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:18:32 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:18:32 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 19 02:18:32 volumio2ag volumio[856]: info: sendMpdCommand clear took 5 milliseconds
Apr 19 02:18:32 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 19 02:18:32 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.0.103:45397/MediaServer/AudioItems/309844adb218c2971ca330604444dac5.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav"
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:18:32 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:32 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 19
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:32 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 19
Apr 19 02:18:32 volumio2ag volumio[856]: 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":"T-f2ba03f15d9301afe317c50c7778affb.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","artist":null,"album":null,"uri":"http://192.168.0.103:45397/MediaServer/AudioItems/T-f2ba03f15d9301afe317c50c7778affb.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","trackType":"wav"}
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: CURRENT POSITION 19
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService stop
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:32 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 19
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:32 volumio2ag volumio[856]: info: No code
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:32 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 19
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:32 volumio2ag volumio[856]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 19 02:18:32 volumio2ag volumio[856]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 19 02:18:32 volumio2ag volumio[856]: info: ------------------------------ 76ms
Apr 19 02:18:32 volumio2ag volumio[856]: info: ------------------------------ 67ms
Apr 19 02:18:32 volumio2ag volumio[856]: info: ------------------------------ 65ms
Apr 19 02:18:32 volumio2ag volumio[856]: info:
Apr 19 02:18:32 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:18:32 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:18:32 volumio2ag volumio[856]: info:
Apr 19 02:18:32 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:18:32 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:18:32 volumio2ag volumio[856]: info: touch_display: Setting screensaver timeout to 360 seconds.
Apr 19 02:18:32 volumio2ag volumio[856]: error: updateQueue error: null
Apr 19 02:18:32 volumio2ag volumio[856]: info: ------------------------------ 62ms
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.0.103:45397/MediaServer/AudioItems/309844adb218c2971ca330604444dac5.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav"
Apr 19 02:18:32 volumio2ag volumio[856]: error: updateQueue error: null
Apr 19 02:18:32 volumio2ag volumio[856]: error: updateQueue error: null
Apr 19 02:18:32 volumio2ag volumio[856]: info:
Apr 19 02:18:32 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:18:32 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:18:32 volumio2ag volumio[856]: info: ------------------------------ 648ms
Apr 19 02:18:32 volumio2ag volumio[856]: info: ------------------------------ 648ms
Apr 19 02:18:32 volumio2ag volumio[856]: info: sendMpdCommand add "http://192.168.0.103:45397/MediaServer/AudioItems/309844adb218c2971ca330604444dac5.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav" took 2 milliseconds
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand play
Apr 19 02:18:32 volumio2ag volumio[856]: info:
Apr 19 02:18:32 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:18:32 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:18:32 volumio2ag volumio[856]: info:
Apr 19 02:18:32 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:18:32 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:18:32 volumio2ag volumio[856]: info: ------------------------------ 6ms
Apr 19 02:18:32 volumio2ag volumio[856]: info: sendMpdCommand play took 6 milliseconds
Apr 19 02:18:32 volumio2ag volumio[856]: info: ------------------------------ 4ms
Apr 19 02:18:32 volumio2ag volumio[856]: info: ------------------------------ 3ms
Apr 19 02:18:32 volumio2ag volumio[856]: info:
Apr 19 02:18:32 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:18:32 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:18:32 volumio2ag volumio[856]: info:
Apr 19 02:18:32 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:18:32 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:18:32 volumio2ag volumio[856]: info:
Apr 19 02:18:32 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:18:32 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:18:32 volumio2ag volumio[856]: info:
Apr 19 02:18:32 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:18:32 volumio2ag volumio[856]: info: sendMpdCommand status took 5 milliseconds
Apr 19 02:18:32 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:18:32 volumio2ag volumio[856]: info: sendMpdCommand status took 4 milliseconds
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:18:32 volumio2ag volumio[856]: info:
Apr 19 02:18:32 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:18:32 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:18:32 volumio2ag volumio[856]: info:
Apr 19 02:18:32 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:18:32 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:18:32 volumio2ag volumio[856]: info: sendMpdCommand status took 8 milliseconds
Apr 19 02:18:32 volumio2ag volumio[856]: info: sendMpdCommand status took 6 milliseconds
Apr 19 02:18:32 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 19 02:18:32 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 19 02:18:32 volumio2ag volumio[856]: info: sendMpdCommand status took 4 milliseconds
Apr 19 02:18:32 volumio2ag volumio[856]: info: sendMpdCommand status took 2 milliseconds
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:18:32 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:18:32 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 19
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"309844adb218c2971ca330604444dac5.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","artist":null,"album":null,"uri":"http://192.168.0.103:45397/MediaServer/AudioItems/309844adb218c2971ca330604444dac5.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","trackType":"wav"}
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: CURRENT POSITION 19
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 02:18:32 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:18:32 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 19
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"309844adb218c2971ca330604444dac5.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","artist":null,"album":null,"uri":"http://192.168.0.103:45397/MediaServer/AudioItems/309844adb218c2971ca330604444dac5.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","trackType":"wav"}
Apr 19 02:18:32 volumio2ag volumio[856]: verbose: CURRENT POSITION 19
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:18:32 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:32 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:32 volumio2ag volumio[856]: info: ------------------------------ 23ms
Apr 19 02:18:33 volumio2ag volumio[856]: info: ------------------------------ 29ms
Apr 19 02:18:33 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 19 milliseconds
Apr 19 02:18:33 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 19 milliseconds
Apr 19 02:18:33 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 19 milliseconds
Apr 19 02:18:33 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 18 milliseconds
Apr 19 02:18:33 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:18:33 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:18:33 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:18:33 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:18:33 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 19
Apr 19 02:18:33 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"309844adb218c2971ca330604444dac5.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","artist":null,"album":null,"uri":"http://192.168.0.103:45397/MediaServer/AudioItems/309844adb218c2971ca330604444dac5.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","trackType":"wav"}
Apr 19 02:18:33 volumio2ag volumio[856]: verbose: CURRENT POSITION 19
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:18:33 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 19
Apr 19 02:18:33 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"309844adb218c2971ca330604444dac5.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","artist":null,"album":null,"uri":"http://192.168.0.103:45397/MediaServer/AudioItems/309844adb218c2971ca330604444dac5.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","trackType":"wav"}
Apr 19 02:18:33 volumio2ag volumio[856]: verbose: CURRENT POSITION 19
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:18:33 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 19
Apr 19 02:18:33 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"309844adb218c2971ca330604444dac5.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","artist":null,"album":null,"uri":"http://192.168.0.103:45397/MediaServer/AudioItems/309844adb218c2971ca330604444dac5.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","trackType":"wav"}
Apr 19 02:18:33 volumio2ag volumio[856]: verbose: CURRENT POSITION 19
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:18:33 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 19
Apr 19 02:18:33 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"309844adb218c2971ca330604444dac5.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","artist":null,"album":null,"uri":"http://192.168.0.103:45397/MediaServer/AudioItems/309844adb218c2971ca330604444dac5.wav?transcoding=1&infokey=f2a7dc344ebfbb6e38511265f18448de&fileext=.wav","trackType":"wav"}
Apr 19 02:18:33 volumio2ag volumio[856]: verbose: CURRENT POSITION 19
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:18:33 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:18:33 volumio2ag volumio[856]: info: ------------------------------ 89ms
Apr 19 02:18:33 volumio2ag volumio[856]: info: ------------------------------ 89ms
Apr 19 02:18:33 volumio2ag volumio[856]: info: ------------------------------ 86ms
Apr 19 02:18:33 volumio2ag volumio[856]: info: ------------------------------ 86ms
Apr 19 02:18:51 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 19 02:18:51 volumio2ag volumio[856]: info: CURURI: playlists
Apr 19 02:18:51 volumio2ag volumio[856]: info: Listing playlists
Apr 19 02:18:51 volumio2ag volumio[856]: info: Preload queue cleared
Apr 19 02:19:00 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 19 02:19:00 volumio2ag volumio[856]: info: CURURI: music-library
Apr 19 02:19:00 volumio2ag volumio[856]: info: Preload queue cleared
Apr 19 02:19:02 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 19 02:19:02 volumio2ag volumio[856]: info: CURURI: music-library/USB
Apr 19 02:19:02 volumio2ag volumio[856]: info: Preload queue cleared
Apr 19 02:19:05 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 19 02:19:05 volumio2ag volumio[856]: info: CURURI: music-library/USB/[2015] Digital Emotion - Best Of [CD]
Apr 19 02:19:05 volumio2ag volumio[856]: info: Preload queue cleared
Apr 19 02:19:11 volumio2ag volumio[856]: info: Preload queue cleared
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::ClearQueue
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::stop
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::stPlaybackTimer
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::updateTrackBlock
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrackBlock
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 19
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::serviceStop
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 19
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::serviceStop
Apr 19 02:19:11 volumio2ag volumio[856]: info: [1713482351495] ControllerUPNPBrowser::stop
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand stop
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::clearPlayQueue
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::saveQueue
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushQueue
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::addQueueItems
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::addQueueItems
Apr 19 02:19:11 volumio2ag volumio[856]: info: Preload queue cleared
Apr 19 02:19:11 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/02. Digital Emotion - Go Go Yellow Screen.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/02. Digital Emotion - Go Go Yellow Screen.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/03. Digital Emotion - The Beauty & The Beast.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/03. Digital Emotion - The Beauty & The Beast.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/04. Digital Emotion - Don't Stop.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/04. Digital Emotion - Don't Stop.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/07. Digital Emotion - Time (Back In Time).flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/07. Digital Emotion - Time (Back In Time).flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/08. Digital Emotion - Outside In The Dark.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/08. Digital Emotion - Outside In The Dark.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/09. Digital Emotion - Down Get Down.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/09. Digital Emotion - Down Get Down.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/10. Digital Emotion - Steppin' Out.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/10. Digital Emotion - Steppin' Out.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/11. Digital Emotion - Reach Out I'll Be There.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/11. Digital Emotion - Reach Out I'll Be There.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/12. Digital Emotion - Je Veux L'amour.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/12. Digital Emotion - Je Veux L'amour.flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/13. Digital Emotion - Go Go Yellow Screen (Re-Remix).flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/13. Digital Emotion - Go Go Yellow Screen (Re-Remix).flac
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushQueue
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::saveQueue
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::updateTrackBlock
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrackBlock
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPlay
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::play index 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::stop
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::play index undefined
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::startPlaybackTimer
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::clearAddPlayTracks USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand stop
Apr 19 02:19:11 volumio2ag volumio[856]: info:
Apr 19 02:19:11 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand stop took 47 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand stop took 9 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand clear
Apr 19 02:19:11 volumio2ag volumio[856]: info:
Apr 19 02:19:11 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:11 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:11 volumio2ag volumio[856]: info:
Apr 19 02:19:11 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:11 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:11 volumio2ag volumio[856]: info:
Apr 19 02:19:11 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:11 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand status took 39 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand clear took 39 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand status took 37 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand status took 44 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand add "USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac"
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:11 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: 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}
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: CURRENT POSITION 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService stop
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: No code
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: 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}
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: CURRENT POSITION 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService stop
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: No code
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: ------------------------------ 87ms
Apr 19 02:19:11 volumio2ag volumio[856]: info: ------------------------------ 86ms
Apr 19 02:19:11 volumio2ag volumio[856]: info:
Apr 19 02:19:11 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:11 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:11 volumio2ag volumio[856]: info:
Apr 19 02:19:11 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:11 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:11 volumio2ag volumio[856]: error: updateQueue error: null
Apr 19 02:19:11 volumio2ag volumio[856]: info:
Apr 19 02:19:11 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:11 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:11 volumio2ag volumio[856]: info: ------------------------------ 71ms
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 57 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand add "USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac" took 57 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: info: ------------------------------ 17ms
Apr 19 02:19:11 volumio2ag volumio[856]: info: ------------------------------ 16ms
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand play
Apr 19 02:19:11 volumio2ag volumio[856]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 19 02:19:11 volumio2ag volumio[856]: info: ------------------------------ 113ms
Apr 19 02:19:11 volumio2ag volumio[856]: info:
Apr 19 02:19:11 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:11 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:11 volumio2ag volumio[856]: info:
Apr 19 02:19:11 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:11 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:11 volumio2ag volumio[856]: info: touch_display: Setting screensaver timeout to 360 seconds.
Apr 19 02:19:11 volumio2ag volumio[856]: info:
Apr 19 02:19:11 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:11 volumio2ag volumio[856]: info:
Apr 19 02:19:11 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:11 volumio2ag volumio[856]: info: ------------------------------ 30ms
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand play took 25 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:11 volumio2ag volumio[856]: info: ------------------------------ 24ms
Apr 19 02:19:11 volumio2ag volumio[856]: info: ------------------------------ 23ms
Apr 19 02:19:11 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:11 volumio2ag volumio[856]: info:
Apr 19 02:19:11 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:11 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:11 volumio2ag volumio[856]: info:
Apr 19 02:19:11 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:11 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand status took 49 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand status took 49 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand status took 47 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand status took 40 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:11 volumio2ag volumio[856]: info:
Apr 19 02:19:11 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:11 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:11 volumio2ag volumio[856]: info:
Apr 19 02:19:11 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:11 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 16 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 17 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 17 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 17 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand status took 19 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand status took 18 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:11 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":528,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"705 Kbps","isStreaming":false,"title":"Humanity","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac","trackType":"flac"}
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: CURRENT POSITION 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 02:19:11 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":528,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"705 Kbps","isStreaming":false,"title":"Humanity","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac","trackType":"flac"}
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: CURRENT POSITION 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:19:11 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":528,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"717 Kbps","isStreaming":false,"title":"Humanity","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac","trackType":"flac"}
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: CURRENT POSITION 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:19:11 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":528,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"717 Kbps","isStreaming":false,"title":"Humanity","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac","trackType":"flac"}
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: CURRENT POSITION 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:19:11 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: ------------------------------ 100ms
Apr 19 02:19:11 volumio2ag volumio[856]: info: ------------------------------ 114ms
Apr 19 02:19:11 volumio2ag volumio[856]: info: ------------------------------ 111ms
Apr 19 02:19:11 volumio2ag volumio[856]: info: ------------------------------ 104ms
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 91 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 91 milliseconds
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:11 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":528,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"717 Kbps","isStreaming":false,"title":"Humanity","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac","trackType":"flac"}
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: CURRENT POSITION 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:19:11 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":528,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"717 Kbps","isStreaming":false,"title":"Humanity","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac","trackType":"flac"}
Apr 19 02:19:11 volumio2ag volumio[856]: verbose: CURRENT POSITION 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:19:11 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:11 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:11 volumio2ag volumio[856]: info: ------------------------------ 147ms
Apr 19 02:19:11 volumio2ag volumio[856]: info: ------------------------------ 148ms
Apr 19 02:19:11 volumio2ag volumio[856]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Apr 19 02:19:11 volumio2ag volumio[856]: info: touch_display: Setting screensaver timeout to 360 seconds.
Apr 19 02:19:13 volumio2ag volumio[856]: info: Preload queue cleared
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::ClearQueue
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::stop
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::stPlaybackTimer
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::updateTrackBlock
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrackBlock
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::serviceStop
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 5
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::serviceStop
Apr 19 02:19:13 volumio2ag volumio[856]: info: ControllerMpd::stop
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand stop
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::clearPlayQueue
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::saveQueue
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushQueue
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::addQueueItems
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::addQueueItems
Apr 19 02:19:13 volumio2ag volumio[856]: info: Preload queue cleared
Apr 19 02:19:13 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/02. Digital Emotion - Go Go Yellow Screen.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/02. Digital Emotion - Go Go Yellow Screen.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/03. Digital Emotion - The Beauty & The Beast.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/03. Digital Emotion - The Beauty & The Beast.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/04. Digital Emotion - Don't Stop.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/04. Digital Emotion - Don't Stop.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/07. Digital Emotion - Time (Back In Time).flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/07. Digital Emotion - Time (Back In Time).flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/08. Digital Emotion - Outside In The Dark.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/08. Digital Emotion - Outside In The Dark.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/09. Digital Emotion - Down Get Down.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/09. Digital Emotion - Down Get Down.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/10. Digital Emotion - Steppin' Out.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/10. Digital Emotion - Steppin' Out.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/11. Digital Emotion - Reach Out I'll Be There.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/11. Digital Emotion - Reach Out I'll Be There.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/12. Digital Emotion - Je Veux L'amour.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/12. Digital Emotion - Je Veux L'amour.flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/13. Digital Emotion - Go Go Yellow Screen (Re-Remix).flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/13. Digital Emotion - Go Go Yellow Screen (Re-Remix).flac
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushQueue
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::saveQueue
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::updateTrackBlock
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrackBlock
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPlay
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::play index 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::stop
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::play index undefined
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::startPlaybackTimer
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::clearAddPlayTracks USB/[2015] Digital Emotion - Best Of [CD]/07. Digital Emotion - Time (Back In Time).flac
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand stop
Apr 19 02:19:13 volumio2ag volumio[856]: info:
Apr 19 02:19:13 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:13 volumio2ag volumio[856]: info: sendMpdCommand stop took 68 milliseconds
Apr 19 02:19:13 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:13 volumio2ag volumio[856]: info: sendMpdCommand stop took 16 milliseconds
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand clear
Apr 19 02:19:13 volumio2ag volumio[856]: info:
Apr 19 02:19:13 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:13 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:13 volumio2ag volumio[856]: info:
Apr 19 02:19:13 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:13 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:13 volumio2ag volumio[856]: info:
Apr 19 02:19:13 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:13 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:13 volumio2ag volumio[856]: info: sendMpdCommand status took 47 milliseconds
Apr 19 02:19:13 volumio2ag volumio[856]: info: sendMpdCommand clear took 45 milliseconds
Apr 19 02:19:13 volumio2ag volumio[856]: info: sendMpdCommand status took 44 milliseconds
Apr 19 02:19:13 volumio2ag volumio[856]: info: sendMpdCommand status took 40 milliseconds
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand add "USB/[2015] Digital Emotion - Best Of [CD]/07. Digital Emotion - Time (Back In Time).flac"
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:13 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: 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}
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: CURRENT POSITION 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService stop
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: No code
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: 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}
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: CURRENT POSITION 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService stop
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: No code
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: ------------------------------ 111ms
Apr 19 02:19:13 volumio2ag volumio[856]: info: ------------------------------ 107ms
Apr 19 02:19:13 volumio2ag volumio[856]: info:
Apr 19 02:19:13 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:13 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:13 volumio2ag volumio[856]: info:
Apr 19 02:19:13 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:13 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:13 volumio2ag volumio[856]: error: updateQueue error: null
Apr 19 02:19:13 volumio2ag volumio[856]: info:
Apr 19 02:19:13 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:13 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:13 volumio2ag volumio[856]: info: ------------------------------ 82ms
Apr 19 02:19:13 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 73 milliseconds
Apr 19 02:19:13 volumio2ag volumio[856]: info: sendMpdCommand add "USB/[2015] Digital Emotion - Best Of [CD]/07. Digital Emotion - Time (Back In Time).flac" took 72 milliseconds
Apr 19 02:19:13 volumio2ag volumio[856]: info: ------------------------------ 12ms
Apr 19 02:19:13 volumio2ag volumio[856]: info: ------------------------------ 9ms
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand play
Apr 19 02:19:13 volumio2ag volumio[856]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 19 02:19:13 volumio2ag volumio[856]: info: ------------------------------ 141ms
Apr 19 02:19:13 volumio2ag volumio[856]: info:
Apr 19 02:19:13 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:13 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:13 volumio2ag volumio[856]: info:
Apr 19 02:19:13 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:13 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:13 volumio2ag volumio[856]: info: touch_display: Setting screensaver timeout to 360 seconds.
Apr 19 02:19:13 volumio2ag volumio[856]: info:
Apr 19 02:19:13 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:13 volumio2ag volumio[856]: info:
Apr 19 02:19:13 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:13 volumio2ag volumio[856]: info: ------------------------------ 31ms
Apr 19 02:19:13 volumio2ag volumio[856]: info: sendMpdCommand play took 25 milliseconds
Apr 19 02:19:13 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:13 volumio2ag volumio[856]: info: ------------------------------ 26ms
Apr 19 02:19:13 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:13 volumio2ag volumio[856]: info: ------------------------------ 24ms
Apr 19 02:19:13 volumio2ag volumio[856]: info:
Apr 19 02:19:13 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:13 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:13 volumio2ag volumio[856]: info:
Apr 19 02:19:13 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:13 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:13 volumio2ag volumio[856]: info: sendMpdCommand status took 13 milliseconds
Apr 19 02:19:13 volumio2ag volumio[856]: info: sendMpdCommand status took 12 milliseconds
Apr 19 02:19:13 volumio2ag volumio[856]: info: sendMpdCommand status took 8 milliseconds
Apr 19 02:19:13 volumio2ag volumio[856]: info: sendMpdCommand status took 5 milliseconds
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:13 volumio2ag volumio[856]: info:
Apr 19 02:19:13 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:13 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:13 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 26 milliseconds
Apr 19 02:19:13 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 27 milliseconds
Apr 19 02:19:13 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 26 milliseconds
Apr 19 02:19:13 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 27 milliseconds
Apr 19 02:19:13 volumio2ag volumio[856]: info: sendMpdCommand status took 25 milliseconds
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:13 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":398,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"299 Kbps","isStreaming":false,"title":"Time (Back In Time)","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/07. Digital Emotion - Time (Back In Time).flac","trackType":"flac"}
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: CURRENT POSITION 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 02:19:13 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":398,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"299 Kbps","isStreaming":false,"title":"Time (Back In Time)","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/07. Digital Emotion - Time (Back In Time).flac","trackType":"flac"}
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: CURRENT POSITION 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:19:13 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":398,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"299 Kbps","isStreaming":false,"title":"Time (Back In Time)","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/07. Digital Emotion - Time (Back In Time).flac","trackType":"flac"}
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: CURRENT POSITION 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:19:13 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":398,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"299 Kbps","isStreaming":false,"title":"Time (Back In Time)","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/07. Digital Emotion - Time (Back In Time).flac","trackType":"flac"}
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: CURRENT POSITION 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:19:13 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: ------------------------------ 84ms
Apr 19 02:19:13 volumio2ag volumio[856]: info: ------------------------------ 99ms
Apr 19 02:19:13 volumio2ag volumio[856]: info: ------------------------------ 90ms
Apr 19 02:19:13 volumio2ag volumio[856]: info: ------------------------------ 88ms
Apr 19 02:19:13 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 48 milliseconds
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:13 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":398,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"299 Kbps","isStreaming":false,"title":"Time (Back In Time)","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/07. Digital Emotion - Time (Back In Time).flac","trackType":"flac"}
Apr 19 02:19:13 volumio2ag volumio[856]: verbose: CURRENT POSITION 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:19:13 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:13 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:13 volumio2ag volumio[856]: info: ------------------------------ 98ms
Apr 19 02:19:15 volumio2ag volumio[856]: info: Preload queue cleared
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::ClearQueue
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::stop
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::stPlaybackTimer
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::updateTrackBlock
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::getTrackBlock
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::serviceStop
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 6
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::serviceStop
Apr 19 02:19:15 volumio2ag volumio[856]: info: ControllerMpd::stop
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand stop
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::clearPlayQueue
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::saveQueue
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushQueue
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::addQueueItems
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::addQueueItems
Apr 19 02:19:15 volumio2ag volumio[856]: info: Preload queue cleared
Apr 19 02:19:15 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/02. Digital Emotion - Go Go Yellow Screen.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/02. Digital Emotion - Go Go Yellow Screen.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/03. Digital Emotion - The Beauty & The Beast.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/03. Digital Emotion - The Beauty & The Beast.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/04. Digital Emotion - Don't Stop.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/04. Digital Emotion - Don't Stop.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/07. Digital Emotion - Time (Back In Time).flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/07. Digital Emotion - Time (Back In Time).flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/08. Digital Emotion - Outside In The Dark.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/08. Digital Emotion - Outside In The Dark.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/09. Digital Emotion - Down Get Down.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/09. Digital Emotion - Down Get Down.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/10. Digital Emotion - Steppin' Out.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/10. Digital Emotion - Steppin' Out.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/11. Digital Emotion - Reach Out I'll Be There.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/11. Digital Emotion - Reach Out I'll Be There.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/12. Digital Emotion - Je Veux L'amour.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/12. Digital Emotion - Je Veux L'amour.flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/13. Digital Emotion - Go Go Yellow Screen (Re-Remix).flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/13. Digital Emotion - Go Go Yellow Screen (Re-Remix).flac
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushQueue
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::saveQueue
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::updateTrackBlock
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::getTrackBlock
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPlay
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::play index 4
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::stop
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::play index undefined
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::startPlaybackTimer
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::clearAddPlayTracks USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand stop
Apr 19 02:19:15 volumio2ag volumio[856]: info:
Apr 19 02:19:15 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:15 volumio2ag volumio[856]: info: sendMpdCommand stop took 39 milliseconds
Apr 19 02:19:15 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:15 volumio2ag volumio[856]: info: sendMpdCommand stop took 7 milliseconds
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand clear
Apr 19 02:19:15 volumio2ag volumio[856]: info:
Apr 19 02:19:15 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:15 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:15 volumio2ag volumio[856]: info:
Apr 19 02:19:15 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:15 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:15 volumio2ag volumio[856]: info:
Apr 19 02:19:15 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:15 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:15 volumio2ag volumio[856]: info: sendMpdCommand status took 34 milliseconds
Apr 19 02:19:15 volumio2ag volumio[856]: info: sendMpdCommand clear took 34 milliseconds
Apr 19 02:19:15 volumio2ag volumio[856]: info: sendMpdCommand status took 32 milliseconds
Apr 19 02:19:15 volumio2ag volumio[856]: info: sendMpdCommand status took 36 milliseconds
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand add "USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac"
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:15 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:15 volumio2ag volumio[856]: 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}
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: CURRENT POSITION 4
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService stop
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: No code
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:15 volumio2ag volumio[856]: 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}
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: CURRENT POSITION 4
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService stop
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: No code
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: ------------------------------ 105ms
Apr 19 02:19:15 volumio2ag volumio[856]: info: ------------------------------ 105ms
Apr 19 02:19:15 volumio2ag volumio[856]: info:
Apr 19 02:19:15 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:15 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:15 volumio2ag volumio[856]: info:
Apr 19 02:19:15 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:15 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:15 volumio2ag volumio[856]: error: updateQueue error: null
Apr 19 02:19:15 volumio2ag volumio[856]: info:
Apr 19 02:19:15 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:15 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:15 volumio2ag volumio[856]: info: ------------------------------ 88ms
Apr 19 02:19:15 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 69 milliseconds
Apr 19 02:19:15 volumio2ag volumio[856]: info: sendMpdCommand add "USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac" took 70 milliseconds
Apr 19 02:19:15 volumio2ag volumio[856]: info: ------------------------------ 12ms
Apr 19 02:19:15 volumio2ag volumio[856]: info: ------------------------------ 10ms
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand play
Apr 19 02:19:15 volumio2ag volumio[856]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 19 02:19:15 volumio2ag volumio[856]: info: ------------------------------ 126ms
Apr 19 02:19:15 volumio2ag volumio[856]: info:
Apr 19 02:19:15 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:15 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:15 volumio2ag volumio[856]: info:
Apr 19 02:19:15 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:15 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:15 volumio2ag volumio[856]: info: touch_display: Setting screensaver timeout to 360 seconds.
Apr 19 02:19:15 volumio2ag volumio[856]: info:
Apr 19 02:19:15 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:15 volumio2ag volumio[856]: info:
Apr 19 02:19:15 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:15 volumio2ag volumio[856]: info: ------------------------------ 23ms
Apr 19 02:19:15 volumio2ag volumio[856]: info: sendMpdCommand play took 20 milliseconds
Apr 19 02:19:15 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:15 volumio2ag volumio[856]: info: ------------------------------ 19ms
Apr 19 02:19:15 volumio2ag volumio[856]: info: ------------------------------ 18ms
Apr 19 02:19:15 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:15 volumio2ag volumio[856]: info:
Apr 19 02:19:15 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:15 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:15 volumio2ag volumio[856]: info:
Apr 19 02:19:15 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:15 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:15 volumio2ag volumio[856]: info: sendMpdCommand status took 20 milliseconds
Apr 19 02:19:15 volumio2ag volumio[856]: info: sendMpdCommand status took 20 milliseconds
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:15 volumio2ag volumio[856]: info:
Apr 19 02:19:15 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:15 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:15 volumio2ag volumio[856]: info: sendMpdCommand status took 37 milliseconds
Apr 19 02:19:15 volumio2ag volumio[856]: info: sendMpdCommand status took 30 milliseconds
Apr 19 02:19:15 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 18 milliseconds
Apr 19 02:19:15 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 18 milliseconds
Apr 19 02:19:15 volumio2ag volumio[856]: info: sendMpdCommand status took 16 milliseconds
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:15 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"257 Kbps","isStreaming":false,"title":"Electric Love","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac","trackType":"flac"}
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: CURRENT POSITION 4
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 02:19:15 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"257 Kbps","isStreaming":false,"title":"Electric Love","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac","trackType":"flac"}
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: CURRENT POSITION 4
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:19:15 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:15 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:15 volumio2ag volumio[856]: info: ------------------------------ 60ms
Apr 19 02:19:15 volumio2ag volumio[856]: info: ------------------------------ 67ms
Apr 19 02:19:15 volumio2ag volumio[856]: info:
Apr 19 02:19:15 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:15 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:15 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:16 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 34 milliseconds
Apr 19 02:19:16 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 34 milliseconds
Apr 19 02:19:16 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 34 milliseconds
Apr 19 02:19:16 volumio2ag volumio[856]: info: sendMpdCommand status took 18 milliseconds
Apr 19 02:19:16 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:16 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:16 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:16 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:16 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:16 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:16 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"257 Kbps","isStreaming":false,"title":"Electric Love","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac","trackType":"flac"}
Apr 19 02:19:16 volumio2ag volumio[856]: verbose: CURRENT POSITION 4
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:19:16 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:16 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"257 Kbps","isStreaming":false,"title":"Electric Love","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac","trackType":"flac"}
Apr 19 02:19:16 volumio2ag volumio[856]: verbose: CURRENT POSITION 4
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:19:16 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:16 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"257 Kbps","isStreaming":false,"title":"Electric Love","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac","trackType":"flac"}
Apr 19 02:19:16 volumio2ag volumio[856]: verbose: CURRENT POSITION 4
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:19:16 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: ------------------------------ 129ms
Apr 19 02:19:16 volumio2ag volumio[856]: info: ------------------------------ 122ms
Apr 19 02:19:16 volumio2ag volumio[856]: info: ------------------------------ 109ms
Apr 19 02:19:16 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 720 milliseconds
Apr 19 02:19:16 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:16 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:16 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"257 Kbps","isStreaming":false,"title":"Electric Love","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac","trackType":"flac"}
Apr 19 02:19:16 volumio2ag volumio[856]: verbose: CURRENT POSITION 4
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:19:16 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:16 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:16 volumio2ag volumio[856]: info: ------------------------------ 756ms
Apr 19 02:19:24 volumio2ag volumio[856]: info: Preload queue cleared
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::ClearQueue
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::stop
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::stPlaybackTimer
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::updateTrackBlock
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrackBlock
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::serviceStop
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 4
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::serviceStop
Apr 19 02:19:24 volumio2ag volumio[856]: info: ControllerMpd::stop
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand stop
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::clearPlayQueue
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::saveQueue
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushQueue
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::addQueueItems
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::addQueueItems
Apr 19 02:19:24 volumio2ag volumio[856]: info: Preload queue cleared
Apr 19 02:19:24 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/02. Digital Emotion - Go Go Yellow Screen.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/02. Digital Emotion - Go Go Yellow Screen.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/03. Digital Emotion - The Beauty & The Beast.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/03. Digital Emotion - The Beauty & The Beast.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/04. Digital Emotion - Don't Stop.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/04. Digital Emotion - Don't Stop.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/07. Digital Emotion - Time (Back In Time).flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/07. Digital Emotion - Time (Back In Time).flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/08. Digital Emotion - Outside In The Dark.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/08. Digital Emotion - Outside In The Dark.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/09. Digital Emotion - Down Get Down.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/09. Digital Emotion - Down Get Down.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/10. Digital Emotion - Steppin' Out.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/10. Digital Emotion - Steppin' Out.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/11. Digital Emotion - Reach Out I'll Be There.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/11. Digital Emotion - Reach Out I'll Be There.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/12. Digital Emotion - Je Veux L'amour.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/12. Digital Emotion - Je Veux L'amour.flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Adding Item to queue: music-library/USB/[2015] Digital Emotion - Best Of [CD]/13. Digital Emotion - Go Go Yellow Screen (Re-Remix).flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: Using cached record of: music-library/USB/[2015] Digital Emotion - Best Of [CD]/13. Digital Emotion - Go Go Yellow Screen (Re-Remix).flac
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushQueue
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::saveQueue
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::updateTrackBlock
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrackBlock
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPlay
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::play index 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::stop
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::play index undefined
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::startPlaybackTimer
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::clearAddPlayTracks USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand stop
Apr 19 02:19:24 volumio2ag volumio[856]: info:
Apr 19 02:19:24 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand stop took 65 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand stop took 15 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand clear
Apr 19 02:19:24 volumio2ag volumio[856]: info:
Apr 19 02:19:24 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:24 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:24 volumio2ag volumio[856]: info:
Apr 19 02:19:24 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:24 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:24 volumio2ag volumio[856]: info:
Apr 19 02:19:24 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:24 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand status took 35 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand clear took 34 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand status took 33 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand status took 31 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand add "USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac"
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:24 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: 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}
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: CURRENT POSITION 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService stop
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: No code
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: 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}
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: CURRENT POSITION 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService stop
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: No code
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: ------------------------------ 75ms
Apr 19 02:19:24 volumio2ag volumio[856]: info: ------------------------------ 75ms
Apr 19 02:19:24 volumio2ag volumio[856]: info:
Apr 19 02:19:24 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:24 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:24 volumio2ag volumio[856]: error: updateQueue error: null
Apr 19 02:19:24 volumio2ag volumio[856]: info:
Apr 19 02:19:24 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:24 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:24 volumio2ag volumio[856]: info: ------------------------------ 52ms
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 48 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand add "USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac" took 48 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: info: ------------------------------ 6ms
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand play
Apr 19 02:19:24 volumio2ag volumio[856]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 19 02:19:24 volumio2ag volumio[856]: info: ------------------------------ 89ms
Apr 19 02:19:24 volumio2ag volumio[856]: info:
Apr 19 02:19:24 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:24 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:24 volumio2ag volumio[856]: info:
Apr 19 02:19:24 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:24 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:24 volumio2ag volumio[856]: info: touch_display: Setting screensaver timeout to 360 seconds.
Apr 19 02:19:24 volumio2ag volumio[856]: info:
Apr 19 02:19:24 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:24 volumio2ag volumio[856]: info:
Apr 19 02:19:24 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:24 volumio2ag volumio[856]: info: ------------------------------ 16ms
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand play took 13 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:24 volumio2ag volumio[856]: info: ------------------------------ 13ms
Apr 19 02:19:24 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:24 volumio2ag volumio[856]: info:
Apr 19 02:19:24 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:24 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:24 volumio2ag volumio[856]: info:
Apr 19 02:19:24 volumio2ag volumio[856]: ---------------------------- MPD announces system playlist update
Apr 19 02:19:24 volumio2ag volumio[856]: info: Ignoring MPD Status Update
Apr 19 02:19:24 volumio2ag volumio[856]: info:
Apr 19 02:19:24 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:24 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand status took 8 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand status took 8 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:24 volumio2ag volumio[856]: info:
Apr 19 02:19:24 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:24 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand status took 21 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: info: ------------------------------ 20ms
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand status took 20 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 17 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 7 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand status took 6 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:24 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":284,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"970 Kbps","isStreaming":false,"title":"Get Up, Action","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac","trackType":"flac"}
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: CURRENT POSITION 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 02:19:24 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":284,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"970 Kbps","isStreaming":false,"title":"Get Up, Action","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac","trackType":"flac"}
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: CURRENT POSITION 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:19:24 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: ------------------------------ 45ms
Apr 19 02:19:24 volumio2ag volumio[856]: info: ------------------------------ 59ms
Apr 19 02:19:24 volumio2ag volumio[856]: info:
Apr 19 02:19:24 volumio2ag volumio[856]: ---------------------------- MPD announces state update: player
Apr 19 02:19:24 volumio2ag volumio[856]: info: ControllerMpd::getState
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 58 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 58 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 61 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand status took 35 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseState
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 02:19:24 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":284,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"716 Kbps","isStreaming":false,"title":"Get Up, Action","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac","trackType":"flac"}
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: CURRENT POSITION 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:19:24 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":284,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"716 Kbps","isStreaming":false,"title":"Get Up, Action","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac","trackType":"flac"}
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: CURRENT POSITION 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:19:24 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":284,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"755 Kbps","isStreaming":false,"title":"Get Up, Action","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac","trackType":"flac"}
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: CURRENT POSITION 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:19:24 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: ------------------------------ 143ms
Apr 19 02:19:24 volumio2ag volumio[856]: info: ------------------------------ 140ms
Apr 19 02:19:24 volumio2ag volumio[856]: info: ------------------------------ 125ms
Apr 19 02:19:24 volumio2ag volumio[856]: info: sendMpdCommand playlistinfo took 94 milliseconds
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: ControllerMpd::parseTrackInfo
Apr 19 02:19:24 volumio2ag volumio[856]: info: ControllerMpd::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::servicePushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":284,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"755 Kbps","isStreaming":false,"title":"Get Up, Action","artist":"Digital Emotion","album":"Best Of","uri":"USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac","trackType":"flac"}
Apr 19 02:19:24 volumio2ag volumio[856]: verbose: CURRENT POSITION 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState stateService play
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::syncState currentStatus play
Apr 19 02:19:24 volumio2ag volumio[856]: info: Received an update from plugin. extracting info from payload
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreStateMachine::pushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 02:19:24 volumio2ag volumio[856]: info: CoreCommandRouter::volumioPushState
Apr 19 02:19:24 volumio2ag volumio[856]: info: ------------------------------ 144ms
Apr 19 02:19:45 volumio2ag volumio[856]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri
Apr 19 02:19:45 volumio2ag volumio[856]: info: Preload queue cleared
Apr 19 02:19:45 volumio2ag volumio[856]: info: Preloading song: mnt/USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac
Apr 19 02:19:45 volumio2ag volumio[856]: info: Preloading song: mnt/USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac
Apr 19 02:19:45 volumio2ag volumio[856]: info: Preloading song: mnt/USB/[2015] Digital Emotion - Best Of [CD]/07. Digital Emotion - Time (Back In Time).flac
Apr 19 02:19:45 volumio2ag volumio[856]: info: Preloading song: mnt/USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac
Apr 19 02:19:45 volumio2ag volumio[856]: info: Preloading song: mnt/USB/1986 - Living On Video (LP, Album)(ATCO Records, Mirage 90518-1)/A2. Eyes Of Desire.mp3
Apr 19 02:19:45 volumio2ag volumio[856]: info: Preloading song: mnt/USB/[2015] Digital Emotion - Best Of [CD]/03. Digital Emotion - The Beauty & The Beast.flac
Apr 19 02:19:45 volumio2ag volumio[856]: info: Preloading song: mnt/USB/[2015] Digital Emotion - Best Of [CD]/02. Digital Emotion - Go Go Yellow Screen.flac
Apr 19 02:19:45 volumio2ag volumio[856]: info: Preloading song: mnt/USB/1986 - Living On Video (LP, Album)(ATCO Records, Mirage 90518-1)/A4. Monkey Dance.mp3
Apr 19 02:19:45 volumio2ag volumio[856]: info: Preloading song: mnt/USB/1986 - Living On Video (LP, Album)(ATCO Records, Mirage 90518-1)/A3. 3-D Dance.mp3
Apr 19 02:19:45 volumio2ag volumio[856]: info: Preloading song: mnt/USB/1986 - Living On Video (LP, Album)(ATCO Records, Mirage 90518-1)/A1. Living On Video.mp3
Apr 19 02:19:45 volumio2ag volumio[856]: info: Preloading song: upnp/folder/http://10.54.75.100:50001/ContentDirectory/control@23
Apr 19 02:19:45 volumio2ag volumio[856]: info: Preloading song: mnt/NAS/NAS/Ariya/1987 - Герой Асфальта (Limited Edition) [24-192]/Ария - Герой Асфальта Limited Edition.flac
Apr 19 02:19:45 volumio2ag volumio[856]: info: Preloading song: cue://NAS/NAS/Ariya/1987 - Герой Асфальта (Limited Edition) [24-192]/Ария - Герой Асфальта Limited Edition.flac.cue@3
Apr 19 02:19:45 volumio2ag volumio[856]: info: Preloading song: cue://NAS/NAS/Ariya/1987 - Герой Асфальта (Limited Edition) [24-192]/Ария - Герой Асфальта Limited Edition.flac.cue@2
Apr 19 02:19:45 volumio2ag volumio[856]: info: Preloading song: cue://NAS/NAS/Ariya/1987 - Герой Асфальта (Limited Edition) [24-192]/Ария - Герой Асфальта Limited Edition.flac.cue@1
Apr 19 02:19:45 volumio2ag volumio[856]: info: Preloading song: upnp/folder/http://10.54.75.100:50001/ContentDirectory/control@22$199
Apr 19 02:19:45 volumio2ag volumio[856]: info: Exploding uri mnt/USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac in service mpd
Apr 19 02:19:45 volumio2ag volumio[856]: info: ALBUMART /albumart?cacheid=195&web=Digital%20Emotion/Best%20Of/small&path=%2Fmnt%2FUSB%2F%5B2015%5D%20Digital%20Emotion%20-%20Best%20Of%20%5BCD%5D%2F01.%20Digital%20Emotion%20-%20Get%20Up%2C%20Action.flac&metadata=false
Apr 19 02:19:45 volumio2ag volumio[856]: info: URI /mnt/USB/[2015] Digital Emotion - Best Of [CD]/01. Digital Emotion - Get Up, Action.flac
Apr 19 02:19:45 volumio2ag volumio[856]: info: Exploding uri mnt/USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac in service mpd
Apr 19 02:19:45 volumio2ag volumio[856]: info: ALBUMART /albumart?cacheid=195&web=Digital%20Emotion/Best%20Of/small&path=%2Fmnt%2FUSB%2F%5B2015%5D%20Digital%20Emotion%20-%20Best%20Of%20%5BCD%5D%2F05.%20Digital%20Emotion%20-%20Electric%20Love.flac&metadata=false
Apr 19 02:19:45 volumio2ag volumio[856]: info: URI /mnt/USB/[2015] Digital Emotion - Best Of [CD]/05. Digital Emotion - Electric Love.flac
Apr 19 02:19:45 volumio2ag volumio[856]: info: Exploding uri mnt/USB/[2015] Digital Emotion - Best Of [CD]/07. Digital Emotion - Time (Back In Time).flac in service mpd
Apr 19 02:19:45 volumio2ag volumio[856]: info: ALBUMART /albumart?cacheid=195&web=Digital%20Emotion/Best%20Of/small&path=%2Fmnt%2FUSB%2F%5B2015%5D%20Digital%20Emotion%20-%20Best%20Of%20%5BCD%5D%2F07.%20Digital%20Emotion%20-%20Time%20(Back%20In%20Time).flac&metadata=false
Apr 19 02:19:45 volumio2ag volumio[856]: info: URI /mnt/USB/[2015] Digital Emotion - Best Of [CD]/07. Digital Emotion - Time (Back In Time).flac
Apr 19 02:19:45 volumio2ag volumio[856]: info: Exploding uri mnt/USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac in service mpd
Apr 19 02:19:45 volumio2ag volumio[856]: info: ALBUMART /albumart?cacheid=195&web=Digital%20Emotion/Best%20Of/small&path=%2Fmnt%2FUSB%2F%5B2015%5D%20Digital%20Emotion%20-%20Best%20Of%20%5BCD%5D%2F06.%20Digital%20Emotion%20-%20Humanity.flac&metadata=false
Apr 19 02:19:45 volumio2ag volumio[856]: info: URI /mnt/USB/[2015] Digital Emotion - Best Of [CD]/06. Digital Emotion - Humanity.flac
Apr 19 02:19:45 volumio2ag volumio[856]: info: Exploding uri mnt/USB/1986 - Living On Video (LP, Album)(ATCO Records, Mirage 90518-1)/A2. Eyes Of Desire.mp3 in service mpd
Apr 19 02:19:45 volumio2ag volumio[856]: info: ALBUMART /albumart?cacheid=195&web=Trans-X/Living%20On%20Video/small&path=%2Fmnt%2FUSB%2F1986%20-%20Living%20On%20Video%20(LP%2C%20Album)(ATCO%20Records%2C%20Mirage%2090518-1)%2FA2.%20Eyes%20Of%20Desire.mp3&metadata=false
Apr 19 02:19:45 volumio2ag volumio[856]: info: URI /mnt/USB/1986 - Living On Video (LP, Album)(ATCO Records, Mirage 90518-1)/A2. Eyes Of Desire.mp3
Apr 19 02:19:46 volumio2ag volumio[856]: info: Exploding uri mnt/USB/[2015] Digital Emotion - Best Of [CD]/03. Digital Emotion - The Beauty & The Beast.flac in service mpd
Apr 19 02:19:46 volumio2ag volumio[856]: info: ALBUMART /albumart?cacheid=195&web=Digital%20Emotion/Best%20Of/small&path=%2Fmnt%2FUSB%2F%5B2015%5D%20Digital%20Emotion%20-%20Best%20Of%20%5BCD%5D%2F03.%20Digital%20Emotion%20-%20The%20Beauty%20%26%20The%20Beast.flac&metadata=false
Apr 19 02:19:46 volumio2ag volumio[856]: info: URI /mnt/USB/[2015] Digital Emotion - Best Of [CD]/03. Digital Emotion - The Beauty & The Beast.flac
Apr 19 02:19:46 volumio2ag volumio[856]: info: Exploding uri mnt/USB/[2015] Digital Emotion - Best Of [CD]/02. Digital Emotion - Go Go Yellow Screen.flac in service mpd
Apr 19 02:19:46 volumio2ag volumio[856]: info: ALBUMART /albumart?cacheid=195&web=Digital%20Emotion/Best%20Of/small&path=%2Fmnt%2FUSB%2F%5B2015%5D%20Digital%20Emotion%20-%20Best%20Of%20%5BCD%5D%2F02.%20Digital%20Emotion%20-%20Go%20Go%20Yellow%20Screen.flac&metadata=false
Apr 19 02:19:46 volumio2ag volumio[856]: info: URI /mnt/USB/[2015] Digital Emotion - Best Of [CD]/02. Digital Emotion - Go Go Yellow Screen.flac
Apr 19 02:19:46 volumio2ag volumio[856]: info: Exploding uri mnt/USB/1986 - Living On Video (LP, Album)(ATCO Records, Mirage 90518-1)/A4. Monkey Dance.mp3 in service mpd
Apr 19 02:19:46 volumio2ag volumio[856]: info: ALBUMART /albumart?cacheid=195&web=Trans-X/Living%20On%20Video/small&path=%2Fmnt%2FUSB%2F1986%20-%20Living%20On%20Video%20(LP%2C%20Album)(ATCO%20Records%2C%20Mirage%2090518-1)%2FA4.%20Monkey%20Dance.mp3&metadata=false
Apr 19 02:19:46 volumio2ag volumio[856]: info: URI /mnt/USB/1986 - Living On Video (LP, Album)(ATCO Records, Mirage 90518-1)/A4. Monkey Dance.mp3
Apr 19 02:19:46 volumio2ag volumio[856]: info: Exploding uri mnt/USB/1986 - Living On Video (LP, Album)(ATCO Records, Mirage 90518-1)/A3. 3-D Dance.mp3 in service mpd
Apr 19 02:19:46 volumio2ag volumio[856]: info: ALBUMART /albumart?cacheid=195&web=Trans-X/Living%20On%20Video/small&path=%2Fmnt%2FUSB%2F1986%20-%20Living%20On%20Video%20(LP%2C%20Album)(ATCO%20Records%2C%20Mirage%2090518-1)%2FA3.%203-D%20Dance.mp3&metadata=false
Apr 19 02:19:46 volumio2ag volumio[856]: info: URI /mnt/USB/1986 - Living On Video (LP, Album)(ATCO Records, Mirage 90518-1)/A3. 3-D Dance.mp3
Apr 19 02:19:46 volumio2ag volumio[856]: info: Exploding uri mnt/USB/1986 - Living On Video (LP, Album)(ATCO Records, Mirage 90518-1)/A1. Living On Video.mp3 in service mpd
Apr 19 02:19:46 volumio2ag volumio[856]: info: ALBUMART /albumart?cacheid=195&web=Trans-X/Living%20On%20Video/small&path=%2Fmnt%2FUSB%2F1986%20-%20Living%20On%20Video%20(LP%2C%20Album)(ATCO%20Records%2C%20Mirage%2090518-1)%2FA1.%20Living%20On%20Video.mp3&metadata=false
Apr 19 02:19:46 volumio2ag volumio[856]: info: URI /mnt/USB/1986 - Living On Video (LP, Album)(ATCO Records, Mirage 90518-1)/A1. Living On Video.mp3
Apr 19 02:19:46 volumio2ag volumio[856]: info: Exploding uri upnp/folder/http://10.54.75.100:50001/ContentDirectory/control@23 in service upnp_browser
Apr 19 02:19:46 volumio2ag volumio[856]: info: Exploding uri mnt/NAS/NAS/Ariya/1987 - Герой Асфальта (Limited Edition) [24-192]/Ария - Герой Асфальта Limited Edition.flac in service mpd
Apr 19 02:19:46 volumio2ag volumio[856]: error: scanFolder - failure to stat '/mnt/NAS/NAS/Ariya/1987 - Герой Асфальта (Limited Edition) [24-192]/Ария - Герой Асфальта Limited Edition.flac'
Apr 19 02:19:46 volumio2ag volumio[856]: info: Exploding uri cue://NAS/NAS/Ariya/1987 - Герой Асфальта (Limited Edition) [24-192]/Ария - Герой Асфальта Limited Edition.flac.cue@3 in service mpd
Apr 19 02:19:46 volumio2ag volumio[856]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 19 02:19:46 volumio2ag volumio[856]: Error: file /mnt/NAS/NAS/Ariya/1987 - Герой Асфальта (Limited Edition) [24-192]/Ария - Герой Асфальта Limited Edition.flac.cue does not exist
Apr 19 02:19:46 volumio2ag volumio[856]: at Object.parse (/volumio/node_modules/cue-parser/lib/cue.js:37:15)
Apr 19 02:19:46 volumio2ag volumio[856]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:1924:27)
Apr 19 02:19:46 volumio2ag volumio[856]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1359:16)
Apr 19 02:19:46 volumio2ag volumio[856]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24)
Apr 19 02:19:46 volumio2ag volumio[856]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19)
Apr 19 02:19:46 volumio2ag volumio[856]: at Timeout._onTimeout (/volumio/app/playqueue.js:146:100)
Apr 19 02:19:46 volumio2ag volumio[856]: at listOnTimeout (internal/timers.js:554:17)
Apr 19 02:19:46 volumio2ag volumio[856]: at processTimers (internal/timers.js:497:7)
Apr 19 02:19:46 volumio2ag volumio[856]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 19 02:19:50 volumio2ag sudo[4084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-19 02:18
Apr 19 02:19:50 volumio2ag sudo[4084]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET"
VOLUMIO_VERSION="3.631"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"