-- Logs begin at Wed 2024-07-10 13:06:58 GMT, end at Wed 2024-07-10 13:11:56 GMT. -- Jul 10 13:10:23 volumio volumio[1021]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 10 13:10:23 volumio volumio[1021]: info: Retrying Login Due to Network Error Jul 10 13:10:32 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 10 13:10:32 volumio volumio[1021]: info: CURURI: music-library Jul 10 13:10:32 volumio volumio[1021]: error: Failed LSINFO: null Jul 10 13:10:32 volumio volumio[1021]: info: Preload queue cleared Jul 10 13:10:33 volumio volumio[1021]: info: MyVolumio login type: Token Jul 10 13:10:36 volumio volumio[1021]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 10 13:10:36 volumio volumio[1021]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 10 13:10:36 volumio volumio[1021]: info: Retrieving Cloud Streaming UI Jul 10 13:10:36 volumio volumio[1021]: info: Getting Tidal Cloud Configuration Jul 10 13:10:36 volumio volumio[1021]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 10 13:10:36 volumio volumio[1021]: info: Getting Qobuz Cloud Configuration Jul 10 13:10:36 volumio volumio[1021]: info: Asking plugin for UI Config Jul 10 13:10:36 volumio volumio[1021]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 10 13:10:36 volumio volumio[1021]: info: Getting Spotify Cloud Configuration Jul 10 13:10:36 volumio volumio[1021]: info: Asking plugin for UI Config Jul 10 13:10:36 volumio volumio[1021]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 10 13:10:36 volumio volumio[1021]: info: Saving Spotify Acccount Jul 10 13:10:36 volumio volumio[1021]: info: Got Tidal Cloud Configuration Jul 10 13:10:36 volumio volumio[1021]: info: Got it Jul 10 13:10:36 volumio volumio[1021]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 10 13:10:36 volumio volumio[1021]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 10 13:10:36 volumio volumio[1021]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 10 13:10:36 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 10 13:10:36 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 10 13:10:36 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 10 13:10:36 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 10 13:10:36 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 10 13:10:36 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 10 13:10:36 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 10 13:10:36 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 10 13:10:36 volumio volumio[1021]: info: CoreCommandRouter::volumioGetBrowseSources Jul 10 13:10:36 volumio volumio[1021]: info: CoreCommandRouter::volumioGetBrowseSources Jul 10 13:10:36 volumio volumio[1021]: info: CoreCommandRouter::volumioGetBrowseSources Jul 10 13:10:36 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 10 13:10:36 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 10 13:10:38 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jul 10 13:10:38 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand update Jul 10 13:10:38 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:38 volumio volumio[1021]: info: Jul 10 13:10:38 volumio volumio[1021]: ---------------------------- MPD announces state update: update Jul 10 13:10:38 volumio volumio[1021]: info: sendMpdCommand update took 5 milliseconds Jul 10 13:10:38 volumio volumio[1021]: info: ControllerMpd::getState Jul 10 13:10:38 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:38 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:38 volumio volumio[1021]: info: Jul 10 13:10:38 volumio volumio[1021]: ---------------------------- MPD announces state update: update Jul 10 13:10:38 volumio volumio[1021]: info: ControllerMpd::getState Jul 10 13:10:38 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:38 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:38 volumio volumio[1021]: info: Jul 10 13:10:38 volumio volumio[1021]: ---------------------------- MPD announces state update: update Jul 10 13:10:38 volumio volumio[1021]: info: ControllerMpd::getState Jul 10 13:10:38 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:38 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:38 volumio volumio[1021]: info: Jul 10 13:10:38 volumio volumio[1021]: ---------------------------- MPD announces state update: update Jul 10 13:10:38 volumio volumio[1021]: info: sendMpdCommand status took 13 milliseconds Jul 10 13:10:38 volumio volumio[1021]: info: sendMpdCommand status took 11 milliseconds Jul 10 13:10:38 volumio volumio[1021]: info: sendMpdCommand status took 9 milliseconds Jul 10 13:10:38 volumio volumio[1021]: info: ControllerMpd::getState Jul 10 13:10:38 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:38 volumio volumio[1021]: info: sendMpdCommand status took 8 milliseconds Jul 10 13:10:38 volumio volumio[1021]: info: sendMpdCommand status took 7 milliseconds Jul 10 13:10:38 volumio volumio[1021]: info: sendMpdCommand status took 5 milliseconds Jul 10 13:10:38 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:39 volumio volumio[1021]: info: Command Router : Notfying DB Updatetrue Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:39 volumio volumio[1021]: info: Command Router : Notfying DB Updatetrue Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:39 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:39 volumio volumio[1021]: info: Jul 10 13:10:39 volumio volumio[1021]: ---------------------------- MPD announces state update: update Jul 10 13:10:39 volumio volumio[1021]: info: ControllerMpd::getState Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:39 volumio volumio[1021]: info: Jul 10 13:10:39 volumio volumio[1021]: ---------------------------- MPD announces state update: update Jul 10 13:10:39 volumio volumio[1021]: info: ControllerMpd::getState Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:39 volumio volumio[1021]: info: sendMpdCommand status took 326 milliseconds Jul 10 13:10:39 volumio volumio[1021]: info: sendMpdCommand status took 322 milliseconds Jul 10 13:10:39 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 80 milliseconds Jul 10 13:10:39 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 39 milliseconds Jul 10 13:10:39 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 22 milliseconds Jul 10 13:10:39 volumio volumio[1021]: info: sendMpdCommand status took 5 milliseconds Jul 10 13:10:39 volumio volumio[1021]: info: sendMpdCommand status took 5 milliseconds Jul 10 13:10:39 volumio volumio[1021]: info: sendMpdCommand status took 4 milliseconds Jul 10 13:10:39 volumio volumio[1021]: info: sendMpdCommand status took 3 milliseconds Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:39 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:39 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:39 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 13:10:39 volumio volumio[1021]: info: ControllerMpd::pushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Jul 10 13:10:39 volumio volumio[1021]: verbose: In UPNP mode Jul 10 13:10:39 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":69961,"duration":233,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1205 Kbps","isStreaming":false,"title":"We Cant Stop (Smithee Remix Edit)","artist":"Can't Stop Band","album":"We Can't Stop","uri":"http://sjy6.stream.qqmusic.qq.com/F000002Yhw432UO8dL.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=C1EED3EB3C45B142519DEBC8C8FA3B8DB213F8E2D0F1C584ED6451C02355DE159080D7A7C12E72221D2D06953A3A037A036DA822D43E432F&uin=28794995&src=F000002Yhw432UO8dL.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 13:10:39 volumio volumio[1021]: verbose: CURRENT POSITION 0 Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Jul 10 13:10:39 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:39 volumio volumio[1021]: info: ControllerMpd::pushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Jul 10 13:10:39 volumio volumio[1021]: verbose: In UPNP mode Jul 10 13:10:39 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":69961,"duration":233,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1205 Kbps","isStreaming":false,"title":"We Cant Stop (Smithee Remix Edit)","artist":"Can't Stop Band","album":"We Can't Stop","uri":"http://sjy6.stream.qqmusic.qq.com/F000002Yhw432UO8dL.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=C1EED3EB3C45B142519DEBC8C8FA3B8DB213F8E2D0F1C584ED6451C02355DE159080D7A7C12E72221D2D06953A3A037A036DA822D43E432F&uin=28794995&src=F000002Yhw432UO8dL.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 13:10:39 volumio volumio[1021]: verbose: CURRENT POSITION 0 Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Jul 10 13:10:39 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:39 volumio volumio[1021]: info: ControllerMpd::pushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Jul 10 13:10:39 volumio volumio[1021]: verbose: In UPNP mode Jul 10 13:10:39 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":69961,"duration":233,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1205 Kbps","isStreaming":false,"title":"We Cant Stop (Smithee Remix Edit)","artist":"Can't Stop Band","album":"We Can't Stop","uri":"http://sjy6.stream.qqmusic.qq.com/F000002Yhw432UO8dL.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=C1EED3EB3C45B142519DEBC8C8FA3B8DB213F8E2D0F1C584ED6451C02355DE159080D7A7C12E72221D2D06953A3A037A036DA822D43E432F&uin=28794995&src=F000002Yhw432UO8dL.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 13:10:39 volumio volumio[1021]: verbose: CURRENT POSITION 0 Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Jul 10 13:10:39 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:39 volumio volumio[1021]: info: ------------------------------ 508ms Jul 10 13:10:39 volumio volumio[1021]: info: ------------------------------ 503ms Jul 10 13:10:39 volumio volumio[1021]: info: ------------------------------ 502ms Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 144 milliseconds Jul 10 13:10:39 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 124 milliseconds Jul 10 13:10:39 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 109 milliseconds Jul 10 13:10:39 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Jul 10 13:10:39 volumio volumio[1021]: info: ControllerMpd::pushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Jul 10 13:10:39 volumio volumio[1021]: verbose: In UPNP mode Jul 10 13:10:39 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":70348,"duration":233,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1228 Kbps","isStreaming":false,"title":"We Cant Stop (Smithee Remix Edit)","artist":"Can't Stop Band","album":"We Can't Stop","uri":"http://sjy6.stream.qqmusic.qq.com/F000002Yhw432UO8dL.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=C1EED3EB3C45B142519DEBC8C8FA3B8DB213F8E2D0F1C584ED6451C02355DE159080D7A7C12E72221D2D06953A3A037A036DA822D43E432F&uin=28794995&src=F000002Yhw432UO8dL.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 13:10:39 volumio volumio[1021]: verbose: CURRENT POSITION 0 Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Jul 10 13:10:39 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:39 volumio volumio[1021]: info: ControllerMpd::pushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Jul 10 13:10:39 volumio volumio[1021]: verbose: In UPNP mode Jul 10 13:10:39 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":70348,"duration":233,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1228 Kbps","isStreaming":false,"title":"We Cant Stop (Smithee Remix Edit)","artist":"Can't Stop Band","album":"We Can't Stop","uri":"http://sjy6.stream.qqmusic.qq.com/F000002Yhw432UO8dL.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=C1EED3EB3C45B142519DEBC8C8FA3B8DB213F8E2D0F1C584ED6451C02355DE159080D7A7C12E72221D2D06953A3A037A036DA822D43E432F&uin=28794995&src=F000002Yhw432UO8dL.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 13:10:39 volumio volumio[1021]: verbose: CURRENT POSITION 0 Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Jul 10 13:10:39 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:39 volumio volumio[1021]: info: ControllerMpd::pushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Jul 10 13:10:39 volumio volumio[1021]: verbose: In UPNP mode Jul 10 13:10:39 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":70348,"duration":233,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1228 Kbps","isStreaming":false,"title":"We Cant Stop (Smithee Remix Edit)","artist":"Can't Stop Band","album":"We Can't Stop","uri":"http://sjy6.stream.qqmusic.qq.com/F000002Yhw432UO8dL.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=C1EED3EB3C45B142519DEBC8C8FA3B8DB213F8E2D0F1C584ED6451C02355DE159080D7A7C12E72221D2D06953A3A037A036DA822D43E432F&uin=28794995&src=F000002Yhw432UO8dL.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 13:10:39 volumio volumio[1021]: verbose: CURRENT POSITION 0 Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Jul 10 13:10:39 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:39 volumio volumio[1021]: info: ------------------------------ 581ms Jul 10 13:10:39 volumio volumio[1021]: info: ------------------------------ 260ms Jul 10 13:10:39 volumio volumio[1021]: info: ------------------------------ 258ms Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:39 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:39 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand rescan Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:40 volumio volumio[1021]: info: Jul 10 13:10:40 volumio volumio[1021]: ---------------------------- MPD announces state update: update Jul 10 13:10:40 volumio volumio[1021]: info: sendMpdCommand rescan took 4 milliseconds Jul 10 13:10:40 volumio volumio[1021]: info: ControllerMpd::getState Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:40 volumio volumio[1021]: info: Jul 10 13:10:40 volumio volumio[1021]: ---------------------------- MPD announces state update: update Jul 10 13:10:40 volumio volumio[1021]: info: ControllerMpd::getState Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:40 volumio volumio[1021]: info: Jul 10 13:10:40 volumio volumio[1021]: ---------------------------- MPD announces state update: update Jul 10 13:10:40 volumio volumio[1021]: info: ControllerMpd::getState Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:40 volumio volumio[1021]: info: Jul 10 13:10:40 volumio volumio[1021]: ---------------------------- MPD announces state update: update Jul 10 13:10:40 volumio volumio[1021]: info: ControllerMpd::getState Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:40 volumio volumio[1021]: info: sendMpdCommand status took 11 milliseconds Jul 10 13:10:40 volumio volumio[1021]: info: sendMpdCommand status took 8 milliseconds Jul 10 13:10:40 volumio volumio[1021]: info: sendMpdCommand status took 7 milliseconds Jul 10 13:10:40 volumio volumio[1021]: info: sendMpdCommand status took 6 milliseconds Jul 10 13:10:40 volumio volumio[1021]: info: sendMpdCommand status took 6 milliseconds Jul 10 13:10:40 volumio volumio[1021]: info: sendMpdCommand status took 4 milliseconds Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:40 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:40 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:40 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:40 volumio volumio[1021]: info: Jul 10 13:10:40 volumio volumio[1021]: ---------------------------- MPD announces state update: update Jul 10 13:10:40 volumio volumio[1021]: info: ControllerMpd::getState Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:40 volumio volumio[1021]: info: Jul 10 13:10:40 volumio volumio[1021]: ---------------------------- MPD announces state update: update Jul 10 13:10:40 volumio volumio[1021]: info: ControllerMpd::getState Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Jul 10 13:10:40 volumio volumio[1021]: info: sendMpdCommand status took 157 milliseconds Jul 10 13:10:40 volumio volumio[1021]: info: sendMpdCommand status took 157 milliseconds Jul 10 13:10:40 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 73 milliseconds Jul 10 13:10:40 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 51 milliseconds Jul 10 13:10:40 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 26 milliseconds Jul 10 13:10:40 volumio volumio[1021]: info: sendMpdCommand status took 6 milliseconds Jul 10 13:10:40 volumio volumio[1021]: info: sendMpdCommand status took 5 milliseconds Jul 10 13:10:40 volumio volumio[1021]: info: sendMpdCommand status took 5 milliseconds Jul 10 13:10:40 volumio volumio[1021]: info: sendMpdCommand status took 4 milliseconds Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:40 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:40 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:40 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::parseState Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 10 13:10:40 volumio volumio[1021]: info: ControllerMpd::pushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Jul 10 13:10:40 volumio volumio[1021]: verbose: In UPNP mode Jul 10 13:10:40 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":71600,"duration":233,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1220 Kbps","isStreaming":false,"title":"We Cant Stop (Smithee Remix Edit)","artist":"Can't Stop Band","album":"We Can't Stop","uri":"http://sjy6.stream.qqmusic.qq.com/F000002Yhw432UO8dL.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=C1EED3EB3C45B142519DEBC8C8FA3B8DB213F8E2D0F1C584ED6451C02355DE159080D7A7C12E72221D2D06953A3A037A036DA822D43E432F&uin=28794995&src=F000002Yhw432UO8dL.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 13:10:40 volumio volumio[1021]: verbose: CURRENT POSITION 0 Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Jul 10 13:10:40 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:40 volumio volumio[1021]: info: ControllerMpd::pushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Jul 10 13:10:40 volumio volumio[1021]: verbose: In UPNP mode Jul 10 13:10:40 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":71600,"duration":233,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1220 Kbps","isStreaming":false,"title":"We Cant Stop (Smithee Remix Edit)","artist":"Can't Stop Band","album":"We Can't Stop","uri":"http://sjy6.stream.qqmusic.qq.com/F000002Yhw432UO8dL.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=C1EED3EB3C45B142519DEBC8C8FA3B8DB213F8E2D0F1C584ED6451C02355DE159080D7A7C12E72221D2D06953A3A037A036DA822D43E432F&uin=28794995&src=F000002Yhw432UO8dL.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 13:10:40 volumio volumio[1021]: verbose: CURRENT POSITION 0 Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Jul 10 13:10:40 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:40 volumio volumio[1021]: info: ControllerMpd::pushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Jul 10 13:10:40 volumio volumio[1021]: verbose: In UPNP mode Jul 10 13:10:40 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":71600,"duration":233,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1220 Kbps","isStreaming":false,"title":"We Cant Stop (Smithee Remix Edit)","artist":"Can't Stop Band","album":"We Can't Stop","uri":"http://sjy6.stream.qqmusic.qq.com/F000002Yhw432UO8dL.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=C1EED3EB3C45B142519DEBC8C8FA3B8DB213F8E2D0F1C584ED6451C02355DE159080D7A7C12E72221D2D06953A3A037A036DA822D43E432F&uin=28794995&src=F000002Yhw432UO8dL.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 13:10:40 volumio volumio[1021]: verbose: CURRENT POSITION 0 Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Jul 10 13:10:40 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:40 volumio volumio[1021]: info: ------------------------------ 329ms Jul 10 13:10:40 volumio volumio[1021]: info: ------------------------------ 325ms Jul 10 13:10:40 volumio volumio[1021]: info: ------------------------------ 323ms Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 140 milliseconds Jul 10 13:10:40 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 119 milliseconds Jul 10 13:10:40 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 97 milliseconds Jul 10 13:10:40 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Jul 10 13:10:40 volumio volumio[1021]: info: ControllerMpd::pushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Jul 10 13:10:40 volumio volumio[1021]: verbose: In UPNP mode Jul 10 13:10:40 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":71600,"duration":233,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1220 Kbps","isStreaming":false,"title":"We Cant Stop (Smithee Remix Edit)","artist":"Can't Stop Band","album":"We Can't Stop","uri":"http://sjy6.stream.qqmusic.qq.com/F000002Yhw432UO8dL.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=C1EED3EB3C45B142519DEBC8C8FA3B8DB213F8E2D0F1C584ED6451C02355DE159080D7A7C12E72221D2D06953A3A037A036DA822D43E432F&uin=28794995&src=F000002Yhw432UO8dL.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 13:10:40 volumio volumio[1021]: verbose: CURRENT POSITION 0 Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Jul 10 13:10:40 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:40 volumio volumio[1021]: info: ControllerMpd::pushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Jul 10 13:10:40 volumio volumio[1021]: verbose: In UPNP mode Jul 10 13:10:40 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":71714,"duration":233,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1172 Kbps","isStreaming":false,"title":"We Cant Stop (Smithee Remix Edit)","artist":"Can't Stop Band","album":"We Can't Stop","uri":"http://sjy6.stream.qqmusic.qq.com/F000002Yhw432UO8dL.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=C1EED3EB3C45B142519DEBC8C8FA3B8DB213F8E2D0F1C584ED6451C02355DE159080D7A7C12E72221D2D06953A3A037A036DA822D43E432F&uin=28794995&src=F000002Yhw432UO8dL.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 13:10:40 volumio volumio[1021]: verbose: CURRENT POSITION 0 Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Jul 10 13:10:40 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:40 volumio volumio[1021]: info: ControllerMpd::pushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Jul 10 13:10:40 volumio volumio[1021]: verbose: In UPNP mode Jul 10 13:10:40 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":71714,"duration":233,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1172 Kbps","isStreaming":false,"title":"We Cant Stop (Smithee Remix Edit)","artist":"Can't Stop Band","album":"We Can't Stop","uri":"http://sjy6.stream.qqmusic.qq.com/F000002Yhw432UO8dL.flac?guid=ffffffff9f826ecf0000018c3ff7e787&vkey=C1EED3EB3C45B142519DEBC8C8FA3B8DB213F8E2D0F1C584ED6451C02355DE159080D7A7C12E72221D2D06953A3A037A036DA822D43E432F&uin=28794995&src=F000002Yhw432UO8dL.flac&redirect=1&fromtag=111114","trackType":""} Jul 10 13:10:40 volumio volumio[1021]: verbose: CURRENT POSITION 0 Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Jul 10 13:10:40 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::pushState Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Jul 10 13:10:40 volumio volumio[1021]: info: ------------------------------ 390ms Jul 10 13:10:40 volumio volumio[1021]: info: ------------------------------ 238ms Jul 10 13:10:40 volumio volumio[1021]: info: ------------------------------ 238ms Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreStateMachine::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CorePlayQueue::getQueue Jul 10 13:10:40 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 10 13:10:44 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 10 13:10:47 volumio volumio[1021]: info: Enabling MyMusic plugin bluetooth Jul 10 13:10:47 volumio volumio[1021]: info: [MyVolumio PluginManager] Enabling and starting plugin audio_interface bluetooth Jul 10 13:10:47 volumio volumio[1021]: info: [MyVolumio PluginManager] Plugin audio_interface bluetooth not in user plan, not enabling Jul 10 13:10:47 volumio volumio[1021]: info: Error: Plugin audio_interface bluetooth not in user plan, not enabling Jul 10 13:10:47 volumio volumio[1021]: error: Could not Enable MyMusic Plugin: Error Jul 10 13:10:48 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 10 13:10:59 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 10 13:10:59 volumio volumio[1021]: info: CURURI: music-library Jul 10 13:10:59 volumio volumio[1021]: info: Preload queue cleared Jul 10 13:11:00 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 10 13:11:00 volumio volumio[1021]: info: CURURI: music-library/USB Jul 10 13:11:00 volumio volumio[1021]: error: Failed LSINFO: null Jul 10 13:11:00 volumio volumio[1021]: info: Preload queue cleared Jul 10 13:11:03 volumio volumio[1021]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 10 13:11:03 volumio volumio[1021]: info: Retrying Login Due to Network Error Jul 10 13:11:04 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 10 13:11:04 volumio volumio[1021]: info: CURURI: music-library Jul 10 13:11:04 volumio volumio[1021]: info: Preload queue cleared Jul 10 13:11:06 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 10 13:11:06 volumio volumio[1021]: info: CURURI: music-library/INTERNAL Jul 10 13:11:06 volumio volumio[1021]: error: Failed LSINFO: null Jul 10 13:11:06 volumio volumio[1021]: info: Preload queue cleared Jul 10 13:11:13 volumio volumio[1021]: info: MyVolumio login type: Token Jul 10 13:11:15 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 10 13:11:15 volumio volumio[1021]: info: CURURI: genres:// Jul 10 13:11:15 volumio volumio[1021]: info: Preload queue cleared Jul 10 13:11:18 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 10 13:11:18 volumio volumio[1021]: info: CURURI: music-library Jul 10 13:11:18 volumio volumio[1021]: info: Preload queue cleared Jul 10 13:11:20 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 10 13:11:20 volumio volumio[1021]: info: CURURI: music-library/NAS Jul 10 13:11:20 volumio volumio[1021]: error: Failed LSINFO: null Jul 10 13:11:20 volumio volumio[1021]: info: Preload queue cleared Jul 10 13:11:22 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 10 13:11:22 volumio volumio[1021]: info: CURURI: music-library/USB Jul 10 13:11:22 volumio volumio[1021]: error: Failed LSINFO: null Jul 10 13:11:22 volumio volumio[1021]: info: Preload queue cleared Jul 10 13:11:34 volumio volumio[1021]: info: Preload queue cleared Jul 10 13:11:41 volumio volumio[1021]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 10 13:11:41 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 10 13:11:41 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 10 13:11:41 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 10 13:11:41 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 10 13:11:41 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 10 13:11:41 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 10 13:11:41 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 10 13:11:41 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 10 13:11:41 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 10 13:11:41 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 10 13:11:41 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 10 13:11:41 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 10 13:11:43 volumio volumio[1021]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 10 13:11:43 volumio volumio[1021]: info: Retrying Login Due to Network Error Jul 10 13:11:53 volumio volumio[1021]: info: MyVolumio login type: Token Jul 10 13:11:56 volumio volumio[1021]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Jul 10 13:11:56 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Jul 10 13:11:56 volumio sudo[2280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 10 13:11:56 volumio sudo[2280]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 13:11:56 volumio sudo[2280]: pam_unix(sudo:session): session closed for user root Jul 10 13:11:56 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 13:11:56 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 13:11:56 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 13:11:56 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 13:11:56 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 13:11:56 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 13:11:56 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 13:11:56 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 13:11:56 volumio sudo[2282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 10 13:11:56 volumio sudo[2282]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 13:11:56 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 10 13:11:56 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 10 13:11:56 volumio systemd[1]: Stopping Music Player Daemon... Jul 10 13:11:56 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 13:11:56 volumio volumio[1021]: info: MPD Permissions set Jul 10 13:11:56 volumio volumio[1021]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 10 13:11:56 volumio volumio[1021]: Error: connect ETIMEDOUT 128.121.146.109:443 Jul 10 13:11:56 volumio volumio[1021]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jul 10 13:11:56 volumio volumio[1021]: errno: -110, Jul 10 13:11:56 volumio volumio[1021]: code: 'ETIMEDOUT', Jul 10 13:11:56 volumio volumio[1021]: syscall: 'connect', Jul 10 13:11:56 volumio volumio[1021]: address: '128.121.146.109', Jul 10 13:11:56 volumio volumio[1021]: port: 443 Jul 10 13:11:56 volumio volumio[1021]: } Jul 10 13:11:56 volumio volumio[1021]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 10 13:11:56 volumio systemd[1]: mpd.service: Succeeded. Jul 10 13:11:56 volumio systemd[1]: Stopped Music Player Daemon. Jul 10 13:11:56 volumio systemd[1]: Starting Music Player Daemon... Jul 10 13:11:56 volumio sudo[2293]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 10 13:11:56 volumio sudo[2293]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 13:11:56 volumio sudo[2293]: pam_unix(sudo:session): session closed for user root Jul 10 13:11:56 volumio sudo[2303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-10 13:10 Jul 10 13:11:56 volumio sudo[2303]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 09:13:11 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ac782621640fcc70c07e91a81b6d958b"