Feb 11 09:45:12 volumio volumio[1350]: info: CoreCommandRouter::volumioGetState
Feb 11 09:45:12 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:19 volumio volumio[1350]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 11 09:45:19 volumio volumio[1350]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 11 09:45:19 volumio volumio[1350]: info: Retrieving Cloud Streaming UI
Feb 11 09:45:19 volumio volumio[1350]: info: Getting Tidal Cloud Configuration
Feb 11 09:45:19 volumio volumio[1350]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 11 09:45:19 volumio volumio[1350]: info: Getting Qobuz Cloud Configuration
Feb 11 09:45:19 volumio volumio[1350]: info: Asking plugin for UI Config
Feb 11 09:45:19 volumio volumio[1350]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 11 09:45:19 volumio volumio[1350]: info: Getting Spotify Cloud Configuration
Feb 11 09:45:19 volumio volumio[1350]: info: Asking plugin for UI Config
Feb 11 09:45:19 volumio volumio[1350]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 11 09:45:19 volumio volumio[1350]: info: Saving Spotify Acccount
Feb 11 09:45:19 volumio volumio[1350]: info: Got Tidal Cloud Configuration
Feb 11 09:45:19 volumio volumio[1350]: info: Got it
Feb 11 09:45:19 volumio volumio[1350]: info: Got it
Feb 11 09:45:19 volumio volumio[1350]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Feb 11 09:45:19 volumio volumio[1350]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 11 09:45:19 volumio volumio[1350]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave')
Feb 11 09:45:19 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 11 09:45:19 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 11 09:45:19 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 11 09:45:19 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 11 09:45:19 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 11 09:45:19 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 11 09:45:19 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 11 09:45:19 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 11 09:45:19 volumio volumio[1350]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 11 09:45:19 volumio volumio[1350]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 11 09:45:19 volumio volumio[1350]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 11 09:45:19 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 11 09:45:19 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand rescan
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:22 volumio volumio[1350]: info:
Feb 11 09:45:22 volumio volumio[1350]: ---------------------------- MPD announces state update: update
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand rescan took 1 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:22 volumio volumio[1350]: info:
Feb 11 09:45:22 volumio volumio[1350]: ---------------------------- MPD announces state update: update
Feb 11 09:45:22 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:22 volumio volumio[1350]: info:
Feb 11 09:45:22 volumio volumio[1350]: ---------------------------- MPD announces state update: update
Feb 11 09:45:22 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand status took 0 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand status took 0 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand status took 0 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand status took 1 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand status took 1 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:22 volumio volumio[1350]: info: Command Router : Notfying DB Updatetrue
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::Close All Modals sent
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:22 volumio volumio[1350]: info: Command Router : Notfying DB Updatetrue
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::Close All Modals sent
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:22 volumio volumio[1350]: info: Command Router : Notfying DB Updatetrue
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::Close All Modals sent
Feb 11 09:45:22 volumio volumio[1350]: info: MPD Database updated - AlbumList cache refreshed
Feb 11 09:45:22 volumio volumio[1350]: info:
Feb 11 09:45:22 volumio volumio[1350]: ---------------------------- MPD announces state update: database
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:22 volumio volumio[1350]: info:
Feb 11 09:45:22 volumio volumio[1350]: ---------------------------- MPD announces state update: update
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand status took 411 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:22 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 169 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 10 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:22 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:22 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:22 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:22 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:22 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:22 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:22 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:22 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:22 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:22 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:22 volumio volumio[1350]: info: ------------------------------ 417ms
Feb 11 09:45:22 volumio volumio[1350]: info: ------------------------------ 417ms
Feb 11 09:45:22 volumio volumio[1350]: info: MPD Database updated - AlbumList cache refreshed
Feb 11 09:45:22 volumio volumio[1350]: info:
Feb 11 09:45:22 volumio volumio[1350]: ---------------------------- MPD announces state update: database
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:22 volumio volumio[1350]: info:
Feb 11 09:45:22 volumio volumio[1350]: ---------------------------- MPD announces state update: update
Feb 11 09:45:22 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:22 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:22 volumio volumio[1350]: info: MPD Database updated - AlbumList cache refreshed
Feb 11 09:45:22 volumio volumio[1350]: info:
Feb 11 09:45:22 volumio volumio[1350]: ---------------------------- MPD announces state update: database
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:22 volumio volumio[1350]: info:
Feb 11 09:45:22 volumio volumio[1350]: ---------------------------- MPD announces state update: update
Feb 11 09:45:22 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:22 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand status took 19 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand status took 19 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand status took 19 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 19 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:22 volumio volumio[1350]: info: Command Router : Notfying DB Updatefalse
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::Close All Modals sent
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:22 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:22 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:22 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:22 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:22 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:22 volumio volumio[1350]: info: ------------------------------ 439ms
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand status took 31 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand status took 32 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand status took 32 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:22 volumio volumio[1350]: info: Command Router : Notfying DB Updatefalse
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::Close All Modals sent
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand status took 46 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand status took 46 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand status took 46 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:22 volumio volumio[1350]: info: Command Router : Notfying DB Updatefalse
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::Close All Modals sent
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 35 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 35 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 18 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 18 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:22 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:22 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:22 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:22 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:22 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:22 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:22 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:22 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:22 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:22 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:22 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:22 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:22 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:22 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:22 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:22 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:22 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:22 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:22 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:22 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:22 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:22 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:22 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:22 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:22 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:22 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:22 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:22 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:22 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:22 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:22 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:22 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:22 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:22 volumio volumio[1350]: info: ------------------------------ 77ms
Feb 11 09:45:22 volumio volumio[1350]: info: ------------------------------ 76ms
Feb 11 09:45:22 volumio volumio[1350]: info: ------------------------------ 70ms
Feb 11 09:45:22 volumio volumio[1350]: info: ------------------------------ 70ms
Feb 11 09:45:22 volumio volumio[1350]: info: ------------------------------ 70ms
Feb 11 09:45:22 volumio volumio[1350]: info: ------------------------------ 69ms
Feb 11 09:45:23 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 11 09:45:27 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 11 09:45:31 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand update
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:32 volumio volumio[1350]: info:
Feb 11 09:45:32 volumio volumio[1350]: ---------------------------- MPD announces state update: update
Feb 11 09:45:32 volumio volumio[1350]: info: sendMpdCommand update took 1 milliseconds
Feb 11 09:45:32 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:32 volumio volumio[1350]: info: sendMpdCommand status took 1 milliseconds
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:32 volumio volumio[1350]: info: Command Router : Notfying DB Updatetrue
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::Close All Modals sent
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:32 volumio volumio[1350]: info:
Feb 11 09:45:32 volumio volumio[1350]: ---------------------------- MPD announces state update: update
Feb 11 09:45:32 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:32 volumio volumio[1350]: info:
Feb 11 09:45:32 volumio volumio[1350]: ---------------------------- MPD announces state update: update
Feb 11 09:45:32 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:32 volumio volumio[1350]: info:
Feb 11 09:45:32 volumio volumio[1350]: ---------------------------- MPD announces state update: update
Feb 11 09:45:32 volumio volumio[1350]: info: sendMpdCommand status took 129 milliseconds
Feb 11 09:45:32 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:32 volumio volumio[1350]: info: sendMpdCommand status took 1 milliseconds
Feb 11 09:45:32 volumio volumio[1350]: info: sendMpdCommand status took 1 milliseconds
Feb 11 09:45:32 volumio volumio[1350]: info: sendMpdCommand status took 2 milliseconds
Feb 11 09:45:32 volumio volumio[1350]: info: sendMpdCommand status took 1 milliseconds
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:32 volumio volumio[1350]: info: Command Router : Notfying DB Updatefalse
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::Close All Modals sent
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:32 volumio volumio[1350]: info: Command Router : Notfying DB Updatefalse
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::Close All Modals sent
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:32 volumio volumio[1350]: info:
Feb 11 09:45:32 volumio volumio[1350]: ---------------------------- MPD announces state update: update
Feb 11 09:45:32 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:32 volumio volumio[1350]: info:
Feb 11 09:45:32 volumio volumio[1350]: ---------------------------- MPD announces state update: update
Feb 11 09:45:32 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:32 volumio volumio[1350]: info: sendMpdCommand status took 175 milliseconds
Feb 11 09:45:32 volumio volumio[1350]: info: sendMpdCommand status took 175 milliseconds
Feb 11 09:45:32 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 174 milliseconds
Feb 11 09:45:32 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 43 milliseconds
Feb 11 09:45:32 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 5 milliseconds
Feb 11 09:45:32 volumio volumio[1350]: info: sendMpdCommand status took 2 milliseconds
Feb 11 09:45:32 volumio volumio[1350]: info: sendMpdCommand status took 2 milliseconds
Feb 11 09:45:32 volumio volumio[1350]: info: sendMpdCommand status took 2 milliseconds
Feb 11 09:45:32 volumio volumio[1350]: info: sendMpdCommand status took 2 milliseconds
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:32 volumio volumio[1350]: info: Command Router : Notfying DB Updatefalse
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::Close All Modals sent
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:32 volumio volumio[1350]: info: Command Router : Notfying DB Updatefalse
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::Close All Modals sent
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:32 volumio volumio[1350]: info: Command Router : Notfying DB Updatefalse
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::Close All Modals sent
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:32 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:32 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:32 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:32 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:32 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:32 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:32 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:32 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:32 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:32 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:32 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:32 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:32 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:32 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:32 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:32 volumio volumio[1350]: info: ------------------------------ 326ms
Feb 11 09:45:32 volumio volumio[1350]: info: ------------------------------ 198ms
Feb 11 09:45:32 volumio volumio[1350]: info: ------------------------------ 198ms
Feb 11 09:45:32 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 19 milliseconds
Feb 11 09:45:32 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 16 milliseconds
Feb 11 09:45:32 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 13 milliseconds
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:32 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:32 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:32 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:32 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:32 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:32 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:32 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:32 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:32 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:32 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:32 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:32 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:32 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:32 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:32 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:32 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:32 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:32 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:32 volumio volumio[1350]: info: ------------------------------ 204ms
Feb 11 09:45:32 volumio volumio[1350]: info: ------------------------------ 31ms
Feb 11 09:45:32 volumio volumio[1350]: info: ------------------------------ 31ms
Feb 11 09:45:35 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 11 09:45:36 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand rescan
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:36 volumio volumio[1350]: info:
Feb 11 09:45:36 volumio volumio[1350]: ---------------------------- MPD announces state update: update
Feb 11 09:45:36 volumio volumio[1350]: info: sendMpdCommand rescan took 1 milliseconds
Feb 11 09:45:36 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:36 volumio volumio[1350]: info:
Feb 11 09:45:36 volumio volumio[1350]: ---------------------------- MPD announces state update: update
Feb 11 09:45:36 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:36 volumio volumio[1350]: info:
Feb 11 09:45:36 volumio volumio[1350]: ---------------------------- MPD announces state update: update
Feb 11 09:45:36 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:36 volumio volumio[1350]: info: sendMpdCommand status took 1 milliseconds
Feb 11 09:45:36 volumio volumio[1350]: info: sendMpdCommand status took 1 milliseconds
Feb 11 09:45:36 volumio volumio[1350]: info: sendMpdCommand status took 1 milliseconds
Feb 11 09:45:36 volumio volumio[1350]: info: sendMpdCommand status took 1 milliseconds
Feb 11 09:45:36 volumio volumio[1350]: info: sendMpdCommand status took 1 milliseconds
Feb 11 09:45:36 volumio volumio[1350]: info: sendMpdCommand status took 1 milliseconds
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:36 volumio volumio[1350]: info: Command Router : Notfying DB Updatetrue
Feb 11 09:45:36 volumio volumio[1350]: info: CoreCommandRouter::Close All Modals sent
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:36 volumio volumio[1350]: info: Command Router : Notfying DB Updatetrue
Feb 11 09:45:36 volumio volumio[1350]: info: CoreCommandRouter::Close All Modals sent
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:36 volumio volumio[1350]: info: Command Router : Notfying DB Updatetrue
Feb 11 09:45:36 volumio volumio[1350]: info: CoreCommandRouter::Close All Modals sent
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:36 volumio volumio[1350]: info: MPD Database updated - AlbumList cache refreshed
Feb 11 09:45:36 volumio volumio[1350]: info:
Feb 11 09:45:36 volumio volumio[1350]: ---------------------------- MPD announces state update: database
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:36 volumio volumio[1350]: info:
Feb 11 09:45:36 volumio volumio[1350]: ---------------------------- MPD announces state update: update
Feb 11 09:45:36 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:36 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:36 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 199 milliseconds
Feb 11 09:45:36 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 42 milliseconds
Feb 11 09:45:36 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 5 milliseconds
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:36 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:36 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:36 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:36 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:36 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:36 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:36 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:36 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:36 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:36 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 11 09:45:36 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:36 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:36 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:36 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:36 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:36 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:36 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:36 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:36 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:36 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:36 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:36 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:36 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:36 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:36 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:36 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:36 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:36 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:36 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:36 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:36 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:36 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:36 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:36 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:36 volumio volumio[1350]: info: ------------------------------ 391ms
Feb 11 09:45:36 volumio volumio[1350]: info: ------------------------------ 390ms
Feb 11 09:45:36 volumio volumio[1350]: info: ------------------------------ 390ms
Feb 11 09:45:36 volumio volumio[1350]: info: MPD Database updated - AlbumList cache refreshed
Feb 11 09:45:36 volumio volumio[1350]: info:
Feb 11 09:45:36 volumio volumio[1350]: ---------------------------- MPD announces state update: database
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:36 volumio volumio[1350]: info:
Feb 11 09:45:36 volumio volumio[1350]: ---------------------------- MPD announces state update: update
Feb 11 09:45:36 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:36 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:36 volumio volumio[1350]: info: MPD Database updated - AlbumList cache refreshed
Feb 11 09:45:36 volumio volumio[1350]: info:
Feb 11 09:45:36 volumio volumio[1350]: ---------------------------- MPD announces state update: database
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:36 volumio volumio[1350]: info:
Feb 11 09:45:36 volumio volumio[1350]: ---------------------------- MPD announces state update: update
Feb 11 09:45:36 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:36 volumio volumio[1350]: info: ControllerMpd::getState
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand status
Feb 11 09:45:36 volumio volumio[1350]: info: sendMpdCommand status took 27 milliseconds
Feb 11 09:45:36 volumio volumio[1350]: info: sendMpdCommand status took 27 milliseconds
Feb 11 09:45:36 volumio volumio[1350]: info: sendMpdCommand status took 27 milliseconds
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:36 volumio volumio[1350]: info: Command Router : Notfying DB Updatefalse
Feb 11 09:45:36 volumio volumio[1350]: info: CoreCommandRouter::Close All Modals sent
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:36 volumio volumio[1350]: info: sendMpdCommand status took 37 milliseconds
Feb 11 09:45:36 volumio volumio[1350]: info: sendMpdCommand status took 38 milliseconds
Feb 11 09:45:36 volumio volumio[1350]: info: sendMpdCommand status took 38 milliseconds
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:36 volumio volumio[1350]: info: Command Router : Notfying DB Updatefalse
Feb 11 09:45:36 volumio volumio[1350]: info: CoreCommandRouter::Close All Modals sent
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:36 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:37 volumio volumio[1350]: info: sendMpdCommand status took 52 milliseconds
Feb 11 09:45:37 volumio volumio[1350]: info: sendMpdCommand status took 52 milliseconds
Feb 11 09:45:37 volumio volumio[1350]: info: sendMpdCommand status took 51 milliseconds
Feb 11 09:45:37 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:37 volumio volumio[1350]: info: Command Router : Notfying DB Updatefalse
Feb 11 09:45:37 volumio volumio[1350]: info: CoreCommandRouter::Close All Modals sent
Feb 11 09:45:37 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:37 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:37 volumio volumio[1350]: verbose: ControllerMpd::parseState
Feb 11 09:45:37 volumio volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 11 09:45:37 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 32 milliseconds
Feb 11 09:45:37 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 32 milliseconds
Feb 11 09:45:37 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 16 milliseconds
Feb 11 09:45:37 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 16 milliseconds
Feb 11 09:45:37 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 11 09:45:37 volumio volumio[1350]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 11 09:45:37 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:37 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:37 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:37 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:37 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:37 volumio volumio[1350]: verbose: ControllerMpd::parseTrackInfo
Feb 11 09:45:37 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:37 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:37 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:37 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:37 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:37 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:37 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 11 09:45:37 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:37 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:37 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:37 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:37 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:37 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:37 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:37 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:37 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:37 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:37 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:37 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:37 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:37 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:37 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:37 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:37 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:37 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:37 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:37 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:37 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:37 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:37 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:37 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:37 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:37 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:37 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:37 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:37 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:37 volumio volumio[1350]: info: ControllerMpd::pushState
Feb 11 09:45:37 volumio volumio[1350]: info: CoreCommandRouter::servicePushState
Feb 11 09:45:37 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:37 volumio volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":88464,"duration":355,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Holiday","artist":"Scorpions","album":"Acoustica","uri":"INTERNAL/Anh-My/Scorpions/scorpions-acoustica/04 - Holiday.mp3","trackType":"mp3"}
Feb 11 09:45:37 volumio volumio[1350]: verbose: CURRENT POSITION 3
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::syncState stateService pause
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::syncState currentStatus pause
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::pushState
Feb 11 09:45:37 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:37 volumio volumio[1350]: info: CoreCommandRouter::volumioPushState
Feb 11 09:45:37 volumio volumio[1350]: info: CoreStateMachine::stPlaybackTimer
Feb 11 09:45:37 volumio volumio[1350]: info: ------------------------------ 76ms
Feb 11 09:45:37 volumio volumio[1350]: info: ------------------------------ 76ms
Feb 11 09:45:37 volumio volumio[1350]: info: ------------------------------ 69ms
Feb 11 09:45:37 volumio volumio[1350]: info: ------------------------------ 69ms
Feb 11 09:45:37 volumio volumio[1350]: info: ------------------------------ 69ms
Feb 11 09:45:37 volumio volumio[1350]: info: ------------------------------ 69ms
Feb 11 09:45:39 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 11 09:45:41 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 11 09:45:41 volumio volumio[1350]: info: Received Get System Info
Feb 11 09:45:41 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 11 09:45:41 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 11 09:45:41 volumio volumio[1350]: info: Discovery: Getting this device information
Feb 11 09:45:41 volumio volumio[1350]: info: CoreCommandRouter::volumioGetState
Feb 11 09:45:41 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:45:41 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 11 09:45:43 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 11 09:45:47 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 11 09:45:51 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 11 09:45:55 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 11 09:45:59 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 11 09:46:03 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 11 09:46:07 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 11 09:46:11 volumio volumio[1350]: info: CALLMETHOD: miscellanea albumart clearAlbumartCache
Feb 11 09:46:11 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: albumart , clearAlbumartCache
Feb 11 09:46:11 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , rebuildAlbumCache
Feb 11 09:46:11 volumio volumio[1350]: info: Rebuild Album cache
Feb 11 09:46:11 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 11 09:46:14 volumio volumio[1350]: info: CALLMETHOD: miscellanea albumart saveAlbumartOptions [object Object]
Feb 11 09:46:14 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: albumart , saveAlbumartOptions
Feb 11 09:46:15 volumio volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 11 09:46:17 volumio volumio[1350]: info: CoreCommandRouter::volumioGetState
Feb 11 09:46:17 volumio volumio[1350]: info: CorePlayQueue::getTrack 3
Feb 11 09:46:21 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service...
Feb 11 09:46:21 volumio ntpd[1162]: PROTO: 103.72.56.71 unlink local addr 192.168.2.184 ->
Feb 11 09:46:22 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully.
Feb 11 09:46:22 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service.
Feb 11 09:46:25 volumio ntpd[1162]: PROTO: 103.184.124.254 unlink local addr 192.168.2.184 ->
Feb 11 09:46:52 volumio volumio[1350]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 11 09:46:52 volumio volumio[1350]: TypeError: Cannot read properties of null (reading 'slice')
Feb 11 09:46:52 volumio volumio[1350]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41)
Feb 11 09:46:52 volumio volumio[1350]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7)
Feb 11 09:46:52 volumio volumio[1350]: at Object.onceWrapper (node:events:629:26)
Feb 11 09:46:52 volumio volumio[1350]: at ClientRequest.emit (node:events:514:28)
Feb 11 09:46:52 volumio volumio[1350]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27)
Feb 11 09:46:52 volumio volumio[1350]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17)
Feb 11 09:46:52 volumio volumio[1350]: at TLSSocket.socketOnData (node:_http_client:535:22)
Feb 11 09:46:52 volumio volumio[1350]: at TLSSocket.emit (node:events:514:28)
Feb 11 09:46:52 volumio volumio[1350]: at addChunk (node:internal/streams/readable:343:12)
Feb 11 09:46:52 volumio volumio[1350]: at readableAddChunk (node:internal/streams/readable:316:9)
Feb 11 09:46:52 volumio volumio[1350]: at Readable.push (node:internal/streams/readable:253:10)
Feb 11 09:46:52 volumio volumio[1350]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23)
Feb 11 09:46:52 volumio volumio[1350]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 11 09:46:53 volumio sudo[4726]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-11 09:45'
Feb 11 09:46:53 volumio sudo[4726]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"
NAME="Debian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Dec 25 09:38:19 UTC 2025"
VOLUMIO_VERSION="4.084"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="00e933ebe3692ad8aea9910d2289bf23"