-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Fri 2025-05-09 19:02:36 CST. -- May 09 19:01:04 volumio wpa_supplicant[873]: wlan0: Failed to initiate sched scan May 09 19:01:11 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin May 09 19:01:11 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin May 09 19:01:11 volumio volumio[994]: info: Retrieving Cloud Streaming UI May 09 19:01:11 volumio volumio[994]: info: Getting Tidal Cloud Configuration May 09 19:01:11 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin May 09 19:01:11 volumio volumio[994]: info: Getting Qobuz Cloud Configuration May 09 19:01:11 volumio volumio[994]: info: Asking plugin for UI Config May 09 19:01:11 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin May 09 19:01:11 volumio volumio[994]: info: Getting Spotify Cloud Configuration May 09 19:01:11 volumio volumio[994]: info: Asking plugin for UI Config May 09 19:01:11 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin May 09 19:01:11 volumio volumio[994]: info: Saving Spotify Acccount May 09 19:01:11 volumio volumio[994]: info: Got Tidal Cloud Configuration May 09 19:01:11 volumio volumio[994]: info: Got it May 09 19:01:11 volumio volumio[994]: info: Got it May 09 19:01:11 volumio volumio[994]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 09 19:01:11 volumio volumio[994]: info: CoreCommandRouter::getUIConfigOnPlugin May 09 19:01:11 volumio volumio[994]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 09 19:01:11 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 09 19:01:11 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 09 19:01:11 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 09 19:01:11 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 09 19:01:11 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 09 19:01:11 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 09 19:01:11 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 09 19:01:11 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 09 19:01:11 volumio volumio[994]: info: CoreCommandRouter::volumioGetBrowseSources May 09 19:01:11 volumio volumio[994]: info: CoreCommandRouter::volumioGetBrowseSources May 09 19:01:11 volumio volumio[994]: info: CoreCommandRouter::volumioGetBrowseSources May 09 19:01:11 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 09 19:01:11 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 09 19:01:13 volumio wpa_supplicant[873]: wlan0: Failed to initiate sched scan May 09 19:01:13 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 09 19:01:13 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand update May 09 19:01:13 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:13 volumio volumio[994]: info: May 09 19:01:13 volumio volumio[994]: ---------------------------- MPD announces state update: update May 09 19:01:13 volumio volumio[994]: info: sendMpdCommand update took 3 milliseconds May 09 19:01:13 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:13 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:13 volumio volumio[994]: info: sendMpdCommand status took 2 milliseconds May 09 19:01:13 volumio volumio[994]: info: sendMpdCommand status took 0 milliseconds May 09 19:01:13 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:13 volumio volumio[994]: info: Command Router : Notfying DB Updatetrue May 09 19:01:13 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:13 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:13 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:13 volumio volumio[994]: info: May 09 19:01:13 volumio volumio[994]: ---------------------------- MPD announces state update: update May 09 19:01:13 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:13 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:13 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:13 volumio volumio[994]: info: May 09 19:01:13 volumio volumio[994]: ---------------------------- MPD announces state update: update May 09 19:01:13 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:13 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:13 volumio volumio[994]: info: sendMpdCommand playlistinfo took 5 milliseconds May 09 19:01:13 volumio volumio[994]: info: sendMpdCommand status took 4 milliseconds May 09 19:01:13 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds May 09 19:01:13 volumio volumio[994]: info: sendMpdCommand status took 2 milliseconds May 09 19:01:13 volumio volumio[994]: info: sendMpdCommand status took 1 milliseconds May 09 19:01:13 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:13 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:13 volumio volumio[994]: info: Command Router : Notfying DB Updatetrue May 09 19:01:13 volumio volumio[994]: info: CoreCommandRouter::Close All Modals sent May 09 19:01:13 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:13 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:13 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:13 volumio volumio[994]: info: Command Router : Notfying DB Updatetrue May 09 19:01:13 volumio volumio[994]: info: CoreCommandRouter::Close All Modals sent May 09 19:01:13 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:13 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:13 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:13 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:13 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:13 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":147986,"duration":235,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"734 Kbps","isStreaming":false,"title":"人生何处不相逢","artist":"阿梨粤","album":"人生何处不相逢","uri":"http://aqqmusic.tc.qq.com/F000002sAsgw0wBx4W.flac?guid=000000004ee6317100000194f337c7bf&vkey=44FC6DA9183FFCC549309AB6BEF45624E4673E3A5B7D437BC1D7A34D320A9EA826BF9EF64CE09C1400040BC88D50F133E9886B172629AA33__v21e2a171d&uin=88340707&src=F000002Qvpji4PgXDu.flac&redirect=1&fromtag=111114","trackType":""} May 09 19:01:13 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:13 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:13 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:13 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:13 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:13 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:13 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 19:01:13 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:13 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:13 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:13 volumio volumio[994]: info: ------------------------------ 102ms May 09 19:01:13 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:14 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:14 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:14 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:14 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:14 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:14 volumio volumio[994]: info: sendMpdCommand playlistinfo took 40 milliseconds May 09 19:01:14 volumio volumio[994]: info: sendMpdCommand playlistinfo took 23 milliseconds May 09 19:01:14 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:14 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:14 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:14 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:14 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:14 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":148101,"duration":235,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"793 Kbps","isStreaming":false,"title":"人生何处不相逢","artist":"阿梨粤","album":"人生何处不相逢","uri":"http://aqqmusic.tc.qq.com/F000002sAsgw0wBx4W.flac?guid=000000004ee6317100000194f337c7bf&vkey=44FC6DA9183FFCC549309AB6BEF45624E4673E3A5B7D437BC1D7A34D320A9EA826BF9EF64CE09C1400040BC88D50F133E9886B172629AA33__v21e2a171d&uin=88340707&src=F000002Qvpji4PgXDu.flac&redirect=1&fromtag=111114","trackType":""} May 09 19:01:14 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:14 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:14 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:14 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:14 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:14 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:14 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 19:01:14 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:14 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:14 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:14 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:14 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:14 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:14 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":148101,"duration":235,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"793 Kbps","isStreaming":false,"title":"人生何处不相逢","artist":"阿梨粤","album":"人生何处不相逢","uri":"http://aqqmusic.tc.qq.com/F000002sAsgw0wBx4W.flac?guid=000000004ee6317100000194f337c7bf&vkey=44FC6DA9183FFCC549309AB6BEF45624E4673E3A5B7D437BC1D7A34D320A9EA826BF9EF64CE09C1400040BC88D50F133E9886B172629AA33__v21e2a171d&uin=88340707&src=F000002Qvpji4PgXDu.flac&redirect=1&fromtag=111114","trackType":""} May 09 19:01:14 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:14 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:14 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:14 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:14 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:14 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:14 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:14 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:14 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:14 volumio volumio[994]: info: ------------------------------ 85ms May 09 19:01:14 volumio volumio[994]: info: ------------------------------ 83ms May 09 19:01:14 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:14 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:14 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:14 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:14 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:14 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:14 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:14 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:14 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:14 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:14 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:14 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:15 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 09 19:01:21 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:21 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:21 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:21 volumio wpa_supplicant[873]: wlan0: Failed to initiate sched scan May 09 19:01:24 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 09 19:01:24 volumio volumio[994]: info: CURURI: music-library May 09 19:01:24 volumio volumio[994]: info: Preload queue cleared May 09 19:01:24 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 09 19:01:24 volumio volumio[994]: info: CURURI: music-library/NAS May 09 19:01:24 volumio volumio[994]: info: Preload queue cleared May 09 19:01:25 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 09 19:01:25 volumio volumio[994]: info: CURURI: music-library/NAS/网盘 May 09 19:01:25 volumio volumio[994]: error: Failed LSINFO: null May 09 19:01:25 volumio volumio[994]: info: Preload queue cleared May 09 19:01:29 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 09 19:01:29 volumio volumio[994]: info: CURURI: music-library/USB May 09 19:01:29 volumio volumio[994]: info: Preload queue cleared May 09 19:01:29 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 09 19:01:29 volumio volumio[994]: info: CURURI: music-library/USB/新加卷 May 09 19:01:30 volumio volumio[994]: info: Preload queue cleared May 09 19:01:30 volumio wpa_supplicant[873]: wlan0: Failed to initiate sched scan May 09 19:01:38 volumio volumio[994]: info: May 09 19:01:38 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:38 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:38 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:38 volumio volumio[994]: info: May 09 19:01:38 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:38 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:38 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:38 volumio volumio[994]: info: May 09 19:01:38 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:38 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:38 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:38 volumio volumio[994]: info: sendMpdCommand status took 4 milliseconds May 09 19:01:38 volumio volumio[994]: info: sendMpdCommand status took 5 milliseconds May 09 19:01:38 volumio volumio[994]: info: sendMpdCommand status took 4 milliseconds May 09 19:01:38 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:38 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:38 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:38 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:38 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:38 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:38 volumio volumio[994]: info: sendMpdCommand playlistinfo took 4 milliseconds May 09 19:01:38 volumio volumio[994]: info: sendMpdCommand playlistinfo took 3 milliseconds May 09 19:01:38 volumio volumio[994]: info: sendMpdCommand playlistinfo took 4 milliseconds May 09 19:01:38 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:38 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:38 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:38 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:38 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:38 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:38 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:38 volumio volumio[994]: info: CorePlayQueue::getTrack 0 May 09 19:01:38 volumio volumio[994]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"人生何处不相逢","artist":"阿梨粤","album":"人生何处不相逢","uri":"http://aqqmusic.tc.qq.com/F000002sAsgw0wBx4W.flac?guid=000000004ee6317100000194f337c7bf&vkey=44FC6DA9183FFCC549309AB6BEF45624E4673E3A5B7D437BC1D7A34D320A9EA826BF9EF64CE09C1400040BC88D50F133E9886B172629AA33__v21e2a171d&uin=88340707&src=F000002Qvpji4PgXDu.flac&redirect=1&fromtag=111114","trackType":""} May 09 19:01:38 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:38 volumio volumio[994]: info: CoreStateMachine::syncState stateService stop May 09 19:01:38 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:38 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:38 volumio volumio[994]: info: CoreStateMachine::stPlaybackTimer May 09 19:01:38 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:38 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:38 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:38 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 19:01:38 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:38 volumio volumio[994]: info: CorePlayQueue::getTrack 0 May 09 19:01:38 volumio volumio[994]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"人生何处不相逢","artist":"阿梨粤","album":"人生何处不相逢","uri":"http://aqqmusic.tc.qq.com/F000002sAsgw0wBx4W.flac?guid=000000004ee6317100000194f337c7bf&vkey=44FC6DA9183FFCC549309AB6BEF45624E4673E3A5B7D437BC1D7A34D320A9EA826BF9EF64CE09C1400040BC88D50F133E9886B172629AA33__v21e2a171d&uin=88340707&src=F000002Qvpji4PgXDu.flac&redirect=1&fromtag=111114","trackType":""} May 09 19:01:38 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:38 volumio volumio[994]: info: CoreStateMachine::syncState stateService stop May 09 19:01:38 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop May 09 19:01:38 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:38 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:38 volumio volumio[994]: info: No code May 09 19:01:38 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:38 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:38 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:38 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:38 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:38 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:38 volumio volumio[994]: info: CorePlayQueue::getTrack 0 May 09 19:01:38 volumio volumio[994]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"人生何处不相逢","artist":"阿梨粤","album":"人生何处不相逢","uri":"http://aqqmusic.tc.qq.com/F000002sAsgw0wBx4W.flac?guid=000000004ee6317100000194f337c7bf&vkey=44FC6DA9183FFCC549309AB6BEF45624E4673E3A5B7D437BC1D7A34D320A9EA826BF9EF64CE09C1400040BC88D50F133E9886B172629AA33__v21e2a171d&uin=88340707&src=F000002Qvpji4PgXDu.flac&redirect=1&fromtag=111114","trackType":""} May 09 19:01:38 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:38 volumio volumio[994]: info: CoreStateMachine::syncState stateService stop May 09 19:01:38 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop May 09 19:01:38 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:38 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:38 volumio volumio[994]: info: No code May 09 19:01:38 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:38 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:38 volumio volumio[994]: info: ------------------------------ 47ms May 09 19:01:38 volumio volumio[994]: info: ------------------------------ 47ms May 09 19:01:38 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:38 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:38 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:38 volumio wpa_supplicant[873]: wlan0: Failed to initiate sched scan May 09 19:01:38 volumio volumio[994]: info: Clearing queue after UPNP request May 09 19:01:38 volumio volumio[994]: info: CoreStateMachine::ClearQueue May 09 19:01:38 volumio volumio[994]: info: CoreStateMachine::stop May 09 19:01:38 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 19:01:38 volumio volumio[994]: info: CorePlayQueue::clearPlayQueue May 09 19:01:38 volumio volumio[994]: info: CorePlayQueue::saveQueue May 09 19:01:38 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:38 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue May 09 19:01:38 volumio volumio[994]: info: May 09 19:01:38 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:38 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:38 volumio volumio[994]: info: May 09 19:01:38 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:38 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:38 volumio volumio[994]: info: May 09 19:01:38 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:38 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:38 volumio volumio[994]: error: updateQueue error: null May 09 19:01:38 volumio volumio[994]: error: updateQueue error: null May 09 19:01:38 volumio volumio[994]: error: updateQueue error: null May 09 19:01:38 volumio volumio[994]: info: ------------------------------ 3ms May 09 19:01:38 volumio volumio[994]: info: ------------------------------ 4ms May 09 19:01:38 volumio volumio[994]: info: ------------------------------ 3ms May 09 19:01:38 volumio volumio[994]: info: Starting UPNP Playback May 09 19:01:38 volumio volumio[994]: info: Preparing playback through UPNP May 09 19:01:38 volumio volumio[994]: info: CoreCommandRouter::volumioGetState May 09 19:01:38 volumio volumio[994]: info: CorePlayQueue::getTrack 0 May 09 19:01:38 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService mpd May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 3ms May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 3ms May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 3ms May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 1ms May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 3ms May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 1ms May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:39 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:39 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:39 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:39 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:39 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds May 09 19:01:39 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds May 09 19:01:39 volumio volumio[994]: info: sendMpdCommand status took 2 milliseconds May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:39 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:39 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:39 volumio volumio[994]: info: sendMpdCommand status took 7 milliseconds May 09 19:01:39 volumio volumio[994]: info: sendMpdCommand playlistinfo took 6 milliseconds May 09 19:01:39 volumio volumio[994]: info: sendMpdCommand playlistinfo took 6 milliseconds May 09 19:01:39 volumio volumio[994]: info: sendMpdCommand playlistinfo took 6 milliseconds May 09 19:01:39 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:39 volumio volumio[994]: info: sendMpdCommand status took 5 milliseconds May 09 19:01:39 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:39 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:39 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:39 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":287,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"天边","artist":"布仁巴雅尔","album":"天边 (布仁巴雅尔特别纪念版 1960-2018)","uri":"http://aqqmusic.tc.qq.com/M500000znYLM0dNvEA.mp3?guid=000000004ee6317100000194f337c7bf&vkey=898D0438713E23615D6242EAF941AECEEF9DC0FB4F7C38449B3B298DB63E51EDA617437A884DCE432689EED19AF2F69CB48AD08FB9E24BB6__v21e2a1874&uin=88340707&redirect=1&fromtag=111042","trackType":""} May 09 19:01:39 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop May 09 19:01:39 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:39 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:39 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":287,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"天边","artist":"布仁巴雅尔","album":"天边 (布仁巴雅尔特别纪念版 1960-2018)","uri":"http://aqqmusic.tc.qq.com/M500000znYLM0dNvEA.mp3?guid=000000004ee6317100000194f337c7bf&vkey=898D0438713E23615D6242EAF941AECEEF9DC0FB4F7C38449B3B298DB63E51EDA617437A884DCE432689EED19AF2F69CB48AD08FB9E24BB6__v21e2a1874&uin=88340707&redirect=1&fromtag=111042","trackType":""} May 09 19:01:39 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:39 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:39 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:39 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:39 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":287,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"天边","artist":"布仁巴雅尔","album":"天边 (布仁巴雅尔特别纪念版 1960-2018)","uri":"http://aqqmusic.tc.qq.com/M500000znYLM0dNvEA.mp3?guid=000000004ee6317100000194f337c7bf&vkey=898D0438713E23615D6242EAF941AECEEF9DC0FB4F7C38449B3B298DB63E51EDA617437A884DCE432689EED19AF2F69CB48AD08FB9E24BB6__v21e2a1874&uin=88340707&redirect=1&fromtag=111042","trackType":""} May 09 19:01:39 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:39 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 27ms May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 35ms May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 35ms May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:39 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:39 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:39 volumio volumio[994]: info: May 09 19:01:39 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:39 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 31ms May 09 19:01:39 volumio volumio[994]: info: sendMpdCommand status took 29 milliseconds May 09 19:01:39 volumio volumio[994]: info: sendMpdCommand playlistinfo took 30 milliseconds May 09 19:01:39 volumio volumio[994]: info: sendMpdCommand playlistinfo took 28 milliseconds May 09 19:01:39 volumio volumio[994]: info: sendMpdCommand playlistinfo took 28 milliseconds May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 6ms May 09 19:01:39 volumio volumio[994]: info: sendMpdCommand status took 5 milliseconds May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 5ms May 09 19:01:39 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:39 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:39 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:39 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":287,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"天边","artist":"布仁巴雅尔","album":"天边 (布仁巴雅尔特别纪念版 1960-2018)","uri":"http://aqqmusic.tc.qq.com/M500000znYLM0dNvEA.mp3?guid=000000004ee6317100000194f337c7bf&vkey=898D0438713E23615D6242EAF941AECEEF9DC0FB4F7C38449B3B298DB63E51EDA617437A884DCE432689EED19AF2F69CB48AD08FB9E24BB6__v21e2a1874&uin=88340707&redirect=1&fromtag=111042","trackType":""} May 09 19:01:39 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:39 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:39 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:39 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:39 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":287,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"天边","artist":"布仁巴雅尔","album":"天边 (布仁巴雅尔特别纪念版 1960-2018)","uri":"http://aqqmusic.tc.qq.com/M500000znYLM0dNvEA.mp3?guid=000000004ee6317100000194f337c7bf&vkey=898D0438713E23615D6242EAF941AECEEF9DC0FB4F7C38449B3B298DB63E51EDA617437A884DCE432689EED19AF2F69CB48AD08FB9E24BB6__v21e2a1874&uin=88340707&redirect=1&fromtag=111042","trackType":""} May 09 19:01:39 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:39 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:39 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:39 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:39 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":287,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"天边","artist":"布仁巴雅尔","album":"天边 (布仁巴雅尔特别纪念版 1960-2018)","uri":"http://aqqmusic.tc.qq.com/M500000znYLM0dNvEA.mp3?guid=000000004ee6317100000194f337c7bf&vkey=898D0438713E23615D6242EAF941AECEEF9DC0FB4F7C38449B3B298DB63E51EDA617437A884DCE432689EED19AF2F69CB48AD08FB9E24BB6__v21e2a1874&uin=88340707&redirect=1&fromtag=111042","trackType":""} May 09 19:01:39 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:39 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 70ms May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 67ms May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 66ms May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:39 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:39 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:39 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:39 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:39 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:39 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:39 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:39 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:39 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:39 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:39 volumio volumio[994]: info: sendMpdCommand playlistinfo took 44 milliseconds May 09 19:01:39 volumio volumio[994]: info: sendMpdCommand playlistinfo took 44 milliseconds May 09 19:01:39 volumio volumio[994]: info: sendMpdCommand playlistinfo took 44 milliseconds May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:39 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:39 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:39 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:39 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":287,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"天边","artist":"布仁巴雅尔","album":"天边 (布仁巴雅尔特别纪念版 1960-2018)","uri":"http://aqqmusic.tc.qq.com/M500000znYLM0dNvEA.mp3?guid=000000004ee6317100000194f337c7bf&vkey=898D0438713E23615D6242EAF941AECEEF9DC0FB4F7C38449B3B298DB63E51EDA617437A884DCE432689EED19AF2F69CB48AD08FB9E24BB6__v21e2a1874&uin=88340707&redirect=1&fromtag=111042","trackType":""} May 09 19:01:39 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:39 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:39 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:39 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:39 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":287,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"天边","artist":"布仁巴雅尔","album":"天边 (布仁巴雅尔特别纪念版 1960-2018)","uri":"http://aqqmusic.tc.qq.com/M500000znYLM0dNvEA.mp3?guid=000000004ee6317100000194f337c7bf&vkey=898D0438713E23615D6242EAF941AECEEF9DC0FB4F7C38449B3B298DB63E51EDA617437A884DCE432689EED19AF2F69CB48AD08FB9E24BB6__v21e2a1874&uin=88340707&redirect=1&fromtag=111042","trackType":""} May 09 19:01:39 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:39 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:39 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:39 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:39 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":287,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"天边","artist":"布仁巴雅尔","album":"天边 (布仁巴雅尔特别纪念版 1960-2018)","uri":"http://aqqmusic.tc.qq.com/M500000znYLM0dNvEA.mp3?guid=000000004ee6317100000194f337c7bf&vkey=898D0438713E23615D6242EAF941AECEEF9DC0FB4F7C38449B3B298DB63E51EDA617437A884DCE432689EED19AF2F69CB48AD08FB9E24BB6__v21e2a1874&uin=88340707&redirect=1&fromtag=111042","trackType":""} May 09 19:01:39 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:39 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 105ms May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 79ms May 09 19:01:39 volumio volumio[994]: info: ------------------------------ 77ms May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:39 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:39 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:39 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:39 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:39 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:39 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:39 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:39 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:43 volumio volumio[994]: info: May 09 19:01:43 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:43 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:43 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:43 volumio volumio[994]: info: May 09 19:01:43 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:43 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:43 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:43 volumio volumio[994]: info: May 09 19:01:43 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:43 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:43 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:43 volumio volumio[994]: info: sendMpdCommand status took 4 milliseconds May 09 19:01:43 volumio volumio[994]: info: sendMpdCommand status took 5 milliseconds May 09 19:01:43 volumio volumio[994]: info: sendMpdCommand status took 4 milliseconds May 09 19:01:43 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:43 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:43 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:43 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:43 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:43 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:43 volumio volumio[994]: info: sendMpdCommand playlistinfo took 3 milliseconds May 09 19:01:43 volumio volumio[994]: info: sendMpdCommand playlistinfo took 2 milliseconds May 09 19:01:43 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:43 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:43 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:43 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:43 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":70000,"duration":287,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"天边","artist":"布仁巴雅尔","album":"天边 (布仁巴雅尔特别纪念版 1960-2018)","uri":"http://aqqmusic.tc.qq.com/M500000znYLM0dNvEA.mp3?guid=000000004ee6317100000194f337c7bf&vkey=898D0438713E23615D6242EAF941AECEEF9DC0FB4F7C38449B3B298DB63E51EDA617437A884DCE432689EED19AF2F69CB48AD08FB9E24BB6__v21e2a1874&uin=88340707&redirect=1&fromtag=111042","trackType":""} May 09 19:01:43 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:43 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:43 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:43 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:43 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:43 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:43 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:43 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:43 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:43 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:43 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:43 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:43 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":70000,"duration":287,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"天边","artist":"布仁巴雅尔","album":"天边 (布仁巴雅尔特别纪念版 1960-2018)","uri":"http://aqqmusic.tc.qq.com/M500000znYLM0dNvEA.mp3?guid=000000004ee6317100000194f337c7bf&vkey=898D0438713E23615D6242EAF941AECEEF9DC0FB4F7C38449B3B298DB63E51EDA617437A884DCE432689EED19AF2F69CB48AD08FB9E24BB6__v21e2a1874&uin=88340707&redirect=1&fromtag=111042","trackType":""} May 09 19:01:43 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:43 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:43 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:43 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:43 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:43 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:43 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:43 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:43 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:43 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:43 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:43 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:43 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":70000,"duration":287,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"天边","artist":"布仁巴雅尔","album":"天边 (布仁巴雅尔特别纪念版 1960-2018)","uri":"http://aqqmusic.tc.qq.com/M500000znYLM0dNvEA.mp3?guid=000000004ee6317100000194f337c7bf&vkey=898D0438713E23615D6242EAF941AECEEF9DC0FB4F7C38449B3B298DB63E51EDA617437A884DCE432689EED19AF2F69CB48AD08FB9E24BB6__v21e2a1874&uin=88340707&redirect=1&fromtag=111042","trackType":""} May 09 19:01:43 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:43 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:43 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:43 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:43 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:43 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:43 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:43 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:43 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:43 volumio volumio[994]: info: ------------------------------ 46ms May 09 19:01:43 volumio volumio[994]: info: ------------------------------ 45ms May 09 19:01:43 volumio volumio[994]: info: ------------------------------ 44ms May 09 19:01:43 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:43 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:43 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:43 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:43 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:43 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:43 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:43 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:43 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:43 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:43 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:43 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:43 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:43 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:43 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:43 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:43 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:43 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:47 volumio wpa_supplicant[873]: wlan0: Failed to initiate sched scan May 09 19:01:47 volumio volumio[994]: info: May 09 19:01:47 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:47 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:47 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:47 volumio volumio[994]: info: May 09 19:01:47 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:47 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:47 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:47 volumio volumio[994]: info: May 09 19:01:47 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:47 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:47 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:47 volumio volumio[994]: info: sendMpdCommand status took 2 milliseconds May 09 19:01:47 volumio volumio[994]: info: sendMpdCommand status took 2 milliseconds May 09 19:01:47 volumio volumio[994]: info: sendMpdCommand status took 1 milliseconds May 09 19:01:47 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:47 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:47 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:47 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:47 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:47 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:47 volumio volumio[994]: info: sendMpdCommand playlistinfo took 1 milliseconds May 09 19:01:47 volumio volumio[994]: info: sendMpdCommand playlistinfo took 2 milliseconds May 09 19:01:47 volumio volumio[994]: info: sendMpdCommand playlistinfo took 2 milliseconds May 09 19:01:47 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:47 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:47 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:47 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:47 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:47 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:47 volumio volumio[994]: info: CorePlayQueue::getTrack 0 May 09 19:01:47 volumio volumio[994]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"天边","artist":"布仁巴雅尔","album":"天边 (布仁巴雅尔特别纪念版 1960-2018)","uri":"http://aqqmusic.tc.qq.com/M500000znYLM0dNvEA.mp3?guid=000000004ee6317100000194f337c7bf&vkey=898D0438713E23615D6242EAF941AECEEF9DC0FB4F7C38449B3B298DB63E51EDA617437A884DCE432689EED19AF2F69CB48AD08FB9E24BB6__v21e2a1874&uin=88340707&redirect=1&fromtag=111042","trackType":""} May 09 19:01:47 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:47 volumio volumio[994]: info: CoreStateMachine::syncState stateService stop May 09 19:01:47 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:47 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:47 volumio volumio[994]: info: CoreStateMachine::stPlaybackTimer May 09 19:01:47 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:47 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:47 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:47 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 19:01:47 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:47 volumio volumio[994]: info: CorePlayQueue::getTrack 0 May 09 19:01:47 volumio volumio[994]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"天边","artist":"布仁巴雅尔","album":"天边 (布仁巴雅尔特别纪念版 1960-2018)","uri":"http://aqqmusic.tc.qq.com/M500000znYLM0dNvEA.mp3?guid=000000004ee6317100000194f337c7bf&vkey=898D0438713E23615D6242EAF941AECEEF9DC0FB4F7C38449B3B298DB63E51EDA617437A884DCE432689EED19AF2F69CB48AD08FB9E24BB6__v21e2a1874&uin=88340707&redirect=1&fromtag=111042","trackType":""} May 09 19:01:47 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:47 volumio volumio[994]: info: CoreStateMachine::syncState stateService stop May 09 19:01:47 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop May 09 19:01:47 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:47 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:47 volumio volumio[994]: info: No code May 09 19:01:47 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:47 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:47 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:47 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:47 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:47 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:47 volumio volumio[994]: info: CorePlayQueue::getTrack 0 May 09 19:01:47 volumio volumio[994]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"天边","artist":"布仁巴雅尔","album":"天边 (布仁巴雅尔特别纪念版 1960-2018)","uri":"http://aqqmusic.tc.qq.com/M500000znYLM0dNvEA.mp3?guid=000000004ee6317100000194f337c7bf&vkey=898D0438713E23615D6242EAF941AECEEF9DC0FB4F7C38449B3B298DB63E51EDA617437A884DCE432689EED19AF2F69CB48AD08FB9E24BB6__v21e2a1874&uin=88340707&redirect=1&fromtag=111042","trackType":""} May 09 19:01:47 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:47 volumio volumio[994]: info: CoreStateMachine::syncState stateService stop May 09 19:01:47 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop May 09 19:01:47 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:47 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:47 volumio volumio[994]: info: No code May 09 19:01:47 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:47 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:47 volumio volumio[994]: info: ------------------------------ 41ms May 09 19:01:47 volumio volumio[994]: info: ------------------------------ 41ms May 09 19:01:47 volumio volumio[994]: info: ------------------------------ 41ms May 09 19:01:47 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:47 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:47 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:47 volumio volumio[994]: info: Clearing queue after UPNP request May 09 19:01:47 volumio volumio[994]: info: CoreStateMachine::ClearQueue May 09 19:01:47 volumio volumio[994]: info: CoreStateMachine::stop May 09 19:01:47 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 19:01:47 volumio volumio[994]: info: CorePlayQueue::clearPlayQueue May 09 19:01:47 volumio volumio[994]: info: CorePlayQueue::saveQueue May 09 19:01:47 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:47 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue May 09 19:01:47 volumio volumio[994]: info: May 09 19:01:47 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:47 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:47 volumio volumio[994]: info: May 09 19:01:47 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:47 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:47 volumio volumio[994]: info: May 09 19:01:47 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:47 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:47 volumio volumio[994]: error: updateQueue error: null May 09 19:01:47 volumio volumio[994]: error: updateQueue error: null May 09 19:01:47 volumio volumio[994]: error: updateQueue error: null May 09 19:01:47 volumio volumio[994]: info: ------------------------------ 3ms May 09 19:01:47 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:47 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:47 volumio volumio[994]: info: Starting UPNP Playback May 09 19:01:47 volumio volumio[994]: info: Preparing playback through UPNP May 09 19:01:47 volumio volumio[994]: info: CoreCommandRouter::volumioGetState May 09 19:01:47 volumio volumio[994]: info: CorePlayQueue::getTrack 0 May 09 19:01:47 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService mpd May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 3ms May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 3ms May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 3ms May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 3ms May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 1ms May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 1ms May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:48 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:48 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:48 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:48 volumio volumio[994]: info: sendMpdCommand status took 38 milliseconds May 09 19:01:48 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:48 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:48 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:48 volumio volumio[994]: info: sendMpdCommand status took 41 milliseconds May 09 19:01:48 volumio volumio[994]: info: sendMpdCommand status took 36 milliseconds May 09 19:01:48 volumio volumio[994]: info: sendMpdCommand status took 4 milliseconds May 09 19:01:48 volumio volumio[994]: info: sendMpdCommand playlistinfo took 5 milliseconds May 09 19:01:48 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:48 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:48 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:48 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":275,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"汉阳门花园","artist":"韩红","album":"汉阳门花园","uri":"http://aqqmusic.tc.qq.com/F000001oT3Wl4PuqZv.flac?guid=000000004ee6317100000194f337c7bf&vkey=F564E58D69677D0391F5FFBFC9062BDAF0ECB1EA1CF81DAF052261152DBD3B7D2113732634748F1927804D6353EEBB12A7DE4E9A7F20084B__v2b9ab33c&uin=88340707&redirect=1&fromtag=111114","trackType":""} May 09 19:01:48 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 47ms May 09 19:01:48 volumio volumio[994]: info: sendMpdCommand status took 6 milliseconds May 09 19:01:48 volumio volumio[994]: info: sendMpdCommand playlistinfo took 5 milliseconds May 09 19:01:48 volumio volumio[994]: info: sendMpdCommand playlistinfo took 4 milliseconds May 09 19:01:48 volumio volumio[994]: info: sendMpdCommand playlistinfo took 4 milliseconds May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:48 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:48 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:48 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":275,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"汉阳门花园","artist":"韩红","album":"汉阳门花园","uri":"http://aqqmusic.tc.qq.com/F000001oT3Wl4PuqZv.flac?guid=000000004ee6317100000194f337c7bf&vkey=F564E58D69677D0391F5FFBFC9062BDAF0ECB1EA1CF81DAF052261152DBD3B7D2113732634748F1927804D6353EEBB12A7DE4E9A7F20084B__v2b9ab33c&uin=88340707&redirect=1&fromtag=111114","trackType":""} May 09 19:01:48 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:48 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:48 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:48 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:48 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":275,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"汉阳门花园","artist":"韩红","album":"汉阳门花园","uri":"http://aqqmusic.tc.qq.com/F000001oT3Wl4PuqZv.flac?guid=000000004ee6317100000194f337c7bf&vkey=F564E58D69677D0391F5FFBFC9062BDAF0ECB1EA1CF81DAF052261152DBD3B7D2113732634748F1927804D6353EEBB12A7DE4E9A7F20084B__v2b9ab33c&uin=88340707&redirect=1&fromtag=111114","trackType":""} May 09 19:01:48 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:48 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:48 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:48 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:48 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":275,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"汉阳门花园","artist":"韩红","album":"汉阳门花园","uri":"http://aqqmusic.tc.qq.com/F000001oT3Wl4PuqZv.flac?guid=000000004ee6317100000194f337c7bf&vkey=F564E58D69677D0391F5FFBFC9062BDAF0ECB1EA1CF81DAF052261152DBD3B7D2113732634748F1927804D6353EEBB12A7DE4E9A7F20084B__v2b9ab33c&uin=88340707&redirect=1&fromtag=111114","trackType":""} May 09 19:01:48 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:48 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:48 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:48 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:48 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":275,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"汉阳门花园","artist":"韩红","album":"汉阳门花园","uri":"http://aqqmusic.tc.qq.com/F000001oT3Wl4PuqZv.flac?guid=000000004ee6317100000194f337c7bf&vkey=F564E58D69677D0391F5FFBFC9062BDAF0ECB1EA1CF81DAF052261152DBD3B7D2113732634748F1927804D6353EEBB12A7DE4E9A7F20084B__v2b9ab33c&uin=88340707&redirect=1&fromtag=111114","trackType":""} May 09 19:01:48 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:48 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 89ms May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 88ms May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 53ms May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 52ms May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:48 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:48 volumio volumio[994]: info: sendMpdCommand playlistinfo took 44 milliseconds May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:48 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:48 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:48 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":275,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"汉阳门花园","artist":"韩红","album":"汉阳门花园","uri":"http://aqqmusic.tc.qq.com/F000001oT3Wl4PuqZv.flac?guid=000000004ee6317100000194f337c7bf&vkey=F564E58D69677D0391F5FFBFC9062BDAF0ECB1EA1CF81DAF052261152DBD3B7D2113732634748F1927804D6353EEBB12A7DE4E9A7F20084B__v2b9ab33c&uin=88340707&redirect=1&fromtag=111114","trackType":""} May 09 19:01:48 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:48 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 64ms May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:48 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:48 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:48 volumio volumio[994]: info: May 09 19:01:48 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:48 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:48 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:48 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:48 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:48 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:48 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:48 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:48 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:48 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:48 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:48 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 25ms May 09 19:01:48 volumio volumio[994]: info: sendMpdCommand status took 24 milliseconds May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 13ms May 09 19:01:48 volumio volumio[994]: info: sendMpdCommand status took 13 milliseconds May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 13ms May 09 19:01:48 volumio volumio[994]: info: sendMpdCommand status took 12 milliseconds May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:48 volumio volumio[994]: info: sendMpdCommand playlistinfo took 1 milliseconds May 09 19:01:48 volumio volumio[994]: info: sendMpdCommand playlistinfo took 1 milliseconds May 09 19:01:48 volumio volumio[994]: info: sendMpdCommand playlistinfo took 1 milliseconds May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:48 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:48 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:48 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:48 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":275,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1360 Kbps","isStreaming":false,"title":"汉阳门花园","artist":"韩红","album":"汉阳门花园","uri":"http://aqqmusic.tc.qq.com/F000001oT3Wl4PuqZv.flac?guid=000000004ee6317100000194f337c7bf&vkey=F564E58D69677D0391F5FFBFC9062BDAF0ECB1EA1CF81DAF052261152DBD3B7D2113732634748F1927804D6353EEBB12A7DE4E9A7F20084B__v2b9ab33c&uin=88340707&redirect=1&fromtag=111114","trackType":""} May 09 19:01:48 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:48 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:48 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:48 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:48 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":275,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1438 Kbps","isStreaming":false,"title":"汉阳门花园","artist":"韩红","album":"汉阳门花园","uri":"http://aqqmusic.tc.qq.com/F000001oT3Wl4PuqZv.flac?guid=000000004ee6317100000194f337c7bf&vkey=F564E58D69677D0391F5FFBFC9062BDAF0ECB1EA1CF81DAF052261152DBD3B7D2113732634748F1927804D6353EEBB12A7DE4E9A7F20084B__v2b9ab33c&uin=88340707&redirect=1&fromtag=111114","trackType":""} May 09 19:01:48 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:48 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:48 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:48 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:48 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":275,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1438 Kbps","isStreaming":false,"title":"汉阳门花园","artist":"韩红","album":"汉阳门花园","uri":"http://aqqmusic.tc.qq.com/F000001oT3Wl4PuqZv.flac?guid=000000004ee6317100000194f337c7bf&vkey=F564E58D69677D0391F5FFBFC9062BDAF0ECB1EA1CF81DAF052261152DBD3B7D2113732634748F1927804D6353EEBB12A7DE4E9A7F20084B__v2b9ab33c&uin=88340707&redirect=1&fromtag=111114","trackType":""} May 09 19:01:48 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:48 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 53ms May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 42ms May 09 19:01:48 volumio volumio[994]: info: ------------------------------ 42ms May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:48 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:48 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:48 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:48 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:48 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:48 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:48 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:48 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:54 volumio volumio[994]: info: May 09 19:01:54 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:54 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:54 volumio volumio[994]: info: May 09 19:01:54 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:54 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:54 volumio volumio[994]: info: May 09 19:01:54 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:54 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:54 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds May 09 19:01:54 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds May 09 19:01:54 volumio volumio[994]: info: sendMpdCommand status took 2 milliseconds May 09 19:01:54 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:54 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:54 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:54 volumio volumio[994]: info: sendMpdCommand playlistinfo took 4 milliseconds May 09 19:01:54 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:54 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:54 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:54 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 May 09 19:01:54 volumio volumio[994]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"汉阳门花园","artist":"韩红","album":"汉阳门花园","uri":"http://aqqmusic.tc.qq.com/F000001oT3Wl4PuqZv.flac?guid=000000004ee6317100000194f337c7bf&vkey=F564E58D69677D0391F5FFBFC9062BDAF0ECB1EA1CF81DAF052261152DBD3B7D2113732634748F1927804D6353EEBB12A7DE4E9A7F20084B__v2b9ab33c&uin=88340707&redirect=1&fromtag=111114","trackType":""} May 09 19:01:54 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:54 volumio volumio[994]: info: CoreStateMachine::syncState stateService stop May 09 19:01:54 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:54 volumio volumio[994]: info: CoreStateMachine::stPlaybackTimer May 09 19:01:54 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:54 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:54 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:54 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 19:01:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 May 09 19:01:54 volumio volumio[994]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"汉阳门花园","artist":"韩红","album":"汉阳门花园","uri":"http://aqqmusic.tc.qq.com/F000001oT3Wl4PuqZv.flac?guid=000000004ee6317100000194f337c7bf&vkey=F564E58D69677D0391F5FFBFC9062BDAF0ECB1EA1CF81DAF052261152DBD3B7D2113732634748F1927804D6353EEBB12A7DE4E9A7F20084B__v2b9ab33c&uin=88340707&redirect=1&fromtag=111114","trackType":""} May 09 19:01:54 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:54 volumio volumio[994]: info: CoreStateMachine::syncState stateService stop May 09 19:01:54 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop May 09 19:01:54 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:54 volumio volumio[994]: info: No code May 09 19:01:54 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:54 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:54 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:54 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 May 09 19:01:54 volumio volumio[994]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"汉阳门花园","artist":"韩红","album":"汉阳门花园","uri":"http://aqqmusic.tc.qq.com/F000001oT3Wl4PuqZv.flac?guid=000000004ee6317100000194f337c7bf&vkey=F564E58D69677D0391F5FFBFC9062BDAF0ECB1EA1CF81DAF052261152DBD3B7D2113732634748F1927804D6353EEBB12A7DE4E9A7F20084B__v2b9ab33c&uin=88340707&redirect=1&fromtag=111114","trackType":""} May 09 19:01:54 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:54 volumio volumio[994]: info: CoreStateMachine::syncState stateService stop May 09 19:01:54 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop May 09 19:01:54 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:54 volumio volumio[994]: info: No code May 09 19:01:54 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:54 volumio volumio[994]: info: ------------------------------ 42ms May 09 19:01:54 volumio volumio[994]: info: ------------------------------ 42ms May 09 19:01:54 volumio volumio[994]: info: ------------------------------ 42ms May 09 19:01:54 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:54 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:54 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:54 volumio volumio[994]: info: Clearing queue after UPNP request May 09 19:01:54 volumio volumio[994]: info: CoreStateMachine::ClearQueue May 09 19:01:54 volumio volumio[994]: info: CoreStateMachine::stop May 09 19:01:54 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 19:01:54 volumio volumio[994]: info: CorePlayQueue::clearPlayQueue May 09 19:01:54 volumio volumio[994]: info: CorePlayQueue::saveQueue May 09 19:01:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue May 09 19:01:54 volumio volumio[994]: info: May 09 19:01:54 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:54 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:54 volumio volumio[994]: info: May 09 19:01:54 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:54 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:54 volumio volumio[994]: info: May 09 19:01:54 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:54 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:54 volumio volumio[994]: error: updateQueue error: null May 09 19:01:54 volumio volumio[994]: error: updateQueue error: null May 09 19:01:54 volumio volumio[994]: info: ------------------------------ 5ms May 09 19:01:54 volumio volumio[994]: info: ------------------------------ 4ms May 09 19:01:54 volumio volumio[994]: info: ------------------------------ 3ms May 09 19:01:54 volumio volumio[994]: info: Starting UPNP Playback May 09 19:01:54 volumio volumio[994]: info: Preparing playback through UPNP May 09 19:01:54 volumio volumio[994]: info: CoreCommandRouter::volumioGetState May 09 19:01:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 May 09 19:01:54 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService mpd May 09 19:01:55 volumio wpa_supplicant[873]: wlan0: Failed to initiate sched scan May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 3ms May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 3ms May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 1ms May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 3ms May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 1ms May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 1ms May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 1ms May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 1ms May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 2ms May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 1ms May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:55 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:55 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:55 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:55 volumio volumio[994]: info: sendMpdCommand status took 38 milliseconds May 09 19:01:55 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:55 volumio volumio[994]: info: sendMpdCommand status took 37 milliseconds May 09 19:01:55 volumio volumio[994]: info: sendMpdCommand status took 37 milliseconds May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 4ms May 09 19:01:55 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds May 09 19:01:55 volumio volumio[994]: info: sendMpdCommand playlistinfo took 2 milliseconds May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:55 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:55 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:55 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"8 送别","artist":"钟丽燕","album":"露华浓","uri":"http://aqqmusic.tc.qq.com/F000003NALOE0FiVoq.flac?guid=000000004ee6317100000194f337c7bf&vkey=0D7E9423A496DC889F66BCD2D042F873A21E870D8BCD9E890C446BA29592EA4E1A89EB7D9D9AE87F157B8488086EBE7D677A46FF9BE47175__v21e2a1874&uin=88340707&src=F000001xBu6d2HEY2t.flac&redirect=1&fromtag=111114","trackType":""} May 09 19:01:55 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 46ms May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:55 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces system playlist update May 09 19:01:55 volumio volumio[994]: info: Ignoring MPD Status Update May 09 19:01:55 volumio volumio[994]: info: May 09 19:01:55 volumio volumio[994]: ---------------------------- MPD announces state update: player May 09 19:01:55 volumio volumio[994]: info: ControllerMpd::getState May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status May 09 19:01:55 volumio volumio[994]: info: sendMpdCommand playlistinfo took 6 milliseconds May 09 19:01:55 volumio volumio[994]: info: sendMpdCommand playlistinfo took 7 milliseconds May 09 19:01:55 volumio volumio[994]: info: sendMpdCommand playlistinfo took 7 milliseconds May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 4ms May 09 19:01:55 volumio volumio[994]: info: sendMpdCommand status took 4 milliseconds May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 3ms May 09 19:01:55 volumio volumio[994]: info: sendMpdCommand status took 2 milliseconds May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::parseState May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 19:01:55 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:55 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:55 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"690 Kbps","isStreaming":false,"title":"8 送别","artist":"钟丽燕","album":"露华浓","uri":"http://aqqmusic.tc.qq.com/F000003NALOE0FiVoq.flac?guid=000000004ee6317100000194f337c7bf&vkey=0D7E9423A496DC889F66BCD2D042F873A21E870D8BCD9E890C446BA29592EA4E1A89EB7D9D9AE87F157B8488086EBE7D677A46FF9BE47175__v21e2a1874&uin=88340707&src=F000001xBu6d2HEY2t.flac&redirect=1&fromtag=111114","trackType":""} May 09 19:01:55 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:55 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:55 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:55 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:55 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"690 Kbps","isStreaming":false,"title":"8 送别","artist":"钟丽燕","album":"露华浓","uri":"http://aqqmusic.tc.qq.com/F000003NALOE0FiVoq.flac?guid=000000004ee6317100000194f337c7bf&vkey=0D7E9423A496DC889F66BCD2D042F873A21E870D8BCD9E890C446BA29592EA4E1A89EB7D9D9AE87F157B8488086EBE7D677A46FF9BE47175__v21e2a1874&uin=88340707&src=F000001xBu6d2HEY2t.flac&redirect=1&fromtag=111114","trackType":""} May 09 19:01:55 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:55 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:55 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:55 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:55 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"896 Kbps","isStreaming":false,"title":"8 送别","artist":"钟丽燕","album":"露华浓","uri":"http://aqqmusic.tc.qq.com/F000003NALOE0FiVoq.flac?guid=000000004ee6317100000194f337c7bf&vkey=0D7E9423A496DC889F66BCD2D042F873A21E870D8BCD9E890C446BA29592EA4E1A89EB7D9D9AE87F157B8488086EBE7D677A46FF9BE47175__v21e2a1874&uin=88340707&src=F000001xBu6d2HEY2t.flac&redirect=1&fromtag=111114","trackType":""} May 09 19:01:55 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:55 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 89ms May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 86ms May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 53ms May 09 19:01:55 volumio volumio[994]: info: sendMpdCommand playlistinfo took 41 milliseconds May 09 19:01:55 volumio volumio[994]: info: sendMpdCommand playlistinfo took 40 milliseconds May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:55 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo May 09 19:01:55 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:55 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:55 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"896 Kbps","isStreaming":false,"title":"8 送别","artist":"钟丽燕","album":"露华浓","uri":"http://aqqmusic.tc.qq.com/F000003NALOE0FiVoq.flac?guid=000000004ee6317100000194f337c7bf&vkey=0D7E9423A496DC889F66BCD2D042F873A21E870D8BCD9E890C446BA29592EA4E1A89EB7D9D9AE87F157B8488086EBE7D677A46FF9BE47175__v21e2a1874&uin=88340707&src=F000001xBu6d2HEY2t.flac&redirect=1&fromtag=111114","trackType":""} May 09 19:01:55 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:55 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:55 volumio volumio[994]: info: ControllerMpd::pushState May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::servicePushState May 09 19:01:55 volumio volumio[994]: verbose: In UPNP mode May 09 19:01:55 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"896 Kbps","isStreaming":false,"title":"8 送别","artist":"钟丽燕","album":"露华浓","uri":"http://aqqmusic.tc.qq.com/F000003NALOE0FiVoq.flac?guid=000000004ee6317100000194f337c7bf&vkey=0D7E9423A496DC889F66BCD2D042F873A21E870D8BCD9E890C446BA29592EA4E1A89EB7D9D9AE87F157B8488086EBE7D677A46FF9BE47175__v21e2a1874&uin=88340707&src=F000001xBu6d2HEY2t.flac&redirect=1&fromtag=111114","trackType":""} May 09 19:01:55 volumio volumio[994]: verbose: CURRENT POSITION 0 May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::syncState stateService play May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play May 09 19:01:55 volumio volumio[994]: info: Received an update from plugin. extracting info from payload May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 65ms May 09 19:01:55 volumio volumio[994]: info: ------------------------------ 64ms May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:55 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:55 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:55 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:55 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:55 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:55 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:55 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:55 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:55 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:01:55 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:01:55 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:01:55 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:02:03 volumio wpa_supplicant[873]: wlan0: Failed to initiate sched scan May 09 19:02:05 volumio volumio[1324]: 89 May 09 19:02:05 volumio volumio[1324]: % Total % Received % Xferd Average Speed Time Time Time Current May 09 19:02:05 volumio volumio[1324]: Dload Upload Total Spent Left Speed May 09 19:02:05 volumio volumio[994]: info: May 09 19:02:05 volumio volumio[994]: ---------------------------- Client requests Volume 89 May 09 19:02:05 volumio volumio[994]: info: VolumeController::SetAlsaVolume89 May 09 19:02:05 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:02:05 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 19:02:05 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:02:05 volumio volumio[1324]: [158B blob data] May 09 19:02:05 volumio volumio[1324]: {"time":1746788525846,"response":"volume Success"}89 May 09 19:02:05 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:02:05 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:02:05 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:02:06 volumio volumio[1324]: 99 May 09 19:02:06 volumio volumio[1324]: % Total % Received % Xferd Average Speed Time Time Time Current May 09 19:02:06 volumio volumio[1324]: Dload Upload Total Spent Left Speed May 09 19:02:06 volumio volumio[994]: info: May 09 19:02:06 volumio volumio[994]: ---------------------------- Client requests Volume 99 May 09 19:02:06 volumio volumio[994]: info: VolumeController::SetAlsaVolume99 May 09 19:02:06 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:02:06 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 19:02:06 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:02:06 volumio volumio[1324]: [158B blob data] May 09 19:02:06 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:02:06 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:02:06 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:02:06 volumio volumio[1324]: {"time":1746788526103,"response":"volume Success"}99 May 09 19:02:06 volumio volumio[1324]: 100 May 09 19:02:06 volumio volumio[1324]: % Total % Received % Xferd Average Speed Time Time Time Current May 09 19:02:06 volumio volumio[1324]: Dload Upload Total Spent Left Speed May 09 19:02:06 volumio volumio[994]: info: May 09 19:02:06 volumio volumio[994]: ---------------------------- Client requests Volume 100 May 09 19:02:06 volumio volumio[994]: info: VolumeController::SetAlsaVolume100 May 09 19:02:06 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:02:06 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 19:02:06 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:02:06 volumio volumio[1324]: [158B blob data] May 09 19:02:06 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:02:06 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:02:06 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:02:06 volumio volumio[1324]: {"time":1746788526223,"response":"volume Success"}100 May 09 19:02:12 volumio wpa_supplicant[873]: wlan0: Failed to initiate sched scan May 09 19:02:13 volumio volumio[1324]: 90 May 09 19:02:13 volumio volumio[1324]: % Total % Received % Xferd Average Speed Time Time Time Current May 09 19:02:13 volumio volumio[1324]: Dload Upload Total Spent Left Speed May 09 19:02:13 volumio volumio[994]: info: May 09 19:02:13 volumio volumio[994]: ---------------------------- Client requests Volume 90 May 09 19:02:13 volumio volumio[994]: info: VolumeController::SetAlsaVolume90 May 09 19:02:13 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:02:13 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 19:02:13 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:02:13 volumio volumio[1324]: [158B blob data] May 09 19:02:13 volumio volumio[1324]: {"time":1746788533098,"response":"volume Success"}90 May 09 19:02:13 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:02:13 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:02:13 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:02:13 volumio volumio[1324]: 80 May 09 19:02:13 volumio volumio[1324]: % Total % Received % Xferd Average Speed Time Time Time Current May 09 19:02:13 volumio volumio[1324]: Dload Upload Total Spent Left Speed May 09 19:02:13 volumio volumio[994]: info: May 09 19:02:13 volumio volumio[994]: ---------------------------- Client requests Volume 80 May 09 19:02:13 volumio volumio[994]: info: VolumeController::SetAlsaVolume80 May 09 19:02:13 volumio volumio[994]: info: CoreStateMachine::pushState May 09 19:02:13 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 19:02:13 volumio volumio[994]: info: CoreCommandRouter::volumioPushState May 09 19:02:13 volumio volumio[1324]: [158B blob data] May 09 19:02:13 volumio volumio[1324]: {"time":1746788533664,"response":"volume Success"}80 May 09 19:02:13 volumio volumio[994]: info: CoreCommandRouter::volumioGetQueue May 09 19:02:13 volumio volumio[994]: info: CoreStateMachine::getQueue May 09 19:02:13 volumio volumio[994]: info: CorePlayQueue::getQueue May 09 19:02:20 volumio wpa_supplicant[873]: wlan0: Failed to initiate sched scan May 09 19:02:29 volumio wpa_supplicant[873]: wlan0: Failed to initiate sched scan May 09 19:02:35 volumio volumio[994]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 19:02:35 volumio volumio[994]: Error: connect ETIMEDOUT 208.77.47.172:443 May 09 19:02:35 volumio volumio[994]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { May 09 19:02:35 volumio volumio[994]: errno: -110, May 09 19:02:35 volumio volumio[994]: code: 'ETIMEDOUT', May 09 19:02:35 volumio volumio[994]: syscall: 'connect', May 09 19:02:35 volumio volumio[994]: address: '208.77.47.172', May 09 19:02:35 volumio volumio[994]: port: 443 May 09 19:02:35 volumio volumio[994]: } May 09 19:02:35 volumio volumio[994]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 19:02:36 volumio sudo[2772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-09 19:01 May 09 19:02:36 volumio sudo[2772]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 11:47:57 AM CEST" VOLUMIO_VERSION="3.807" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fddd10196af80fdc784c726185a6abe4"