-- Logs begin at Wed 2025-02-26 03:52:59 UTC, end at Wed 2025-02-26 13:39:01 UTC. --
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: Retrieving Cloud Streaming UI
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: Getting Tidal Cloud Configuration
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: Getting Qobuz Cloud Configuration
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: Asking plugin for UI Config
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: Getting Spotify Cloud Configuration
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: Asking plugin for UI Config
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: Saving Spotify Acccount
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: Got Tidal Cloud Configuration
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: Got it
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: Got it
Feb 26 13:38:01 volumio-chen1 volumio[1240]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 26 13:38:01 volumio-chen1 volumio[1240]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 26 13:38:01 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Feb 26 13:38:03 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Feb 26 13:38:03 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand rescan
Feb 26 13:38:03 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:03 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:03 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:03 volumio-chen1 volumio[1240]: info: sendMpdCommand rescan took 2 milliseconds
Feb 26 13:38:03 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:03 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:03 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:03 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:03 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:03 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:03 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:03 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:03 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:03 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:03 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:03 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:03 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:03 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:03 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:03 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 2 milliseconds
Feb 26 13:38:03 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 2 milliseconds
Feb 26 13:38:03 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 1 milliseconds
Feb 26 13:38:03 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:03 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:03 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:03 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:03 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:03 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:03 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:03 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:03 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:03 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:03 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:04 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 59 milliseconds
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 36 milliseconds
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 11 milliseconds
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: ------------------------------ 108ms
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: ------------------------------ 107ms
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: ------------------------------ 107ms
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:04 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:04 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 25 milliseconds
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 21 milliseconds
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 2 milliseconds
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 51 milliseconds
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 30 milliseconds
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 5 milliseconds
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:04 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: ------------------------------ 112ms
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: ------------------------------ 91ms
Feb 26 13:38:04 volumio-chen1 volumio[1240]: info: ------------------------------ 90ms
Feb 26 13:38:05 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 26 13:38:09 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand update
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:10 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: sendMpdCommand update took 4 milliseconds
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:10 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:10 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 12 milliseconds
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 10 milliseconds
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 9 milliseconds
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 8 milliseconds
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 7 milliseconds
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 6 milliseconds
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:10 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 52 milliseconds
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 28 milliseconds
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 6 milliseconds
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: ------------------------------ 107ms
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: ------------------------------ 103ms
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: ------------------------------ 101ms
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:10 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:10 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 23 milliseconds
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 22 milliseconds
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 11 milliseconds
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 10 milliseconds
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 10 milliseconds
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 48 milliseconds
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 27 milliseconds
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 5 milliseconds
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:10 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: ------------------------------ 106ms
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: ------------------------------ 95ms
Feb 26 13:38:10 volumio-chen1 volumio[1240]: info: ------------------------------ 93ms
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand update
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:11 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand update took 2 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:11 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:11 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 5 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 2 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:11 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 50 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 28 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 6 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ------------------------------ 94ms
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ------------------------------ 93ms
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ------------------------------ 92ms
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:11 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:11 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 22 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 22 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 2 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 48 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 27 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 5 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ------------------------------ 109ms
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ------------------------------ 90ms
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ------------------------------ 89ms
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand rescan
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:11 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand rescan took 3 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:11 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:11 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 7 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 6 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 5 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 2 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:11 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 53 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 28 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 6 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ------------------------------ 104ms
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ------------------------------ 103ms
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ------------------------------ 101ms
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:11 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:11 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 29 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 28 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 6 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 5 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 51 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 30 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 8 milliseconds
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:11 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ------------------------------ 118ms
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ------------------------------ 95ms
Feb 26 13:38:11 volumio-chen1 volumio[1240]: info: ------------------------------ 93ms
Feb 26 13:38:13 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 26 13:38:17 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 26 13:38:21 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand rescan
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:23 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: sendMpdCommand rescan took 2 milliseconds
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:23 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:23 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 9 milliseconds
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 8 milliseconds
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 7 milliseconds
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 6 milliseconds
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 5 milliseconds
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:23 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 49 milliseconds
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 26 milliseconds
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 5 milliseconds
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: ------------------------------ 120ms
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: ------------------------------ 119ms
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: ------------------------------ 117ms
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:23 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:23 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 22 milliseconds
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 21 milliseconds
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 9 milliseconds
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 10 milliseconds
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 9 milliseconds
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 9 milliseconds
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 48 milliseconds
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 26 milliseconds
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 4 milliseconds
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:23 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: ------------------------------ 106ms
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: ------------------------------ 93ms
Feb 26 13:38:23 volumio-chen1 volumio[1240]: info: ------------------------------ 93ms
Feb 26 13:38:25 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 26 13:38:29 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 26 13:38:31 volumio-chen1 kernel: usb 1-1.2: USB disconnect, device number 5
Feb 26 13:38:31 volumio-chen1 volumio[1240]: info: Partition removed: {"syspath":"/sys/devices/platform/ff540000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb3","ACTION":"remove","DEVLINKS":"/dev/disk/by-label/New\\x20Volume /dev/disk/by-partuuid/199fc1fc-892b-4d48-8a16-66d3e114b0bd /dev/disk/by-id/wwn-0x5002538e40f6367d-part3 /dev/disk/by-id/ata-Samsung_SSD_860_EVO_M.2_500GB_S414NB0M415427V-part3 /dev/disk/by-uuid/82D8F149D8F13BCB /dev/disk/by-partlabel/Basic\\x20data\\x20partition /dev/disk/by-path/platform-ff540000.usb-usb-0:1.2:1.0-scsi-0:0:0:0-part3","DEVNAME":"/dev/sdb3","DEVPATH":"/devices/platform/ff540000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb3","DEVTYPE":"partition","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"8","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"4","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"0","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"New_Volume","ID_FS_LABEL_ENC":"New\\x20Volume","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"82D8F149D8F13BCB","ID_FS_UUID_ENC":"82D8F149D8F13BCB","ID_MODEL":"Samsung_SSD_860_EVO_M.2_500GB","ID_MODEL_ENC":"Samsung\\x20SSD\\x20860\\x20EVO\\x20M.2\\x20500GB\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_NAME":"Basic\\x20data\\x20partition","ID_PART_ENTRY_NUMBER":"3","ID_PART_ENTRY_OFFSET":"239616","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"975435776","ID_PART_ENTRY_TYPE":"ebd0a0a2-b9e5-4433-87c0-68b6b72699c7","ID_PART_ENTRY_UUID":"199fc1fc-892b-4d48-8a16-66d3e114b0bd","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"d9276d2e-675c-4d09-b21c-e81a89a87924","ID_PATH":"platform-ff540000.usb-usb-0:1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-ff540000_usb-usb-0_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"RVT22B6Q","ID_SERIAL":"Samsung_SSD_860_EVO_M.2_500GB_S414NB0M415427V","ID_SERIAL_SHORT":"S414NB0M415427V","ID_TYPE":"disk","ID_WWN":"0x5002538e40f6367d","ID_WWN_WITH_EXTENSION":"0x5002538e40f6367d","MAJOR":"8","MINOR":"19","PARTN":"3","PARTNAME":"Basic data partition","SEQNUM":"3123","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"20064304870"}
Feb 26 13:38:31 volumio-chen1 volumio[1240]: info: Partition removed: {"syspath":"/sys/devices/platform/ff540000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb2","ACTION":"remove","DEVLINKS":"/dev/disk/by-partuuid/2616858d-408f-4e83-a39d-16291f35ef8a /dev/disk/by-path/platform-ff540000.usb-usb-0:1.2:1.0-scsi-0:0:0:0-part2 /dev/disk/by-id/ata-Samsung_SSD_860_EVO_M.2_500GB_S414NB0M415427V-part2 /dev/disk/by-partlabel/Microsoft\\x20reserved\\x20partition /dev/disk/by-id/wwn-0x5002538e40f6367d-part2","DEVNAME":"/dev/sdb2","DEVPATH":"/devices/platform/ff540000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb2","DEVTYPE":"partition","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"8","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"4","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"0","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_MODEL":"Samsung_SSD_860_EVO_M.2_500GB","ID_MODEL_ENC":"Samsung\\x20SSD\\x20860\\x20EVO\\x20M.2\\x20500GB\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_FLAGS":"0x8000000000000000","ID_PART_ENTRY_NAME":"Microsoft\\x20reserved\\x20partition","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"206848","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"32768","ID_PART_ENTRY_TYPE":"e3c9e316-0b5c-4db8-817d-f92df00215ae","ID_PART_ENTRY_UUID":"2616858d-408f-4e83-a39d-16291f35ef8a","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"d9276d2e-675c-4d09-b21c-e81a89a87924","ID_PATH":"platform-ff540000.usb-usb-0:1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-ff540000_usb-usb-0_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"RVT22B6Q","ID_SERIAL":"Samsung_SSD_860_EVO_M.2_500GB_S414NB0M415427V","ID_SERIAL_SHORT":"S414NB0M415427V","ID_TYPE":"disk","ID_WWN":"0x5002538e40f6367d","ID_WWN_WITH_EXTENSION":"0x5002538e40f6367d","MAJOR":"8","MINOR":"18","PARTN":"2","PARTNAME":"Microsoft reserved partition","SEQNUM":"3124","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"20064210717"}
Feb 26 13:38:31 volumio-chen1 volumio[1240]: error: Cannot associate FS Label, not mounting
Feb 26 13:38:31 volumio-chen1 volumio[1240]: info: Partition removed: {"syspath":"/sys/devices/platform/ff540000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/ata-Samsung_SSD_860_EVO_M.2_500GB_S414NB0M415427V-part1 /dev/disk/by-uuid/8A3B-A32D /dev/disk/by-partlabel/EFI\\x20system\\x20partition /dev/disk/by-path/platform-ff540000.usb-usb-0:1.2:1.0-scsi-0:0:0:0-part1 /dev/disk/by-id/wwn-0x5002538e40f6367d-part1 /dev/disk/by-partuuid/e7931407-5ea6-4af3-887c-5ea57f205628","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/platform/ff540000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"8","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"4","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"0","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"8A3B-A32D","ID_FS_UUID_ENC":"8A3B-A32D","ID_FS_VERSION":"FAT32","ID_MODEL":"Samsung_SSD_860_EVO_M.2_500GB","ID_MODEL_ENC":"Samsung\\x20SSD\\x20860\\x20EVO\\x20M.2\\x20500GB\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_FLAGS":"0x8000000000000000","ID_PART_ENTRY_NAME":"EFI\\x20system\\x20partition","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"204800","ID_PART_ENTRY_TYPE":"c12a7328-f81f-11d2-ba4b-00a0c93ec93b","ID_PART_ENTRY_UUID":"e7931407-5ea6-4af3-887c-5ea57f205628","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"d9276d2e-675c-4d09-b21c-e81a89a87924","ID_PATH":"platform-ff540000.usb-usb-0:1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-ff540000_usb-usb-0_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"RVT22B6Q","ID_SERIAL":"Samsung_SSD_860_EVO_M.2_500GB_S414NB0M415427V","ID_SERIAL_SHORT":"S414NB0M415427V","ID_TYPE":"disk","ID_WWN":"0x5002538e40f6367d","ID_WWN_WITH_EXTENSION":"0x5002538e40f6367d","MAJOR":"8","MINOR":"17","PARTN":"1","PARTNAME":"EFI system partition","SEQNUM":"3125","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"20064201419"}
Feb 26 13:38:31 volumio-chen1 kernel: sd 1:0:0:0: [sdb] Synchronizing SCSI cache
Feb 26 13:38:31 volumio-chen1 kernel: sd 1:0:0:0: [sdb] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=0x00
Feb 26 13:38:31 volumio-chen1 sudo[17118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdb1
Feb 26 13:38:31 volumio-chen1 sudo[17118]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 26 13:38:31 volumio-chen1 systemd[1]: media-8A3B\x2dA32D.mount: Succeeded.
Feb 26 13:38:31 volumio-chen1 sudo[17118]: pam_unix(sudo:session): session closed for user root
Feb 26 13:38:31 volumio-chen1 volumio[1240]: info: Partition removed: {"syspath":"/sys/devices/platform/ff540000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb4","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/D6EEE1AFEEE18857 /dev/disk/by-partuuid/ef652fef-a9f5-4402-be64-53262173e3fc /dev/disk/by-id/ata-Samsung_SSD_860_EVO_M.2_500GB_S414NB0M415427V-part4 /dev/disk/by-id/wwn-0x5002538e40f6367d-part4 /dev/disk/by-path/platform-ff540000.usb-usb-0:1.2:1.0-scsi-0:0:0:0-part4","DEVNAME":"/dev/sdb4","DEVPATH":"/devices/platform/ff540000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb4","DEVTYPE":"partition","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"8","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"4","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"0","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"D6EEE1AFEEE18857","ID_FS_UUID_ENC":"D6EEE1AFEEE18857","ID_MODEL":"Samsung_SSD_860_EVO_M.2_500GB","ID_MODEL_ENC":"Samsung\\x20SSD\\x20860\\x20EVO\\x20M.2\\x20500GB\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_FLAGS":"0x8000000000000001","ID_PART_ENTRY_NUMBER":"4","ID_PART_ENTRY_OFFSET":"975677440","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"1093632","ID_PART_ENTRY_TYPE":"de94bba4-06d1-4d40-a16a-bfd50179d6ac","ID_PART_ENTRY_UUID":"ef652fef-a9f5-4402-be64-53262173e3fc","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"d9276d2e-675c-4d09-b21c-e81a89a87924","ID_PATH":"platform-ff540000.usb-usb-0:1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-ff540000_usb-usb-0_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"RVT22B6Q","ID_SERIAL":"Samsung_SSD_860_EVO_M.2_500GB_S414NB0M415427V","ID_SERIAL_SHORT":"S414NB0M415427V","ID_TYPE":"disk","ID_WWN":"0x5002538e40f6367d","ID_WWN_WITH_EXTENSION":"0x5002538e40f6367d","MAJOR":"8","MINOR":"20","PARTN":"4","SEQNUM":"3122","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"20064134497"}
Feb 26 13:38:31 volumio-chen1 sudo[17128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdb4
Feb 26 13:38:31 volumio-chen1 sudo[17128]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 26 13:38:31 volumio-chen1 ntfs-3g[16651]: Unmounting /dev/sdb4 ()
Feb 26 13:38:31 volumio-chen1 ntfs-3g[16651]: Failed to sync device /dev/sdb4: Input/output error
Feb 26 13:38:31 volumio-chen1 ntfs-3g[16651]: Failed to close volume /dev/sdb4: Input/output error
Feb 26 13:38:31 volumio-chen1 systemd[1]: media-D6EEE1AFEEE18857.mount: Succeeded.
Feb 26 13:38:31 volumio-chen1 sudo[17128]: pam_unix(sudo:session): session closed for user root
Feb 26 13:38:33 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 26 13:38:34 volumio-chen1 kernel: usb 1-1.1: new high-speed USB device number 6 using dwc2
Feb 26 13:38:34 volumio-chen1 kernel: usb 1-1.1: New USB device found, idVendor=2109, idProduct=0715
Feb 26 13:38:34 volumio-chen1 kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Feb 26 13:38:34 volumio-chen1 kernel: usb 1-1.1: Product: VLI Product String
Feb 26 13:38:34 volumio-chen1 kernel: usb 1-1.1: Manufacturer: VLI Manufacture String
Feb 26 13:38:34 volumio-chen1 kernel: usb 1-1.1: SerialNumber: 000000123ACD
Feb 26 13:38:34 volumio-chen1 kernel: usb-storage 1-1.1:1.0: USB Mass Storage device detected
Feb 26 13:38:34 volumio-chen1 kernel: scsi host2: usb-storage 1-1.1:1.0
Feb 26 13:38:35 volumio-chen1 volumio[1240]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/8A3B-A32D
Feb 26 13:38:35 volumio-chen1 volumio[1240]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/D6EEE1AFEEE18857
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: Scanning removed location : "USB/8A3B-A32D"
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:36 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:36 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:36 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: MPD Database updated - AlbumList cache refreshed
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:36 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: database
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:36 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 2 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: MPD Database updated - AlbumList cache refreshed
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:36 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: database
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:36 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: MPD Database updated - AlbumList cache refreshed
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:36 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: database
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:36 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 86 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 59 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 37 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 15 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 8 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 7 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 6 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 5 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 6 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ------------------------------ 175ms
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ------------------------------ 175ms
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ------------------------------ 174ms
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 68 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 67 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 45 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 24 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ------------------------------ 199ms
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ------------------------------ 200ms
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ------------------------------ 121ms
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ------------------------------ 121ms
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ------------------------------ 120ms
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ------------------------------ 120ms
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: Scanning removed location : "USB/D6EEE1AFEEE18857"
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:36 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:36 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:36 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:36 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 5 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:36 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:36 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 83 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 83 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 52 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 30 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 7 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ------------------------------ 168ms
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ------------------------------ 167ms
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ------------------------------ 167ms
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 66 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 44 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 23 milliseconds
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:36 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ------------------------------ 184ms
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ------------------------------ 105ms
Feb 26 13:38:36 volumio-chen1 volumio[1240]: info: ------------------------------ 104ms
Feb 26 13:38:37 volumio-chen1 kernel: scsi 2:0:0:0: Direct-Access Samsung SSD 860 EVO RVT2 PQ: 0 ANSI: 6
Feb 26 13:38:37 volumio-chen1 kernel: sd 2:0:0:0: [sdb] 976773168 512-byte logical blocks: (500 GB/466 GiB)
Feb 26 13:38:37 volumio-chen1 kernel: sd 2:0:0:0: [sdb] Write Protect is off
Feb 26 13:38:37 volumio-chen1 kernel: sd 2:0:0:0: [sdb] Mode Sense: 2f 00 00 00
Feb 26 13:38:37 volumio-chen1 kernel: sd 2:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Feb 26 13:38:37 volumio-chen1 kernel: sdb: sdb1 sdb2 sdb3 sdb4
Feb 26 13:38:37 volumio-chen1 kernel: sd 2:0:0:0: [sdb] Attached SCSI disk
Feb 26 13:38:37 volumio-chen1 volumio[1240]: error: Cannot associate FS Label, not mounting
Feb 26 13:38:37 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 26 13:38:37 volumio-chen1 volumio[1240]: info: Mounting Device D6EEE1AFEEE18857
Feb 26 13:38:37 volumio-chen1 sudo[17195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb4 /mnt/USB/D6EEE1AFEEE18857 -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 26 13:38:37 volumio-chen1 sudo[17195]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 26 13:38:38 volumio-chen1 ntfs-3g[17203]: Version 2017.3.23AR.3 integrated FUSE 28
Feb 26 13:38:38 volumio-chen1 ntfs-3g[17203]: Mounted /dev/sdb4 (Read-Write, label "", NTFS 3.1)
Feb 26 13:38:38 volumio-chen1 ntfs-3g[17203]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 26 13:38:38 volumio-chen1 ntfs-3g[17203]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sdb4,blkdev,blksize=4096
Feb 26 13:38:38 volumio-chen1 ntfs-3g[17203]: Global ownership and permissions enforced, configuration type 7
Feb 26 13:38:38 volumio-chen1 sudo[17195]: pam_unix(sudo:session): session closed for user root
Feb 26 13:38:38 volumio-chen1 volumio[1240]: info: Mounting Device New_Volume
Feb 26 13:38:38 volumio-chen1 volumio[1240]: /bin/mkdir: cannot create directory ‘/mnt/USB/New_Volume’: File exists
Feb 26 13:38:38 volumio-chen1 volumio[1240]: error: Failed to create folder Error: Command failed: /bin/mkdir -m 777 "/mnt/USB/New_Volume"
Feb 26 13:38:38 volumio-chen1 volumio[1240]: /bin/mkdir: cannot create directory ‘/mnt/USB/New_Volume’: File exists
Feb 26 13:38:38 volumio-chen1 sudo[17213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb3 /mnt/USB/New_Volume -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 26 13:38:38 volumio-chen1 sudo[17213]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 26 13:38:38 volumio-chen1 sudo[17213]: pam_unix(sudo:session): session closed for user root
Feb 26 13:38:38 volumio-chen1 volumio[1240]: ntfs-3g-mount: failed to access mountpoint /media/New_Volume: Transport endpoint is not connected
Feb 26 13:38:38 volumio-chen1 volumio[1240]: error: Failed to mount New_Volume: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sdb3" "/mnt/USB/New_Volume" -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 26 13:38:38 volumio-chen1 volumio[1240]: ntfs-3g-mount: failed to access mountpoint /media/New_Volume: Transport endpoint is not connected
Feb 26 13:38:38 volumio-chen1 volumio[1240]: info: Mounting Device 8A3B-A32D
Feb 26 13:38:38 volumio-chen1 sudo[17227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/8A3B-A32D -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 26 13:38:38 volumio-chen1 sudo[17227]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 26 13:38:38 volumio-chen1 kernel: FAT-fs (sdb1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive!
Feb 26 13:38:38 volumio-chen1 sudo[17227]: pam_unix(sudo:session): session closed for user root
Feb 26 13:38:38 volumio-chen1 kernel: FAT-fs (sdb1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Feb 26 13:38:38 volumio-chen1 volumio[1240]: info: Scanning new location : "USB/D6EEE1AFEEE18857"
Feb 26 13:38:38 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:38 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:38 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:38 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:38 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:38 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:38 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:38 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:38 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:38 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:38 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:38 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:38 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:38 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:38 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:38 volumio-chen1 volumio[1240]: info: Scanning new location : "USB/8A3B-A32D"
Feb 26 13:38:38 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:38 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:38 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:38 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 25 milliseconds
Feb 26 13:38:38 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 24 milliseconds
Feb 26 13:38:38 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 23 milliseconds
Feb 26 13:38:38 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:38 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:38 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:38 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:38 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:38 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:38 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:38 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:39 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 80 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 78 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:39 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:39 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:39 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 89 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 66 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 43 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 39 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 38 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 10 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 8 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 7 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ------------------------------ 220ms
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ------------------------------ 220ms
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ------------------------------ 219ms
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ------------------------------ 198ms
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:39 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:39 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 89 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 87 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 64 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 42 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 20 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 5 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ------------------------------ 210ms
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ------------------------------ 179ms
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ------------------------------ 178ms
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:39 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:39 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 71 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 48 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 27 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 14 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 13 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 14 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 13 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ------------------------------ 245ms
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ------------------------------ 160ms
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ------------------------------ 160ms
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 34 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 12 milliseconds
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:39 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ------------------------------ 81ms
Feb 26 13:38:39 volumio-chen1 volumio[1240]: info: ------------------------------ 80ms
Feb 26 13:38:41 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand rescan
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:43 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand rescan took 2 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 2 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:43 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:43 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 37 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 2 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 2 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: MPD Database updated - AlbumList cache refreshed
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:43 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: database
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:43 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 60 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 30 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 7 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ------------------------------ 109ms
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ------------------------------ 75ms
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ------------------------------ 73ms
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: MPD Database updated - AlbumList cache refreshed
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:43 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: database
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:43 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: MPD Database updated - AlbumList cache refreshed
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:43 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: database
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:43 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 19 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 19 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 19 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 9 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 8 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 5 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 53 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 53 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 30 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 8 milliseconds
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:43 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ------------------------------ 115ms
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ------------------------------ 115ms
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ------------------------------ 104ms
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ------------------------------ 105ms
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ------------------------------ 101ms
Feb 26 13:38:43 volumio-chen1 volumio[1240]: info: ------------------------------ 101ms
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand rescan
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:44 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: sendMpdCommand rescan took 4 milliseconds
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 2 milliseconds
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 1 milliseconds
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:44 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:44 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:44 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 5 milliseconds
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 2 milliseconds
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 2 milliseconds
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: ------------------------------ 85ms
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:44 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:44 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 61 milliseconds
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 37 milliseconds
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 12 milliseconds
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 6 milliseconds
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 7 milliseconds
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 6 milliseconds
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: ------------------------------ 144ms
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: ------------------------------ 144ms
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 57 milliseconds
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 33 milliseconds
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 11 milliseconds
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:44 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: ------------------------------ 152ms
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: ------------------------------ 98ms
Feb 26 13:38:44 volumio-chen1 volumio[1240]: info: ------------------------------ 97ms
Feb 26 13:38:45 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand rescan
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:49 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: sendMpdCommand rescan took 2 milliseconds
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:49 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:49 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:49 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 42 milliseconds
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 42 milliseconds
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 42 milliseconds
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 42 milliseconds
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 4 milliseconds
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatetrue
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: ------------------------------ 99ms
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:49 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info:
Feb 26 13:38:49 volumio-chen1 volumio[1240]: ---------------------------- MPD announces state update: update
Feb 26 13:38:49 volumio-chen1 volumio[1240]: info: ControllerMpd::getState
Feb 26 13:38:49 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 62 milliseconds
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 62 milliseconds
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 36 milliseconds
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 15 milliseconds
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 4 milliseconds
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: sendMpdCommand status took 3 milliseconds
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: Command Router : Notfying DB Updatefalse
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreCommandRouter::Close All Modals sent
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: ------------------------------ 183ms
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: ------------------------------ 183ms
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 53 milliseconds
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 33 milliseconds
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: sendMpdCommand playlistinfo took 11 milliseconds
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: ControllerMpd::parseTrackInfo
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: ControllerMpd::pushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreCommandRouter::servicePushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23223,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","artist":null,"album":null,"uri":"USB/New_Volume/Audiophile/Best of Chesky Jazz And More Audiophile Tests Volume 1 (1990)/02 - Johnny Frigo With Bucky And John Pizzarelli - Stompin' At The Savoy.aiff","trackType":"aiff"}
Feb 26 13:38:50 volumio-chen1 volumio[1240]: verbose: CURRENT POSITION 1
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState stateService pause
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::syncState currentStatus pause
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::pushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CorePlayQueue::getTrack 1
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreCommandRouter::volumioPushState
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: CoreStateMachine::stPlaybackTimer
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: ------------------------------ 153ms
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: ------------------------------ 94ms
Feb 26 13:38:50 volumio-chen1 volumio[1240]: info: ------------------------------ 93ms
Feb 26 13:38:53 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 26 13:38:57 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 26 13:39:00 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Feb 26 13:39:00 volumio-chen1 volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Feb 26 13:39:00 volumio-chen1 volumio[1240]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 26 13:39:00 volumio-chen1 volumio[1240]: Error: getaddrinfo -3007
Feb 26 13:39:00 volumio-chen1 volumio[1240]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11)
Feb 26 13:39:00 volumio-chen1 volumio[1240]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10)
Feb 26 13:39:00 volumio-chen1 volumio[1240]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) {
Feb 26 13:39:00 volumio-chen1 volumio[1240]: code: -3007,
Feb 26 13:39:00 volumio-chen1 volumio[1240]: errno: -3007,
Feb 26 13:39:00 volumio-chen1 volumio[1240]: syscall: 'getaddrinfo'
Feb 26 13:39:00 volumio-chen1 volumio[1240]: }
Feb 26 13:39:00 volumio-chen1 volumio[1240]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 26 13:39:01 volumio-chen1 sudo[17394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-26 13:38
Feb 26 13:39:01 volumio-chen1 sudo[17394]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:11:38 PM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="tinkerboard"
VOLUMIO_DEVICENAME="Asus Tinkerboard"
VOLUMIO_HASH="932fc3546f7cc8faa2b4d349036752dd"